{"level":"warn","ts":"2026-05-21T13:13:55.865326Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-21T13:13:55.86541Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.223: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.223:2380","--initial-cluster=instance=https://199.204.45.223:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.223:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.223: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-05-21T13:13:55.865474Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-21T13:13:55.865482Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.223:2380"]} {"level":"info","ts":"2026-05-21T13:13:55.865508Z","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-05-21T13:13:55.86636Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"]} {"level":"info","ts":"2026-05-21T13:13:55.866442Z","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.223:2380"],"listen-peer-urls":["https://199.204.45.223:2380"],"advertise-client-urls":["https://199.204.45.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.223: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-05-21T13:13:55.870756Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.068222ms"} {"level":"info","ts":"2026-05-21T13:13:55.879971Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"11f26225a5bb9fe3","cluster-id":"75c25101f01fd4c6"} {"level":"info","ts":"2026-05-21T13:13:55.880047Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=()"} {"level":"info","ts":"2026-05-21T13:13:55.880064Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became follower at term 0"} {"level":"info","ts":"2026-05-21T13:13:55.880075Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 11f26225a5bb9fe3 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-21T13:13:55.880083Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became follower at term 1"} {"level":"info","ts":"2026-05-21T13:13:55.880118Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=(1293203956842602467)"} {"level":"warn","ts":"2026-05-21T13:13:55.885298Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-21T13:13:55.886638Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-21T13:13:55.887839Z","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-05-21T13:13:55.890353Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"11f26225a5bb9fe3","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-21T13:13:55.890489Z","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-05-21T13:13:55.890582Z","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-05-21T13:13:55.890609Z","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-05-21T13:13:55.890674Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"11f26225a5bb9fe3","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-21T13:13:55.891974Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=(1293203956842602467)"} {"level":"info","ts":"2026-05-21T13:13:55.892403Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"75c25101f01fd4c6","local-member-id":"11f26225a5bb9fe3","added-peer-id":"11f26225a5bb9fe3","added-peer-peer-urls":["https://199.204.45.223:2380"]} {"level":"info","ts":"2026-05-21T13:13:55.895123Z","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-05-21T13:13:55.895396Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"11f26225a5bb9fe3","initial-advertise-peer-urls":["https://199.204.45.223:2380"],"listen-peer-urls":["https://199.204.45.223:2380"],"advertise-client-urls":["https://199.204.45.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-21T13:13:55.895426Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-21T13:13:55.895551Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.223:2380"} {"level":"info","ts":"2026-05-21T13:13:55.895567Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.223:2380"} {"level":"info","ts":"2026-05-21T13:13:56.080811Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 is starting a new election at term 1"} {"level":"info","ts":"2026-05-21T13:13:56.080871Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-21T13:13:56.080916Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 received MsgPreVoteResp from 11f26225a5bb9fe3 at term 1"} {"level":"info","ts":"2026-05-21T13:13:56.080937Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became candidate at term 2"} {"level":"info","ts":"2026-05-21T13:13:56.080948Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 received MsgVoteResp from 11f26225a5bb9fe3 at term 2"} {"level":"info","ts":"2026-05-21T13:13:56.080975Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became leader at term 2"} {"level":"info","ts":"2026-05-21T13:13:56.080989Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 11f26225a5bb9fe3 elected leader 11f26225a5bb9fe3 at term 2"} {"level":"info","ts":"2026-05-21T13:13:56.081839Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-21T13:13:56.082612Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"11f26225a5bb9fe3","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.223:2379]}","request-path":"/0/members/11f26225a5bb9fe3/attributes","cluster-id":"75c25101f01fd4c6","publish-timeout":"7s"} {"level":"info","ts":"2026-05-21T13:13:56.082773Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-21T13:13:56.082813Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-21T13:13:56.082968Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-21T13:13:56.083069Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-21T13:13:56.085053Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"75c25101f01fd4c6","local-member-id":"11f26225a5bb9fe3","cluster-version":"3.5"} {"level":"info","ts":"2026-05-21T13:13:56.085124Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-21T13:13:56.085143Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-21T13:13:56.088488Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-21T13:13:56.101428Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.223:2379"} {"level":"warn","ts":"2026-05-21T13:13:57.882496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.845204ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-21T13:13:57.882619Z","caller":"traceutil/trace.go:171","msg":"trace[2140251230] transaction","detail":"{read_only:false; response_revision:26; number_of_response:1; }","duration":"359.458585ms","start":"2026-05-21T13:13:57.523143Z","end":"2026-05-21T13:13:57.882601Z","steps":["trace[2140251230] 'process raft request' (duration: 149.091296ms)","trace[2140251230] 'compare' (duration: 209.67518ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T13:13:57.882701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T13:13:57.523128Z","time spent":"359.546477ms","remote":"127.0.0.1:34224","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":959,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-21T13:13:58.183048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.159969ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-21T13:13:58.183373Z","caller":"traceutil/trace.go:171","msg":"trace[1674186565] transaction","detail":"{read_only:false; response_revision:29; number_of_response:1; }","duration":"642.556461ms","start":"2026-05-21T13:13:57.540726Z","end":"2026-05-21T13:13:58.183282Z","steps":["trace[1674186565] 'process raft request' (duration: 642.466539ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T13:13:58.183433Z","caller":"traceutil/trace.go:171","msg":"trace[2068842156] transaction","detail":"{read_only:false; response_revision:35; number_of_response:1; }","duration":"298.171511ms","start":"2026-05-21T13:13:57.885251Z","end":"2026-05-21T13:13:58.183422Z","steps":["trace[2068842156] 'process raft request' (duration: 298.149201ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T13:13:58.183476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T13:13:57.540255Z","time spent":"643.180649ms","remote":"127.0.0.1:34224","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-21T13:13:58.183648Z","caller":"traceutil/trace.go:171","msg":"trace[911211782] transaction","detail":"{read_only:false; response_revision:32; number_of_response:1; }","duration":"641.643967ms","start":"2026-05-21T13:13:57.541974Z","end":"2026-05-21T13:13:58.183618Z","steps":["trace[911211782] 'process raft request' (duration: 641.274997ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T13:13:58.183707Z","caller":"traceutil/trace.go:171","msg":"trace[365471089] transaction","detail":"{read_only:false; response_revision:34; number_of_response:1; }","duration":"638.224443ms","start":"2026-05-21T13:13:57.545474Z","end":"2026-05-21T13:13:58.183699Z","steps":["trace[365471089] 'process raft request' (duration: 637.856633ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T13:13:58.18374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T13:13:57.541939Z","time spent":"641.76204ms","remote":"127.0.0.1:34224","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":926,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-21T13:13:58.183765Z","caller":"traceutil/trace.go:171","msg":"trace[1230898055] transaction","detail":"{read_only:false; response_revision:33; number_of_response:1; }","duration":"641.493742ms","start":"2026-05-21T13:13:57.542184Z","end":"2026-05-21T13:13:58.183678Z","steps":["trace[1230898055] 'process raft request' (duration: 641.123172ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T13:13:58.183809Z","caller":"traceutil/trace.go:171","msg":"trace[535958519] transaction","detail":"{read_only:false; response_revision:27; number_of_response:1; }","duration":"645.317818ms","start":"2026-05-21T13:13:57.538464Z","end":"2026-05-21T13:13:58.183782Z","steps":["trace[535958519] 'process raft request' (duration: 472.374397ms)","trace[535958519] 'compare' (duration: 172.060377ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T13:13:58.183774Z","caller":"traceutil/trace.go:171","msg":"trace[537839844] transaction","detail":"{read_only:false; response_revision:30; number_of_response:1; }","duration":"642.182422ms","start":"2026-05-21T13:13:57.541561Z","end":"2026-05-21T13:13:58.183744Z","steps":["trace[537839844] 'process raft request' (duration: 641.651098ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T13:13:58.183887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T13:13:57.538454Z","time spent":"645.39283ms","remote":"127.0.0.1:33826","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":357,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-21T13:13:58.183916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T13:13:57.542171Z","time spent":"641.670938ms","remote":"127.0.0.1:34224","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":959,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-21T13:13:58.183958Z","caller":"traceutil/trace.go:171","msg":"trace[1423666787] transaction","detail":"{read_only:false; response_revision:31; number_of_response:1; }","duration":"642.12336ms","start":"2026-05-21T13:13:57.541822Z","end":"2026-05-21T13:13:58.183946Z","steps":["trace[1423666787] 'process raft request' (duration: 641.40513ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T13:13:58.183943Z","caller":"traceutil/trace.go:171","msg":"trace[820387542] transaction","detail":"{read_only:false; response_revision:28; number_of_response:1; }","duration":"644.636759ms","start":"2026-05-21T13:13:57.539266Z","end":"2026-05-21T13:13:58.183903Z","steps":["trace[820387542] 'process raft request' (duration: 643.895209ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T13:13:58.18399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T13:13:57.540656Z","time spent":"643.291082ms","remote":"127.0.0.1:34224","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":983,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-21T13:13:58.184009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T13:13:57.545454Z","time spent":"638.275625ms","remote":"127.0.0.1:33884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3479,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-21T13:13:58.184029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T13:13:57.541805Z","time spent":"642.196902ms","remote":"127.0.0.1:34140","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":713,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-21T13:13:58.184068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T13:13:57.539253Z","time spent":"644.762943ms","remote":"127.0.0.1:33826","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3004,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-21T13:13:58.18417Z","caller":"traceutil/trace.go:171","msg":"trace[1029865311] linearizableReadLoop","detail":"{readStateIndex:33; appliedIndex:29; }","duration":"642.813789ms","start":"2026-05-21T13:13:57.541348Z","end":"2026-05-21T13:13:58.184162Z","steps":["trace[1029865311] 'read index received' (duration: 130.885825ms)","trace[1029865311] 'applied index is now lower than readState.Index' (duration: 511.907223ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T13:13:58.184276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"642.923742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-node-lease/\" range_end:\"/registry/resourcequotas/kube-node-lease0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-21T13:13:58.184325Z","caller":"traceutil/trace.go:171","msg":"trace[282615091] range","detail":"{range_begin:/registry/resourcequotas/kube-node-lease/; range_end:/registry/resourcequotas/kube-node-lease0; response_count:0; response_revision:35; }","duration":"642.981993ms","start":"2026-05-21T13:13:57.541312Z","end":"2026-05-21T13:13:58.184294Z","steps":["trace[282615091] 'agreement among raft nodes before linearized reading' (duration: 642.929722ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T13:13:58.184356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T13:13:57.541271Z","time spent":"643.075147ms","remote":"127.0.0.1:33806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":26,"request content":"key:\"/registry/resourcequotas/kube-node-lease/\" range_end:\"/registry/resourcequotas/kube-node-lease0\" "} {"level":"warn","ts":"2026-05-21T13:13:58.184368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"524.333394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-21T13:13:58.184421Z","caller":"traceutil/trace.go:171","msg":"trace[1246675610] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:35; }","duration":"524.429156ms","start":"2026-05-21T13:13:57.659977Z","end":"2026-05-21T13:13:58.184407Z","steps":["trace[1246675610] 'agreement among raft nodes before linearized reading' (duration: 524.333674ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T13:13:58.184459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T13:13:57.659955Z","time spent":"524.496798ms","remote":"127.0.0.1:33966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":26,"request content":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" "} {"level":"warn","ts":"2026-05-21T13:13:58.18461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.728137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-21T13:13:58.184656Z","caller":"traceutil/trace.go:171","msg":"trace[2033565352] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:35; }","duration":"432.803199ms","start":"2026-05-21T13:13:57.751828Z","end":"2026-05-21T13:13:58.184631Z","steps":["trace[2033565352] 'agreement among raft nodes before linearized reading' (duration: 432.763748ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T13:13:58.184683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T13:13:57.751807Z","time spent":"432.869811ms","remote":"127.0.0.1:34074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":26,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"info","ts":"2026-05-21T13:14:32.502023Z","caller":"traceutil/trace.go:171","msg":"trace[1052242614] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"139.02077ms","start":"2026-05-21T13:14:32.36298Z","end":"2026-05-21T13:14:32.502001Z","steps":["trace[1052242614] 'process raft request' (duration: 138.538846ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T13:14:32.979538Z","caller":"traceutil/trace.go:171","msg":"trace[310044343] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"110.756483ms","start":"2026-05-21T13:14:32.86875Z","end":"2026-05-21T13:14:32.979506Z","steps":["trace[310044343] 'process raft request' (duration: 82.23673ms)","trace[310044343] 'compare' (duration: 28.160963ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T13:14:33.247252Z","caller":"traceutil/trace.go:171","msg":"trace[1988995720] linearizableReadLoop","detail":"{readStateIndex:584; appliedIndex:583; }","duration":"206.626907ms","start":"2026-05-21T13:14:33.040605Z","end":"2026-05-21T13:14:33.247232Z","steps":["trace[1988995720] 'read index received' (duration: 162.34993ms)","trace[1988995720] 'applied index is now lower than readState.Index' (duration: 44.276167ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T13:14:33.247408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.791561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/tlsroutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:65214"} {"level":"info","ts":"2026-05-21T13:14:33.247433Z","caller":"traceutil/trace.go:171","msg":"trace[1308384763] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/tlsroutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:560; }","duration":"206.828562ms","start":"2026-05-21T13:14:33.040595Z","end":"2026-05-21T13:14:33.247424Z","steps":["trace[1308384763] 'agreement among raft nodes before linearized reading' (duration: 206.708589ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T13:14:33.247481Z","caller":"traceutil/trace.go:171","msg":"trace[1144684664] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"208.962041ms","start":"2026-05-21T13:14:33.038498Z","end":"2026-05-21T13:14:33.24746Z","steps":["trace[1144684664] 'process raft request' (duration: 164.5258ms)","trace[1144684664] 'compare' (duration: 44.098152ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T13:14:38.823022Z","caller":"traceutil/trace.go:171","msg":"trace[1131856603] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"171.621525ms","start":"2026-05-21T13:14:38.651376Z","end":"2026-05-21T13:14:38.822998Z","steps":["trace[1131856603] 'process raft request' (duration: 171.44079ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T13:14:54.212804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.892671ms","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-05-21T13:14:54.212909Z","caller":"traceutil/trace.go:171","msg":"trace[1228355419] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:751; }","duration":"143.050895ms","start":"2026-05-21T13:14:54.069837Z","end":"2026-05-21T13:14:54.212887Z","steps":["trace[1228355419] 'range keys from in-memory index tree' (duration: 142.698825ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T13:15:48.679038Z","caller":"traceutil/trace.go:171","msg":"trace[1816886718] transaction","detail":"{read_only:false; response_revision:1035; number_of_response:1; }","duration":"179.55108ms","start":"2026-05-21T13:15:48.49946Z","end":"2026-05-21T13:15:48.679011Z","steps":["trace[1816886718] 'process raft request' (duration: 179.410266ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T13:15:48.691362Z","caller":"traceutil/trace.go:171","msg":"trace[1263949065] linearizableReadLoop","detail":"{readStateIndex:1079; appliedIndex:1077; }","duration":"187.012235ms","start":"2026-05-21T13:15:48.504317Z","end":"2026-05-21T13:15:48.691329Z","steps":["trace[1263949065] 'read index received' (duration: 174.589144ms)","trace[1263949065] 'applied index is now lower than readState.Index' (duration: 12.421941ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T13:15:48.691472Z","caller":"traceutil/trace.go:171","msg":"trace[192747526] transaction","detail":"{read_only:false; response_revision:1036; number_of_response:1; }","duration":"191.416636ms","start":"2026-05-21T13:15:48.50002Z","end":"2026-05-21T13:15:48.691436Z","steps":["trace[192747526] 'process raft request' (duration: 191.159049ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T13:15:48.691551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.20876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T13:15:48.691613Z","caller":"traceutil/trace.go:171","msg":"trace[1352316987] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1036; }","duration":"187.308053ms","start":"2026-05-21T13:15:48.50429Z","end":"2026-05-21T13:15:48.691598Z","steps":["trace[1352316987] 'agreement among raft nodes before linearized reading' (duration: 187.155078ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T13:15:50.281661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.866646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-21T13:15:50.281749Z","caller":"traceutil/trace.go:171","msg":"trace[1749844794] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1039; }","duration":"121.01762ms","start":"2026-05-21T13:15:50.160712Z","end":"2026-05-21T13:15:50.281729Z","steps":["trace[1749844794] 'range keys from in-memory index tree' (duration: 120.598828ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T13:15:50.282213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.312483ms","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-05-21T13:15:50.282336Z","caller":"traceutil/trace.go:171","msg":"trace[444440614] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1039; }","duration":"223.707445ms","start":"2026-05-21T13:15:50.058607Z","end":"2026-05-21T13:15:50.282314Z","steps":["trace[444440614] 'range keys from in-memory index tree' (duration: 223.115058ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T13:15:50.440848Z","caller":"traceutil/trace.go:171","msg":"trace[894133663] transaction","detail":"{read_only:false; response_revision:1041; number_of_response:1; }","duration":"154.592473ms","start":"2026-05-21T13:15:50.286231Z","end":"2026-05-21T13:15:50.440823Z","steps":["trace[894133663] 'process raft request' (duration: 154.455049ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T13:16:20.790619Z","caller":"traceutil/trace.go:171","msg":"trace[1148176721] transaction","detail":"{read_only:false; response_revision:1211; number_of_response:1; }","duration":"101.477831ms","start":"2026-05-21T13:16:20.689116Z","end":"2026-05-21T13:16:20.790594Z","steps":["trace[1148176721] 'process raft request' (duration: 101.322376ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T13:16:24.402557Z","caller":"traceutil/trace.go:171","msg":"trace[1327868179] transaction","detail":"{read_only:false; response_revision:1241; number_of_response:1; }","duration":"107.272188ms","start":"2026-05-21T13:16:24.295257Z","end":"2026-05-21T13:16:24.402529Z","steps":["trace[1327868179] 'process raft request' (duration: 85.390423ms)","trace[1327868179] 'compare' (duration: 21.765752ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T13:16:34.360713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.55577ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-05-21T13:16:34.362324Z","caller":"traceutil/trace.go:171","msg":"trace[1821285458] linearizableReadLoop","detail":"{readStateIndex:1362; appliedIndex:1360; }","duration":"180.543322ms","start":"2026-05-21T13:16:34.181699Z","end":"2026-05-21T13:16:34.362243Z","steps":["trace[1821285458] 'read index received' (duration: 171.069084ms)","trace[1821285458] 'applied index is now lower than readState.Index' (duration: 9.472318ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T13:16:34.362897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.182309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-05-21T13:16:34.362957Z","caller":"traceutil/trace.go:171","msg":"trace[632819712] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1307; }","duration":"181.275091ms","start":"2026-05-21T13:16:34.181656Z","end":"2026-05-21T13:16:34.362931Z","steps":["trace[632819712] 'agreement among raft nodes before linearized reading' (duration: 180.742157ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T13:16:34.363046Z","caller":"traceutil/trace.go:171","msg":"trace[453269653] transaction","detail":"{read_only:false; response_revision:1307; number_of_response:1; }","duration":"187.035738ms","start":"2026-05-21T13:16:34.175957Z","end":"2026-05-21T13:16:34.362993Z","steps":["trace[453269653] 'process raft request' (duration: 185.953719ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T13:20:26.03672Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521226315291541088,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-21T13:20:26.097458Z","caller":"traceutil/trace.go:171","msg":"trace[632701116] linearizableReadLoop","detail":"{readStateIndex:2503; appliedIndex:2502; }","duration":"561.634996ms","start":"2026-05-21T13:20:25.535778Z","end":"2026-05-21T13:20:26.097413Z","steps":["trace[632701116] 'read index received' (duration: 559.59493ms)","trace[632701116] 'applied index is now lower than readState.Index' (duration: 2.038466ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T13:20:26.097608Z","caller":"traceutil/trace.go:171","msg":"trace[74916897] transaction","detail":"{read_only:false; response_revision:2401; number_of_response:1; }","duration":"567.058285ms","start":"2026-05-21T13:20:25.530537Z","end":"2026-05-21T13:20:26.097596Z","steps":["trace[74916897] 'process raft request' (duration: 564.822453ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T13:20:26.104306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.39568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:endpointslice-controller\" ","response":"range_response_count:1 size:791"} {"level":"warn","ts":"2026-05-21T13:20:26.104316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"568.521656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/cluster-admin\" ","response":"range_response_count:1 size:679"} {"level":"info","ts":"2026-05-21T13:20:26.104407Z","caller":"traceutil/trace.go:171","msg":"trace[610225686] range","detail":"{range_begin:/registry/clusterroles/system:controller:endpointslice-controller; range_end:; response_count:1; response_revision:2401; }","duration":"507.553135ms","start":"2026-05-21T13:20:25.59683Z","end":"2026-05-21T13:20:26.104383Z","steps":["trace[610225686] 'agreement among raft nodes before linearized reading' (duration: 507.35234ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T13:20:26.104416Z","caller":"traceutil/trace.go:171","msg":"trace[1153382998] range","detail":"{range_begin:/registry/clusterrolebindings/cluster-admin; range_end:; response_count:1; response_revision:2401; }","duration":"568.65945ms","start":"2026-05-21T13:20:25.535733Z","end":"2026-05-21T13:20:26.104392Z","steps":["trace[1153382998] 'agreement among raft nodes before linearized reading' (duration: 568.499355ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T13:20:26.104463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T13:20:25.535717Z","time spent":"568.734031ms","remote":"127.0.0.1:34050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":701,"request content":"key:\"/registry/clusterrolebindings/cluster-admin\" "} {"level":"warn","ts":"2026-05-21T13:20:26.104446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T13:20:25.596811Z","time spent":"507.628117ms","remote":"127.0.0.1:34048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":1,"response size":813,"request content":"key:\"/registry/clusterroles/system:controller:endpointslice-controller\" "} {"level":"warn","ts":"2026-05-21T13:20:26.104728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T13:20:25.530517Z","time spent":"567.115177ms","remote":"127.0.0.1:33966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-21T13:20:26.104834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.354005ms","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-05-21T13:20:26.104915Z","caller":"traceutil/trace.go:171","msg":"trace[273726998] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2401; }","duration":"389.475329ms","start":"2026-05-21T13:20:25.715427Z","end":"2026-05-21T13:20:26.104902Z","steps":["trace[273726998] 'agreement among raft nodes before linearized reading' (duration: 389.325464ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T13:20:26.104954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T13:20:25.715406Z","time spent":"389.538541ms","remote":"127.0.0.1:33966","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-05-21T13:20:28.892515Z","caller":"traceutil/trace.go:171","msg":"trace[963466439] transaction","detail":"{read_only:false; response_revision:2417; number_of_response:1; }","duration":"317.771752ms","start":"2026-05-21T13:20:28.57472Z","end":"2026-05-21T13:20:28.892491Z","steps":["trace[963466439] 'process raft request' (duration: 317.463513ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T13:20:28.892747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T13:20:28.574707Z","time spent":"317.935847ms","remote":"127.0.0.1:33966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-21T13:20:28.892818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.583377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:ephemeral-volume-controller\" ","response":"range_response_count:1 size:783"} {"level":"info","ts":"2026-05-21T13:20:28.892887Z","caller":"traceutil/trace.go:171","msg":"trace[1942253378] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:ephemeral-volume-controller; range_end:; response_count:1; response_revision:2417; }","duration":"317.668779ms","start":"2026-05-21T13:20:28.575197Z","end":"2026-05-21T13:20:28.892866Z","steps":["trace[1942253378] 'agreement among raft nodes before linearized reading' (duration: 317.528955ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T13:20:28.892387Z","caller":"traceutil/trace.go:171","msg":"trace[416981301] linearizableReadLoop","detail":"{readStateIndex:2519; appliedIndex:2518; }","duration":"317.143554ms","start":"2026-05-21T13:20:28.575216Z","end":"2026-05-21T13:20:28.89236Z","steps":["trace[416981301] 'read index received' (duration: 316.893987ms)","trace[416981301] 'applied index is now lower than readState.Index' (duration: 248.357µs)"],"step_count":2} {"level":"warn","ts":"2026-05-21T13:20:28.892935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T13:20:28.57519Z","time spent":"317.732271ms","remote":"127.0.0.1:34050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":77,"response count":1,"response size":805,"request content":"key:\"/registry/clusterrolebindings/system:controller:ephemeral-volume-controller\" "} {"level":"warn","ts":"2026-05-21T13:20:28.893526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.491547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:expand-controller\" ","response":"range_response_count:1 size:743"} {"level":"info","ts":"2026-05-21T13:20:28.893581Z","caller":"traceutil/trace.go:171","msg":"trace[653808548] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:expand-controller; range_end:; response_count:1; response_revision:2417; }","duration":"246.582879ms","start":"2026-05-21T13:20:28.646981Z","end":"2026-05-21T13:20:28.893564Z","steps":["trace[653808548] 'agreement among raft nodes before linearized reading' (duration: 246.410195ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T13:20:35.237432Z","caller":"traceutil/trace.go:171","msg":"trace[1187672289] linearizableReadLoop","detail":"{readStateIndex:2542; appliedIndex:2541; }","duration":"328.204769ms","start":"2026-05-21T13:20:34.90919Z","end":"2026-05-21T13:20:35.237394Z","steps":["trace[1187672289] 'read index received' (duration: 324.808005ms)","trace[1187672289] 'applied index is now lower than readState.Index' (duration: 3.392303ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T13:20:35.23762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.724395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T13:20:35.237647Z","caller":"traceutil/trace.go:171","msg":"trace[1723332379] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:2439; }","duration":"315.779096ms","start":"2026-05-21T13:20:34.921861Z","end":"2026-05-21T13:20:35.23764Z","steps":["trace[1723332379] 'agreement among raft nodes before linearized reading' (duration: 315.697144ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T13:20:35.237625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.147977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-node-lease\" ","response":"range_response_count:1 size:363"} {"level":"warn","ts":"2026-05-21T13:20:35.237675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T13:20:34.921857Z","time spent":"315.811967ms","remote":"127.0.0.1:34018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":27,"request content":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true "} {"level":"warn","ts":"2026-05-21T13:20:35.237662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.411114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-21T13:20:35.237723Z","caller":"traceutil/trace.go:171","msg":"trace[991096559] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2439; }","duration":"328.486496ms","start":"2026-05-21T13:20:34.909222Z","end":"2026-05-21T13:20:35.237708Z","steps":["trace[991096559] 'agreement among raft nodes before linearized reading' (duration: 328.334092ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T13:20:35.237759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T13:20:34.909219Z","time spent":"328.534437ms","remote":"127.0.0.1:33966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-21T13:20:35.237772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.579469ms","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-05-21T13:20:35.237793Z","caller":"traceutil/trace.go:171","msg":"trace[1974129755] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2439; }","duration":"328.62402ms","start":"2026-05-21T13:20:34.909163Z","end":"2026-05-21T13:20:35.237787Z","steps":["trace[1974129755] 'agreement among raft nodes before linearized reading' (duration: 328.541308ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T13:20:35.237823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T13:20:34.909153Z","time spent":"328.663891ms","remote":"127.0.0.1:33966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-21T13:20:35.237839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.951711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T13:20:35.23786Z","caller":"traceutil/trace.go:171","msg":"trace[310575327] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:2439; }","duration":"315.979611ms","start":"2026-05-21T13:20:34.921876Z","end":"2026-05-21T13:20:35.237856Z","steps":["trace[310575327] 'agreement among raft nodes before linearized reading' (duration: 315.94578ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T13:20:35.23788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T13:20:34.921874Z","time spent":"316.002182ms","remote":"127.0.0.1:33984","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":27,"request content":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true "} {"level":"warn","ts":"2026-05-21T13:20:35.237912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.657341ms","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-05-21T13:20:35.237937Z","caller":"traceutil/trace.go:171","msg":"trace[927997823] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2439; }","duration":"328.686512ms","start":"2026-05-21T13:20:34.909244Z","end":"2026-05-21T13:20:35.237931Z","steps":["trace[927997823] 'agreement among raft nodes before linearized reading' (duration: 328.627361ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T13:20:35.237958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T13:20:34.909243Z","time spent":"328.711213ms","remote":"127.0.0.1:33966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-21T13:20:35.23801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.129365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T13:20:35.238032Z","caller":"traceutil/trace.go:171","msg":"trace[83514167] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2439; }","duration":"316.181097ms","start":"2026-05-21T13:20:34.921845Z","end":"2026-05-21T13:20:35.238026Z","steps":["trace[83514167] 'agreement among raft nodes before linearized reading' (duration: 316.148006ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T13:20:35.23805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T13:20:34.921824Z","time spent":"316.222489ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-21T13:20:35.23805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.804436ms","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-05-21T13:20:35.237686Z","caller":"traceutil/trace.go:171","msg":"trace[939191685] range","detail":"{range_begin:/registry/namespaces/kube-node-lease; range_end:; response_count:1; response_revision:2439; }","duration":"270.24443ms","start":"2026-05-21T13:20:34.967427Z","end":"2026-05-21T13:20:35.237671Z","steps":["trace[939191685] 'agreement among raft nodes before linearized reading' (duration: 270.148348ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T13:20:35.238133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.866947ms","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-05-21T13:20:35.238151Z","caller":"traceutil/trace.go:171","msg":"trace[1636856342] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2439; }","duration":"328.891287ms","start":"2026-05-21T13:20:34.909255Z","end":"2026-05-21T13:20:35.238146Z","steps":["trace[1636856342] 'agreement among raft nodes before linearized reading' (duration: 328.843186ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T13:20:35.238168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T13:20:34.909253Z","time spent":"328.911388ms","remote":"127.0.0.1:33966","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":"info","ts":"2026-05-21T13:20:35.238074Z","caller":"traceutil/trace.go:171","msg":"trace[1270700246] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2439; }","duration":"328.833646ms","start":"2026-05-21T13:20:34.909234Z","end":"2026-05-21T13:20:35.238068Z","steps":["trace[1270700246] 'agreement among raft nodes before linearized reading' (duration: 328.764994ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T13:20:35.238245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T13:20:34.909232Z","time spent":"329.004661ms","remote":"127.0.0.1:33966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-21T13:20:35.238325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.469385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"info","ts":"2026-05-21T13:20:35.238348Z","caller":"traceutil/trace.go:171","msg":"trace[1068895210] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2439; }","duration":"316.517137ms","start":"2026-05-21T13:20:34.921823Z","end":"2026-05-21T13:20:35.23834Z","steps":["trace[1068895210] 'agreement among raft nodes before linearized reading' (duration: 316.453285ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T13:20:35.23837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T13:20:34.921809Z","time spent":"316.555947ms","remote":"127.0.0.1:33966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":557,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "}