{"level":"warn","ts":"2026-04-28T05:58:29.727308Z","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-28T05:58:29.727516Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.4: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.4:2380","--initial-cluster=instance=https://199.204.45.4:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.4:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.4: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-28T05:58:29.72766Z","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-28T05:58:29.727765Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.4:2380"]}
{"level":"info","ts":"2026-04-28T05:58:29.72781Z","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-28T05:58:29.728665Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"]}
{"level":"info","ts":"2026-04-28T05:58:29.728778Z","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.4:2380"],"listen-peer-urls":["https://199.204.45.4:2380"],"advertise-client-urls":["https://199.204.45.4:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.4: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-28T05:58:29.73301Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.88635ms"}
{"level":"info","ts":"2026-04-28T05:58:29.740567Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"66f7b57d56ad567d","cluster-id":"ec267dcaac715770"}
{"level":"info","ts":"2026-04-28T05:58:29.740729Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=()"}
{"level":"info","ts":"2026-04-28T05:58:29.740812Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became follower at term 0"}
{"level":"info","ts":"2026-04-28T05:58:29.740848Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 66f7b57d56ad567d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-04-28T05:58:29.740875Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became follower at term 1"}
{"level":"info","ts":"2026-04-28T05:58:29.740937Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=(7419598461045921405)"}
{"level":"warn","ts":"2026-04-28T05:58:29.749429Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-04-28T05:58:29.750925Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-04-28T05:58:29.752141Z","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-28T05:58:29.755199Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"66f7b57d56ad567d","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-04-28T05:58:29.755335Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"66f7b57d56ad567d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-04-28T05:58:29.755338Z","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-28T05:58:29.755509Z","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-28T05:58:29.755549Z","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-28T05:58:29.756473Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=(7419598461045921405)"}
{"level":"info","ts":"2026-04-28T05:58:29.758071Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ec267dcaac715770","local-member-id":"66f7b57d56ad567d","added-peer-id":"66f7b57d56ad567d","added-peer-peer-urls":["https://199.204.45.4:2380"]}
{"level":"info","ts":"2026-04-28T05:58:29.763034Z","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-28T05:58:29.763336Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"66f7b57d56ad567d","initial-advertise-peer-urls":["https://199.204.45.4:2380"],"listen-peer-urls":["https://199.204.45.4:2380"],"advertise-client-urls":["https://199.204.45.4:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-04-28T05:58:29.763379Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-04-28T05:58:29.763502Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.4:2380"}
{"level":"info","ts":"2026-04-28T05:58:29.763532Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.4:2380"}
{"level":"info","ts":"2026-04-28T05:58:30.142058Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d is starting a new election at term 1"}
{"level":"info","ts":"2026-04-28T05:58:30.142136Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became pre-candidate at term 1"}
{"level":"info","ts":"2026-04-28T05:58:30.142176Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d received MsgPreVoteResp from 66f7b57d56ad567d at term 1"}
{"level":"info","ts":"2026-04-28T05:58:30.142194Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became candidate at term 2"}
{"level":"info","ts":"2026-04-28T05:58:30.142205Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d received MsgVoteResp from 66f7b57d56ad567d at term 2"}
{"level":"info","ts":"2026-04-28T05:58:30.142215Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became leader at term 2"}
{"level":"info","ts":"2026-04-28T05:58:30.142227Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 66f7b57d56ad567d elected leader 66f7b57d56ad567d at term 2"}
{"level":"info","ts":"2026-04-28T05:58:30.145152Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"66f7b57d56ad567d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.4:2379]}","request-path":"/0/members/66f7b57d56ad567d/attributes","cluster-id":"ec267dcaac715770","publish-timeout":"7s"}
{"level":"info","ts":"2026-04-28T05:58:30.145326Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-28T05:58:30.145361Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-28T05:58:30.145487Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-28T05:58:30.146683Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-04-28T05:58:30.146767Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-04-28T05:58:30.147395Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ec267dcaac715770","local-member-id":"66f7b57d56ad567d","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-28T05:58:30.147643Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-28T05:58:30.147769Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-28T05:58:30.148136Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-04-28T05:58:30.149307Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.4:2379"}
{"level":"warn","ts":"2026-04-28T05:59:05.337133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"626.332426ms","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-28T05:59:05.337291Z","caller":"traceutil/trace.go:171","msg":"trace[43285320] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:570; }","duration":"626.547562ms","start":"2026-04-28T05:59:04.710716Z","end":"2026-04-28T05:59:05.337264Z","steps":["trace[43285320] 'range keys from in-memory index tree'  (duration: 626.071546ms)"],"step_count":1}
{"level":"info","ts":"2026-04-28T05:59:05.337306Z","caller":"traceutil/trace.go:171","msg":"trace[242919884] linearizableReadLoop","detail":"{readStateIndex:593; appliedIndex:592; }","duration":"270.225437ms","start":"2026-04-28T05:59:05.067048Z","end":"2026-04-28T05:59:05.337274Z","steps":["trace[242919884] 'read index received'  (duration: 238.066922ms)","trace[242919884] 'applied index is now lower than readState.Index'  (duration: 32.157665ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-28T05:59:05.337381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T05:59:04.710694Z","time spent":"626.668779ms","remote":"127.0.0.1:60400","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-04-28T05:59:05.337537Z","caller":"traceutil/trace.go:171","msg":"trace[411947078] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"333.728206ms","start":"2026-04-28T05:59:05.003753Z","end":"2026-04-28T05:59:05.337481Z","steps":["trace[411947078] 'process raft request'  (duration: 301.58916ms)","trace[411947078] 'compare'  (duration: 31.599537ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-28T05:59:05.337394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"512.475997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-04-28T05:59:05.337568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.498456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-tkhnf\" ","response":"range_response_count:1 size:16957"}
{"level":"info","ts":"2026-04-28T05:59:05.338727Z","caller":"traceutil/trace.go:171","msg":"trace[1561006193] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:570; }","duration":"513.996375ms","start":"2026-04-28T05:59:04.824704Z","end":"2026-04-28T05:59:05.3387Z","steps":["trace[1561006193] 'range keys from in-memory index tree'  (duration: 512.274211ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-28T05:59:05.338801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T05:59:04.824666Z","time spent":"514.115692ms","remote":"127.0.0.1:60400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-04-28T05:59:05.338891Z","caller":"traceutil/trace.go:171","msg":"trace[666708113] range","detail":"{range_begin:/registry/pods/kube-system/cilium-tkhnf; range_end:; response_count:1; response_revision:571; }","duration":"271.798049ms","start":"2026-04-28T05:59:05.067003Z","end":"2026-04-28T05:59:05.338801Z","steps":["trace[666708113] 'agreement among raft nodes before linearized reading'  (duration: 270.415305ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-28T05:59:05.339562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T05:59:05.003717Z","time spent":"334.623375ms","remote":"127.0.0.1:60198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:568 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036201 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"info","ts":"2026-04-28T05:59:05.584078Z","caller":"traceutil/trace.go:171","msg":"trace[822907583] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"240.934449ms","start":"2026-04-28T05:59:05.343109Z","end":"2026-04-28T05:59:05.584043Z","steps":["trace[822907583] 'process raft request'  (duration: 214.025491ms)","trace[822907583] 'compare'  (duration: 26.672005ms)"],"step_count":2}
{"level":"info","ts":"2026-04-28T05:59:05.584089Z","caller":"traceutil/trace.go:171","msg":"trace[1777813348] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"192.254463ms","start":"2026-04-28T05:59:05.391812Z","end":"2026-04-28T05:59:05.584067Z","steps":["trace[1777813348] 'process raft request'  (duration: 192.203979ms)"],"step_count":1}
{"level":"info","ts":"2026-04-28T05:59:05.584367Z","caller":"traceutil/trace.go:171","msg":"trace[1012288539] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"226.759351ms","start":"2026-04-28T05:59:05.357595Z","end":"2026-04-28T05:59:05.584354Z","steps":["trace[1012288539] 'process raft request'  (duration: 226.364896ms)"],"step_count":1}
{"level":"info","ts":"2026-04-28T05:59:05.908295Z","caller":"traceutil/trace.go:171","msg":"trace[1379089921] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"253.058678ms","start":"2026-04-28T05:59:05.655223Z","end":"2026-04-28T05:59:05.908282Z","steps":["trace[1379089921] 'process raft request'  (duration: 251.110099ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-28T05:59:05.908393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.436383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-28T05:59:05.908406Z","caller":"traceutil/trace.go:171","msg":"trace[1958579545] linearizableReadLoop","detail":"{readStateIndex:599; appliedIndex:598; }","duration":"244.308778ms","start":"2026-04-28T05:59:05.663943Z","end":"2026-04-28T05:59:05.908252Z","steps":["trace[1958579545] 'read index received'  (duration: 242.337381ms)","trace[1958579545] 'applied index is now lower than readState.Index'  (duration: 1.970297ms)"],"step_count":2}
{"level":"info","ts":"2026-04-28T05:59:05.908452Z","caller":"traceutil/trace.go:171","msg":"trace[985603083] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:577; }","duration":"244.505185ms","start":"2026-04-28T05:59:05.663935Z","end":"2026-04-28T05:59:05.908441Z","steps":["trace[985603083] 'agreement among raft nodes before linearized reading'  (duration: 244.414036ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-28T06:01:12.458686Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6232310987486820372,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-04-28T06:01:12.722909Z","caller":"traceutil/trace.go:171","msg":"trace[1087063441] linearizableReadLoop","detail":"{readStateIndex:1306; appliedIndex:1305; }","duration":"764.844769ms","start":"2026-04-28T06:01:11.958047Z","end":"2026-04-28T06:01:12.722891Z","steps":["trace[1087063441] 'read index received'  (duration: 764.65398ms)","trace[1087063441] 'applied index is now lower than readState.Index'  (duration: 189.41µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-28T06:01:12.723073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"765.02136ms","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-28T06:01:12.723102Z","caller":"traceutil/trace.go:171","msg":"trace[1500249593] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1255; }","duration":"765.099822ms","start":"2026-04-28T06:01:11.957993Z","end":"2026-04-28T06:01:12.723093Z","steps":["trace[1500249593] 'agreement among raft nodes before linearized reading'  (duration: 764.994503ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-28T06:01:12.723125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:11.957975Z","time spent":"765.145037ms","remote":"127.0.0.1:60400","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-04-28T06:01:12.723347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.787345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:1490"}
{"level":"info","ts":"2026-04-28T06:01:12.723384Z","caller":"traceutil/trace.go:171","msg":"trace[1958222096] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:1255; }","duration":"325.83452ms","start":"2026-04-28T06:01:12.397538Z","end":"2026-04-28T06:01:12.723373Z","steps":["trace[1958222096] 'agreement among raft nodes before linearized reading'  (duration: 325.737651ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-28T06:01:12.723402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:12.397531Z","time spent":"325.867266ms","remote":"127.0.0.1:60302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":1,"response size":1513,"request content":"key:\"/registry/pods/default/test-pvc-pod\" "}
{"level":"warn","ts":"2026-04-28T06:01:12.72343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.834127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-1f8387fc-e8a0-4f3a-ae53-fbd04b50f246\" ","response":"range_response_count:1 size:3882"}
{"level":"info","ts":"2026-04-28T06:01:12.723499Z","caller":"traceutil/trace.go:171","msg":"trace[1353580394] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-1f8387fc-e8a0-4f3a-ae53-fbd04b50f246; range_end:; response_count:1; response_revision:1255; }","duration":"278.941265ms","start":"2026-04-28T06:01:12.444541Z","end":"2026-04-28T06:01:12.723482Z","steps":["trace[1353580394] 'agreement among raft nodes before linearized reading'  (duration: 278.689743ms)"],"step_count":1}
{"level":"info","ts":"2026-04-28T06:01:12.723571Z","caller":"traceutil/trace.go:171","msg":"trace[1288467366] transaction","detail":"{read_only:false; response_revision:1255; number_of_response:1; }","duration":"844.687445ms","start":"2026-04-28T06:01:11.878277Z","end":"2026-04-28T06:01:12.722964Z","steps":["trace[1288467366] 'process raft request'  (duration: 844.492137ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-28T06:01:12.723461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.943069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-04-28T06:01:12.723891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:11.878261Z","time spent":"845.517707ms","remote":"127.0.0.1:60400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1247 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-04-28T06:01:12.723922Z","caller":"traceutil/trace.go:171","msg":"trace[533974785] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1255; }","duration":"583.531667ms","start":"2026-04-28T06:01:12.140381Z","end":"2026-04-28T06:01:12.723912Z","steps":["trace[533974785] 'agreement among raft nodes before linearized reading'  (duration: 582.650101ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-28T06:01:12.723959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:12.14037Z","time spent":"583.577662ms","remote":"127.0.0.1:60400","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-04-28T06:01:13.269036Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6232310987486820379,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-28T06:01:13.732997Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.002563599s","expected-duration":"1s"}
{"level":"info","ts":"2026-04-28T06:01:13.734208Z","caller":"traceutil/trace.go:171","msg":"trace[1235475200] transaction","detail":"{read_only:false; response_revision:1260; number_of_response:1; }","duration":"149.003731ms","start":"2026-04-28T06:01:13.585183Z","end":"2026-04-28T06:01:13.734187Z","steps":["trace[1235475200] 'process raft request'  (duration: 148.91737ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-28T06:01:13.734281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"965.678892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-28T06:01:13.734384Z","caller":"traceutil/trace.go:171","msg":"trace[658135545] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1260; }","duration":"965.822606ms","start":"2026-04-28T06:01:12.768541Z","end":"2026-04-28T06:01:13.734364Z","steps":["trace[658135545] 'agreement among raft nodes before linearized reading'  (duration: 965.627027ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-28T06:01:13.734435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:12.768528Z","time spent":"965.897098ms","remote":"127.0.0.1:60334","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":28,"request content":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true "}
{"level":"info","ts":"2026-04-28T06:01:13.73421Z","caller":"traceutil/trace.go:171","msg":"trace[1371946891] transaction","detail":"{read_only:false; response_revision:1259; number_of_response:1; }","duration":"1.003820993s","start":"2026-04-28T06:01:12.73034Z","end":"2026-04-28T06:01:13.734161Z","steps":["trace[1371946891] 'process raft request'  (duration: 1.003144146s)"],"step_count":1}
{"level":"info","ts":"2026-04-28T06:01:13.735019Z","caller":"traceutil/trace.go:171","msg":"trace[1070508816] linearizableReadLoop","detail":"{readStateIndex:1310; appliedIndex:1309; }","duration":"965.343258ms","start":"2026-04-28T06:01:12.768573Z","end":"2026-04-28T06:01:13.733917Z","steps":["trace[1070508816] 'read index received'  (duration: 964.862281ms)","trace[1070508816] 'applied index is now lower than readState.Index'  (duration: 479.388µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-28T06:01:13.735337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"872.603738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-28T06:01:13.735403Z","caller":"traceutil/trace.go:171","msg":"trace[64259912] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:1260; }","duration":"872.700607ms","start":"2026-04-28T06:01:12.862685Z","end":"2026-04-28T06:01:13.735386Z","steps":["trace[64259912] 'agreement among raft nodes before linearized reading'  (duration: 872.532595ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-28T06:01:13.735658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:12.862612Z","time spent":"872.879117ms","remote":"127.0.0.1:37256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "}
{"level":"warn","ts":"2026-04-28T06:01:13.735749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.319335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.4\" ","response":"range_response_count:1 size:131"}
{"level":"info","ts":"2026-04-28T06:01:13.735817Z","caller":"traceutil/trace.go:171","msg":"trace[1209826407] range","detail":"{range_begin:/registry/masterleases/199.204.45.4; range_end:; response_count:1; response_revision:1260; }","duration":"307.456811ms","start":"2026-04-28T06:01:13.428344Z","end":"2026-04-28T06:01:13.735801Z","steps":["trace[1209826407] 'agreement among raft nodes before linearized reading'  (duration: 307.2781ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-28T06:01:13.735848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:13.428309Z","time spent":"307.532452ms","remote":"127.0.0.1:60142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":1,"response size":154,"request content":"key:\"/registry/masterleases/199.204.45.4\" "}
{"level":"warn","ts":"2026-04-28T06:01:13.735868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"786.363813ms","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-04-28T06:01:13.735933Z","caller":"traceutil/trace.go:171","msg":"trace[1224571604] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1260; }","duration":"786.429786ms","start":"2026-04-28T06:01:12.949491Z","end":"2026-04-28T06:01:13.735921Z","steps":["trace[1224571604] 'agreement among raft nodes before linearized reading'  (duration: 786.258404ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-28T06:01:13.735971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:12.949442Z","time spent":"786.521505ms","remote":"127.0.0.1:60400","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":"warn","ts":"2026-04-28T06:01:13.736824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:12.730332Z","time spent":"1.004581191s","remote":"127.0.0.1:60302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3879,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-1f8387fc-e8a0-4f3a-ae53-fbd04b50f246\" mod_revision:1253 > success:<request_put:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-1f8387fc-e8a0-4f3a-ae53-fbd04b50f246\" value_size:3779 >> failure:<request_range:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-1f8387fc-e8a0-4f3a-ae53-fbd04b50f246\" > >"}
{"level":"info","ts":"2026-04-28T06:01:23.937586Z","caller":"traceutil/trace.go:171","msg":"trace[1796979916] transaction","detail":"{read_only:false; response_revision:1313; number_of_response:1; }","duration":"149.23183ms","start":"2026-04-28T06:01:23.78833Z","end":"2026-04-28T06:01:23.937562Z","steps":["trace[1796979916] 'process raft request'  (duration: 149.067528ms)"],"step_count":1}