{"level":"warn","ts":"2026-08-04T15:21:12.186726Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-04T15:21:12.186828Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.222: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.222:2380","--initial-cluster=instance=https://199.204.45.222:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.222:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.222: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-08-04T15:21:12.186925Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-04T15:21:12.186938Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.222:2380"]} {"level":"info","ts":"2026-08-04T15:21:12.186965Z","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-08-04T15:21:12.187666Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"]} {"level":"info","ts":"2026-08-04T15:21:12.187741Z","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.222:2380"],"listen-peer-urls":["https://199.204.45.222:2380"],"advertise-client-urls":["https://199.204.45.222:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.222: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-08-04T15:21:12.192761Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.801796ms"} {"level":"info","ts":"2026-08-04T15:21:12.207843Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"380f6760faea5f9e","cluster-id":"b87e8aca83a17eab"} {"level":"info","ts":"2026-08-04T15:21:12.207921Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=()"} {"level":"info","ts":"2026-08-04T15:21:12.207949Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became follower at term 0"} {"level":"info","ts":"2026-08-04T15:21:12.207962Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 380f6760faea5f9e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-04T15:21:12.207978Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became follower at term 1"} {"level":"info","ts":"2026-08-04T15:21:12.20802Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=(4039561056998809502)"} {"level":"warn","ts":"2026-08-04T15:21:12.218202Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-04T15:21:12.221309Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-04T15:21:12.22416Z","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-08-04T15:21:12.231745Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"380f6760faea5f9e","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-04T15:21:12.232077Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"380f6760faea5f9e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-04T15:21:12.232255Z","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-08-04T15:21:12.232287Z","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-08-04T15:21:12.2323Z","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-08-04T15:21:12.234767Z","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-08-04T15:21:12.234993Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"380f6760faea5f9e","initial-advertise-peer-urls":["https://199.204.45.222:2380"],"listen-peer-urls":["https://199.204.45.222:2380"],"advertise-client-urls":["https://199.204.45.222:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-04T15:21:12.235025Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-04T15:21:12.235137Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.222:2380"} {"level":"info","ts":"2026-08-04T15:21:12.235151Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.222:2380"} {"level":"info","ts":"2026-08-04T15:21:12.235712Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=(4039561056998809502)"} {"level":"info","ts":"2026-08-04T15:21:12.235899Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b87e8aca83a17eab","local-member-id":"380f6760faea5f9e","added-peer-id":"380f6760faea5f9e","added-peer-peer-urls":["https://199.204.45.222:2380"]} {"level":"info","ts":"2026-08-04T15:21:12.610658Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e is starting a new election at term 1"} {"level":"info","ts":"2026-08-04T15:21:12.61072Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became pre-candidate at term 1"} {"level":"info","ts":"2026-08-04T15:21:12.610753Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e received MsgPreVoteResp from 380f6760faea5f9e at term 1"} {"level":"info","ts":"2026-08-04T15:21:12.610779Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became candidate at term 2"} {"level":"info","ts":"2026-08-04T15:21:12.610795Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e received MsgVoteResp from 380f6760faea5f9e at term 2"} {"level":"info","ts":"2026-08-04T15:21:12.610816Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became leader at term 2"} {"level":"info","ts":"2026-08-04T15:21:12.610834Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 380f6760faea5f9e elected leader 380f6760faea5f9e at term 2"} {"level":"info","ts":"2026-08-04T15:21:12.611964Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"380f6760faea5f9e","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.222:2379]}","request-path":"/0/members/380f6760faea5f9e/attributes","cluster-id":"b87e8aca83a17eab","publish-timeout":"7s"} {"level":"info","ts":"2026-08-04T15:21:12.61209Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-04T15:21:12.612053Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-04T15:21:12.612334Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-04T15:21:12.61419Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-04T15:21:12.622149Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b87e8aca83a17eab","local-member-id":"380f6760faea5f9e","cluster-version":"3.5"} {"level":"info","ts":"2026-08-04T15:21:12.622738Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-04T15:21:12.622891Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-04T15:21:12.622997Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-04T15:21:12.623042Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-04T15:21:12.626238Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.222:2379"} {"level":"info","ts":"2026-08-04T15:21:17.513167Z","caller":"traceutil/trace.go:171","msg":"trace[1761517088] linearizableReadLoop","detail":"{readStateIndex:226; appliedIndex:225; }","duration":"281.279141ms","start":"2026-08-04T15:21:17.231862Z","end":"2026-08-04T15:21:17.513141Z","steps":["trace[1761517088] 'read index received' (duration: 281.093848ms)","trace[1761517088] 'applied index is now lower than readState.Index' (duration: 183.993µs)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:21:17.513349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.473993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:21:17.513394Z","caller":"traceutil/trace.go:171","msg":"trace[1630672771] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:221; }","duration":"281.601365ms","start":"2026-08-04T15:21:17.231784Z","end":"2026-08-04T15:21:17.513385Z","steps":["trace[1630672771] 'agreement among raft nodes before linearized reading' (duration: 281.503684ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:21:17.513625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.893571ms","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-08-04T15:21:17.513664Z","caller":"traceutil/trace.go:171","msg":"trace[516734970] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:221; }","duration":"139.934452ms","start":"2026-08-04T15:21:17.373723Z","end":"2026-08-04T15:21:17.513657Z","steps":["trace[516734970] 'agreement among raft nodes before linearized reading' (duration: 139.871221ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:21:17.513736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.990562ms","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-08-04T15:21:17.51376Z","caller":"traceutil/trace.go:171","msg":"trace[410944456] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:221; }","duration":"140.057043ms","start":"2026-08-04T15:21:17.373697Z","end":"2026-08-04T15:21:17.513754Z","steps":["trace[410944456] 'agreement among raft nodes before linearized reading' (duration: 140.021522ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:21:17.51383Z","caller":"traceutil/trace.go:171","msg":"trace[1111612879] transaction","detail":"{read_only:false; response_revision:221; number_of_response:1; }","duration":"375.265058ms","start":"2026-08-04T15:21:17.137923Z","end":"2026-08-04T15:21:17.513188Z","steps":["trace[1111612879] 'process raft request' (duration: 375.062095ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:21:17.514702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:21:17.137888Z","time spent":"376.13675ms","remote":"127.0.0.1:40578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4003,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T15:21:17.8115Z","caller":"traceutil/trace.go:171","msg":"trace[1052715839] transaction","detail":"{read_only:false; response_revision:222; number_of_response:1; }","duration":"294.220968ms","start":"2026-08-04T15:21:17.517222Z","end":"2026-08-04T15:21:17.811443Z","steps":["trace[1052715839] 'process raft request' (duration: 280.348209ms)","trace[1052715839] 'compare' (duration: 13.593685ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:21:17.811702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.093213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/bootstrap-token-k8s34b\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:21:17.811789Z","caller":"traceutil/trace.go:171","msg":"trace[1800764884] range","detail":"{range_begin:/registry/secrets/kube-system/bootstrap-token-k8s34b; range_end:; response_count:0; response_revision:222; }","duration":"293.233124ms","start":"2026-08-04T15:21:17.518541Z","end":"2026-08-04T15:21:17.811775Z","steps":["trace[1800764884] 'agreement among raft nodes before linearized reading' (duration: 293.076042ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:21:17.811566Z","caller":"traceutil/trace.go:171","msg":"trace[1021861164] linearizableReadLoop","detail":"{readStateIndex:227; appliedIndex:226; }","duration":"292.784579ms","start":"2026-08-04T15:21:17.518568Z","end":"2026-08-04T15:21:17.811352Z","steps":["trace[1021861164] 'read index received' (duration: 279.158443ms)","trace[1021861164] 'applied index is now lower than readState.Index' (duration: 13.625386ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:21:17.840133Z","caller":"traceutil/trace.go:171","msg":"trace[914936065] transaction","detail":"{read_only:false; response_revision:224; number_of_response:1; }","duration":"320.631197ms","start":"2026-08-04T15:21:17.519464Z","end":"2026-08-04T15:21:17.840096Z","steps":["trace[914936065] 'process raft request' (duration: 320.569616ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:21:17.840342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:21:17.519453Z","time spent":"320.792919ms","remote":"127.0.0.1:40674","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T15:21:17.840167Z","caller":"traceutil/trace.go:171","msg":"trace[56636109] transaction","detail":"{read_only:false; response_revision:223; number_of_response:1; }","duration":"321.501288ms","start":"2026-08-04T15:21:17.518638Z","end":"2026-08-04T15:21:17.84014Z","steps":["trace[56636109] 'process raft request' (duration: 321.238335ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:21:17.840754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:21:17.518606Z","time spent":"321.980984ms","remote":"127.0.0.1:40674","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T15:22:06.804491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.677459ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-04T15:22:06.804687Z","caller":"traceutil/trace.go:171","msg":"trace[236538500] linearizableReadLoop","detail":"{readStateIndex:629; appliedIndex:628; }","duration":"239.825942ms","start":"2026-08-04T15:22:06.564841Z","end":"2026-08-04T15:22:06.804667Z","steps":["trace[236538500] 'read index received' (duration: 102.566497ms)","trace[236538500] 'applied index is now lower than readState.Index' (duration: 137.257835ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:22:06.804697Z","caller":"traceutil/trace.go:171","msg":"trace[13461785] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"255.926191ms","start":"2026-08-04T15:22:06.548735Z","end":"2026-08-04T15:22:06.804661Z","steps":["trace[13461785] 'process raft request' (duration: 118.647496ms)","trace[13461785] 'compare' (duration: 136.04165ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:22:06.80518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.33536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/clienttrafficpolicies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:65436"} {"level":"info","ts":"2026-08-04T15:22:06.805226Z","caller":"traceutil/trace.go:171","msg":"trace[1010075496] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/clienttrafficpolicies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:601; }","duration":"240.41528ms","start":"2026-08-04T15:22:06.564797Z","end":"2026-08-04T15:22:06.805212Z","steps":["trace[1010075496] 'agreement among raft nodes before linearized reading' (duration: 239.950474ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:22:06.971794Z","caller":"traceutil/trace.go:171","msg":"trace[60154621] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"101.931929ms","start":"2026-08-04T15:22:06.869827Z","end":"2026-08-04T15:22:06.971759Z","steps":["trace[60154621] 'process raft request' (duration: 92.922408ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:22:11.282623Z","caller":"traceutil/trace.go:171","msg":"trace[1529767462] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"183.743195ms","start":"2026-08-04T15:22:11.098849Z","end":"2026-08-04T15:22:11.282592Z","steps":["trace[1529767462] 'process raft request' (duration: 183.032776ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:22:11.617233Z","caller":"traceutil/trace.go:171","msg":"trace[274718689] linearizableReadLoop","detail":"{readStateIndex:657; appliedIndex:656; }","duration":"175.517534ms","start":"2026-08-04T15:22:11.44167Z","end":"2026-08-04T15:22:11.617187Z","steps":["trace[274718689] 'read index received' (duration: 169.655032ms)","trace[274718689] 'applied index is now lower than readState.Index' (duration: 5.860832ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:22:11.617252Z","caller":"traceutil/trace.go:171","msg":"trace[413976541] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"263.645566ms","start":"2026-08-04T15:22:11.353581Z","end":"2026-08-04T15:22:11.617226Z","steps":["trace[413976541] 'process raft request' (duration: 257.829094ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:22:11.619008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.313076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-9hjnd\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-08-04T15:22:11.619141Z","caller":"traceutil/trace.go:171","msg":"trace[1542223183] range","detail":"{range_begin:/registry/pods/kube-system/cilium-9hjnd; range_end:; response_count:1; response_revision:628; }","duration":"177.469628ms","start":"2026-08-04T15:22:11.441618Z","end":"2026-08-04T15:22:11.619088Z","steps":["trace[1542223183] 'agreement among raft nodes before linearized reading' (duration: 175.793627ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:22:12.653625Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890120184306013791,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-04T15:22:12.798472Z","caller":"traceutil/trace.go:171","msg":"trace[583484496] linearizableReadLoop","detail":"{readStateIndex:659; appliedIndex:658; }","duration":"644.879724ms","start":"2026-08-04T15:22:12.153574Z","end":"2026-08-04T15:22:12.798454Z","steps":["trace[583484496] 'read index received' (duration: 644.071514ms)","trace[583484496] 'applied index is now lower than readState.Index' (duration: 807.54µs)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:22:12.798509Z","caller":"traceutil/trace.go:171","msg":"trace[1330177429] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"762.276704ms","start":"2026-08-04T15:22:12.036217Z","end":"2026-08-04T15:22:12.798494Z","steps":["trace[1330177429] 'process raft request' (duration: 761.708787ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:22:12.798588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"628.103979ms","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-08-04T15:22:12.798595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:22:12.036188Z","time spent":"762.348954ms","remote":"127.0.0.1:40488","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T15:22:12.798615Z","caller":"traceutil/trace.go:171","msg":"trace[106769732] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:630; }","duration":"628.176069ms","start":"2026-08-04T15:22:12.170432Z","end":"2026-08-04T15:22:12.798608Z","steps":["trace[106769732] 'agreement among raft nodes before linearized reading' (duration: 628.121709ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:22:12.798635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:22:12.170411Z","time spent":"628.219861ms","remote":"127.0.0.1:40674","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-08-04T15:22:12.79869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.670897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:22:12.79875Z","caller":"traceutil/trace.go:171","msg":"trace[893367436] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:630; }","duration":"252.775618ms","start":"2026-08-04T15:22:12.545959Z","end":"2026-08-04T15:22:12.798735Z","steps":["trace[893367436] 'agreement among raft nodes before linearized reading' (duration: 252.663606ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:22:12.798739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"645.144987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-08-04T15:22:12.798822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"628.325002ms","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-08-04T15:22:12.798814Z","caller":"traceutil/trace.go:171","msg":"trace[1025123616] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:630; }","duration":"645.26609ms","start":"2026-08-04T15:22:12.153527Z","end":"2026-08-04T15:22:12.798793Z","steps":["trace[1025123616] 'agreement among raft nodes before linearized reading' (duration: 645.020607ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:22:12.798847Z","caller":"traceutil/trace.go:171","msg":"trace[1109548379] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:630; }","duration":"628.396872ms","start":"2026-08-04T15:22:12.170445Z","end":"2026-08-04T15:22:12.798842Z","steps":["trace[1109548379] 'agreement among raft nodes before linearized reading' (duration: 628.355442ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:22:12.798865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:22:12.17041Z","time spent":"628.451313ms","remote":"127.0.0.1:40674","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-08-04T15:22:12.798856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.661342ms","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-08-04T15:22:12.798886Z","caller":"traceutil/trace.go:171","msg":"trace[758307298] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:630; }","duration":"290.723774ms","start":"2026-08-04T15:22:12.508154Z","end":"2026-08-04T15:22:12.798877Z","steps":["trace[758307298] 'agreement among raft nodes before linearized reading' (duration: 290.619142ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:22:12.798884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:22:12.153507Z","time spent":"645.367031ms","remote":"127.0.0.1:40674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-08-04T15:22:14.720979Z","caller":"traceutil/trace.go:171","msg":"trace[1419561135] transaction","detail":"{read_only:false; response_revision:661; number_of_response:1; }","duration":"122.406827ms","start":"2026-08-04T15:22:14.598547Z","end":"2026-08-04T15:22:14.720954Z","steps":["trace[1419561135] 'process raft request' (duration: 122.254075ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:22:28.770495Z","caller":"traceutil/trace.go:171","msg":"trace[195854962] linearizableReadLoop","detail":"{readStateIndex:831; appliedIndex:830; }","duration":"134.693573ms","start":"2026-08-04T15:22:28.635777Z","end":"2026-08-04T15:22:28.770471Z","steps":["trace[195854962] 'read index received' (duration: 134.49254ms)","trace[195854962] 'applied index is now lower than readState.Index' (duration: 200.163µs)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:22:28.770594Z","caller":"traceutil/trace.go:171","msg":"trace[683272881] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"214.371592ms","start":"2026-08-04T15:22:28.556177Z","end":"2026-08-04T15:22:28.770548Z","steps":["trace[683272881] 'process raft request' (duration: 214.146659ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:22:28.77072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.931165ms","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-08-04T15:22:28.770786Z","caller":"traceutil/trace.go:171","msg":"trace[373024953] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:797; }","duration":"135.049186ms","start":"2026-08-04T15:22:28.635718Z","end":"2026-08-04T15:22:28.770767Z","steps":["trace[373024953] 'agreement among raft nodes before linearized reading' (duration: 134.861544ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:22:29.047513Z","caller":"traceutil/trace.go:171","msg":"trace[1460252298] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"143.418836ms","start":"2026-08-04T15:22:28.904065Z","end":"2026-08-04T15:22:29.047484Z","steps":["trace[1460252298] 'process raft request' (duration: 91.255399ms)","trace[1460252298] 'compare' (duration: 51.904074ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:22:29.04778Z","caller":"traceutil/trace.go:171","msg":"trace[2088306877] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"143.69553ms","start":"2026-08-04T15:22:28.904059Z","end":"2026-08-04T15:22:29.047755Z","steps":["trace[2088306877] 'process raft request' (duration: 143.377036ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:22:29.04787Z","caller":"traceutil/trace.go:171","msg":"trace[1506763332] transaction","detail":"{read_only:false; response_revision:802; number_of_response:1; }","duration":"143.70415ms","start":"2026-08-04T15:22:28.904142Z","end":"2026-08-04T15:22:29.047846Z","steps":["trace[1506763332] 'process raft request' (duration: 143.535418ms)"],"step_count":1}