{"level":"warn","ts":"2026-01-20T13:46:40.24771Z","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-20T13:46:40.247796Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.62: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://162.253.55.62:2380","--initial-cluster=instance=https://162.253.55.62:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.62:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.62: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-20T13:46:40.247886Z","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-20T13:46:40.250499Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.62:2380"]}
{"level":"info","ts":"2026-01-20T13:46:40.250545Z","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-20T13:46:40.252035Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.62:2379"]}
{"level":"info","ts":"2026-01-20T13:46:40.252164Z","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://162.253.55.62:2380"],"listen-peer-urls":["https://162.253.55.62:2380"],"advertise-client-urls":["https://162.253.55.62:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.62:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.62: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-20T13:46:40.256529Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.099011ms"}
{"level":"info","ts":"2026-01-20T13:46:40.278569Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"791a7e25b533cd26","cluster-id":"be484d2748da72cd"}
{"level":"info","ts":"2026-01-20T13:46:40.278625Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 switched to configuration voters=()"}
{"level":"info","ts":"2026-01-20T13:46:40.278641Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 became follower at term 0"}
{"level":"info","ts":"2026-01-20T13:46:40.278649Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 791a7e25b533cd26 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-01-20T13:46:40.278655Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 became follower at term 1"}
{"level":"info","ts":"2026-01-20T13:46:40.278683Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 switched to configuration voters=(8726425928402717990)"}
{"level":"warn","ts":"2026-01-20T13:46:40.285646Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-01-20T13:46:40.288652Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-01-20T13:46:40.290791Z","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-20T13:46:40.292747Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"791a7e25b533cd26","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-01-20T13:46:40.297496Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"791a7e25b533cd26","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-01-20T13:46:40.297782Z","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-20T13:46:40.297905Z","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-20T13:46:40.298061Z","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-20T13:46:40.299224Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 switched to configuration voters=(8726425928402717990)"}
{"level":"info","ts":"2026-01-20T13:46:40.299564Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"be484d2748da72cd","local-member-id":"791a7e25b533cd26","added-peer-id":"791a7e25b533cd26","added-peer-peer-urls":["https://162.253.55.62:2380"]}
{"level":"info","ts":"2026-01-20T13:46:40.30099Z","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-20T13:46:40.304114Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"791a7e25b533cd26","initial-advertise-peer-urls":["https://162.253.55.62:2380"],"listen-peer-urls":["https://162.253.55.62:2380"],"advertise-client-urls":["https://162.253.55.62:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.62:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-01-20T13:46:40.304139Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-01-20T13:46:40.303545Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.62:2380"}
{"level":"info","ts":"2026-01-20T13:46:40.305465Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.62:2380"}
{"level":"info","ts":"2026-01-20T13:46:40.579468Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 is starting a new election at term 1"}
{"level":"info","ts":"2026-01-20T13:46:40.57952Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 became pre-candidate at term 1"}
{"level":"info","ts":"2026-01-20T13:46:40.579564Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 received MsgPreVoteResp from 791a7e25b533cd26 at term 1"}
{"level":"info","ts":"2026-01-20T13:46:40.579578Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 became candidate at term 2"}
{"level":"info","ts":"2026-01-20T13:46:40.579605Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 received MsgVoteResp from 791a7e25b533cd26 at term 2"}
{"level":"info","ts":"2026-01-20T13:46:40.579624Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 became leader at term 2"}
{"level":"info","ts":"2026-01-20T13:46:40.579635Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 791a7e25b533cd26 elected leader 791a7e25b533cd26 at term 2"}
{"level":"info","ts":"2026-01-20T13:46:40.580376Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"791a7e25b533cd26","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.62:2379]}","request-path":"/0/members/791a7e25b533cd26/attributes","cluster-id":"be484d2748da72cd","publish-timeout":"7s"}
{"level":"info","ts":"2026-01-20T13:46:40.580544Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-20T13:46:40.580626Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-01-20T13:46:40.580959Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-01-20T13:46:40.581727Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-01-20T13:46:40.581802Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-01-20T13:46:40.581875Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"be484d2748da72cd","local-member-id":"791a7e25b533cd26","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-20T13:46:40.581976Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-20T13:46:40.58205Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-20T13:46:40.586663Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.62:2379"}
{"level":"info","ts":"2026-01-20T13:46:40.592793Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-01-20T13:47:12.166889Z","caller":"traceutil/trace.go:171","msg":"trace[565862748] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"119.153643ms","start":"2026-01-20T13:47:12.047588Z","end":"2026-01-20T13:47:12.166742Z","steps":["trace[565862748] 'process raft request'  (duration: 119.060701ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T13:47:12.901344Z","caller":"traceutil/trace.go:171","msg":"trace[1718075944] linearizableReadLoop","detail":"{readStateIndex:531; appliedIndex:530; }","duration":"120.218147ms","start":"2026-01-20T13:47:12.781109Z","end":"2026-01-20T13:47:12.901327Z","steps":["trace[1718075944] 'read index received'  (duration: 102.270904ms)","trace[1718075944] 'applied index is now lower than readState.Index'  (duration: 17.946553ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T13:47:12.901512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.375093ms","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-20T13:47:12.901539Z","caller":"traceutil/trace.go:171","msg":"trace[1022577706] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:516; }","duration":"120.432124ms","start":"2026-01-20T13:47:12.7811Z","end":"2026-01-20T13:47:12.901533Z","steps":["trace[1022577706] 'agreement among raft nodes before linearized reading'  (duration: 120.29312ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T13:47:12.901588Z","caller":"traceutil/trace.go:171","msg":"trace[1059939007] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"126.354593ms","start":"2026-01-20T13:47:12.77521Z","end":"2026-01-20T13:47:12.901564Z","steps":["trace[1059939007] 'process raft request'  (duration: 108.166883ms)","trace[1059939007] 'compare'  (duration: 17.87188ms)"],"step_count":2}
{"level":"info","ts":"2026-01-20T13:47:13.053337Z","caller":"traceutil/trace.go:171","msg":"trace[1703861260] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"148.864181ms","start":"2026-01-20T13:47:12.904452Z","end":"2026-01-20T13:47:13.053316Z","steps":["trace[1703861260] 'process raft request'  (duration: 127.126867ms)","trace[1703861260] 'compare'  (duration: 21.652051ms)"],"step_count":2}
{"level":"info","ts":"2026-01-20T13:47:16.410945Z","caller":"traceutil/trace.go:171","msg":"trace[1415111245] linearizableReadLoop","detail":"{readStateIndex:540; appliedIndex:539; }","duration":"233.423851ms","start":"2026-01-20T13:47:16.177499Z","end":"2026-01-20T13:47:16.410923Z","steps":["trace[1415111245] 'read index received'  (duration: 233.287687ms)","trace[1415111245] 'applied index is now lower than readState.Index'  (duration: 135.384µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T13:47:16.411075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.559556ms","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-01-20T13:47:16.411092Z","caller":"traceutil/trace.go:171","msg":"trace[2015727655] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:524; }","duration":"233.614446ms","start":"2026-01-20T13:47:16.177471Z","end":"2026-01-20T13:47:16.411085Z","steps":["trace[2015727655] 'agreement among raft nodes before linearized reading'  (duration: 233.520653ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T13:47:16.411205Z","caller":"traceutil/trace.go:171","msg":"trace[1247106843] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"425.308385ms","start":"2026-01-20T13:47:15.985861Z","end":"2026-01-20T13:47:16.41117Z","steps":["trace[1247106843] 'process raft request'  (duration: 424.960274ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T13:47:16.41174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T13:47:15.985839Z","time spent":"425.423649ms","remote":"127.0.0.1:36774","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:467 > 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-01-20T13:47:18.115236Z","caller":"traceutil/trace.go:171","msg":"trace[983750488] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"342.641637ms","start":"2026-01-20T13:47:17.772574Z","end":"2026-01-20T13:47:18.115215Z","steps":["trace[983750488] 'process raft request'  (duration: 342.539464ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T13:47:18.115342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T13:47:17.77255Z","time spent":"342.73654ms","remote":"127.0.0.1:36688","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16799,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-jlkdh\" mod_revision:503 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-jlkdh\" value_size:16750 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-jlkdh\" > >"}
{"level":"info","ts":"2026-01-20T13:47:31.13852Z","caller":"traceutil/trace.go:171","msg":"trace[1712001485] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"205.936864ms","start":"2026-01-20T13:47:30.932568Z","end":"2026-01-20T13:47:31.138505Z","steps":["trace[1712001485] 'process raft request'  (duration: 205.839561ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T13:47:31.145393Z","caller":"traceutil/trace.go:171","msg":"trace[1742303853] linearizableReadLoop","detail":"{readStateIndex:701; appliedIndex:700; }","duration":"212.587486ms","start":"2026-01-20T13:47:30.932787Z","end":"2026-01-20T13:47:31.145374Z","steps":["trace[1742303853] 'read index received'  (duration: 205.858261ms)","trace[1742303853] 'applied index is now lower than readState.Index'  (duration: 6.728715ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T13:47:31.145521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.71822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-5dd5756b68-4n6bh\" ","response":"range_response_count:1 size:4696"}
{"level":"info","ts":"2026-01-20T13:47:31.145539Z","caller":"traceutil/trace.go:171","msg":"trace[950297237] range","detail":"{range_begin:/registry/pods/kube-system/coredns-5dd5756b68-4n6bh; range_end:; response_count:1; response_revision:682; }","duration":"212.761181ms","start":"2026-01-20T13:47:30.932771Z","end":"2026-01-20T13:47:31.145532Z","steps":["trace[950297237] 'agreement among raft nodes before linearized reading'  (duration: 212.665858ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T13:47:31.145658Z","caller":"traceutil/trace.go:171","msg":"trace[1565948767] transaction","detail":"{read_only:false; response_revision:681; number_of_response:1; }","duration":"212.927167ms","start":"2026-01-20T13:47:30.932726Z","end":"2026-01-20T13:47:31.145653Z","steps":["trace[1565948767] 'process raft request'  (duration: 212.553185ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T13:47:31.145855Z","caller":"traceutil/trace.go:171","msg":"trace[1202237832] transaction","detail":"{read_only:false; response_revision:682; number_of_response:1; }","duration":"206.45042ms","start":"2026-01-20T13:47:30.939398Z","end":"2026-01-20T13:47:31.145849Z","steps":["trace[1202237832] 'process raft request'  (duration: 205.938434ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T13:47:34.556299Z","caller":"traceutil/trace.go:171","msg":"trace[783692133] transaction","detail":"{read_only:false; response_revision:704; number_of_response:1; }","duration":"273.710627ms","start":"2026-01-20T13:47:34.282562Z","end":"2026-01-20T13:47:34.556273Z","steps":["trace[783692133] 'process raft request'  (duration: 216.409058ms)","trace[783692133] 'compare'  (duration: 57.158635ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T13:47:54.651776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.381525ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14782674194614393968 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/162.253.55.62\" mod_revision:738 > success:<request_put:<key:\"/registry/masterleases/162.253.55.62\" value_size:66 lease:5559302157759618158 >> failure:<request_range:<key:\"/registry/masterleases/162.253.55.62\" > >>","response":"size:16"}
{"level":"info","ts":"2026-01-20T13:47:54.651846Z","caller":"traceutil/trace.go:171","msg":"trace[107922543] linearizableReadLoop","detail":"{readStateIndex:792; appliedIndex:791; }","duration":"238.503013ms","start":"2026-01-20T13:47:54.413332Z","end":"2026-01-20T13:47:54.651835Z","steps":["trace[107922543] 'read index received'  (duration: 48.904551ms)","trace[107922543] 'applied index is now lower than readState.Index'  (duration: 189.597742ms)"],"step_count":2}
{"level":"info","ts":"2026-01-20T13:47:54.651903Z","caller":"traceutil/trace.go:171","msg":"trace[1092034142] transaction","detail":"{read_only:false; response_revision:767; number_of_response:1; }","duration":"367.078918ms","start":"2026-01-20T13:47:54.284816Z","end":"2026-01-20T13:47:54.651895Z","steps":["trace[1092034142] 'process raft request'  (duration: 177.417634ms)","trace[1092034142] 'compare'  (duration: 189.306742ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T13:47:54.651938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T13:47:54.284795Z","time spent":"367.124278ms","remote":"127.0.0.1:36524","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/162.253.55.62\" mod_revision:738 > success:<request_put:<key:\"/registry/masterleases/162.253.55.62\" value_size:66 lease:5559302157759618158 >> failure:<request_range:<key:\"/registry/masterleases/162.253.55.62\" > >"}
{"level":"warn","ts":"2026-01-20T13:47:54.652096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.780562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-01-20T13:47:54.652116Z","caller":"traceutil/trace.go:171","msg":"trace[1881385008] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:767; }","duration":"238.841663ms","start":"2026-01-20T13:47:54.413269Z","end":"2026-01-20T13:47:54.652111Z","steps":["trace[1881385008] 'agreement among raft nodes before linearized reading'  (duration: 238.791222ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T13:47:54.652236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.348302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-20T13:47:54.652252Z","caller":"traceutil/trace.go:171","msg":"trace[2108808856] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:767; }","duration":"105.364823ms","start":"2026-01-20T13:47:54.546883Z","end":"2026-01-20T13:47:54.652248Z","steps":["trace[2108808856] 'agreement among raft nodes before linearized reading'  (duration: 105.339332ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T13:47:54.873396Z","caller":"traceutil/trace.go:171","msg":"trace[1359980710] transaction","detail":"{read_only:false; response_revision:768; number_of_response:1; }","duration":"199.960123ms","start":"2026-01-20T13:47:54.673421Z","end":"2026-01-20T13:47:54.873381Z","steps":["trace[1359980710] 'process raft request'  (duration: 199.669684ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T13:47:57.506288Z","caller":"traceutil/trace.go:171","msg":"trace[2037411448] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"240.898188ms","start":"2026-01-20T13:47:57.265349Z","end":"2026-01-20T13:47:57.506247Z","steps":["trace[2037411448] 'process raft request'  (duration: 240.757744ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T13:47:57.506919Z","caller":"traceutil/trace.go:171","msg":"trace[215828710] linearizableReadLoop","detail":"{readStateIndex:801; appliedIndex:801; }","duration":"225.266899ms","start":"2026-01-20T13:47:57.281637Z","end":"2026-01-20T13:47:57.506904Z","steps":["trace[215828710] 'read index received'  (duration: 225.262089ms)","trace[215828710] 'applied index is now lower than readState.Index'  (duration: 3.99µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T13:47:57.507112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.454455ms","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-20T13:47:57.507177Z","caller":"traceutil/trace.go:171","msg":"trace[1007154466] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:776; }","duration":"225.542939ms","start":"2026-01-20T13:47:57.281624Z","end":"2026-01-20T13:47:57.507166Z","steps":["trace[1007154466] 'agreement among raft nodes before linearized reading'  (duration: 225.379293ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T13:47:57.520684Z","caller":"traceutil/trace.go:171","msg":"trace[392765930] transaction","detail":"{read_only:false; response_revision:777; number_of_response:1; }","duration":"223.07785ms","start":"2026-01-20T13:47:57.297592Z","end":"2026-01-20T13:47:57.52067Z","steps":["trace[392765930] 'process raft request'  (duration: 223.008227ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T13:48:11.215353Z","caller":"traceutil/trace.go:171","msg":"trace[2143954348] linearizableReadLoop","detail":"{readStateIndex:894; appliedIndex:893; }","duration":"116.000062ms","start":"2026-01-20T13:48:11.099337Z","end":"2026-01-20T13:48:11.215337Z","steps":["trace[2143954348] 'read index received'  (duration: 115.887679ms)","trace[2143954348] 'applied index is now lower than readState.Index'  (duration: 111.743µs)"],"step_count":2}
{"level":"info","ts":"2026-01-20T13:48:11.215431Z","caller":"traceutil/trace.go:171","msg":"trace[1534668816] transaction","detail":"{read_only:false; response_revision:863; number_of_response:1; }","duration":"175.681142ms","start":"2026-01-20T13:48:11.039745Z","end":"2026-01-20T13:48:11.215426Z","steps":["trace[1534668816] 'process raft request'  (duration: 175.491406ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T13:48:11.215569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.220659ms","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-01-20T13:48:11.215585Z","caller":"traceutil/trace.go:171","msg":"trace[240813614] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:863; }","duration":"116.26801ms","start":"2026-01-20T13:48:11.099312Z","end":"2026-01-20T13:48:11.21558Z","steps":["trace[240813614] 'agreement among raft nodes before linearized reading'  (duration: 116.193668ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T13:48:11.215731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.11765ms","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-20T13:48:11.215774Z","caller":"traceutil/trace.go:171","msg":"trace[1985778798] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:863; }","duration":"108.175461ms","start":"2026-01-20T13:48:11.107588Z","end":"2026-01-20T13:48:11.215764Z","steps":["trace[1985778798] 'agreement among raft nodes before linearized reading'  (duration: 108.065908ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T13:48:11.862793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.076393ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14782674194614394212 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:862 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-01-20T13:48:11.862908Z","caller":"traceutil/trace.go:171","msg":"trace[1032751884] linearizableReadLoop","detail":"{readStateIndex:898; appliedIndex:897; }","duration":"153.507862ms","start":"2026-01-20T13:48:11.709376Z","end":"2026-01-20T13:48:11.862884Z","steps":["trace[1032751884] 'read index received'  (duration: 27.431µs)","trace[1032751884] 'applied index is now lower than readState.Index'  (duration: 153.479281ms)"],"step_count":2}
{"level":"info","ts":"2026-01-20T13:48:11.86311Z","caller":"traceutil/trace.go:171","msg":"trace[505165972] transaction","detail":"{read_only:false; response_revision:867; number_of_response:1; }","duration":"222.79963ms","start":"2026-01-20T13:48:11.640302Z","end":"2026-01-20T13:48:11.863102Z","steps":["trace[505165972] 'process raft request'  (duration: 57.337795ms)","trace[505165972] 'compare'  (duration: 164.98144ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T13:48:11.86324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.859253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-01-20T13:48:11.863259Z","caller":"traceutil/trace.go:171","msg":"trace[621035992] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:867; }","duration":"153.899995ms","start":"2026-01-20T13:48:11.709353Z","end":"2026-01-20T13:48:11.863253Z","steps":["trace[621035992] 'agreement among raft nodes before linearized reading'  (duration: 153.856184ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T13:48:11.86338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.28914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-20T13:48:11.863412Z","caller":"traceutil/trace.go:171","msg":"trace[899283345] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:867; }","duration":"110.349411ms","start":"2026-01-20T13:48:11.753058Z","end":"2026-01-20T13:48:11.863407Z","steps":["trace[899283345] 'agreement among raft nodes before linearized reading'  (duration: 110.303399ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T13:48:19.464469Z","caller":"traceutil/trace.go:171","msg":"trace[1292512282] transaction","detail":"{read_only:false; response_revision:886; number_of_response:1; }","duration":"226.191369ms","start":"2026-01-20T13:48:19.238263Z","end":"2026-01-20T13:48:19.464454Z","steps":["trace[1292512282] 'process raft request'  (duration: 226.115616ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T13:48:19.464626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.071101ms","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-01-20T13:48:19.464649Z","caller":"traceutil/trace.go:171","msg":"trace[155954600] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:886; }","duration":"169.137083ms","start":"2026-01-20T13:48:19.295506Z","end":"2026-01-20T13:48:19.464643Z","steps":["trace[155954600] 'agreement among raft nodes before linearized reading'  (duration: 168.995408ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T13:48:19.464469Z","caller":"traceutil/trace.go:171","msg":"trace[733911449] linearizableReadLoop","detail":"{readStateIndex:918; appliedIndex:918; }","duration":"168.922815ms","start":"2026-01-20T13:48:19.29553Z","end":"2026-01-20T13:48:19.464452Z","steps":["trace[733911449] 'read index received'  (duration: 168.916445ms)","trace[733911449] 'applied index is now lower than readState.Index'  (duration: 5.36µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T13:48:19.468282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.374637ms","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-01-20T13:48:19.46831Z","caller":"traceutil/trace.go:171","msg":"trace[796458334] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:886; }","duration":"167.418508ms","start":"2026-01-20T13:48:19.300885Z","end":"2026-01-20T13:48:19.468303Z","steps":["trace[796458334] 'agreement among raft nodes before linearized reading'  (duration: 167.343725ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T13:48:29.668437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.160538ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14782674194614394369 > lease_revoke:<id:4d269bdba8531d74>","response":"size:28"}
{"level":"info","ts":"2026-01-20T13:48:29.668521Z","caller":"traceutil/trace.go:171","msg":"trace[1451367003] linearizableReadLoop","detail":"{readStateIndex:968; appliedIndex:967; }","duration":"148.642116ms","start":"2026-01-20T13:48:29.519862Z","end":"2026-01-20T13:48:29.668505Z","steps":["trace[1451367003] 'read index received'  (duration: 24.48µs)","trace[1451367003] 'applied index is now lower than readState.Index'  (duration: 148.616846ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T13:48:29.668652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.780981ms","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-01-20T13:48:29.668668Z","caller":"traceutil/trace.go:171","msg":"trace[595614149] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:933; }","duration":"148.828413ms","start":"2026-01-20T13:48:29.519832Z","end":"2026-01-20T13:48:29.668661Z","steps":["trace[595614149] 'agreement among raft nodes before linearized reading'  (duration: 148.733279ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T13:48:29.668741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.522527ms","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-20T13:48:29.668791Z","caller":"traceutil/trace.go:171","msg":"trace[88685856] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:933; }","duration":"145.582769ms","start":"2026-01-20T13:48:29.523196Z","end":"2026-01-20T13:48:29.668779Z","steps":["trace[88685856] 'agreement among raft nodes before linearized reading'  (duration: 145.436785ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T13:48:29.668967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.774769ms","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-01-20T13:48:29.668984Z","caller":"traceutil/trace.go:171","msg":"trace[1889596956] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:933; }","duration":"132.79243ms","start":"2026-01-20T13:48:29.536187Z","end":"2026-01-20T13:48:29.668979Z","steps":["trace[1889596956] 'agreement among raft nodes before linearized reading'  (duration: 132.749528ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T13:48:29.907854Z","caller":"traceutil/trace.go:171","msg":"trace[1629510147] transaction","detail":"{read_only:false; response_revision:937; number_of_response:1; }","duration":"227.885732ms","start":"2026-01-20T13:48:29.679945Z","end":"2026-01-20T13:48:29.90783Z","steps":["trace[1629510147] 'process raft request'  (duration: 227.850641ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T13:48:29.908287Z","caller":"traceutil/trace.go:171","msg":"trace[1213129160] transaction","detail":"{read_only:false; response_revision:935; number_of_response:1; }","duration":"234.04875ms","start":"2026-01-20T13:48:29.674222Z","end":"2026-01-20T13:48:29.908271Z","steps":["trace[1213129160] 'process raft request'  (duration: 233.40652ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T13:48:29.908486Z","caller":"traceutil/trace.go:171","msg":"trace[1907920334] transaction","detail":"{read_only:false; response_revision:936; number_of_response:1; }","duration":"232.530241ms","start":"2026-01-20T13:48:29.675931Z","end":"2026-01-20T13:48:29.908461Z","steps":["trace[1907920334] 'process raft request'  (duration: 231.822569ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T13:48:30.189098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.634769ms","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-20T13:48:30.189191Z","caller":"traceutil/trace.go:171","msg":"trace[764086910] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:937; }","duration":"209.754462ms","start":"2026-01-20T13:48:29.979408Z","end":"2026-01-20T13:48:30.189163Z","steps":["trace[764086910] 'range keys from in-memory index tree'  (duration: 209.500355ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T13:48:41.946946Z","caller":"traceutil/trace.go:171","msg":"trace[123986944] transaction","detail":"{read_only:false; response_revision:1012; number_of_response:1; }","duration":"150.514307ms","start":"2026-01-20T13:48:41.796413Z","end":"2026-01-20T13:48:41.946927Z","steps":["trace[123986944] 'process raft request'  (duration: 149.525646ms)"],"step_count":1}