{"level":"warn","ts":"2026-02-12T01:51:57.381295Z","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-12T01:51:57.384773Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.36: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.36:2380","--initial-cluster=instance=https://162.253.55.36:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.36:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.36: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-12T01:51:57.384893Z","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-12T01:51:57.384911Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.36:2380"]} {"level":"info","ts":"2026-02-12T01:51:57.385092Z","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-12T01:51:57.387372Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.36:2379"]} {"level":"info","ts":"2026-02-12T01:51:57.388282Z","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.36:2380"],"listen-peer-urls":["https://162.253.55.36:2380"],"advertise-client-urls":["https://162.253.55.36:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.36:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.36: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-12T01:51:57.398679Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"10.179972ms"} {"level":"info","ts":"2026-02-12T01:51:57.41928Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"cb89ec34a9687f0b","cluster-id":"d8e0d5e222e856c9"} {"level":"info","ts":"2026-02-12T01:51:57.419386Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b switched to configuration voters=()"} {"level":"info","ts":"2026-02-12T01:51:57.419411Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b became follower at term 0"} {"level":"info","ts":"2026-02-12T01:51:57.419425Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft cb89ec34a9687f0b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-12T01:51:57.419432Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b became follower at term 1"} {"level":"info","ts":"2026-02-12T01:51:57.419497Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b switched to configuration voters=(14666513372433383179)"} {"level":"warn","ts":"2026-02-12T01:51:57.435005Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-12T01:51:57.441211Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-12T01:51:57.442341Z","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-12T01:51:57.444767Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"cb89ec34a9687f0b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-12T01:51:57.446469Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"cb89ec34a9687f0b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-12T01:51:57.454079Z","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-12T01:51:57.454187Z","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-12T01:51:57.454224Z","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-12T01:51:57.458461Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b switched to configuration voters=(14666513372433383179)"} {"level":"info","ts":"2026-02-12T01:51:57.458601Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"d8e0d5e222e856c9","local-member-id":"cb89ec34a9687f0b","added-peer-id":"cb89ec34a9687f0b","added-peer-peer-urls":["https://162.253.55.36:2380"]} {"level":"info","ts":"2026-02-12T01:51:57.458928Z","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-12T01:51:57.458963Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.36:2380"} {"level":"info","ts":"2026-02-12T01:51:57.460443Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.36:2380"} {"level":"info","ts":"2026-02-12T01:51:57.460615Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"cb89ec34a9687f0b","initial-advertise-peer-urls":["https://162.253.55.36:2380"],"listen-peer-urls":["https://162.253.55.36:2380"],"advertise-client-urls":["https://162.253.55.36:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.36:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-12T01:51:57.461385Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-12T01:51:58.119676Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b is starting a new election at term 1"} {"level":"info","ts":"2026-02-12T01:51:58.119725Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b became pre-candidate at term 1"} {"level":"info","ts":"2026-02-12T01:51:58.119745Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b received MsgPreVoteResp from cb89ec34a9687f0b at term 1"} {"level":"info","ts":"2026-02-12T01:51:58.119756Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b became candidate at term 2"} {"level":"info","ts":"2026-02-12T01:51:58.119761Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b received MsgVoteResp from cb89ec34a9687f0b at term 2"} {"level":"info","ts":"2026-02-12T01:51:58.11977Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b became leader at term 2"} {"level":"info","ts":"2026-02-12T01:51:58.119777Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: cb89ec34a9687f0b elected leader cb89ec34a9687f0b at term 2"} {"level":"info","ts":"2026-02-12T01:51:58.121686Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"cb89ec34a9687f0b","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.36:2379]}","request-path":"/0/members/cb89ec34a9687f0b/attributes","cluster-id":"d8e0d5e222e856c9","publish-timeout":"7s"} {"level":"info","ts":"2026-02-12T01:51:58.121711Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-12T01:51:58.122046Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-12T01:51:58.122251Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-12T01:51:58.122389Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-12T01:51:58.122402Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-12T01:51:58.130597Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-12T01:51:58.130682Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"d8e0d5e222e856c9","local-member-id":"cb89ec34a9687f0b","cluster-version":"3.5"} {"level":"info","ts":"2026-02-12T01:51:58.130727Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-12T01:51:58.130739Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-12T01:51:58.176739Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.36:2379"} {"level":"warn","ts":"2026-02-12T01:52:01.222848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.139276ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-12T01:52:01.222969Z","caller":"traceutil/trace.go:171","msg":"trace[1655581294] transaction","detail":"{read_only:false; response_revision:193; number_of_response:1; }","duration":"161.351194ms","start":"2026-02-12T01:52:01.0616Z","end":"2026-02-12T01:52:01.222951Z","steps":["trace[1655581294] 'process raft request' (duration: 29.617853ms)","trace[1655581294] 'compare' (duration: 131.03025ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T01:52:02.378032Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9154582533030014179,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-12T01:52:02.765394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.00109375s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-12T01:52:02.765604Z","caller":"traceutil/trace.go:171","msg":"trace[1504424697] transaction","detail":"{read_only:false; response_revision:195; number_of_response:1; }","duration":"1.485840352s","start":"2026-02-12T01:52:01.279742Z","end":"2026-02-12T01:52:02.765582Z","steps":["trace[1504424697] 'process raft request' (duration: 484.473356ms)","trace[1504424697] 'compare' (duration: 1.000939391s)"],"step_count":2} {"level":"warn","ts":"2026-02-12T01:52:02.765804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T01:52:01.279726Z","time spent":"1.48596939s","remote":"127.0.0.1:36480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T01:52:02.77122Z","caller":"traceutil/trace.go:171","msg":"trace[1485223071] linearizableReadLoop","detail":"{readStateIndex:201; appliedIndex:200; }","duration":"893.822269ms","start":"2026-02-12T01:52:01.87738Z","end":"2026-02-12T01:52:02.771202Z","steps":["trace[1485223071] 'read index received' (duration: 893.700882ms)","trace[1485223071] 'applied index is now lower than readState.Index' (duration: 120.507µs)"],"step_count":2} {"level":"info","ts":"2026-02-12T01:52:02.77157Z","caller":"traceutil/trace.go:171","msg":"trace[1374681343] transaction","detail":"{read_only:false; response_revision:196; number_of_response:1; }","duration":"1.45164353s","start":"2026-02-12T01:52:01.319914Z","end":"2026-02-12T01:52:02.771558Z","steps":["trace[1374681343] 'process raft request' (duration: 1.451210265s)"],"step_count":1} {"level":"warn","ts":"2026-02-12T01:52:02.771702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T01:52:01.319869Z","time spent":"1.451790559s","remote":"127.0.0.1:36558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":984,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-12T01:52:02.772107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"894.716022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T01:52:02.772211Z","caller":"traceutil/trace.go:171","msg":"trace[651664318] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:196; }","duration":"894.867191ms","start":"2026-02-12T01:52:01.87733Z","end":"2026-02-12T01:52:02.772197Z","steps":["trace[651664318] 'agreement among raft nodes before linearized reading' (duration: 894.651638ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T01:52:02.772295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T01:52:01.877311Z","time spent":"894.977628ms","remote":"127.0.0.1:36742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":29,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-12T01:52:26.854934Z","caller":"traceutil/trace.go:171","msg":"trace[1483568924] transaction","detail":"{read_only:false; response_revision:431; number_of_response:1; }","duration":"458.183398ms","start":"2026-02-12T01:52:26.396725Z","end":"2026-02-12T01:52:26.854908Z","steps":["trace[1483568924] 'process raft request' (duration: 456.544947ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T01:52:26.855479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T01:52:26.39652Z","time spent":"458.87535ms","remote":"127.0.0.1:36542","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":317276,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-12T01:52:26.87353Z","caller":"traceutil/trace.go:171","msg":"trace[538745251] linearizableReadLoop","detail":"{readStateIndex:449; appliedIndex:447; }","duration":"199.573121ms","start":"2026-02-12T01:52:26.673907Z","end":"2026-02-12T01:52:26.87348Z","steps":["trace[538745251] 'read index received' (duration: 179.237229ms)","trace[538745251] 'applied index is now lower than readState.Index' (duration: 20.334692ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T01:52:26.873687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.726441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T01:52:26.873859Z","caller":"traceutil/trace.go:171","msg":"trace[1282848237] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:431; }","duration":"199.906262ms","start":"2026-02-12T01:52:26.673871Z","end":"2026-02-12T01:52:26.873777Z","steps":["trace[1282848237] 'agreement among raft nodes before linearized reading' (duration: 199.71729ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T01:52:28.267069Z","caller":"traceutil/trace.go:171","msg":"trace[913369936] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"321.003949ms","start":"2026-02-12T01:52:27.946046Z","end":"2026-02-12T01:52:28.26705Z","steps":["trace[913369936] 'process raft request' (duration: 320.896133ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T01:52:28.267182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T01:52:27.946033Z","time spent":"321.093794ms","remote":"127.0.0.1:36742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T01:52:37.411426Z","caller":"traceutil/trace.go:171","msg":"trace[1693889947] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"334.725689ms","start":"2026-02-12T01:52:37.076686Z","end":"2026-02-12T01:52:37.411412Z","steps":["trace[1693889947] 'process raft request' (duration: 334.394436ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T01:52:37.411515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T01:52:37.076676Z","time spent":"334.785917ms","remote":"127.0.0.1:36742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-12T01:52:38.047511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.176816ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-12T01:52:38.047581Z","caller":"traceutil/trace.go:171","msg":"trace[340360443] linearizableReadLoop","detail":"{readStateIndex:537; appliedIndex:536; }","duration":"375.517559ms","start":"2026-02-12T01:52:37.672054Z","end":"2026-02-12T01:52:38.047572Z","steps":["trace[340360443] 'read index received' (duration: 252.199316ms)","trace[340360443] 'applied index is now lower than readState.Index' (duration: 123.317633ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T01:52:38.047944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.954861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T01:52:38.047964Z","caller":"traceutil/trace.go:171","msg":"trace[1161381399] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:517; }","duration":"376.008299ms","start":"2026-02-12T01:52:37.671949Z","end":"2026-02-12T01:52:38.047957Z","steps":["trace[1161381399] 'agreement among raft nodes before linearized reading' (duration: 375.96995ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T01:52:38.047981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T01:52:37.671932Z","time spent":"376.044839ms","remote":"127.0.0.1:36436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-12T01:52:38.048166Z","caller":"traceutil/trace.go:171","msg":"trace[1836567744] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"593.67495ms","start":"2026-02-12T01:52:37.454481Z","end":"2026-02-12T01:52:38.048156Z","steps":["trace[1836567744] 'process raft request' (duration: 469.796399ms)","trace[1836567744] 'compare' (duration: 123.086727ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T01:52:38.048197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T01:52:37.454465Z","time spent":"593.71576ms","remote":"127.0.0.1:36658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16799,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-12T01:52:38.048795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.210896ms","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-12T01:52:38.048819Z","caller":"traceutil/trace.go:171","msg":"trace[1070816739] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:517; }","duration":"318.268395ms","start":"2026-02-12T01:52:37.730546Z","end":"2026-02-12T01:52:38.048815Z","steps":["trace[1070816739] 'agreement among raft nodes before linearized reading' (duration: 318.232296ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T01:52:38.048833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T01:52:37.730534Z","time spent":"318.296144ms","remote":"127.0.0.1:36742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-12T01:52:39.820692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.51120141s","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-02-12T01:52:39.820738Z","caller":"traceutil/trace.go:171","msg":"trace[1165206527] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:518; }","duration":"1.511290448s","start":"2026-02-12T01:52:38.309437Z","end":"2026-02-12T01:52:39.820728Z","steps":["trace[1165206527] 'range keys from in-memory index tree' (duration: 1.511088053s)"],"step_count":1} {"level":"warn","ts":"2026-02-12T01:52:39.82076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T01:52:38.309366Z","time spent":"1.511389417s","remote":"127.0.0.1:36742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-12T01:52:39.821307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.016426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-12T01:52:39.821323Z","caller":"traceutil/trace.go:171","msg":"trace[17605177] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:518; }","duration":"405.064985ms","start":"2026-02-12T01:52:39.416253Z","end":"2026-02-12T01:52:39.821318Z","steps":["trace[17605177] 'range keys from in-memory index tree' (duration: 404.908308ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T01:52:39.821335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T01:52:39.416235Z","time spent":"405.097085ms","remote":"127.0.0.1:36742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-12T01:52:39.821457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.024714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-12T01:52:39.82147Z","caller":"traceutil/trace.go:171","msg":"trace[1576938745] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:518; }","duration":"378.085123ms","start":"2026-02-12T01:52:39.443381Z","end":"2026-02-12T01:52:39.821466Z","steps":["trace[1576938745] 'range keys from in-memory index tree' (duration: 377.970925ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T01:52:39.821482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T01:52:39.443369Z","time spent":"378.110073ms","remote":"127.0.0.1:36742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-12T01:52:39.821721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.371192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T01:52:39.821735Z","caller":"traceutil/trace.go:171","msg":"trace[730048491] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:518; }","duration":"149.410572ms","start":"2026-02-12T01:52:39.67232Z","end":"2026-02-12T01:52:39.82173Z","steps":["trace[730048491] 'range keys from in-memory index tree' (duration: 149.328273ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T01:52:42.073352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.120198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T01:52:42.073444Z","caller":"traceutil/trace.go:171","msg":"trace[697854068] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:534; }","duration":"401.243676ms","start":"2026-02-12T01:52:41.672183Z","end":"2026-02-12T01:52:42.073426Z","steps":["trace[697854068] 'range keys from in-memory index tree' (duration: 401.074579ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T01:52:42.073482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T01:52:41.67217Z","time spent":"401.303636ms","remote":"127.0.0.1:36436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-12T01:52:42.073717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.173825ms","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-02-12T01:52:42.073747Z","caller":"traceutil/trace.go:171","msg":"trace[201390132] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:534; }","duration":"241.235973ms","start":"2026-02-12T01:52:41.832499Z","end":"2026-02-12T01:52:42.073735Z","steps":["trace[201390132] 'range keys from in-memory index tree' (duration: 241.058096ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T01:52:42.073902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.178928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-12T01:52:42.073927Z","caller":"traceutil/trace.go:171","msg":"trace[1034397346] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:534; }","duration":"239.222728ms","start":"2026-02-12T01:52:41.834696Z","end":"2026-02-12T01:52:42.073919Z","steps":["trace[1034397346] 'range keys from in-memory index tree' (duration: 239.10039ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T01:52:42.074118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.266675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-12T01:52:42.074146Z","caller":"traceutil/trace.go:171","msg":"trace[2109205964] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:534; }","duration":"238.315133ms","start":"2026-02-12T01:52:41.835823Z","end":"2026-02-12T01:52:42.074139Z","steps":["trace[2109205964] 'range keys from in-memory index tree' (duration: 238.185425ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T01:52:42.074324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.160836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-02-12T01:52:42.074352Z","caller":"traceutil/trace.go:171","msg":"trace[306430373] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:534; }","duration":"108.190316ms","start":"2026-02-12T01:52:41.966154Z","end":"2026-02-12T01:52:42.074344Z","steps":["trace[306430373] 'range keys from in-memory index tree' (duration: 108.099386ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T01:53:00.401243Z","caller":"traceutil/trace.go:171","msg":"trace[1715638583] linearizableReadLoop","detail":"{readStateIndex:748; appliedIndex:747; }","duration":"155.998921ms","start":"2026-02-12T01:53:00.245222Z","end":"2026-02-12T01:53:00.401221Z","steps":["trace[1715638583] 'read index received' (duration: 155.919631ms)","trace[1715638583] 'applied index is now lower than readState.Index' (duration: 78.61µs)"],"step_count":2} {"level":"info","ts":"2026-02-12T01:53:00.401338Z","caller":"traceutil/trace.go:171","msg":"trace[585201932] transaction","detail":"{read_only:false; response_revision:723; number_of_response:1; }","duration":"171.286233ms","start":"2026-02-12T01:53:00.230044Z","end":"2026-02-12T01:53:00.40133Z","steps":["trace[585201932] 'process raft request' (duration: 171.069283ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T01:53:00.40154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.303152ms","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-12T01:53:00.401562Z","caller":"traceutil/trace.go:171","msg":"trace[212773797] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:723; }","duration":"156.356862ms","start":"2026-02-12T01:53:00.245198Z","end":"2026-02-12T01:53:00.401555Z","steps":["trace[212773797] 'agreement among raft nodes before linearized reading' (duration: 156.263901ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T01:53:00.401665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.764324ms","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-12T01:53:00.401682Z","caller":"traceutil/trace.go:171","msg":"trace[284471843] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:723; }","duration":"130.809644ms","start":"2026-02-12T01:53:00.270867Z","end":"2026-02-12T01:53:00.401676Z","steps":["trace[284471843] 'agreement among raft nodes before linearized reading' (duration: 130.743504ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T01:53:00.401898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.342588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-12T01:53:00.401915Z","caller":"traceutil/trace.go:171","msg":"trace[1671325418] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:723; }","duration":"127.371258ms","start":"2026-02-12T01:53:00.274539Z","end":"2026-02-12T01:53:00.40191Z","steps":["trace[1671325418] 'agreement among raft nodes before linearized reading' (duration: 127.320878ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T01:53:00.401914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.864995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-02-12T01:53:00.405222Z","caller":"traceutil/trace.go:171","msg":"trace[1021702073] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:723; }","duration":"124.951415ms","start":"2026-02-12T01:53:00.277003Z","end":"2026-02-12T01:53:00.401954Z","steps":["trace[1021702073] 'agreement among raft nodes before linearized reading' (duration: 124.781915ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T01:53:00.620456Z","caller":"traceutil/trace.go:171","msg":"trace[1862333821] transaction","detail":"{read_only:false; response_revision:727; number_of_response:1; }","duration":"207.383307ms","start":"2026-02-12T01:53:00.413054Z","end":"2026-02-12T01:53:00.620437Z","steps":["trace[1862333821] 'process raft request' (duration: 207.353187ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T01:53:00.620801Z","caller":"traceutil/trace.go:171","msg":"trace[1975668553] transaction","detail":"{read_only:false; response_revision:725; number_of_response:1; }","duration":"212.276435ms","start":"2026-02-12T01:53:00.408502Z","end":"2026-02-12T01:53:00.620779Z","steps":["trace[1975668553] 'process raft request' (duration: 204.696723ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T01:53:00.620898Z","caller":"traceutil/trace.go:171","msg":"trace[1973613238] transaction","detail":"{read_only:false; response_revision:726; number_of_response:1; }","duration":"209.24708ms","start":"2026-02-12T01:53:00.411637Z","end":"2026-02-12T01:53:00.620884Z","steps":["trace[1973613238] 'process raft request' (duration: 208.729899ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T01:53:01.385102Z","caller":"traceutil/trace.go:171","msg":"trace[2133663780] linearizableReadLoop","detail":"{readStateIndex:756; appliedIndex:755; }","duration":"171.292255ms","start":"2026-02-12T01:53:01.213754Z","end":"2026-02-12T01:53:01.385046Z","steps":["trace[2133663780] 'read index received' (duration: 136.182035ms)","trace[2133663780] 'applied index is now lower than readState.Index' (duration: 35.10929ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T01:53:01.386286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.509608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-02-12T01:53:01.386516Z","caller":"traceutil/trace.go:171","msg":"trace[1795758637] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:730; }","duration":"172.768329ms","start":"2026-02-12T01:53:01.213733Z","end":"2026-02-12T01:53:01.386502Z","steps":["trace[1795758637] 'agreement among raft nodes before linearized reading' (duration: 172.450948ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T01:53:01.387043Z","caller":"traceutil/trace.go:171","msg":"trace[1818327066] transaction","detail":"{read_only:false; response_revision:730; number_of_response:1; }","duration":"221.768871ms","start":"2026-02-12T01:53:01.16526Z","end":"2026-02-12T01:53:01.387028Z","steps":["trace[1818327066] 'process raft request' (duration: 184.667535ms)","trace[1818327066] 'compare' (duration: 34.987091ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T01:54:07.200152Z","caller":"traceutil/trace.go:171","msg":"trace[657973628] transaction","detail":"{read_only:false; response_revision:956; number_of_response:1; }","duration":"239.454836ms","start":"2026-02-12T01:54:06.96068Z","end":"2026-02-12T01:54:07.200135Z","steps":["trace[657973628] 'process raft request' (duration: 239.367593ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T01:54:07.200726Z","caller":"traceutil/trace.go:171","msg":"trace[1357497224] linearizableReadLoop","detail":"{readStateIndex:996; appliedIndex:996; }","duration":"226.934481ms","start":"2026-02-12T01:54:06.973783Z","end":"2026-02-12T01:54:07.200718Z","steps":["trace[1357497224] 'read index received' (duration: 226.928951ms)","trace[1357497224] 'applied index is now lower than readState.Index' (duration: 4.86µs)"],"step_count":2} {"level":"warn","ts":"2026-02-12T01:54:07.200824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.030654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-12T01:54:07.20084Z","caller":"traceutil/trace.go:171","msg":"trace[708041307] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:956; }","duration":"227.087586ms","start":"2026-02-12T01:54:06.973747Z","end":"2026-02-12T01:54:07.200835Z","steps":["trace[708041307] 'agreement among raft nodes before linearized reading' (duration: 227.017414ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T01:54:07.257979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.395807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-12T01:54:07.25809Z","caller":"traceutil/trace.go:171","msg":"trace[1565189930] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:957; }","duration":"258.549873ms","start":"2026-02-12T01:54:06.999527Z","end":"2026-02-12T01:54:07.258077Z","steps":["trace[1565189930] 'agreement among raft nodes before linearized reading' (duration: 258.334695ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T01:54:07.258436Z","caller":"traceutil/trace.go:171","msg":"trace[863183447] transaction","detail":"{read_only:false; response_revision:957; number_of_response:1; }","duration":"247.690324ms","start":"2026-02-12T01:54:07.010736Z","end":"2026-02-12T01:54:07.258426Z","steps":["trace[863183447] 'process raft request' (duration: 236.825944ms)","trace[863183447] 'compare' (duration: 10.236258ms)"],"step_count":2}