{"level":"warn","ts":"2026-02-17T19:50:40.856433Z","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-17T19:50:40.857319Z","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-17T19:50:40.857419Z","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-17T19:50:40.858096Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.12:2380"]} {"level":"info","ts":"2026-02-17T19:50:40.858146Z","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-17T19:50:40.858696Z","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-17T19:50:40.863219Z","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":2,"max-cpu-available":2,"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-17T19:50:40.868581Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.91572ms"} {"level":"info","ts":"2026-02-17T19:50:40.890025Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b4c6dc24a78438ca","cluster-id":"587227f9a3f73e98"} {"level":"info","ts":"2026-02-17T19:50:40.890223Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca switched to configuration voters=()"} {"level":"info","ts":"2026-02-17T19:50:40.89025Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca became follower at term 0"} {"level":"info","ts":"2026-02-17T19:50:40.890311Z","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-17T19:50:40.890362Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca became follower at term 1"} {"level":"info","ts":"2026-02-17T19:50:40.890459Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca switched to configuration voters=(13026341022203132106)"} {"level":"warn","ts":"2026-02-17T19:50:40.903753Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-17T19:50:40.907747Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-17T19:50:40.914478Z","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-17T19:50:40.924282Z","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-17T19:50:40.935863Z","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-17T19:50:40.935963Z","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-17T19:50:40.936012Z","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-17T19:50:40.936071Z","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-17T19:50:40.936273Z","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-17T19:50:40.936606Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-17T19:50:40.936431Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca switched to configuration voters=(13026341022203132106)"} {"level":"info","ts":"2026-02-17T19:50:40.937104Z","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-17T19:50:40.936493Z","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-17T19:50:40.936561Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.12:2380"} {"level":"info","ts":"2026-02-17T19:50:40.947431Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.12:2380"} {"level":"info","ts":"2026-02-17T19:50:41.891869Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca is starting a new election at term 1"} {"level":"info","ts":"2026-02-17T19:50:41.891908Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca became pre-candidate at term 1"} {"level":"info","ts":"2026-02-17T19:50:41.891934Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca received MsgPreVoteResp from b4c6dc24a78438ca at term 1"} {"level":"info","ts":"2026-02-17T19:50:41.891948Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca became candidate at term 2"} {"level":"info","ts":"2026-02-17T19:50:41.891957Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca received MsgVoteResp from b4c6dc24a78438ca at term 2"} {"level":"info","ts":"2026-02-17T19:50:41.891969Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca became leader at term 2"} {"level":"info","ts":"2026-02-17T19:50:41.891976Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b4c6dc24a78438ca elected leader b4c6dc24a78438ca at term 2"} {"level":"info","ts":"2026-02-17T19:50:41.893603Z","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-17T19:50:41.893631Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T19:50:41.893704Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-17T19:50:41.893945Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-17T19:50:41.894028Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-17T19:50:41.894035Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-17T19:50:41.895181Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-17T19:50:41.89527Z","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-17T19:50:41.895347Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T19:50:41.895365Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T19:50:41.896399Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.12:2379"} {"level":"info","ts":"2026-02-17T19:50:59.555785Z","caller":"traceutil/trace.go:171","msg":"trace[573750161] linearizableReadLoop","detail":"{readStateIndex:423; appliedIndex:422; }","duration":"116.465572ms","start":"2026-02-17T19:50:59.439303Z","end":"2026-02-17T19:50:59.555769Z","steps":["trace[573750161] 'read index received' (duration: 116.350413ms)","trace[573750161] 'applied index is now lower than readState.Index' (duration: 114.359µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:50:59.555873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.560959ms","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-02-17T19:50:59.555906Z","caller":"traceutil/trace.go:171","msg":"trace[1824889689] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:410; }","duration":"116.664137ms","start":"2026-02-17T19:50:59.439234Z","end":"2026-02-17T19:50:59.555899Z","steps":["trace[1824889689] 'agreement among raft nodes before linearized reading' (duration: 116.596992ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:50:59.556002Z","caller":"traceutil/trace.go:171","msg":"trace[973925656] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"137.952338ms","start":"2026-02-17T19:50:59.418029Z","end":"2026-02-17T19:50:59.555981Z","steps":["trace[973925656] 'process raft request' (duration: 137.625252ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:50:59.827781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.627873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T19:50:59.827839Z","caller":"traceutil/trace.go:171","msg":"trace[759546650] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:413; }","duration":"172.744162ms","start":"2026-02-17T19:50:59.655079Z","end":"2026-02-17T19:50:59.827824Z","steps":["trace[759546650] 'range keys from in-memory index tree' (duration: 172.58119ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:51:01.938359Z","caller":"traceutil/trace.go:171","msg":"trace[421441670] linearizableReadLoop","detail":"{readStateIndex:428; appliedIndex:427; }","duration":"371.798121ms","start":"2026-02-17T19:51:01.566539Z","end":"2026-02-17T19:51:01.938337Z","steps":["trace[421441670] 'read index received' (duration: 371.588054ms)","trace[421441670] 'applied index is now lower than readState.Index' (duration: 209.057µs)"],"step_count":2} {"level":"info","ts":"2026-02-17T19:51:01.938652Z","caller":"traceutil/trace.go:171","msg":"trace[1896672189] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"376.292921ms","start":"2026-02-17T19:51:01.562348Z","end":"2026-02-17T19:51:01.938641Z","steps":["trace[1896672189] 'process raft request' (duration: 375.835935ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:51:01.939764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.212535ms","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-02-17T19:51:01.939819Z","caller":"traceutil/trace.go:171","msg":"trace[835763690] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:414; }","duration":"373.288111ms","start":"2026-02-17T19:51:01.566516Z","end":"2026-02-17T19:51:01.939804Z","steps":["trace[835763690] 'agreement among raft nodes before linearized reading' (duration: 373.199724ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:51:01.93986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:51:01.566506Z","time spent":"373.344126ms","remote":"127.0.0.1:58686","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-02-17T19:51:01.940355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:51:01.562333Z","time spent":"376.347025ms","remote":"127.0.0.1:58686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T19:51:01.940907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.574036ms","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-17T19:51:01.941183Z","caller":"traceutil/trace.go:171","msg":"trace[429266855] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:414; }","duration":"333.880141ms","start":"2026-02-17T19:51:01.607288Z","end":"2026-02-17T19:51:01.941169Z","steps":["trace[429266855] 'agreement among raft nodes before linearized reading' (duration: 332.764092ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:51:01.941543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:51:01.607271Z","time spent":"334.236719ms","remote":"127.0.0.1:58686","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-17T19:51:01.946855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.779436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-02-17T19:51:01.946922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.211609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T19:51:01.946982Z","caller":"traceutil/trace.go:171","msg":"trace[2013770862] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:414; }","duration":"290.324978ms","start":"2026-02-17T19:51:01.656644Z","end":"2026-02-17T19:51:01.946969Z","steps":["trace[2013770862] 'agreement among raft nodes before linearized reading' (duration: 285.688437ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:51:01.946955Z","caller":"traceutil/trace.go:171","msg":"trace[1323369708] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:414; }","duration":"297.884374ms","start":"2026-02-17T19:51:01.64904Z","end":"2026-02-17T19:51:01.946924Z","steps":["trace[1323369708] 'agreement among raft nodes before linearized reading' (duration: 297.312579ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:51:12.070047Z","caller":"traceutil/trace.go:171","msg":"trace[1341142119] linearizableReadLoop","detail":"{readStateIndex:487; appliedIndex:486; }","duration":"414.807641ms","start":"2026-02-17T19:51:11.655224Z","end":"2026-02-17T19:51:12.070032Z","steps":["trace[1341142119] 'read index received' (duration: 414.67366ms)","trace[1341142119] 'applied index is now lower than readState.Index' (duration: 133.181µs)"],"step_count":2} {"level":"info","ts":"2026-02-17T19:51:12.070127Z","caller":"traceutil/trace.go:171","msg":"trace[249108614] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"564.864969ms","start":"2026-02-17T19:51:11.505255Z","end":"2026-02-17T19:51:12.07012Z","steps":["trace[249108614] 'process raft request' (duration: 564.659862ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:51:12.070464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.253788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T19:51:12.070509Z","caller":"traceutil/trace.go:171","msg":"trace[1512612858] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:471; }","duration":"415.318654ms","start":"2026-02-17T19:51:11.65517Z","end":"2026-02-17T19:51:12.070489Z","steps":["trace[1512612858] 'agreement among raft nodes before linearized reading' (duration: 415.257699ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:51:12.070531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:51:11.655156Z","time spent":"415.369518ms","remote":"127.0.0.1:58412","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-17T19:51:12.071022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:51:11.505228Z","time spent":"564.916324ms","remote":"127.0.0.1:58612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4210,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T19:51:20.159194Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4092255204050075243,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T19:51:20.659301Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4092255204050075243,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T19:51:20.762581Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.793410504s","expected-duration":"1s"} {"level":"info","ts":"2026-02-17T19:51:20.762921Z","caller":"traceutil/trace.go:171","msg":"trace[146441088] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"1.793847973s","start":"2026-02-17T19:51:18.969057Z","end":"2026-02-17T19:51:20.762905Z","steps":["trace[146441088] 'process raft request' (duration: 1.793734943s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:51:20.763016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:51:18.969035Z","time spent":"1.793932969s","remote":"127.0.0.1:58620","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16799,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T19:51:20.926999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.317367ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-17T19:51:20.927097Z","caller":"traceutil/trace.go:171","msg":"trace[1313072773] linearizableReadLoop","detail":"{readStateIndex:534; appliedIndex:533; }","duration":"1.268853494s","start":"2026-02-17T19:51:19.658219Z","end":"2026-02-17T19:51:20.927073Z","steps":["trace[1313072773] 'read index received' (duration: 1.105115821s)","trace[1313072773] 'applied index is now lower than readState.Index' (duration: 163.736233ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:51:20.927253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.269022588s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T19:51:20.927287Z","caller":"traceutil/trace.go:171","msg":"trace[1631132299] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:516; }","duration":"1.269098454s","start":"2026-02-17T19:51:19.65818Z","end":"2026-02-17T19:51:20.927278Z","steps":["trace[1631132299] 'agreement among raft nodes before linearized reading' (duration: 1.268992786s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:51:20.92729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"771.382949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-02-17T19:51:20.927319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:51:19.658163Z","time spent":"1.269149729s","remote":"127.0.0.1:58412","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-17T19:51:20.927338Z","caller":"traceutil/trace.go:171","msg":"trace[785399194] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:516; }","duration":"771.525171ms","start":"2026-02-17T19:51:20.1558Z","end":"2026-02-17T19:51:20.927325Z","steps":["trace[785399194] 'agreement among raft nodes before linearized reading' (duration: 771.413682ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:51:20.927365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:51:20.155783Z","time spent":"771.576955ms","remote":"127.0.0.1:58686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-17T19:51:20.927505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"744.546638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-02-17T19:51:20.927519Z","caller":"traceutil/trace.go:171","msg":"trace[1078138117] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:516; }","duration":"744.580682ms","start":"2026-02-17T19:51:20.182934Z","end":"2026-02-17T19:51:20.927514Z","steps":["trace[1078138117] 'agreement among raft nodes before linearized reading' (duration: 744.555489ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:51:20.927532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:51:20.182923Z","time spent":"744.606824ms","remote":"127.0.0.1:58686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-17T19:51:20.927597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"746.121003ms","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-17T19:51:20.927621Z","caller":"traceutil/trace.go:171","msg":"trace[1241387994] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:516; }","duration":"746.164747ms","start":"2026-02-17T19:51:20.18144Z","end":"2026-02-17T19:51:20.927605Z","steps":["trace[1241387994] 'agreement among raft nodes before linearized reading' (duration: 746.141995ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:51:20.927636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:51:20.18142Z","time spent":"746.212951ms","remote":"127.0.0.1:58686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-17T19:51:20.927681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"771.648702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-17T19:51:20.927692Z","caller":"traceutil/trace.go:171","msg":"trace[1193094002] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:516; }","duration":"771.658752ms","start":"2026-02-17T19:51:20.156029Z","end":"2026-02-17T19:51:20.927688Z","steps":["trace[1193094002] 'agreement among raft nodes before linearized reading' (duration: 771.639421ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:51:20.927703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:51:20.156003Z","time spent":"771.697626ms","remote":"127.0.0.1:58686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-17T19:51:23.532241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.222028ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-17T19:51:23.532507Z","caller":"traceutil/trace.go:171","msg":"trace[274920454] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"341.142476ms","start":"2026-02-17T19:51:23.191152Z","end":"2026-02-17T19:51:23.532295Z","steps":["trace[274920454] 'process raft request' (duration: 225.842801ms)","trace[274920454] 'compare' (duration: 115.022971ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:51:23.532543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:51:23.191138Z","time spent":"341.389638ms","remote":"127.0.0.1:58916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":950,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T19:51:23.541217Z","caller":"traceutil/trace.go:171","msg":"trace[203198099] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"192.848167ms","start":"2026-02-17T19:51:23.348347Z","end":"2026-02-17T19:51:23.541196Z","steps":["trace[203198099] 'process raft request' (duration: 192.809364ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:51:23.541575Z","caller":"traceutil/trace.go:171","msg":"trace[1065486198] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"349.048055ms","start":"2026-02-17T19:51:23.192506Z","end":"2026-02-17T19:51:23.541554Z","steps":["trace[1065486198] 'process raft request' (duration: 348.549092ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:51:23.542317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:51:23.192499Z","time spent":"349.738044ms","remote":"127.0.0.1:58472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10353,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T19:51:25.316223Z","caller":"traceutil/trace.go:171","msg":"trace[998571212] linearizableReadLoop","detail":"{readStateIndex:609; appliedIndex:608; }","duration":"173.356433ms","start":"2026-02-17T19:51:25.142842Z","end":"2026-02-17T19:51:25.316198Z","steps":["trace[998571212] 'read index received' (duration: 112.210979ms)","trace[998571212] 'applied index is now lower than readState.Index' (duration: 61.144504ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T19:51:25.316845Z","caller":"traceutil/trace.go:171","msg":"trace[793018365] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"174.25447ms","start":"2026-02-17T19:51:25.142574Z","end":"2026-02-17T19:51:25.316828Z","steps":["trace[793018365] 'process raft request' (duration: 112.552758ms)","trace[793018365] 'compare' (duration: 60.931016ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:51:25.318467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.256067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:1 size:5586"} {"level":"info","ts":"2026-02-17T19:51:25.318537Z","caller":"traceutil/trace.go:171","msg":"trace[1241292941] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:590; }","duration":"175.701136ms","start":"2026-02-17T19:51:25.142799Z","end":"2026-02-17T19:51:25.3185Z","steps":["trace[1241292941] 'agreement among raft nodes before linearized reading' (duration: 173.620596ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:51:41.311866Z","caller":"traceutil/trace.go:171","msg":"trace[2110136564] linearizableReadLoop","detail":"{readStateIndex:741; appliedIndex:740; }","duration":"177.199271ms","start":"2026-02-17T19:51:41.134654Z","end":"2026-02-17T19:51:41.311853Z","steps":["trace[2110136564] 'read index received' (duration: 177.00242ms)","trace[2110136564] 'applied index is now lower than readState.Index' (duration: 196.391µs)"],"step_count":2} {"level":"info","ts":"2026-02-17T19:51:41.312044Z","caller":"traceutil/trace.go:171","msg":"trace[1524828802] transaction","detail":"{read_only:false; response_revision:718; number_of_response:1; }","duration":"200.320763ms","start":"2026-02-17T19:51:41.111718Z","end":"2026-02-17T19:51:41.312038Z","steps":["trace[1524828802] 'process raft request' (duration: 200.00644ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:51:41.312206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.542422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-02-17T19:51:41.312226Z","caller":"traceutil/trace.go:171","msg":"trace[292741186] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:718; }","duration":"177.617839ms","start":"2026-02-17T19:51:41.134602Z","end":"2026-02-17T19:51:41.31222Z","steps":["trace[292741186] 'agreement among raft nodes before linearized reading' (duration: 177.567871ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:52:48.811715Z","caller":"traceutil/trace.go:171","msg":"trace[1631793421] linearizableReadLoop","detail":"{readStateIndex:982; appliedIndex:981; }","duration":"162.891754ms","start":"2026-02-17T19:52:48.6488Z","end":"2026-02-17T19:52:48.811692Z","steps":["trace[1631793421] 'read index received' (duration: 162.608565ms)","trace[1631793421] 'applied index is now lower than readState.Index' (duration: 282.359µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:52:48.81187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.042049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-17T19:52:48.811901Z","caller":"traceutil/trace.go:171","msg":"trace[1919656584] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:945; }","duration":"163.111391ms","start":"2026-02-17T19:52:48.648779Z","end":"2026-02-17T19:52:48.811891Z","steps":["trace[1919656584] 'agreement among raft nodes before linearized reading' (duration: 163.006238ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:52:48.81205Z","caller":"traceutil/trace.go:171","msg":"trace[2096143031] transaction","detail":"{read_only:false; response_revision:945; number_of_response:1; }","duration":"173.198528ms","start":"2026-02-17T19:52:48.638826Z","end":"2026-02-17T19:52:48.812024Z","steps":["trace[2096143031] 'process raft request' (duration: 172.661351ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:52:54.00681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.230989ms","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-02-17T19:52:54.006856Z","caller":"traceutil/trace.go:171","msg":"trace[1275924882] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:964; }","duration":"276.316842ms","start":"2026-02-17T19:52:53.730528Z","end":"2026-02-17T19:52:54.006845Z","steps":["trace[1275924882] 'range keys from in-memory index tree' (duration: 276.122805ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:52:54.006982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.453262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-17T19:52:54.007Z","caller":"traceutil/trace.go:171","msg":"trace[1584586948] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:964; }","duration":"254.471562ms","start":"2026-02-17T19:52:53.752525Z","end":"2026-02-17T19:52:54.006996Z","steps":["trace[1584586948] 'range keys from in-memory index tree' (duration: 254.39382ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:52:56.329595Z","caller":"traceutil/trace.go:171","msg":"trace[1754748975] transaction","detail":"{read_only:false; response_revision:978; number_of_response:1; }","duration":"245.303943ms","start":"2026-02-17T19:52:56.084267Z","end":"2026-02-17T19:52:56.329571Z","steps":["trace[1754748975] 'process raft request' (duration: 245.273202ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:52:56.329758Z","caller":"traceutil/trace.go:171","msg":"trace[1700190509] transaction","detail":"{read_only:false; response_revision:977; number_of_response:1; }","duration":"246.395072ms","start":"2026-02-17T19:52:56.083336Z","end":"2026-02-17T19:52:56.329731Z","steps":["trace[1700190509] 'process raft request' (duration: 171.8589ms)","trace[1700190509] 'compare' (duration: 74.240722ms)"],"step_count":2}