{"level":"warn","ts":"2026-01-21T00:36:19.042167Z","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-21T00:36:19.042286Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.207: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.207:2380","--initial-cluster=instance=https://162.253.55.207:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.207:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.207: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-21T00:36:19.042374Z","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-21T00:36:19.042411Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.207:2380"]}
{"level":"info","ts":"2026-01-21T00:36:19.042439Z","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-21T00:36:19.043721Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.207:2379"]}
{"level":"info","ts":"2026-01-21T00:36:19.043792Z","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.207:2380"],"listen-peer-urls":["https://162.253.55.207:2380"],"advertise-client-urls":["https://162.253.55.207:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.207:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.207: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-21T00:36:19.049732Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.744219ms"}
{"level":"info","ts":"2026-01-21T00:36:19.07749Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6f1fcbe50562a63a","cluster-id":"a9b9f04f4e8a9fba"}
{"level":"info","ts":"2026-01-21T00:36:19.077607Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6f1fcbe50562a63a switched to configuration voters=()"}
{"level":"info","ts":"2026-01-21T00:36:19.077637Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6f1fcbe50562a63a became follower at term 0"}
{"level":"info","ts":"2026-01-21T00:36:19.078401Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6f1fcbe50562a63a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-01-21T00:36:19.078423Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6f1fcbe50562a63a became follower at term 1"}
{"level":"info","ts":"2026-01-21T00:36:19.078478Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6f1fcbe50562a63a switched to configuration voters=(8007342846986331706)"}
{"level":"warn","ts":"2026-01-21T00:36:19.085526Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-01-21T00:36:19.086645Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-01-21T00:36:19.088362Z","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-21T00:36:19.095941Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6f1fcbe50562a63a","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-01-21T00:36:19.097321Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6f1fcbe50562a63a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-01-21T00:36:19.097463Z","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-21T00:36:19.097504Z","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-21T00:36:19.097531Z","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-21T00:36:19.099557Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6f1fcbe50562a63a switched to configuration voters=(8007342846986331706)"}
{"level":"info","ts":"2026-01-21T00:36:19.09965Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"a9b9f04f4e8a9fba","local-member-id":"6f1fcbe50562a63a","added-peer-id":"6f1fcbe50562a63a","added-peer-peer-urls":["https://162.253.55.207:2380"]}
{"level":"info","ts":"2026-01-21T00:36:19.122019Z","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-21T00:36:19.122515Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6f1fcbe50562a63a","initial-advertise-peer-urls":["https://162.253.55.207:2380"],"listen-peer-urls":["https://162.253.55.207:2380"],"advertise-client-urls":["https://162.253.55.207:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.207:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-01-21T00:36:19.122565Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-01-21T00:36:19.12322Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.207:2380"}
{"level":"info","ts":"2026-01-21T00:36:19.123299Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.207:2380"}
{"level":"info","ts":"2026-01-21T00:36:20.079744Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6f1fcbe50562a63a is starting a new election at term 1"}
{"level":"info","ts":"2026-01-21T00:36:20.07986Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6f1fcbe50562a63a became pre-candidate at term 1"}
{"level":"info","ts":"2026-01-21T00:36:20.079903Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6f1fcbe50562a63a received MsgPreVoteResp from 6f1fcbe50562a63a at term 1"}
{"level":"info","ts":"2026-01-21T00:36:20.079933Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6f1fcbe50562a63a became candidate at term 2"}
{"level":"info","ts":"2026-01-21T00:36:20.07994Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6f1fcbe50562a63a received MsgVoteResp from 6f1fcbe50562a63a at term 2"}
{"level":"info","ts":"2026-01-21T00:36:20.07995Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6f1fcbe50562a63a became leader at term 2"}
{"level":"info","ts":"2026-01-21T00:36:20.079956Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6f1fcbe50562a63a elected leader 6f1fcbe50562a63a at term 2"}
{"level":"info","ts":"2026-01-21T00:36:20.081407Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-21T00:36:20.083135Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6f1fcbe50562a63a","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.207:2379]}","request-path":"/0/members/6f1fcbe50562a63a/attributes","cluster-id":"a9b9f04f4e8a9fba","publish-timeout":"7s"}
{"level":"info","ts":"2026-01-21T00:36:20.083263Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-01-21T00:36:20.083528Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-01-21T00:36:20.084533Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"a9b9f04f4e8a9fba","local-member-id":"6f1fcbe50562a63a","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-21T00:36:20.08466Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-21T00:36:20.084712Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-21T00:36:20.085962Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.207:2379"}
{"level":"info","ts":"2026-01-21T00:36:20.096472Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-01-21T00:36:20.096528Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-01-21T00:36:20.143118Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"warn","ts":"2026-01-21T00:36:29.981321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.436914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:4597"}
{"level":"info","ts":"2026-01-21T00:36:29.981412Z","caller":"traceutil/trace.go:171","msg":"trace[73949555] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:341; }","duration":"207.58194ms","start":"2026-01-21T00:36:29.773812Z","end":"2026-01-21T00:36:29.981394Z","steps":["trace[73949555] 'range keys from in-memory index tree'  (duration: 207.3044ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-21T00:36:29.981714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"724.446568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"}
{"level":"info","ts":"2026-01-21T00:36:29.981746Z","caller":"traceutil/trace.go:171","msg":"trace[1968420487] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:341; }","duration":"724.50888ms","start":"2026-01-21T00:36:29.257227Z","end":"2026-01-21T00:36:29.981736Z","steps":["trace[1968420487] 'range keys from in-memory index tree'  (duration: 724.379076ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-21T00:36:29.981773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-21T00:36:29.25721Z","time spent":"724.555462ms","remote":"127.0.0.1:44138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":1,"response size":241,"request content":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" "}
{"level":"warn","ts":"2026-01-21T00:36:29.98193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"674.457327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"}
{"level":"info","ts":"2026-01-21T00:36:29.981956Z","caller":"traceutil/trace.go:171","msg":"trace[12625345] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:341; }","duration":"674.515939ms","start":"2026-01-21T00:36:29.307433Z","end":"2026-01-21T00:36:29.981949Z","steps":["trace[12625345] 'range keys from in-memory index tree'  (duration: 674.368354ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-21T00:36:29.981981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-21T00:36:29.307417Z","time spent":"674.5582ms","remote":"127.0.0.1:44138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":232,"request content":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" "}
{"level":"warn","ts":"2026-01-21T00:36:29.982097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"625.660947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"}
{"level":"info","ts":"2026-01-21T00:36:29.982122Z","caller":"traceutil/trace.go:171","msg":"trace[1390185908] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:341; }","duration":"625.707189ms","start":"2026-01-21T00:36:29.356407Z","end":"2026-01-21T00:36:29.982114Z","steps":["trace[1390185908] 'range keys from in-memory index tree'  (duration: 625.618955ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-21T00:36:29.982147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-21T00:36:29.356398Z","time spent":"625.743259ms","remote":"127.0.0.1:44138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":257,"request content":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" "}
{"level":"warn","ts":"2026-01-21T00:36:29.982862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.599624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"}
{"level":"info","ts":"2026-01-21T00:36:29.98305Z","caller":"traceutil/trace.go:171","msg":"trace[1933638966] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:341; }","duration":"324.826812ms","start":"2026-01-21T00:36:29.658207Z","end":"2026-01-21T00:36:29.983034Z","steps":["trace[1933638966] 'range keys from in-memory index tree'  (duration: 324.47438ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-21T00:36:29.983237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.005601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6898"}
{"level":"info","ts":"2026-01-21T00:36:29.983271Z","caller":"traceutil/trace.go:171","msg":"trace[2128202100] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:341; }","duration":"210.048043ms","start":"2026-01-21T00:36:29.773213Z","end":"2026-01-21T00:36:29.983261Z","steps":["trace[2128202100] 'range keys from in-memory index tree'  (duration: 209.968589ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-21T00:36:29.983501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.312361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"}
{"level":"info","ts":"2026-01-21T00:36:29.983538Z","caller":"traceutil/trace.go:171","msg":"trace[1616206272] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:341; }","duration":"210.367163ms","start":"2026-01-21T00:36:29.773162Z","end":"2026-01-21T00:36:29.983529Z","steps":["trace[1616206272] 'range keys from in-memory index tree'  (duration: 210.206378ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-21T00:36:29.983479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-21T00:36:29.658177Z","time spent":"325.07592ms","remote":"127.0.0.1:44138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":216,"request content":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" "}
{"level":"warn","ts":"2026-01-21T00:36:29.984048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.070552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"}
{"level":"info","ts":"2026-01-21T00:36:29.984261Z","caller":"traceutil/trace.go:171","msg":"trace[8861715] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:341; }","duration":"276.33704ms","start":"2026-01-21T00:36:29.707911Z","end":"2026-01-21T00:36:29.984248Z","steps":["trace[8861715] 'range keys from in-memory index tree'  (duration: 275.988099ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-21T00:36:29.982635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.951632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-01-21T00:36:29.982686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"575.011964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"}
{"level":"warn","ts":"2026-01-21T00:36:29.982718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"525.264691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"}
{"level":"warn","ts":"2026-01-21T00:36:29.982746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.517138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"}
{"level":"warn","ts":"2026-01-21T00:36:29.982772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.048391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"}
{"level":"warn","ts":"2026-01-21T00:36:29.982798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.0387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"}
{"level":"warn","ts":"2026-01-21T00:36:29.982827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.058957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-01-21T00:36:29.983175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.27072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7045"}
{"level":"warn","ts":"2026-01-21T00:36:29.983207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.362933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5270"}
{"level":"info","ts":"2026-01-21T00:36:29.985939Z","caller":"traceutil/trace.go:171","msg":"trace[833380494] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:341; }","duration":"213.103785ms","start":"2026-01-21T00:36:29.772819Z","end":"2026-01-21T00:36:29.985923Z","steps":["trace[833380494] 'range keys from in-memory index tree'  (duration: 210.243558ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-21T00:36:29.986399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.390135ms","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-21T00:36:29.987301Z","caller":"traceutil/trace.go:171","msg":"trace[1181817640] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:341; }","duration":"236.316816ms","start":"2026-01-21T00:36:29.75097Z","end":"2026-01-21T00:36:29.987286Z","steps":["trace[1181817640] 'range keys from in-memory index tree'  (duration: 235.328502ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-21T00:36:29.983803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.909557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4260"}
{"level":"warn","ts":"2026-01-21T00:36:29.983132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.070088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"}
{"level":"info","ts":"2026-01-21T00:36:29.986697Z","caller":"traceutil/trace.go:171","msg":"trace[2041051459] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:341; }","duration":"529.269326ms","start":"2026-01-21T00:36:29.45742Z","end":"2026-01-21T00:36:29.986689Z","steps":["trace[2041051459] 'range keys from in-memory index tree'  (duration: 525.20978ms)"],"step_count":1}
{"level":"info","ts":"2026-01-21T00:36:29.986798Z","caller":"traceutil/trace.go:171","msg":"trace[925079086] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:341; }","duration":"234.143813ms","start":"2026-01-21T00:36:29.752648Z","end":"2026-01-21T00:36:29.986792Z","steps":["trace[925079086] 'range keys from in-memory index tree'  (duration: 229.896081ms)"],"step_count":1}
{"level":"info","ts":"2026-01-21T00:36:29.986814Z","caller":"traceutil/trace.go:171","msg":"trace[1049471338] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:341; }","duration":"579.170264ms","start":"2026-01-21T00:36:29.407639Z","end":"2026-01-21T00:36:29.98681Z","steps":["trace[1049471338] 'range keys from in-memory index tree'  (duration: 574.958073ms)"],"step_count":1}
{"level":"info","ts":"2026-01-21T00:36:29.986907Z","caller":"traceutil/trace.go:171","msg":"trace[196989676] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:341; }","duration":"379.186349ms","start":"2026-01-21T00:36:29.607715Z","end":"2026-01-21T00:36:29.986901Z","steps":["trace[196989676] 'range keys from in-memory index tree'  (duration: 374.962998ms)"],"step_count":1}
{"level":"info","ts":"2026-01-21T00:36:29.98695Z","caller":"traceutil/trace.go:171","msg":"trace[1663755403] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:341; }","duration":"479.716239ms","start":"2026-01-21T00:36:29.507203Z","end":"2026-01-21T00:36:29.986919Z","steps":["trace[1663755403] 'range keys from in-memory index tree'  (duration: 475.472537ms)"],"step_count":1}
{"level":"info","ts":"2026-01-21T00:36:29.986965Z","caller":"traceutil/trace.go:171","msg":"trace[1138625291] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:341; }","duration":"429.270093ms","start":"2026-01-21T00:36:29.55769Z","end":"2026-01-21T00:36:29.98696Z","steps":["trace[1138625291] 'range keys from in-memory index tree'  (duration: 424.99594ms)"],"step_count":1}
{"level":"info","ts":"2026-01-21T00:36:29.986986Z","caller":"traceutil/trace.go:171","msg":"trace[1986374929] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:341; }","duration":"214.096757ms","start":"2026-01-21T00:36:29.772885Z","end":"2026-01-21T00:36:29.986981Z","steps":["trace[1986374929] 'range keys from in-memory index tree'  (duration: 210.226648ms)"],"step_count":1}
{"level":"info","ts":"2026-01-21T00:36:29.987Z","caller":"traceutil/trace.go:171","msg":"trace[421299806] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:341; }","duration":"367.271659ms","start":"2026-01-21T00:36:29.619724Z","end":"2026-01-21T00:36:29.986995Z","steps":["trace[421299806] 'range keys from in-memory index tree'  (duration: 363.006416ms)"],"step_count":1}
{"level":"info","ts":"2026-01-21T00:36:29.988984Z","caller":"traceutil/trace.go:171","msg":"trace[722423780] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:341; }","duration":"215.095302ms","start":"2026-01-21T00:36:29.773871Z","end":"2026-01-21T00:36:29.988966Z","steps":["trace[722423780] 'range keys from in-memory index tree'  (duration: 209.870756ms)"],"step_count":1}
{"level":"info","ts":"2026-01-21T00:36:29.989199Z","caller":"traceutil/trace.go:171","msg":"trace[1391786939] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:341; }","duration":"231.150433ms","start":"2026-01-21T00:36:29.758036Z","end":"2026-01-21T00:36:29.989187Z","steps":["trace[1391786939] 'range keys from in-memory index tree'  (duration: 224.994385ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-21T00:36:29.989417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-21T00:36:29.457394Z","time spent":"532.006028ms","remote":"127.0.0.1:44138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":220,"request content":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" "}
{"level":"warn","ts":"2026-01-21T00:36:29.990178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-21T00:36:29.407624Z","time spent":"582.510246ms","remote":"127.0.0.1:44138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":232,"request content":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" "}
{"level":"warn","ts":"2026-01-21T00:36:29.990402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-21T00:36:29.607693Z","time spent":"382.693597ms","remote":"127.0.0.1:44138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" "}
{"level":"warn","ts":"2026-01-21T00:36:29.990651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-21T00:36:29.50719Z","time spent":"483.447424ms","remote":"127.0.0.1:44138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" "}
{"level":"warn","ts":"2026-01-21T00:36:29.990973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-21T00:36:29.557675Z","time spent":"433.283629ms","remote":"127.0.0.1:44138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":226,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" "}
{"level":"warn","ts":"2026-01-21T00:36:29.992092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-21T00:36:29.619709Z","time spent":"372.37116ms","remote":"127.0.0.1:44204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-01-21T00:36:35.616717Z","caller":"traceutil/trace.go:171","msg":"trace[1443143558] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"508.227098ms","start":"2026-01-21T00:36:35.108465Z","end":"2026-01-21T00:36:35.616692Z","steps":["trace[1443143558] 'process raft request'  (duration: 508.033571ms)"],"step_count":1}
{"level":"info","ts":"2026-01-21T00:36:35.617591Z","caller":"traceutil/trace.go:171","msg":"trace[2116149710] linearizableReadLoop","detail":"{readStateIndex:423; appliedIndex:423; }","duration":"444.309986ms","start":"2026-01-21T00:36:35.173255Z","end":"2026-01-21T00:36:35.617565Z","steps":["trace[2116149710] 'read index received'  (duration: 444.298036ms)","trace[2116149710] 'applied index is now lower than readState.Index'  (duration: 9.44µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-21T00:36:35.617663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-21T00:36:35.108449Z","time spent":"508.350342ms","remote":"127.0.0.1:44204","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:287 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-01-21T00:36:35.61788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.603976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4019"}
{"level":"info","ts":"2026-01-21T00:36:35.617919Z","caller":"traceutil/trace.go:171","msg":"trace[327898580] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:411; }","duration":"444.685179ms","start":"2026-01-21T00:36:35.173222Z","end":"2026-01-21T00:36:35.617907Z","steps":["trace[327898580] 'agreement among raft nodes before linearized reading'  (duration: 444.492702ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-21T00:36:35.617954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-21T00:36:35.173208Z","time spent":"444.73693ms","remote":"127.0.0.1:44118","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4042,"request content":"key:\"/registry/minions/instance\" "}
{"level":"warn","ts":"2026-01-21T00:36:35.618148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.304163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-21T00:36:35.618193Z","caller":"traceutil/trace.go:171","msg":"trace[113976883] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:411; }","duration":"182.380556ms","start":"2026-01-21T00:36:35.435799Z","end":"2026-01-21T00:36:35.618179Z","steps":["trace[113976883] 'agreement among raft nodes before linearized reading'  (duration: 182.317644ms)"],"step_count":1}
{"level":"info","ts":"2026-01-21T00:36:50.305113Z","caller":"traceutil/trace.go:171","msg":"trace[1918014462] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"171.413152ms","start":"2026-01-21T00:36:50.133692Z","end":"2026-01-21T00:36:50.305106Z","steps":["trace[1918014462] 'process raft request'  (duration: 171.115802ms)"],"step_count":1}
{"level":"info","ts":"2026-01-21T00:36:50.305063Z","caller":"traceutil/trace.go:171","msg":"trace[2035921348] linearizableReadLoop","detail":"{readStateIndex:527; appliedIndex:526; }","duration":"164.491033ms","start":"2026-01-21T00:36:50.140556Z","end":"2026-01-21T00:36:50.305047Z","steps":["trace[2035921348] 'read index received'  (duration: 164.190883ms)","trace[2035921348] 'applied index is now lower than readState.Index'  (duration: 299.15µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-21T00:36:50.305339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.516871ms","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-01-21T00:36:50.30536Z","caller":"traceutil/trace.go:171","msg":"trace[2065831074] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:511; }","duration":"161.553562ms","start":"2026-01-21T00:36:50.1438Z","end":"2026-01-21T00:36:50.305354Z","steps":["trace[2065831074] 'agreement among raft nodes before linearized reading'  (duration: 161.52013ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-21T00:36:50.305467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.746272ms","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-01-21T00:36:50.305481Z","caller":"traceutil/trace.go:171","msg":"trace[958328924] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:511; }","duration":"164.944669ms","start":"2026-01-21T00:36:50.140532Z","end":"2026-01-21T00:36:50.305477Z","steps":["trace[958328924] 'agreement among raft nodes before linearized reading'  (duration: 164.753462ms)"],"step_count":1}
{"level":"info","ts":"2026-01-21T00:36:53.267789Z","caller":"traceutil/trace.go:171","msg":"trace[208255449] linearizableReadLoop","detail":"{readStateIndex:557; appliedIndex:556; }","duration":"143.974567ms","start":"2026-01-21T00:36:53.123793Z","end":"2026-01-21T00:36:53.267767Z","steps":["trace[208255449] 'read index received'  (duration: 143.785159ms)","trace[208255449] 'applied index is now lower than readState.Index'  (duration: 188.478µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-21T00:36:53.267952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.128852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.207\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-01-21T00:36:53.267997Z","caller":"traceutil/trace.go:171","msg":"trace[1254320468] range","detail":"{range_begin:/registry/masterleases/162.253.55.207; range_end:; response_count:1; response_revision:541; }","duration":"144.214645ms","start":"2026-01-21T00:36:53.123772Z","end":"2026-01-21T00:36:53.267987Z","steps":["trace[1254320468] 'agreement among raft nodes before linearized reading'  (duration: 144.094041ms)"],"step_count":1}
{"level":"info","ts":"2026-01-21T00:36:53.268301Z","caller":"traceutil/trace.go:171","msg":"trace[2064134615] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"157.681263ms","start":"2026-01-21T00:36:53.11061Z","end":"2026-01-21T00:36:53.268291Z","steps":["trace[2064134615] 'process raft request'  (duration: 157.03703ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-21T00:36:53.929752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.821807ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11978057536647989920 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:263a9bddfb180a9f>","response":"size:40"}
{"level":"warn","ts":"2026-01-21T00:36:53.929941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-21T00:36:53.269805Z","time spent":"660.130769ms","remote":"127.0.0.1:43980","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-01-21T00:36:53.93001Z","caller":"traceutil/trace.go:171","msg":"trace[420715925] linearizableReadLoop","detail":"{readStateIndex:558; appliedIndex:557; }","duration":"495.141743ms","start":"2026-01-21T00:36:53.434851Z","end":"2026-01-21T00:36:53.929993Z","steps":["trace[420715925] 'read index received'  (duration: 24.831µs)","trace[420715925] 'applied index is now lower than readState.Index'  (duration: 495.114742ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-21T00:36:53.93012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.262097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-21T00:36:53.93158Z","caller":"traceutil/trace.go:171","msg":"trace[930678149] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:541; }","duration":"496.758319ms","start":"2026-01-21T00:36:53.434806Z","end":"2026-01-21T00:36:53.931565Z","steps":["trace[930678149] 'agreement among raft nodes before linearized reading'  (duration: 495.269758ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-21T00:36:53.931792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-21T00:36:53.434793Z","time spent":"496.915285ms","remote":"127.0.0.1:35232","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-01-21T00:36:55.553098Z","caller":"traceutil/trace.go:171","msg":"trace[810426461] linearizableReadLoop","detail":"{readStateIndex:563; appliedIndex:562; }","duration":"120.295092ms","start":"2026-01-21T00:36:55.432767Z","end":"2026-01-21T00:36:55.553062Z","steps":["trace[810426461] 'read index received'  (duration: 120.147467ms)","trace[810426461] 'applied index is now lower than readState.Index'  (duration: 146.665µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-21T00:36:55.553203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.414326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-21T00:36:55.553257Z","caller":"traceutil/trace.go:171","msg":"trace[97439808] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:546; }","duration":"120.508209ms","start":"2026-01-21T00:36:55.43274Z","end":"2026-01-21T00:36:55.553248Z","steps":["trace[97439808] 'agreement among raft nodes before linearized reading'  (duration: 120.417896ms)"],"step_count":1}
{"level":"info","ts":"2026-01-21T00:36:55.553305Z","caller":"traceutil/trace.go:171","msg":"trace[568576962] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"279.506925ms","start":"2026-01-21T00:36:55.27378Z","end":"2026-01-21T00:36:55.553287Z","steps":["trace[568576962] 'process raft request'  (duration: 279.149643ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-21T00:36:56.756721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.609309ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11978057536647989942 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:544 > 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-21T00:36:56.756821Z","caller":"traceutil/trace.go:171","msg":"trace[446083129] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"402.09321ms","start":"2026-01-21T00:36:56.354717Z","end":"2026-01-21T00:36:56.756811Z","steps":["trace[446083129] 'process raft request'  (duration: 402.064899ms)"],"step_count":1}
{"level":"info","ts":"2026-01-21T00:36:56.756834Z","caller":"traceutil/trace.go:171","msg":"trace[1293048576] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"403.044563ms","start":"2026-01-21T00:36:56.35377Z","end":"2026-01-21T00:36:56.756815Z","steps":["trace[1293048576] 'process raft request'  (duration: 54.289429ms)","trace[1293048576] 'compare'  (duration: 348.531836ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-21T00:36:56.756935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-21T00:36:56.353754Z","time spent":"403.126755ms","remote":"127.0.0.1:44204","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:544 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-01-21T00:36:56.756854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-21T00:36:56.354711Z","time spent":"402.128291ms","remote":"127.0.0.1:44204","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:545 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-01-21T00:36:57.93474Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11978057536647989950,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-21T00:36:58.420303Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.183478406s","expected-duration":"1s"}
{"level":"info","ts":"2026-01-21T00:36:58.420612Z","caller":"traceutil/trace.go:171","msg":"trace[2095218303] linearizableReadLoop","detail":"{readStateIndex:571; appliedIndex:570; }","duration":"985.887216ms","start":"2026-01-21T00:36:57.434704Z","end":"2026-01-21T00:36:58.420591Z","steps":["trace[2095218303] 'read index received'  (duration: 985.71682ms)","trace[2095218303] 'applied index is now lower than readState.Index'  (duration: 169.496µs)"],"step_count":2}
{"level":"info","ts":"2026-01-21T00:36:58.420903Z","caller":"traceutil/trace.go:171","msg":"trace[286789762] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"1.18418159s","start":"2026-01-21T00:36:57.236709Z","end":"2026-01-21T00:36:58.420891Z","steps":["trace[286789762] 'process raft request'  (duration: 1.183764245s)"],"step_count":1}
{"level":"warn","ts":"2026-01-21T00:36:58.421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-21T00:36:57.23669Z","time spent":"1.184251332s","remote":"127.0.0.1:44130","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-8lqxp\" mod_revision:499 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-8lqxp\" value_size:16754 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-8lqxp\" > >"}
{"level":"warn","ts":"2026-01-21T00:36:58.421172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"986.465006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-21T00:36:58.421212Z","caller":"traceutil/trace.go:171","msg":"trace[439109496] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:554; }","duration":"986.501237ms","start":"2026-01-21T00:36:57.434699Z","end":"2026-01-21T00:36:58.4212Z","steps":["trace[439109496] 'agreement among raft nodes before linearized reading'  (duration: 986.444255ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-21T00:36:58.421244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-21T00:36:57.434646Z","time spent":"986.592461ms","remote":"127.0.0.1:35248","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-21T00:36:58.421375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"864.852462ms","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-21T00:36:58.421391Z","caller":"traceutil/trace.go:171","msg":"trace[484224722] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:554; }","duration":"864.902364ms","start":"2026-01-21T00:36:57.556485Z","end":"2026-01-21T00:36:58.421387Z","steps":["trace[484224722] 'agreement among raft nodes before linearized reading'  (duration: 864.843682ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-21T00:36:58.421403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-21T00:36:57.556466Z","time spent":"864.934885ms","remote":"127.0.0.1:44204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-01-21T00:36:58.553213Z","caller":"traceutil/trace.go:171","msg":"trace[794192062] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"122.224748ms","start":"2026-01-21T00:36:58.430975Z","end":"2026-01-21T00:36:58.553199Z","steps":["trace[794192062] 'process raft request'  (duration: 122.087964ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-21T00:37:00.177929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.624782315s","expected-duration":"100ms","prefix":"","request":"header:<ID:11978057536647989956 > lease_revoke:<id:263a9bddfb1809f3>","response":"size:28"}
{"level":"info","ts":"2026-01-21T00:37:00.177997Z","caller":"traceutil/trace.go:171","msg":"trace[221417534] linearizableReadLoop","detail":"{readStateIndex:573; appliedIndex:572; }","duration":"1.746380292s","start":"2026-01-21T00:36:58.431604Z","end":"2026-01-21T00:37:00.177984Z","steps":["trace[221417534] 'read index received'  (duration: 42.822512ms)","trace[221417534] 'applied index is now lower than readState.Index'  (duration: 1.70355696s)"],"step_count":2}
{"level":"warn","ts":"2026-01-21T00:37:00.178392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.746783006s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-21T00:37:00.178412Z","caller":"traceutil/trace.go:171","msg":"trace[783800422] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:556; }","duration":"1.746821217s","start":"2026-01-21T00:36:58.431583Z","end":"2026-01-21T00:37:00.178404Z","steps":["trace[783800422] 'agreement among raft nodes before linearized reading'  (duration: 1.746782286s)"],"step_count":1}
{"level":"warn","ts":"2026-01-21T00:37:00.178429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-21T00:36:58.431578Z","time spent":"1.746847238s","remote":"127.0.0.1:35232","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-21T00:37:00.178581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.417768432s","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-21T00:37:00.178594Z","caller":"traceutil/trace.go:171","msg":"trace[871710644] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:556; }","duration":"1.417824905s","start":"2026-01-21T00:36:58.760765Z","end":"2026-01-21T00:37:00.17859Z","steps":["trace[871710644] 'agreement among raft nodes before linearized reading'  (duration: 1.417755902s)"],"step_count":1}
{"level":"warn","ts":"2026-01-21T00:37:00.178606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-21T00:36:58.760746Z","time spent":"1.417857115s","remote":"127.0.0.1:44204","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-01-21T00:37:00.17871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.417871556s","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-21T00:37:00.178725Z","caller":"traceutil/trace.go:171","msg":"trace[1663492877] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:556; }","duration":"1.417899727s","start":"2026-01-21T00:36:58.76082Z","end":"2026-01-21T00:37:00.17872Z","steps":["trace[1663492877] 'agreement among raft nodes before linearized reading'  (duration: 1.417858676s)"],"step_count":1}
{"level":"warn","ts":"2026-01-21T00:37:00.178737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-21T00:36:58.760815Z","time spent":"1.417918858s","remote":"127.0.0.1:44204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-01-21T00:37:01.416889Z","caller":"traceutil/trace.go:171","msg":"trace[166872637] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"170.862996ms","start":"2026-01-21T00:37:01.24601Z","end":"2026-01-21T00:37:01.416873Z","steps":["trace[166872637] 'process raft request'  (duration: 170.778833ms)"],"step_count":1}
{"level":"info","ts":"2026-01-21T00:37:02.765625Z","caller":"traceutil/trace.go:171","msg":"trace[664889396] linearizableReadLoop","detail":"{readStateIndex:593; appliedIndex:592; }","duration":"203.453529ms","start":"2026-01-21T00:37:02.562156Z","end":"2026-01-21T00:37:02.76561Z","steps":["trace[664889396] 'read index received'  (duration: 203.325424ms)","trace[664889396] 'applied index is now lower than readState.Index'  (duration: 127.565µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-21T00:37:02.765761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.586413ms","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-21T00:37:02.76578Z","caller":"traceutil/trace.go:171","msg":"trace[1850213897] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:575; }","duration":"203.643505ms","start":"2026-01-21T00:37:02.56213Z","end":"2026-01-21T00:37:02.765773Z","steps":["trace[1850213897] 'agreement among raft nodes before linearized reading'  (duration: 203.544112ms)"],"step_count":1}
{"level":"info","ts":"2026-01-21T00:37:02.765986Z","caller":"traceutil/trace.go:171","msg":"trace[1940706122] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"279.180165ms","start":"2026-01-21T00:37:02.4868Z","end":"2026-01-21T00:37:02.765981Z","steps":["trace[1940706122] 'process raft request'  (duration: 278.725779ms)"],"step_count":1}
{"level":"info","ts":"2026-01-21T00:38:27.426984Z","caller":"traceutil/trace.go:171","msg":"trace[1283659429] transaction","detail":"{read_only:false; response_revision:992; number_of_response:1; }","duration":"100.673574ms","start":"2026-01-21T00:38:27.326293Z","end":"2026-01-21T00:38:27.426967Z","steps":["trace[1283659429] 'process raft request'  (duration: 76.665176ms)","trace[1283659429] 'compare'  (duration: 23.906036ms)"],"step_count":2}
{"level":"info","ts":"2026-01-21T00:38:28.782062Z","caller":"traceutil/trace.go:171","msg":"trace[1516839363] transaction","detail":"{read_only:false; response_revision:993; number_of_response:1; }","duration":"621.868395ms","start":"2026-01-21T00:38:28.160176Z","end":"2026-01-21T00:38:28.782044Z","steps":["trace[1516839363] 'process raft request'  (duration: 621.744203ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-21T00:38:28.782317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-21T00:38:28.160158Z","time spent":"622.094781ms","remote":"127.0.0.1:44118","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5218,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:783 > success:<request_put:<key:\"/registry/minions/instance\" value_size:5184 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"info","ts":"2026-01-21T00:38:28.834463Z","caller":"traceutil/trace.go:171","msg":"trace[11483159] transaction","detail":"{read_only:false; response_revision:994; number_of_response:1; }","duration":"362.94004ms","start":"2026-01-21T00:38:28.47151Z","end":"2026-01-21T00:38:28.83445Z","steps":["trace[11483159] 'process raft request'  (duration: 362.637763ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-21T00:38:28.835519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-21T00:38:28.471493Z","time spent":"363.021721ms","remote":"127.0.0.1:44204","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:959 > 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-21T00:38:28.8361Z","caller":"traceutil/trace.go:171","msg":"trace[1317017207] linearizableReadLoop","detail":"{readStateIndex:1033; appliedIndex:1032; }","duration":"398.213454ms","start":"2026-01-21T00:38:28.43605Z","end":"2026-01-21T00:38:28.834263Z","steps":["trace[1317017207] 'read index received'  (duration: 346.864527ms)","trace[1317017207] 'applied index is now lower than readState.Index'  (duration: 51.348187ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-21T00:38:28.836205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.150669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-21T00:38:28.836359Z","caller":"traceutil/trace.go:171","msg":"trace[808857581] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:994; }","duration":"400.336942ms","start":"2026-01-21T00:38:28.436012Z","end":"2026-01-21T00:38:28.836349Z","steps":["trace[808857581] 'agreement among raft nodes before linearized reading'  (duration: 400.147038ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-21T00:38:28.836407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-21T00:38:28.435994Z","time spent":"400.404974ms","remote":"127.0.0.1:35248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-01-21T00:39:01.592174Z","caller":"traceutil/trace.go:171","msg":"trace[2072677985] linearizableReadLoop","detail":"{readStateIndex:1137; appliedIndex:1136; }","duration":"114.27817ms","start":"2026-01-21T00:39:01.477879Z","end":"2026-01-21T00:39:01.592157Z","steps":["trace[2072677985] 'read index received'  (duration: 75.509616ms)","trace[2072677985] 'applied index is now lower than readState.Index'  (duration: 38.767704ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-21T00:39:01.592523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.62181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-8lqxp\" ","response":"range_response_count:1 size:18062"}
{"level":"info","ts":"2026-01-21T00:39:01.592569Z","caller":"traceutil/trace.go:171","msg":"trace[484608681] range","detail":"{range_begin:/registry/pods/kube-system/cilium-8lqxp; range_end:; response_count:1; response_revision:1091; }","duration":"114.682282ms","start":"2026-01-21T00:39:01.477877Z","end":"2026-01-21T00:39:01.592559Z","steps":["trace[484608681] 'agreement among raft nodes before linearized reading'  (duration: 114.366262ms)"],"step_count":1}
{"level":"info","ts":"2026-01-21T00:39:01.593099Z","caller":"traceutil/trace.go:171","msg":"trace[635836908] transaction","detail":"{read_only:false; response_revision:1091; number_of_response:1; }","duration":"115.384179ms","start":"2026-01-21T00:39:01.477699Z","end":"2026-01-21T00:39:01.593084Z","steps":["trace[635836908] 'process raft request'  (duration: 75.771672ms)","trace[635836908] 'compare'  (duration: 38.559989ms)"],"step_count":2}