{"level":"warn","ts":"2026-01-26T15:29:46.635065Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-01-26T15:29:46.640109Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.144: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.144:2380","--initial-cluster=instance=https://199.204.45.144:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.144:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.144: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-01-26T15:29:46.640346Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-01-26T15:29:46.641158Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.144:2380"]}
{"level":"info","ts":"2026-01-26T15:29:46.641311Z","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-01-26T15:29:46.64612Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.144:2379"]}
{"level":"info","ts":"2026-01-26T15:29:46.647748Z","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.144:2380"],"listen-peer-urls":["https://199.204.45.144:2380"],"advertise-client-urls":["https://199.204.45.144:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.144:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.144: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-01-26T15:29:46.652218Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.160318ms"}
{"level":"info","ts":"2026-01-26T15:29:46.659306Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4594e5f716bad646","cluster-id":"ff2e51b364668606"}
{"level":"info","ts":"2026-01-26T15:29:46.659426Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 switched to configuration voters=()"}
{"level":"info","ts":"2026-01-26T15:29:46.659454Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became follower at term 0"}
{"level":"info","ts":"2026-01-26T15:29:46.659599Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4594e5f716bad646 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-01-26T15:29:46.659657Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became follower at term 1"}
{"level":"info","ts":"2026-01-26T15:29:46.660212Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 switched to configuration voters=(5013885134571230790)"}
{"level":"warn","ts":"2026-01-26T15:29:46.671052Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-01-26T15:29:46.677917Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-01-26T15:29:46.678976Z","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-01-26T15:29:46.683541Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4594e5f716bad646","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-01-26T15:29:46.685568Z","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-01-26T15:29:46.685881Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4594e5f716bad646","initial-advertise-peer-urls":["https://199.204.45.144:2380"],"listen-peer-urls":["https://199.204.45.144:2380"],"advertise-client-urls":["https://199.204.45.144:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.144:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-01-26T15:29:46.685905Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-01-26T15:29:46.686113Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4594e5f716bad646","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-01-26T15:29:46.686257Z","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-01-26T15:29:46.68628Z","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-01-26T15:29:46.686287Z","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-01-26T15:29:46.686644Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.144:2380"}
{"level":"info","ts":"2026-01-26T15:29:46.686657Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.144:2380"}
{"level":"info","ts":"2026-01-26T15:29:46.691151Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 switched to configuration voters=(5013885134571230790)"}
{"level":"info","ts":"2026-01-26T15:29:46.691276Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ff2e51b364668606","local-member-id":"4594e5f716bad646","added-peer-id":"4594e5f716bad646","added-peer-peer-urls":["https://199.204.45.144:2380"]}
{"level":"info","ts":"2026-01-26T15:29:47.561901Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 is starting a new election at term 1"}
{"level":"info","ts":"2026-01-26T15:29:47.561949Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became pre-candidate at term 1"}
{"level":"info","ts":"2026-01-26T15:29:47.561976Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 received MsgPreVoteResp from 4594e5f716bad646 at term 1"}
{"level":"info","ts":"2026-01-26T15:29:47.56199Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became candidate at term 2"}
{"level":"info","ts":"2026-01-26T15:29:47.562008Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 received MsgVoteResp from 4594e5f716bad646 at term 2"}
{"level":"info","ts":"2026-01-26T15:29:47.562017Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became leader at term 2"}
{"level":"info","ts":"2026-01-26T15:29:47.562029Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4594e5f716bad646 elected leader 4594e5f716bad646 at term 2"}
{"level":"info","ts":"2026-01-26T15:29:47.565093Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-26T15:29:47.567286Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4594e5f716bad646","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.144:2379]}","request-path":"/0/members/4594e5f716bad646/attributes","cluster-id":"ff2e51b364668606","publish-timeout":"7s"}
{"level":"info","ts":"2026-01-26T15:29:47.567422Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-01-26T15:29:47.567663Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-01-26T15:29:47.567766Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ff2e51b364668606","local-member-id":"4594e5f716bad646","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-26T15:29:47.56781Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-26T15:29:47.567824Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-26T15:29:47.569028Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.144:2379"}
{"level":"info","ts":"2026-01-26T15:29:47.573809Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-01-26T15:29:47.576823Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-01-26T15:29:47.576838Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-01-26T15:30:11.883958Z","caller":"traceutil/trace.go:171","msg":"trace[1744188195] transaction","detail":"{read_only:false; response_revision:427; number_of_response:1; }","duration":"186.674323ms","start":"2026-01-26T15:30:11.697267Z","end":"2026-01-26T15:30:11.883942Z","steps":["trace[1744188195] 'process raft request'  (duration: 186.582614ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-26T15:30:15.873786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.784813ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15440199874504599575 > lease_revoke:<id:56469bfaece0a74e>","response":"size:28"}
{"level":"info","ts":"2026-01-26T15:30:21.239348Z","caller":"traceutil/trace.go:171","msg":"trace[122573967] linearizableReadLoop","detail":"{readStateIndex:522; appliedIndex:521; }","duration":"265.876403ms","start":"2026-01-26T15:30:20.973458Z","end":"2026-01-26T15:30:21.239334Z","steps":["trace[122573967] 'read index received'  (duration: 265.814332ms)","trace[122573967] 'applied index is now lower than readState.Index'  (duration: 61.161µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-26T15:30:21.239395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-26T15:30:20.569728Z","time spent":"669.653104ms","remote":"127.0.0.1:44612","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-01-26T15:30:21.239468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.977603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-26T15:30:21.239489Z","caller":"traceutil/trace.go:171","msg":"trace[1944290626] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:501; }","duration":"266.029783ms","start":"2026-01-26T15:30:20.973454Z","end":"2026-01-26T15:30:21.239484Z","steps":["trace[1944290626] 'agreement among raft nodes before linearized reading'  (duration: 265.961113ms)"],"step_count":1}
{"level":"info","ts":"2026-01-26T15:30:22.295956Z","caller":"traceutil/trace.go:171","msg":"trace[590463255] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"372.357927ms","start":"2026-01-26T15:30:21.923579Z","end":"2026-01-26T15:30:22.295937Z","steps":["trace[590463255] 'process raft request'  (duration: 372.256656ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-26T15:30:22.296399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-26T15:30:21.923558Z","time spent":"372.461398ms","remote":"127.0.0.1:44866","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:500 > 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-01-26T15:30:25.696095Z","caller":"traceutil/trace.go:171","msg":"trace[740437632] linearizableReadLoop","detail":"{readStateIndex:536; appliedIndex:535; }","duration":"116.037598ms","start":"2026-01-26T15:30:25.580039Z","end":"2026-01-26T15:30:25.696077Z","steps":["trace[740437632] 'read index received'  (duration: 115.812916ms)","trace[740437632] 'applied index is now lower than readState.Index'  (duration: 223.932µs)"],"step_count":2}
{"level":"info","ts":"2026-01-26T15:30:25.696174Z","caller":"traceutil/trace.go:171","msg":"trace[1724076497] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"351.414422ms","start":"2026-01-26T15:30:25.344753Z","end":"2026-01-26T15:30:25.696167Z","steps":["trace[1724076497] 'process raft request'  (duration: 351.17254ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-26T15:30:25.696245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-26T15:30:25.344741Z","time spent":"351.450912ms","remote":"127.0.0.1:44866","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:508 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-01-26T15:30:25.696404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.362971ms","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-01-26T15:30:25.696424Z","caller":"traceutil/trace.go:171","msg":"trace[1234675974] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:515; }","duration":"116.404311ms","start":"2026-01-26T15:30:25.580014Z","end":"2026-01-26T15:30:25.696418Z","steps":["trace[1234675974] 'agreement among raft nodes before linearized reading'  (duration: 116.32059ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-26T15:30:25.696583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.484471ms","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-01-26T15:30:25.696645Z","caller":"traceutil/trace.go:171","msg":"trace[57935018] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:515; }","duration":"116.564173ms","start":"2026-01-26T15:30:25.580067Z","end":"2026-01-26T15:30:25.696631Z","steps":["trace[57935018] 'agreement among raft nodes before linearized reading'  (duration: 116.404881ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-26T15:30:26.479853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.913913ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15440199874504599677 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:509 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-01-26T15:30:26.479917Z","caller":"traceutil/trace.go:171","msg":"trace[585644411] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"772.025817ms","start":"2026-01-26T15:30:25.70788Z","end":"2026-01-26T15:30:26.479906Z","steps":["trace[585644411] 'process raft request'  (duration: 365.002113ms)","trace[585644411] 'compare'  (duration: 406.849862ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-26T15:30:26.479947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-26T15:30:25.707864Z","time spent":"772.069687ms","remote":"127.0.0.1:44866","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:509 > 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-01-26T15:30:26.482268Z","caller":"traceutil/trace.go:171","msg":"trace[633177846] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"774.158347ms","start":"2026-01-26T15:30:25.708089Z","end":"2026-01-26T15:30:26.482247Z","steps":["trace[633177846] 'process raft request'  (duration: 773.491071ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-26T15:30:26.482443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-26T15:30:25.70808Z","time spent":"774.234858ms","remote":"127.0.0.1:44866","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-01-26T15:30:26.482665Z","caller":"traceutil/trace.go:171","msg":"trace[1902706410] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"766.685463ms","start":"2026-01-26T15:30:25.715972Z","end":"2026-01-26T15:30:26.482658Z","steps":["trace[1902706410] 'process raft request'  (duration: 765.644653ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-26T15:30:26.482704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-26T15:30:25.715963Z","time spent":"766.719653ms","remote":"127.0.0.1:44776","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-2q8sz\" mod_revision:459 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-2q8sz\" value_size:16754 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-2q8sz\" > >"}
{"level":"warn","ts":"2026-01-26T15:30:26.730516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.855509ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15440199874504599680 > lease_revoke:<id:56469bfaece0a7b9>","response":"size:28"}
{"level":"info","ts":"2026-01-26T15:30:26.730591Z","caller":"traceutil/trace.go:171","msg":"trace[539406864] linearizableReadLoop","detail":"{readStateIndex:540; appliedIndex:537; }","duration":"426.518799ms","start":"2026-01-26T15:30:26.304059Z","end":"2026-01-26T15:30:26.730578Z","steps":["trace[539406864] 'read index received'  (duration: 177.497009ms)","trace[539406864] 'applied index is now lower than readState.Index'  (duration: 249.02076ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-26T15:30:26.731797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.722541ms","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-01-26T15:30:26.731904Z","caller":"traceutil/trace.go:171","msg":"trace[32224387] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:518; }","duration":"427.854352ms","start":"2026-01-26T15:30:26.304029Z","end":"2026-01-26T15:30:26.731883Z","steps":["trace[32224387] 'agreement among raft nodes before linearized reading'  (duration: 426.58054ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-26T15:30:26.731933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-26T15:30:26.304002Z","time spent":"427.924163ms","remote":"127.0.0.1:44866","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-01-26T15:30:27.47346Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440199874504599681,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-26T15:30:27.901785Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.165337242s","expected-duration":"1s"}
{"level":"info","ts":"2026-01-26T15:30:27.902132Z","caller":"traceutil/trace.go:171","msg":"trace[224662234] linearizableReadLoop","detail":"{readStateIndex:541; appliedIndex:540; }","duration":"929.147754ms","start":"2026-01-26T15:30:26.972962Z","end":"2026-01-26T15:30:27.90211Z","steps":["trace[224662234] 'read index received'  (duration: 928.929981ms)","trace[224662234] 'applied index is now lower than readState.Index'  (duration: 215.003µs)"],"step_count":2}
{"level":"info","ts":"2026-01-26T15:30:27.902213Z","caller":"traceutil/trace.go:171","msg":"trace[660935497] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"1.165824127s","start":"2026-01-26T15:30:26.73638Z","end":"2026-01-26T15:30:27.902204Z","steps":["trace[660935497] 'process raft request'  (duration: 1.165582484s)"],"step_count":1}
{"level":"warn","ts":"2026-01-26T15:30:27.902316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-26T15:30:26.736362Z","time spent":"1.165883647s","remote":"127.0.0.1:44866","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:511 > 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-01-26T15:30:27.902867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"929.881942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-26T15:30:27.90292Z","caller":"traceutil/trace.go:171","msg":"trace[350467039] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:519; }","duration":"929.970553ms","start":"2026-01-26T15:30:26.972935Z","end":"2026-01-26T15:30:27.902905Z","steps":["trace[350467039] 'agreement among raft nodes before linearized reading'  (duration: 929.881182ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-26T15:30:27.902958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-26T15:30:26.972923Z","time spent":"930.028123ms","remote":"127.0.0.1:44566","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-01-26T15:30:27.902855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.287437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-01-26T15:30:27.903157Z","caller":"traceutil/trace.go:171","msg":"trace[212016006] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:519; }","duration":"201.767482ms","start":"2026-01-26T15:30:27.70137Z","end":"2026-01-26T15:30:27.903137Z","steps":["trace[212016006] 'agreement among raft nodes before linearized reading'  (duration: 201.187326ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-26T15:30:31.187446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.437063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-26T15:30:31.187492Z","caller":"traceutil/trace.go:171","msg":"trace[1802525744] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:540; }","duration":"211.528245ms","start":"2026-01-26T15:30:30.975953Z","end":"2026-01-26T15:30:31.187482Z","steps":["trace[1802525744] 'range keys from in-memory index tree'  (duration: 211.378603ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-26T15:30:32.034136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.12092ms","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-01-26T15:30:32.034203Z","caller":"traceutil/trace.go:171","msg":"trace[1802374451] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:561; }","duration":"119.225622ms","start":"2026-01-26T15:30:31.914961Z","end":"2026-01-26T15:30:32.034187Z","steps":["trace[1802374451] 'range keys from in-memory index tree'  (duration: 118.990758ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-26T15:30:32.034313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.868789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-01-26T15:30:32.034364Z","caller":"traceutil/trace.go:171","msg":"trace[1720345730] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:561; }","duration":"103.92758ms","start":"2026-01-26T15:30:31.930423Z","end":"2026-01-26T15:30:32.03435Z","steps":["trace[1720345730] 'range keys from in-memory index tree'  (duration: 103.757287ms)"],"step_count":1}
{"level":"info","ts":"2026-01-26T15:30:33.190799Z","caller":"traceutil/trace.go:171","msg":"trace[469393065] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"224.729993ms","start":"2026-01-26T15:30:32.966053Z","end":"2026-01-26T15:30:33.190783Z","steps":["trace[469393065] 'process raft request'  (duration: 224.645661ms)"],"step_count":1}
{"level":"info","ts":"2026-01-26T15:30:33.191686Z","caller":"traceutil/trace.go:171","msg":"trace[2052779200] linearizableReadLoop","detail":"{readStateIndex:609; appliedIndex:608; }","duration":"216.587893ms","start":"2026-01-26T15:30:32.975087Z","end":"2026-01-26T15:30:33.191675Z","steps":["trace[2052779200] 'read index received'  (duration: 216.041775ms)","trace[2052779200] 'applied index is now lower than readState.Index'  (duration: 545.698µs)"],"step_count":2}
{"level":"info","ts":"2026-01-26T15:30:33.191833Z","caller":"traceutil/trace.go:171","msg":"trace[34915460] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"219.135482ms","start":"2026-01-26T15:30:32.972691Z","end":"2026-01-26T15:30:33.191826Z","steps":["trace[34915460] 'process raft request'  (duration: 218.864258ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-26T15:30:33.191962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.861758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-26T15:30:33.191992Z","caller":"traceutil/trace.go:171","msg":"trace[228079528] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:586; }","duration":"216.924669ms","start":"2026-01-26T15:30:32.975053Z","end":"2026-01-26T15:30:33.191978Z","steps":["trace[228079528] 'agreement among raft nodes before linearized reading'  (duration: 216.878678ms)"],"step_count":1}
{"level":"info","ts":"2026-01-26T15:31:52.25246Z","caller":"traceutil/trace.go:171","msg":"trace[1020690972] transaction","detail":"{read_only:false; response_revision:941; number_of_response:1; }","duration":"219.60073ms","start":"2026-01-26T15:31:52.032838Z","end":"2026-01-26T15:31:52.252438Z","steps":["trace[1020690972] 'process raft request'  (duration: 188.66934ms)","trace[1020690972] 'compare'  (duration: 30.618794ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-26T15:31:52.981642Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440199874504600696,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-01-26T15:31:53.114557Z","caller":"traceutil/trace.go:171","msg":"trace[792421069] linearizableReadLoop","detail":"{readStateIndex:982; appliedIndex:981; }","duration":"633.609779ms","start":"2026-01-26T15:31:52.480905Z","end":"2026-01-26T15:31:53.114515Z","steps":["trace[792421069] 'read index received'  (duration: 633.364726ms)","trace[792421069] 'applied index is now lower than readState.Index'  (duration: 244.373µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-26T15:31:53.114786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"633.874332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-01-26T15:31:53.11482Z","caller":"traceutil/trace.go:171","msg":"trace[1425160243] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:942; }","duration":"633.941756ms","start":"2026-01-26T15:31:52.480871Z","end":"2026-01-26T15:31:53.114812Z","steps":["trace[1425160243] 'agreement among raft nodes before linearized reading'  (duration: 633.82558ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-26T15:31:53.114833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.708477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-01-26T15:31:53.114844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-26T15:31:52.48083Z","time spent":"634.00924ms","remote":"127.0.0.1:44866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-01-26T15:31:53.114855Z","caller":"traceutil/trace.go:171","msg":"trace[977790678] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:942; }","duration":"145.759579ms","start":"2026-01-26T15:31:52.969088Z","end":"2026-01-26T15:31:53.114848Z","steps":["trace[977790678] 'agreement among raft nodes before linearized reading'  (duration: 145.694816ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-26T15:31:53.114927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.167394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-26T15:31:53.114942Z","caller":"traceutil/trace.go:171","msg":"trace[1948684834] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:942; }","duration":"139.195356ms","start":"2026-01-26T15:31:52.975742Z","end":"2026-01-26T15:31:53.114937Z","steps":["trace[1948684834] 'agreement among raft nodes before linearized reading'  (duration: 139.173435ms)"],"step_count":1}
{"level":"info","ts":"2026-01-26T15:31:53.114979Z","caller":"traceutil/trace.go:171","msg":"trace[704038303] transaction","detail":"{read_only:false; response_revision:942; number_of_response:1; }","duration":"657.425286ms","start":"2026-01-26T15:31:52.457546Z","end":"2026-01-26T15:31:53.114971Z","steps":["trace[704038303] 'process raft request'  (duration: 656.793433ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-26T15:31:53.11503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-26T15:31:52.457524Z","time spent":"657.470428ms","remote":"127.0.0.1:44866","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:933 > 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-01-26T15:31:53.11507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.451897ms","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-01-26T15:31:53.115087Z","caller":"traceutil/trace.go:171","msg":"trace[318023965] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:942; }","duration":"142.483268ms","start":"2026-01-26T15:31:52.972599Z","end":"2026-01-26T15:31:53.115082Z","steps":["trace[318023965] 'agreement among raft nodes before linearized reading'  (duration: 142.425055ms)"],"step_count":1}