{"level":"warn","ts":"2026-02-17T23:09:48.765507Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-17T23:09:48.765587Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.248: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.248:2380","--initial-cluster=instance=https://199.204.45.248:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.248:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.248: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-02-17T23:09:48.765767Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-17T23:09:48.765782Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.248:2380"]} {"level":"info","ts":"2026-02-17T23:09:48.765822Z","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-02-17T23:09:48.766408Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"]} {"level":"info","ts":"2026-02-17T23:09:48.766483Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":2,"max-cpu-available":2,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.248:2380"],"listen-peer-urls":["https://199.204.45.248:2380"],"advertise-client-urls":["https://199.204.45.248:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.248: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-02-17T23:09:48.781658Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"14.987225ms"} {"level":"info","ts":"2026-02-17T23:09:48.791323Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"39582465ceaa2f67","cluster-id":"87fd8ddedde3be45"} {"level":"info","ts":"2026-02-17T23:09:48.791399Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=()"} {"level":"info","ts":"2026-02-17T23:09:48.791454Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became follower at term 0"} {"level":"info","ts":"2026-02-17T23:09:48.791462Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 39582465ceaa2f67 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-17T23:09:48.791469Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became follower at term 1"} {"level":"info","ts":"2026-02-17T23:09:48.791559Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=(4132092677789986663)"} {"level":"warn","ts":"2026-02-17T23:09:48.798776Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-17T23:09:48.812589Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-17T23:09:48.816928Z","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-02-17T23:09:48.819091Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"39582465ceaa2f67","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-17T23:09:48.819461Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"39582465ceaa2f67","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-17T23:09:48.819592Z","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-02-17T23:09:48.81964Z","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-02-17T23:09:48.819647Z","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-02-17T23:09:48.820199Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=(4132092677789986663)"} {"level":"info","ts":"2026-02-17T23:09:48.8203Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"87fd8ddedde3be45","local-member-id":"39582465ceaa2f67","added-peer-id":"39582465ceaa2f67","added-peer-peer-urls":["https://199.204.45.248:2380"]} {"level":"info","ts":"2026-02-17T23:09:48.822392Z","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-02-17T23:09:48.822456Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.248:2380"} {"level":"info","ts":"2026-02-17T23:09:48.822466Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.248:2380"} {"level":"info","ts":"2026-02-17T23:09:48.828111Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-17T23:09:48.828174Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"39582465ceaa2f67","initial-advertise-peer-urls":["https://199.204.45.248:2380"],"listen-peer-urls":["https://199.204.45.248:2380"],"advertise-client-urls":["https://199.204.45.248:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-17T23:09:49.092886Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 is starting a new election at term 1"} {"level":"info","ts":"2026-02-17T23:09:49.092962Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-17T23:09:49.093021Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 received MsgPreVoteResp from 39582465ceaa2f67 at term 1"} {"level":"info","ts":"2026-02-17T23:09:49.09304Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became candidate at term 2"} {"level":"info","ts":"2026-02-17T23:09:49.093051Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 received MsgVoteResp from 39582465ceaa2f67 at term 2"} {"level":"info","ts":"2026-02-17T23:09:49.093063Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became leader at term 2"} {"level":"info","ts":"2026-02-17T23:09:49.093121Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 39582465ceaa2f67 elected leader 39582465ceaa2f67 at term 2"} {"level":"info","ts":"2026-02-17T23:09:49.096058Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"39582465ceaa2f67","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.248:2379]}","request-path":"/0/members/39582465ceaa2f67/attributes","cluster-id":"87fd8ddedde3be45","publish-timeout":"7s"} {"level":"info","ts":"2026-02-17T23:09:49.096101Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-17T23:09:49.096531Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T23:09:49.096838Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-17T23:09:49.097102Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-17T23:09:49.097119Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-17T23:09:49.10468Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.248:2379"} {"level":"info","ts":"2026-02-17T23:09:49.105319Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"87fd8ddedde3be45","local-member-id":"39582465ceaa2f67","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T23:09:49.105437Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T23:09:49.105777Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T23:09:49.110745Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-02-17T23:09:51.4244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.556006ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-02-17T23:09:51.424518Z","caller":"traceutil/trace.go:171","msg":"trace[1554667271] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"251.172529ms","start":"2026-02-17T23:09:51.173314Z","end":"2026-02-17T23:09:51.424486Z","steps":["trace[1554667271] 'process raft request' (duration: 91.798ms)","trace[1554667271] 'compare' (duration: 158.292238ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:09:51.466075Z","caller":"traceutil/trace.go:171","msg":"trace[932053250] linearizableReadLoop","detail":"{readStateIndex:10; appliedIndex:5; }","duration":"289.858948ms","start":"2026-02-17T23:09:51.176177Z","end":"2026-02-17T23:09:51.466036Z","steps":["trace[932053250] 'read index received' (duration: 89.059413ms)","trace[932053250] 'applied index is now lower than readState.Index' (duration: 200.798725ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:09:51.466321Z","caller":"traceutil/trace.go:171","msg":"trace[592333355] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"291.667578ms","start":"2026-02-17T23:09:51.174644Z","end":"2026-02-17T23:09:51.466311Z","steps":["trace[592333355] 'process raft request' (duration: 290.926297ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:09:51.473793Z","caller":"traceutil/trace.go:171","msg":"trace[1439920409] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"298.944528ms","start":"2026-02-17T23:09:51.174834Z","end":"2026-02-17T23:09:51.473778Z","steps":["trace[1439920409] 'process raft request' (duration: 290.866066ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:09:51.474115Z","caller":"traceutil/trace.go:171","msg":"trace[385002892] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"299.082723ms","start":"2026-02-17T23:09:51.175021Z","end":"2026-02-17T23:09:51.474104Z","steps":["trace[385002892] 'process raft request' (duration: 290.731632ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:09:51.474311Z","caller":"traceutil/trace.go:171","msg":"trace[59641958] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"298.848977ms","start":"2026-02-17T23:09:51.175452Z","end":"2026-02-17T23:09:51.4743Z","steps":["trace[59641958] 'process raft request' (duration: 290.344062ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:09:51.474667Z","caller":"traceutil/trace.go:171","msg":"trace[299510434] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"298.542498ms","start":"2026-02-17T23:09:51.176113Z","end":"2026-02-17T23:09:51.474655Z","steps":["trace[299510434] 'process raft request' (duration: 289.736885ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:09:51.476075Z","caller":"traceutil/trace.go:171","msg":"trace[1373644647] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"298.287751ms","start":"2026-02-17T23:09:51.177781Z","end":"2026-02-17T23:09:51.476069Z","steps":["trace[1373644647] 'process raft request' (duration: 288.10358ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:09:51.476499Z","caller":"traceutil/trace.go:171","msg":"trace[1570769094] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"262.750547ms","start":"2026-02-17T23:09:51.213743Z","end":"2026-02-17T23:09:51.476494Z","steps":["trace[1570769094] 'process raft request' (duration: 252.163475ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:09:51.476701Z","caller":"traceutil/trace.go:171","msg":"trace[529683520] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"252.891855ms","start":"2026-02-17T23:09:51.223798Z","end":"2026-02-17T23:09:51.47669Z","steps":["trace[529683520] 'process raft request' (duration: 242.20794ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:09:51.476921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.909394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:2859"} {"level":"info","ts":"2026-02-17T23:09:51.476947Z","caller":"traceutil/trace.go:171","msg":"trace[1890426276] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:11; }","duration":"300.969816ms","start":"2026-02-17T23:09:51.175971Z","end":"2026-02-17T23:09:51.476941Z","steps":["trace[1890426276] 'agreement among raft nodes before linearized reading' (duration: 300.888074ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:09:51.477002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:09:51.175965Z","time spent":"301.031587ms","remote":"127.0.0.1:40520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":2882,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-02-17T23:09:51.477102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.933199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T23:09:51.477122Z","caller":"traceutil/trace.go:171","msg":"trace[197724449] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"302.967821ms","start":"2026-02-17T23:09:51.174149Z","end":"2026-02-17T23:09:51.477117Z","steps":["trace[197724449] 'agreement among raft nodes before linearized reading' (duration: 302.93739ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:09:51.477135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:09:51.174132Z","time spent":"303.000432ms","remote":"127.0.0.1:40454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-02-17T23:09:51.607454Z","caller":"traceutil/trace.go:171","msg":"trace[298684792] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"116.74631ms","start":"2026-02-17T23:09:51.490683Z","end":"2026-02-17T23:09:51.607429Z","steps":["trace[298684792] 'process raft request' (duration: 116.725019ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:09:51.607719Z","caller":"traceutil/trace.go:171","msg":"trace[245312829] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"178.355633ms","start":"2026-02-17T23:09:51.429355Z","end":"2026-02-17T23:09:51.607711Z","steps":["trace[245312829] 'process raft request' (duration: 173.098507ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:09:51.607838Z","caller":"traceutil/trace.go:171","msg":"trace[56975791] linearizableReadLoop","detail":"{readStateIndex:15; appliedIndex:14; }","duration":"141.690669ms","start":"2026-02-17T23:09:51.46614Z","end":"2026-02-17T23:09:51.60783Z","steps":["trace[56975791] 'read index received' (duration: 136.253288ms)","trace[56975791] 'applied index is now lower than readState.Index' (duration: 5.436491ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:09:51.607986Z","caller":"traceutil/trace.go:171","msg":"trace[253756055] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"118.532519ms","start":"2026-02-17T23:09:51.489447Z","end":"2026-02-17T23:09:51.60798Z","steps":["trace[253756055] 'process raft request' (duration: 117.795929ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:09:51.60813Z","caller":"traceutil/trace.go:171","msg":"trace[1044579053] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"118.390815ms","start":"2026-02-17T23:09:51.489733Z","end":"2026-02-17T23:09:51.608124Z","steps":["trace[1044579053] 'process raft request' (duration: 117.581243ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:09:51.608238Z","caller":"traceutil/trace.go:171","msg":"trace[1847147653] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"118.468747ms","start":"2026-02-17T23:09:51.489763Z","end":"2026-02-17T23:09:51.608232Z","steps":["trace[1847147653] 'process raft request' (duration: 117.576812ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:09:51.608504Z","caller":"traceutil/trace.go:171","msg":"trace[49453505] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"118.54696ms","start":"2026-02-17T23:09:51.489951Z","end":"2026-02-17T23:09:51.608498Z","steps":["trace[49453505] 'process raft request' (duration: 117.411898ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:09:51.608574Z","caller":"traceutil/trace.go:171","msg":"trace[2008915652] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"118.563841ms","start":"2026-02-17T23:09:51.490006Z","end":"2026-02-17T23:09:51.608569Z","steps":["trace[2008915652] 'process raft request' (duration: 117.373037ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:09:51.608641Z","caller":"traceutil/trace.go:171","msg":"trace[1572048208] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"118.598302ms","start":"2026-02-17T23:09:51.490038Z","end":"2026-02-17T23:09:51.608636Z","steps":["trace[1572048208] 'process raft request' (duration: 117.355457ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:09:51.60878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.142744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T23:09:51.60881Z","caller":"traceutil/trace.go:171","msg":"trace[310238061] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:19; }","duration":"385.211676ms","start":"2026-02-17T23:09:51.223589Z","end":"2026-02-17T23:09:51.6088Z","steps":["trace[310238061] 'agreement among raft nodes before linearized reading' (duration: 385.161295ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:09:51.608834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:09:51.223575Z","time spent":"385.254007ms","remote":"127.0.0.1:40454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-02-17T23:09:51.608922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.994977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T23:09:51.608946Z","caller":"traceutil/trace.go:171","msg":"trace[899112582] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:19; }","duration":"429.016057ms","start":"2026-02-17T23:09:51.179923Z","end":"2026-02-17T23:09:51.608939Z","steps":["trace[899112582] 'agreement among raft nodes before linearized reading' (duration: 428.987196ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:09:51.608972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:09:51.179917Z","time spent":"429.047838ms","remote":"127.0.0.1:40454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-02-17T23:09:51.60905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.786639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T23:09:51.609071Z","caller":"traceutil/trace.go:171","msg":"trace[1870659898] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:19; }","duration":"429.817111ms","start":"2026-02-17T23:09:51.179249Z","end":"2026-02-17T23:09:51.609066Z","steps":["trace[1870659898] 'agreement among raft nodes before linearized reading' (duration: 429.78862ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:09:51.609088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:09:51.179235Z","time spent":"429.849931ms","remote":"127.0.0.1:40618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-17T23:09:51.609172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.93542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T23:09:51.609194Z","caller":"traceutil/trace.go:171","msg":"trace[1163698502] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:19; }","duration":"430.971032ms","start":"2026-02-17T23:09:51.178218Z","end":"2026-02-17T23:09:51.609189Z","steps":["trace[1163698502] 'agreement among raft nodes before linearized reading' (duration: 430.942411ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:09:51.609215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:09:51.178214Z","time spent":"430.996673ms","remote":"127.0.0.1:40618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-17T23:09:51.609301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.227989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.248\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T23:09:51.609322Z","caller":"traceutil/trace.go:171","msg":"trace[886748909] range","detail":"{range_begin:/registry/masterleases/199.204.45.248; range_end:; response_count:0; response_revision:19; }","duration":"431.267779ms","start":"2026-02-17T23:09:51.17805Z","end":"2026-02-17T23:09:51.609318Z","steps":["trace[886748909] 'agreement among raft nodes before linearized reading' (duration: 431.238889ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:09:51.609339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:09:51.178047Z","time spent":"431.28875ms","remote":"127.0.0.1:40348","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/199.204.45.248\" "} {"level":"warn","ts":"2026-02-17T23:09:51.609438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.580147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T23:09:51.609461Z","caller":"traceutil/trace.go:171","msg":"trace[1163153306] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:19; }","duration":"432.602857ms","start":"2026-02-17T23:09:51.176852Z","end":"2026-02-17T23:09:51.609455Z","steps":["trace[1163153306] 'agreement among raft nodes before linearized reading' (duration: 432.569036ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:09:51.609478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:09:51.176836Z","time spent":"432.638318ms","remote":"127.0.0.1:40414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"warn","ts":"2026-02-17T23:09:51.609582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.753331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-226gb\" ","response":"range_response_count:1 size:857"} {"level":"info","ts":"2026-02-17T23:09:51.609605Z","caller":"traceutil/trace.go:171","msg":"trace[1051331301] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-226gb; range_end:; response_count:1; response_revision:19; }","duration":"128.798063ms","start":"2026-02-17T23:09:51.480801Z","end":"2026-02-17T23:09:51.6096Z","steps":["trace[1051331301] 'agreement among raft nodes before linearized reading' (duration: 128.758202ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:10:27.874913Z","caller":"traceutil/trace.go:171","msg":"trace[243649688] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"116.793628ms","start":"2026-02-17T23:10:27.758101Z","end":"2026-02-17T23:10:27.874895Z","steps":["trace[243649688] 'process raft request' (duration: 73.372821ms)","trace[243649688] 'compare' (duration: 43.032806ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:10:42.239886Z","caller":"traceutil/trace.go:171","msg":"trace[1665769930] linearizableReadLoop","detail":"{readStateIndex:732; appliedIndex:731; }","duration":"479.281839ms","start":"2026-02-17T23:10:41.760587Z","end":"2026-02-17T23:10:42.239868Z","steps":["trace[1665769930] 'read index received' (duration: 479.150576ms)","trace[1665769930] 'applied index is now lower than readState.Index' (duration: 130.683µs)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:10:42.239999Z","caller":"traceutil/trace.go:171","msg":"trace[1388287523] transaction","detail":"{read_only:false; response_revision:711; number_of_response:1; }","duration":"482.779837ms","start":"2026-02-17T23:10:41.757198Z","end":"2026-02-17T23:10:42.239978Z","steps":["trace[1388287523] 'process raft request' (duration: 482.539601ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:10:42.240181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.561009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-02-17T23:10:42.240228Z","caller":"traceutil/trace.go:171","msg":"trace[1725218205] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:711; }","duration":"181.630701ms","start":"2026-02-17T23:10:42.058583Z","end":"2026-02-17T23:10:42.240214Z","steps":["trace[1725218205] 'agreement among raft nodes before linearized reading' (duration: 181.494607ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:10:42.240252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:10:41.757188Z","time spent":"482.846839ms","remote":"127.0.0.1:40618","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T23:10:42.240387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.798214ms","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-02-17T23:10:42.240415Z","caller":"traceutil/trace.go:171","msg":"trace[1874631921] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:711; }","duration":"479.840375ms","start":"2026-02-17T23:10:41.760565Z","end":"2026-02-17T23:10:42.240406Z","steps":["trace[1874631921] 'agreement among raft nodes before linearized reading' (duration: 479.764243ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:10:42.240443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:10:41.760557Z","time spent":"479.879596ms","remote":"127.0.0.1:40618","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":"warn","ts":"2026-02-17T23:10:42.240565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.316329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-02-17T23:10:42.240587Z","caller":"traceutil/trace.go:171","msg":"trace[199914115] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:711; }","duration":"178.34981ms","start":"2026-02-17T23:10:42.06223Z","end":"2026-02-17T23:10:42.24058Z","steps":["trace[199914115] 'agreement among raft nodes before linearized reading' (duration: 178.274458ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:11:22.858064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.038328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.248\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-17T23:11:22.858125Z","caller":"traceutil/trace.go:171","msg":"trace[1511931684] range","detail":"{range_begin:/registry/masterleases/199.204.45.248; range_end:; response_count:1; response_revision:888; }","duration":"124.12993ms","start":"2026-02-17T23:11:22.733982Z","end":"2026-02-17T23:11:22.858111Z","steps":["trace[1511931684] 'range keys from in-memory index tree' (duration: 123.907914ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:11:34.182877Z","caller":"traceutil/trace.go:171","msg":"trace[2099159348] linearizableReadLoop","detail":"{readStateIndex:955; appliedIndex:954; }","duration":"134.671522ms","start":"2026-02-17T23:11:34.04819Z","end":"2026-02-17T23:11:34.182861Z","steps":["trace[2099159348] 'read index received' (duration: 134.551759ms)","trace[2099159348] 'applied index is now lower than readState.Index' (duration: 119.123µs)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:11:34.182988Z","caller":"traceutil/trace.go:171","msg":"trace[678778656] transaction","detail":"{read_only:false; response_revision:919; number_of_response:1; }","duration":"149.935805ms","start":"2026-02-17T23:11:34.033033Z","end":"2026-02-17T23:11:34.182968Z","steps":["trace[678778656] 'process raft request' (duration: 149.72609ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:11:34.183034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.822737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-17T23:11:34.183057Z","caller":"traceutil/trace.go:171","msg":"trace[2054073188] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:919; }","duration":"134.880698ms","start":"2026-02-17T23:11:34.048169Z","end":"2026-02-17T23:11:34.18305Z","steps":["trace[2054073188] 'agreement among raft nodes before linearized reading' (duration: 134.792905ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:11:52.214591Z","caller":"traceutil/trace.go:171","msg":"trace[1017285904] linearizableReadLoop","detail":"{readStateIndex:1072; appliedIndex:1071; }","duration":"142.444138ms","start":"2026-02-17T23:11:52.072123Z","end":"2026-02-17T23:11:52.214567Z","steps":["trace[1017285904] 'read index received' (duration: 142.285274ms)","trace[1017285904] 'applied index is now lower than readState.Index' (duration: 157.984µs)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:11:52.215197Z","caller":"traceutil/trace.go:171","msg":"trace[170184326] transaction","detail":"{read_only:false; response_revision:1033; number_of_response:1; }","duration":"260.637273ms","start":"2026-02-17T23:11:51.954546Z","end":"2026-02-17T23:11:52.215183Z","steps":["trace[170184326] 'process raft request' (duration: 259.915353ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:11:52.216043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.921349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T23:11:52.216069Z","caller":"traceutil/trace.go:171","msg":"trace[1659984320] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1033; }","duration":"143.95609ms","start":"2026-02-17T23:11:52.072106Z","end":"2026-02-17T23:11:52.216062Z","steps":["trace[1659984320] 'agreement among raft nodes before linearized reading' (duration: 143.906289ms)"],"step_count":1}