{"level":"warn","ts":"2026-01-30T15:58:13.900344Z","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-30T15:58:13.90043Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.227: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.227:2380","--initial-cluster=instance=https://162.253.55.227:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.227:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.227: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-30T15:58:13.90071Z","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-30T15:58:13.90072Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.227:2380"]}
{"level":"info","ts":"2026-01-30T15:58:13.900741Z","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-30T15:58:13.901444Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.227:2379"]}
{"level":"info","ts":"2026-01-30T15:58:13.901521Z","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.227:2380"],"listen-peer-urls":["https://162.253.55.227:2380"],"advertise-client-urls":["https://162.253.55.227:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.227:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.227: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-30T15:58:13.911806Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"10.00167ms"}
{"level":"info","ts":"2026-01-30T15:58:13.927617Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"9bd37ed2859641e3","cluster-id":"47d0f4f0a1c3b0a9"}
{"level":"info","ts":"2026-01-30T15:58:13.927796Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd37ed2859641e3 switched to configuration voters=()"}
{"level":"info","ts":"2026-01-30T15:58:13.927831Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd37ed2859641e3 became follower at term 0"}
{"level":"info","ts":"2026-01-30T15:58:13.935273Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 9bd37ed2859641e3 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-01-30T15:58:13.935293Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd37ed2859641e3 became follower at term 1"}
{"level":"info","ts":"2026-01-30T15:58:13.935351Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd37ed2859641e3 switched to configuration voters=(11228457738614227427)"}
{"level":"warn","ts":"2026-01-30T15:58:13.948305Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-01-30T15:58:13.952497Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-01-30T15:58:13.95376Z","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-30T15:58:13.955533Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"9bd37ed2859641e3","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-01-30T15:58:13.958201Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"9bd37ed2859641e3","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-01-30T15:58:13.958518Z","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-30T15:58:13.958554Z","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-30T15:58:13.958593Z","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-30T15:58:13.964385Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd37ed2859641e3 switched to configuration voters=(11228457738614227427)"}
{"level":"info","ts":"2026-01-30T15:58:13.964615Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"47d0f4f0a1c3b0a9","local-member-id":"9bd37ed2859641e3","added-peer-id":"9bd37ed2859641e3","added-peer-peer-urls":["https://162.253.55.227:2380"]}
{"level":"info","ts":"2026-01-30T15:58:13.973963Z","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-30T15:58:13.978715Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"9bd37ed2859641e3","initial-advertise-peer-urls":["https://162.253.55.227:2380"],"listen-peer-urls":["https://162.253.55.227:2380"],"advertise-client-urls":["https://162.253.55.227:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.227:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-01-30T15:58:13.979288Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-01-30T15:58:13.980029Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.227:2380"}
{"level":"info","ts":"2026-01-30T15:58:13.981581Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.227:2380"}
{"level":"info","ts":"2026-01-30T15:58:14.236412Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd37ed2859641e3 is starting a new election at term 1"}
{"level":"info","ts":"2026-01-30T15:58:14.23653Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd37ed2859641e3 became pre-candidate at term 1"}
{"level":"info","ts":"2026-01-30T15:58:14.236557Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd37ed2859641e3 received MsgPreVoteResp from 9bd37ed2859641e3 at term 1"}
{"level":"info","ts":"2026-01-30T15:58:14.236572Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd37ed2859641e3 became candidate at term 2"}
{"level":"info","ts":"2026-01-30T15:58:14.236579Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd37ed2859641e3 received MsgVoteResp from 9bd37ed2859641e3 at term 2"}
{"level":"info","ts":"2026-01-30T15:58:14.236593Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd37ed2859641e3 became leader at term 2"}
{"level":"info","ts":"2026-01-30T15:58:14.23694Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 9bd37ed2859641e3 elected leader 9bd37ed2859641e3 at term 2"}
{"level":"info","ts":"2026-01-30T15:58:14.238961Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-30T15:58:14.241212Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"9bd37ed2859641e3","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.227:2379]}","request-path":"/0/members/9bd37ed2859641e3/attributes","cluster-id":"47d0f4f0a1c3b0a9","publish-timeout":"7s"}
{"level":"info","ts":"2026-01-30T15:58:14.241251Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-01-30T15:58:14.241404Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-01-30T15:58:14.24623Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-01-30T15:58:14.246478Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-01-30T15:58:14.246503Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-01-30T15:58:14.248058Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"47d0f4f0a1c3b0a9","local-member-id":"9bd37ed2859641e3","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-30T15:58:14.248353Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-30T15:58:14.248381Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-30T15:58:14.254183Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.227:2379"}
{"level":"warn","ts":"2026-01-30T15:58:34.487291Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4747810023107572364,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-30T15:58:34.838165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.715699ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4747810023107572366 > lease_revoke:<id:41e39c0fa05db0e3>","response":"size:28"}
{"level":"info","ts":"2026-01-30T15:58:34.8383Z","caller":"traceutil/trace.go:171","msg":"trace[744005578] linearizableReadLoop","detail":"{readStateIndex:418; appliedIndex:417; }","duration":"851.96614ms","start":"2026-01-30T15:58:33.986315Z","end":"2026-01-30T15:58:34.838281Z","steps":["trace[744005578] 'read index received'  (duration: 667.996689ms)","trace[744005578] 'applied index is now lower than readState.Index'  (duration: 183.968021ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-30T15:58:34.838523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"852.195952ms","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-30T15:58:34.83856Z","caller":"traceutil/trace.go:171","msg":"trace[1100190095] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:404; }","duration":"852.273933ms","start":"2026-01-30T15:58:33.986275Z","end":"2026-01-30T15:58:34.838549Z","steps":["trace[1100190095] 'agreement among raft nodes before linearized reading'  (duration: 852.079162ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T15:58:34.838605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T15:58:33.986254Z","time spent":"852.340004ms","remote":"127.0.0.1:58208","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-30T15:58:41.428643Z","caller":"traceutil/trace.go:171","msg":"trace[1081770324] transaction","detail":"{read_only:false; response_revision:421; number_of_response:1; }","duration":"185.608806ms","start":"2026-01-30T15:58:41.24301Z","end":"2026-01-30T15:58:41.428619Z","steps":["trace[1081770324] 'process raft request'  (duration: 177.144227ms)"],"step_count":1}
{"level":"info","ts":"2026-01-30T15:58:46.360627Z","caller":"traceutil/trace.go:171","msg":"trace[153482845] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"237.081113ms","start":"2026-01-30T15:58:46.123527Z","end":"2026-01-30T15:58:46.360608Z","steps":["trace[153482845] 'process raft request'  (duration: 236.981112ms)"],"step_count":1}
{"level":"info","ts":"2026-01-30T15:58:51.677127Z","caller":"traceutil/trace.go:171","msg":"trace[1010522930] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"175.211157ms","start":"2026-01-30T15:58:51.501907Z","end":"2026-01-30T15:58:51.677118Z","steps":["trace[1010522930] 'process raft request'  (duration: 174.961685ms)"],"step_count":1}
{"level":"info","ts":"2026-01-30T15:58:51.676984Z","caller":"traceutil/trace.go:171","msg":"trace[1131307509] linearizableReadLoop","detail":"{readStateIndex:518; appliedIndex:517; }","duration":"140.021547ms","start":"2026-01-30T15:58:51.536946Z","end":"2026-01-30T15:58:51.676968Z","steps":["trace[1131307509] 'read index received'  (duration: 139.865466ms)","trace[1131307509] 'applied index is now lower than readState.Index'  (duration: 155.231µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-30T15:58:51.677477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.50014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-01-30T15:58:51.677503Z","caller":"traceutil/trace.go:171","msg":"trace[331859142] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:501; }","duration":"140.58457ms","start":"2026-01-30T15:58:51.536911Z","end":"2026-01-30T15:58:51.677495Z","steps":["trace[331859142] 'agreement among raft nodes before linearized reading'  (duration: 140.467609ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T15:58:51.678758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.000704ms","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-01-30T15:58:51.678787Z","caller":"traceutil/trace.go:171","msg":"trace[757960418] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:501; }","duration":"126.046005ms","start":"2026-01-30T15:58:51.552732Z","end":"2026-01-30T15:58:51.678778Z","steps":["trace[757960418] 'agreement among raft nodes before linearized reading'  (duration: 125.933165ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T15:58:53.378304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"651.629651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-w4nr7\" ","response":"range_response_count:1 size:16656"}
{"level":"info","ts":"2026-01-30T15:58:53.378375Z","caller":"traceutil/trace.go:171","msg":"trace[1426251595] range","detail":"{range_begin:/registry/pods/kube-system/cilium-w4nr7; range_end:; response_count:1; response_revision:506; }","duration":"651.753953ms","start":"2026-01-30T15:58:52.726604Z","end":"2026-01-30T15:58:53.378358Z","steps":["trace[1426251595] 'range keys from in-memory index tree'  (duration: 651.427791ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T15:58:53.378907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T15:58:52.726588Z","time spent":"652.304856ms","remote":"127.0.0.1:58124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16679,"request content":"key:\"/registry/pods/kube-system/cilium-w4nr7\" "}
{"level":"warn","ts":"2026-01-30T15:58:53.379309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.259473ms","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-30T15:58:53.379331Z","caller":"traceutil/trace.go:171","msg":"trace[1855723922] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:506; }","duration":"458.309873ms","start":"2026-01-30T15:58:52.921015Z","end":"2026-01-30T15:58:53.379325Z","steps":["trace[1855723922] 'range keys from in-memory index tree'  (duration: 458.158332ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T15:58:53.379345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T15:58:52.920999Z","time spent":"458.343053ms","remote":"127.0.0.1:58208","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-30T15:58:53.651298Z","caller":"traceutil/trace.go:171","msg":"trace[1251801426] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"266.361556ms","start":"2026-01-30T15:58:53.384919Z","end":"2026-01-30T15:58:53.651281Z","steps":["trace[1251801426] 'process raft request'  (duration: 266.249726ms)"],"step_count":1}
{"level":"info","ts":"2026-01-30T15:58:53.651641Z","caller":"traceutil/trace.go:171","msg":"trace[2019543773] linearizableReadLoop","detail":"{readStateIndex:524; appliedIndex:524; }","duration":"253.411532ms","start":"2026-01-30T15:58:53.398225Z","end":"2026-01-30T15:58:53.651636Z","steps":["trace[2019543773] 'read index received'  (duration: 253.404942ms)","trace[2019543773] 'applied index is now lower than readState.Index'  (duration: 6.21µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-30T15:58:53.651688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.448692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-30T15:58:53.651703Z","caller":"traceutil/trace.go:171","msg":"trace[1557530179] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:507; }","duration":"253.499202ms","start":"2026-01-30T15:58:53.3982Z","end":"2026-01-30T15:58:53.651699Z","steps":["trace[1557530179] 'agreement among raft nodes before linearized reading'  (duration: 253.456062ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T15:58:54.175187Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4747810023107572590,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-01-30T15:58:54.314468Z","caller":"traceutil/trace.go:171","msg":"trace[779356688] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"907.49013ms","start":"2026-01-30T15:58:53.406959Z","end":"2026-01-30T15:58:54.314449Z","steps":["trace[779356688] 'process raft request'  (duration: 907.340919ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T15:58:54.314844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T15:58:53.406941Z","time spent":"907.57572ms","remote":"127.0.0.1:58124","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-w4nr7\" mod_revision:454 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-w4nr7\" value_size:16754 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-w4nr7\" > >"}
{"level":"warn","ts":"2026-01-30T15:58:54.689541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.7573ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4747810023107572591 > lease_revoke:<id:41e39c0fa05db2a9>","response":"size:28"}
{"level":"info","ts":"2026-01-30T15:58:54.689614Z","caller":"traceutil/trace.go:171","msg":"trace[17273883] linearizableReadLoop","detail":"{readStateIndex:526; appliedIndex:525; }","duration":"1.015131276s","start":"2026-01-30T15:58:53.674471Z","end":"2026-01-30T15:58:54.689602Z","steps":["trace[17273883] 'read index received'  (duration: 640.727182ms)","trace[17273883] 'applied index is now lower than readState.Index'  (duration: 374.403064ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-30T15:58:54.689719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.015236797s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-30T15:58:54.689738Z","caller":"traceutil/trace.go:171","msg":"trace[1254262051] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:508; }","duration":"1.015282667s","start":"2026-01-30T15:58:53.674449Z","end":"2026-01-30T15:58:54.689732Z","steps":["trace[1254262051] 'agreement among raft nodes before linearized reading'  (duration: 1.015235247s)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T15:58:54.689782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T15:58:53.674438Z","time spent":"1.015336778s","remote":"127.0.0.1:57930","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-30T15:58:54.690007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.007416016s","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-30T15:58:54.690025Z","caller":"traceutil/trace.go:171","msg":"trace[1616903214] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:508; }","duration":"1.007458976s","start":"2026-01-30T15:58:53.682561Z","end":"2026-01-30T15:58:54.690021Z","steps":["trace[1616903214] 'agreement among raft nodes before linearized reading'  (duration: 1.007386816s)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T15:58:54.690039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T15:58:53.68255Z","time spent":"1.007484646s","remote":"127.0.0.1:58208","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-30T15:58:54.690153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"975.168187ms","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-01-30T15:58:54.690181Z","caller":"traceutil/trace.go:171","msg":"trace[1163982027] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:508; }","duration":"975.205977ms","start":"2026-01-30T15:58:53.71496Z","end":"2026-01-30T15:58:54.690166Z","steps":["trace[1163982027] 'agreement among raft nodes before linearized reading'  (duration: 975.164847ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T15:58:54.690197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T15:58:53.714933Z","time spent":"975.261297ms","remote":"127.0.0.1:58208","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-01-30T15:58:54.690279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.001387497s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-01-30T15:58:54.690295Z","caller":"traceutil/trace.go:171","msg":"trace[1190221026] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:508; }","duration":"1.001412457s","start":"2026-01-30T15:58:53.688879Z","end":"2026-01-30T15:58:54.690292Z","steps":["trace[1190221026] 'agreement among raft nodes before linearized reading'  (duration: 1.001364477s)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T15:58:54.690307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T15:58:53.688874Z","time spent":"1.001430317s","remote":"127.0.0.1:58208","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-01-30T15:58:55.236754Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4747810023107572593,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-30T15:58:55.736989Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4747810023107572593,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-30T15:58:56.238433Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4747810023107572593,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-30T15:58:56.440815Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.704474236s","expected-duration":"1s"}
{"level":"info","ts":"2026-01-30T15:58:56.441164Z","caller":"traceutil/trace.go:171","msg":"trace[159536706] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"1.704871238s","start":"2026-01-30T15:58:54.736277Z","end":"2026-01-30T15:58:56.441148Z","steps":["trace[159536706] 'process raft request'  (duration: 1.704735988s)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T15:58:56.441253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T15:58:54.73626Z","time spent":"1.704938559s","remote":"127.0.0.1:58208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:502 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-01-30T15:58:56.484966Z","caller":"traceutil/trace.go:171","msg":"trace[1000864302] linearizableReadLoop","detail":"{readStateIndex:529; appliedIndex:527; }","duration":"1.748353387s","start":"2026-01-30T15:58:54.736561Z","end":"2026-01-30T15:58:56.484914Z","steps":["trace[1000864302] 'read index received'  (duration: 1.707829088s)","trace[1000864302] 'applied index is now lower than readState.Index'  (duration: 40.523099ms)"],"step_count":2}
{"level":"info","ts":"2026-01-30T15:58:56.485218Z","caller":"traceutil/trace.go:171","msg":"trace[1259828635] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"1.698830627s","start":"2026-01-30T15:58:54.786376Z","end":"2026-01-30T15:58:56.485207Z","steps":["trace[1259828635] 'process raft request'  (duration: 1.698392754s)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T15:58:56.485348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T15:58:54.786321Z","time spent":"1.698934578s","remote":"127.0.0.1:58208","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:503 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-01-30T15:58:56.48552Z","caller":"traceutil/trace.go:171","msg":"trace[1793883614] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"1.695625977s","start":"2026-01-30T15:58:54.789876Z","end":"2026-01-30T15:58:56.485502Z","steps":["trace[1793883614] 'process raft request'  (duration: 1.695002833s)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T15:58:56.485575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T15:58:54.789857Z","time spent":"1.695691897s","remote":"127.0.0.1:58208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:501 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-01-30T15:58:56.485745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.749179622s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-30T15:58:56.485787Z","caller":"traceutil/trace.go:171","msg":"trace[1190085886] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:511; }","duration":"1.749236203s","start":"2026-01-30T15:58:54.736541Z","end":"2026-01-30T15:58:56.485777Z","steps":["trace[1190085886] 'agreement among raft nodes before linearized reading'  (duration: 1.749176442s)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T15:58:56.48582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T15:58:54.736527Z","time spent":"1.749287703s","remote":"127.0.0.1:57928","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-30T15:58:56.486021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"808.678418ms","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-30T15:58:56.486056Z","caller":"traceutil/trace.go:171","msg":"trace[793859590] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:511; }","duration":"808.761238ms","start":"2026-01-30T15:58:55.677286Z","end":"2026-01-30T15:58:56.486048Z","steps":["trace[793859590] 'agreement among raft nodes before linearized reading'  (duration: 808.657738ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T15:58:56.48609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T15:58:55.677261Z","time spent":"808.820129ms","remote":"127.0.0.1:58208","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-30T15:58:58.549194Z","caller":"traceutil/trace.go:171","msg":"trace[1435587949] linearizableReadLoop","detail":"{readStateIndex:539; appliedIndex:538; }","duration":"150.710585ms","start":"2026-01-30T15:58:58.398462Z","end":"2026-01-30T15:58:58.549157Z","steps":["trace[1435587949] 'read index received'  (duration: 150.495614ms)","trace[1435587949] 'applied index is now lower than readState.Index'  (duration: 198.431µs)"],"step_count":2}
{"level":"info","ts":"2026-01-30T15:58:58.549542Z","caller":"traceutil/trace.go:171","msg":"trace[1581782693] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"216.941675ms","start":"2026-01-30T15:58:58.332588Z","end":"2026-01-30T15:58:58.54953Z","steps":["trace[1581782693] 'process raft request'  (duration: 216.425221ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T15:58:58.550667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.961596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-01-30T15:58:58.552502Z","caller":"traceutil/trace.go:171","msg":"trace[863850879] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:521; }","duration":"103.818668ms","start":"2026-01-30T15:58:58.448667Z","end":"2026-01-30T15:58:58.552486Z","steps":["trace[863850879] 'agreement among raft nodes before linearized reading'  (duration: 101.903856ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T15:58:58.549774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.299189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-30T15:58:58.554698Z","caller":"traceutil/trace.go:171","msg":"trace[1624655671] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:521; }","duration":"156.258ms","start":"2026-01-30T15:58:58.398426Z","end":"2026-01-30T15:58:58.554684Z","steps":["trace[1624655671] 'agreement among raft nodes before linearized reading'  (duration: 151.306749ms)"],"step_count":1}
{"level":"info","ts":"2026-01-30T16:00:41.577807Z","caller":"traceutil/trace.go:171","msg":"trace[1544693744] transaction","detail":"{read_only:false; response_revision:1000; number_of_response:1; }","duration":"164.152672ms","start":"2026-01-30T16:00:41.413622Z","end":"2026-01-30T16:00:41.577774Z","steps":["trace[1544693744] 'process raft request'  (duration: 159.469825ms)"],"step_count":1}
{"level":"info","ts":"2026-01-30T16:00:41.589803Z","caller":"traceutil/trace.go:171","msg":"trace[1651788891] transaction","detail":"{read_only:false; response_revision:1001; number_of_response:1; }","duration":"175.887919ms","start":"2026-01-30T16:00:41.413896Z","end":"2026-01-30T16:00:41.589784Z","steps":["trace[1651788891] 'process raft request'  (duration: 175.486101ms)"],"step_count":1}
{"level":"info","ts":"2026-01-30T16:00:41.589998Z","caller":"traceutil/trace.go:171","msg":"trace[1446562551] transaction","detail":"{read_only:false; response_revision:1002; number_of_response:1; }","duration":"174.988522ms","start":"2026-01-30T16:00:41.414998Z","end":"2026-01-30T16:00:41.589987Z","steps":["trace[1446562551] 'process raft request'  (duration: 174.446802ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T16:00:42.827746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.394023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-30T16:00:42.827828Z","caller":"traceutil/trace.go:171","msg":"trace[258469461] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1003; }","duration":"414.519115ms","start":"2026-01-30T16:00:42.413292Z","end":"2026-01-30T16:00:42.827811Z","steps":["trace[258469461] 'range keys from in-memory index tree'  (duration: 414.321771ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-30T16:00:42.828326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-30T16:00:42.413273Z","time spent":"415.011364ms","remote":"127.0.0.1:57928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}