{"level":"warn","ts":"2026-09-19T01:54:33.33468Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-19T01:54:33.334765Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.214: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://162.253.55.214:2380","--initial-cluster=instance=https://162.253.55.214:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.214:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.214: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-09-19T01:54:33.334832Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-19T01:54:33.334839Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.214:2380"]} {"level":"info","ts":"2026-09-19T01:54:33.334859Z","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-09-19T01:54:33.335425Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.214:2379"]} {"level":"info","ts":"2026-09-19T01:54:33.335494Z","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://162.253.55.214:2380"],"listen-peer-urls":["https://162.253.55.214:2380"],"advertise-client-urls":["https://162.253.55.214:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.214:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.214: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-09-19T01:54:33.341963Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.936193ms"} {"level":"info","ts":"2026-09-19T01:54:33.357839Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"86f12f2ae020828","cluster-id":"dfe59afaaa064e4a"} {"level":"info","ts":"2026-09-19T01:54:33.357919Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 switched to configuration voters=()"} {"level":"info","ts":"2026-09-19T01:54:33.357938Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 became follower at term 0"} {"level":"info","ts":"2026-09-19T01:54:33.357949Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 86f12f2ae020828 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-19T01:54:33.357955Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 became follower at term 1"} {"level":"info","ts":"2026-09-19T01:54:33.357986Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 switched to configuration voters=(607725308229060648)"} {"level":"warn","ts":"2026-09-19T01:54:33.366659Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-19T01:54:33.36797Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-19T01:54:33.3691Z","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-09-19T01:54:33.370889Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"86f12f2ae020828","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-19T01:54:33.373064Z","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-09-19T01:54:33.373201Z","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-09-19T01:54:33.373225Z","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-09-19T01:54:33.373336Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"86f12f2ae020828","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-19T01:54:33.37384Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 switched to configuration voters=(607725308229060648)"} {"level":"info","ts":"2026-09-19T01:54:33.374176Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"dfe59afaaa064e4a","local-member-id":"86f12f2ae020828","added-peer-id":"86f12f2ae020828","added-peer-peer-urls":["https://162.253.55.214:2380"]} {"level":"info","ts":"2026-09-19T01:54:33.375023Z","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-09-19T01:54:33.375112Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.214:2380"} {"level":"info","ts":"2026-09-19T01:54:33.375124Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.214:2380"} {"level":"info","ts":"2026-09-19T01:54:33.375236Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"86f12f2ae020828","initial-advertise-peer-urls":["https://162.253.55.214:2380"],"listen-peer-urls":["https://162.253.55.214:2380"],"advertise-client-urls":["https://162.253.55.214:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.214:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-19T01:54:33.375275Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-19T01:54:33.558494Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 is starting a new election at term 1"} {"level":"info","ts":"2026-09-19T01:54:33.558561Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-19T01:54:33.558724Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 received MsgPreVoteResp from 86f12f2ae020828 at term 1"} {"level":"info","ts":"2026-09-19T01:54:33.558757Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 became candidate at term 2"} {"level":"info","ts":"2026-09-19T01:54:33.558769Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 received MsgVoteResp from 86f12f2ae020828 at term 2"} {"level":"info","ts":"2026-09-19T01:54:33.558824Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 became leader at term 2"} {"level":"info","ts":"2026-09-19T01:54:33.558838Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 86f12f2ae020828 elected leader 86f12f2ae020828 at term 2"} {"level":"info","ts":"2026-09-19T01:54:33.560961Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"86f12f2ae020828","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.214:2379]}","request-path":"/0/members/86f12f2ae020828/attributes","cluster-id":"dfe59afaaa064e4a","publish-timeout":"7s"} {"level":"info","ts":"2026-09-19T01:54:33.560994Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-19T01:54:33.561245Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-19T01:54:33.561556Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T01:54:33.561729Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-19T01:54:33.561787Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-19T01:54:33.563271Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"dfe59afaaa064e4a","local-member-id":"86f12f2ae020828","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T01:54:33.563415Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T01:54:33.563459Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T01:54:33.564699Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-19T01:54:33.565712Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.214:2379"} {"level":"warn","ts":"2026-09-19T01:54:37.268045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.376141ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-19T01:54:37.268162Z","caller":"traceutil/trace.go:171","msg":"trace[77165479] transaction","detail":"{read_only:false; response_revision:186; number_of_response:1; }","duration":"311.457441ms","start":"2026-09-19T01:54:36.956687Z","end":"2026-09-19T01:54:37.268145Z","steps":["trace[77165479] 'process raft request' (duration: 139.527215ms)","trace[77165479] 'compare' (duration: 171.230487ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:54:37.268223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:54:36.956673Z","time spent":"311.528262ms","remote":"127.0.0.1:38740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":841,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-19T01:54:37.727744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.902337ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-19T01:54:37.727848Z","caller":"traceutil/trace.go:171","msg":"trace[1794192964] transaction","detail":"{read_only:false; response_revision:202; number_of_response:1; }","duration":"256.610936ms","start":"2026-09-19T01:54:37.471217Z","end":"2026-09-19T01:54:37.727828Z","steps":["trace[1794192964] 'process raft request' (duration: 57.564055ms)","trace[1794192964] 'compare' (duration: 198.737003ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:54:38.194707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.714934ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-19T01:54:38.19481Z","caller":"traceutil/trace.go:171","msg":"trace[83301076] linearizableReadLoop","detail":"{readStateIndex:208; appliedIndex:207; }","duration":"159.205345ms","start":"2026-09-19T01:54:38.03559Z","end":"2026-09-19T01:54:38.194795Z","steps":["trace[83301076] 'read index received' (duration: 79.002µs)","trace[83301076] 'applied index is now lower than readState.Index' (duration: 159.125223ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:54:38.194901Z","caller":"traceutil/trace.go:171","msg":"trace[1933142260] transaction","detail":"{read_only:false; response_revision:203; number_of_response:1; }","duration":"462.874683ms","start":"2026-09-19T01:54:37.73198Z","end":"2026-09-19T01:54:38.194854Z","steps":["trace[1933142260] 'process raft request' (duration: 199.930803ms)","trace[1933142260] 'compare' (duration: 262.585101ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:54:38.195126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:54:37.731953Z","time spent":"463.09661ms","remote":"127.0.0.1:38740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-19T01:54:38.195145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.546634ms","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-09-19T01:54:38.195324Z","caller":"traceutil/trace.go:171","msg":"trace[206579815] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:203; }","duration":"159.76319ms","start":"2026-09-19T01:54:38.035541Z","end":"2026-09-19T01:54:38.195304Z","steps":["trace[206579815] 'agreement among raft nodes before linearized reading' (duration: 159.355289ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:54:38.382223Z","caller":"traceutil/trace.go:171","msg":"trace[1968364780] transaction","detail":"{read_only:false; response_revision:204; number_of_response:1; }","duration":"181.076364ms","start":"2026-09-19T01:54:38.201126Z","end":"2026-09-19T01:54:38.382202Z","steps":["trace[1968364780] 'process raft request' (duration: 178.893588ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:55:11.499149Z","caller":"traceutil/trace.go:171","msg":"trace[912751194] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"199.321978ms","start":"2026-09-19T01:55:11.299787Z","end":"2026-09-19T01:55:11.499109Z","steps":["trace[912751194] 'process raft request' (duration: 199.146903ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:55:11.52154Z","caller":"traceutil/trace.go:171","msg":"trace[67447450] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"211.042312ms","start":"2026-09-19T01:55:11.31047Z","end":"2026-09-19T01:55:11.521513Z","steps":["trace[67447450] 'process raft request' (duration: 210.898418ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:55:11.521845Z","caller":"traceutil/trace.go:171","msg":"trace[1311965230] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"202.163053ms","start":"2026-09-19T01:55:11.319613Z","end":"2026-09-19T01:55:11.521776Z","steps":["trace[1311965230] 'process raft request' (duration: 201.797604ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:55:11.521852Z","caller":"traceutil/trace.go:171","msg":"trace[865804177] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"199.751879ms","start":"2026-09-19T01:55:11.322044Z","end":"2026-09-19T01:55:11.521796Z","steps":["trace[865804177] 'process raft request' (duration: 199.409661ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:55:11.521521Z","caller":"traceutil/trace.go:171","msg":"trace[1836845629] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"215.325904ms","start":"2026-09-19T01:55:11.306151Z","end":"2026-09-19T01:55:11.521477Z","steps":["trace[1836845629] 'process raft request' (duration: 215.079747ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:55:11.522007Z","caller":"traceutil/trace.go:171","msg":"trace[642099405] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"187.037458ms","start":"2026-09-19T01:55:11.334956Z","end":"2026-09-19T01:55:11.521994Z","steps":["trace[642099405] 'process raft request' (duration: 186.683889ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:55:11.522043Z","caller":"traceutil/trace.go:171","msg":"trace[755248425] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"195.981781ms","start":"2026-09-19T01:55:11.326047Z","end":"2026-09-19T01:55:11.522029Z","steps":["trace[755248425] 'process raft request' (duration: 195.481849ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:55:11.5221Z","caller":"traceutil/trace.go:171","msg":"trace[515131590] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"175.904829ms","start":"2026-09-19T01:55:11.346184Z","end":"2026-09-19T01:55:11.522089Z","steps":["trace[515131590] 'process raft request' (duration: 175.50897ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:55:11.522118Z","caller":"traceutil/trace.go:171","msg":"trace[1024854640] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"144.71793ms","start":"2026-09-19T01:55:11.37739Z","end":"2026-09-19T01:55:11.522108Z","steps":["trace[1024854640] 'process raft request' (duration: 144.356561ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:55:11.522093Z","caller":"traceutil/trace.go:171","msg":"trace[1364764760] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"192.363428ms","start":"2026-09-19T01:55:11.329691Z","end":"2026-09-19T01:55:11.522054Z","steps":["trace[1364764760] 'process raft request' (duration: 191.903926ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:55:11.52222Z","caller":"traceutil/trace.go:171","msg":"trace[663175691] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"197.772667ms","start":"2026-09-19T01:55:11.324424Z","end":"2026-09-19T01:55:11.522197Z","steps":["trace[663175691] 'process raft request' (duration: 197.06844ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:55:17.77736Z","caller":"traceutil/trace.go:171","msg":"trace[915068781] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"129.274802ms","start":"2026-09-19T01:55:17.648061Z","end":"2026-09-19T01:55:17.777336Z","steps":["trace[915068781] 'process raft request' (duration: 128.844992ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:55:17.874234Z","caller":"traceutil/trace.go:171","msg":"trace[493919909] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"102.368659ms","start":"2026-09-19T01:55:17.771829Z","end":"2026-09-19T01:55:17.874198Z","steps":["trace[493919909] 'process raft request' (duration: 86.88235ms)","trace[493919909] 'compare' (duration: 14.816471ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:55:18.348892Z","caller":"traceutil/trace.go:171","msg":"trace[1540700017] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"404.430408ms","start":"2026-09-19T01:55:17.944434Z","end":"2026-09-19T01:55:18.348864Z","steps":["trace[1540700017] 'process raft request' (duration: 404.240572ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:55:18.349111Z","caller":"traceutil/trace.go:171","msg":"trace[730032324] linearizableReadLoop","detail":"{readStateIndex:621; appliedIndex:621; }","duration":"388.697271ms","start":"2026-09-19T01:55:17.960383Z","end":"2026-09-19T01:55:18.34908Z","steps":["trace[730032324] 'read index received' (duration: 388.683391ms)","trace[730032324] 'applied index is now lower than readState.Index' (duration: 11.43µs)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:55:18.349241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:55:17.944409Z","time spent":"404.581481ms","remote":"127.0.0.1:38612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-19T01:55:18.349406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.005629ms","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-09-19T01:55:18.349721Z","caller":"traceutil/trace.go:171","msg":"trace[145102100] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:595; }","duration":"389.370009ms","start":"2026-09-19T01:55:17.960325Z","end":"2026-09-19T01:55:18.349695Z","steps":["trace[145102100] 'agreement among raft nodes before linearized reading' (duration: 388.870006ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:55:18.349789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:55:17.960305Z","time spent":"389.469502ms","remote":"127.0.0.1:38680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-09-19T01:55:18.541Z","caller":"traceutil/trace.go:171","msg":"trace[890955031] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"562.787068ms","start":"2026-09-19T01:55:17.978184Z","end":"2026-09-19T01:55:18.540971Z","steps":["trace[890955031] 'process raft request' (duration: 544.783724ms)","trace[890955031] 'compare' (duration: 17.750168ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:55:18.541048Z","caller":"traceutil/trace.go:171","msg":"trace[1087338951] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"186.621401ms","start":"2026-09-19T01:55:18.354411Z","end":"2026-09-19T01:55:18.541032Z","steps":["trace[1087338951] 'process raft request' (duration: 186.557689ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:55:18.541131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:55:17.978165Z","time spent":"562.904352ms","remote":"127.0.0.1:38644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-19T01:55:18.541229Z","caller":"traceutil/trace.go:171","msg":"trace[267954307] linearizableReadLoop","detail":"{readStateIndex:622; appliedIndex:621; }","duration":"192.037961ms","start":"2026-09-19T01:55:18.349181Z","end":"2026-09-19T01:55:18.541219Z","steps":["trace[267954307] 'read index received' (duration: 173.734929ms)","trace[267954307] 'applied index is now lower than readState.Index' (duration: 18.301722ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:55:18.541386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.056229ms","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-09-19T01:55:18.541413Z","caller":"traceutil/trace.go:171","msg":"trace[406110726] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:597; }","duration":"470.132691ms","start":"2026-09-19T01:55:18.071272Z","end":"2026-09-19T01:55:18.541404Z","steps":["trace[406110726] 'agreement among raft nodes before linearized reading' (duration: 469.991337ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:55:18.541443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:55:18.071239Z","time spent":"470.197463ms","remote":"127.0.0.1:38680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-09-19T01:55:18.541523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.124458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T01:55:18.541544Z","caller":"traceutil/trace.go:171","msg":"trace[625707066] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:597; }","duration":"274.194559ms","start":"2026-09-19T01:55:18.267342Z","end":"2026-09-19T01:55:18.541537Z","steps":["trace[625707066] 'agreement among raft nodes before linearized reading' (duration: 274.160968ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:55:35.986087Z","caller":"traceutil/trace.go:171","msg":"trace[553910636] linearizableReadLoop","detail":"{readStateIndex:794; appliedIndex:793; }","duration":"121.653856ms","start":"2026-09-19T01:55:35.86441Z","end":"2026-09-19T01:55:35.986064Z","steps":["trace[553910636] 'read index received' (duration: 121.335468ms)","trace[553910636] 'applied index is now lower than readState.Index' (duration: 317.378µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:55:35.986164Z","caller":"traceutil/trace.go:171","msg":"trace[373159001] transaction","detail":"{read_only:false; response_revision:764; number_of_response:1; }","duration":"157.729815ms","start":"2026-09-19T01:55:35.828398Z","end":"2026-09-19T01:55:35.986128Z","steps":["trace[373159001] 'process raft request' (duration: 157.418718ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:55:35.986275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.854871ms","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-09-19T01:55:35.986315Z","caller":"traceutil/trace.go:171","msg":"trace[243757791] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:764; }","duration":"121.952134ms","start":"2026-09-19T01:55:35.864354Z","end":"2026-09-19T01:55:35.986306Z","steps":["trace[243757791] 'agreement among raft nodes before linearized reading' (duration: 121.81184ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:56:16.548854Z","caller":"traceutil/trace.go:171","msg":"trace[1346365345] transaction","detail":"{read_only:false; response_revision:1046; number_of_response:1; }","duration":"322.800802ms","start":"2026-09-19T01:56:16.226037Z","end":"2026-09-19T01:56:16.548838Z","steps":["trace[1346365345] 'process raft request' (duration: 322.578016ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:56:16.548795Z","caller":"traceutil/trace.go:171","msg":"trace[148664517] linearizableReadLoop","detail":"{readStateIndex:1088; appliedIndex:1087; }","duration":"322.086153ms","start":"2026-09-19T01:56:16.226688Z","end":"2026-09-19T01:56:16.548774Z","steps":["trace[148664517] 'read index received' (duration: 321.886328ms)","trace[148664517] 'applied index is now lower than readState.Index' (duration: 199.005µs)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:56:16.548953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:56:16.226022Z","time spent":"322.881634ms","remote":"127.0.0.1:38680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-19T01:56:16.549071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.369551ms","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-09-19T01:56:16.549115Z","caller":"traceutil/trace.go:171","msg":"trace[1880419318] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1046; }","duration":"322.472734ms","start":"2026-09-19T01:56:16.22663Z","end":"2026-09-19T01:56:16.549103Z","steps":["trace[1880419318] 'agreement among raft nodes before linearized reading' (duration: 322.31014ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:56:16.549144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:56:16.226619Z","time spent":"322.516464ms","remote":"127.0.0.1:38680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-09-19T01:56:16.795759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.325664ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-19T01:56:16.795899Z","caller":"traceutil/trace.go:171","msg":"trace[806498933] linearizableReadLoop","detail":"{readStateIndex:1089; appliedIndex:1088; }","duration":"246.973477ms","start":"2026-09-19T01:56:16.548911Z","end":"2026-09-19T01:56:16.795885Z","steps":["trace[806498933] 'read index received' (duration: 143.415877ms)","trace[806498933] 'applied index is now lower than readState.Index' (duration: 103.55672ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:56:16.795917Z","caller":"traceutil/trace.go:171","msg":"trace[2006188857] transaction","detail":"{read_only:false; response_revision:1047; number_of_response:1; }","duration":"495.668649ms","start":"2026-09-19T01:56:16.300219Z","end":"2026-09-19T01:56:16.795888Z","steps":["trace[2006188857] 'process raft request' (duration: 392.14651ms)","trace[2006188857] 'compare' (duration: 103.226401ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:56:16.79604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:56:16.300199Z","time spent":"495.774131ms","remote":"127.0.0.1:38680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T01:56:16.796091Z","caller":"traceutil/trace.go:171","msg":"trace[885438555] transaction","detail":"{read_only:false; response_revision:1048; number_of_response:1; }","duration":"242.195453ms","start":"2026-09-19T01:56:16.553875Z","end":"2026-09-19T01:56:16.796071Z","steps":["trace[885438555] 'process raft request' (duration: 241.975108ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:56:16.796157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.364678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T01:56:16.796215Z","caller":"traceutil/trace.go:171","msg":"trace[1135182795] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1048; }","duration":"529.46754ms","start":"2026-09-19T01:56:16.266731Z","end":"2026-09-19T01:56:16.796198Z","steps":["trace[1135182795] 'agreement among raft nodes before linearized reading' (duration: 529.193904ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:56:16.796242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:56:16.266696Z","time spent":"529.538892ms","remote":"127.0.0.1:38426","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-09-19T01:56:34.876458Z","caller":"traceutil/trace.go:171","msg":"trace[1440234646] transaction","detail":"{read_only:false; response_revision:1127; number_of_response:1; }","duration":"228.288978ms","start":"2026-09-19T01:56:34.648103Z","end":"2026-09-19T01:56:34.876392Z","steps":["trace[1440234646] 'process raft request' (duration: 228.174035ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:56:34.998428Z","caller":"traceutil/trace.go:171","msg":"trace[1860695537] linearizableReadLoop","detail":"{readStateIndex:1174; appliedIndex:1173; }","duration":"133.265748ms","start":"2026-09-19T01:56:34.865112Z","end":"2026-09-19T01:56:34.998377Z","steps":["trace[1860695537] 'read index received' (duration: 11.382834ms)","trace[1860695537] 'applied index is now lower than readState.Index' (duration: 121.881644ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:56:34.99875Z","caller":"traceutil/trace.go:171","msg":"trace[1727012850] transaction","detail":"{read_only:false; response_revision:1128; number_of_response:1; }","duration":"143.959905ms","start":"2026-09-19T01:56:34.854764Z","end":"2026-09-19T01:56:34.998724Z","steps":["trace[1727012850] 'process raft request' (duration: 134.294495ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:56:34.998849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.72293ms","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-09-19T01:56:34.998992Z","caller":"traceutil/trace.go:171","msg":"trace[470604373] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1128; }","duration":"133.837733ms","start":"2026-09-19T01:56:34.865097Z","end":"2026-09-19T01:56:34.998935Z","steps":["trace[470604373] 'agreement among raft nodes before linearized reading' (duration: 133.571336ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:56:35.664154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.205223ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-19T01:56:35.664464Z","caller":"traceutil/trace.go:171","msg":"trace[424785934] transaction","detail":"{read_only:false; response_revision:1137; number_of_response:1; }","duration":"317.395123ms","start":"2026-09-19T01:56:35.347043Z","end":"2026-09-19T01:56:35.664438Z","steps":["trace[424785934] 'process raft request' (duration: 187.789359ms)","trace[424785934] 'compare' (duration: 129.0775ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:56:35.664541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:56:35.347029Z","time spent":"317.478045ms","remote":"127.0.0.1:38490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":773,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-19T01:56:35.704782Z","caller":"traceutil/trace.go:171","msg":"trace[243860801] linearizableReadLoop","detail":"{readStateIndex:1184; appliedIndex:1183; }","duration":"140.399283ms","start":"2026-09-19T01:56:35.564353Z","end":"2026-09-19T01:56:35.704752Z","steps":["trace[243860801] 'read index received' (duration: 140.129136ms)","trace[243860801] 'applied index is now lower than readState.Index' (duration: 268.467µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:56:35.704972Z","caller":"traceutil/trace.go:171","msg":"trace[944397346] transaction","detail":"{read_only:false; response_revision:1138; number_of_response:1; }","duration":"355.872908ms","start":"2026-09-19T01:56:35.349058Z","end":"2026-09-19T01:56:35.704931Z","steps":["trace[944397346] 'process raft request' (duration: 355.53506ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:56:35.705099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.718701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T01:56:35.705135Z","caller":"traceutil/trace.go:171","msg":"trace[593459263] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1138; }","duration":"140.805553ms","start":"2026-09-19T01:56:35.564317Z","end":"2026-09-19T01:56:35.705122Z","steps":["trace[593459263] 'agreement among raft nodes before linearized reading' (duration: 140.720281ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:56:35.70534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:56:35.349041Z","time spent":"356.062873ms","remote":"127.0.0.1:38680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T01:56:46.717875Z","caller":"traceutil/trace.go:171","msg":"trace[223231022] transaction","detail":"{read_only:false; response_revision:1213; number_of_response:1; }","duration":"191.424833ms","start":"2026-09-19T01:56:46.526419Z","end":"2026-09-19T01:56:46.717844Z","steps":["trace[223231022] 'process raft request' (duration: 191.284899ms)"],"step_count":1}