{"level":"warn","ts":"2026-09-19T01:47:29.928348Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-19T01:47:29.928483Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.124: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.124:2380","--initial-cluster=instance=https://162.253.55.124:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.124:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.124:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-09-19T01:47:29.928586Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-19T01:47:29.928613Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.124:2380"]} {"level":"info","ts":"2026-09-19T01:47:29.928657Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-19T01:47:29.929889Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.124:2379"]} {"level":"info","ts":"2026-09-19T01:47:29.930065Z","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.124:2380"],"listen-peer-urls":["https://162.253.55.124:2380"],"advertise-client-urls":["https://162.253.55.124:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.124:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.124:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-09-19T01:47:30.034146Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"99.190179ms"} {"level":"info","ts":"2026-09-19T01:47:30.283888Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"9ad1df4dc3f3835d","cluster-id":"5f6d28152804218"} {"level":"info","ts":"2026-09-19T01:47:30.28402Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ad1df4dc3f3835d switched to configuration voters=()"} {"level":"info","ts":"2026-09-19T01:47:30.28405Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ad1df4dc3f3835d became follower at term 0"} {"level":"info","ts":"2026-09-19T01:47:30.284069Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 9ad1df4dc3f3835d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-19T01:47:30.284081Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ad1df4dc3f3835d became follower at term 1"} {"level":"info","ts":"2026-09-19T01:47:30.28414Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ad1df4dc3f3835d switched to configuration voters=(11155943277066421085)"} {"level":"warn","ts":"2026-09-19T01:47:30.288739Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-19T01:47:30.29107Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-19T01:47:30.292561Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-09-19T01:47:30.295782Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"9ad1df4dc3f3835d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-19T01:47:30.296701Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"9ad1df4dc3f3835d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-19T01:47:30.296758Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-19T01:47:30.296963Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-19T01:47:30.297046Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-19T01:47:30.298317Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ad1df4dc3f3835d switched to configuration voters=(11155943277066421085)"} {"level":"info","ts":"2026-09-19T01:47:30.298541Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5f6d28152804218","local-member-id":"9ad1df4dc3f3835d","added-peer-id":"9ad1df4dc3f3835d","added-peer-peer-urls":["https://162.253.55.124:2380"]} {"level":"info","ts":"2026-09-19T01:47:30.304196Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-19T01:47:30.304413Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.124:2380"} {"level":"info","ts":"2026-09-19T01:47:30.304497Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.124:2380"} {"level":"info","ts":"2026-09-19T01:47:30.304657Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"9ad1df4dc3f3835d","initial-advertise-peer-urls":["https://162.253.55.124:2380"],"listen-peer-urls":["https://162.253.55.124:2380"],"advertise-client-urls":["https://162.253.55.124:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.124:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-19T01:47:30.304741Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-19T01:47:30.386077Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ad1df4dc3f3835d is starting a new election at term 1"} {"level":"info","ts":"2026-09-19T01:47:30.386175Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ad1df4dc3f3835d became pre-candidate at term 1"} {"level":"info","ts":"2026-09-19T01:47:30.386198Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ad1df4dc3f3835d received MsgPreVoteResp from 9ad1df4dc3f3835d at term 1"} {"level":"info","ts":"2026-09-19T01:47:30.3863Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ad1df4dc3f3835d became candidate at term 2"} {"level":"info","ts":"2026-09-19T01:47:30.386321Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ad1df4dc3f3835d received MsgVoteResp from 9ad1df4dc3f3835d at term 2"} {"level":"info","ts":"2026-09-19T01:47:30.386336Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ad1df4dc3f3835d became leader at term 2"} {"level":"info","ts":"2026-09-19T01:47:30.38635Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 9ad1df4dc3f3835d elected leader 9ad1df4dc3f3835d at term 2"} {"level":"info","ts":"2026-09-19T01:47:30.388689Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T01:47:30.390647Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5f6d28152804218","local-member-id":"9ad1df4dc3f3835d","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T01:47:30.390756Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"9ad1df4dc3f3835d","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.124:2379]}","request-path":"/0/members/9ad1df4dc3f3835d/attributes","cluster-id":"5f6d28152804218","publish-timeout":"7s"} {"level":"info","ts":"2026-09-19T01:47:30.391007Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T01:47:30.391047Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T01:47:30.391073Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-19T01:47:30.391057Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-19T01:47:30.391184Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-19T01:47:30.391219Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-19T01:47:30.393767Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-19T01:47:30.396572Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.124:2379"} {"level":"info","ts":"2026-09-19T01:47:36.098971Z","caller":"traceutil/trace.go:171","msg":"trace[655992825] linearizableReadLoop","detail":"{readStateIndex:295; appliedIndex:294; }","duration":"201.143172ms","start":"2026-09-19T01:47:35.897802Z","end":"2026-09-19T01:47:36.098945Z","steps":["trace[655992825] 'read index received' (duration: 201.032128ms)","trace[655992825] 'applied index is now lower than readState.Index' (duration: 109.824µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:47:36.099179Z","caller":"traceutil/trace.go:171","msg":"trace[373279782] transaction","detail":"{read_only:false; response_revision:289; number_of_response:1; }","duration":"204.137931ms","start":"2026-09-19T01:47:35.895019Z","end":"2026-09-19T01:47:36.099157Z","steps":["trace[373279782] 'process raft request' (duration: 203.7859ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:47:36.09922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.40263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T01:47:36.099352Z","caller":"traceutil/trace.go:171","msg":"trace[583007857] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:0; response_revision:289; }","duration":"201.523523ms","start":"2026-09-19T01:47:35.897745Z","end":"2026-09-19T01:47:36.099268Z","steps":["trace[583007857] 'agreement among raft nodes before linearized reading' (duration: 201.406539ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:47:36.332998Z","caller":"traceutil/trace.go:171","msg":"trace[1006189442] transaction","detail":"{read_only:false; response_revision:290; number_of_response:1; }","duration":"341.499938ms","start":"2026-09-19T01:47:35.991476Z","end":"2026-09-19T01:47:36.332976Z","steps":["trace[1006189442] 'process raft request' (duration: 341.400065ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:47:36.333177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.589232ms","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-09-19T01:47:36.333301Z","caller":"traceutil/trace.go:171","msg":"trace[2140479442] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:290; }","duration":"336.753377ms","start":"2026-09-19T01:47:35.99651Z","end":"2026-09-19T01:47:36.333263Z","steps":["trace[2140479442] 'agreement among raft nodes before linearized reading' (duration: 336.53915ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:47:36.333214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.345832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-09-19T01:47:36.333351Z","caller":"traceutil/trace.go:171","msg":"trace[1452393071] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:290; }","duration":"342.525998ms","start":"2026-09-19T01:47:35.990811Z","end":"2026-09-19T01:47:36.333338Z","steps":["trace[1452393071] 'agreement among raft nodes before linearized reading' (duration: 342.320022ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:47:36.333372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:47:35.990792Z","time spent":"342.57535ms","remote":"127.0.0.1:37116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":687,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-09-19T01:47:36.333348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:47:35.9965Z","time spent":"336.83958ms","remote":"127.0.0.1:36998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-node-lease/instance\" "} {"level":"info","ts":"2026-09-19T01:47:36.333051Z","caller":"traceutil/trace.go:171","msg":"trace[285611806] linearizableReadLoop","detail":"{readStateIndex:296; appliedIndex:296; }","duration":"233.910766ms","start":"2026-09-19T01:47:36.099096Z","end":"2026-09-19T01:47:36.333007Z","steps":["trace[285611806] 'read index received' (duration: 233.898586ms)","trace[285611806] 'applied index is now lower than readState.Index' (duration: 9.52µs)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:47:36.334274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:47:35.991458Z","time spent":"341.618582ms","remote":"127.0.0.1:36800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":592,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-19T01:47:36.658703Z","caller":"traceutil/trace.go:171","msg":"trace[366595588] transaction","detail":"{read_only:false; number_of_response:0; response_revision:291; }","duration":"538.25704ms","start":"2026-09-19T01:47:36.120419Z","end":"2026-09-19T01:47:36.658676Z","steps":["trace[366595588] 'process raft request' (duration: 538.107296ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:47:36.658778Z","caller":"traceutil/trace.go:171","msg":"trace[1205746360] transaction","detail":"{read_only:false; response_revision:291; number_of_response:1; }","duration":"555.24468ms","start":"2026-09-19T01:47:36.103492Z","end":"2026-09-19T01:47:36.658736Z","steps":["trace[1205746360] 'process raft request' (duration: 554.87703ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:47:36.6589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:47:36.103469Z","time spent":"555.368654ms","remote":"127.0.0.1:37076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":373,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-19T01:47:36.658885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:47:36.120392Z","time spent":"538.422335ms","remote":"127.0.0.1:36892","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-19T01:47:36.659106Z","caller":"traceutil/trace.go:171","msg":"trace[1017217881] transaction","detail":"{read_only:false; response_revision:294; number_of_response:1; }","duration":"538.326843ms","start":"2026-09-19T01:47:36.120768Z","end":"2026-09-19T01:47:36.659095Z","steps":["trace[1017217881] 'process raft request' (duration: 537.949821ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:47:36.659183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:47:36.120757Z","time spent":"538.395775ms","remote":"127.0.0.1:36892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2905,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-19T01:47:36.658853Z","caller":"traceutil/trace.go:171","msg":"trace[1997261743] linearizableReadLoop","detail":"{readStateIndex:303; appliedIndex:296; }","duration":"325.254738ms","start":"2026-09-19T01:47:36.33358Z","end":"2026-09-19T01:47:36.658835Z","steps":["trace[1997261743] 'read index received' (duration: 324.827956ms)","trace[1997261743] 'applied index is now lower than readState.Index' (duration: 425.902µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:47:36.659355Z","caller":"traceutil/trace.go:171","msg":"trace[1303462706] transaction","detail":"{read_only:false; response_revision:293; number_of_response:1; }","duration":"538.768486ms","start":"2026-09-19T01:47:36.120572Z","end":"2026-09-19T01:47:36.65934Z","steps":["trace[1303462706] 'process raft request' (duration: 538.085386ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:47:36.659362Z","caller":"traceutil/trace.go:171","msg":"trace[1615538360] transaction","detail":"{read_only:false; response_revision:292; number_of_response:1; }","duration":"538.847638ms","start":"2026-09-19T01:47:36.120499Z","end":"2026-09-19T01:47:36.659347Z","steps":["trace[1615538360] 'process raft request' (duration: 538.093176ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:47:36.659433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:47:36.120478Z","time spent":"538.92457ms","remote":"127.0.0.1:36892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3965,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-19T01:47:36.659439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:47:36.120546Z","time spent":"538.848808ms","remote":"127.0.0.1:36892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5498,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-19T01:47:36.659395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.30302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-09-19T01:47:36.659546Z","caller":"traceutil/trace.go:171","msg":"trace[1832097792] transaction","detail":"{read_only:false; number_of_response:0; response_revision:294; }","duration":"469.051809ms","start":"2026-09-19T01:47:36.190484Z","end":"2026-09-19T01:47:36.659535Z","steps":["trace[1832097792] 'process raft request' (duration: 468.319987ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:47:36.659603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:47:36.190455Z","time spent":"469.119061ms","remote":"127.0.0.1:36888","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-19T01:47:36.659614Z","caller":"traceutil/trace.go:171","msg":"trace[1838351072] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:294; }","duration":"557.558917ms","start":"2026-09-19T01:47:36.102037Z","end":"2026-09-19T01:47:36.659596Z","steps":["trace[1838351072] 'agreement among raft nodes before linearized reading' (duration: 557.094094ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:47:36.659803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.820945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-09-19T01:47:36.659824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:47:36.102021Z","time spent":"557.706291ms","remote":"127.0.0.1:36838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-09-19T01:47:36.659812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.479106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-09-19T01:47:36.660114Z","caller":"traceutil/trace.go:171","msg":"trace[1050059130] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:294; }","duration":"370.766335ms","start":"2026-09-19T01:47:36.289307Z","end":"2026-09-19T01:47:36.660074Z","steps":["trace[1050059130] 'agreement among raft nodes before linearized reading' (duration: 370.407564ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:47:36.660154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:47:36.289304Z","time spent":"370.840607ms","remote":"127.0.0.1:36998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-09-19T01:47:36.660214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.090123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4017"} {"level":"info","ts":"2026-09-19T01:47:36.659854Z","caller":"traceutil/trace.go:171","msg":"trace[874369351] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:294; }","duration":"370.898677ms","start":"2026-09-19T01:47:36.288944Z","end":"2026-09-19T01:47:36.659843Z","steps":["trace[874369351] 'agreement among raft nodes before linearized reading' (duration: 370.811335ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:47:36.660275Z","caller":"traceutil/trace.go:171","msg":"trace[1769972565] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:295; }","duration":"324.171866ms","start":"2026-09-19T01:47:36.336087Z","end":"2026-09-19T01:47:36.660259Z","steps":["trace[1769972565] 'agreement among raft nodes before linearized reading' (duration: 324.046852ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:47:36.660351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:47:36.336072Z","time spent":"324.267668ms","remote":"127.0.0.1:36888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4040,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-09-19T01:47:36.660537Z","caller":"traceutil/trace.go:171","msg":"trace[279788417] transaction","detail":"{read_only:false; response_revision:295; number_of_response:1; }","duration":"322.993581ms","start":"2026-09-19T01:47:36.337528Z","end":"2026-09-19T01:47:36.660522Z","steps":["trace[279788417] 'process raft request' (duration: 322.489357ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:47:36.660546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:47:36.288921Z","time spent":"371.506906ms","remote":"127.0.0.1:36998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-19T01:47:36.660617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:47:36.337517Z","time spent":"323.060394ms","remote":"127.0.0.1:36800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":625,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-19T01:47:36.659621Z","caller":"traceutil/trace.go:171","msg":"trace[966628] transaction","detail":"{read_only:false; number_of_response:0; response_revision:294; }","duration":"538.707194ms","start":"2026-09-19T01:47:36.120905Z","end":"2026-09-19T01:47:36.659612Z","steps":["trace[966628] 'process raft request' (duration: 537.862879ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:47:36.660858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.907653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-09-19T01:47:36.660842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:47:36.120872Z","time spent":"539.921329ms","remote":"127.0.0.1:36892","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-19T01:47:36.660907Z","caller":"traceutil/trace.go:171","msg":"trace[1572582442] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:295; }","duration":"255.011396ms","start":"2026-09-19T01:47:36.405884Z","end":"2026-09-19T01:47:36.660895Z","steps":["trace[1572582442] 'agreement among raft nodes before linearized reading' (duration: 254.905353ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:47:36.66118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.552959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-09-19T01:47:36.661246Z","caller":"traceutil/trace.go:171","msg":"trace[1077613023] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:295; }","duration":"323.657421ms","start":"2026-09-19T01:47:36.337562Z","end":"2026-09-19T01:47:36.66122Z","steps":["trace[1077613023] 'agreement among raft nodes before linearized reading' (duration: 323.489116ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:47:36.661332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:47:36.337536Z","time spent":"323.782525ms","remote":"127.0.0.1:37116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":687,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-09-19T01:48:12.027797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.825949ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-19T01:48:12.02792Z","caller":"traceutil/trace.go:171","msg":"trace[1690107436] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"353.900104ms","start":"2026-09-19T01:48:11.674001Z","end":"2026-09-19T01:48:12.027901Z","steps":["trace[1690107436] 'process raft request' (duration: 48.614065ms)","trace[1690107436] 'compare' (duration: 304.639465ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:48:12.027985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:48:11.673973Z","time spent":"353.983636ms","remote":"127.0.0.1:36774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T01:48:12.031014Z","caller":"traceutil/trace.go:171","msg":"trace[123901978] linearizableReadLoop","detail":"{readStateIndex:597; appliedIndex:595; }","duration":"351.829907ms","start":"2026-09-19T01:48:11.679052Z","end":"2026-09-19T01:48:12.030882Z","steps":["trace[123901978] 'read index received' (duration: 43.660233ms)","trace[123901978] 'applied index is now lower than readState.Index' (duration: 308.116923ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:48:12.032444Z","caller":"traceutil/trace.go:171","msg":"trace[1241548668] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"333.397351ms","start":"2026-09-19T01:48:11.699011Z","end":"2026-09-19T01:48:12.032408Z","steps":["trace[1241548668] 'process raft request' (duration: 331.711493ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:48:12.032718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:48:11.698967Z","time spent":"333.561715ms","remote":"127.0.0.1:36800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":763,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-19T01:48:12.032579Z","caller":"traceutil/trace.go:171","msg":"trace[1334500389] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"355.275524ms","start":"2026-09-19T01:48:11.677211Z","end":"2026-09-19T01:48:12.032486Z","steps":["trace[1334500389] 'process raft request' (duration: 352.329848ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:48:12.03301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:48:11.677199Z","time spent":"355.627983ms","remote":"127.0.0.1:36774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-19T01:48:12.033181Z","caller":"traceutil/trace.go:171","msg":"trace[802656834] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"353.638548ms","start":"2026-09-19T01:48:11.679524Z","end":"2026-09-19T01:48:12.033162Z","steps":["trace[802656834] 'process raft request' (duration: 350.877117ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:48:12.033347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:48:11.679494Z","time spent":"353.74186ms","remote":"127.0.0.1:36774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29546,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-19T01:48:12.035014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.086939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-09-19T01:48:12.035169Z","caller":"traceutil/trace.go:171","msg":"trace[1957179197] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:576; }","duration":"150.284493ms","start":"2026-09-19T01:48:11.88484Z","end":"2026-09-19T01:48:12.035124Z","steps":["trace[1957179197] 'agreement among raft nodes before linearized reading' (duration: 149.141298ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:48:12.035486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.41737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-09-19T01:48:12.035564Z","caller":"traceutil/trace.go:171","msg":"trace[448587423] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:576; }","duration":"356.511502ms","start":"2026-09-19T01:48:11.679023Z","end":"2026-09-19T01:48:12.035534Z","steps":["trace[448587423] 'agreement among raft nodes before linearized reading' (duration: 355.599122ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:48:12.035608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:48:11.679011Z","time spent":"356.587343ms","remote":"127.0.0.1:36998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-09-19T01:48:13.228199Z","caller":"traceutil/trace.go:171","msg":"trace[1015659164] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"234.259286ms","start":"2026-09-19T01:48:12.993916Z","end":"2026-09-19T01:48:13.228176Z","steps":["trace[1015659164] 'process raft request' (duration: 233.778124ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:48:13.237118Z","caller":"traceutil/trace.go:171","msg":"trace[1059099761] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"192.720598ms","start":"2026-09-19T01:48:13.044374Z","end":"2026-09-19T01:48:13.237094Z","steps":["trace[1059099761] 'process raft request' (duration: 192.003723ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:48:13.237309Z","caller":"traceutil/trace.go:171","msg":"trace[1581674192] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"110.97841ms","start":"2026-09-19T01:48:13.126298Z","end":"2026-09-19T01:48:13.237276Z","steps":["trace[1581674192] 'process raft request' (duration: 110.356516ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:48:37.118662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.959116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-19T01:48:37.118748Z","caller":"traceutil/trace.go:171","msg":"trace[1373307975] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:821; }","duration":"239.083468ms","start":"2026-09-19T01:48:36.879641Z","end":"2026-09-19T01:48:37.118724Z","steps":["trace[1373307975] 'count revisions from in-memory index tree' (duration: 238.892184ms)"],"step_count":1}