{"level":"warn","ts":"2026-02-08T16:33:15.268493Z","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-08T16:33:15.268635Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.212: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.212:2380","--initial-cluster=instance=https://162.253.55.212:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.212:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.212: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-08T16:33:15.268733Z","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-08T16:33:15.268744Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.212:2380"]} {"level":"info","ts":"2026-02-08T16:33:15.268759Z","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-08T16:33:15.269476Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.212:2379"]} {"level":"info","ts":"2026-02-08T16:33:15.269546Z","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.212:2380"],"listen-peer-urls":["https://162.253.55.212:2380"],"advertise-client-urls":["https://162.253.55.212:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.212:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.212: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-08T16:33:15.273538Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.800901ms"} {"level":"info","ts":"2026-02-08T16:33:15.313398Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d078b1e39c21939c","cluster-id":"cdc9ba8de57e3589"} {"level":"info","ts":"2026-02-08T16:33:15.313516Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d078b1e39c21939c switched to configuration voters=()"} {"level":"info","ts":"2026-02-08T16:33:15.313545Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d078b1e39c21939c became follower at term 0"} {"level":"info","ts":"2026-02-08T16:33:15.313591Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d078b1e39c21939c [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-08T16:33:15.313607Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d078b1e39c21939c became follower at term 1"} {"level":"info","ts":"2026-02-08T16:33:15.313872Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d078b1e39c21939c switched to configuration voters=(15021952148229428124)"} {"level":"warn","ts":"2026-02-08T16:33:15.323989Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-08T16:33:15.32956Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-08T16:33:15.333585Z","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-08T16:33:15.340875Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d078b1e39c21939c","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-08T16:33:15.342494Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d078b1e39c21939c","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-08T16:33:15.368523Z","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-08T16:33:15.368554Z","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-08T16:33:15.36856Z","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-08T16:33:15.368708Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d078b1e39c21939c switched to configuration voters=(15021952148229428124)"} {"level":"info","ts":"2026-02-08T16:33:15.368763Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"cdc9ba8de57e3589","local-member-id":"d078b1e39c21939c","added-peer-id":"d078b1e39c21939c","added-peer-peer-urls":["https://162.253.55.212:2380"]} {"level":"info","ts":"2026-02-08T16:33:15.368992Z","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-08T16:33:15.369136Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.212:2380"} {"level":"info","ts":"2026-02-08T16:33:15.369145Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.212:2380"} {"level":"info","ts":"2026-02-08T16:33:15.369246Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d078b1e39c21939c","initial-advertise-peer-urls":["https://162.253.55.212:2380"],"listen-peer-urls":["https://162.253.55.212:2380"],"advertise-client-urls":["https://162.253.55.212:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.212:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-08T16:33:15.369264Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-08T16:33:16.314187Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d078b1e39c21939c is starting a new election at term 1"} {"level":"info","ts":"2026-02-08T16:33:16.314225Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d078b1e39c21939c became pre-candidate at term 1"} {"level":"info","ts":"2026-02-08T16:33:16.314251Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d078b1e39c21939c received MsgPreVoteResp from d078b1e39c21939c at term 1"} {"level":"info","ts":"2026-02-08T16:33:16.314339Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d078b1e39c21939c became candidate at term 2"} {"level":"info","ts":"2026-02-08T16:33:16.314346Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d078b1e39c21939c received MsgVoteResp from d078b1e39c21939c at term 2"} {"level":"info","ts":"2026-02-08T16:33:16.314447Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d078b1e39c21939c became leader at term 2"} {"level":"info","ts":"2026-02-08T16:33:16.31446Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d078b1e39c21939c elected leader d078b1e39c21939c at term 2"} {"level":"info","ts":"2026-02-08T16:33:16.32256Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-08T16:33:16.325825Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d078b1e39c21939c","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.212:2379]}","request-path":"/0/members/d078b1e39c21939c/attributes","cluster-id":"cdc9ba8de57e3589","publish-timeout":"7s"} {"level":"info","ts":"2026-02-08T16:33:16.325966Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-08T16:33:16.326266Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-08T16:33:16.326373Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"cdc9ba8de57e3589","local-member-id":"d078b1e39c21939c","cluster-version":"3.5"} {"level":"info","ts":"2026-02-08T16:33:16.326445Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-08T16:33:16.32647Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-08T16:33:16.326556Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-08T16:33:16.326636Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-08T16:33:16.328304Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.212:2379"} {"level":"info","ts":"2026-02-08T16:33:16.329202Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-08T16:33:24.938546Z","caller":"traceutil/trace.go:171","msg":"trace[130253613] transaction","detail":"{read_only:false; response_revision:295; number_of_response:1; }","duration":"137.158623ms","start":"2026-02-08T16:33:24.801371Z","end":"2026-02-08T16:33:24.93853Z","steps":["trace[130253613] 'process raft request' (duration: 137.010139ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:33:25.117413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.572335ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-08T16:33:25.117533Z","caller":"traceutil/trace.go:171","msg":"trace[805607371] transaction","detail":"{read_only:false; response_revision:296; number_of_response:1; }","duration":"167.432836ms","start":"2026-02-08T16:33:24.950089Z","end":"2026-02-08T16:33:25.117522Z","steps":["trace[805607371] 'process raft request' (duration: 28.993698ms)","trace[805607371] 'compare' (duration: 137.438411ms)"],"step_count":2} {"level":"warn","ts":"2026-02-08T16:33:25.465902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.970145ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-08T16:33:25.465978Z","caller":"traceutil/trace.go:171","msg":"trace[1895402195] transaction","detail":"{read_only:false; response_revision:297; number_of_response:1; }","duration":"337.866735ms","start":"2026-02-08T16:33:25.128096Z","end":"2026-02-08T16:33:25.465962Z","steps":["trace[1895402195] 'process raft request' (duration: 183.787737ms)","trace[1895402195] 'compare' (duration: 153.867832ms)"],"step_count":2} {"level":"warn","ts":"2026-02-08T16:33:25.466016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:33:25.128081Z","time spent":"337.922206ms","remote":"127.0.0.1:35982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":194,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-08T16:33:26.135275Z","caller":"traceutil/trace.go:171","msg":"trace[1927044494] transaction","detail":"{read_only:false; response_revision:308; number_of_response:1; }","duration":"124.911147ms","start":"2026-02-08T16:33:26.010329Z","end":"2026-02-08T16:33:26.13524Z","steps":["trace[1927044494] 'process raft request' (duration: 124.740542ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T16:33:26.135914Z","caller":"traceutil/trace.go:171","msg":"trace[392495240] transaction","detail":"{read_only:false; response_revision:309; number_of_response:1; }","duration":"124.30369ms","start":"2026-02-08T16:33:26.011597Z","end":"2026-02-08T16:33:26.135901Z","steps":["trace[392495240] 'process raft request' (duration: 123.583111ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T16:33:28.788577Z","caller":"traceutil/trace.go:171","msg":"trace[2102815231] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"100.78161ms","start":"2026-02-08T16:33:28.687777Z","end":"2026-02-08T16:33:28.788558Z","steps":["trace[2102815231] 'process raft request' (duration: 91.467789ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T16:33:30.804984Z","caller":"traceutil/trace.go:171","msg":"trace[1453748584] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"482.238358ms","start":"2026-02-08T16:33:30.322721Z","end":"2026-02-08T16:33:30.804959Z","steps":["trace[1453748584] 'process raft request' (duration: 482.055233ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:33:30.805319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:33:30.322707Z","time spent":"482.351062ms","remote":"127.0.0.1:35952","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4245,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-08T16:33:31.845091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"535.818455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4260"} {"level":"info","ts":"2026-02-08T16:33:31.845168Z","caller":"traceutil/trace.go:171","msg":"trace[1106581031] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:370; }","duration":"535.933998ms","start":"2026-02-08T16:33:31.30922Z","end":"2026-02-08T16:33:31.845154Z","steps":["trace[1106581031] 'range keys from in-memory index tree' (duration: 535.765304ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:33:31.8452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:33:31.309206Z","time spent":"535.9869ms","remote":"127.0.0.1:35952","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":4284,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" "} {"level":"warn","ts":"2026-02-08T16:33:31.845366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.252419ms","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-08T16:33:31.845385Z","caller":"traceutil/trace.go:171","msg":"trace[94129198] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:370; }","duration":"311.306141ms","start":"2026-02-08T16:33:31.534072Z","end":"2026-02-08T16:33:31.845378Z","steps":["trace[94129198] 'range keys from in-memory index tree' (duration: 311.150717ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:33:31.845402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:33:31.534054Z","time spent":"311.343211ms","remote":"127.0.0.1:36054","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":"info","ts":"2026-02-08T16:33:31.845646Z","caller":"traceutil/trace.go:171","msg":"trace[1325895746] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"295.717311ms","start":"2026-02-08T16:33:31.549919Z","end":"2026-02-08T16:33:31.845637Z","steps":["trace[1325895746] 'process raft request' (duration: 241.818261ms)","trace[1325895746] 'compare' (duration: 53.246303ms)"],"step_count":2} {"level":"info","ts":"2026-02-08T16:33:38.049963Z","caller":"traceutil/trace.go:171","msg":"trace[219150415] linearizableReadLoop","detail":"{readStateIndex:429; appliedIndex:428; }","duration":"109.147783ms","start":"2026-02-08T16:33:37.940798Z","end":"2026-02-08T16:33:38.049946Z","steps":["trace[219150415] 'read index received' (duration: 67.525496ms)","trace[219150415] 'applied index is now lower than readState.Index' (duration: 41.621567ms)"],"step_count":2} {"level":"info","ts":"2026-02-08T16:33:38.050101Z","caller":"traceutil/trace.go:171","msg":"trace[563053251] transaction","detail":"{read_only:false; response_revision:418; number_of_response:1; }","duration":"135.630897ms","start":"2026-02-08T16:33:37.914463Z","end":"2026-02-08T16:33:38.050094Z","steps":["trace[563053251] 'process raft request' (duration: 93.947059ms)","trace[563053251] 'compare' (duration: 41.436304ms)"],"step_count":2} {"level":"warn","ts":"2026-02-08T16:33:38.050246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.441707ms","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-08T16:33:38.050265Z","caller":"traceutil/trace.go:171","msg":"trace[1307896689] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:418; }","duration":"109.471718ms","start":"2026-02-08T16:33:37.940787Z","end":"2026-02-08T16:33:38.050258Z","steps":["trace[1307896689] 'agreement among raft nodes before linearized reading' (duration: 109.423657ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T16:33:40.233607Z","caller":"traceutil/trace.go:171","msg":"trace[1108936505] linearizableReadLoop","detail":"{readStateIndex:436; appliedIndex:435; }","duration":"168.94733ms","start":"2026-02-08T16:33:40.064642Z","end":"2026-02-08T16:33:40.233589Z","steps":["trace[1108936505] 'read index received' (duration: 168.826908ms)","trace[1108936505] 'applied index is now lower than readState.Index' (duration: 119.772µs)"],"step_count":2} {"level":"info","ts":"2026-02-08T16:33:40.233678Z","caller":"traceutil/trace.go:171","msg":"trace[732306335] transaction","detail":"{read_only:false; response_revision:424; number_of_response:1; }","duration":"174.84036ms","start":"2026-02-08T16:33:40.05883Z","end":"2026-02-08T16:33:40.23367Z","steps":["trace[732306335] 'process raft request' (duration: 174.675638ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:33:40.233869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.58074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-02-08T16:33:40.233954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.300785ms","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-08T16:33:40.233948Z","caller":"traceutil/trace.go:171","msg":"trace[1478116144] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:424; }","duration":"158.678702ms","start":"2026-02-08T16:33:40.075249Z","end":"2026-02-08T16:33:40.233928Z","steps":["trace[1478116144] 'agreement among raft nodes before linearized reading' (duration: 158.55801ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T16:33:40.233983Z","caller":"traceutil/trace.go:171","msg":"trace[493336090] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:424; }","duration":"169.379737ms","start":"2026-02-08T16:33:40.064595Z","end":"2026-02-08T16:33:40.233975Z","steps":["trace[493336090] 'agreement among raft nodes before linearized reading' (duration: 169.318996ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T16:33:44.477183Z","caller":"traceutil/trace.go:171","msg":"trace[1816133880] transaction","detail":"{read_only:false; response_revision:435; number_of_response:1; }","duration":"156.350056ms","start":"2026-02-08T16:33:44.320776Z","end":"2026-02-08T16:33:44.477126Z","steps":["trace[1816133880] 'process raft request' (duration: 73.00518ms)","trace[1816133880] 'compare' (duration: 83.119322ms)"],"step_count":2} {"level":"info","ts":"2026-02-08T16:33:49.303652Z","caller":"traceutil/trace.go:171","msg":"trace[63910531] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"101.291708ms","start":"2026-02-08T16:33:49.202341Z","end":"2026-02-08T16:33:49.303632Z","steps":["trace[63910531] 'process raft request' (duration: 94.678358ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T16:33:50.50996Z","caller":"traceutil/trace.go:171","msg":"trace[413393205] linearizableReadLoop","detail":"{readStateIndex:496; appliedIndex:495; }","duration":"121.516854ms","start":"2026-02-08T16:33:50.38843Z","end":"2026-02-08T16:33:50.509946Z","steps":["trace[413393205] 'read index received' (duration: 121.388712ms)","trace[413393205] 'applied index is now lower than readState.Index' (duration: 127.612µs)"],"step_count":2} {"level":"info","ts":"2026-02-08T16:33:50.510194Z","caller":"traceutil/trace.go:171","msg":"trace[1562229925] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"144.784118ms","start":"2026-02-08T16:33:50.365404Z","end":"2026-02-08T16:33:50.510188Z","steps":["trace[1562229925] 'process raft request' (duration: 144.453773ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:33:50.510349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.913712ms","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-08T16:33:50.510366Z","caller":"traceutil/trace.go:171","msg":"trace[245870860] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:482; }","duration":"121.966812ms","start":"2026-02-08T16:33:50.388394Z","end":"2026-02-08T16:33:50.51036Z","steps":["trace[245870860] 'agreement among raft nodes before linearized reading' (duration: 121.888451ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:33:54.894551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.899846ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-02-08T16:33:54.894615Z","caller":"traceutil/trace.go:171","msg":"trace[693471394] linearizableReadLoop","detail":"{readStateIndex:527; appliedIndex:526; }","duration":"358.886693ms","start":"2026-02-08T16:33:54.535716Z","end":"2026-02-08T16:33:54.894603Z","steps":["trace[693471394] 'read index received' (duration: 98.886756ms)","trace[693471394] 'applied index is now lower than readState.Index' (duration: 259.999107ms)"],"step_count":2} {"level":"warn","ts":"2026-02-08T16:33:54.894732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.007275ms","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-08T16:33:54.894747Z","caller":"traceutil/trace.go:171","msg":"trace[100914748] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:512; }","duration":"359.053215ms","start":"2026-02-08T16:33:54.535687Z","end":"2026-02-08T16:33:54.89474Z","steps":["trace[100914748] 'agreement among raft nodes before linearized reading' (duration: 358.967784ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:33:54.894763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:33:54.535673Z","time spent":"359.086565ms","remote":"127.0.0.1:36054","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-08T16:33:54.89488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.609283ms","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-08T16:33:54.894892Z","caller":"traceutil/trace.go:171","msg":"trace[579588582] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:512; }","duration":"332.661235ms","start":"2026-02-08T16:33:54.562226Z","end":"2026-02-08T16:33:54.894888Z","steps":["trace[579588582] 'agreement among raft nodes before linearized reading' (duration: 332.624784ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:33:54.894903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:33:54.562214Z","time spent":"332.686465ms","remote":"127.0.0.1:36054","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-08T16:33:54.895012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.826941ms","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-08T16:33:54.895025Z","caller":"traceutil/trace.go:171","msg":"trace[1544119268] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:512; }","duration":"323.840001ms","start":"2026-02-08T16:33:54.571181Z","end":"2026-02-08T16:33:54.895021Z","steps":["trace[1544119268] 'agreement among raft nodes before linearized reading' (duration: 323.79718ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:33:54.895037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:33:54.571161Z","time spent":"323.872632ms","remote":"127.0.0.1:36054","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-08T16:33:58.980731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"708.418051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-08T16:33:58.98078Z","caller":"traceutil/trace.go:171","msg":"trace[2008597456] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:523; }","duration":"708.503603ms","start":"2026-02-08T16:33:58.272266Z","end":"2026-02-08T16:33:58.980769Z","steps":["trace[2008597456] 'range keys from in-memory index tree' (duration: 708.361991ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:33:58.980802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:33:58.272251Z","time spent":"708.546603ms","remote":"127.0.0.1:35788","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-08T16:33:58.980925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.452553ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-08T16:33:58.980958Z","caller":"traceutil/trace.go:171","msg":"trace[1204015042] linearizableReadLoop","detail":"{readStateIndex:539; appliedIndex:538; }","duration":"589.342594ms","start":"2026-02-08T16:33:58.39161Z","end":"2026-02-08T16:33:58.980952Z","steps":["trace[1204015042] 'read index received' (duration: 81.807179ms)","trace[1204015042] 'applied index is now lower than readState.Index' (duration: 507.534865ms)"],"step_count":2} {"level":"info","ts":"2026-02-08T16:33:58.981006Z","caller":"traceutil/trace.go:171","msg":"trace[166429203] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"607.031211ms","start":"2026-02-08T16:33:58.373969Z","end":"2026-02-08T16:33:58.981001Z","steps":["trace[166429203] 'process raft request' (duration: 99.465315ms)","trace[166429203] 'compare' (duration: 507.251169ms)"],"step_count":2} {"level":"warn","ts":"2026-02-08T16:33:58.981029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:33:58.373953Z","time spent":"607.063792ms","remote":"127.0.0.1:36054","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-08T16:33:58.981125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"589.521447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-ngtrc\" ","response":"range_response_count:1 size:16656"} {"level":"info","ts":"2026-02-08T16:33:58.981141Z","caller":"traceutil/trace.go:171","msg":"trace[1667004010] range","detail":"{range_begin:/registry/pods/kube-system/cilium-ngtrc; range_end:; response_count:1; response_revision:524; }","duration":"589.561508ms","start":"2026-02-08T16:33:58.391575Z","end":"2026-02-08T16:33:58.981136Z","steps":["trace[1667004010] 'agreement among raft nodes before linearized reading' (duration: 589.521787ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:33:58.981153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:33:58.391548Z","time spent":"589.601788ms","remote":"127.0.0.1:35952","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16680,"request content":"key:\"/registry/pods/kube-system/cilium-ngtrc\" "} {"level":"warn","ts":"2026-02-08T16:33:59.685329Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10636548210474759821,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-08T16:34:00.185807Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10636548210474759821,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-08T16:34:00.686393Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10636548210474759821,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-08T16:34:01.186524Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10636548210474759821,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-08T16:34:01.210315Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.468303706s","expected-duration":"1s"} {"level":"warn","ts":"2026-02-08T16:34:01.273699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000183377s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-02-08T16:34:01.274124Z","caller":"traceutil/trace.go:171","msg":"trace[130821187] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000666746s","start":"2026-02-08T16:33:59.27344Z","end":"2026-02-08T16:34:01.274107Z","steps":["trace[130821187] 'agreement among raft nodes before linearized reading' (duration: 2.000218038s)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:34:01.27417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:33:59.273421Z","time spent":"2.000739887s","remote":"127.0.0.1:35798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-08T16:34:02.49312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.28240581s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-08T16:34:02.495928Z","caller":"traceutil/trace.go:171","msg":"trace[1633465465] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"3.510552831s","start":"2026-02-08T16:33:58.98536Z","end":"2026-02-08T16:34:02.495913Z","steps":["trace[1633465465] 'process raft request' (duration: 2.225268979s)","trace[1633465465] 'compare' (duration: 1.281951311s)"],"step_count":2} {"level":"warn","ts":"2026-02-08T16:34:02.496111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:33:58.985345Z","time spent":"3.510735444s","remote":"127.0.0.1:36054","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-08T16:34:02.68471Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.474177215s","expected-duration":"1s"} {"level":"info","ts":"2026-02-08T16:34:02.695914Z","caller":"traceutil/trace.go:171","msg":"trace[1931743664] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"3.701513506s","start":"2026-02-08T16:33:58.994373Z","end":"2026-02-08T16:34:02.695887Z","steps":["trace[1931743664] 'process raft request' (duration: 3.690497853s)","trace[1931743664] 'compare' (duration: 10.31261ms)"],"step_count":2} {"level":"warn","ts":"2026-02-08T16:34:02.696069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:33:58.994356Z","time spent":"3.701633228s","remote":"127.0.0.1:35952","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-08T16:34:02.696545Z","caller":"traceutil/trace.go:171","msg":"trace[1959825546] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"3.700287094s","start":"2026-02-08T16:33:58.996251Z","end":"2026-02-08T16:34:02.696538Z","steps":["trace[1959825546] 'process raft request' (duration: 3.699538381s)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:34:02.696588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:33:58.99624Z","time spent":"3.700324765s","remote":"127.0.0.1:36054","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-08T16:34:02.702777Z","caller":"traceutil/trace.go:171","msg":"trace[1384930537] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"3.706460128s","start":"2026-02-08T16:33:58.996297Z","end":"2026-02-08T16:34:02.702757Z","steps":["trace[1384930537] 'process raft request' (duration: 3.700190422s)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:34:02.702875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:33:58.996293Z","time spent":"3.706537489s","remote":"127.0.0.1:36054","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-08T16:34:02.703205Z","caller":"traceutil/trace.go:171","msg":"trace[647268782] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"140.052162ms","start":"2026-02-08T16:34:02.563144Z","end":"2026-02-08T16:34:02.703197Z","steps":["trace[647268782] 'process raft request' (duration: 133.370649ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T16:34:02.70331Z","caller":"traceutil/trace.go:171","msg":"trace[1168098750] linearizableReadLoop","detail":"{readStateIndex:543; appliedIndex:539; }","duration":"3.519102162s","start":"2026-02-08T16:33:59.184201Z","end":"2026-02-08T16:34:02.703303Z","steps":["trace[1168098750] 'read index received' (duration: 2.026438016s)","trace[1168098750] 'applied index is now lower than readState.Index' (duration: 1.492663396s)"],"step_count":2} {"level":"warn","ts":"2026-02-08T16:34:02.70347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.519275314s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.212\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-08T16:34:02.703494Z","caller":"traceutil/trace.go:171","msg":"trace[1514530366] range","detail":"{range_begin:/registry/masterleases/162.253.55.212; range_end:; response_count:1; response_revision:529; }","duration":"3.519334416s","start":"2026-02-08T16:33:59.184152Z","end":"2026-02-08T16:34:02.703487Z","steps":["trace[1514530366] 'agreement among raft nodes before linearized reading' (duration: 3.519292035s)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:34:02.703513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:33:59.184136Z","time spent":"3.519372726s","remote":"127.0.0.1:35806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/162.253.55.212\" "} {"level":"warn","ts":"2026-02-08T16:34:02.703718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.561296199s","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-08T16:34:02.703739Z","caller":"traceutil/trace.go:171","msg":"trace[1933627263] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:529; }","duration":"2.56135995s","start":"2026-02-08T16:34:00.142374Z","end":"2026-02-08T16:34:02.703734Z","steps":["trace[1933627263] 'agreement among raft nodes before linearized reading' (duration: 2.561268179s)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:34:02.703758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:34:00.142359Z","time spent":"2.561395101s","remote":"127.0.0.1:36054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-08T16:34:02.703881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.429332115s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-08T16:34:02.7039Z","caller":"traceutil/trace.go:171","msg":"trace[1709673285] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:529; }","duration":"1.429365066s","start":"2026-02-08T16:34:01.274528Z","end":"2026-02-08T16:34:02.703894Z","steps":["trace[1709673285] 'agreement among raft nodes before linearized reading' (duration: 1.429336006s)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:34:02.703917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:34:01.274519Z","time spent":"1.429393827s","remote":"127.0.0.1:35788","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-08T16:34:05.406657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"702.277069ms","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-08T16:34:05.406713Z","caller":"traceutil/trace.go:171","msg":"trace[2137013628] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:541; }","duration":"702.378341ms","start":"2026-02-08T16:34:04.704324Z","end":"2026-02-08T16:34:05.406702Z","steps":["trace[2137013628] 'range keys from in-memory index tree' (duration: 702.106055ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:34:05.406748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:34:04.704302Z","time spent":"702.433382ms","remote":"127.0.0.1:36054","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-08T16:34:05.406873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"681.515832ms","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-08T16:34:05.406893Z","caller":"traceutil/trace.go:171","msg":"trace[365200388] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:541; }","duration":"681.555643ms","start":"2026-02-08T16:34:04.725331Z","end":"2026-02-08T16:34:05.406887Z","steps":["trace[365200388] 'range keys from in-memory index tree' (duration: 681.449002ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:34:05.406906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:34:04.725322Z","time spent":"681.580974ms","remote":"127.0.0.1:36054","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-08T16:34:05.406989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"675.898627ms","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-08T16:34:05.407024Z","caller":"traceutil/trace.go:171","msg":"trace[455366507] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:541; }","duration":"675.937069ms","start":"2026-02-08T16:34:04.731065Z","end":"2026-02-08T16:34:05.407002Z","steps":["trace[455366507] 'range keys from in-memory index tree' (duration: 675.837387ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:34:05.407041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:34:04.731055Z","time spent":"675.982489ms","remote":"127.0.0.1:36054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-08T16:34:05.407262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.431807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-08T16:34:05.407281Z","caller":"traceutil/trace.go:171","msg":"trace[863753972] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:541; }","duration":"131.482969ms","start":"2026-02-08T16:34:05.275794Z","end":"2026-02-08T16:34:05.407276Z","steps":["trace[863753972] 'range keys from in-memory index tree' (duration: 131.347556ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T16:34:05.523905Z","caller":"traceutil/trace.go:171","msg":"trace[1193946779] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"112.566193ms","start":"2026-02-08T16:34:05.411317Z","end":"2026-02-08T16:34:05.523884Z","steps":["trace[1193946779] 'process raft request' (duration: 96.170475ms)","trace[1193946779] 'compare' (duration: 16.064342ms)"],"step_count":2} {"level":"info","ts":"2026-02-08T16:34:05.526411Z","caller":"traceutil/trace.go:171","msg":"trace[1961630729] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"111.708587ms","start":"2026-02-08T16:34:05.412156Z","end":"2026-02-08T16:34:05.523864Z","steps":["trace[1961630729] 'process raft request' (duration: 111.499753ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T16:34:10.116227Z","caller":"traceutil/trace.go:171","msg":"trace[147225242] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"123.951381ms","start":"2026-02-08T16:34:09.992251Z","end":"2026-02-08T16:34:10.116203Z","steps":["trace[147225242] 'process raft request' (duration: 123.497152ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T16:34:13.382649Z","caller":"traceutil/trace.go:171","msg":"trace[1173555123] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"153.362326ms","start":"2026-02-08T16:34:13.229268Z","end":"2026-02-08T16:34:13.382631Z","steps":["trace[1173555123] 'process raft request' (duration: 153.184802ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:34:13.383764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.150903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-08T16:34:13.3839Z","caller":"traceutil/trace.go:171","msg":"trace[1671819272] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:649; }","duration":"100.223915ms","start":"2026-02-08T16:34:13.283572Z","end":"2026-02-08T16:34:13.383795Z","steps":["trace[1671819272] 'agreement among raft nodes before linearized reading' (duration: 98.96493ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T16:35:29.308395Z","caller":"traceutil/trace.go:171","msg":"trace[44859945] transaction","detail":"{read_only:false; response_revision:964; number_of_response:1; }","duration":"107.662016ms","start":"2026-02-08T16:35:29.200712Z","end":"2026-02-08T16:35:29.308374Z","steps":["trace[44859945] 'process raft request' (duration: 64.499743ms)","trace[44859945] 'compare' (duration: 42.486296ms)"],"step_count":2}