{"level":"warn","ts":"2026-06-26T02:07:48.421888Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-26T02:07:48.421965Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.171: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.19.213.171:2380","--initial-cluster=instance=https://199.19.213.171:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.171:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.171: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-06-26T02:07:48.422583Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-26T02:07:48.422623Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.171:2380"]} {"level":"info","ts":"2026-06-26T02:07:48.422649Z","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-06-26T02:07:48.423601Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.171:2379"]} {"level":"info","ts":"2026-06-26T02:07:48.423703Z","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.19.213.171:2380"],"listen-peer-urls":["https://199.19.213.171:2380"],"advertise-client-urls":["https://199.19.213.171:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.171:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.171: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-06-26T02:07:48.428789Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.677745ms"} {"level":"info","ts":"2026-06-26T02:07:48.437847Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"837e89131cc6bd81","cluster-id":"8af92e75ab8f3e69"} {"level":"info","ts":"2026-06-26T02:07:48.437924Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"837e89131cc6bd81 switched to configuration voters=()"} {"level":"info","ts":"2026-06-26T02:07:48.437944Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"837e89131cc6bd81 became follower at term 0"} {"level":"info","ts":"2026-06-26T02:07:48.437956Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 837e89131cc6bd81 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-26T02:07:48.437967Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"837e89131cc6bd81 became follower at term 1"} {"level":"info","ts":"2026-06-26T02:07:48.438006Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"837e89131cc6bd81 switched to configuration voters=(9475161381214272897)"} {"level":"warn","ts":"2026-06-26T02:07:48.447009Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-26T02:07:48.448651Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-26T02:07:48.449794Z","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-06-26T02:07:48.45212Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"837e89131cc6bd81","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-26T02:07:48.452723Z","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-06-26T02:07:48.4528Z","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-06-26T02:07:48.452822Z","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-06-26T02:07:48.45253Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"837e89131cc6bd81","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-26T02:07:48.453748Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"837e89131cc6bd81 switched to configuration voters=(9475161381214272897)"} {"level":"info","ts":"2026-06-26T02:07:48.453866Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8af92e75ab8f3e69","local-member-id":"837e89131cc6bd81","added-peer-id":"837e89131cc6bd81","added-peer-peer-urls":["https://199.19.213.171:2380"]} {"level":"info","ts":"2026-06-26T02:07:48.457629Z","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-06-26T02:07:48.457811Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.171:2380"} {"level":"info","ts":"2026-06-26T02:07:48.457856Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.171:2380"} {"level":"info","ts":"2026-06-26T02:07:48.458044Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"837e89131cc6bd81","initial-advertise-peer-urls":["https://199.19.213.171:2380"],"listen-peer-urls":["https://199.19.213.171:2380"],"advertise-client-urls":["https://199.19.213.171:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.171:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-26T02:07:48.458092Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-26T02:07:49.040084Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"837e89131cc6bd81 is starting a new election at term 1"} {"level":"info","ts":"2026-06-26T02:07:49.040165Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"837e89131cc6bd81 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-26T02:07:49.040204Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"837e89131cc6bd81 received MsgPreVoteResp from 837e89131cc6bd81 at term 1"} {"level":"info","ts":"2026-06-26T02:07:49.040238Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"837e89131cc6bd81 became candidate at term 2"} {"level":"info","ts":"2026-06-26T02:07:49.040254Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"837e89131cc6bd81 received MsgVoteResp from 837e89131cc6bd81 at term 2"} {"level":"info","ts":"2026-06-26T02:07:49.04027Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"837e89131cc6bd81 became leader at term 2"} {"level":"info","ts":"2026-06-26T02:07:49.04029Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 837e89131cc6bd81 elected leader 837e89131cc6bd81 at term 2"} {"level":"info","ts":"2026-06-26T02:07:49.041502Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-26T02:07:49.042557Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-26T02:07:49.042607Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"837e89131cc6bd81","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.171:2379]}","request-path":"/0/members/837e89131cc6bd81/attributes","cluster-id":"8af92e75ab8f3e69","publish-timeout":"7s"} {"level":"info","ts":"2026-06-26T02:07:49.042635Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-26T02:07:49.043261Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8af92e75ab8f3e69","local-member-id":"837e89131cc6bd81","cluster-version":"3.5"} {"level":"info","ts":"2026-06-26T02:07:49.043417Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-26T02:07:49.04345Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-26T02:07:49.04352Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-26T02:07:49.043572Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-26T02:07:49.045208Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.171:2379"} {"level":"info","ts":"2026-06-26T02:07:49.049915Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-06-26T02:08:35.310323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.310393ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:08:35.310502Z","caller":"traceutil/trace.go:171","msg":"trace[1244645548] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:631; }","duration":"233.507178ms","start":"2026-06-26T02:08:35.076971Z","end":"2026-06-26T02:08:35.310478Z","steps":["trace[1244645548] 'range keys from in-memory index tree' (duration: 233.290163ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:08:35.31124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.012822ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-26T02:08:35.311371Z","caller":"traceutil/trace.go:171","msg":"trace[2124270207] linearizableReadLoop","detail":"{readStateIndex:654; appliedIndex:653; }","duration":"442.935592ms","start":"2026-06-26T02:08:34.868404Z","end":"2026-06-26T02:08:35.31134Z","steps":["trace[2124270207] 'read index received' (duration: 266.216894ms)","trace[2124270207] 'applied index is now lower than readState.Index' (duration: 176.717518ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:08:35.311386Z","caller":"traceutil/trace.go:171","msg":"trace[591137727] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"525.539321ms","start":"2026-06-26T02:08:34.7858Z","end":"2026-06-26T02:08:35.31134Z","steps":["trace[591137727] 'process raft request' (duration: 348.817663ms)","trace[591137727] 'compare' (duration: 175.840817ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:08:35.31152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:08:34.785767Z","time spent":"525.671955ms","remote":"127.0.0.1:36230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":818,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-26T02:08:35.311588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.166228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-hrml9\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-06-26T02:08:35.311643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.183147ms","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-06-26T02:08:35.311659Z","caller":"traceutil/trace.go:171","msg":"trace[1734721310] range","detail":"{range_begin:/registry/pods/kube-system/cilium-hrml9; range_end:; response_count:1; response_revision:632; }","duration":"443.306381ms","start":"2026-06-26T02:08:34.868338Z","end":"2026-06-26T02:08:35.311644Z","steps":["trace[1734721310] 'agreement among raft nodes before linearized reading' (duration: 443.060916ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:08:35.311676Z","caller":"traceutil/trace.go:171","msg":"trace[469855641] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:632; }","duration":"275.276439ms","start":"2026-06-26T02:08:35.036386Z","end":"2026-06-26T02:08:35.311662Z","steps":["trace[469855641] 'agreement among raft nodes before linearized reading' (duration: 275.075484ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:08:35.311694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.153317ms","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-06-26T02:08:35.311705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:08:34.86831Z","time spent":"443.388254ms","remote":"127.0.0.1:36218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16989,"request content":"key:\"/registry/pods/kube-system/cilium-hrml9\" "} {"level":"info","ts":"2026-06-26T02:08:35.311739Z","caller":"traceutil/trace.go:171","msg":"trace[1562093842] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:632; }","duration":"103.25975ms","start":"2026-06-26T02:08:35.208468Z","end":"2026-06-26T02:08:35.311728Z","steps":["trace[1562093842] 'agreement among raft nodes before linearized reading' (duration: 103.059226ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:08:50.018506Z","caller":"traceutil/trace.go:171","msg":"trace[1938569994] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"136.44464ms","start":"2026-06-26T02:08:49.881996Z","end":"2026-06-26T02:08:50.01844Z","steps":["trace[1938569994] 'process raft request' (duration: 136.189894ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:09:06.591372Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13655370374742466087,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-26T02:09:06.671938Z","caller":"traceutil/trace.go:171","msg":"trace[1242143275] transaction","detail":"{read_only:false; response_revision:980; number_of_response:1; }","duration":"644.040423ms","start":"2026-06-26T02:09:06.027858Z","end":"2026-06-26T02:09:06.671898Z","steps":["trace[1242143275] 'process raft request' (duration: 643.865879ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:09:06.672291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:09:06.027831Z","time spent":"644.160127ms","remote":"127.0.0.1:36288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:09:06.72294Z","caller":"traceutil/trace.go:171","msg":"trace[1349867517] linearizableReadLoop","detail":"{readStateIndex:1014; appliedIndex:1012; }","duration":"632.265926ms","start":"2026-06-26T02:09:06.090655Z","end":"2026-06-26T02:09:06.722921Z","steps":["trace[1349867517] 'read index received' (duration: 581.146735ms)","trace[1349867517] 'applied index is now lower than readState.Index' (duration: 51.118691ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:09:06.723108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"632.43932ms","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-06-26T02:09:06.72313Z","caller":"traceutil/trace.go:171","msg":"trace[1944875189] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:981; }","duration":"632.529463ms","start":"2026-06-26T02:09:06.090594Z","end":"2026-06-26T02:09:06.723124Z","steps":["trace[1944875189] 'agreement among raft nodes before linearized reading' (duration: 632.42386ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:09:06.723149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:09:06.090566Z","time spent":"632.578343ms","remote":"127.0.0.1:36288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-26T02:09:06.723112Z","caller":"traceutil/trace.go:171","msg":"trace[585192979] transaction","detail":"{read_only:false; response_revision:981; number_of_response:1; }","duration":"685.882856ms","start":"2026-06-26T02:09:06.037169Z","end":"2026-06-26T02:09:06.723051Z","steps":["trace[585192979] 'process raft request' (duration: 685.312703ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:09:06.723258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"593.666399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-26T02:09:06.723277Z","caller":"traceutil/trace.go:171","msg":"trace[747343319] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:981; }","duration":"593.71958ms","start":"2026-06-26T02:09:06.12955Z","end":"2026-06-26T02:09:06.72327Z","steps":["trace[747343319] 'agreement among raft nodes before linearized reading' (duration: 593.674209ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:09:06.723289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:09:06.129535Z","time spent":"593.751792ms","remote":"127.0.0.1:36288","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-06-26T02:09:06.723352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:09:06.037146Z","time spent":"686.07319ms","remote":"127.0.0.1:36288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:09:06.723464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"554.653763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/local-path-storage/local-path-config\" ","response":"range_response_count:1 size:1464"} {"level":"info","ts":"2026-06-26T02:09:06.723484Z","caller":"traceutil/trace.go:171","msg":"trace[786201588] range","detail":"{range_begin:/registry/configmaps/local-path-storage/local-path-config; range_end:; response_count:1; response_revision:981; }","duration":"554.705684ms","start":"2026-06-26T02:09:06.168774Z","end":"2026-06-26T02:09:06.723479Z","steps":["trace[786201588] 'agreement among raft nodes before linearized reading' (duration: 554.656363ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:09:06.723498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:09:06.168755Z","time spent":"554.738415ms","remote":"127.0.0.1:36156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":1488,"request content":"key:\"/registry/configmaps/local-path-storage/local-path-config\" "} {"level":"info","ts":"2026-06-26T02:09:16.972265Z","caller":"traceutil/trace.go:171","msg":"trace[918194826] linearizableReadLoop","detail":"{readStateIndex:1053; appliedIndex:1052; }","duration":"203.201827ms","start":"2026-06-26T02:09:16.769039Z","end":"2026-06-26T02:09:16.972241Z","steps":["trace[918194826] 'read index received' (duration: 203.007912ms)","trace[918194826] 'applied index is now lower than readState.Index' (duration: 193.005µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:09:16.972382Z","caller":"traceutil/trace.go:171","msg":"trace[705075824] transaction","detail":"{read_only:false; response_revision:1018; number_of_response:1; }","duration":"219.451489ms","start":"2026-06-26T02:09:16.752896Z","end":"2026-06-26T02:09:16.972348Z","steps":["trace[705075824] 'process raft request' (duration: 219.211903ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:09:16.972543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.495464ms","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-06-26T02:09:16.972587Z","caller":"traceutil/trace.go:171","msg":"trace[1845787996] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1018; }","duration":"203.582876ms","start":"2026-06-26T02:09:16.768993Z","end":"2026-06-26T02:09:16.972576Z","steps":["trace[1845787996] 'agreement among raft nodes before linearized reading' (duration: 203.36371ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:09:16.973088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.456432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-26T02:09:16.973254Z","caller":"traceutil/trace.go:171","msg":"trace[287674718] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1018; }","duration":"203.626947ms","start":"2026-06-26T02:09:16.769548Z","end":"2026-06-26T02:09:16.973175Z","steps":["trace[287674718] 'agreement among raft nodes before linearized reading' (duration: 203.137815ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:09:17.780006Z","caller":"traceutil/trace.go:171","msg":"trace[1156412600] transaction","detail":"{read_only:false; response_revision:1022; number_of_response:1; }","duration":"184.2017ms","start":"2026-06-26T02:09:17.595772Z","end":"2026-06-26T02:09:17.779974Z","steps":["trace[1156412600] 'process raft request' (duration: 183.816721ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:10:01.702185Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13655370374742466567,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T02:10:02.202547Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13655370374742466567,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T02:10:02.702825Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13655370374742466567,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T02:10:03.015975Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.028172175s","expected-duration":"1s"} {"level":"info","ts":"2026-06-26T02:10:03.016649Z","caller":"traceutil/trace.go:171","msg":"trace[1627034] transaction","detail":"{read_only:false; response_revision:1166; number_of_response:1; }","duration":"2.028976944s","start":"2026-06-26T02:10:00.987591Z","end":"2026-06-26T02:10:03.016568Z","steps":["trace[1627034] 'process raft request' (duration: 2.028635236s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:10:03.016824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:10:00.987568Z","time spent":"2.029166209s","remote":"127.0.0.1:36288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:10:03.019994Z","caller":"traceutil/trace.go:171","msg":"trace[741186843] linearizableReadLoop","detail":"{readStateIndex:1212; appliedIndex:1210; }","duration":"1.818466917s","start":"2026-06-26T02:10:01.201494Z","end":"2026-06-26T02:10:03.019961Z","steps":["trace[741186843] 'read index received' (duration: 1.8147711s)","trace[741186843] 'applied index is now lower than readState.Index' (duration: 3.694197ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:10:03.020242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.818746074s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-26T02:10:03.020235Z","caller":"traceutil/trace.go:171","msg":"trace[1274772021] transaction","detail":"{read_only:false; response_revision:1167; number_of_response:1; }","duration":"1.891625384s","start":"2026-06-26T02:10:01.128583Z","end":"2026-06-26T02:10:03.020209Z","steps":["trace[1274772021] 'process raft request' (duration: 1.891179484s)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:10:03.020276Z","caller":"traceutil/trace.go:171","msg":"trace[264636982] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1167; }","duration":"1.818831186s","start":"2026-06-26T02:10:01.201436Z","end":"2026-06-26T02:10:03.020267Z","steps":["trace[264636982] 'agreement among raft nodes before linearized reading' (duration: 1.818696743s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:10:03.020296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:10:01.201411Z","time spent":"1.818880367s","remote":"127.0.0.1:36288","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-06-26T02:10:03.020359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.103791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:10:03.020372Z","caller":"traceutil/trace.go:171","msg":"trace[279120758] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1167; }","duration":"385.154342ms","start":"2026-06-26T02:10:02.635212Z","end":"2026-06-26T02:10:03.020366Z","steps":["trace[279120758] 'agreement among raft nodes before linearized reading' (duration: 385.135061ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:10:03.020383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:10:02.635192Z","time spent":"385.189062ms","remote":"127.0.0.1:36038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-26T02:10:03.02039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.009669403s","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-06-26T02:10:03.020394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.040438243s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.171\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-26T02:10:03.020421Z","caller":"traceutil/trace.go:171","msg":"trace[726379589] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1167; }","duration":"1.009744615s","start":"2026-06-26T02:10:02.010666Z","end":"2026-06-26T02:10:03.02041Z","steps":["trace[726379589] 'agreement among raft nodes before linearized reading' (duration: 1.009638222s)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:10:03.02044Z","caller":"traceutil/trace.go:171","msg":"trace[1087851366] range","detail":"{range_begin:/registry/masterleases/199.19.213.171; range_end:; response_count:1; response_revision:1167; }","duration":"1.040518755s","start":"2026-06-26T02:10:01.979908Z","end":"2026-06-26T02:10:03.020426Z","steps":["trace[1087851366] 'agreement among raft nodes before linearized reading' (duration: 1.040391162s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:10:03.020501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:10:01.979875Z","time spent":"1.040618798s","remote":"127.0.0.1:36060","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/199.19.213.171\" "} {"level":"warn","ts":"2026-06-26T02:10:03.02046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:10:02.010637Z","time spent":"1.009805737s","remote":"127.0.0.1:36288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-26T02:10:03.020676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.809748981s","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-06-26T02:10:03.020712Z","caller":"traceutil/trace.go:171","msg":"trace[1864197682] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1167; }","duration":"1.809807183s","start":"2026-06-26T02:10:01.210895Z","end":"2026-06-26T02:10:03.020702Z","steps":["trace[1864197682] 'agreement among raft nodes before linearized reading' (duration: 1.8096822s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:10:03.020687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.817553396s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-26T02:10:03.020791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:10:01.210879Z","time spent":"1.809854383s","remote":"127.0.0.1:36288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-26T02:10:03.020794Z","caller":"traceutil/trace.go:171","msg":"trace[1960354847] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1167; }","duration":"1.817784711s","start":"2026-06-26T02:10:01.202976Z","end":"2026-06-26T02:10:03.020761Z","steps":["trace[1960354847] 'agreement among raft nodes before linearized reading' (duration: 1.81729323s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:10:03.020854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:10:01.202965Z","time spent":"1.817876433s","remote":"127.0.0.1:36288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-26T02:10:03.021064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:10:01.12855Z","time spent":"1.892387061s","remote":"127.0.0.1:36288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:10:49.782496Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13655370374742467079,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-26T02:10:50.230851Z","caller":"traceutil/trace.go:171","msg":"trace[1683009703] transaction","detail":"{read_only:false; response_revision:1363; number_of_response:1; }","duration":"952.256756ms","start":"2026-06-26T02:10:49.27857Z","end":"2026-06-26T02:10:50.230827Z","steps":["trace[1683009703] 'process raft request' (duration: 950.630258ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:10:50.231181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:10:49.278559Z","time spent":"952.36477ms","remote":"127.0.0.1:36288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:10:50.231182Z","caller":"traceutil/trace.go:171","msg":"trace[593856937] transaction","detail":"{read_only:false; response_revision:1364; number_of_response:1; }","duration":"952.065573ms","start":"2026-06-26T02:10:49.27907Z","end":"2026-06-26T02:10:50.231136Z","steps":["trace[593856937] 'process raft request' (duration: 951.461669ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:10:50.23139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:10:49.279049Z","time spent":"952.228236ms","remote":"127.0.0.1:36288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:10:50.231607Z","caller":"traceutil/trace.go:171","msg":"trace[131134462] linearizableReadLoop","detail":"{readStateIndex:1421; appliedIndex:1419; }","duration":"949.528911ms","start":"2026-06-26T02:10:49.281978Z","end":"2026-06-26T02:10:50.231507Z","steps":["trace[131134462] 'read index received' (duration: 947.258968ms)","trace[131134462] 'applied index is now lower than readState.Index' (duration: 2.263793ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:10:50.23184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"949.855029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-26T02:10:50.231895Z","caller":"traceutil/trace.go:171","msg":"trace[288128030] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1364; }","duration":"949.929191ms","start":"2026-06-26T02:10:49.281952Z","end":"2026-06-26T02:10:50.231881Z","steps":["trace[288128030] 'agreement among raft nodes before linearized reading' (duration: 949.714586ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:10:50.231937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:10:49.281942Z","time spent":"949.985942ms","remote":"127.0.0.1:36288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-26T02:10:50.231931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"623.687339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:10:50.231985Z","caller":"traceutil/trace.go:171","msg":"trace[1171793040] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:1364; }","duration":"623.831272ms","start":"2026-06-26T02:10:49.60814Z","end":"2026-06-26T02:10:50.231971Z","steps":["trace[1171793040] 'agreement among raft nodes before linearized reading' (duration: 623.657498ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:10:50.232043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:10:49.608119Z","time spent":"623.911504ms","remote":"127.0.0.1:55358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "} {"level":"warn","ts":"2026-06-26T02:10:50.232072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"597.22491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:10:50.232102Z","caller":"traceutil/trace.go:171","msg":"trace[335444464] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1364; }","duration":"597.26824ms","start":"2026-06-26T02:10:49.634823Z","end":"2026-06-26T02:10:50.232091Z","steps":["trace[335444464] 'agreement among raft nodes before linearized reading' (duration: 597.219809ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:10:50.232135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:10:49.634816Z","time spent":"597.312951ms","remote":"127.0.0.1:36038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}