{"level":"warn","ts":"2026-03-15T01:56:25.078891Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-15T01:56:25.078979Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.204: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.204:2380","--initial-cluster=instance=https://162.253.55.204:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.204:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.204: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-03-15T01:56:25.079043Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-15T01:56:25.079056Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.204:2380"]}
{"level":"info","ts":"2026-03-15T01:56:25.079071Z","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-03-15T01:56:25.07967Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.204:2379"]}
{"level":"info","ts":"2026-03-15T01:56:25.079743Z","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":8,"max-cpu-available":8,"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.204:2380"],"listen-peer-urls":["https://162.253.55.204:2380"],"advertise-client-urls":["https://162.253.55.204:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.204:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.204: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-03-15T01:56:25.084731Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.775691ms"}
{"level":"info","ts":"2026-03-15T01:56:25.095565Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a11c20306510c1f7","cluster-id":"97da89d0cbebd2b5"}
{"level":"info","ts":"2026-03-15T01:56:25.09566Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 switched to configuration voters=()"}
{"level":"info","ts":"2026-03-15T01:56:25.09568Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became follower at term 0"}
{"level":"info","ts":"2026-03-15T01:56:25.09569Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a11c20306510c1f7 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-15T01:56:25.095699Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became follower at term 1"}
{"level":"info","ts":"2026-03-15T01:56:25.095732Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 switched to configuration voters=(11609189331680412151)"}
{"level":"warn","ts":"2026-03-15T01:56:25.10325Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-15T01:56:25.104525Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-15T01:56:25.105598Z","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-03-15T01:56:25.107515Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a11c20306510c1f7","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-15T01:56:25.108236Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a11c20306510c1f7","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-15T01:56:25.108308Z","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-03-15T01:56:25.108343Z","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-03-15T01:56:25.10835Z","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-03-15T01:56:25.115735Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 switched to configuration voters=(11609189331680412151)"}
{"level":"info","ts":"2026-03-15T01:56:25.116155Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"97da89d0cbebd2b5","local-member-id":"a11c20306510c1f7","added-peer-id":"a11c20306510c1f7","added-peer-peer-urls":["https://162.253.55.204:2380"]}
{"level":"info","ts":"2026-03-15T01:56:25.118611Z","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-03-15T01:56:25.118722Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.204:2380"}
{"level":"info","ts":"2026-03-15T01:56:25.11886Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.204:2380"}
{"level":"info","ts":"2026-03-15T01:56:25.119073Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a11c20306510c1f7","initial-advertise-peer-urls":["https://162.253.55.204:2380"],"listen-peer-urls":["https://162.253.55.204:2380"],"advertise-client-urls":["https://162.253.55.204:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.204:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-15T01:56:25.119132Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-15T01:56:26.096781Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 is starting a new election at term 1"}
{"level":"info","ts":"2026-03-15T01:56:26.096848Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-15T01:56:26.096896Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 received MsgPreVoteResp from a11c20306510c1f7 at term 1"}
{"level":"info","ts":"2026-03-15T01:56:26.096915Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became candidate at term 2"}
{"level":"info","ts":"2026-03-15T01:56:26.096927Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 received MsgVoteResp from a11c20306510c1f7 at term 2"}
{"level":"info","ts":"2026-03-15T01:56:26.096943Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became leader at term 2"}
{"level":"info","ts":"2026-03-15T01:56:26.096957Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a11c20306510c1f7 elected leader a11c20306510c1f7 at term 2"}
{"level":"info","ts":"2026-03-15T01:56:26.098035Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-15T01:56:26.099372Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-15T01:56:26.099428Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-15T01:56:26.099351Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a11c20306510c1f7","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.204:2379]}","request-path":"/0/members/a11c20306510c1f7/attributes","cluster-id":"97da89d0cbebd2b5","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-15T01:56:26.099669Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"97da89d0cbebd2b5","local-member-id":"a11c20306510c1f7","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-15T01:56:26.09976Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-15T01:56:26.099795Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-15T01:56:26.10007Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-15T01:56:26.100177Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-15T01:56:26.103754Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.204:2379"}
{"level":"info","ts":"2026-03-15T01:56:26.106476Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-03-15T01:56:35.635105Z","caller":"traceutil/trace.go:171","msg":"trace[859577004] linearizableReadLoop","detail":"{readStateIndex:379; appliedIndex:378; }","duration":"148.376887ms","start":"2026-03-15T01:56:35.486702Z","end":"2026-03-15T01:56:35.635079Z","steps":["trace[859577004] 'read index received'  (duration: 132.136047ms)","trace[859577004] 'applied index is now lower than readState.Index'  (duration: 16.23966ms)"],"step_count":2}
{"level":"info","ts":"2026-03-15T01:56:35.635255Z","caller":"traceutil/trace.go:171","msg":"trace[1439046714] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"172.469836ms","start":"2026-03-15T01:56:35.462728Z","end":"2026-03-15T01:56:35.635198Z","steps":["trace[1439046714] 'process raft request'  (duration: 156.110912ms)","trace[1439046714] 'compare'  (duration: 16.103285ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-15T01:56:35.635307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.590755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"}
{"level":"info","ts":"2026-03-15T01:56:35.635377Z","caller":"traceutil/trace.go:171","msg":"trace[785436837] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:369; }","duration":"148.715419ms","start":"2026-03-15T01:56:35.486649Z","end":"2026-03-15T01:56:35.635364Z","steps":["trace[785436837] 'agreement among raft nodes before linearized reading'  (duration: 148.541123ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-15T01:56:41.092776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.570635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-03-15T01:56:41.092903Z","caller":"traceutil/trace.go:171","msg":"trace[1604808811] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:413; }","duration":"123.783224ms","start":"2026-03-15T01:56:40.969095Z","end":"2026-03-15T01:56:41.092878Z","steps":["trace[1604808811] 'range keys from in-memory index tree'  (duration: 123.294646ms)"],"step_count":1}
{"level":"info","ts":"2026-03-15T01:56:41.432761Z","caller":"traceutil/trace.go:171","msg":"trace[756190230] linearizableReadLoop","detail":"{readStateIndex:426; appliedIndex:425; }","duration":"231.977703ms","start":"2026-03-15T01:56:41.20075Z","end":"2026-03-15T01:56:41.432728Z","steps":["trace[756190230] 'read index received'  (duration: 231.821338ms)","trace[756190230] 'applied index is now lower than readState.Index'  (duration: 154.665µs)"],"step_count":2}
{"level":"info","ts":"2026-03-15T01:56:41.432805Z","caller":"traceutil/trace.go:171","msg":"trace[2088847178] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"326.139573ms","start":"2026-03-15T01:56:41.106638Z","end":"2026-03-15T01:56:41.432777Z","steps":["trace[2088847178] 'process raft request'  (duration: 325.934166ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-15T01:56:41.432951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.18009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4375"}
{"level":"info","ts":"2026-03-15T01:56:41.432992Z","caller":"traceutil/trace.go:171","msg":"trace[1231142683] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:414; }","duration":"232.287164ms","start":"2026-03-15T01:56:41.200694Z","end":"2026-03-15T01:56:41.432982Z","steps":["trace[1231142683] 'agreement among raft nodes before linearized reading'  (duration: 232.1835ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-15T01:56:41.433397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-15T01:56:41.106581Z","time spent":"326.288058ms","remote":"127.0.0.1:52436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:407 > 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-03-15T01:56:41.933102Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976812519775898272,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-15T01:56:42.49566Z","caller":"traceutil/trace.go:171","msg":"trace[259900665] linearizableReadLoop","detail":"{readStateIndex:427; appliedIndex:426; }","duration":"1.06279088s","start":"2026-03-15T01:56:41.432847Z","end":"2026-03-15T01:56:42.495638Z","steps":["trace[259900665] 'read index received'  (duration: 986.05935ms)","trace[259900665] 'applied index is now lower than readState.Index'  (duration: 76.73056ms)"],"step_count":2}
{"level":"info","ts":"2026-03-15T01:56:42.495731Z","caller":"traceutil/trace.go:171","msg":"trace[2062371754] transaction","detail":"{read_only:false; response_revision:415; number_of_response:1; }","duration":"1.22781914s","start":"2026-03-15T01:56:41.26788Z","end":"2026-03-15T01:56:42.495699Z","steps":["trace[2062371754] 'process raft request'  (duration: 1.151102591s)","trace[2062371754] 'compare'  (duration: 76.559193ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-15T01:56:42.495869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"713.776743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-03-15T01:56:42.495867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.15528574s","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-03-15T01:56:42.495888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-15T01:56:41.267851Z","time spent":"1.227964065s","remote":"127.0.0.1:52436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:289 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-03-15T01:56:42.495912Z","caller":"traceutil/trace.go:171","msg":"trace[206572476] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:415; }","duration":"713.853845ms","start":"2026-03-15T01:56:41.782047Z","end":"2026-03-15T01:56:42.495901Z","steps":["trace[206572476] 'agreement among raft nodes before linearized reading'  (duration: 713.72088ms)"],"step_count":1}
{"level":"info","ts":"2026-03-15T01:56:42.495934Z","caller":"traceutil/trace.go:171","msg":"trace[541486970] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:415; }","duration":"1.155410334s","start":"2026-03-15T01:56:41.340504Z","end":"2026-03-15T01:56:42.495914Z","steps":["trace[541486970] 'agreement among raft nodes before linearized reading'  (duration: 1.155251689s)"],"step_count":1}
{"level":"warn","ts":"2026-03-15T01:56:42.495948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-15T01:56:41.782028Z","time spent":"713.909577ms","remote":"127.0.0.1:52436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-15T01:56:42.49597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-15T01:56:41.340471Z","time spent":"1.155490927s","remote":"127.0.0.1:52436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-15T01:56:42.49606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.211216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"info","ts":"2026-03-15T01:56:42.496157Z","caller":"traceutil/trace.go:171","msg":"trace[291191092] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:415; }","duration":"251.358112ms","start":"2026-03-15T01:56:42.24477Z","end":"2026-03-15T01:56:42.496128Z","steps":["trace[291191092] 'agreement among raft nodes before linearized reading'  (duration: 251.130254ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-15T01:56:42.496243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.369433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-15T01:56:42.496339Z","caller":"traceutil/trace.go:171","msg":"trace[1197095343] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:415; }","duration":"431.688674ms","start":"2026-03-15T01:56:42.064596Z","end":"2026-03-15T01:56:42.496285Z","steps":["trace[1197095343] 'agreement among raft nodes before linearized reading'  (duration: 431.368993ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-15T01:56:42.496426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-15T01:56:42.06458Z","time spent":"431.795069ms","remote":"127.0.0.1:52144","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-15T01:56:57.414264Z","caller":"traceutil/trace.go:171","msg":"trace[1114092858] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"127.10126ms","start":"2026-03-15T01:56:57.287135Z","end":"2026-03-15T01:56:57.414236Z","steps":["trace[1114092858] 'process raft request'  (duration: 126.984816ms)"],"step_count":1}
{"level":"info","ts":"2026-03-15T01:57:03.622443Z","caller":"traceutil/trace.go:171","msg":"trace[14293461] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"426.023598ms","start":"2026-03-15T01:57:03.196398Z","end":"2026-03-15T01:57:03.622421Z","steps":["trace[14293461] 'process raft request'  (duration: 425.618374ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-15T01:57:03.622573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-15T01:57:03.196379Z","time spent":"426.128932ms","remote":"127.0.0.1:52352","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-lhpzc\" mod_revision:502 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-lhpzc\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-lhpzc\" > >"}
{"level":"warn","ts":"2026-03-15T01:57:05.175525Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976812519775898555,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-15T01:57:05.216056Z","caller":"traceutil/trace.go:171","msg":"trace[413520972] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"543.180839ms","start":"2026-03-15T01:57:04.672851Z","end":"2026-03-15T01:57:05.216032Z","steps":["trace[413520972] 'process raft request'  (duration: 542.968242ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-15T01:57:05.216212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-15T01:57:04.67284Z","time spent":"543.286093ms","remote":"127.0.0.1:52436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:549 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-03-15T01:57:05.22747Z","caller":"traceutil/trace.go:171","msg":"trace[1745361017] linearizableReadLoop","detail":"{readStateIndex:577; appliedIndex:575; }","duration":"552.606624ms","start":"2026-03-15T01:57:04.674842Z","end":"2026-03-15T01:57:05.227449Z","steps":["trace[1745361017] 'read index received'  (duration: 541.080739ms)","trace[1745361017] 'applied index is now lower than readState.Index'  (duration: 11.525095ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-15T01:57:05.227737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.927491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-15T01:57:05.227768Z","caller":"traceutil/trace.go:171","msg":"trace[250304711] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:558; }","duration":"163.006913ms","start":"2026-03-15T01:57:05.064753Z","end":"2026-03-15T01:57:05.22776Z","steps":["trace[250304711] 'agreement among raft nodes before linearized reading'  (duration: 162.946361ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-15T01:57:05.227795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"552.931555ms","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-03-15T01:57:05.227875Z","caller":"traceutil/trace.go:171","msg":"trace[211508580] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:558; }","duration":"553.057329ms","start":"2026-03-15T01:57:04.674802Z","end":"2026-03-15T01:57:05.227859Z","steps":["trace[211508580] 'agreement among raft nodes before linearized reading'  (duration: 552.828552ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-15T01:57:05.22791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-15T01:57:04.674787Z","time spent":"553.117271ms","remote":"127.0.0.1:52436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-03-15T01:57:05.228262Z","caller":"traceutil/trace.go:171","msg":"trace[1071003020] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"553.893217ms","start":"2026-03-15T01:57:04.674322Z","end":"2026-03-15T01:57:05.228215Z","steps":["trace[1071003020] 'process raft request'  (duration: 553.011298ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-15T01:57:05.228468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-15T01:57:04.674299Z","time spent":"554.106764ms","remote":"127.0.0.1:52436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:550 > 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-03-15T01:57:06.018141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"605.384365ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976812519775898561 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:551 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-15T01:57:06.018449Z","caller":"traceutil/trace.go:171","msg":"trace[489223663] linearizableReadLoop","detail":"{readStateIndex:578; appliedIndex:577; }","duration":"293.228371ms","start":"2026-03-15T01:57:05.7252Z","end":"2026-03-15T01:57:06.018428Z","steps":["trace[489223663] 'read index received'  (duration: 29.711µs)","trace[489223663] 'applied index is now lower than readState.Index'  (duration: 293.19712ms)"],"step_count":2}
{"level":"info","ts":"2026-03-15T01:57:06.018475Z","caller":"traceutil/trace.go:171","msg":"trace[1974139663] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"786.817994ms","start":"2026-03-15T01:57:05.231621Z","end":"2026-03-15T01:57:06.018439Z","steps":["trace[1974139663] 'process raft request'  (duration: 180.844629ms)","trace[1974139663] 'compare'  (duration: 605.271221ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-15T01:57:06.018586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.382146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-03-15T01:57:06.018614Z","caller":"traceutil/trace.go:171","msg":"trace[1869236115] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:559; }","duration":"293.440898ms","start":"2026-03-15T01:57:05.725164Z","end":"2026-03-15T01:57:06.018605Z","steps":["trace[1869236115] 'agreement among raft nodes before linearized reading'  (duration: 293.321684ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-15T01:57:06.018622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-15T01:57:05.2316Z","time spent":"786.947868ms","remote":"127.0.0.1:52436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:551 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-03-15T01:57:07.718934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.69343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-15T01:57:07.719036Z","caller":"traceutil/trace.go:171","msg":"trace[132130392] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:0; response_revision:573; }","duration":"381.841465ms","start":"2026-03-15T01:57:07.337176Z","end":"2026-03-15T01:57:07.719017Z","steps":["trace[132130392] 'range keys from in-memory index tree'  (duration: 381.638228ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-15T01:57:07.719079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-15T01:57:07.337162Z","time spent":"381.906488ms","remote":"127.0.0.1:52436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":29,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-03-15T01:57:10.53344Z","caller":"traceutil/trace.go:171","msg":"trace[1187270697] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"171.514597ms","start":"2026-03-15T01:57:10.361899Z","end":"2026-03-15T01:57:10.533413Z","steps":["trace[1187270697] 'process raft request'  (duration: 171.380203ms)"],"step_count":1}
{"level":"info","ts":"2026-03-15T01:58:36.495604Z","caller":"traceutil/trace.go:171","msg":"trace[1038528514] transaction","detail":"{read_only:false; response_revision:1000; number_of_response:1; }","duration":"275.596242ms","start":"2026-03-15T01:58:36.21998Z","end":"2026-03-15T01:58:36.495576Z","steps":["trace[1038528514] 'process raft request'  (duration: 275.297373ms)"],"step_count":1}