{"level":"warn","ts":"2026-10-14T02:15:29.120319Z","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-14T02:15:29.120629Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.80: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.80:2380","--initial-cluster=instance=https://162.253.55.80:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.80:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.80: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-14T02:15:29.120795Z","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-14T02:15:29.120888Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.80:2380"]} {"level":"info","ts":"2026-10-14T02:15:29.120986Z","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-14T02:15:29.121972Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.80:2379"]} {"level":"info","ts":"2026-10-14T02:15:29.122873Z","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.80:2380"],"listen-peer-urls":["https://162.253.55.80:2380"],"advertise-client-urls":["https://162.253.55.80:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.80:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.80: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-14T02:15:29.130776Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.614433ms"} {"level":"info","ts":"2026-10-14T02:15:29.140027Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a87e3d9cf178847b","cluster-id":"df2e96c7e71d56b9"} {"level":"info","ts":"2026-10-14T02:15:29.140174Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a87e3d9cf178847b switched to configuration voters=()"} {"level":"info","ts":"2026-10-14T02:15:29.140234Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a87e3d9cf178847b became follower at term 0"} {"level":"info","ts":"2026-10-14T02:15:29.140261Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a87e3d9cf178847b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-14T02:15:29.140283Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a87e3d9cf178847b became follower at term 1"} {"level":"info","ts":"2026-10-14T02:15:29.140366Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a87e3d9cf178847b switched to configuration voters=(12141209389712835707)"} {"level":"warn","ts":"2026-10-14T02:15:29.156731Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-14T02:15:29.160653Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-14T02:15:29.162999Z","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-14T02:15:29.166107Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a87e3d9cf178847b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-14T02:15:29.166449Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a87e3d9cf178847b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-14T02:15:29.16656Z","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-14T02:15:29.166634Z","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-14T02:15:29.166651Z","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-14T02:15:29.1679Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a87e3d9cf178847b switched to configuration voters=(12141209389712835707)"} {"level":"info","ts":"2026-10-14T02:15:29.169401Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"df2e96c7e71d56b9","local-member-id":"a87e3d9cf178847b","added-peer-id":"a87e3d9cf178847b","added-peer-peer-urls":["https://162.253.55.80:2380"]} {"level":"info","ts":"2026-10-14T02:15:29.170632Z","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-14T02:15:29.170721Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.80:2380"} {"level":"info","ts":"2026-10-14T02:15:29.170753Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.80:2380"} {"level":"info","ts":"2026-10-14T02:15:29.170964Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a87e3d9cf178847b","initial-advertise-peer-urls":["https://162.253.55.80:2380"],"listen-peer-urls":["https://162.253.55.80:2380"],"advertise-client-urls":["https://162.253.55.80:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.80:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-14T02:15:29.171008Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-14T02:15:29.942349Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a87e3d9cf178847b is starting a new election at term 1"} {"level":"info","ts":"2026-10-14T02:15:29.942416Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a87e3d9cf178847b became pre-candidate at term 1"} {"level":"info","ts":"2026-10-14T02:15:29.942459Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a87e3d9cf178847b received MsgPreVoteResp from a87e3d9cf178847b at term 1"} {"level":"info","ts":"2026-10-14T02:15:29.942482Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a87e3d9cf178847b became candidate at term 2"} {"level":"info","ts":"2026-10-14T02:15:29.942493Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a87e3d9cf178847b received MsgVoteResp from a87e3d9cf178847b at term 2"} {"level":"info","ts":"2026-10-14T02:15:29.942513Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a87e3d9cf178847b became leader at term 2"} {"level":"info","ts":"2026-10-14T02:15:29.942534Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a87e3d9cf178847b elected leader a87e3d9cf178847b at term 2"} {"level":"info","ts":"2026-10-14T02:15:29.944316Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-14T02:15:29.945337Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-14T02:15:29.945337Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a87e3d9cf178847b","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.80:2379]}","request-path":"/0/members/a87e3d9cf178847b/attributes","cluster-id":"df2e96c7e71d56b9","publish-timeout":"7s"} {"level":"info","ts":"2026-10-14T02:15:29.945406Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-14T02:15:29.945649Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-14T02:15:29.945673Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-14T02:15:29.948746Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.80:2379"} {"level":"info","ts":"2026-10-14T02:15:29.949023Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-14T02:15:29.974337Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"df2e96c7e71d56b9","local-member-id":"a87e3d9cf178847b","cluster-version":"3.5"} {"level":"info","ts":"2026-10-14T02:15:29.974539Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-14T02:15:29.974575Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-14T02:15:48.712103Z","caller":"traceutil/trace.go:171","msg":"trace[823591225] transaction","detail":"{read_only:false; response_revision:375; number_of_response:1; }","duration":"460.137333ms","start":"2026-10-14T02:15:48.251934Z","end":"2026-10-14T02:15:48.712071Z","steps":["trace[823591225] 'process raft request' (duration: 459.285673ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T02:15:48.712701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T02:15:48.251891Z","time spent":"460.308077ms","remote":"127.0.0.1:58472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4307,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T02:15:49.052459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.817457ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"warn","ts":"2026-10-14T02:15:49.053088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.596176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4322"} {"level":"info","ts":"2026-10-14T02:15:49.053032Z","caller":"traceutil/trace.go:171","msg":"trace[54751455] linearizableReadLoop","detail":"{readStateIndex:391; appliedIndex:390; }","duration":"335.208487ms","start":"2026-10-14T02:15:48.71745Z","end":"2026-10-14T02:15:49.052659Z","steps":["trace[54751455] 'read index received' (duration: 2.785486ms)","trace[54751455] 'applied index is now lower than readState.Index' (duration: 332.419971ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T02:15:49.053146Z","caller":"traceutil/trace.go:171","msg":"trace[611267252] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:375; }","duration":"335.706569ms","start":"2026-10-14T02:15:48.717415Z","end":"2026-10-14T02:15:49.053122Z","steps":["trace[611267252] 'agreement among raft nodes before linearized reading' (duration: 335.571566ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T02:15:49.053203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T02:15:48.717394Z","time spent":"335.79894ms","remote":"127.0.0.1:58472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":4346,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" "} {"level":"warn","ts":"2026-10-14T02:15:49.054393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.675153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T02:15:49.054494Z","caller":"traceutil/trace.go:171","msg":"trace[746442651] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:375; }","duration":"210.826637ms","start":"2026-10-14T02:15:48.843642Z","end":"2026-10-14T02:15:49.054468Z","steps":["trace[746442651] 'agreement among raft nodes before linearized reading' (duration: 210.656623ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T02:16:16.988807Z","caller":"traceutil/trace.go:171","msg":"trace[16311096] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"179.864217ms","start":"2026-10-14T02:16:16.808892Z","end":"2026-10-14T02:16:16.988756Z","steps":["trace[16311096] 'process raft request' (duration: 179.728504ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T02:16:17.134272Z","caller":"traceutil/trace.go:171","msg":"trace[2011460499] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"318.754414ms","start":"2026-10-14T02:16:16.815454Z","end":"2026-10-14T02:16:17.134208Z","steps":["trace[2011460499] 'process raft request' (duration: 318.371996ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T02:16:17.134329Z","caller":"traceutil/trace.go:171","msg":"trace[779103130] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"312.945158ms","start":"2026-10-14T02:16:16.821344Z","end":"2026-10-14T02:16:17.134289Z","steps":["trace[779103130] 'process raft request' (duration: 312.740003ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T02:16:17.134494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T02:16:16.821309Z","time spent":"313.109022ms","remote":"127.0.0.1:58306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-14T02:16:17.134497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T02:16:16.815422Z","time spent":"318.947739ms","remote":"127.0.0.1:58306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-14T02:16:17.134588Z","caller":"traceutil/trace.go:171","msg":"trace[1548674305] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"311.937525ms","start":"2026-10-14T02:16:16.822558Z","end":"2026-10-14T02:16:17.134495Z","steps":["trace[1548674305] 'process raft request' (duration: 311.620178ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T02:16:17.134848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T02:16:16.822544Z","time spent":"312.199462ms","remote":"127.0.0.1:58306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-14T02:16:17.134931Z","caller":"traceutil/trace.go:171","msg":"trace[1449345769] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"308.743437ms","start":"2026-10-14T02:16:16.826101Z","end":"2026-10-14T02:16:17.134844Z","steps":["trace[1449345769] 'process raft request' (duration: 308.185675ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T02:16:17.135307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T02:16:16.826088Z","time spent":"309.027753ms","remote":"127.0.0.1:58306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-14T02:16:17.136018Z","caller":"traceutil/trace.go:171","msg":"trace[507311553] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"303.934631ms","start":"2026-10-14T02:16:16.832068Z","end":"2026-10-14T02:16:17.136003Z","steps":["trace[507311553] 'process raft request' (duration: 303.478071ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T02:16:17.136173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T02:16:16.832061Z","time spent":"303.998403ms","remote":"127.0.0.1:58306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-14T02:16:17.136253Z","caller":"traceutil/trace.go:171","msg":"trace[125800289] linearizableReadLoop","detail":"{readStateIndex:536; appliedIndex:527; }","duration":"294.368883ms","start":"2026-10-14T02:16:16.841815Z","end":"2026-10-14T02:16:17.136184Z","steps":["trace[125800289] 'read index received' (duration: 146.897479ms)","trace[125800289] 'applied index is now lower than readState.Index' (duration: 147.469154ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T02:16:17.13639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.558127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T02:16:17.136445Z","caller":"traceutil/trace.go:171","msg":"trace[310183616] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"304.432872ms","start":"2026-10-14T02:16:16.831996Z","end":"2026-10-14T02:16:17.136429Z","steps":["trace[310183616] 'process raft request' (duration: 302.381528ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T02:16:17.136461Z","caller":"traceutil/trace.go:171","msg":"trace[1613194509] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:516; }","duration":"294.691161ms","start":"2026-10-14T02:16:16.841757Z","end":"2026-10-14T02:16:17.136448Z","steps":["trace[1613194509] 'agreement among raft nodes before linearized reading' (duration: 294.563408ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T02:16:17.136703Z","caller":"traceutil/trace.go:171","msg":"trace[133557895] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"297.563703ms","start":"2026-10-14T02:16:16.839128Z","end":"2026-10-14T02:16:17.136692Z","steps":["trace[133557895] 'process raft request' (duration: 296.552471ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T02:16:17.136701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T02:16:16.831981Z","time spent":"304.505064ms","remote":"127.0.0.1:58306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-14T02:16:17.13676Z","caller":"traceutil/trace.go:171","msg":"trace[398049779] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"295.870976ms","start":"2026-10-14T02:16:16.840875Z","end":"2026-10-14T02:16:17.136746Z","steps":["trace[398049779] 'process raft request' (duration: 295.032838ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T02:16:17.136853Z","caller":"traceutil/trace.go:171","msg":"trace[12345977] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"297.626494ms","start":"2026-10-14T02:16:16.83921Z","end":"2026-10-14T02:16:17.136837Z","steps":["trace[12345977] 'process raft request' (duration: 296.588522ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T02:16:17.137005Z","caller":"traceutil/trace.go:171","msg":"trace[68132666] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"279.102371ms","start":"2026-10-14T02:16:16.857891Z","end":"2026-10-14T02:16:17.136994Z","steps":["trace[68132666] 'process raft request' (duration: 278.13742ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T02:16:17.192536Z","caller":"traceutil/trace.go:171","msg":"trace[401657737] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"195.753452ms","start":"2026-10-14T02:16:16.996749Z","end":"2026-10-14T02:16:17.192503Z","steps":["trace[401657737] 'process raft request' (duration: 195.557438ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T02:16:17.192747Z","caller":"traceutil/trace.go:171","msg":"trace[567817044] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"196.09982ms","start":"2026-10-14T02:16:16.996634Z","end":"2026-10-14T02:16:17.192734Z","steps":["trace[567817044] 'process raft request' (duration: 195.489577ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T02:16:17.192895Z","caller":"traceutil/trace.go:171","msg":"trace[545025432] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"192.824048ms","start":"2026-10-14T02:16:17.000058Z","end":"2026-10-14T02:16:17.192882Z","steps":["trace[545025432] 'process raft request' (duration: 192.295107ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T02:16:17.193003Z","caller":"traceutil/trace.go:171","msg":"trace[650649920] transaction","detail":"{read_only:false; number_of_response:1; response_revision:519; }","duration":"192.578733ms","start":"2026-10-14T02:16:17.000399Z","end":"2026-10-14T02:16:17.192978Z","steps":["trace[650649920] 'process raft request' (duration: 192.099223ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T02:16:17.193148Z","caller":"traceutil/trace.go:171","msg":"trace[1175192479] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"184.724292ms","start":"2026-10-14T02:16:17.008413Z","end":"2026-10-14T02:16:17.193138Z","steps":["trace[1175192479] 'process raft request' (duration: 184.246641ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T02:16:23.384013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.215361ms","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-10-14T02:16:23.384215Z","caller":"traceutil/trace.go:171","msg":"trace[1755844408] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:610; }","duration":"101.472557ms","start":"2026-10-14T02:16:23.282689Z","end":"2026-10-14T02:16:23.384161Z","steps":["trace[1755844408] 'range keys from in-memory index tree' (duration: 100.882625ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T02:16:23.384198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.818441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-10-14T02:16:23.384293Z","caller":"traceutil/trace.go:171","msg":"trace[911093499] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:610; }","duration":"106.966935ms","start":"2026-10-14T02:16:23.277308Z","end":"2026-10-14T02:16:23.384275Z","steps":["trace[911093499] 'range keys from in-memory index tree' (duration: 106.675059ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T02:16:23.937969Z","caller":"traceutil/trace.go:171","msg":"trace[1694153844] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"439.721581ms","start":"2026-10-14T02:16:23.498205Z","end":"2026-10-14T02:16:23.937926Z","steps":["trace[1694153844] 'process raft request' (duration: 439.381353ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T02:16:23.938207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T02:16:23.498168Z","time spent":"439.909275ms","remote":"127.0.0.1:58472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T02:16:24.066077Z","caller":"traceutil/trace.go:171","msg":"trace[942813530] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:640; }","duration":"222.219022ms","start":"2026-10-14T02:16:23.843795Z","end":"2026-10-14T02:16:24.066014Z","steps":["trace[942813530] 'read index received' (duration: 93.740062ms)","trace[942813530] 'applied index is now lower than readState.Index' (duration: 128.47769ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T02:16:24.066111Z","caller":"traceutil/trace.go:171","msg":"trace[1520267469] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"419.23142ms","start":"2026-10-14T02:16:23.646858Z","end":"2026-10-14T02:16:24.066089Z","steps":["trace[1520267469] 'process raft request' (duration: 418.473964ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T02:16:24.066286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.406396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T02:16:24.066366Z","caller":"traceutil/trace.go:171","msg":"trace[877014673] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:615; }","duration":"222.60025ms","start":"2026-10-14T02:16:23.843722Z","end":"2026-10-14T02:16:24.066322Z","steps":["trace[877014673] 'agreement among raft nodes before linearized reading' (duration: 222.435606ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T02:16:24.066373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T02:16:23.646818Z","time spent":"419.406544ms","remote":"127.0.0.1:58352","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T02:16:24.0666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.447553ms","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-14T02:16:24.066664Z","caller":"traceutil/trace.go:171","msg":"trace[351072703] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:615; }","duration":"175.648938ms","start":"2026-10-14T02:16:23.890999Z","end":"2026-10-14T02:16:24.066648Z","steps":["trace[351072703] 'agreement among raft nodes before linearized reading' (duration: 175.226009ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T02:16:40.011377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.625629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T02:16:40.011485Z","caller":"traceutil/trace.go:171","msg":"trace[1420274246] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:781; }","duration":"202.811482ms","start":"2026-10-14T02:16:39.808652Z","end":"2026-10-14T02:16:40.011463Z","steps":["trace[1420274246] 'range keys from in-memory index tree' (duration: 202.492546ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T02:16:40.011591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.560357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-14T02:16:40.01161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.548217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T02:16:40.011698Z","caller":"traceutil/trace.go:171","msg":"trace[1053378434] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:781; }","duration":"201.667079ms","start":"2026-10-14T02:16:39.809994Z","end":"2026-10-14T02:16:40.011661Z","steps":["trace[1053378434] 'range keys from in-memory index tree' (duration: 201.490616ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T02:16:40.011708Z","caller":"traceutil/trace.go:171","msg":"trace[355346823] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:781; }","duration":"245.68491ms","start":"2026-10-14T02:16:39.766009Z","end":"2026-10-14T02:16:40.011694Z","steps":["trace[355346823] 'range keys from in-memory index tree' (duration: 245.479286ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T02:16:40.011842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.392257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T02:16:40.012024Z","caller":"traceutil/trace.go:171","msg":"trace[1520876906] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:781; }","duration":"293.603481ms","start":"2026-10-14T02:16:39.718359Z","end":"2026-10-14T02:16:40.011962Z","steps":["trace[1520876906] 'range keys from in-memory index tree' (duration: 293.193102ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T02:16:40.012065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.607231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T02:16:40.01215Z","caller":"traceutil/trace.go:171","msg":"trace[270509987] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:781; }","duration":"293.777145ms","start":"2026-10-14T02:16:39.718359Z","end":"2026-10-14T02:16:40.012136Z","steps":["trace[270509987] 'range keys from in-memory index tree' (duration: 293.439407ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T02:16:40.012267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.836606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T02:16:40.012298Z","caller":"traceutil/trace.go:171","msg":"trace[897671483] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:781; }","duration":"293.925148ms","start":"2026-10-14T02:16:39.718365Z","end":"2026-10-14T02:16:40.01229Z","steps":["trace[897671483] 'count revisions from in-memory index tree' (duration: 293.719773ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T02:16:40.01247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.13119ms","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-10-14T02:16:40.012494Z","caller":"traceutil/trace.go:171","msg":"trace[1346362912] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:781; }","duration":"246.270712ms","start":"2026-10-14T02:16:39.766217Z","end":"2026-10-14T02:16:40.012487Z","steps":["trace[1346362912] 'count revisions from in-memory index tree' (duration: 245.994486ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T02:16:40.012803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.977637ms","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-10-14T02:16:40.012893Z","caller":"traceutil/trace.go:171","msg":"trace[1659928548] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:781; }","duration":"204.17175ms","start":"2026-10-14T02:16:39.808699Z","end":"2026-10-14T02:16:40.012871Z","steps":["trace[1659928548] 'count revisions from in-memory index tree' (duration: 203.873354ms)"],"step_count":1}