{"level":"warn","ts":"2026-10-03T22:09:43.410237Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-03T22:09:43.410413Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.86: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.86:2380","--initial-cluster=instance=https://162.253.55.86:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.86:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.86: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-10-03T22:09:43.410647Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-03T22:09:43.410706Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.86:2380"]} {"level":"info","ts":"2026-10-03T22:09:43.410743Z","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-10-03T22:09:43.411426Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.86:2379"]} {"level":"info","ts":"2026-10-03T22:09:43.411562Z","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.86:2380"],"listen-peer-urls":["https://162.253.55.86:2380"],"advertise-client-urls":["https://162.253.55.86:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.86:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.86: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-10-03T22:09:43.417389Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.575306ms"} {"level":"info","ts":"2026-10-03T22:09:43.423435Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d01cde7b2aa18f95","cluster-id":"9e5d9cb67aed7785"} {"level":"info","ts":"2026-10-03T22:09:43.423517Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d01cde7b2aa18f95 switched to configuration voters=()"} {"level":"info","ts":"2026-10-03T22:09:43.423537Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d01cde7b2aa18f95 became follower at term 0"} {"level":"info","ts":"2026-10-03T22:09:43.423553Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d01cde7b2aa18f95 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-03T22:09:43.423569Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d01cde7b2aa18f95 became follower at term 1"} {"level":"info","ts":"2026-10-03T22:09:43.423604Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d01cde7b2aa18f95 switched to configuration voters=(14996105479814483861)"} {"level":"warn","ts":"2026-10-03T22:09:43.429587Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-03T22:09:43.431251Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-03T22:09:43.432361Z","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-10-03T22:09:43.43405Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d01cde7b2aa18f95","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-03T22:09:43.4344Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d01cde7b2aa18f95","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-03T22:09:43.43444Z","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-10-03T22:09:43.434478Z","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-10-03T22:09:43.434486Z","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-10-03T22:09:43.435759Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d01cde7b2aa18f95 switched to configuration voters=(14996105479814483861)"} {"level":"info","ts":"2026-10-03T22:09:43.435988Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9e5d9cb67aed7785","local-member-id":"d01cde7b2aa18f95","added-peer-id":"d01cde7b2aa18f95","added-peer-peer-urls":["https://162.253.55.86:2380"]} {"level":"info","ts":"2026-10-03T22:09:43.436909Z","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-10-03T22:09:43.436961Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.86:2380"} {"level":"info","ts":"2026-10-03T22:09:43.43699Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.86:2380"} {"level":"info","ts":"2026-10-03T22:09:43.437074Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d01cde7b2aa18f95","initial-advertise-peer-urls":["https://162.253.55.86:2380"],"listen-peer-urls":["https://162.253.55.86:2380"],"advertise-client-urls":["https://162.253.55.86:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.86:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-03T22:09:43.437113Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-03T22:09:44.22444Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d01cde7b2aa18f95 is starting a new election at term 1"} {"level":"info","ts":"2026-10-03T22:09:44.224489Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d01cde7b2aa18f95 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-03T22:09:44.224525Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d01cde7b2aa18f95 received MsgPreVoteResp from d01cde7b2aa18f95 at term 1"} {"level":"info","ts":"2026-10-03T22:09:44.224536Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d01cde7b2aa18f95 became candidate at term 2"} {"level":"info","ts":"2026-10-03T22:09:44.224541Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d01cde7b2aa18f95 received MsgVoteResp from d01cde7b2aa18f95 at term 2"} {"level":"info","ts":"2026-10-03T22:09:44.224549Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d01cde7b2aa18f95 became leader at term 2"} {"level":"info","ts":"2026-10-03T22:09:44.224555Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d01cde7b2aa18f95 elected leader d01cde7b2aa18f95 at term 2"} {"level":"info","ts":"2026-10-03T22:09:44.226906Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-03T22:09:44.231841Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-03T22:09:44.231837Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d01cde7b2aa18f95","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.86:2379]}","request-path":"/0/members/d01cde7b2aa18f95/attributes","cluster-id":"9e5d9cb67aed7785","publish-timeout":"7s"} {"level":"info","ts":"2026-10-03T22:09:44.23193Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-03T22:09:44.232116Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-03T22:09:44.232177Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-03T22:09:44.233905Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9e5d9cb67aed7785","local-member-id":"d01cde7b2aa18f95","cluster-version":"3.5"} {"level":"info","ts":"2026-10-03T22:09:44.233996Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-03T22:09:44.234023Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-03T22:09:44.234948Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-03T22:09:44.235148Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.86:2379"} {"level":"info","ts":"2026-10-03T22:09:46.085538Z","caller":"traceutil/trace.go:171","msg":"trace[2085490431] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"143.842732ms","start":"2026-10-03T22:09:45.941661Z","end":"2026-10-03T22:09:46.085503Z","steps":["trace[2085490431] 'process raft request' (duration: 115.098288ms)","trace[2085490431] 'compare' (duration: 28.55049ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T22:09:46.085688Z","caller":"traceutil/trace.go:171","msg":"trace[807203735] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"142.665679ms","start":"2026-10-03T22:09:45.942995Z","end":"2026-10-03T22:09:46.085661Z","steps":["trace[807203735] 'process raft request' (duration: 142.501306ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T22:09:46.085782Z","caller":"traceutil/trace.go:171","msg":"trace[733000661] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"117.917499ms","start":"2026-10-03T22:09:45.967841Z","end":"2026-10-03T22:09:46.085758Z","steps":["trace[733000661] 'process raft request' (duration: 117.859658ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T22:09:46.085949Z","caller":"traceutil/trace.go:171","msg":"trace[2147188634] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"143.359222ms","start":"2026-10-03T22:09:45.942577Z","end":"2026-10-03T22:09:46.085936Z","steps":["trace[2147188634] 'process raft request' (duration: 142.862072ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T22:09:46.086023Z","caller":"traceutil/trace.go:171","msg":"trace[368529869] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"142.691189ms","start":"2026-10-03T22:09:45.943319Z","end":"2026-10-03T22:09:46.08601Z","steps":["trace[368529869] 'process raft request' (duration: 142.21578ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T22:09:46.086132Z","caller":"traceutil/trace.go:171","msg":"trace[240950285] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"142.524656ms","start":"2026-10-03T22:09:45.943596Z","end":"2026-10-03T22:09:46.08612Z","steps":["trace[240950285] 'process raft request' (duration: 141.966286ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T22:09:46.086154Z","caller":"traceutil/trace.go:171","msg":"trace[1368253496] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"142.366272ms","start":"2026-10-03T22:09:45.943778Z","end":"2026-10-03T22:09:46.086144Z","steps":["trace[1368253496] 'process raft request' (duration: 141.812102ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T22:09:46.086267Z","caller":"traceutil/trace.go:171","msg":"trace[2059646307] linearizableReadLoop","detail":"{readStateIndex:25; appliedIndex:18; }","duration":"130.967937ms","start":"2026-10-03T22:09:45.955161Z","end":"2026-10-03T22:09:46.086129Z","steps":["trace[2059646307] 'read index received' (duration: 101.567301ms)","trace[2059646307] 'applied index is now lower than readState.Index' (duration: 29.398366ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T22:09:46.086296Z","caller":"traceutil/trace.go:171","msg":"trace[1793127502] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"142.447095ms","start":"2026-10-03T22:09:45.943808Z","end":"2026-10-03T22:09:46.086255Z","steps":["trace[1793127502] 'process raft request' (duration: 141.846823ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T22:09:46.086593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.819047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"warn","ts":"2026-10-03T22:09:46.086604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.782625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-2k42m\" ","response":"range_response_count:1 size:861"} {"level":"info","ts":"2026-10-03T22:09:46.086733Z","caller":"traceutil/trace.go:171","msg":"trace[860403196] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:22; }","duration":"146.089823ms","start":"2026-10-03T22:09:45.9406Z","end":"2026-10-03T22:09:46.08669Z","steps":["trace[860403196] 'agreement among raft nodes before linearized reading' (duration: 145.803477ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T22:09:46.086734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.771786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3490"} {"level":"info","ts":"2026-10-03T22:09:46.086803Z","caller":"traceutil/trace.go:171","msg":"trace[1113352552] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:22; }","duration":"127.900457ms","start":"2026-10-03T22:09:45.958885Z","end":"2026-10-03T22:09:46.086786Z","steps":["trace[1113352552] 'agreement among raft nodes before linearized reading' (duration: 127.786695ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T22:09:46.086736Z","caller":"traceutil/trace.go:171","msg":"trace[1523272418] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-2k42m; range_end:; response_count:1; response_revision:22; }","duration":"128.983199ms","start":"2026-10-03T22:09:45.957729Z","end":"2026-10-03T22:09:46.086712Z","steps":["trace[1523272418] 'agreement among raft nodes before linearized reading' (duration: 128.741395ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T22:09:49.42107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.547471ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-03T22:09:49.421186Z","caller":"traceutil/trace.go:171","msg":"trace[1247797662] transaction","detail":"{read_only:false; response_revision:221; number_of_response:1; }","duration":"272.415931ms","start":"2026-10-03T22:09:49.148752Z","end":"2026-10-03T22:09:49.421168Z","steps":["trace[1247797662] 'process raft request' (duration: 135.270929ms)","trace[1247797662] 'compare' (duration: 136.413889ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T22:09:49.464237Z","caller":"traceutil/trace.go:171","msg":"trace[1398321577] linearizableReadLoop","detail":"{readStateIndex:227; appliedIndex:225; }","duration":"294.187302ms","start":"2026-10-03T22:09:49.170034Z","end":"2026-10-03T22:09:49.464221Z","steps":["trace[1398321577] 'read index received' (duration: 113.999498ms)","trace[1398321577] 'applied index is now lower than readState.Index' (duration: 180.187024ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T22:09:49.464311Z","caller":"traceutil/trace.go:171","msg":"trace[1226298148] transaction","detail":"{read_only:false; response_revision:225; number_of_response:1; }","duration":"184.493046ms","start":"2026-10-03T22:09:49.279808Z","end":"2026-10-03T22:09:49.464301Z","steps":["trace[1226298148] 'process raft request' (duration: 184.344553ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T22:09:49.464266Z","caller":"traceutil/trace.go:171","msg":"trace[1491877631] transaction","detail":"{read_only:false; response_revision:222; number_of_response:1; }","duration":"314.499894ms","start":"2026-10-03T22:09:49.149723Z","end":"2026-10-03T22:09:49.464223Z","steps":["trace[1491877631] 'process raft request' (duration: 314.192149ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T22:09:49.464342Z","caller":"traceutil/trace.go:171","msg":"trace[1211640883] transaction","detail":"{read_only:false; response_revision:224; number_of_response:1; }","duration":"184.524546ms","start":"2026-10-03T22:09:49.279758Z","end":"2026-10-03T22:09:49.464283Z","steps":["trace[1211640883] 'process raft request' (duration: 184.348093ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T22:09:49.464626Z","caller":"traceutil/trace.go:171","msg":"trace[384703773] transaction","detail":"{read_only:false; number_of_response:0; response_revision:222; }","duration":"196.829908ms","start":"2026-10-03T22:09:49.267743Z","end":"2026-10-03T22:09:49.464573Z","steps":["trace[384703773] 'process raft request' (duration: 196.294038ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T22:09:49.464586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T22:09:49.149709Z","time spent":"314.759279ms","remote":"127.0.0.1:43448","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-03T22:09:49.464782Z","caller":"traceutil/trace.go:171","msg":"trace[1356500764] transaction","detail":"{read_only:false; response_revision:223; number_of_response:1; }","duration":"184.833942ms","start":"2026-10-03T22:09:49.279745Z","end":"2026-10-03T22:09:49.464579Z","steps":["trace[1356500764] 'process raft request' (duration: 184.319152ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T22:09:49.464855Z","caller":"traceutil/trace.go:171","msg":"trace[1890200195] transaction","detail":"{read_only:false; response_revision:227; number_of_response:1; }","duration":"183.746262ms","start":"2026-10-03T22:09:49.28105Z","end":"2026-10-03T22:09:49.464796Z","steps":["trace[1890200195] 'process raft request' (duration: 183.148331ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T22:09:49.46495Z","caller":"traceutil/trace.go:171","msg":"trace[36877589] transaction","detail":"{read_only:false; response_revision:226; number_of_response:1; }","duration":"184.016937ms","start":"2026-10-03T22:09:49.280919Z","end":"2026-10-03T22:09:49.464936Z","steps":["trace[36877589] 'process raft request' (duration: 183.257763ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T22:09:49.465127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.064778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-10-03T22:09:49.465174Z","caller":"traceutil/trace.go:171","msg":"trace[486053320] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:227; }","duration":"295.166141ms","start":"2026-10-03T22:09:49.169993Z","end":"2026-10-03T22:09:49.465159Z","steps":["trace[486053320] 'agreement among raft nodes before linearized reading' (duration: 294.979947ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T22:09:49.648557Z","caller":"traceutil/trace.go:171","msg":"trace[312321014] linearizableReadLoop","detail":"{readStateIndex:235; appliedIndex:234; }","duration":"184.253741ms","start":"2026-10-03T22:09:49.464278Z","end":"2026-10-03T22:09:49.648532Z","steps":["trace[312321014] 'read index received' (duration: 184.125349ms)","trace[312321014] 'applied index is now lower than readState.Index' (duration: 126.952µs)"],"step_count":2} {"level":"info","ts":"2026-10-03T22:09:49.648631Z","caller":"traceutil/trace.go:171","msg":"trace[1046962988] transaction","detail":"{read_only:false; response_revision:228; number_of_response:1; }","duration":"223.424609ms","start":"2026-10-03T22:09:49.425142Z","end":"2026-10-03T22:09:49.648566Z","steps":["trace[1046962988] 'process raft request' (duration: 223.261446ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T22:09:49.64927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.342329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"warn","ts":"2026-10-03T22:09:49.649293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.458217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4016"} {"level":"warn","ts":"2026-10-03T22:09:49.649317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.885418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-10-03T22:09:49.649335Z","caller":"traceutil/trace.go:171","msg":"trace[153920875] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:229; }","duration":"179.44583ms","start":"2026-10-03T22:09:49.469867Z","end":"2026-10-03T22:09:49.649313Z","steps":["trace[153920875] 'agreement among raft nodes before linearized reading' (duration: 179.306597ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T22:09:49.649348Z","caller":"traceutil/trace.go:171","msg":"trace[1302688168] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:229; }","duration":"182.559128ms","start":"2026-10-03T22:09:49.466773Z","end":"2026-10-03T22:09:49.649332Z","steps":["trace[1302688168] 'agreement among raft nodes before linearized reading' (duration: 182.399385ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T22:09:49.648856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.016185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-03T22:09:49.649365Z","caller":"traceutil/trace.go:171","msg":"trace[1983959979] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:229; }","duration":"179.993561ms","start":"2026-10-03T22:09:49.469359Z","end":"2026-10-03T22:09:49.649352Z","steps":["trace[1983959979] 'agreement among raft nodes before linearized reading' (duration: 179.860818ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T22:09:49.649409Z","caller":"traceutil/trace.go:171","msg":"trace[1297881456] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:228; }","duration":"478.607646ms","start":"2026-10-03T22:09:49.170786Z","end":"2026-10-03T22:09:49.649394Z","steps":["trace[1297881456] 'agreement among raft nodes before linearized reading' (duration: 477.929404ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T22:09:49.649464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T22:09:49.170772Z","time spent":"478.674967ms","remote":"127.0.0.1:43448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":29,"request content":"key:\"/registry/leases/kube-node-lease/instance\" "} {"level":"info","ts":"2026-10-03T22:09:49.649212Z","caller":"traceutil/trace.go:171","msg":"trace[95129354] transaction","detail":"{read_only:false; response_revision:229; number_of_response:1; }","duration":"182.07388ms","start":"2026-10-03T22:09:49.467118Z","end":"2026-10-03T22:09:49.649192Z","steps":["trace[95129354] 'process raft request' (duration: 181.969578ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T22:09:52.237987Z","caller":"traceutil/trace.go:171","msg":"trace[1611625368] transaction","detail":"{read_only:false; response_revision:282; number_of_response:1; }","duration":"121.564042ms","start":"2026-10-03T22:09:52.116399Z","end":"2026-10-03T22:09:52.237963Z","steps":["trace[1611625368] 'process raft request' (duration: 78.688477ms)","trace[1611625368] 'compare' (duration: 42.569769ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T22:10:23.296234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.162411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-03T22:10:23.296456Z","caller":"traceutil/trace.go:171","msg":"trace[723191900] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:566; }","duration":"124.462566ms","start":"2026-10-03T22:10:23.171963Z","end":"2026-10-03T22:10:23.296426Z","steps":["trace[723191900] 'range keys from in-memory index tree' (duration: 124.033657ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T22:10:26.402012Z","caller":"traceutil/trace.go:171","msg":"trace[1116898866] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"181.774959ms","start":"2026-10-03T22:10:26.220211Z","end":"2026-10-03T22:10:26.401986Z","steps":["trace[1116898866] 'process raft request' (duration: 181.221299ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T22:10:26.404246Z","caller":"traceutil/trace.go:171","msg":"trace[1255797978] linearizableReadLoop","detail":"{readStateIndex:607; appliedIndex:605; }","duration":"129.359288ms","start":"2026-10-03T22:10:26.274869Z","end":"2026-10-03T22:10:26.404228Z","steps":["trace[1255797978] 'read index received' (duration: 126.381614ms)","trace[1255797978] 'applied index is now lower than readState.Index' (duration: 2.976824ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T22:10:26.404454Z","caller":"traceutil/trace.go:171","msg":"trace[860268912] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"179.975077ms","start":"2026-10-03T22:10:26.224468Z","end":"2026-10-03T22:10:26.404443Z","steps":["trace[860268912] 'process raft request' (duration: 179.688922ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T22:10:26.404776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.895787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-whd29\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-10-03T22:10:26.40485Z","caller":"traceutil/trace.go:171","msg":"trace[1096859023] range","detail":"{range_begin:/registry/pods/kube-system/cilium-whd29; range_end:; response_count:1; response_revision:586; }","duration":"130.051111ms","start":"2026-10-03T22:10:26.274779Z","end":"2026-10-03T22:10:26.40483Z","steps":["trace[1096859023] 'agreement among raft nodes before linearized reading' (duration: 129.897378ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T22:10:26.800829Z","caller":"traceutil/trace.go:171","msg":"trace[714396517] linearizableReadLoop","detail":"{readStateIndex:610; appliedIndex:609; }","duration":"230.066296ms","start":"2026-10-03T22:10:26.570721Z","end":"2026-10-03T22:10:26.800788Z","steps":["trace[714396517] 'read index received' (duration: 136.64755ms)","trace[714396517] 'applied index is now lower than readState.Index' (duration: 93.417776ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T22:10:26.801178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.111418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-03T22:10:26.801258Z","caller":"traceutil/trace.go:171","msg":"trace[141665229] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:589; }","duration":"191.20627ms","start":"2026-10-03T22:10:26.610032Z","end":"2026-10-03T22:10:26.801238Z","steps":["trace[141665229] 'agreement among raft nodes before linearized reading' (duration: 191.069408ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T22:10:26.801227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.496073ms","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-10-03T22:10:26.801581Z","caller":"traceutil/trace.go:171","msg":"trace[1267486428] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:589; }","duration":"230.905001ms","start":"2026-10-03T22:10:26.570648Z","end":"2026-10-03T22:10:26.801553Z","steps":["trace[1267486428] 'agreement among raft nodes before linearized reading' (duration: 230.353041ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T22:10:26.80165Z","caller":"traceutil/trace.go:171","msg":"trace[39202584] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"313.769685ms","start":"2026-10-03T22:10:26.487863Z","end":"2026-10-03T22:10:26.801633Z","steps":["trace[39202584] 'process raft request' (duration: 219.583146ms)","trace[39202584] 'compare' (duration: 93.178801ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T22:10:26.801733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T22:10:26.487847Z","time spent":"313.834556ms","remote":"127.0.0.1:43724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"}