{"level":"warn","ts":"2026-02-25T07:35:26.250022Z","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-25T07:35:26.25012Z","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-25T07:35:26.250198Z","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-25T07:35:26.250207Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.212:2380"]} {"level":"info","ts":"2026-02-25T07:35:26.250229Z","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-25T07:35:26.250898Z","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-25T07:35:26.250967Z","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.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-25T07:35:26.263048Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"11.897583ms"} {"level":"info","ts":"2026-02-25T07:35:26.282136Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d078b1e39c21939c","cluster-id":"cdc9ba8de57e3589"} {"level":"info","ts":"2026-02-25T07:35:26.28227Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d078b1e39c21939c switched to configuration voters=()"} {"level":"info","ts":"2026-02-25T07:35:26.28231Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d078b1e39c21939c became follower at term 0"} {"level":"info","ts":"2026-02-25T07:35:26.282338Z","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-25T07:35:26.282355Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d078b1e39c21939c became follower at term 1"} {"level":"info","ts":"2026-02-25T07:35:26.282422Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d078b1e39c21939c switched to configuration voters=(15021952148229428124)"} {"level":"warn","ts":"2026-02-25T07:35:26.299394Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-25T07:35:26.302793Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-25T07:35:26.306925Z","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-25T07:35:26.309808Z","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-25T07:35:26.310364Z","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-25T07:35:26.310459Z","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-25T07:35:26.310474Z","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-25T07:35:26.310436Z","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-25T07:35:26.313835Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d078b1e39c21939c switched to configuration voters=(15021952148229428124)"} {"level":"info","ts":"2026-02-25T07:35:26.313997Z","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-25T07:35:26.316603Z","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-25T07:35:26.316644Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.212:2380"} {"level":"info","ts":"2026-02-25T07:35:26.316686Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.212:2380"} {"level":"info","ts":"2026-02-25T07:35:26.316816Z","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-25T07:35:26.316864Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-25T07:35:26.582631Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d078b1e39c21939c is starting a new election at term 1"} {"level":"info","ts":"2026-02-25T07:35:26.582698Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d078b1e39c21939c became pre-candidate at term 1"} {"level":"info","ts":"2026-02-25T07:35:26.582742Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d078b1e39c21939c received MsgPreVoteResp from d078b1e39c21939c at term 1"} {"level":"info","ts":"2026-02-25T07:35:26.582762Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d078b1e39c21939c became candidate at term 2"} {"level":"info","ts":"2026-02-25T07:35:26.582774Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d078b1e39c21939c received MsgVoteResp from d078b1e39c21939c at term 2"} {"level":"info","ts":"2026-02-25T07:35:26.582791Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d078b1e39c21939c became leader at term 2"} {"level":"info","ts":"2026-02-25T07:35:26.582805Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d078b1e39c21939c elected leader d078b1e39c21939c at term 2"} {"level":"info","ts":"2026-02-25T07:35:26.589703Z","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-25T07:35:26.589988Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-25T07:35:26.590151Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-25T07:35:26.590704Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T07:35:26.592429Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-25T07:35:26.592498Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-25T07:35:26.594359Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-25T07:35:26.594772Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.212:2379"} {"level":"info","ts":"2026-02-25T07:35:26.595673Z","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-25T07:35:26.595863Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T07:35:26.603553Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T07:35:29.026155Z","caller":"traceutil/trace.go:171","msg":"trace[1411744127] transaction","detail":"{read_only:false; response_revision:70; number_of_response:1; }","duration":"413.27711ms","start":"2026-02-25T07:35:28.612858Z","end":"2026-02-25T07:35:29.026135Z","steps":["trace[1411744127] 'process raft request' (duration: 413.165956ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T07:35:29.026536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T07:35:28.61284Z","time spent":"413.396612ms","remote":"127.0.0.1:41386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3431,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-25T07:35:34.26855Z","caller":"traceutil/trace.go:171","msg":"trace[1504376980] transaction","detail":"{read_only:false; response_revision:284; number_of_response:1; }","duration":"281.027742ms","start":"2026-02-25T07:35:33.987493Z","end":"2026-02-25T07:35:34.268521Z","steps":["trace[1504376980] 'process raft request' (duration: 280.787996ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T07:35:50.396256Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10636548578226687411,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-25T07:35:50.897531Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10636548578226687411,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-25T07:35:51.268391Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.413265272s","expected-duration":"1s"} {"level":"warn","ts":"2026-02-25T07:35:51.268916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T07:35:49.854953Z","time spent":"1.413959421s","remote":"127.0.0.1:41246","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-02-25T07:35:51.269107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.373285526s","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-25T07:35:51.269186Z","caller":"traceutil/trace.go:171","msg":"trace[1155044993] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:419; }","duration":"1.373404879s","start":"2026-02-25T07:35:49.895759Z","end":"2026-02-25T07:35:51.269163Z","steps":["trace[1155044993] 'agreement among raft nodes before linearized reading' (duration: 1.373253504s)"],"step_count":1} {"level":"info","ts":"2026-02-25T07:35:51.268862Z","caller":"traceutil/trace.go:171","msg":"trace[1357921225] linearizableReadLoop","detail":"{readStateIndex:436; appliedIndex:435; }","duration":"1.373034348s","start":"2026-02-25T07:35:49.895802Z","end":"2026-02-25T07:35:51.268836Z","steps":["trace[1357921225] 'read index received' (duration: 1.37277003s)","trace[1357921225] 'applied index is now lower than readState.Index' (duration: 262.978µs)"],"step_count":2} {"level":"warn","ts":"2026-02-25T07:35:51.269235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T07:35:49.895741Z","time spent":"1.373484611s","remote":"127.0.0.1:41496","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-25T07:35:51.269434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"963.028793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T07:35:51.269482Z","caller":"traceutil/trace.go:171","msg":"trace[1447240331] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:419; }","duration":"963.145817ms","start":"2026-02-25T07:35:50.306322Z","end":"2026-02-25T07:35:51.269468Z","steps":["trace[1447240331] 'agreement among raft nodes before linearized reading' (duration: 963.058364ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T07:35:51.269488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"825.892884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-02-25T07:35:51.269516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T07:35:50.306288Z","time spent":"963.220829ms","remote":"127.0.0.1:41206","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-25T07:35:51.269546Z","caller":"traceutil/trace.go:171","msg":"trace[774217544] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:419; }","duration":"825.983126ms","start":"2026-02-25T07:35:50.443532Z","end":"2026-02-25T07:35:51.269515Z","steps":["trace[774217544] 'agreement among raft nodes before linearized reading' (duration: 825.923324ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T07:35:51.269615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T07:35:50.443504Z","time spent":"826.086319ms","remote":"127.0.0.1:41496","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-25T07:35:51.269818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"597.159203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-25T07:35:51.269954Z","caller":"traceutil/trace.go:171","msg":"trace[1586072615] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:419; }","duration":"597.38402ms","start":"2026-02-25T07:35:50.672504Z","end":"2026-02-25T07:35:51.269889Z","steps":["trace[1586072615] 'agreement among raft nodes before linearized reading' (duration: 596.957809ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T07:35:51.2701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T07:35:50.672481Z","time spent":"597.603776ms","remote":"127.0.0.1:41496","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-25T07:35:55.793775Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10636548578226687501,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-25T07:35:55.796871Z","caller":"traceutil/trace.go:171","msg":"trace[179784591] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"505.079144ms","start":"2026-02-25T07:35:55.29177Z","end":"2026-02-25T07:35:55.796849Z","steps":["trace[179784591] 'process raft request' (duration: 504.951841ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T07:35:55.797181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T07:35:55.291758Z","time spent":"505.188388ms","remote":"127.0.0.1:41496","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T07:35:56.894958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.214954ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-25T07:35:56.895603Z","caller":"traceutil/trace.go:171","msg":"trace[813090943] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"1.60044728s","start":"2026-02-25T07:35:55.295134Z","end":"2026-02-25T07:35:56.895581Z","steps":["trace[813090943] 'process raft request' (duration: 1.433392523s)","trace[813090943] 'compare' (duration: 166.071211ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T07:35:56.895687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T07:35:55.295114Z","time spent":"1.600529172s","remote":"127.0.0.1:41496","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-25T07:35:57.903193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.008132156s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-02-25T07:35:57.903288Z","caller":"traceutil/trace.go:171","msg":"trace[1024060800] linearizableReadLoop","detail":"{readStateIndex:484; appliedIndex:481; }","duration":"2.610296582s","start":"2026-02-25T07:35:55.292974Z","end":"2026-02-25T07:35:57.903271Z","steps":["trace[1024060800] 'read index received' (duration: 503.780949ms)","trace[1024060800] 'applied index is now lower than readState.Index' (duration: 2.106514233s)"],"step_count":2} {"level":"warn","ts":"2026-02-25T07:35:57.903409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.610422606s","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-25T07:35:57.903445Z","caller":"traceutil/trace.go:171","msg":"trace[1590843135] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:466; }","duration":"2.610485728s","start":"2026-02-25T07:35:55.29295Z","end":"2026-02-25T07:35:57.903435Z","steps":["trace[1590843135] 'agreement among raft nodes before linearized reading' (duration: 2.610411606s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T07:35:57.903418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T07:35:57.224543Z","time spent":"678.867287ms","remote":"127.0.0.1:37046","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-02-25T07:35:57.903481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T07:35:55.292939Z","time spent":"2.610533829s","remote":"127.0.0.1:41496","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-25T07:35:57.903536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.598039138s","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-25T07:35:57.903642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.088257645s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4021"} {"level":"warn","ts":"2026-02-25T07:35:57.903641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.225593ms","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-25T07:35:57.903614Z","caller":"traceutil/trace.go:171","msg":"trace[1777939988] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:466; }","duration":"2.598158501s","start":"2026-02-25T07:35:55.305442Z","end":"2026-02-25T07:35:57.9036Z","steps":["trace[1777939988] 'agreement among raft nodes before linearized reading' (duration: 2.598049488s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T07:35:57.903651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.593615023s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T07:35:57.903724Z","caller":"traceutil/trace.go:171","msg":"trace[1198530753] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:466; }","duration":"2.088378798s","start":"2026-02-25T07:35:55.815321Z","end":"2026-02-25T07:35:57.9037Z","steps":["trace[1198530753] 'agreement among raft nodes before linearized reading' (duration: 2.088227624s)"],"step_count":1} {"level":"info","ts":"2026-02-25T07:35:57.903732Z","caller":"traceutil/trace.go:171","msg":"trace[1769964350] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:466; }","duration":"102.354906ms","start":"2026-02-25T07:35:57.801354Z","end":"2026-02-25T07:35:57.903709Z","steps":["trace[1769964350] 'agreement among raft nodes before linearized reading' (duration: 102.214102ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T07:35:57.90373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T07:35:55.305421Z","time spent":"2.598296484s","remote":"127.0.0.1:41496","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":"info","ts":"2026-02-25T07:35:57.903769Z","caller":"traceutil/trace.go:171","msg":"trace[1840929427] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:466; }","duration":"1.593777368s","start":"2026-02-25T07:35:56.30996Z","end":"2026-02-25T07:35:57.903737Z","steps":["trace[1840929427] 'agreement among raft nodes before linearized reading' (duration: 1.593545022s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T07:35:57.903775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T07:35:55.815303Z","time spent":"2.0884613s","remote":"127.0.0.1:41376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4045,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-02-25T07:35:57.903819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T07:35:56.309943Z","time spent":"1.59386689s","remote":"127.0.0.1:41206","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-25T07:36:01.24375Z","caller":"traceutil/trace.go:171","msg":"trace[1682688146] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"386.871814ms","start":"2026-02-25T07:36:00.856855Z","end":"2026-02-25T07:36:01.243727Z","steps":["trace[1682688146] 'process raft request' (duration: 386.7317ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T07:36:01.243884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T07:36:00.856838Z","time spent":"386.973926ms","remote":"127.0.0.1:41702","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3638,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T07:36:01.256983Z","caller":"traceutil/trace.go:171","msg":"trace[1111115373] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"398.58992ms","start":"2026-02-25T07:36:00.858354Z","end":"2026-02-25T07:36:01.256943Z","steps":["trace[1111115373] 'process raft request' (duration: 398.489747ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T07:36:01.257088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T07:36:00.858348Z","time spent":"398.685582ms","remote":"127.0.0.1:41714","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3165,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T07:36:01.257129Z","caller":"traceutil/trace.go:171","msg":"trace[150453472] linearizableReadLoop","detail":"{readStateIndex:515; appliedIndex:511; }","duration":"357.683263ms","start":"2026-02-25T07:36:00.899429Z","end":"2026-02-25T07:36:01.257112Z","steps":["trace[150453472] 'read index received' (duration: 344.303462ms)","trace[150453472] 'applied index is now lower than readState.Index' (duration: 13.378901ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T07:36:01.257267Z","caller":"traceutil/trace.go:171","msg":"trace[945729327] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"398.809585ms","start":"2026-02-25T07:36:00.858448Z","end":"2026-02-25T07:36:01.257258Z","steps":["trace[945729327] 'process raft request' (duration: 398.437005ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T07:36:01.257326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T07:36:00.858441Z","time spent":"398.853267ms","remote":"127.0.0.1:41288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":785,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-25T07:36:01.257405Z","caller":"traceutil/trace.go:171","msg":"trace[1963486730] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"399.183887ms","start":"2026-02-25T07:36:00.858165Z","end":"2026-02-25T07:36:01.257349Z","steps":["trace[1963486730] 'process raft request' (duration: 398.526479ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T07:36:01.257515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T07:36:00.858156Z","time spent":"399.30347ms","remote":"127.0.0.1:41386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3024,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T07:36:01.257798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.103474ms","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-25T07:36:01.257854Z","caller":"traceutil/trace.go:171","msg":"trace[823010629] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"399.389751ms","start":"2026-02-25T07:36:00.858452Z","end":"2026-02-25T07:36:01.257842Z","steps":["trace[823010629] 'process raft request' (duration: 398.61506ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T07:36:01.257858Z","caller":"traceutil/trace.go:171","msg":"trace[1198336529] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:496; }","duration":"348.199487ms","start":"2026-02-25T07:36:00.909644Z","end":"2026-02-25T07:36:01.257843Z","steps":["trace[1198336529] 'agreement among raft nodes before linearized reading' (duration: 347.768435ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T07:36:01.257948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T07:36:00.858435Z","time spent":"399.448573ms","remote":"127.0.0.1:41288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":896,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-25T07:36:01.257921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.436233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:1 size:12727"} {"level":"info","ts":"2026-02-25T07:36:01.258022Z","caller":"traceutil/trace.go:171","msg":"trace[1936136224] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:1; response_revision:496; }","duration":"358.591298ms","start":"2026-02-25T07:36:00.899404Z","end":"2026-02-25T07:36:01.257996Z","steps":["trace[1936136224] 'agreement among raft nodes before linearized reading' (duration: 358.248969ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T07:36:01.258074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T07:36:00.899396Z","time spent":"358.66883ms","remote":"127.0.0.1:41298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":12751,"request content":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" "} {"level":"warn","ts":"2026-02-25T07:36:01.257981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T07:36:00.909634Z","time spent":"348.33436ms","remote":"127.0.0.1:41496","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":"info","ts":"2026-02-25T07:36:04.791254Z","caller":"traceutil/trace.go:171","msg":"trace[1246188668] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"220.683234ms","start":"2026-02-25T07:36:04.570551Z","end":"2026-02-25T07:36:04.791234Z","steps":["trace[1246188668] 'process raft request' (duration: 220.5559ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T07:36:05.810152Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10636548578226687595,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-25T07:36:06.012822Z","caller":"traceutil/trace.go:171","msg":"trace[480226260] linearizableReadLoop","detail":"{readStateIndex:531; appliedIndex:530; }","duration":"703.356059ms","start":"2026-02-25T07:36:05.309448Z","end":"2026-02-25T07:36:06.012804Z","steps":["trace[480226260] 'read index received' (duration: 703.317898ms)","trace[480226260] 'applied index is now lower than readState.Index' (duration: 37.471µs)"],"step_count":2} {"level":"warn","ts":"2026-02-25T07:36:06.01297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"703.503032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T07:36:06.012946Z","caller":"traceutil/trace.go:171","msg":"trace[386914916] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"731.590065ms","start":"2026-02-25T07:36:05.281322Z","end":"2026-02-25T07:36:06.012912Z","steps":["trace[386914916] 'process raft request' (duration: 731.379999ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T07:36:06.012996Z","caller":"traceutil/trace.go:171","msg":"trace[151680255] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:512; }","duration":"703.574504ms","start":"2026-02-25T07:36:05.309412Z","end":"2026-02-25T07:36:06.012987Z","steps":["trace[151680255] 'agreement among raft nodes before linearized reading' (duration: 703.495382ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T07:36:06.013022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T07:36:05.309398Z","time spent":"703.618556ms","remote":"127.0.0.1:41206","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-25T07:36:06.013117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T07:36:05.281311Z","time spent":"731.710488ms","remote":"127.0.0.1:41496","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-25T07:36:08.181597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.855679232s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T07:36:08.1817Z","caller":"traceutil/trace.go:171","msg":"trace[1191067652] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:515; }","duration":"1.855881008s","start":"2026-02-25T07:36:06.325804Z","end":"2026-02-25T07:36:08.181685Z","steps":["trace[1191067652] 'range keys from in-memory index tree' (duration: 1.85559037s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T07:36:08.181729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T07:36:06.325777Z","time spent":"1.855945749s","remote":"127.0.0.1:41206","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-25T07:36:08.379728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.180881302s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-02-25T07:36:08.379824Z","caller":"traceutil/trace.go:171","msg":"trace[1865406159] linearizableReadLoop","detail":"{readStateIndex:535; appliedIndex:534; }","duration":"363.923789ms","start":"2026-02-25T07:36:08.015882Z","end":"2026-02-25T07:36:08.379806Z","steps":["trace[1865406159] 'read index received' (duration: 29.541µs)","trace[1865406159] 'applied index is now lower than readState.Index' (duration: 363.892778ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T07:36:08.380019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.126895ms","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-25T07:36:08.380058Z","caller":"traceutil/trace.go:171","msg":"trace[907377988] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:515; }","duration":"364.192767ms","start":"2026-02-25T07:36:08.015854Z","end":"2026-02-25T07:36:08.380046Z","steps":["trace[907377988] 'agreement among raft nodes before linearized reading' (duration: 364.046422ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T07:36:08.380092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T07:36:08.015841Z","time spent":"364.242608ms","remote":"127.0.0.1:41496","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-25T07:36:08.380088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.172105ms","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-25T07:36:08.38011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.461745ms","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-25T07:36:08.380175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.186216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T07:36:08.380188Z","caller":"traceutil/trace.go:171","msg":"trace[609842564] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:515; }","duration":"340.578549ms","start":"2026-02-25T07:36:08.039594Z","end":"2026-02-25T07:36:08.380173Z","steps":["trace[609842564] 'agreement among raft nodes before linearized reading' (duration: 340.424234ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T07:36:08.380202Z","caller":"traceutil/trace.go:171","msg":"trace[1790636210] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:515; }","duration":"197.212977ms","start":"2026-02-25T07:36:08.18298Z","end":"2026-02-25T07:36:08.380193Z","steps":["trace[1790636210] 'agreement among raft nodes before linearized reading' (duration: 197.173526ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T07:36:08.380231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T07:36:08.039579Z","time spent":"340.64516ms","remote":"127.0.0.1:41496","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":"info","ts":"2026-02-25T07:36:08.380133Z","caller":"traceutil/trace.go:171","msg":"trace[2139290655] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:515; }","duration":"311.240036ms","start":"2026-02-25T07:36:08.068882Z","end":"2026-02-25T07:36:08.380122Z","steps":["trace[2139290655] 'agreement among raft nodes before linearized reading' (duration: 311.146164ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T07:36:08.380374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T07:36:08.068868Z","time spent":"311.495893ms","remote":"127.0.0.1:41496","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-25T07:36:08.380368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.838222ms","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-25T07:36:08.38044Z","caller":"traceutil/trace.go:171","msg":"trace[2119759058] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:515; }","duration":"311.952645ms","start":"2026-02-25T07:36:08.068469Z","end":"2026-02-25T07:36:08.380421Z","steps":["trace[2119759058] 'agreement among raft nodes before linearized reading' (duration: 311.810831ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T07:36:08.380478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T07:36:08.06845Z","time spent":"312.021156ms","remote":"127.0.0.1:41496","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-25T07:36:10.254121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.466129ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-25T07:36:10.254292Z","caller":"traceutil/trace.go:171","msg":"trace[1574284085] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"297.911485ms","start":"2026-02-25T07:36:09.956354Z","end":"2026-02-25T07:36:10.254265Z","steps":["trace[1574284085] 'process raft request' (duration: 142.156438ms)","trace[1574284085] 'compare' (duration: 155.162501ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T07:37:30.798914Z","caller":"traceutil/trace.go:171","msg":"trace[1935639216] transaction","detail":"{read_only:false; response_revision:926; number_of_response:1; }","duration":"290.547046ms","start":"2026-02-25T07:37:30.50833Z","end":"2026-02-25T07:37:30.798877Z","steps":["trace[1935639216] 'process raft request' (duration: 289.665544ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T07:37:39.0966Z","caller":"traceutil/trace.go:171","msg":"trace[2137202659] linearizableReadLoop","detail":"{readStateIndex:998; appliedIndex:997; }","duration":"200.97258ms","start":"2026-02-25T07:37:38.895603Z","end":"2026-02-25T07:37:39.096575Z","steps":["trace[2137202659] 'read index received' (duration: 200.841757ms)","trace[2137202659] 'applied index is now lower than readState.Index' (duration: 127.413µs)"],"step_count":2} {"level":"info","ts":"2026-02-25T07:37:39.096782Z","caller":"traceutil/trace.go:171","msg":"trace[248108019] transaction","detail":"{read_only:false; response_revision:955; number_of_response:1; }","duration":"202.010967ms","start":"2026-02-25T07:37:38.894756Z","end":"2026-02-25T07:37:39.096767Z","steps":["trace[248108019] 'process raft request' (duration: 201.647448ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T07:37:39.097206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.44145ms","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-25T07:37:39.097314Z","caller":"traceutil/trace.go:171","msg":"trace[510883500] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:955; }","duration":"200.602472ms","start":"2026-02-25T07:37:38.896683Z","end":"2026-02-25T07:37:39.097286Z","steps":["trace[510883500] 'agreement among raft nodes before linearized reading' (duration: 200.322295ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T07:37:39.09752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.902194ms","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-25T07:37:39.097598Z","caller":"traceutil/trace.go:171","msg":"trace[342830625] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:955; }","duration":"202.008067ms","start":"2026-02-25T07:37:38.895572Z","end":"2026-02-25T07:37:39.097581Z","steps":["trace[342830625] 'agreement among raft nodes before linearized reading' (duration: 201.820692ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T07:37:39.09753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.077901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-25T07:37:39.097663Z","caller":"traceutil/trace.go:171","msg":"trace[423283886] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:955; }","duration":"191.238765ms","start":"2026-02-25T07:37:38.906408Z","end":"2026-02-25T07:37:39.097646Z","steps":["trace[423283886] 'agreement among raft nodes before linearized reading' (duration: 190.818285ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T07:37:39.097725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.019635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-25T07:37:39.097867Z","caller":"traceutil/trace.go:171","msg":"trace[1229727797] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:955; }","duration":"115.246941ms","start":"2026-02-25T07:37:38.982592Z","end":"2026-02-25T07:37:39.097839Z","steps":["trace[1229727797] 'agreement among raft nodes before linearized reading' (duration: 114.555264ms)"],"step_count":1}