{"level":"warn","ts":"2026-02-26T18:54:15.229296Z","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-26T18:54:15.229427Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.195: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.195:2380","--initial-cluster=instance=https://162.253.55.195:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.195:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.195: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-26T18:54:15.229521Z","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-26T18:54:15.229533Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.195:2380"]} {"level":"info","ts":"2026-02-26T18:54:15.229574Z","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-26T18:54:15.23052Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.195:2379"]} {"level":"info","ts":"2026-02-26T18:54:15.23063Z","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.195:2380"],"listen-peer-urls":["https://162.253.55.195:2380"],"advertise-client-urls":["https://162.253.55.195:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.195:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.195: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-26T18:54:15.235548Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.646057ms"} {"level":"info","ts":"2026-02-26T18:54:15.24791Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b66d12fd59101739","cluster-id":"a64a525934ce8379"} {"level":"info","ts":"2026-02-26T18:54:15.248008Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 switched to configuration voters=()"} {"level":"info","ts":"2026-02-26T18:54:15.248041Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became follower at term 0"} {"level":"info","ts":"2026-02-26T18:54:15.24806Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b66d12fd59101739 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-26T18:54:15.24807Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became follower at term 1"} {"level":"info","ts":"2026-02-26T18:54:15.248115Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 switched to configuration voters=(13145183766694598457)"} {"level":"warn","ts":"2026-02-26T18:54:15.254713Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-26T18:54:15.25599Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-26T18:54:15.257127Z","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-26T18:54:15.259409Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b66d12fd59101739","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-26T18:54:15.259725Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b66d12fd59101739","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-26T18:54:15.261059Z","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-26T18:54:15.261192Z","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-26T18:54:15.261209Z","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-26T18:54:15.261381Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 switched to configuration voters=(13145183766694598457)"} {"level":"info","ts":"2026-02-26T18:54:15.261885Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"a64a525934ce8379","local-member-id":"b66d12fd59101739","added-peer-id":"b66d12fd59101739","added-peer-peer-urls":["https://162.253.55.195:2380"]} {"level":"info","ts":"2026-02-26T18:54:15.264082Z","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-26T18:54:15.264364Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b66d12fd59101739","initial-advertise-peer-urls":["https://162.253.55.195:2380"],"listen-peer-urls":["https://162.253.55.195:2380"],"advertise-client-urls":["https://162.253.55.195:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.195:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-26T18:54:15.264391Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-26T18:54:15.264172Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.195:2380"} {"level":"info","ts":"2026-02-26T18:54:15.265315Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.195:2380"} {"level":"info","ts":"2026-02-26T18:54:15.749143Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 is starting a new election at term 1"} {"level":"info","ts":"2026-02-26T18:54:15.749311Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-26T18:54:15.749401Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 received MsgPreVoteResp from b66d12fd59101739 at term 1"} {"level":"info","ts":"2026-02-26T18:54:15.749458Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became candidate at term 2"} {"level":"info","ts":"2026-02-26T18:54:15.749532Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 received MsgVoteResp from b66d12fd59101739 at term 2"} {"level":"info","ts":"2026-02-26T18:54:15.749648Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became leader at term 2"} {"level":"info","ts":"2026-02-26T18:54:15.749713Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b66d12fd59101739 elected leader b66d12fd59101739 at term 2"} {"level":"info","ts":"2026-02-26T18:54:15.750879Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T18:54:15.751847Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b66d12fd59101739","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.195:2379]}","request-path":"/0/members/b66d12fd59101739/attributes","cluster-id":"a64a525934ce8379","publish-timeout":"7s"} {"level":"info","ts":"2026-02-26T18:54:15.75197Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-26T18:54:15.752002Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-26T18:54:15.752257Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"a64a525934ce8379","local-member-id":"b66d12fd59101739","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T18:54:15.75251Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T18:54:15.752607Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T18:54:15.752777Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-26T18:54:15.752861Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-26T18:54:15.755301Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.195:2379"} {"level":"info","ts":"2026-02-26T18:54:15.756069Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-26T18:54:32.481647Z","caller":"traceutil/trace.go:171","msg":"trace[716386131] transaction","detail":"{read_only:false; response_revision:396; number_of_response:1; }","duration":"120.925967ms","start":"2026-02-26T18:54:32.36069Z","end":"2026-02-26T18:54:32.481616Z","steps":["trace[716386131] 'process raft request' (duration: 62.107417ms)","trace[716386131] 'compare' (duration: 58.529948ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T18:54:32.482035Z","caller":"traceutil/trace.go:171","msg":"trace[616015368] transaction","detail":"{read_only:false; response_revision:397; number_of_response:1; }","duration":"120.540704ms","start":"2026-02-26T18:54:32.361447Z","end":"2026-02-26T18:54:32.481988Z","steps":["trace[616015368] 'process raft request' (duration: 119.98175ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:54:32.48223Z","caller":"traceutil/trace.go:171","msg":"trace[1949224828] transaction","detail":"{read_only:false; response_revision:398; number_of_response:1; }","duration":"101.221566ms","start":"2026-02-26T18:54:32.380963Z","end":"2026-02-26T18:54:32.482185Z","steps":["trace[1949224828] 'process raft request' (duration: 100.929933ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:54:32.482257Z","caller":"traceutil/trace.go:171","msg":"trace[1787697585] transaction","detail":"{read_only:false; response_revision:399; number_of_response:1; }","duration":"100.753732ms","start":"2026-02-26T18:54:32.381453Z","end":"2026-02-26T18:54:32.482207Z","steps":["trace[1787697585] 'process raft request' (duration: 100.52469ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:54:34.363752Z","caller":"traceutil/trace.go:171","msg":"trace[483218534] transaction","detail":"{read_only:false; response_revision:412; number_of_response:1; }","duration":"129.424425ms","start":"2026-02-26T18:54:34.234304Z","end":"2026-02-26T18:54:34.363728Z","steps":["trace[483218534] 'process raft request' (duration: 129.260044ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:54:40.951394Z","caller":"traceutil/trace.go:171","msg":"trace[473216436] transaction","detail":"{read_only:false; response_revision:426; number_of_response:1; }","duration":"554.719529ms","start":"2026-02-26T18:54:40.396617Z","end":"2026-02-26T18:54:40.951337Z","steps":["trace[473216436] 'process raft request' (duration: 554.403827ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:54:40.952706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T18:54:40.396594Z","time spent":"554.87978ms","remote":"127.0.0.1:58392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T18:54:45.124635Z","caller":"traceutil/trace.go:171","msg":"trace[1481231689] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"155.036173ms","start":"2026-02-26T18:54:44.969562Z","end":"2026-02-26T18:54:45.124598Z","steps":["trace[1481231689] 'process raft request' (duration: 154.816321ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:54:45.935206Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1673540927374283795,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-26T18:54:46.436001Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1673540927374283795,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-26T18:54:46.596268Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.382536632s","expected-duration":"1s"} {"level":"info","ts":"2026-02-26T18:54:46.596677Z","caller":"traceutil/trace.go:171","msg":"trace[1576028363] linearizableReadLoop","detail":"{readStateIndex:487; appliedIndex:486; }","duration":"1.161768252s","start":"2026-02-26T18:54:45.434889Z","end":"2026-02-26T18:54:46.596657Z","steps":["trace[1576028363] 'read index received' (duration: 1.16154251s)","trace[1576028363] 'applied index is now lower than readState.Index' (duration: 224.822µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T18:54:46.596787Z","caller":"traceutil/trace.go:171","msg":"trace[1809347536] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"1.452459713s","start":"2026-02-26T18:54:45.144319Z","end":"2026-02-26T18:54:46.596779Z","steps":["trace[1809347536] 'process raft request' (duration: 1.45213301s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:54:46.596969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T18:54:45.144287Z","time spent":"1.452527613s","remote":"127.0.0.1:58392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T18:54:46.597058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"682.720937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-26T18:54:46.597191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.597915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4375"} {"level":"info","ts":"2026-02-26T18:54:46.597217Z","caller":"traceutil/trace.go:171","msg":"trace[669999808] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:470; }","duration":"682.94434ms","start":"2026-02-26T18:54:45.914245Z","end":"2026-02-26T18:54:46.59719Z","steps":["trace[669999808] 'agreement among raft nodes before linearized reading' (duration: 682.682788ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:54:46.597282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T18:54:45.914221Z","time spent":"683.05051ms","remote":"127.0.0.1:58108","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-26T18:54:46.597289Z","caller":"traceutil/trace.go:171","msg":"trace[669767415] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:470; }","duration":"540.712495ms","start":"2026-02-26T18:54:46.056545Z","end":"2026-02-26T18:54:46.597258Z","steps":["trace[669767415] 'agreement among raft nodes before linearized reading' (duration: 540.342493ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:54:46.597366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T18:54:46.056525Z","time spent":"540.825946ms","remote":"127.0.0.1:58304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4399,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-02-26T18:54:46.597126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.162176745s","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-26T18:54:46.597758Z","caller":"traceutil/trace.go:171","msg":"trace[433758780] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:470; }","duration":"1.162909201s","start":"2026-02-26T18:54:45.434833Z","end":"2026-02-26T18:54:46.597742Z","steps":["trace[433758780] 'agreement among raft nodes before linearized reading' (duration: 1.162133745s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:54:46.597802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T18:54:45.434803Z","time spent":"1.162988321s","remote":"127.0.0.1:58392","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-26T18:54:46.598178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"718.719841ms","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-26T18:54:46.598295Z","caller":"traceutil/trace.go:171","msg":"trace[381425865] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:470; }","duration":"718.840152ms","start":"2026-02-26T18:54:45.879437Z","end":"2026-02-26T18:54:46.598277Z","steps":["trace[381425865] 'agreement among raft nodes before linearized reading' (duration: 717.456692ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:54:46.598329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T18:54:45.879354Z","time spent":"718.966982ms","remote":"127.0.0.1:58392","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-26T18:54:46.827585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.158678ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-26T18:54:46.827838Z","caller":"traceutil/trace.go:171","msg":"trace[2096675852] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"224.787398ms","start":"2026-02-26T18:54:46.602904Z","end":"2026-02-26T18:54:46.827691Z","steps":["trace[2096675852] 'process raft request' (duration: 85.212407ms)","trace[2096675852] 'compare' (duration: 139.014257ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T18:54:46.85629Z","caller":"traceutil/trace.go:171","msg":"trace[2132557815] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"249.210735ms","start":"2026-02-26T18:54:46.607061Z","end":"2026-02-26T18:54:46.856272Z","steps":["trace[2132557815] 'process raft request' (duration: 249.164674ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:54:46.856315Z","caller":"traceutil/trace.go:171","msg":"trace[1381587065] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"253.163623ms","start":"2026-02-26T18:54:46.60313Z","end":"2026-02-26T18:54:46.856293Z","steps":["trace[1381587065] 'process raft request' (duration: 253.007302ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:54:48.246234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.117129428s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-26T18:54:48.246316Z","caller":"traceutil/trace.go:171","msg":"trace[1958431972] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:473; }","duration":"1.117251798s","start":"2026-02-26T18:54:47.129041Z","end":"2026-02-26T18:54:48.246293Z","steps":["trace[1958431972] 'range keys from in-memory index tree' (duration: 1.116981386s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:54:48.246355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T18:54:47.129022Z","time spent":"1.11732534s","remote":"127.0.0.1:58392","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":"info","ts":"2026-02-26T18:54:48.246419Z","caller":"traceutil/trace.go:171","msg":"trace[1774371750] linearizableReadLoop","detail":"{readStateIndex:491; appliedIndex:490; }","duration":"328.857041ms","start":"2026-02-26T18:54:47.917543Z","end":"2026-02-26T18:54:48.2464Z","steps":["trace[1774371750] 'read index received' (duration: 238.692907ms)","trace[1774371750] 'applied index is now lower than readState.Index' (duration: 90.163374ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T18:54:48.246497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.941912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T18:54:48.246518Z","caller":"traceutil/trace.go:171","msg":"trace[1567379818] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:474; }","duration":"329.013912ms","start":"2026-02-26T18:54:47.917494Z","end":"2026-02-26T18:54:48.246508Z","steps":["trace[1567379818] 'agreement among raft nodes before linearized reading' (duration: 328.965801ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:54:48.246536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T18:54:47.91747Z","time spent":"329.062152ms","remote":"127.0.0.1:58108","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-26T18:54:48.246511Z","caller":"traceutil/trace.go:171","msg":"trace[1229311278] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"443.835667ms","start":"2026-02-26T18:54:47.802641Z","end":"2026-02-26T18:54:48.246477Z","steps":["trace[1229311278] 'process raft request' (duration: 353.695564ms)","trace[1229311278] 'compare' (duration: 89.991772ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T18:54:48.246656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T18:54:47.802617Z","time spent":"443.961248ms","remote":"127.0.0.1:58392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T18:54:55.353448Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1673540927374283894,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-26T18:54:55.684137Z","caller":"traceutil/trace.go:171","msg":"trace[1304834394] linearizableReadLoop","detail":"{readStateIndex:535; appliedIndex:534; }","duration":"831.041423ms","start":"2026-02-26T18:54:54.853071Z","end":"2026-02-26T18:54:55.684112Z","steps":["trace[1304834394] 'read index received' (duration: 830.793981ms)","trace[1304834394] 'applied index is now lower than readState.Index' (duration: 246.392µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T18:54:55.684225Z","caller":"traceutil/trace.go:171","msg":"trace[861764543] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"870.165301ms","start":"2026-02-26T18:54:54.814021Z","end":"2026-02-26T18:54:55.684186Z","steps":["trace[861764543] 'process raft request' (duration: 869.844959ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:54:55.684354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"767.810588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-26T18:54:55.684372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"792.182045ms","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-26T18:54:55.684419Z","caller":"traceutil/trace.go:171","msg":"trace[1277424847] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:516; }","duration":"792.262746ms","start":"2026-02-26T18:54:54.892142Z","end":"2026-02-26T18:54:55.684405Z","steps":["trace[1277424847] 'agreement among raft nodes before linearized reading' (duration: 792.112325ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:54:55.68442Z","caller":"traceutil/trace.go:171","msg":"trace[104395881] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:516; }","duration":"767.921469ms","start":"2026-02-26T18:54:54.916481Z","end":"2026-02-26T18:54:55.684402Z","steps":["trace[104395881] 'agreement among raft nodes before linearized reading' (duration: 767.804628ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:54:55.684463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T18:54:54.916466Z","time spent":"767.989249ms","remote":"127.0.0.1:58100","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-26T18:54:55.684463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T18:54:54.892126Z","time spent":"792.329006ms","remote":"127.0.0.1:58392","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-26T18:54:55.684461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T18:54:54.81399Z","time spent":"870.374202ms","remote":"127.0.0.1:58320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T18:54:55.684448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"831.346265ms","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-26T18:54:55.684534Z","caller":"traceutil/trace.go:171","msg":"trace[312016829] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:516; }","duration":"831.484405ms","start":"2026-02-26T18:54:54.853028Z","end":"2026-02-26T18:54:55.684513Z","steps":["trace[312016829] 'agreement among raft nodes before linearized reading' (duration: 831.173553ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:54:55.684589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T18:54:54.853009Z","time spent":"831.570236ms","remote":"127.0.0.1:58392","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-26T18:54:56.772962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.101128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-26T18:54:56.773031Z","caller":"traceutil/trace.go:171","msg":"trace[1444111637] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:518; }","duration":"400.212329ms","start":"2026-02-26T18:54:56.372802Z","end":"2026-02-26T18:54:56.773015Z","steps":["trace[1444111637] 'range keys from in-memory index tree' (duration: 399.922927ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:54:56.773064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T18:54:56.372789Z","time spent":"400.268769ms","remote":"127.0.0.1:58392","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-26T18:54:56.772977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"857.901361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T18:54:56.773708Z","caller":"traceutil/trace.go:171","msg":"trace[878675420] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:518; }","duration":"858.680126ms","start":"2026-02-26T18:54:55.915002Z","end":"2026-02-26T18:54:56.773682Z","steps":["trace[878675420] 'range keys from in-memory index tree' (duration: 857.82383ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:54:56.773773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T18:54:55.914943Z","time spent":"858.811937ms","remote":"127.0.0.1:58108","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-26T18:54:57.291383Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1673540927374283902,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-26T18:54:57.791853Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1673540927374283902,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-26T18:54:57.984406Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.207580816s","expected-duration":"1s"} {"level":"info","ts":"2026-02-26T18:54:57.984749Z","caller":"traceutil/trace.go:171","msg":"trace[646162170] linearizableReadLoop","detail":"{readStateIndex:538; appliedIndex:537; }","duration":"1.194333616s","start":"2026-02-26T18:54:56.790393Z","end":"2026-02-26T18:54:57.984726Z","steps":["trace[646162170] 'read index received' (duration: 1.194125825s)","trace[646162170] 'applied index is now lower than readState.Index' (duration: 206.781µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T18:54:57.984864Z","caller":"traceutil/trace.go:171","msg":"trace[281621336] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"1.208098259s","start":"2026-02-26T18:54:56.776735Z","end":"2026-02-26T18:54:57.984833Z","steps":["trace[281621336] 'process raft request' (duration: 1.207874358s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:54:57.984914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.068652363s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-26T18:54:57.98493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.194531508s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-02-26T18:54:57.984959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.674525ms","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-26T18:54:57.984961Z","caller":"traceutil/trace.go:171","msg":"trace[1457321792] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:519; }","duration":"1.194590578s","start":"2026-02-26T18:54:56.790361Z","end":"2026-02-26T18:54:57.984952Z","steps":["trace[1457321792] 'agreement among raft nodes before linearized reading' (duration: 1.194468327s)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:54:57.984964Z","caller":"traceutil/trace.go:171","msg":"trace[880069779] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:519; }","duration":"1.068749943s","start":"2026-02-26T18:54:56.9162Z","end":"2026-02-26T18:54:57.98495Z","steps":["trace[880069779] 'agreement among raft nodes before linearized reading' (duration: 1.068661442s)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:54:57.98498Z","caller":"traceutil/trace.go:171","msg":"trace[48589919] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:519; }","duration":"191.719215ms","start":"2026-02-26T18:54:57.793254Z","end":"2026-02-26T18:54:57.984974Z","steps":["trace[48589919] 'agreement among raft nodes before linearized reading' (duration: 191.663145ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:54:57.984975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T18:54:56.776711Z","time spent":"1.20819208s","remote":"127.0.0.1:58392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T18:54:57.984995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T18:54:56.790348Z","time spent":"1.194641738s","remote":"127.0.0.1:58392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-26T18:54:57.984998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T18:54:56.916182Z","time spent":"1.068808463s","remote":"127.0.0.1:58108","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-26T18:54:57.985081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.35878ms","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-26T18:54:57.985106Z","caller":"traceutil/trace.go:171","msg":"trace[232077831] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:519; }","duration":"192.40178ms","start":"2026-02-26T18:54:57.792696Z","end":"2026-02-26T18:54:57.985097Z","steps":["trace[232077831] 'agreement among raft nodes before linearized reading' (duration: 192.319109ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:54:58.097481Z","caller":"traceutil/trace.go:171","msg":"trace[1383684978] linearizableReadLoop","detail":"{readStateIndex:541; appliedIndex:538; }","duration":"102.792911ms","start":"2026-02-26T18:54:57.994672Z","end":"2026-02-26T18:54:58.097465Z","steps":["trace[1383684978] 'read index received' (duration: 70.295372ms)","trace[1383684978] 'applied index is now lower than readState.Index' (duration: 32.496759ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T18:54:58.097568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.886661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T18:54:58.097587Z","caller":"traceutil/trace.go:171","msg":"trace[697463744] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:522; }","duration":"102.945553ms","start":"2026-02-26T18:54:57.994633Z","end":"2026-02-26T18:54:58.097579Z","steps":["trace[697463744] 'agreement among raft nodes before linearized reading' (duration: 102.894742ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:54:58.097596Z","caller":"traceutil/trace.go:171","msg":"trace[102278570] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"107.711564ms","start":"2026-02-26T18:54:57.989829Z","end":"2026-02-26T18:54:58.097541Z","steps":["trace[102278570] 'process raft request' (duration: 107.500503ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:54:58.097758Z","caller":"traceutil/trace.go:171","msg":"trace[1517184459] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"106.564557ms","start":"2026-02-26T18:54:57.991166Z","end":"2026-02-26T18:54:58.09773Z","steps":["trace[1517184459] 'process raft request' (duration: 106.263805ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:55:00.274531Z","caller":"traceutil/trace.go:171","msg":"trace[1693116495] linearizableReadLoop","detail":"{readStateIndex:566; appliedIndex:565; }","duration":"285.885701ms","start":"2026-02-26T18:54:59.988611Z","end":"2026-02-26T18:55:00.274497Z","steps":["trace[1693116495] 'read index received' (duration: 285.780361ms)","trace[1693116495] 'applied index is now lower than readState.Index' (duration: 104.3µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T18:55:00.274607Z","caller":"traceutil/trace.go:171","msg":"trace[1537246497] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"335.918246ms","start":"2026-02-26T18:54:59.93862Z","end":"2026-02-26T18:55:00.274538Z","steps":["trace[1537246497] 'process raft request' (duration: 335.753295ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:55:00.274722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T18:54:59.938594Z","time spent":"336.074677ms","remote":"127.0.0.1:58180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3202,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T18:55:00.274787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.164933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-26T18:55:00.274844Z","caller":"traceutil/trace.go:171","msg":"trace[711484488] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:546; }","duration":"286.256424ms","start":"2026-02-26T18:54:59.988565Z","end":"2026-02-26T18:55:00.274821Z","steps":["trace[711484488] 'agreement among raft nodes before linearized reading' (duration: 286.071582ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:55:00.278971Z","caller":"traceutil/trace.go:171","msg":"trace[515296506] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"142.320477ms","start":"2026-02-26T18:55:00.13663Z","end":"2026-02-26T18:55:00.27895Z","steps":["trace[515296506] 'process raft request' (duration: 141.978994ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:55:00.279092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.37006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-02-26T18:55:00.279093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.925197ms","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-26T18:55:00.279114Z","caller":"traceutil/trace.go:171","msg":"trace[157083315] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:547; }","duration":"177.43656ms","start":"2026-02-26T18:55:00.101672Z","end":"2026-02-26T18:55:00.279108Z","steps":["trace[157083315] 'agreement among raft nodes before linearized reading' (duration: 177.350579ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:55:00.279123Z","caller":"traceutil/trace.go:171","msg":"trace[601684776] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:547; }","duration":"176.977167ms","start":"2026-02-26T18:55:00.102138Z","end":"2026-02-26T18:55:00.279115Z","steps":["trace[601684776] 'agreement among raft nodes before linearized reading' (duration: 176.843746ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:55:00.279528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.442196ms","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-26T18:55:00.279598Z","caller":"traceutil/trace.go:171","msg":"trace[1295628898] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:547; }","duration":"211.544487ms","start":"2026-02-26T18:55:00.068017Z","end":"2026-02-26T18:55:00.279562Z","steps":["trace[1295628898] 'agreement among raft nodes before linearized reading' (duration: 210.880042ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:56:16.971989Z","caller":"traceutil/trace.go:171","msg":"trace[1238641544] linearizableReadLoop","detail":"{readStateIndex:960; appliedIndex:958; }","duration":"274.952951ms","start":"2026-02-26T18:56:16.697003Z","end":"2026-02-26T18:56:16.971956Z","steps":["trace[1238641544] 'read index received' (duration: 95.860462ms)","trace[1238641544] 'applied index is now lower than readState.Index' (duration: 179.091169ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T18:56:16.97203Z","caller":"traceutil/trace.go:171","msg":"trace[1126281693] transaction","detail":"{read_only:false; response_revision:921; number_of_response:1; }","duration":"276.237371ms","start":"2026-02-26T18:56:16.695757Z","end":"2026-02-26T18:56:16.971994Z","steps":["trace[1126281693] 'process raft request' (duration: 274.408078ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:56:16.972385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.850316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-26T18:56:16.973363Z","caller":"traceutil/trace.go:171","msg":"trace[1588604735] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:921; }","duration":"233.853559ms","start":"2026-02-26T18:56:16.739483Z","end":"2026-02-26T18:56:16.973337Z","steps":["trace[1588604735] 'agreement among raft nodes before linearized reading' (duration: 232.780034ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:56:16.973506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.286152ms","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-26T18:56:16.973622Z","caller":"traceutil/trace.go:171","msg":"trace[1191285121] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:921; }","duration":"276.400725ms","start":"2026-02-26T18:56:16.697181Z","end":"2026-02-26T18:56:16.973582Z","steps":["trace[1191285121] 'agreement among raft nodes before linearized reading' (duration: 274.944781ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:56:16.973087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.060096ms","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-26T18:56:16.975091Z","caller":"traceutil/trace.go:171","msg":"trace[2007536921] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:921; }","duration":"278.095444ms","start":"2026-02-26T18:56:16.696969Z","end":"2026-02-26T18:56:16.975065Z","steps":["trace[2007536921] 'agreement among raft nodes before linearized reading' (duration: 275.064924ms)"],"step_count":1}