{"level":"warn","ts":"2026-01-19T13:39:16.449154Z","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-19T13:39:16.449237Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.74: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.74:2380","--initial-cluster=instance=https://162.253.55.74:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.74:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.74: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-19T13:39:16.449292Z","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-19T13:39:16.449299Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.74:2380"]}
{"level":"info","ts":"2026-01-19T13:39:16.449314Z","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-19T13:39:16.450035Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.74:2379"]}
{"level":"info","ts":"2026-01-19T13:39:16.450098Z","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.74:2380"],"listen-peer-urls":["https://162.253.55.74:2380"],"advertise-client-urls":["https://162.253.55.74:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.74:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.74: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-19T13:39:16.478044Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"27.77115ms"}
{"level":"info","ts":"2026-01-19T13:39:16.500705Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"30aa8136fb61a722","cluster-id":"e7ea3889c4872560"}
{"level":"info","ts":"2026-01-19T13:39:16.500766Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 switched to configuration voters=()"}
{"level":"info","ts":"2026-01-19T13:39:16.5009Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 became follower at term 0"}
{"level":"info","ts":"2026-01-19T13:39:16.500991Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 30aa8136fb61a722 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-01-19T13:39:16.501059Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 became follower at term 1"}
{"level":"info","ts":"2026-01-19T13:39:16.501192Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 switched to configuration voters=(3506757333007050530)"}
{"level":"warn","ts":"2026-01-19T13:39:16.507753Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-01-19T13:39:16.514161Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-01-19T13:39:16.522554Z","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-19T13:39:16.528657Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"30aa8136fb61a722","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-01-19T13:39:16.536566Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"30aa8136fb61a722","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-01-19T13:39:16.536891Z","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-19T13:39:16.536923Z","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-19T13:39:16.53693Z","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-19T13:39:16.545936Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 switched to configuration voters=(3506757333007050530)"}
{"level":"info","ts":"2026-01-19T13:39:16.546292Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e7ea3889c4872560","local-member-id":"30aa8136fb61a722","added-peer-id":"30aa8136fb61a722","added-peer-peer-urls":["https://162.253.55.74:2380"]}
{"level":"info","ts":"2026-01-19T13:39:16.549982Z","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-19T13:39:16.550271Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"30aa8136fb61a722","initial-advertise-peer-urls":["https://162.253.55.74:2380"],"listen-peer-urls":["https://162.253.55.74:2380"],"advertise-client-urls":["https://162.253.55.74:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.74:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-01-19T13:39:16.550302Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-01-19T13:39:16.550478Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.74:2380"}
{"level":"info","ts":"2026-01-19T13:39:16.550497Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.74:2380"}
{"level":"info","ts":"2026-01-19T13:39:16.801781Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 is starting a new election at term 1"}
{"level":"info","ts":"2026-01-19T13:39:16.801819Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 became pre-candidate at term 1"}
{"level":"info","ts":"2026-01-19T13:39:16.801837Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 received MsgPreVoteResp from 30aa8136fb61a722 at term 1"}
{"level":"info","ts":"2026-01-19T13:39:16.801877Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 became candidate at term 2"}
{"level":"info","ts":"2026-01-19T13:39:16.801886Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 received MsgVoteResp from 30aa8136fb61a722 at term 2"}
{"level":"info","ts":"2026-01-19T13:39:16.801907Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 became leader at term 2"}
{"level":"info","ts":"2026-01-19T13:39:16.801917Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 30aa8136fb61a722 elected leader 30aa8136fb61a722 at term 2"}
{"level":"info","ts":"2026-01-19T13:39:16.806353Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"30aa8136fb61a722","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.74:2379]}","request-path":"/0/members/30aa8136fb61a722/attributes","cluster-id":"e7ea3889c4872560","publish-timeout":"7s"}
{"level":"info","ts":"2026-01-19T13:39:16.806505Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-01-19T13:39:16.806576Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-01-19T13:39:16.806882Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-19T13:39:16.806997Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-01-19T13:39:16.807054Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-01-19T13:39:16.808445Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-01-19T13:39:16.810767Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e7ea3889c4872560","local-member-id":"30aa8136fb61a722","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-19T13:39:16.810925Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-19T13:39:16.811001Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-19T13:39:16.830696Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.74:2379"}
{"level":"info","ts":"2026-01-19T13:39:33.259407Z","caller":"traceutil/trace.go:171","msg":"trace[689316408] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"113.526642ms","start":"2026-01-19T13:39:33.145857Z","end":"2026-01-19T13:39:33.259383Z","steps":["trace[689316408] 'process raft request'  (duration: 113.113989ms)"],"step_count":1}
{"level":"info","ts":"2026-01-19T13:39:33.938487Z","caller":"traceutil/trace.go:171","msg":"trace[1957021580] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"664.447931ms","start":"2026-01-19T13:39:33.274014Z","end":"2026-01-19T13:39:33.938462Z","steps":["trace[1957021580] 'process raft request'  (duration: 607.538383ms)","trace[1957021580] 'compare'  (duration: 56.684305ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-19T13:39:33.946081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T13:39:33.274Z","time spent":"664.552412ms","remote":"127.0.0.1:37740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6669,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-controller-manager-instance\" mod_revision:381 > success:<request_put:<key:\"/registry/pods/kube-system/kube-controller-manager-instance\" value_size:6602 >> failure:<request_range:<key:\"/registry/pods/kube-system/kube-controller-manager-instance\" > >"}
{"level":"info","ts":"2026-01-19T13:39:34.465534Z","caller":"traceutil/trace.go:171","msg":"trace[373102983] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"1.184557649s","start":"2026-01-19T13:39:33.280943Z","end":"2026-01-19T13:39:34.465501Z","steps":["trace[373102983] 'process raft request'  (duration: 1.114292108s)","trace[373102983] 'compare'  (duration: 69.809833ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-19T13:39:34.465783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T13:39:33.280934Z","time spent":"1.184663633s","remote":"127.0.0.1:38032","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4158,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/deployments/kube-system/coredns\" mod_revision:354 > success:<request_put:<key:\"/registry/deployments/kube-system/coredns\" value_size:4109 >> failure:<request_range:<key:\"/registry/deployments/kube-system/coredns\" > >"}
{"level":"info","ts":"2026-01-19T13:39:51.093328Z","caller":"traceutil/trace.go:171","msg":"trace[1292323822] linearizableReadLoop","detail":"{readStateIndex:530; appliedIndex:529; }","duration":"100.296419ms","start":"2026-01-19T13:39:50.993017Z","end":"2026-01-19T13:39:51.093313Z","steps":["trace[1292323822] 'read index received'  (duration: 100.106462ms)","trace[1292323822] 'applied index is now lower than readState.Index'  (duration: 189.427µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-19T13:39:51.093522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.482825ms","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-19T13:39:51.09356Z","caller":"traceutil/trace.go:171","msg":"trace[224555335] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:511; }","duration":"100.60761ms","start":"2026-01-19T13:39:50.992946Z","end":"2026-01-19T13:39:51.093553Z","steps":["trace[224555335] 'agreement among raft nodes before linearized reading'  (duration: 100.528407ms)"],"step_count":1}
{"level":"info","ts":"2026-01-19T13:39:51.093713Z","caller":"traceutil/trace.go:171","msg":"trace[79923518] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"104.367378ms","start":"2026-01-19T13:39:50.989339Z","end":"2026-01-19T13:39:51.093707Z","steps":["trace[79923518] 'process raft request'  (duration: 103.8273ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T13:39:51.093878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.216996ms","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-19T13:39:51.093896Z","caller":"traceutil/trace.go:171","msg":"trace[1345535511] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:511; }","duration":"100.236517ms","start":"2026-01-19T13:39:50.993656Z","end":"2026-01-19T13:39:51.093892Z","steps":["trace[1345535511] 'agreement among raft nodes before linearized reading'  (duration: 100.206456ms)"],"step_count":1}
{"level":"info","ts":"2026-01-19T13:40:01.577409Z","caller":"traceutil/trace.go:171","msg":"trace[525628102] linearizableReadLoop","detail":"{readStateIndex:558; appliedIndex:557; }","duration":"444.663635ms","start":"2026-01-19T13:40:01.132723Z","end":"2026-01-19T13:40:01.577386Z","steps":["trace[525628102] 'read index received'  (duration: 444.457619ms)","trace[525628102] 'applied index is now lower than readState.Index'  (duration: 205.076µs)"],"step_count":2}
{"level":"info","ts":"2026-01-19T13:40:01.577633Z","caller":"traceutil/trace.go:171","msg":"trace[1423906656] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"449.269885ms","start":"2026-01-19T13:40:01.128352Z","end":"2026-01-19T13:40:01.577622Z","steps":["trace[1423906656] 'process raft request'  (duration: 448.880813ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T13:40:01.577725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T13:40:01.128344Z","time spent":"449.317916ms","remote":"127.0.0.1:37840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:528 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-01-19T13:40:01.578232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.49758ms","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-19T13:40:01.578272Z","caller":"traceutil/trace.go:171","msg":"trace[1480792457] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:537; }","duration":"445.549252ms","start":"2026-01-19T13:40:01.132711Z","end":"2026-01-19T13:40:01.57826Z","steps":["trace[1480792457] 'agreement among raft nodes before linearized reading'  (duration: 445.385587ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T13:40:01.578303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T13:40:01.132706Z","time spent":"445.590094ms","remote":"127.0.0.1:37840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-01-19T13:40:01.578642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.586026ms","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-19T13:40:01.578677Z","caller":"traceutil/trace.go:171","msg":"trace[1246109373] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:537; }","duration":"427.648248ms","start":"2026-01-19T13:40:01.151019Z","end":"2026-01-19T13:40:01.578667Z","steps":["trace[1246109373] 'agreement among raft nodes before linearized reading'  (duration: 427.532225ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T13:40:01.578705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T13:40:01.150988Z","time spent":"427.71048ms","remote":"127.0.0.1:37840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-01-19T13:40:01.578957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.044326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-dv6ts\" ","response":"range_response_count:1 size:16652"}
{"level":"info","ts":"2026-01-19T13:40:01.578991Z","caller":"traceutil/trace.go:171","msg":"trace[1348573782] range","detail":"{range_begin:/registry/pods/kube-system/cilium-dv6ts; range_end:; response_count:1; response_revision:537; }","duration":"251.112478ms","start":"2026-01-19T13:40:01.327869Z","end":"2026-01-19T13:40:01.578982Z","steps":["trace[1348573782] 'agreement among raft nodes before linearized reading'  (duration: 251.045036ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T13:40:02.45995Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12043359699034282407,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-01-19T13:40:02.545971Z","caller":"traceutil/trace.go:171","msg":"trace[1868311621] linearizableReadLoop","detail":"{readStateIndex:561; appliedIndex:559; }","duration":"586.066707ms","start":"2026-01-19T13:40:01.959889Z","end":"2026-01-19T13:40:02.545956Z","steps":["trace[1868311621] 'read index received'  (duration: 585.905083ms)","trace[1868311621] 'applied index is now lower than readState.Index'  (duration: 161.034µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-19T13:40:02.546091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"586.192331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-19T13:40:02.546106Z","caller":"traceutil/trace.go:171","msg":"trace[677478919] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:540; }","duration":"586.246563ms","start":"2026-01-19T13:40:01.959855Z","end":"2026-01-19T13:40:02.546102Z","steps":["trace[677478919] 'agreement among raft nodes before linearized reading'  (duration: 586.16908ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T13:40:02.546124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T13:40:01.959842Z","time spent":"586.278203ms","remote":"127.0.0.1:37562","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-19T13:40:02.546306Z","caller":"traceutil/trace.go:171","msg":"trace[1778940468] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"959.311883ms","start":"2026-01-19T13:40:01.586989Z","end":"2026-01-19T13:40:02.546301Z","steps":["trace[1778940468] 'process raft request'  (duration: 958.850029ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T13:40:02.546353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T13:40:01.586983Z","time spent":"959.336513ms","remote":"127.0.0.1:37840","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:530 > 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":"info","ts":"2026-01-19T13:40:02.546454Z","caller":"traceutil/trace.go:171","msg":"trace[337699894] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"955.102075ms","start":"2026-01-19T13:40:01.591348Z","end":"2026-01-19T13:40:02.54645Z","steps":["trace[337699894] 'process raft request'  (duration: 954.572579ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T13:40:02.54649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T13:40:01.591339Z","time spent":"955.125856ms","remote":"127.0.0.1:37740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16799,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-dv6ts\" mod_revision:470 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-dv6ts\" value_size:16750 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-dv6ts\" > >"}
{"level":"warn","ts":"2026-01-19T13:40:03.141044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.582493ms","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-19T13:40:03.141101Z","caller":"traceutil/trace.go:171","msg":"trace[1516636658] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:540; }","duration":"352.684516ms","start":"2026-01-19T13:40:02.788405Z","end":"2026-01-19T13:40:03.141089Z","steps":["trace[1516636658] 'range keys from in-memory index tree'  (duration: 352.429927ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T13:40:03.14113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T13:40:02.788387Z","time spent":"352.735107ms","remote":"127.0.0.1:37840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-01-19T13:40:03.141299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.318295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-19T13:40:03.141324Z","caller":"traceutil/trace.go:171","msg":"trace[705395905] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:540; }","duration":"175.343045ms","start":"2026-01-19T13:40:02.965976Z","end":"2026-01-19T13:40:03.141319Z","steps":["trace[705395905] 'range keys from in-memory index tree'  (duration: 175.276134ms)"],"step_count":1}
{"level":"info","ts":"2026-01-19T13:40:03.256621Z","caller":"traceutil/trace.go:171","msg":"trace[359456544] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"112.701163ms","start":"2026-01-19T13:40:03.143902Z","end":"2026-01-19T13:40:03.256603Z","steps":["trace[359456544] 'process raft request'  (duration: 112.611841ms)"],"step_count":1}
{"level":"info","ts":"2026-01-19T13:40:06.67577Z","caller":"traceutil/trace.go:171","msg":"trace[83323775] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"110.870825ms","start":"2026-01-19T13:40:06.564868Z","end":"2026-01-19T13:40:06.675739Z","steps":["trace[83323775] 'process raft request'  (duration: 34.02327ms)","trace[83323775] 'compare'  (duration: 76.729302ms)"],"step_count":2}
{"level":"info","ts":"2026-01-19T13:40:07.738647Z","caller":"traceutil/trace.go:171","msg":"trace[531423069] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"137.972148ms","start":"2026-01-19T13:40:07.600593Z","end":"2026-01-19T13:40:07.738566Z","steps":["trace[531423069] 'process raft request'  (duration: 137.843934ms)"],"step_count":1}
{"level":"info","ts":"2026-01-19T13:40:07.971263Z","caller":"traceutil/trace.go:171","msg":"trace[82565360] linearizableReadLoop","detail":"{readStateIndex:613; appliedIndex:612; }","duration":"338.893432ms","start":"2026-01-19T13:40:07.632358Z","end":"2026-01-19T13:40:07.971252Z","steps":["trace[82565360] 'read index received'  (duration: 106.87232ms)","trace[82565360] 'applied index is now lower than readState.Index'  (duration: 232.020492ms)"],"step_count":2}
{"level":"info","ts":"2026-01-19T13:40:07.971528Z","caller":"traceutil/trace.go:171","msg":"trace[135608691] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"356.763192ms","start":"2026-01-19T13:40:07.614758Z","end":"2026-01-19T13:40:07.971522Z","steps":["trace[135608691] 'process raft request'  (duration: 356.419383ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T13:40:07.971634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T13:40:07.61475Z","time spent":"356.847015ms","remote":"127.0.0.1:37604","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12244,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" value_size:12154 >> failure:<>"}
{"level":"warn","ts":"2026-01-19T13:40:07.971796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.442097ms","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-19T13:40:07.971876Z","caller":"traceutil/trace.go:171","msg":"trace[1764262809] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:591; }","duration":"339.580711ms","start":"2026-01-19T13:40:07.632289Z","end":"2026-01-19T13:40:07.97187Z","steps":["trace[1764262809] 'agreement among raft nodes before linearized reading'  (duration: 339.465658ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T13:40:07.971934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T13:40:07.632277Z","time spent":"339.650493ms","remote":"127.0.0.1:37840","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-19T13:40:07.978846Z","caller":"traceutil/trace.go:171","msg":"trace[126322389] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"162.382565ms","start":"2026-01-19T13:40:07.816452Z","end":"2026-01-19T13:40:07.978834Z","steps":["trace[126322389] 'process raft request'  (duration: 162.168268ms)"],"step_count":1}
{"level":"info","ts":"2026-01-19T13:40:23.680693Z","caller":"traceutil/trace.go:171","msg":"trace[1416894508] transaction","detail":"{read_only:false; response_revision:740; number_of_response:1; }","duration":"124.625233ms","start":"2026-01-19T13:40:23.556047Z","end":"2026-01-19T13:40:23.680672Z","steps":["trace[1416894508] 'process raft request'  (duration: 124.482769ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T13:41:24.957985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.087447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-19T13:41:24.958049Z","caller":"traceutil/trace.go:171","msg":"trace[1266909547] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:953; }","duration":"167.183498ms","start":"2026-01-19T13:41:24.790852Z","end":"2026-01-19T13:41:24.958036Z","steps":["trace[1266909547] 'range keys from in-memory index tree'  (duration: 167.032245ms)"],"step_count":1}
{"level":"info","ts":"2026-01-19T13:41:25.180952Z","caller":"traceutil/trace.go:171","msg":"trace[1730993899] transaction","detail":"{read_only:false; response_revision:954; number_of_response:1; }","duration":"305.190968ms","start":"2026-01-19T13:41:24.875743Z","end":"2026-01-19T13:41:25.180934Z","steps":["trace[1730993899] 'process raft request'  (duration: 305.091037ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T13:41:25.181042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.909018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-19T13:41:25.181068Z","caller":"traceutil/trace.go:171","msg":"trace[48869041] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:954; }","duration":"218.942318ms","start":"2026-01-19T13:41:24.962117Z","end":"2026-01-19T13:41:25.181059Z","steps":["trace[48869041] 'agreement among raft nodes before linearized reading'  (duration: 218.872847ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T13:41:25.181071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T13:41:24.875725Z","time spent":"305.30024ms","remote":"127.0.0.1:37726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5217,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:740 > success:<request_put:<key:\"/registry/minions/instance\" value_size:5183 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"info","ts":"2026-01-19T13:41:25.18097Z","caller":"traceutil/trace.go:171","msg":"trace[1663629201] linearizableReadLoop","detail":"{readStateIndex:994; appliedIndex:994; }","duration":"218.840537ms","start":"2026-01-19T13:41:24.962121Z","end":"2026-01-19T13:41:25.180961Z","steps":["trace[1663629201] 'read index received'  (duration: 218.833787ms)","trace[1663629201] 'applied index is now lower than readState.Index'  (duration: 5.8µs)"],"step_count":2}
{"level":"info","ts":"2026-01-19T13:41:25.190707Z","caller":"traceutil/trace.go:171","msg":"trace[148823897] transaction","detail":"{read_only:false; response_revision:955; number_of_response:1; }","duration":"198.617431ms","start":"2026-01-19T13:41:24.992074Z","end":"2026-01-19T13:41:25.190691Z","steps":["trace[148823897] 'process raft request'  (duration: 198.370747ms)"],"step_count":1}
{"level":"info","ts":"2026-01-19T13:41:26.057649Z","caller":"traceutil/trace.go:171","msg":"trace[330838855] linearizableReadLoop","detail":"{readStateIndex:997; appliedIndex:996; }","duration":"338.6944ms","start":"2026-01-19T13:41:25.718927Z","end":"2026-01-19T13:41:26.057622Z","steps":["trace[330838855] 'read index received'  (duration: 303.946376ms)","trace[330838855] 'applied index is now lower than readState.Index'  (duration: 34.746464ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-19T13:41:26.058074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.120256ms","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-19T13:41:26.058146Z","caller":"traceutil/trace.go:171","msg":"trace[654450388] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:956; }","duration":"339.249197ms","start":"2026-01-19T13:41:25.718881Z","end":"2026-01-19T13:41:26.05813Z","steps":["trace[654450388] 'agreement among raft nodes before linearized reading'  (duration: 339.046384ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T13:41:26.058208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T13:41:25.718861Z","time spent":"339.335919ms","remote":"127.0.0.1:37840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-01-19T13:41:26.058566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.907287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-01-19T13:41:26.058778Z","caller":"traceutil/trace.go:171","msg":"trace[160428635] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:956; }","duration":"338.13689ms","start":"2026-01-19T13:41:25.720629Z","end":"2026-01-19T13:41:26.058766Z","steps":["trace[160428635] 'agreement among raft nodes before linearized reading'  (duration: 337.872826ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T13:41:26.058856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T13:41:25.720619Z","time spent":"338.224241ms","remote":"127.0.0.1:37840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-01-19T13:41:26.059214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.566648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-19T13:41:26.059929Z","caller":"traceutil/trace.go:171","msg":"trace[1071451853] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:956; }","duration":"295.298759ms","start":"2026-01-19T13:41:25.764611Z","end":"2026-01-19T13:41:26.059909Z","steps":["trace[1071451853] 'agreement among raft nodes before linearized reading'  (duration: 294.576718ms)"],"step_count":1}