{"level":"warn","ts":"2026-02-19T05:50:51.218632Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-19T05:50:51.218722Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.12: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.12:2380","--initial-cluster=instance=https://162.253.55.12:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.12:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.12: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-02-19T05:50:51.218793Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-19T05:50:51.218808Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.12:2380"]} {"level":"info","ts":"2026-02-19T05:50:51.218829Z","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-02-19T05:50:51.219479Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.12:2379"]} {"level":"info","ts":"2026-02-19T05:50:51.219556Z","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.12:2380"],"listen-peer-urls":["https://162.253.55.12:2380"],"advertise-client-urls":["https://162.253.55.12:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.12:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.12: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-02-19T05:50:51.289634Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"69.869336ms"} {"level":"info","ts":"2026-02-19T05:50:51.524525Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b4c6dc24a78438ca","cluster-id":"587227f9a3f73e98"} {"level":"info","ts":"2026-02-19T05:50:51.524677Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca switched to configuration voters=()"} {"level":"info","ts":"2026-02-19T05:50:51.524718Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca became follower at term 0"} {"level":"info","ts":"2026-02-19T05:50:51.524734Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b4c6dc24a78438ca [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-19T05:50:51.524749Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca became follower at term 1"} {"level":"info","ts":"2026-02-19T05:50:51.524812Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca switched to configuration voters=(13026341022203132106)"} {"level":"warn","ts":"2026-02-19T05:50:51.527479Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-19T05:50:51.529293Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-19T05:50:51.530676Z","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-02-19T05:50:51.533769Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b4c6dc24a78438ca","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-19T05:50:51.534033Z","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-02-19T05:50:51.534136Z","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-02-19T05:50:51.534074Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b4c6dc24a78438ca","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-19T05:50:51.534162Z","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-02-19T05:50:51.535751Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca switched to configuration voters=(13026341022203132106)"} {"level":"info","ts":"2026-02-19T05:50:51.536114Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"587227f9a3f73e98","local-member-id":"b4c6dc24a78438ca","added-peer-id":"b4c6dc24a78438ca","added-peer-peer-urls":["https://162.253.55.12:2380"]} {"level":"info","ts":"2026-02-19T05:50:51.539428Z","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-02-19T05:50:51.539559Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.12:2380"} {"level":"info","ts":"2026-02-19T05:50:51.539601Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.12:2380"} {"level":"info","ts":"2026-02-19T05:50:51.539712Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b4c6dc24a78438ca","initial-advertise-peer-urls":["https://162.253.55.12:2380"],"listen-peer-urls":["https://162.253.55.12:2380"],"advertise-client-urls":["https://162.253.55.12:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.12:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-19T05:50:51.539758Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-19T05:50:52.225505Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca is starting a new election at term 1"} {"level":"info","ts":"2026-02-19T05:50:52.225579Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca became pre-candidate at term 1"} {"level":"info","ts":"2026-02-19T05:50:52.225618Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca received MsgPreVoteResp from b4c6dc24a78438ca at term 1"} {"level":"info","ts":"2026-02-19T05:50:52.225639Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca became candidate at term 2"} {"level":"info","ts":"2026-02-19T05:50:52.22565Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca received MsgVoteResp from b4c6dc24a78438ca at term 2"} {"level":"info","ts":"2026-02-19T05:50:52.225665Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca became leader at term 2"} {"level":"info","ts":"2026-02-19T05:50:52.225685Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b4c6dc24a78438ca elected leader b4c6dc24a78438ca at term 2"} {"level":"info","ts":"2026-02-19T05:50:52.226728Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b4c6dc24a78438ca","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.12:2379]}","request-path":"/0/members/b4c6dc24a78438ca/attributes","cluster-id":"587227f9a3f73e98","publish-timeout":"7s"} {"level":"info","ts":"2026-02-19T05:50:52.226732Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-19T05:50:52.226777Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-19T05:50:52.226846Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-19T05:50:52.226983Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-19T05:50:52.227018Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-19T05:50:52.228097Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"587227f9a3f73e98","local-member-id":"b4c6dc24a78438ca","cluster-version":"3.5"} {"level":"info","ts":"2026-02-19T05:50:52.228297Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-19T05:50:52.228365Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-19T05:50:52.230176Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.12:2379"} {"level":"info","ts":"2026-02-19T05:50:52.230648Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-02-19T05:50:55.115536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.304818ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-19T05:50:55.11569Z","caller":"traceutil/trace.go:171","msg":"trace[1371684166] transaction","detail":"{read_only:false; response_revision:179; number_of_response:1; }","duration":"129.365315ms","start":"2026-02-19T05:50:54.986302Z","end":"2026-02-19T05:50:55.115667Z","steps":["trace[1371684166] 'compare' (duration: 118.179766ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:50:55.739267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.149984ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-19T05:50:55.739394Z","caller":"traceutil/trace.go:171","msg":"trace[1488770590] transaction","detail":"{read_only:false; response_revision:195; number_of_response:1; }","duration":"492.307372ms","start":"2026-02-19T05:50:55.247068Z","end":"2026-02-19T05:50:55.739376Z","steps":["trace[1488770590] 'process raft request' (duration: 177.833802ms)","trace[1488770590] 'compare' (duration: 313.917578ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T05:50:55.739472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:50:55.247051Z","time spent":"492.376993ms","remote":"127.0.0.1:38594","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T05:50:55.79926Z","caller":"traceutil/trace.go:171","msg":"trace[1277966547] transaction","detail":"{read_only:false; response_revision:196; number_of_response:1; }","duration":"458.905818ms","start":"2026-02-19T05:50:55.340337Z","end":"2026-02-19T05:50:55.799243Z","steps":["trace[1277966547] 'process raft request' (duration: 458.823077ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:50:55.799366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:50:55.34031Z","time spent":"459.00242ms","remote":"127.0.0.1:38678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":984,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-19T05:50:56.068579Z","caller":"traceutil/trace.go:171","msg":"trace[674852823] linearizableReadLoop","detail":"{readStateIndex:202; appliedIndex:201; }","duration":"327.068959ms","start":"2026-02-19T05:50:55.741483Z","end":"2026-02-19T05:50:56.068552Z","steps":["trace[674852823] 'read index received' (duration: 57.744564ms)","trace[674852823] 'applied index is now lower than readState.Index' (duration: 269.323525ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T05:50:56.068671Z","caller":"traceutil/trace.go:171","msg":"trace[1605351327] transaction","detail":"{read_only:false; response_revision:197; number_of_response:1; }","duration":"337.322168ms","start":"2026-02-19T05:50:55.731316Z","end":"2026-02-19T05:50:56.068639Z","steps":["trace[1605351327] 'process raft request' (duration: 337.057672ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:50:56.068958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:50:55.731294Z","time spent":"337.604715ms","remote":"127.0.0.1:38768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3937,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-19T05:50:56.069386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.897037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T05:50:56.069473Z","caller":"traceutil/trace.go:171","msg":"trace[78226886] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:0; response_revision:197; }","duration":"328.02762ms","start":"2026-02-19T05:50:55.741431Z","end":"2026-02-19T05:50:56.069459Z","steps":["trace[78226886] 'agreement among raft nodes before linearized reading' (duration: 327.256123ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:50:56.069544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:50:55.741409Z","time spent":"328.123722ms","remote":"127.0.0.1:38746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":0,"response size":28,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"info","ts":"2026-02-19T05:50:56.073943Z","caller":"traceutil/trace.go:171","msg":"trace[19841533] transaction","detail":"{read_only:false; response_revision:199; number_of_response:1; }","duration":"128.281201ms","start":"2026-02-19T05:50:55.945629Z","end":"2026-02-19T05:50:56.073911Z","steps":["trace[19841533] 'process raft request' (duration: 128.131097ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:50:56.073935Z","caller":"traceutil/trace.go:171","msg":"trace[1918704062] transaction","detail":"{read_only:false; response_revision:198; number_of_response:1; }","duration":"271.711096ms","start":"2026-02-19T05:50:55.80217Z","end":"2026-02-19T05:50:56.073881Z","steps":["trace[1918704062] 'process raft request' (duration: 271.508032ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:51:26.287594Z","caller":"traceutil/trace.go:171","msg":"trace[208360737] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"163.192488ms","start":"2026-02-19T05:51:26.124382Z","end":"2026-02-19T05:51:26.287574Z","steps":["trace[208360737] 'process raft request' (duration: 163.062805ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:51:27.690036Z","caller":"traceutil/trace.go:171","msg":"trace[781796390] linearizableReadLoop","detail":"{readStateIndex:523; appliedIndex:522; }","duration":"191.355651ms","start":"2026-02-19T05:51:27.498654Z","end":"2026-02-19T05:51:27.69001Z","steps":["trace[781796390] 'read index received' (duration: 191.110016ms)","trace[781796390] 'applied index is now lower than readState.Index' (duration: 244.765µs)"],"step_count":2} {"level":"info","ts":"2026-02-19T05:51:27.690118Z","caller":"traceutil/trace.go:171","msg":"trace[1829611106] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"290.27837ms","start":"2026-02-19T05:51:27.399797Z","end":"2026-02-19T05:51:27.690075Z","steps":["trace[1829611106] 'process raft request' (duration: 290.049875ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:51:27.690281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.586506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T05:51:27.690406Z","caller":"traceutil/trace.go:171","msg":"trace[1858853767] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:506; }","duration":"191.78946ms","start":"2026-02-19T05:51:27.498587Z","end":"2026-02-19T05:51:27.690376Z","steps":["trace[1858853767] 'agreement among raft nodes before linearized reading' (duration: 191.539935ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:51:28.083782Z","caller":"traceutil/trace.go:171","msg":"trace[1341620638] linearizableReadLoop","detail":"{readStateIndex:524; appliedIndex:523; }","duration":"307.094446ms","start":"2026-02-19T05:51:27.77666Z","end":"2026-02-19T05:51:28.083754Z","steps":["trace[1341620638] 'read index received' (duration: 306.918872ms)","trace[1341620638] 'applied index is now lower than readState.Index' (duration: 174.223µs)"],"step_count":2} {"level":"info","ts":"2026-02-19T05:51:28.083865Z","caller":"traceutil/trace.go:171","msg":"trace[1980649807] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"375.03379ms","start":"2026-02-19T05:51:27.708782Z","end":"2026-02-19T05:51:28.083816Z","steps":["trace[1980649807] 'process raft request' (duration: 374.817045ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:51:28.08398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.29609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-19T05:51:28.084015Z","caller":"traceutil/trace.go:171","msg":"trace[2138503837] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:507; }","duration":"307.379411ms","start":"2026-02-19T05:51:27.776626Z","end":"2026-02-19T05:51:28.084005Z","steps":["trace[2138503837] 'agreement among raft nodes before linearized reading' (duration: 307.225398ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:51:28.08405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:51:27.776613Z","time spent":"307.428292ms","remote":"127.0.0.1:38844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-19T05:51:28.084047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:51:27.708769Z","time spent":"375.180733ms","remote":"127.0.0.1:38768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16799,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T05:52:42.239665Z","caller":"traceutil/trace.go:171","msg":"trace[397819654] transaction","detail":"{read_only:false; response_revision:869; number_of_response:1; }","duration":"186.066092ms","start":"2026-02-19T05:52:42.053573Z","end":"2026-02-19T05:52:42.239639Z","steps":["trace[397819654] 'process raft request' (duration: 185.847959ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:52:42.241619Z","caller":"traceutil/trace.go:171","msg":"trace[694800941] transaction","detail":"{read_only:false; response_revision:870; number_of_response:1; }","duration":"187.687629ms","start":"2026-02-19T05:52:42.053906Z","end":"2026-02-19T05:52:42.241593Z","steps":["trace[694800941] 'process raft request' (duration: 187.555277ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:53:02.727738Z","caller":"traceutil/trace.go:171","msg":"trace[557703644] transaction","detail":"{read_only:false; response_revision:965; number_of_response:1; }","duration":"389.487676ms","start":"2026-02-19T05:53:02.338227Z","end":"2026-02-19T05:53:02.727714Z","steps":["trace[557703644] 'process raft request' (duration: 389.355094ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:53:02.72799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:53:02.33821Z","time spent":"389.703591ms","remote":"127.0.0.1:38844","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T05:53:02.751911Z","caller":"traceutil/trace.go:171","msg":"trace[799840275] linearizableReadLoop","detail":"{readStateIndex:1005; appliedIndex:1003; }","duration":"216.66214ms","start":"2026-02-19T05:53:02.53522Z","end":"2026-02-19T05:53:02.751882Z","steps":["trace[799840275] 'read index received' (duration: 192.433838ms)","trace[799840275] 'applied index is now lower than readState.Index' (duration: 24.227022ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T05:53:02.752046Z","caller":"traceutil/trace.go:171","msg":"trace[812913696] transaction","detail":"{read_only:false; response_revision:966; number_of_response:1; }","duration":"413.564548ms","start":"2026-02-19T05:53:02.338446Z","end":"2026-02-19T05:53:02.75201Z","steps":["trace[812913696] 'process raft request' (duration: 413.297072ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:53:02.752276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.000718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-19T05:53:02.752328Z","caller":"traceutil/trace.go:171","msg":"trace[89785320] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:966; }","duration":"217.11357ms","start":"2026-02-19T05:53:02.535203Z","end":"2026-02-19T05:53:02.752316Z","steps":["trace[89785320] 'agreement among raft nodes before linearized reading' (duration: 216.825165ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:53:02.752448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:53:02.338435Z","time spent":"413.794961ms","remote":"127.0.0.1:38844","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T05:53:12.997611Z","caller":"traceutil/trace.go:171","msg":"trace[354314900] transaction","detail":"{read_only:false; response_revision:998; number_of_response:1; }","duration":"119.156753ms","start":"2026-02-19T05:53:12.878428Z","end":"2026-02-19T05:53:12.997584Z","steps":["trace[354314900] 'process raft request' (duration: 51.525258ms)","trace[354314900] 'compare' (duration: 67.541094ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T05:53:13.191844Z","caller":"traceutil/trace.go:171","msg":"trace[2053229831] linearizableReadLoop","detail":"{readStateIndex:1041; appliedIndex:1038; }","duration":"294.611505ms","start":"2026-02-19T05:53:12.897215Z","end":"2026-02-19T05:53:13.191827Z","steps":["trace[2053229831] 'read index received' (duration: 32.667352ms)","trace[2053229831] 'applied index is now lower than readState.Index' (duration: 261.943503ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T05:53:13.191889Z","caller":"traceutil/trace.go:171","msg":"trace[412269940] transaction","detail":"{read_only:false; response_revision:999; number_of_response:1; }","duration":"313.076564ms","start":"2026-02-19T05:53:12.878783Z","end":"2026-02-19T05:53:13.19186Z","steps":["trace[412269940] 'process raft request' (duration: 312.906391ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:53:13.191964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.739678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:endpointslicemirroring-controller\" ","response":"range_response_count:1 size:807"} {"level":"info","ts":"2026-02-19T05:53:13.191992Z","caller":"traceutil/trace.go:171","msg":"trace[400203282] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:endpointslicemirroring-controller; range_end:; response_count:1; response_revision:1000; }","duration":"294.779308ms","start":"2026-02-19T05:53:12.897203Z","end":"2026-02-19T05:53:13.191983Z","steps":["trace[400203282] 'agreement among raft nodes before linearized reading' (duration: 294.714877ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:53:13.19204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:53:12.878767Z","time spent":"313.192487ms","remote":"127.0.0.1:38844","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T05:53:13.192144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.217661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:route-controller\" ","response":"range_response_count:1 size:675"} {"level":"info","ts":"2026-02-19T05:53:13.191986Z","caller":"traceutil/trace.go:171","msg":"trace[720125904] transaction","detail":"{read_only:false; response_revision:1000; number_of_response:1; }","duration":"312.87429ms","start":"2026-02-19T05:53:12.879032Z","end":"2026-02-19T05:53:13.191907Z","steps":["trace[720125904] 'process raft request' (duration: 312.764848ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:53:13.192206Z","caller":"traceutil/trace.go:171","msg":"trace[2909125] range","detail":"{range_begin:/registry/clusterroles/system:controller:route-controller; range_end:; response_count:1; response_revision:1000; }","duration":"288.304203ms","start":"2026-02-19T05:53:12.903885Z","end":"2026-02-19T05:53:13.192189Z","steps":["trace[2909125] 'agreement among raft nodes before linearized reading' (duration: 288.1638ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:53:13.192437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:53:12.879023Z","time spent":"313.240736ms","remote":"127.0.0.1:38844","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T05:53:13.192481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.810013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-02-19T05:53:13.193259Z","caller":"traceutil/trace.go:171","msg":"trace[1856643886] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1000; }","duration":"183.609967ms","start":"2026-02-19T05:53:13.009631Z","end":"2026-02-19T05:53:13.193241Z","steps":["trace[1856643886] 'agreement among raft nodes before linearized reading' (duration: 182.68868ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:53:13.450305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.735166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:ephemeral-volume-controller\" ","response":"range_response_count:1 size:783"} {"level":"info","ts":"2026-02-19T05:53:13.450406Z","caller":"traceutil/trace.go:171","msg":"trace[1114529031] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:ephemeral-volume-controller; range_end:; response_count:1; response_revision:1001; }","duration":"106.8755ms","start":"2026-02-19T05:53:13.343496Z","end":"2026-02-19T05:53:13.450372Z","steps":["trace[1114529031] 'range keys from in-memory index tree' (duration: 106.564733ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:53:13.450426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.499919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:expand-controller\" ","response":"range_response_count:1 size:743"} {"level":"info","ts":"2026-02-19T05:53:13.45049Z","caller":"traceutil/trace.go:171","msg":"trace[2146387778] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:expand-controller; range_end:; response_count:1; response_revision:1001; }","duration":"103.59449ms","start":"2026-02-19T05:53:13.34688Z","end":"2026-02-19T05:53:13.450474Z","steps":["trace[2146387778] 'range keys from in-memory index tree' (duration: 103.195232ms)"],"step_count":1}