{"level":"warn","ts":"2026-04-20T04:51:29.080872Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-20T04:51:29.08095Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.233: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://199.204.45.233:2380","--initial-cluster=instance=https://199.204.45.233:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.233:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.233: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-04-20T04:51:29.08113Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-20T04:51:29.081145Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.233:2380"]} {"level":"info","ts":"2026-04-20T04:51:29.081164Z","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-04-20T04:51:29.081905Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.233:2379"]} {"level":"info","ts":"2026-04-20T04:51:29.082019Z","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://199.204.45.233:2380"],"listen-peer-urls":["https://199.204.45.233:2380"],"advertise-client-urls":["https://199.204.45.233:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.233:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.233: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-04-20T04:51:29.091912Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"9.61999ms"} {"level":"info","ts":"2026-04-20T04:51:29.098894Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"90a0cb2044183f95","cluster-id":"782fef34d5ea94f9"} {"level":"info","ts":"2026-04-20T04:51:29.099022Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 switched to configuration voters=()"} {"level":"info","ts":"2026-04-20T04:51:29.099048Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 became follower at term 0"} {"level":"info","ts":"2026-04-20T04:51:29.099067Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 90a0cb2044183f95 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-20T04:51:29.099077Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 became follower at term 1"} {"level":"info","ts":"2026-04-20T04:51:29.099116Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 switched to configuration voters=(10421552877177159573)"} {"level":"warn","ts":"2026-04-20T04:51:29.111247Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-20T04:51:29.112624Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-20T04:51:29.113965Z","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-04-20T04:51:29.116256Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"90a0cb2044183f95","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-20T04:51:29.116502Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"90a0cb2044183f95","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-20T04:51:29.11651Z","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-04-20T04:51:29.116814Z","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-04-20T04:51:29.116864Z","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-04-20T04:51:29.119585Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 switched to configuration voters=(10421552877177159573)"} {"level":"info","ts":"2026-04-20T04:51:29.119757Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"782fef34d5ea94f9","local-member-id":"90a0cb2044183f95","added-peer-id":"90a0cb2044183f95","added-peer-peer-urls":["https://199.204.45.233:2380"]} {"level":"info","ts":"2026-04-20T04:51:29.120901Z","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-04-20T04:51:29.121084Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"90a0cb2044183f95","initial-advertise-peer-urls":["https://199.204.45.233:2380"],"listen-peer-urls":["https://199.204.45.233:2380"],"advertise-client-urls":["https://199.204.45.233:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.233:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-20T04:51:29.121114Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-20T04:51:29.121243Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.233:2380"} {"level":"info","ts":"2026-04-20T04:51:29.12126Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.233:2380"} {"level":"info","ts":"2026-04-20T04:51:29.799372Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 is starting a new election at term 1"} {"level":"info","ts":"2026-04-20T04:51:29.799433Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-20T04:51:29.799483Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 received MsgPreVoteResp from 90a0cb2044183f95 at term 1"} {"level":"info","ts":"2026-04-20T04:51:29.799509Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 became candidate at term 2"} {"level":"info","ts":"2026-04-20T04:51:29.799524Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 received MsgVoteResp from 90a0cb2044183f95 at term 2"} {"level":"info","ts":"2026-04-20T04:51:29.799543Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 became leader at term 2"} {"level":"info","ts":"2026-04-20T04:51:29.799561Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 90a0cb2044183f95 elected leader 90a0cb2044183f95 at term 2"} {"level":"info","ts":"2026-04-20T04:51:29.800633Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T04:51:29.808126Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"90a0cb2044183f95","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.233:2379]}","request-path":"/0/members/90a0cb2044183f95/attributes","cluster-id":"782fef34d5ea94f9","publish-timeout":"7s"} {"level":"info","ts":"2026-04-20T04:51:29.808139Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T04:51:29.808167Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T04:51:29.808492Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-20T04:51:29.80858Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-20T04:51:29.809939Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.233:2379"} {"level":"info","ts":"2026-04-20T04:51:29.810073Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"782fef34d5ea94f9","local-member-id":"90a0cb2044183f95","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T04:51:29.810137Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T04:51:29.810167Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T04:51:29.811452Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-04-20T04:51:59.429569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.128864ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T04:51:59.429739Z","caller":"traceutil/trace.go:171","msg":"trace[1210664749] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"343.027943ms","start":"2026-04-20T04:51:59.086679Z","end":"2026-04-20T04:51:59.429707Z","steps":["trace[1210664749] 'process raft request' (duration: 194.192667ms)","trace[1210664749] 'compare' (duration: 147.996211ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T04:51:59.429817Z","caller":"traceutil/trace.go:171","msg":"trace[1833486522] linearizableReadLoop","detail":"{readStateIndex:603; appliedIndex:602; }","duration":"342.087305ms","start":"2026-04-20T04:51:59.087721Z","end":"2026-04-20T04:51:59.429808Z","steps":["trace[1833486522] 'read index received' (duration: 193.3469ms)","trace[1833486522] 'applied index is now lower than readState.Index' (duration: 148.739515ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T04:51:59.429921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:51:59.086664Z","time spent":"343.181376ms","remote":"127.0.0.1:45644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T04:51:59.42978Z","caller":"traceutil/trace.go:171","msg":"trace[1691879640] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"297.629202ms","start":"2026-04-20T04:51:59.132131Z","end":"2026-04-20T04:51:59.429761Z","steps":["trace[1691879640] 'process raft request' (duration: 297.560931ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:51:59.43016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.430822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/xbackendtrafficpolicies.gateway.networking.x-k8s.io\" ","response":"range_response_count:1 size:23081"} {"level":"info","ts":"2026-04-20T04:51:59.430197Z","caller":"traceutil/trace.go:171","msg":"trace[1866806899] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/xbackendtrafficpolicies.gateway.networking.x-k8s.io; range_end:; response_count:1; response_revision:586; }","duration":"342.486693ms","start":"2026-04-20T04:51:59.087701Z","end":"2026-04-20T04:51:59.430188Z","steps":["trace[1866806899] 'agreement among raft nodes before linearized reading' (duration: 342.3611ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:51:59.430241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:51:59.087694Z","time spent":"342.538405ms","remote":"127.0.0.1:45410","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":1,"response size":23104,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/xbackendtrafficpolicies.gateway.networking.x-k8s.io\" "} {"level":"warn","ts":"2026-04-20T04:51:59.430493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.538255ms","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-04-20T04:51:59.430538Z","caller":"traceutil/trace.go:171","msg":"trace[667278115] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:586; }","duration":"302.613446ms","start":"2026-04-20T04:51:59.127913Z","end":"2026-04-20T04:51:59.430527Z","steps":["trace[667278115] 'agreement among raft nodes before linearized reading' (duration: 302.480993ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:51:59.430573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:51:59.127894Z","time spent":"302.672558ms","remote":"127.0.0.1:45644","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":"info","ts":"2026-04-20T04:52:04.167937Z","caller":"traceutil/trace.go:171","msg":"trace[1219212339] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"189.511728ms","start":"2026-04-20T04:52:03.978396Z","end":"2026-04-20T04:52:04.167907Z","steps":["trace[1219212339] 'process raft request' (duration: 188.818756ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:52:04.804822Z","caller":"traceutil/trace.go:171","msg":"trace[755932229] linearizableReadLoop","detail":"{readStateIndex:637; appliedIndex:636; }","duration":"420.835699ms","start":"2026-04-20T04:52:04.383963Z","end":"2026-04-20T04:52:04.804798Z","steps":["trace[755932229] 'read index received' (duration: 420.631156ms)","trace[755932229] 'applied index is now lower than readState.Index' (duration: 203.683µs)"],"step_count":2} {"level":"warn","ts":"2026-04-20T04:52:04.805015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.043873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-p5kjx\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-20T04:52:04.805045Z","caller":"traceutil/trace.go:171","msg":"trace[1904779068] range","detail":"{range_begin:/registry/pods/kube-system/cilium-p5kjx; range_end:; response_count:1; response_revision:618; }","duration":"421.122065ms","start":"2026-04-20T04:52:04.383914Z","end":"2026-04-20T04:52:04.805036Z","steps":["trace[1904779068] 'agreement among raft nodes before linearized reading' (duration: 420.975262ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:52:04.805053Z","caller":"traceutil/trace.go:171","msg":"trace[1255786248] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"579.180764ms","start":"2026-04-20T04:52:04.22585Z","end":"2026-04-20T04:52:04.805031Z","steps":["trace[1255786248] 'process raft request' (duration: 578.801147ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:52:04.805076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:52:04.383893Z","time spent":"421.176245ms","remote":"127.0.0.1:45546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-p5kjx\" "} {"level":"warn","ts":"2026-04-20T04:52:04.80515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:52:04.225748Z","time spent":"579.349467ms","remote":"127.0.0.1:45874","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T04:52:19.785564Z","caller":"traceutil/trace.go:171","msg":"trace[664132482] linearizableReadLoop","detail":"{readStateIndex:802; appliedIndex:801; }","duration":"257.463961ms","start":"2026-04-20T04:52:19.528073Z","end":"2026-04-20T04:52:19.785537Z","steps":["trace[664132482] 'read index received' (duration: 257.257277ms)","trace[664132482] 'applied index is now lower than readState.Index' (duration: 204.954µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T04:52:19.785626Z","caller":"traceutil/trace.go:171","msg":"trace[630134463] transaction","detail":"{read_only:false; response_revision:779; number_of_response:1; }","duration":"294.996864ms","start":"2026-04-20T04:52:19.490597Z","end":"2026-04-20T04:52:19.785594Z","steps":["trace[630134463] 'process raft request' (duration: 294.76718ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:52:19.785968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.640628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-20T04:52:19.786008Z","caller":"traceutil/trace.go:171","msg":"trace[2011595883] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:779; }","duration":"255.693758ms","start":"2026-04-20T04:52:19.530304Z","end":"2026-04-20T04:52:19.785997Z","steps":["trace[2011595883] 'agreement among raft nodes before linearized reading' (duration: 255.602887ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:52:19.785998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.689215ms","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-04-20T04:52:19.786075Z","caller":"traceutil/trace.go:171","msg":"trace[2103944450] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:779; }","duration":"257.790898ms","start":"2026-04-20T04:52:19.528266Z","end":"2026-04-20T04:52:19.786057Z","steps":["trace[2103944450] 'agreement among raft nodes before linearized reading' (duration: 257.574534ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:52:19.785868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.737496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-20T04:52:19.78621Z","caller":"traceutil/trace.go:171","msg":"trace[1454664199] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:779; }","duration":"258.168034ms","start":"2026-04-20T04:52:19.528032Z","end":"2026-04-20T04:52:19.7862Z","steps":["trace[1454664199] 'agreement among raft nodes before linearized reading' (duration: 257.665995ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:52:54.267944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.600761ms","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-04-20T04:52:54.268044Z","caller":"traceutil/trace.go:171","msg":"trace[1666693356] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:997; }","duration":"212.745484ms","start":"2026-04-20T04:52:54.05527Z","end":"2026-04-20T04:52:54.268016Z","steps":["trace[1666693356] 'range keys from in-memory index tree' (duration: 212.383837ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:52:54.26808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.841162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-20T04:52:54.268158Z","caller":"traceutil/trace.go:171","msg":"trace[1858387521] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:997; }","duration":"172.972994ms","start":"2026-04-20T04:52:54.095163Z","end":"2026-04-20T04:52:54.268136Z","steps":["trace[1858387521] 'range keys from in-memory index tree' (duration: 172.645538ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:52:54.468693Z","caller":"traceutil/trace.go:171","msg":"trace[2046537328] linearizableReadLoop","detail":"{readStateIndex:1031; appliedIndex:1029; }","duration":"147.118605ms","start":"2026-04-20T04:52:54.32155Z","end":"2026-04-20T04:52:54.468668Z","steps":["trace[2046537328] 'read index received' (duration: 7.358638ms)","trace[2046537328] 'applied index is now lower than readState.Index' (duration: 139.759017ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T04:52:54.468822Z","caller":"traceutil/trace.go:171","msg":"trace[1550669168] transaction","detail":"{read_only:false; response_revision:999; number_of_response:1; }","duration":"196.472556ms","start":"2026-04-20T04:52:54.272312Z","end":"2026-04-20T04:52:54.468785Z","steps":["trace[1550669168] 'process raft request' (duration: 191.289118ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:52:54.468928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.365709ms","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-04-20T04:52:54.468965Z","caller":"traceutil/trace.go:171","msg":"trace[294646636] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:999; }","duration":"147.460031ms","start":"2026-04-20T04:52:54.321494Z","end":"2026-04-20T04:52:54.468954Z","steps":["trace[294646636] 'agreement among raft nodes before linearized reading' (duration: 147.289828ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:53:18.388342Z","caller":"traceutil/trace.go:171","msg":"trace[456594918] transaction","detail":"{read_only:false; response_revision:1076; number_of_response:1; }","duration":"202.875328ms","start":"2026-04-20T04:53:18.185448Z","end":"2026-04-20T04:53:18.388323Z","steps":["trace[456594918] 'process raft request' (duration: 202.724945ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:53:49.653439Z","caller":"traceutil/trace.go:171","msg":"trace[1580369955] linearizableReadLoop","detail":"{readStateIndex:1303; appliedIndex:1302; }","duration":"127.787091ms","start":"2026-04-20T04:53:49.525624Z","end":"2026-04-20T04:53:49.653412Z","steps":["trace[1580369955] 'read index received' (duration: 127.594637ms)","trace[1580369955] 'applied index is now lower than readState.Index' (duration: 191.094µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T04:53:49.653508Z","caller":"traceutil/trace.go:171","msg":"trace[1226744232] transaction","detail":"{read_only:false; response_revision:1258; number_of_response:1; }","duration":"206.587408ms","start":"2026-04-20T04:53:49.446884Z","end":"2026-04-20T04:53:49.653472Z","steps":["trace[1226744232] 'process raft request' (duration: 206.390474ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:53:49.65369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.012885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T04:53:49.65384Z","caller":"traceutil/trace.go:171","msg":"trace[1707855504] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1258; }","duration":"128.234959ms","start":"2026-04-20T04:53:49.525573Z","end":"2026-04-20T04:53:49.653808Z","steps":["trace[1707855504] 'agreement among raft nodes before linearized reading' (duration: 127.950554ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:53:50.119955Z","caller":"traceutil/trace.go:171","msg":"trace[1154437565] linearizableReadLoop","detail":"{readStateIndex:1304; appliedIndex:1303; }","duration":"143.320094ms","start":"2026-04-20T04:53:49.976612Z","end":"2026-04-20T04:53:50.119932Z","steps":["trace[1154437565] 'read index received' (duration: 143.211922ms)","trace[1154437565] 'applied index is now lower than readState.Index' (duration: 106.942µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T04:53:50.119991Z","caller":"traceutil/trace.go:171","msg":"trace[1519712785] transaction","detail":"{read_only:false; response_revision:1259; number_of_response:1; }","duration":"147.531013ms","start":"2026-04-20T04:53:49.972421Z","end":"2026-04-20T04:53:50.119952Z","steps":["trace[1519712785] 'process raft request' (duration: 147.37908ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:53:50.120071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.444786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T04:53:50.1201Z","caller":"traceutil/trace.go:171","msg":"trace[1242452746] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1259; }","duration":"143.519658ms","start":"2026-04-20T04:53:49.976569Z","end":"2026-04-20T04:53:50.120089Z","steps":["trace[1242452746] 'agreement among raft nodes before linearized reading' (duration: 143.443156ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:54:01.502275Z","caller":"traceutil/trace.go:171","msg":"trace[74448909] transaction","detail":"{read_only:false; response_revision:1339; number_of_response:1; }","duration":"163.767587ms","start":"2026-04-20T04:54:01.338482Z","end":"2026-04-20T04:54:01.502249Z","steps":["trace[74448909] 'process raft request' (duration: 163.603814ms)"],"step_count":1}