{"level":"warn","ts":"2026-04-30T05:55:07.004492Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-30T05:55:07.004575Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.205: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.205:2380","--initial-cluster=instance=https://199.204.45.205:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.205:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.205: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-04-30T05:55:07.00464Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-30T05:55:07.004651Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.205:2380"]} {"level":"info","ts":"2026-04-30T05:55:07.004671Z","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-04-30T05:55:07.005359Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"]} {"level":"info","ts":"2026-04-30T05:55:07.005457Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.205:2380"],"listen-peer-urls":["https://199.204.45.205:2380"],"advertise-client-urls":["https://199.204.45.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.205: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-04-30T05:55:07.010931Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.203143ms"} {"level":"info","ts":"2026-04-30T05:55:07.02206Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"71d28e9ac1bc4e5d","cluster-id":"4a4ae660c7a9a6a7"} {"level":"info","ts":"2026-04-30T05:55:07.022354Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=()"} {"level":"info","ts":"2026-04-30T05:55:07.022456Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became follower at term 0"} {"level":"info","ts":"2026-04-30T05:55:07.022574Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 71d28e9ac1bc4e5d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-30T05:55:07.022683Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became follower at term 1"} {"level":"info","ts":"2026-04-30T05:55:07.022835Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=(8201774666721545821)"} {"level":"warn","ts":"2026-04-30T05:55:07.035385Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-30T05:55:07.038387Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-30T05:55:07.040953Z","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-04-30T05:55:07.043761Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"71d28e9ac1bc4e5d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-30T05:55:07.046005Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"71d28e9ac1bc4e5d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-30T05:55:07.04607Z","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-04-30T05:55:07.046103Z","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-04-30T05:55:07.046115Z","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-04-30T05:55:07.049688Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=(8201774666721545821)"} {"level":"info","ts":"2026-04-30T05:55:07.049808Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4a4ae660c7a9a6a7","local-member-id":"71d28e9ac1bc4e5d","added-peer-id":"71d28e9ac1bc4e5d","added-peer-peer-urls":["https://199.204.45.205:2380"]} {"level":"info","ts":"2026-04-30T05:55:07.052237Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.205:2380"} {"level":"info","ts":"2026-04-30T05:55:07.05226Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.205:2380"} {"level":"info","ts":"2026-04-30T05:55:07.052226Z","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-04-30T05:55:07.052586Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"71d28e9ac1bc4e5d","initial-advertise-peer-urls":["https://199.204.45.205:2380"],"listen-peer-urls":["https://199.204.45.205:2380"],"advertise-client-urls":["https://199.204.45.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-30T05:55:07.052639Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-30T05:55:07.924583Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d is starting a new election at term 1"} {"level":"info","ts":"2026-04-30T05:55:07.924643Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became pre-candidate at term 1"} {"level":"info","ts":"2026-04-30T05:55:07.924694Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d received MsgPreVoteResp from 71d28e9ac1bc4e5d at term 1"} {"level":"info","ts":"2026-04-30T05:55:07.924714Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became candidate at term 2"} {"level":"info","ts":"2026-04-30T05:55:07.924731Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d received MsgVoteResp from 71d28e9ac1bc4e5d at term 2"} {"level":"info","ts":"2026-04-30T05:55:07.924747Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became leader at term 2"} {"level":"info","ts":"2026-04-30T05:55:07.924761Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 71d28e9ac1bc4e5d elected leader 71d28e9ac1bc4e5d at term 2"} {"level":"info","ts":"2026-04-30T05:55:07.926139Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-30T05:55:07.927109Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"71d28e9ac1bc4e5d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.205:2379]}","request-path":"/0/members/71d28e9ac1bc4e5d/attributes","cluster-id":"4a4ae660c7a9a6a7","publish-timeout":"7s"} {"level":"info","ts":"2026-04-30T05:55:07.927112Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-30T05:55:07.927134Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-30T05:55:07.927439Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-30T05:55:07.92751Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-30T05:55:07.928738Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-30T05:55:07.930334Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.205:2379"} {"level":"info","ts":"2026-04-30T05:55:07.943691Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4a4ae660c7a9a6a7","local-member-id":"71d28e9ac1bc4e5d","cluster-version":"3.5"} {"level":"info","ts":"2026-04-30T05:55:07.943864Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-30T05:55:07.94392Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-04-30T05:55:12.7614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.739965ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-30T05:55:12.761611Z","caller":"traceutil/trace.go:171","msg":"trace[2141026334] transaction","detail":"{read_only:false; response_revision:234; number_of_response:1; }","duration":"204.828294ms","start":"2026-04-30T05:55:12.556733Z","end":"2026-04-30T05:55:12.761561Z","steps":["trace[2141026334] 'process raft request' (duration: 38.155855ms)","trace[2141026334] 'compare' (duration: 165.550851ms)"],"step_count":2} {"level":"info","ts":"2026-04-30T05:55:12.793363Z","caller":"traceutil/trace.go:171","msg":"trace[354535873] transaction","detail":"{read_only:false; number_of_response:0; response_revision:234; }","duration":"236.398408ms","start":"2026-04-30T05:55:12.556931Z","end":"2026-04-30T05:55:12.79333Z","steps":["trace[354535873] 'process raft request' (duration: 236.116611ms)"],"step_count":1} {"level":"info","ts":"2026-04-30T05:55:12.793426Z","caller":"traceutil/trace.go:171","msg":"trace[247071444] transaction","detail":"{read_only:false; response_revision:235; number_of_response:1; }","duration":"206.940546ms","start":"2026-04-30T05:55:12.586459Z","end":"2026-04-30T05:55:12.793399Z","steps":["trace[247071444] 'process raft request' (duration: 206.68518ms)"],"step_count":1} {"level":"info","ts":"2026-04-30T05:55:12.793506Z","caller":"traceutil/trace.go:171","msg":"trace[332310261] transaction","detail":"{read_only:false; response_revision:236; number_of_response:1; }","duration":"206.240109ms","start":"2026-04-30T05:55:12.587211Z","end":"2026-04-30T05:55:12.793451Z","steps":["trace[332310261] 'process raft request' (duration: 206.093336ms)"],"step_count":1} {"level":"info","ts":"2026-04-30T05:55:12.793565Z","caller":"traceutil/trace.go:171","msg":"trace[1726784831] transaction","detail":"{read_only:false; response_revision:237; number_of_response:1; }","duration":"205.544251ms","start":"2026-04-30T05:55:12.587974Z","end":"2026-04-30T05:55:12.793518Z","steps":["trace[1726784831] 'process raft request' (duration: 205.367067ms)"],"step_count":1} {"level":"info","ts":"2026-04-30T05:55:12.793592Z","caller":"traceutil/trace.go:171","msg":"trace[1863056076] transaction","detail":"{read_only:false; number_of_response:0; response_revision:235; }","duration":"206.457694ms","start":"2026-04-30T05:55:12.58707Z","end":"2026-04-30T05:55:12.793527Z","steps":["trace[1863056076] 'process raft request' (duration: 206.210068ms)"],"step_count":1} {"level":"info","ts":"2026-04-30T05:55:12.793727Z","caller":"traceutil/trace.go:171","msg":"trace[87717832] transaction","detail":"{read_only:false; number_of_response:0; response_revision:237; }","duration":"205.637764ms","start":"2026-04-30T05:55:12.588078Z","end":"2026-04-30T05:55:12.793716Z","steps":["trace[87717832] 'process raft request' (duration: 205.289955ms)"],"step_count":1} {"level":"warn","ts":"2026-04-30T05:55:13.175208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.353572ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-30T05:55:13.17537Z","caller":"traceutil/trace.go:171","msg":"trace[1554224344] linearizableReadLoop","detail":"{readStateIndex:248; appliedIndex:246; }","duration":"380.07821ms","start":"2026-04-30T05:55:12.795275Z","end":"2026-04-30T05:55:13.175354Z","steps":["trace[1554224344] 'read index received' (duration: 164.448622ms)","trace[1554224344] 'applied index is now lower than readState.Index' (duration: 215.628668ms)"],"step_count":2} {"level":"info","ts":"2026-04-30T05:55:13.175462Z","caller":"traceutil/trace.go:171","msg":"trace[909619787] transaction","detail":"{read_only:false; response_revision:239; number_of_response:1; }","duration":"408.718133ms","start":"2026-04-30T05:55:12.766715Z","end":"2026-04-30T05:55:13.175433Z","steps":["trace[909619787] 'process raft request' (duration: 408.58743ms)"],"step_count":1} {"level":"warn","ts":"2026-04-30T05:55:13.175528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.300266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:3466"} {"level":"info","ts":"2026-04-30T05:55:13.175566Z","caller":"traceutil/trace.go:171","msg":"trace[435957901] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:239; }","duration":"380.371948ms","start":"2026-04-30T05:55:12.795182Z","end":"2026-04-30T05:55:13.175554Z","steps":["trace[435957901] 'agreement among raft nodes before linearized reading' (duration: 380.256255ms)"],"step_count":1} {"level":"warn","ts":"2026-04-30T05:55:13.175605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-30T05:55:12.795169Z","time spent":"380.427489ms","remote":"127.0.0.1:43188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":3488,"request content":"key:\"/registry/pods/kube-system/kube-vip-instance\" "} {"level":"warn","ts":"2026-04-30T05:55:13.175688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.365047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:5897"} {"level":"info","ts":"2026-04-30T05:55:13.175783Z","caller":"traceutil/trace.go:171","msg":"trace[169969932] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:239; }","duration":"380.507292ms","start":"2026-04-30T05:55:12.795255Z","end":"2026-04-30T05:55:13.175763Z","steps":["trace[169969932] 'agreement among raft nodes before linearized reading' (duration: 380.315606ms)"],"step_count":1} {"level":"info","ts":"2026-04-30T05:55:13.17581Z","caller":"traceutil/trace.go:171","msg":"trace[1178086821] transaction","detail":"{read_only:false; response_revision:238; number_of_response:1; }","duration":"526.971795ms","start":"2026-04-30T05:55:12.648819Z","end":"2026-04-30T05:55:13.175791Z","steps":["trace[1178086821] 'process raft request' (duration: 310.962857ms)","trace[1178086821] 'compare' (duration: 215.195247ms)"],"step_count":2} {"level":"warn","ts":"2026-04-30T05:55:13.175832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-30T05:55:12.795233Z","time spent":"380.590383ms","remote":"127.0.0.1:43188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":5919,"request content":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" "} {"level":"warn","ts":"2026-04-30T05:55:13.175872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-30T05:55:12.648782Z","time spent":"527.064527ms","remote":"127.0.0.1:43108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1934,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-30T05:55:13.176037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-30T05:55:12.766688Z","time spent":"408.846666ms","remote":"127.0.0.1:43070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":638,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-30T05:55:13.176028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.82019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4017"} {"level":"info","ts":"2026-04-30T05:55:13.176126Z","caller":"traceutil/trace.go:171","msg":"trace[1388130079] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:239; }","duration":"380.892641ms","start":"2026-04-30T05:55:12.795184Z","end":"2026-04-30T05:55:13.176077Z","steps":["trace[1388130079] 'agreement among raft nodes before linearized reading' (duration: 380.651996ms)"],"step_count":1} {"level":"warn","ts":"2026-04-30T05:55:13.176451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-30T05:55:12.795126Z","time spent":"381.033404ms","remote":"127.0.0.1:43178","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4039,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-04-30T05:55:13.480579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.474104ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-30T05:55:13.480937Z","caller":"traceutil/trace.go:171","msg":"trace[1447963939] transaction","detail":"{read_only:false; response_revision:241; number_of_response:1; }","duration":"297.126033ms","start":"2026-04-30T05:55:13.183788Z","end":"2026-04-30T05:55:13.480914Z","steps":["trace[1447963939] 'process raft request' (duration: 296.898548ms)"],"step_count":1} {"level":"info","ts":"2026-04-30T05:55:13.481022Z","caller":"traceutil/trace.go:171","msg":"trace[1098532269] transaction","detail":"{read_only:false; response_revision:240; number_of_response:1; }","duration":"300.747851ms","start":"2026-04-30T05:55:13.180242Z","end":"2026-04-30T05:55:13.48099Z","steps":["trace[1098532269] 'process raft request' (duration: 151.792115ms)","trace[1098532269] 'compare' (duration: 148.108726ms)"],"step_count":2} {"level":"info","ts":"2026-04-30T05:55:13.481064Z","caller":"traceutil/trace.go:171","msg":"trace[1797123510] linearizableReadLoop","detail":"{readStateIndex:249; appliedIndex:248; }","duration":"299.981472ms","start":"2026-04-30T05:55:13.181057Z","end":"2026-04-30T05:55:13.481038Z","steps":["trace[1797123510] 'read index received' (duration: 151.079038ms)","trace[1797123510] 'applied index is now lower than readState.Index' (duration: 148.840783ms)"],"step_count":2} {"level":"warn","ts":"2026-04-30T05:55:13.481177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-30T05:55:13.180217Z","time spent":"300.881155ms","remote":"127.0.0.1:43070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":636,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-30T05:55:13.48121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.139597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4017"} {"level":"info","ts":"2026-04-30T05:55:13.481269Z","caller":"traceutil/trace.go:171","msg":"trace[1711235159] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:241; }","duration":"300.224949ms","start":"2026-04-30T05:55:13.181029Z","end":"2026-04-30T05:55:13.481253Z","steps":["trace[1711235159] 'agreement among raft nodes before linearized reading' (duration: 300.098556ms)"],"step_count":1} {"level":"warn","ts":"2026-04-30T05:55:13.481311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-30T05:55:13.181016Z","time spent":"300.287181ms","remote":"127.0.0.1:43178","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4039,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-04-30T05:55:13.481394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.911826ms","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-04-30T05:55:13.481466Z","caller":"traceutil/trace.go:171","msg":"trace[1863957636] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:241; }","duration":"209.035019ms","start":"2026-04-30T05:55:13.27242Z","end":"2026-04-30T05:55:13.481455Z","steps":["trace[1863957636] 'agreement among raft nodes before linearized reading' (duration: 208.853025ms)"],"step_count":1} {"level":"warn","ts":"2026-04-30T05:55:13.481612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.739588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-30T05:55:13.481795Z","caller":"traceutil/trace.go:171","msg":"trace[1913151893] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:241; }","duration":"145.942422ms","start":"2026-04-30T05:55:13.335798Z","end":"2026-04-30T05:55:13.481741Z","steps":["trace[1913151893] 'agreement among raft nodes before linearized reading' (duration: 145.578953ms)"],"step_count":1} {"level":"info","ts":"2026-04-30T05:55:42.884079Z","caller":"traceutil/trace.go:171","msg":"trace[464281113] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"145.830339ms","start":"2026-04-30T05:55:42.738224Z","end":"2026-04-30T05:55:42.884054Z","steps":["trace[464281113] 'process raft request' (duration: 144.062534ms)"],"step_count":1} {"level":"warn","ts":"2026-04-30T05:55:44.932988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.288628ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-30T05:55:44.933119Z","caller":"traceutil/trace.go:171","msg":"trace[1122872388] linearizableReadLoop","detail":"{readStateIndex:601; appliedIndex:600; }","duration":"342.340988ms","start":"2026-04-30T05:55:44.590757Z","end":"2026-04-30T05:55:44.933098Z","steps":["trace[1122872388] 'read index received' (duration: 220.927217ms)","trace[1122872388] 'applied index is now lower than readState.Index' (duration: 121.412021ms)"],"step_count":2} {"level":"warn","ts":"2026-04-30T05:55:44.933329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.560912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-vskxv\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-30T05:55:44.933375Z","caller":"traceutil/trace.go:171","msg":"trace[1759354793] range","detail":"{range_begin:/registry/pods/kube-system/cilium-vskxv; range_end:; response_count:1; response_revision:581; }","duration":"342.649114ms","start":"2026-04-30T05:55:44.59071Z","end":"2026-04-30T05:55:44.933359Z","steps":["trace[1759354793] 'agreement among raft nodes before linearized reading' (duration: 342.44344ms)"],"step_count":1} {"level":"info","ts":"2026-04-30T05:55:44.933429Z","caller":"traceutil/trace.go:171","msg":"trace[636907590] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"430.515519ms","start":"2026-04-30T05:55:44.50285Z","end":"2026-04-30T05:55:44.933365Z","steps":["trace[636907590] 'process raft request' (duration: 308.764822ms)","trace[636907590] 'compare' (duration: 121.115405ms)"],"step_count":2} {"level":"warn","ts":"2026-04-30T05:55:44.933488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-30T05:55:44.590689Z","time spent":"342.783047ms","remote":"127.0.0.1:43188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-vskxv\" "} {"level":"warn","ts":"2026-04-30T05:55:44.933594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-30T05:55:44.502825Z","time spent":"430.704633ms","remote":"127.0.0.1:43514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-30T05:56:00.557256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.900576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-30T05:56:00.557335Z","caller":"traceutil/trace.go:171","msg":"trace[1827649372] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:743; }","duration":"111.035748ms","start":"2026-04-30T05:56:00.446282Z","end":"2026-04-30T05:56:00.557318Z","steps":["trace[1827649372] 'range keys from in-memory index tree' (duration: 110.710702ms)"],"step_count":1}