{"level":"warn","ts":"2026-07-25T10:31:59.765615Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-25T10:31:59.765697Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.169: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://199.204.45.169:2380","--initial-cluster=instance=https://199.204.45.169:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.169:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.169: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-07-25T10:31:59.765754Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-25T10:31:59.765769Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.169:2380"]} {"level":"info","ts":"2026-07-25T10:31:59.765785Z","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-07-25T10:31:59.76648Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"]} {"level":"info","ts":"2026-07-25T10:31:59.766555Z","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://199.204.45.169:2380"],"listen-peer-urls":["https://199.204.45.169:2380"],"advertise-client-urls":["https://199.204.45.169:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.169: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-07-25T10:31:59.770909Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.005538ms"} {"level":"info","ts":"2026-07-25T10:31:59.777939Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1c917701ce165bac","cluster-id":"bfb5247022b87cb1"} {"level":"info","ts":"2026-07-25T10:31:59.778016Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=()"} {"level":"info","ts":"2026-07-25T10:31:59.778041Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became follower at term 0"} {"level":"info","ts":"2026-07-25T10:31:59.778052Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1c917701ce165bac [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-25T10:31:59.778063Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became follower at term 1"} {"level":"info","ts":"2026-07-25T10:31:59.778099Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=(2058557354321271724)"} {"level":"warn","ts":"2026-07-25T10:31:59.786392Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-25T10:31:59.788729Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-25T10:31:59.789859Z","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-07-25T10:31:59.791968Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1c917701ce165bac","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-25T10:31:59.792392Z","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-07-25T10:31:59.792492Z","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-07-25T10:31:59.792928Z","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-07-25T10:31:59.792168Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1c917701ce165bac","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-25T10:31:59.793798Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=(2058557354321271724)"} {"level":"info","ts":"2026-07-25T10:31:59.794214Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"bfb5247022b87cb1","local-member-id":"1c917701ce165bac","added-peer-id":"1c917701ce165bac","added-peer-peer-urls":["https://199.204.45.169:2380"]} {"level":"info","ts":"2026-07-25T10:31:59.798408Z","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-07-25T10:31:59.798598Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.169:2380"} {"level":"info","ts":"2026-07-25T10:31:59.798651Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.169:2380"} {"level":"info","ts":"2026-07-25T10:31:59.798931Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1c917701ce165bac","initial-advertise-peer-urls":["https://199.204.45.169:2380"],"listen-peer-urls":["https://199.204.45.169:2380"],"advertise-client-urls":["https://199.204.45.169:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-25T10:31:59.799038Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-25T10:32:00.67909Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac is starting a new election at term 1"} {"level":"info","ts":"2026-07-25T10:32:00.679195Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became pre-candidate at term 1"} {"level":"info","ts":"2026-07-25T10:32:00.679233Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac received MsgPreVoteResp from 1c917701ce165bac at term 1"} {"level":"info","ts":"2026-07-25T10:32:00.67926Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became candidate at term 2"} {"level":"info","ts":"2026-07-25T10:32:00.67928Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac received MsgVoteResp from 1c917701ce165bac at term 2"} {"level":"info","ts":"2026-07-25T10:32:00.6793Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became leader at term 2"} {"level":"info","ts":"2026-07-25T10:32:00.679323Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1c917701ce165bac elected leader 1c917701ce165bac at term 2"} {"level":"info","ts":"2026-07-25T10:32:00.894223Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-25T10:32:00.89517Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-25T10:32:00.895201Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-25T10:32:00.895805Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-25T10:32:00.895908Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-25T10:32:00.895956Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"bfb5247022b87cb1","local-member-id":"1c917701ce165bac","cluster-version":"3.5"} {"level":"info","ts":"2026-07-25T10:32:00.896155Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-25T10:32:00.896238Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-25T10:32:00.896303Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1c917701ce165bac","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.169:2379]}","request-path":"/0/members/1c917701ce165bac/attributes","cluster-id":"bfb5247022b87cb1","publish-timeout":"7s"} {"level":"info","ts":"2026-07-25T10:32:00.898078Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.169:2379"} {"level":"info","ts":"2026-07-25T10:32:00.917025Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-07-25T10:32:02.719005Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6605830232202027633,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-25T10:32:03.219292Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6605830232202027633,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-25T10:32:03.503178Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.286238609s","expected-duration":"1s"} {"level":"info","ts":"2026-07-25T10:32:03.503737Z","caller":"traceutil/trace.go:171","msg":"trace[1563157911] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"1.2868571s","start":"2026-07-25T10:32:02.216853Z","end":"2026-07-25T10:32:03.50371Z","steps":["trace[1563157911] 'process raft request' (duration: 1.286618986s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:03.504396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:02.216841Z","time spent":"1.286961323s","remote":"127.0.0.1:45114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T10:32:03.656478Z","caller":"traceutil/trace.go:171","msg":"trace[2084747063] linearizableReadLoop","detail":"{readStateIndex:13; appliedIndex:4; }","duration":"1.43795988s","start":"2026-07-25T10:32:02.218484Z","end":"2026-07-25T10:32:03.656444Z","steps":["trace[2084747063] 'read index received' (duration: 1.284991786s)","trace[2084747063] 'applied index is now lower than readState.Index' (duration: 152.966884ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T10:32:03.656537Z","caller":"traceutil/trace.go:171","msg":"trace[1979343653] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"1.35116036s","start":"2026-07-25T10:32:02.305303Z","end":"2026-07-25T10:32:03.656463Z","steps":["trace[1979343653] 'process raft request' (duration: 1.350973186s)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:32:03.656648Z","caller":"traceutil/trace.go:171","msg":"trace[263811065] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"1.351042797s","start":"2026-07-25T10:32:02.305588Z","end":"2026-07-25T10:32:03.656631Z","steps":["trace[263811065] 'process raft request' (duration: 1.350735881s)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:32:03.656749Z","caller":"traceutil/trace.go:171","msg":"trace[1820012516] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"1.357178424s","start":"2026-07-25T10:32:02.299535Z","end":"2026-07-25T10:32:03.656714Z","steps":["trace[1820012516] 'process raft request' (duration: 1.35650575s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:03.656787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:02.305284Z","time spent":"1.351390034s","remote":"127.0.0.1:45516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T10:32:03.656841Z","caller":"traceutil/trace.go:171","msg":"trace[1625680233] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"1.337059672s","start":"2026-07-25T10:32:02.319744Z","end":"2026-07-25T10:32:03.656803Z","steps":["trace[1625680233] 'process raft request' (duration: 1.336656135s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:03.656916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:02.299483Z","time spent":"1.357356617s","remote":"127.0.0.1:45442","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T10:32:03.656946Z","caller":"traceutil/trace.go:171","msg":"trace[66057592] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"1.351909784s","start":"2026-07-25T10:32:02.305022Z","end":"2026-07-25T10:32:03.656932Z","steps":["trace[66057592] 'process raft request' (duration: 1.351146898s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:03.657029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:02.305006Z","time spent":"1.351987935s","remote":"127.0.0.1:45516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-25T10:32:03.656966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:02.319727Z","time spent":"1.337187344s","remote":"127.0.0.1:45298","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":845,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T10:32:03.657174Z","caller":"traceutil/trace.go:171","msg":"trace[156979675] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"1.351991545s","start":"2026-07-25T10:32:02.305171Z","end":"2026-07-25T10:32:03.657163Z","steps":["trace[156979675] 'process raft request' (duration: 1.351073528s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:03.656802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:02.305574Z","time spent":"1.351124519s","remote":"127.0.0.1:45516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-25T10:32:03.657242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:02.305151Z","time spent":"1.352060627s","remote":"127.0.0.1:45516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T10:32:03.657357Z","caller":"traceutil/trace.go:171","msg":"trace[65280734] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"1.352320931s","start":"2026-07-25T10:32:02.305027Z","end":"2026-07-25T10:32:03.657348Z","steps":["trace[65280734] 'process raft request' (duration: 1.35118545s)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:32:03.657372Z","caller":"traceutil/trace.go:171","msg":"trace[1575901503] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"1.348057029s","start":"2026-07-25T10:32:02.309303Z","end":"2026-07-25T10:32:03.65736Z","steps":["trace[1575901503] 'process raft request' (duration: 1.347066861s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:03.657417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:02.304993Z","time spent":"1.352393333s","remote":"127.0.0.1:45516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-25T10:32:03.657421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:02.309293Z","time spent":"1.34810569s","remote":"127.0.0.1:45222","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3159,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-25T10:32:03.657423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.438419088s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-25T10:32:03.657464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.358321935s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-25T10:32:03.657525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.897658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-25T10:32:03.657525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.358124621s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.169\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-25T10:32:03.657568Z","caller":"traceutil/trace.go:171","msg":"trace[355109945] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:10; }","duration":"459.95385ms","start":"2026-07-25T10:32:03.1976Z","end":"2026-07-25T10:32:03.657554Z","steps":["trace[355109945] 'agreement among raft nodes before linearized reading' (duration: 459.892849ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:03.657532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.437729404s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-25T10:32:03.657591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.666367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-25T10:32:03.657611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:03.197591Z","time spent":"460.013411ms","remote":"127.0.0.1:45392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":27,"request content":"key:\"/registry/priorityclasses/system-node-critical\" "} {"level":"info","ts":"2026-07-25T10:32:03.657638Z","caller":"traceutil/trace.go:171","msg":"trace[661253536] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:10; }","duration":"110.771868ms","start":"2026-07-25T10:32:03.546858Z","end":"2026-07-25T10:32:03.65763Z","steps":["trace[661253536] 'agreement among raft nodes before linearized reading' (duration: 110.704867ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:03.657645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.278095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-25T10:32:03.657642Z","caller":"traceutil/trace.go:171","msg":"trace[1794032191] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:10; }","duration":"1.43804402s","start":"2026-07-25T10:32:02.219576Z","end":"2026-07-25T10:32:03.65762Z","steps":["trace[1794032191] 'agreement among raft nodes before linearized reading' (duration: 1.437685884s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:03.657664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.307756944s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-25T10:32:03.657678Z","caller":"traceutil/trace.go:171","msg":"trace[938883043] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:10; }","duration":"460.318646ms","start":"2026-07-25T10:32:03.197351Z","end":"2026-07-25T10:32:03.65767Z","steps":["trace[938883043] 'agreement among raft nodes before linearized reading' (duration: 460.260655ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:03.657696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:02.21957Z","time spent":"1.438114301s","remote":"127.0.0.1:45302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" "} {"level":"info","ts":"2026-07-25T10:32:03.65771Z","caller":"traceutil/trace.go:171","msg":"trace[991938026] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"1.307830696s","start":"2026-07-25T10:32:02.349869Z","end":"2026-07-25T10:32:03.6577Z","steps":["trace[991938026] 'agreement among raft nodes before linearized reading' (duration: 1.307751484s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:03.657718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:03.197282Z","time spent":"460.427209ms","remote":"127.0.0.1:45362","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" "} {"level":"info","ts":"2026-07-25T10:32:03.657516Z","caller":"traceutil/trace.go:171","msg":"trace[1422720967] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:10; }","duration":"1.439041129s","start":"2026-07-25T10:32:02.218461Z","end":"2026-07-25T10:32:03.657502Z","steps":["trace[1422720967] 'agreement among raft nodes before linearized reading' (duration: 1.438380257s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:03.65775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:02.349856Z","time spent":"1.307887597s","remote":"127.0.0.1:45174","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-07-25T10:32:03.657762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:02.218452Z","time spent":"1.439300155s","remote":"127.0.0.1:45242","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":27,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" "} {"level":"info","ts":"2026-07-25T10:32:03.657594Z","caller":"traceutil/trace.go:171","msg":"trace[1488361515] range","detail":"{range_begin:/registry/masterleases/199.204.45.169; range_end:; response_count:0; response_revision:10; }","duration":"1.358378237s","start":"2026-07-25T10:32:02.299201Z","end":"2026-07-25T10:32:03.657579Z","steps":["trace[1488361515] 'agreement among raft nodes before linearized reading' (duration: 1.358108432s)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:32:03.65754Z","caller":"traceutil/trace.go:171","msg":"trace[2114855373] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:10; }","duration":"1.358442547s","start":"2026-07-25T10:32:02.299074Z","end":"2026-07-25T10:32:03.657516Z","steps":["trace[2114855373] 'agreement among raft nodes before linearized reading' (duration: 1.358279024s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:03.657851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:02.29918Z","time spent":"1.358648111s","remote":"127.0.0.1:45088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/199.204.45.169\" "} {"level":"warn","ts":"2026-07-25T10:32:03.657882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:02.299067Z","time spent":"1.358803044s","remote":"127.0.0.1:45126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"warn","ts":"2026-07-25T10:32:03.658064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.437864156s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-25T10:32:03.658124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.438014659s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3171"} {"level":"info","ts":"2026-07-25T10:32:03.658176Z","caller":"traceutil/trace.go:171","msg":"trace[1639161815] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:10; }","duration":"1.43807442s","start":"2026-07-25T10:32:02.220091Z","end":"2026-07-25T10:32:03.658165Z","steps":["trace[1639161815] 'agreement among raft nodes before linearized reading' (duration: 1.437988269s)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:32:03.658122Z","caller":"traceutil/trace.go:171","msg":"trace[1833310225] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:10; }","duration":"1.437936517s","start":"2026-07-25T10:32:02.220171Z","end":"2026-07-25T10:32:03.658108Z","steps":["trace[1833310225] 'agreement among raft nodes before linearized reading' (duration: 1.437849526s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:03.658211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:02.220086Z","time spent":"1.438118151s","remote":"127.0.0.1:45222","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3194,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-07-25T10:32:03.658219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:02.220168Z","time spent":"1.43804286s","remote":"127.0.0.1:45414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-07-25T10:32:03.658276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.359076579s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-25T10:32:03.658342Z","caller":"traceutil/trace.go:171","msg":"trace[739797112] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"1.360075808s","start":"2026-07-25T10:32:02.298239Z","end":"2026-07-25T10:32:03.658315Z","steps":["trace[739797112] 'agreement among raft nodes before linearized reading' (duration: 1.35908056s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:03.658383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:02.298214Z","time spent":"1.360157549s","remote":"127.0.0.1:45174","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-07-25T10:32:42.195579Z","caller":"traceutil/trace.go:171","msg":"trace[1247876778] transaction","detail":"{read_only:false; response_revision:464; number_of_response:1; }","duration":"215.980563ms","start":"2026-07-25T10:32:41.979554Z","end":"2026-07-25T10:32:42.195534Z","steps":["trace[1247876778] 'process raft request' (duration: 215.850891ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:32:42.196236Z","caller":"traceutil/trace.go:171","msg":"trace[24670978] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"216.407649ms","start":"2026-07-25T10:32:41.979797Z","end":"2026-07-25T10:32:42.196205Z","steps":["trace[24670978] 'process raft request' (duration: 216.248327ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:32:46.053038Z","caller":"traceutil/trace.go:171","msg":"trace[179073279] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"683.7342ms","start":"2026-07-25T10:32:45.369279Z","end":"2026-07-25T10:32:46.053013Z","steps":["trace[179073279] 'process raft request' (duration: 683.613448ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:46.053198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:45.369254Z","time spent":"683.863601ms","remote":"127.0.0.1:45106","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T10:32:46.06038Z","caller":"traceutil/trace.go:171","msg":"trace[148077281] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"688.200443ms","start":"2026-07-25T10:32:45.372153Z","end":"2026-07-25T10:32:46.060353Z","steps":["trace[148077281] 'process raft request' (duration: 688.009619ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:46.060528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:45.372133Z","time spent":"688.317284ms","remote":"127.0.0.1:45106","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T10:32:46.060529Z","caller":"traceutil/trace.go:171","msg":"trace[57109906] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"688.268244ms","start":"2026-07-25T10:32:45.372228Z","end":"2026-07-25T10:32:46.060497Z","steps":["trace[57109906] 'process raft request' (duration: 688.04787ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:32:46.060639Z","caller":"traceutil/trace.go:171","msg":"trace[1808797980] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"678.539817ms","start":"2026-07-25T10:32:45.38208Z","end":"2026-07-25T10:32:46.06062Z","steps":["trace[1808797980] 'process raft request' (duration: 678.270054ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:46.060816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:45.372224Z","time spent":"688.415346ms","remote":"127.0.0.1:45106","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T10:32:46.060858Z","caller":"traceutil/trace.go:171","msg":"trace[68572109] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"678.704179ms","start":"2026-07-25T10:32:45.382124Z","end":"2026-07-25T10:32:46.060828Z","steps":["trace[68572109] 'process raft request' (duration: 678.357194ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:46.060841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:45.382069Z","time spent":"678.634388ms","remote":"127.0.0.1:45106","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-25T10:32:46.061068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:45.38212Z","time spent":"678.836501ms","remote":"127.0.0.1:45106","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T10:32:46.062862Z","caller":"traceutil/trace.go:171","msg":"trace[1448908746] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"679.134395ms","start":"2026-07-25T10:32:45.382189Z","end":"2026-07-25T10:32:46.061324Z","steps":["trace[1448908746] 'process raft request' (duration: 679.017633ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:46.062957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:45.382186Z","time spent":"680.744977ms","remote":"127.0.0.1:45106","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T10:32:46.063199Z","caller":"traceutil/trace.go:171","msg":"trace[258780540] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"679.190534ms","start":"2026-07-25T10:32:45.383869Z","end":"2026-07-25T10:32:46.06306Z","steps":["trace[258780540] 'process raft request' (duration: 677.38279ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:46.063308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:45.383862Z","time spent":"679.396459ms","remote":"127.0.0.1:45106","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T10:32:46.063684Z","caller":"traceutil/trace.go:171","msg":"trace[316640604] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"678.73461ms","start":"2026-07-25T10:32:45.384925Z","end":"2026-07-25T10:32:46.063659Z","steps":["trace[316640604] 'process raft request' (duration: 676.361606ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:46.063865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:45.384919Z","time spent":"678.7997ms","remote":"127.0.0.1:45106","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T10:32:46.069402Z","caller":"traceutil/trace.go:171","msg":"trace[1920264156] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"677.42554ms","start":"2026-07-25T10:32:45.391957Z","end":"2026-07-25T10:32:46.069382Z","steps":["trace[1920264156] 'process raft request' (duration: 670.396792ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:46.069752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:45.391946Z","time spent":"677.611203ms","remote":"127.0.0.1:45106","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T10:32:46.069908Z","caller":"traceutil/trace.go:171","msg":"trace[868764208] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"665.759657ms","start":"2026-07-25T10:32:45.403984Z","end":"2026-07-25T10:32:46.069744Z","steps":["trace[868764208] 'process raft request' (duration: 665.24766ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:46.070102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:45.403972Z","time spent":"665.96652ms","remote":"127.0.0.1:45106","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T10:32:46.071478Z","caller":"traceutil/trace.go:171","msg":"trace[885861941] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"650.685145ms","start":"2026-07-25T10:32:45.420696Z","end":"2026-07-25T10:32:46.071381Z","steps":["trace[885861941] 'process raft request' (duration: 649.750152ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:46.071542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:45.42067Z","time spent":"650.837988ms","remote":"127.0.0.1:45106","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T10:32:46.07353Z","caller":"traceutil/trace.go:171","msg":"trace[920489880] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"538.26336ms","start":"2026-07-25T10:32:45.535251Z","end":"2026-07-25T10:32:46.073514Z","steps":["trace[920489880] 'process raft request' (duration: 538.171878ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:46.073588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:45.53523Z","time spent":"538.33368ms","remote":"127.0.0.1:45106","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T10:32:46.0737Z","caller":"traceutil/trace.go:171","msg":"trace[2087486643] linearizableReadLoop","detail":"{readStateIndex:543; appliedIndex:532; }","duration":"407.629297ms","start":"2026-07-25T10:32:45.66602Z","end":"2026-07-25T10:32:46.073649Z","steps":["trace[2087486643] 'read index received' (duration: 387.075171ms)","trace[2087486643] 'applied index is now lower than readState.Index' (duration: 20.552986ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T10:32:46.073792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.766839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T10:32:46.073815Z","caller":"traceutil/trace.go:171","msg":"trace[2004980080] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:521; }","duration":"407.835271ms","start":"2026-07-25T10:32:45.665972Z","end":"2026-07-25T10:32:46.073807Z","steps":["trace[2004980080] 'agreement among raft nodes before linearized reading' (duration: 407.76248ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:46.073834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:45.665957Z","time spent":"407.873171ms","remote":"127.0.0.1:45050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-25T10:32:52.667524Z","caller":"traceutil/trace.go:171","msg":"trace[1853661690] linearizableReadLoop","detail":"{readStateIndex:641; appliedIndex:640; }","duration":"423.079282ms","start":"2026-07-25T10:32:52.244416Z","end":"2026-07-25T10:32:52.667495Z","steps":["trace[1853661690] 'read index received' (duration: 421.371429ms)","trace[1853661690] 'applied index is now lower than readState.Index' (duration: 1.706943ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T10:32:52.66775Z","caller":"traceutil/trace.go:171","msg":"trace[164224704] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"825.425448ms","start":"2026-07-25T10:32:51.842266Z","end":"2026-07-25T10:32:52.667692Z","steps":["trace[164224704] 'process raft request' (duration: 823.890518ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:52.667952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.571839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-07-25T10:32:52.667979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:51.842227Z","time spent":"825.626781ms","remote":"127.0.0.1:45142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T10:32:52.668004Z","caller":"traceutil/trace.go:171","msg":"trace[554246436] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:613; }","duration":"417.67572ms","start":"2026-07-25T10:32:52.250312Z","end":"2026-07-25T10:32:52.667988Z","steps":["trace[554246436] 'agreement among raft nodes before linearized reading' (duration: 417.480987ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:52.66805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:52.250302Z","time spent":"417.73784ms","remote":"127.0.0.1:45302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-25T10:32:52.668055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.600249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-25T10:32:52.668151Z","caller":"traceutil/trace.go:171","msg":"trace[1341064456] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:613; }","duration":"423.71781ms","start":"2026-07-25T10:32:52.244407Z","end":"2026-07-25T10:32:52.668124Z","steps":["trace[1341064456] 'agreement among raft nodes before linearized reading' (duration: 423.361176ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:52.668204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:52.244327Z","time spent":"423.868353ms","remote":"127.0.0.1:45302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-25T10:32:52.668262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.965868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-42qwq\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-07-25T10:32:52.668397Z","caller":"traceutil/trace.go:171","msg":"trace[1165474173] range","detail":"{range_begin:/registry/pods/kube-system/cilium-42qwq; range_end:; response_count:1; response_revision:613; }","duration":"399.182111ms","start":"2026-07-25T10:32:52.269179Z","end":"2026-07-25T10:32:52.668361Z","steps":["trace[1165474173] 'agreement among raft nodes before linearized reading' (duration: 398.763845ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:52.668465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:52.26914Z","time spent":"399.309682ms","remote":"127.0.0.1:45226","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-42qwq\" "} {"level":"warn","ts":"2026-07-25T10:32:53.327047Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6605830232202028836,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-25T10:32:53.827723Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6605830232202028836,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-25T10:32:53.830972Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.094236848s","expected-duration":"1s"} {"level":"info","ts":"2026-07-25T10:32:53.832642Z","caller":"traceutil/trace.go:171","msg":"trace[512897339] linearizableReadLoop","detail":"{readStateIndex:645; appliedIndex:644; }","duration":"1.006211164s","start":"2026-07-25T10:32:52.826403Z","end":"2026-07-25T10:32:53.832614Z","steps":["trace[512897339] 'read index received' (duration: 1.004713003s)","trace[512897339] 'applied index is now lower than readState.Index' (duration: 1.497191ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T10:32:53.832744Z","caller":"traceutil/trace.go:171","msg":"trace[1863533373] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"1.104190914s","start":"2026-07-25T10:32:52.728506Z","end":"2026-07-25T10:32:53.832697Z","steps":["trace[1863533373] 'process raft request' (duration: 1.103359833s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:53.832902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:52.72848Z","time spent":"1.104340376s","remote":"127.0.0.1:45502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-25T10:32:53.832992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"916.935599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-07-25T10:32:53.832986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.391045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T10:32:53.833045Z","caller":"traceutil/trace.go:171","msg":"trace[458474829] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:617; }","duration":"916.99749ms","start":"2026-07-25T10:32:52.916031Z","end":"2026-07-25T10:32:53.833029Z","steps":["trace[458474829] 'agreement among raft nodes before linearized reading' (duration: 916.746137ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:32:53.833052Z","caller":"traceutil/trace.go:171","msg":"trace[55523815] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:617; }","duration":"164.532146ms","start":"2026-07-25T10:32:53.668505Z","end":"2026-07-25T10:32:53.833037Z","steps":["trace[55523815] 'agreement among raft nodes before linearized reading' (duration: 164.403414ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:53.833091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.00667859s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-07-25T10:32:53.833094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:52.916025Z","time spent":"917.056091ms","remote":"127.0.0.1:45302","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":"info","ts":"2026-07-25T10:32:53.833136Z","caller":"traceutil/trace.go:171","msg":"trace[1786496437] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:617; }","duration":"1.00675514s","start":"2026-07-25T10:32:52.826366Z","end":"2026-07-25T10:32:53.833121Z","steps":["trace[1786496437] 'agreement among raft nodes before linearized reading' (duration: 1.006365105s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:53.833185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:52.826349Z","time spent":"1.006825171s","remote":"127.0.0.1:45302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-25T10:33:09.501719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.720433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-25T10:33:09.501877Z","caller":"traceutil/trace.go:171","msg":"trace[1327911521] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:782; }","duration":"165.944966ms","start":"2026-07-25T10:33:09.335888Z","end":"2026-07-25T10:33:09.501833Z","steps":["trace[1327911521] 'count revisions from in-memory index tree' (duration: 165.562962ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:33:09.502009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.701322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-07-25T10:33:09.502133Z","caller":"traceutil/trace.go:171","msg":"trace[1056473517] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:782; }","duration":"160.881835ms","start":"2026-07-25T10:33:09.341229Z","end":"2026-07-25T10:33:09.502111Z","steps":["trace[1056473517] 'range keys from in-memory index tree' (duration: 160.456088ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:33:09.502017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.892551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-ssslb\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-07-25T10:33:09.502238Z","caller":"traceutil/trace.go:171","msg":"trace[1295590784] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-ssslb; range_end:; response_count:1; response_revision:782; }","duration":"118.245506ms","start":"2026-07-25T10:33:09.383963Z","end":"2026-07-25T10:33:09.502209Z","steps":["trace[1295590784] 'range keys from in-memory index tree' (duration: 117.615857ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:33:10.202045Z","caller":"traceutil/trace.go:171","msg":"trace[1937430935] transaction","detail":"{read_only:false; response_revision:783; number_of_response:1; }","duration":"695.106615ms","start":"2026-07-25T10:33:09.50691Z","end":"2026-07-25T10:33:10.202016Z","steps":["trace[1937430935] 'process raft request' (duration: 694.948593ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:33:10.202215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:33:09.506883Z","time spent":"695.244267ms","remote":"127.0.0.1:45302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T10:33:10.214207Z","caller":"traceutil/trace.go:171","msg":"trace[2092529981] transaction","detail":"{read_only:false; response_revision:784; number_of_response:1; }","duration":"704.31207ms","start":"2026-07-25T10:33:09.50986Z","end":"2026-07-25T10:33:10.214172Z","steps":["trace[2092529981] 'process raft request' (duration: 704.149428ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:33:10.214415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:33:09.509853Z","time spent":"704.449071ms","remote":"127.0.0.1:45226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4028,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T10:33:10.219206Z","caller":"traceutil/trace.go:171","msg":"trace[2054717530] linearizableReadLoop","detail":"{readStateIndex:820; appliedIndex:817; }","duration":"294.363968ms","start":"2026-07-25T10:33:09.924817Z","end":"2026-07-25T10:33:10.219181Z","steps":["trace[2054717530] 'read index received' (duration: 277.135604ms)","trace[2054717530] 'applied index is now lower than readState.Index' (duration: 17.227304ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T10:33:10.219436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.60356ms","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-07-25T10:33:10.219475Z","caller":"traceutil/trace.go:171","msg":"trace[1907698776] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:784; }","duration":"294.657331ms","start":"2026-07-25T10:33:09.924808Z","end":"2026-07-25T10:33:10.219465Z","steps":["trace[1907698776] 'agreement among raft nodes before linearized reading' (duration: 294.503979ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:33:10.219694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.258681ms","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-07-25T10:33:10.219819Z","caller":"traceutil/trace.go:171","msg":"trace[195245558] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:784; }","duration":"292.445284ms","start":"2026-07-25T10:33:09.927352Z","end":"2026-07-25T10:33:10.219797Z","steps":["trace[195245558] 'agreement among raft nodes before linearized reading' (duration: 292.018769ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:33:44.669054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.384234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.169\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-25T10:33:44.669157Z","caller":"traceutil/trace.go:171","msg":"trace[1351774821] range","detail":"{range_begin:/registry/masterleases/199.204.45.169; range_end:; response_count:1; response_revision:994; }","duration":"200.528915ms","start":"2026-07-25T10:33:44.468605Z","end":"2026-07-25T10:33:44.669134Z","steps":["trace[1351774821] 'range keys from in-memory index tree' (duration: 200.201882ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:34:06.664451Z","caller":"traceutil/trace.go:171","msg":"trace[1868310112] transaction","detail":"{read_only:false; response_revision:1065; number_of_response:1; }","duration":"134.433411ms","start":"2026-07-25T10:34:06.529991Z","end":"2026-07-25T10:34:06.664425Z","steps":["trace[1868310112] 'process raft request' (duration: 134.170189ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:34:07.055595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.834979ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-25T10:34:07.055805Z","caller":"traceutil/trace.go:171","msg":"trace[1703707302] transaction","detail":"{read_only:false; response_revision:1066; number_of_response:1; }","duration":"524.322817ms","start":"2026-07-25T10:34:06.531459Z","end":"2026-07-25T10:34:07.055781Z","steps":["trace[1703707302] 'process raft request' (duration: 296.067704ms)","trace[1703707302] 'compare' (duration: 227.716988ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T10:34:07.055878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:34:06.531441Z","time spent":"524.404097ms","remote":"127.0.0.1:45302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T10:34:07.056206Z","caller":"traceutil/trace.go:171","msg":"trace[273381463] linearizableReadLoop","detail":"{readStateIndex:1116; appliedIndex:1114; }","duration":"388.680975ms","start":"2026-07-25T10:34:06.667499Z","end":"2026-07-25T10:34:07.05618Z","steps":["trace[273381463] 'read index received' (duration: 160.028068ms)","trace[273381463] 'applied index is now lower than readState.Index' (duration: 228.651937ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T10:34:07.056367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.855947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T10:34:07.056399Z","caller":"traceutil/trace.go:171","msg":"trace[1912949600] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1067; }","duration":"388.974588ms","start":"2026-07-25T10:34:06.667413Z","end":"2026-07-25T10:34:07.056388Z","steps":["trace[1912949600] 'agreement among raft nodes before linearized reading' (duration: 388.869847ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:34:07.056432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:34:06.667381Z","time spent":"389.044308ms","remote":"127.0.0.1:45042","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-25T10:34:07.056514Z","caller":"traceutil/trace.go:171","msg":"trace[832860542] transaction","detail":"{read_only:false; response_revision:1067; number_of_response:1; }","duration":"524.409159ms","start":"2026-07-25T10:34:06.53207Z","end":"2026-07-25T10:34:07.056479Z","steps":["trace[832860542] 'process raft request' (duration: 523.660031ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:34:07.056656Z","caller":"traceutil/trace.go:171","msg":"trace[1621110068] transaction","detail":"{read_only:false; response_revision:1068; number_of_response:1; }","duration":"301.614184ms","start":"2026-07-25T10:34:06.75503Z","end":"2026-07-25T10:34:07.056644Z","steps":["trace[1621110068] 'process raft request' (duration: 301.046139ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:34:07.056717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:34:06.532056Z","time spent":"524.5472ms","remote":"127.0.0.1:45302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T10:34:07.056748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:34:06.755005Z","time spent":"301.686355ms","remote":"127.0.0.1:45302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T10:34:34.811164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.716143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T10:34:34.811245Z","caller":"traceutil/trace.go:171","msg":"trace[1342750683] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1157; }","duration":"143.856744ms","start":"2026-07-25T10:34:34.667368Z","end":"2026-07-25T10:34:34.811225Z","steps":["trace[1342750683] 'range keys from in-memory index tree' (duration: 143.620392ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:34:34.954007Z","caller":"traceutil/trace.go:171","msg":"trace[1527269530] transaction","detail":"{read_only:false; response_revision:1158; number_of_response:1; }","duration":"138.466056ms","start":"2026-07-25T10:34:34.815523Z","end":"2026-07-25T10:34:34.953989Z","steps":["trace[1527269530] 'process raft request' (duration: 138.336925ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:34:35.385703Z","caller":"traceutil/trace.go:171","msg":"trace[1665296248] linearizableReadLoop","detail":"{readStateIndex:1215; appliedIndex:1214; }","duration":"107.395472ms","start":"2026-07-25T10:34:35.278289Z","end":"2026-07-25T10:34:35.385684Z","steps":["trace[1665296248] 'read index received' (duration: 107.293371ms)","trace[1665296248] 'applied index is now lower than readState.Index' (duration: 101.231µs)"],"step_count":2} {"level":"info","ts":"2026-07-25T10:34:35.385865Z","caller":"traceutil/trace.go:171","msg":"trace[1572700735] transaction","detail":"{read_only:false; response_revision:1160; number_of_response:1; }","duration":"109.4596ms","start":"2026-07-25T10:34:35.276307Z","end":"2026-07-25T10:34:35.385767Z","steps":["trace[1572700735] 'process raft request' (duration: 109.271389ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:34:35.385883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.571553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-25T10:34:35.385924Z","caller":"traceutil/trace.go:171","msg":"trace[510853371] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1160; }","duration":"107.647845ms","start":"2026-07-25T10:34:35.278264Z","end":"2026-07-25T10:34:35.385912Z","steps":["trace[510853371] 'agreement among raft nodes before linearized reading' (duration: 107.524723ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:34:35.391793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.79847ms","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-07-25T10:34:35.391847Z","caller":"traceutil/trace.go:171","msg":"trace[480571074] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1161; }","duration":"104.87711ms","start":"2026-07-25T10:34:35.286958Z","end":"2026-07-25T10:34:35.391835Z","steps":["trace[480571074] 'agreement among raft nodes before linearized reading' (duration: 104.743939ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:34:35.391841Z","caller":"traceutil/trace.go:171","msg":"trace[1520537785] transaction","detail":"{read_only:false; response_revision:1161; number_of_response:1; }","duration":"113.427666ms","start":"2026-07-25T10:34:35.278385Z","end":"2026-07-25T10:34:35.391813Z","steps":["trace[1520537785] 'process raft request' (duration: 113.209344ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:34:35.510117Z","caller":"traceutil/trace.go:171","msg":"trace[1442819646] transaction","detail":"{read_only:false; response_revision:1162; number_of_response:1; }","duration":"120.482438ms","start":"2026-07-25T10:34:35.389615Z","end":"2026-07-25T10:34:35.510097Z","steps":["trace[1442819646] 'process raft request' (duration: 115.138591ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:34:35.516592Z","caller":"traceutil/trace.go:171","msg":"trace[319007638] transaction","detail":"{read_only:false; response_revision:1163; number_of_response:1; }","duration":"120.265236ms","start":"2026-07-25T10:34:35.396299Z","end":"2026-07-25T10:34:35.516565Z","steps":["trace[319007638] 'process raft request' (duration: 120.141845ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:34:37.477867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.513963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-25T10:34:37.477977Z","caller":"traceutil/trace.go:171","msg":"trace[543193687] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:1165; }","duration":"151.677645ms","start":"2026-07-25T10:34:37.326272Z","end":"2026-07-25T10:34:37.47795Z","steps":["trace[543193687] 'count revisions from in-memory index tree' (duration: 151.380372ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:34:37.659514Z","caller":"traceutil/trace.go:171","msg":"trace[1143227089] linearizableReadLoop","detail":"{readStateIndex:1222; appliedIndex:1220; }","duration":"145.269898ms","start":"2026-07-25T10:34:37.514218Z","end":"2026-07-25T10:34:37.659488Z","steps":["trace[1143227089] 'read index received' (duration: 19.251291ms)","trace[1143227089] 'applied index is now lower than readState.Index' (duration: 126.015707ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T10:34:37.659567Z","caller":"traceutil/trace.go:171","msg":"trace[1688604068] transaction","detail":"{read_only:false; response_revision:1167; number_of_response:1; }","duration":"177.593373ms","start":"2026-07-25T10:34:37.481926Z","end":"2026-07-25T10:34:37.65952Z","steps":["trace[1688604068] 'process raft request' (duration: 109.095737ms)","trace[1688604068] 'compare' (duration: 68.363845ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T10:34:37.659787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.517645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-07-25T10:34:37.6598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.56142ms","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-07-25T10:34:37.659829Z","caller":"traceutil/trace.go:171","msg":"trace[1779452217] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1167; }","duration":"140.595396ms","start":"2026-07-25T10:34:37.519223Z","end":"2026-07-25T10:34:37.659819Z","steps":["trace[1779452217] 'agreement among raft nodes before linearized reading' (duration: 140.443024ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:34:37.65987Z","caller":"traceutil/trace.go:171","msg":"trace[1789531037] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1167; }","duration":"145.661941ms","start":"2026-07-25T10:34:37.51419Z","end":"2026-07-25T10:34:37.659851Z","steps":["trace[1789531037] 'agreement among raft nodes before linearized reading' (duration: 145.430549ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:36:05.601999Z","caller":"traceutil/trace.go:171","msg":"trace[618469597] transaction","detail":"{read_only:false; response_revision:1456; number_of_response:1; }","duration":"130.222642ms","start":"2026-07-25T10:36:05.471746Z","end":"2026-07-25T10:36:05.601969Z","steps":["trace[618469597] 'process raft request' (duration: 80.353341ms)","trace[618469597] 'compare' (duration: 49.774778ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T10:36:06.354407Z","caller":"traceutil/trace.go:171","msg":"trace[300562439] linearizableReadLoop","detail":"{readStateIndex:1530; appliedIndex:1529; }","duration":"334.523533ms","start":"2026-07-25T10:36:06.019856Z","end":"2026-07-25T10:36:06.354379Z","steps":["trace[300562439] 'read index received' (duration: 334.265576ms)","trace[300562439] 'applied index is now lower than readState.Index' (duration: 257.167µs)"],"step_count":2} {"level":"info","ts":"2026-07-25T10:36:06.35453Z","caller":"traceutil/trace.go:171","msg":"trace[982747546] transaction","detail":"{read_only:false; response_revision:1457; number_of_response:1; }","duration":"399.349562ms","start":"2026-07-25T10:36:05.955167Z","end":"2026-07-25T10:36:06.354516Z","steps":["trace[982747546] 'process raft request' (duration: 399.047074ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:36:06.354651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:36:05.955136Z","time spent":"399.418254ms","remote":"127.0.0.1:45302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T10:36:06.354762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.034228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-07-25T10:36:06.354792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.595376ms","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-07-25T10:36:06.354835Z","caller":"traceutil/trace.go:171","msg":"trace[1349413089] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1457; }","duration":"215.152292ms","start":"2026-07-25T10:36:06.139666Z","end":"2026-07-25T10:36:06.354818Z","steps":["trace[1349413089] 'agreement among raft nodes before linearized reading' (duration: 214.898015ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:36:06.35488Z","caller":"traceutil/trace.go:171","msg":"trace[1681983994] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1457; }","duration":"214.71235ms","start":"2026-07-25T10:36:06.140146Z","end":"2026-07-25T10:36:06.354858Z","steps":["trace[1681983994] 'agreement among raft nodes before linearized reading' (duration: 214.493924ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:36:06.354792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.908892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-25T10:36:06.354944Z","caller":"traceutil/trace.go:171","msg":"trace[697704359] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1457; }","duration":"335.109518ms","start":"2026-07-25T10:36:06.019821Z","end":"2026-07-25T10:36:06.354931Z","steps":["trace[697704359] 'agreement among raft nodes before linearized reading' (duration: 334.770869ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:36:06.354982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:36:06.019806Z","time spent":"335.166019ms","remote":"127.0.0.1:45302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-25T10:36:14.544187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.693646ms","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-07-25T10:36:14.544264Z","caller":"traceutil/trace.go:171","msg":"trace[2123085502] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1484; }","duration":"133.80542ms","start":"2026-07-25T10:36:14.41044Z","end":"2026-07-25T10:36:14.544245Z","steps":["trace[2123085502] 'agreement among raft nodes before linearized reading' (duration: 133.570163ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:36:14.544267Z","caller":"traceutil/trace.go:171","msg":"trace[1350103198] transaction","detail":"{read_only:false; response_revision:1484; number_of_response:1; }","duration":"145.293681ms","start":"2026-07-25T10:36:14.398941Z","end":"2026-07-25T10:36:14.544235Z","steps":["trace[1350103198] 'process raft request' (duration: 144.90153ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:36:14.748425Z","caller":"traceutil/trace.go:171","msg":"trace[1387864278] transaction","detail":"{read_only:false; response_revision:1485; number_of_response:1; }","duration":"247.999072ms","start":"2026-07-25T10:36:14.500399Z","end":"2026-07-25T10:36:14.748398Z","steps":["trace[1387864278] 'process raft request' (duration: 247.870718ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:36:14.757202Z","caller":"traceutil/trace.go:171","msg":"trace[780019253] transaction","detail":"{read_only:false; response_revision:1486; number_of_response:1; }","duration":"208.977626ms","start":"2026-07-25T10:36:14.548197Z","end":"2026-07-25T10:36:14.757175Z","steps":["trace[780019253] 'process raft request' (duration: 208.650037ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:36:15.750476Z","caller":"traceutil/trace.go:171","msg":"trace[1101390196] transaction","detail":"{read_only:false; response_revision:1489; number_of_response:1; }","duration":"112.674044ms","start":"2026-07-25T10:36:15.637768Z","end":"2026-07-25T10:36:15.750442Z","steps":["trace[1101390196] 'process raft request' (duration: 31.240302ms)","trace[1101390196] 'compare' (duration: 81.283298ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T10:40:56.918003Z","caller":"traceutil/trace.go:171","msg":"trace[2058542477] transaction","detail":"{read_only:false; response_revision:2414; number_of_response:1; }","duration":"110.87523ms","start":"2026-07-25T10:40:56.807098Z","end":"2026-07-25T10:40:56.917974Z","steps":["trace[2058542477] 'process raft request' (duration: 110.678104ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:40:57.120425Z","caller":"traceutil/trace.go:171","msg":"trace[2001321438] transaction","detail":"{read_only:false; response_revision:2415; number_of_response:1; }","duration":"198.210867ms","start":"2026-07-25T10:40:56.922185Z","end":"2026-07-25T10:40:57.120396Z","steps":["trace[2001321438] 'process raft request' (duration: 198.066413ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:41:36.602692Z","caller":"traceutil/trace.go:171","msg":"trace[1637322891] linearizableReadLoop","detail":"{readStateIndex:2733; appliedIndex:2732; }","duration":"454.428791ms","start":"2026-07-25T10:41:36.148242Z","end":"2026-07-25T10:41:36.602671Z","steps":["trace[1637322891] 'read index received' (duration: 454.265107ms)","trace[1637322891] 'applied index is now lower than readState.Index' (duration: 162.644µs)"],"step_count":2} {"level":"info","ts":"2026-07-25T10:41:36.602797Z","caller":"traceutil/trace.go:171","msg":"trace[434293432] transaction","detail":"{read_only:false; response_revision:2592; number_of_response:1; }","duration":"455.444746ms","start":"2026-07-25T10:41:36.147323Z","end":"2026-07-25T10:41:36.602768Z","steps":["trace[434293432] 'process raft request' (duration: 455.19732ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:41:36.602915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.653047ms","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-07-25T10:41:36.602968Z","caller":"traceutil/trace.go:171","msg":"trace[87376496] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2592; }","duration":"454.739049ms","start":"2026-07-25T10:41:36.148218Z","end":"2026-07-25T10:41:36.602957Z","steps":["trace[87376496] 'agreement among raft nodes before linearized reading' (duration: 454.587056ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:41:36.603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:41:36.148206Z","time spent":"454.78599ms","remote":"127.0.0.1:45302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-25T10:41:36.602929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:41:36.147297Z","time spent":"455.557889ms","remote":"127.0.0.1:45302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T10:41:36.603055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.19642ms","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-07-25T10:41:36.603136Z","caller":"traceutil/trace.go:171","msg":"trace[104289585] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2592; }","duration":"195.295792ms","start":"2026-07-25T10:41:36.407821Z","end":"2026-07-25T10:41:36.603117Z","steps":["trace[104289585] 'agreement among raft nodes before linearized reading' (duration: 195.097027ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:41:36.603401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.496548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-25T10:41:36.603447Z","caller":"traceutil/trace.go:171","msg":"trace[212580401] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2592; }","duration":"195.658231ms","start":"2026-07-25T10:41:36.407778Z","end":"2026-07-25T10:41:36.603436Z","steps":["trace[212580401] 'agreement among raft nodes before linearized reading' (duration: 195.083057ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:41:37.044204Z","caller":"traceutil/trace.go:171","msg":"trace[1680951129] transaction","detail":"{read_only:false; response_revision:2593; number_of_response:1; }","duration":"436.558982ms","start":"2026-07-25T10:41:36.607626Z","end":"2026-07-25T10:41:37.044185Z","steps":["trace[1680951129] 'process raft request' (duration: 433.860066ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:41:37.044322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:41:36.607612Z","time spent":"436.655014ms","remote":"127.0.0.1:45302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T10:41:37.055688Z","caller":"traceutil/trace.go:171","msg":"trace[897513332] transaction","detail":"{read_only:false; response_revision:2595; number_of_response:1; }","duration":"447.591402ms","start":"2026-07-25T10:41:36.608082Z","end":"2026-07-25T10:41:37.055673Z","steps":["trace[897513332] 'process raft request' (duration: 447.52036ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:41:37.055727Z","caller":"traceutil/trace.go:171","msg":"trace[2054211169] transaction","detail":"{read_only:false; response_revision:2594; number_of_response:1; }","duration":"447.936461ms","start":"2026-07-25T10:41:36.607772Z","end":"2026-07-25T10:41:37.055708Z","steps":["trace[2054211169] 'process raft request' (duration: 447.744996ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:41:37.055804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:41:36.608072Z","time spent":"447.662513ms","remote":"127.0.0.1:45302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T10:41:37.055834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:41:36.607746Z","time spent":"448.024503ms","remote":"127.0.0.1:45302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T10:41:37.056077Z","caller":"traceutil/trace.go:171","msg":"trace[793502968] linearizableReadLoop","detail":"{readStateIndex:2736; appliedIndex:2733; }","duration":"389.312923ms","start":"2026-07-25T10:41:36.666743Z","end":"2026-07-25T10:41:37.056055Z","steps":["trace[793502968] 'read index received' (duration: 374.756996ms)","trace[793502968] 'applied index is now lower than readState.Index' (duration: 14.555097ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T10:41:37.056181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.427886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T10:41:37.056204Z","caller":"traceutil/trace.go:171","msg":"trace[491571829] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2597; }","duration":"389.495199ms","start":"2026-07-25T10:41:36.666702Z","end":"2026-07-25T10:41:37.056197Z","steps":["trace[491571829] 'agreement among raft nodes before linearized reading' (duration: 389.430956ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:41:37.05623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:41:36.666683Z","time spent":"389.541829ms","remote":"127.0.0.1:45042","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-25T10:41:53.967754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.237874ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-25T10:41:53.968063Z","caller":"traceutil/trace.go:171","msg":"trace[1115740452] linearizableReadLoop","detail":"{readStateIndex:2820; appliedIndex:2818; }","duration":"614.207001ms","start":"2026-07-25T10:41:53.353831Z","end":"2026-07-25T10:41:53.968038Z","steps":["trace[1115740452] 'read index received' (duration: 350.114381ms)","trace[1115740452] 'applied index is now lower than readState.Index' (duration: 264.09118ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T10:41:53.968096Z","caller":"traceutil/trace.go:171","msg":"trace[1974445538] transaction","detail":"{read_only:false; response_revision:2675; number_of_response:1; }","duration":"706.249699ms","start":"2026-07-25T10:41:53.261798Z","end":"2026-07-25T10:41:53.968048Z","steps":["trace[1974445538] 'process raft request' (duration: 441.588316ms)","trace[1974445538] 'compare' (duration: 263.768872ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T10:41:53.968189Z","caller":"traceutil/trace.go:171","msg":"trace[1011509386] transaction","detail":"{read_only:false; response_revision:2676; number_of_response:1; }","duration":"702.897887ms","start":"2026-07-25T10:41:53.265273Z","end":"2026-07-25T10:41:53.968171Z","steps":["trace[1011509386] 'process raft request' (duration: 702.62642ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:41:53.968304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.11983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-25T10:41:53.968326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"614.490419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-07-25T10:41:53.96838Z","caller":"traceutil/trace.go:171","msg":"trace[1581782553] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2676; }","duration":"301.261383ms","start":"2026-07-25T10:41:53.667097Z","end":"2026-07-25T10:41:53.968359Z","steps":["trace[1581782553] 'agreement among raft nodes before linearized reading' (duration: 301.112599ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:41:53.968404Z","caller":"traceutil/trace.go:171","msg":"trace[1845086926] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2676; }","duration":"614.633473ms","start":"2026-07-25T10:41:53.353754Z","end":"2026-07-25T10:41:53.968387Z","steps":["trace[1845086926] 'agreement among raft nodes before linearized reading' (duration: 614.434048ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:41:53.968439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:41:53.667074Z","time spent":"301.356866ms","remote":"127.0.0.1:45042","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-25T10:41:53.968448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:41:53.35372Z","time spent":"614.717195ms","remote":"127.0.0.1:45302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-25T10:41:53.968502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:41:53.261785Z","time spent":"706.463946ms","remote":"127.0.0.1:45122","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":770,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-25T10:41:53.968545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:41:53.265244Z","time spent":"703.130143ms","remote":"127.0.0.1:45302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":456,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T10:41:54.32387Z","caller":"traceutil/trace.go:171","msg":"trace[1900022279] transaction","detail":"{read_only:false; response_revision:2677; number_of_response:1; }","duration":"351.079564ms","start":"2026-07-25T10:41:53.972752Z","end":"2026-07-25T10:41:54.323832Z","steps":["trace[1900022279] 'process raft request' (duration: 272.23705ms)","trace[1900022279] 'compare' (duration: 78.572698ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T10:41:54.324065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:41:53.972731Z","time spent":"351.226108ms","remote":"127.0.0.1:45302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T10:41:55.399177Z","caller":"traceutil/trace.go:171","msg":"trace[281516400] transaction","detail":"{read_only:false; response_revision:2680; number_of_response:1; }","duration":"251.595852ms","start":"2026-07-25T10:41:55.147558Z","end":"2026-07-25T10:41:55.399154Z","steps":["trace[281516400] 'process raft request' (duration: 251.422978ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:41:55.399664Z","caller":"traceutil/trace.go:171","msg":"trace[1342400964] linearizableReadLoop","detail":"{readStateIndex:2825; appliedIndex:2825; }","duration":"237.707193ms","start":"2026-07-25T10:41:55.161921Z","end":"2026-07-25T10:41:55.399628Z","steps":["trace[1342400964] 'read index received' (duration: 237.703193ms)","trace[1342400964] 'applied index is now lower than readState.Index' (duration: 3.27µs)"],"step_count":2} {"level":"warn","ts":"2026-07-25T10:41:55.399818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.345129ms","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-07-25T10:41:55.399848Z","caller":"traceutil/trace.go:171","msg":"trace[1811643278] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2680; }","duration":"227.39155ms","start":"2026-07-25T10:41:55.172447Z","end":"2026-07-25T10:41:55.399839Z","steps":["trace[1811643278] 'agreement among raft nodes before linearized reading' (duration: 227.269077ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:41:55.400034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.751293ms","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-07-25T10:41:55.400061Z","caller":"traceutil/trace.go:171","msg":"trace[273665126] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2680; }","duration":"226.796465ms","start":"2026-07-25T10:41:55.173256Z","end":"2026-07-25T10:41:55.400052Z","steps":["trace[273665126] 'agreement among raft nodes before linearized reading' (duration: 226.717103ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:41:55.400086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.145824ms","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-07-25T10:41:55.400166Z","caller":"traceutil/trace.go:171","msg":"trace[2131266791] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2680; }","duration":"238.291207ms","start":"2026-07-25T10:41:55.161855Z","end":"2026-07-25T10:41:55.400147Z","steps":["trace[2131266791] 'agreement among raft nodes before linearized reading' (duration: 238.025801ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:41:55.735283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.411212ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T10:41:55.735397Z","caller":"traceutil/trace.go:171","msg":"trace[1996905759] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2683; }","duration":"190.539995ms","start":"2026-07-25T10:41:55.544841Z","end":"2026-07-25T10:41:55.735381Z","steps":["trace[1996905759] 'range keys from in-memory index tree' (duration: 190.395972ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:42:00.949185Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":1637} {"level":"info","ts":"2026-07-25T10:42:00.993112Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":1637,"took":"43.375514ms","hash":2415055761,"current-db-size-bytes":23355392,"current-db-size":"23 MB","current-db-size-in-use-bytes":5976064,"current-db-size-in-use":"6.0 MB"} {"level":"info","ts":"2026-07-25T10:42:00.993166Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2415055761,"revision":1637,"compact-revision":-1} {"level":"info","ts":"2026-07-25T10:47:00.957594Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2734} {"level":"info","ts":"2026-07-25T10:47:00.982732Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2734,"took":"23.551335ms","hash":3132681806,"current-db-size-bytes":23355392,"current-db-size":"23 MB","current-db-size-in-use-bytes":6332416,"current-db-size-in-use":"6.3 MB"} {"level":"info","ts":"2026-07-25T10:47:00.982957Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3132681806,"revision":2734,"compact-revision":1637}