{"level":"warn","ts":"2026-04-23T10:19:22.816125Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-23T10:19:22.816237Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.25: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.25:2380","--initial-cluster=instance=https://199.204.45.25:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.25:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.25: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-04-23T10:19:22.816312Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-23T10:19:22.816324Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.25:2380"]} {"level":"info","ts":"2026-04-23T10:19:22.816345Z","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-04-23T10:19:22.816893Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.25:2379"]} {"level":"info","ts":"2026-04-23T10:19:22.81696Z","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.25:2380"],"listen-peer-urls":["https://199.204.45.25:2380"],"advertise-client-urls":["https://199.204.45.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.25: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-04-23T10:19:22.825848Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"8.686846ms"} {"level":"info","ts":"2026-04-23T10:19:22.850763Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ba52c55cf4193752","cluster-id":"4468ed52294bc271"} {"level":"info","ts":"2026-04-23T10:19:22.850844Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 switched to configuration voters=()"} {"level":"info","ts":"2026-04-23T10:19:22.850864Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became follower at term 0"} {"level":"info","ts":"2026-04-23T10:19:22.850874Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ba52c55cf4193752 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-23T10:19:22.850883Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became follower at term 1"} {"level":"info","ts":"2026-04-23T10:19:22.85092Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 switched to configuration voters=(13426010442167826258)"} {"level":"warn","ts":"2026-04-23T10:19:22.866784Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-23T10:19:22.869743Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-23T10:19:22.871221Z","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-04-23T10:19:22.87397Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ba52c55cf4193752","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-23T10:19:22.874075Z","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-04-23T10:19:22.874166Z","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-04-23T10:19:22.874179Z","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-04-23T10:19:22.874169Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ba52c55cf4193752","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-23T10:19:22.875825Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 switched to configuration voters=(13426010442167826258)"} {"level":"info","ts":"2026-04-23T10:19:22.875989Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4468ed52294bc271","local-member-id":"ba52c55cf4193752","added-peer-id":"ba52c55cf4193752","added-peer-peer-urls":["https://199.204.45.25:2380"]} {"level":"info","ts":"2026-04-23T10:19:22.885823Z","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-04-23T10:19:22.885956Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.25:2380"} {"level":"info","ts":"2026-04-23T10:19:22.886034Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.25:2380"} {"level":"info","ts":"2026-04-23T10:19:22.886265Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ba52c55cf4193752","initial-advertise-peer-urls":["https://199.204.45.25:2380"],"listen-peer-urls":["https://199.204.45.25:2380"],"advertise-client-urls":["https://199.204.45.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-23T10:19:22.886332Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-23T10:19:23.151161Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 is starting a new election at term 1"} {"level":"info","ts":"2026-04-23T10:19:23.15122Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-23T10:19:23.151298Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 received MsgPreVoteResp from ba52c55cf4193752 at term 1"} {"level":"info","ts":"2026-04-23T10:19:23.151326Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became candidate at term 2"} {"level":"info","ts":"2026-04-23T10:19:23.151346Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 received MsgVoteResp from ba52c55cf4193752 at term 2"} {"level":"info","ts":"2026-04-23T10:19:23.151499Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became leader at term 2"} {"level":"info","ts":"2026-04-23T10:19:23.151656Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ba52c55cf4193752 elected leader ba52c55cf4193752 at term 2"} {"level":"info","ts":"2026-04-23T10:19:23.152823Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ba52c55cf4193752","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.25:2379]}","request-path":"/0/members/ba52c55cf4193752/attributes","cluster-id":"4468ed52294bc271","publish-timeout":"7s"} {"level":"info","ts":"2026-04-23T10:19:23.153088Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-23T10:19:23.153172Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-23T10:19:23.153781Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T10:19:23.154118Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-23T10:19:23.154149Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-23T10:19:23.154724Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4468ed52294bc271","local-member-id":"ba52c55cf4193752","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T10:19:23.155039Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T10:19:23.155093Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T10:19:23.157706Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.25:2379"} {"level":"info","ts":"2026-04-23T10:19:23.158045Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-23T10:19:43.382866Z","caller":"traceutil/trace.go:171","msg":"trace[1674111234] linearizableReadLoop","detail":"{readStateIndex:463; appliedIndex:462; }","duration":"255.993134ms","start":"2026-04-23T10:19:43.126847Z","end":"2026-04-23T10:19:43.38284Z","steps":["trace[1674111234] 'read index received' (duration: 255.922831ms)","trace[1674111234] 'applied index is now lower than readState.Index' (duration: 69.052µs)"],"step_count":2} {"level":"info","ts":"2026-04-23T10:19:43.383006Z","caller":"traceutil/trace.go:171","msg":"trace[1584516693] transaction","detail":"{read_only:false; response_revision:451; number_of_response:1; }","duration":"677.02141ms","start":"2026-04-23T10:19:42.705948Z","end":"2026-04-23T10:19:43.38297Z","steps":["trace[1584516693] 'process raft request' (duration: 676.749389ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:19:43.383077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.989643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-04-23T10:19:43.383159Z","caller":"traceutil/trace.go:171","msg":"trace[1201921468] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:451; }","duration":"256.130379ms","start":"2026-04-23T10:19:43.127016Z","end":"2026-04-23T10:19:43.383146Z","steps":["trace[1201921468] 'agreement among raft nodes before linearized reading' (duration: 255.996304ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:19:43.38318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.305156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-23T10:19:43.38341Z","caller":"traceutil/trace.go:171","msg":"trace[761417688] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:451; }","duration":"256.448262ms","start":"2026-04-23T10:19:43.126807Z","end":"2026-04-23T10:19:43.383255Z","steps":["trace[761417688] 'agreement among raft nodes before linearized reading' (duration: 256.1748ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:19:43.383972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:19:42.705921Z","time spent":"677.169566ms","remote":"127.0.0.1:56820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T10:19:46.638105Z","caller":"traceutil/trace.go:171","msg":"trace[826836971] transaction","detail":"{read_only:false; response_revision:460; number_of_response:1; }","duration":"136.942836ms","start":"2026-04-23T10:19:46.501134Z","end":"2026-04-23T10:19:46.638077Z","steps":["trace[826836971] 'process raft request' (duration: 127.700415ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:19:56.250473Z","caller":"traceutil/trace.go:171","msg":"trace[1923552544] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"143.810613ms","start":"2026-04-23T10:19:56.106621Z","end":"2026-04-23T10:19:56.250432Z","steps":["trace[1923552544] 'process raft request' (duration: 143.534063ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:19:56.25063Z","caller":"traceutil/trace.go:171","msg":"trace[51528978] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"143.858506ms","start":"2026-04-23T10:19:56.106756Z","end":"2026-04-23T10:19:56.250614Z","steps":["trace[51528978] 'process raft request' (duration: 143.605967ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:19:56.250631Z","caller":"traceutil/trace.go:171","msg":"trace[309938319] transaction","detail":"{read_only:false; number_of_response:1; response_revision:520; }","duration":"143.903197ms","start":"2026-04-23T10:19:56.106683Z","end":"2026-04-23T10:19:56.250586Z","steps":["trace[309938319] 'process raft request' (duration: 143.638537ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:19:56.261123Z","caller":"traceutil/trace.go:171","msg":"trace[300053731] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"147.131945ms","start":"2026-04-23T10:19:56.113968Z","end":"2026-04-23T10:19:56.2611Z","steps":["trace[300053731] 'process raft request' (duration: 146.311094ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:19:56.261155Z","caller":"traceutil/trace.go:171","msg":"trace[740146483] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"134.119004ms","start":"2026-04-23T10:19:56.127017Z","end":"2026-04-23T10:19:56.261136Z","steps":["trace[740146483] 'process raft request' (duration: 133.325354ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:19:56.261192Z","caller":"traceutil/trace.go:171","msg":"trace[206548225] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"149.986647ms","start":"2026-04-23T10:19:56.111177Z","end":"2026-04-23T10:19:56.261163Z","steps":["trace[206548225] 'process raft request' (duration: 148.99153ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:19:56.261319Z","caller":"traceutil/trace.go:171","msg":"trace[1673427463] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"122.300307ms","start":"2026-04-23T10:19:56.139011Z","end":"2026-04-23T10:19:56.261311Z","steps":["trace[1673427463] 'process raft request' (duration: 121.435735ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:19:56.2614Z","caller":"traceutil/trace.go:171","msg":"trace[2041328729] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"128.383597ms","start":"2026-04-23T10:19:56.132998Z","end":"2026-04-23T10:19:56.261382Z","steps":["trace[2041328729] 'process raft request' (duration: 127.370089ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:19:56.261459Z","caller":"traceutil/trace.go:171","msg":"trace[163243132] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"118.795061ms","start":"2026-04-23T10:19:56.142658Z","end":"2026-04-23T10:19:56.261453Z","steps":["trace[163243132] 'process raft request' (duration: 117.914149ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:19:56.26147Z","caller":"traceutil/trace.go:171","msg":"trace[1855317697] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"128.393447ms","start":"2026-04-23T10:19:56.133056Z","end":"2026-04-23T10:19:56.26145Z","steps":["trace[1855317697] 'process raft request' (duration: 127.352139ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:19:56.261556Z","caller":"traceutil/trace.go:171","msg":"trace[691629411] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"122.436493ms","start":"2026-04-23T10:19:56.139111Z","end":"2026-04-23T10:19:56.261548Z","steps":["trace[691629411] 'process raft request' (duration: 121.429866ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:19:56.261569Z","caller":"traceutil/trace.go:171","msg":"trace[1015893765] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"107.102308ms","start":"2026-04-23T10:19:56.15446Z","end":"2026-04-23T10:19:56.261563Z","steps":["trace[1015893765] 'process raft request' (duration: 106.145544ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:19:56.261723Z","caller":"traceutil/trace.go:171","msg":"trace[102664454] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"134.743536ms","start":"2026-04-23T10:19:56.126969Z","end":"2026-04-23T10:19:56.261713Z","steps":["trace[102664454] 'process raft request' (duration: 133.338985ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:19:56.981356Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3986422041727690608,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-23T10:19:57.486334Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3986422041727690608,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-23T10:19:57.540956Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.271671483s","expected-duration":"1s"} {"level":"info","ts":"2026-04-23T10:19:57.560576Z","caller":"traceutil/trace.go:171","msg":"trace[1551333999] transaction","detail":"{read_only:false; number_of_response:0; response_revision:534; }","duration":"1.291325695s","start":"2026-04-23T10:19:56.26922Z","end":"2026-04-23T10:19:57.560546Z","steps":["trace[1551333999] 'process raft request' (duration: 1.272003785s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:19:57.560745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:19:56.269205Z","time spent":"1.29145915s","remote":"127.0.0.1:57088","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-23T10:19:57.56609Z","caller":"traceutil/trace.go:171","msg":"trace[427607461] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"1.292485936s","start":"2026-04-23T10:19:56.273561Z","end":"2026-04-23T10:19:57.566047Z","steps":["trace[427607461] 'process raft request' (duration: 1.291603004s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:19:57.566322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:19:56.273544Z","time spent":"1.292659532s","remote":"127.0.0.1:56624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T10:19:57.566969Z","caller":"traceutil/trace.go:171","msg":"trace[707474944] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"1.292741425s","start":"2026-04-23T10:19:56.274057Z","end":"2026-04-23T10:19:57.566799Z","steps":["trace[707474944] 'process raft request' (duration: 1.291616804s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:19:57.56731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:19:56.274051Z","time spent":"1.293134638s","remote":"127.0.0.1:57088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-23T10:19:57.567967Z","caller":"traceutil/trace.go:171","msg":"trace[1914269572] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"1.287806646s","start":"2026-04-23T10:19:56.280131Z","end":"2026-04-23T10:19:57.567938Z","steps":["trace[1914269572] 'process raft request' (duration: 1.285589376s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:19:57.568332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:19:56.280115Z","time spent":"1.288151198s","remote":"127.0.0.1:56624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9125,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T10:19:57.568342Z","caller":"traceutil/trace.go:171","msg":"trace[1048147636] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"1.288088365s","start":"2026-04-23T10:19:56.280223Z","end":"2026-04-23T10:19:57.568311Z","steps":["trace[1048147636] 'process raft request' (duration: 1.285547894s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:19:57.568805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:19:56.280217Z","time spent":"1.288488589s","remote":"127.0.0.1:56624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T10:19:57.568398Z","caller":"traceutil/trace.go:171","msg":"trace[1739111590] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"1.278865632s","start":"2026-04-23T10:19:56.289517Z","end":"2026-04-23T10:19:57.568383Z","steps":["trace[1739111590] 'process raft request' (duration: 1.277061188s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:19:57.571096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:19:56.289499Z","time spent":"1.279397442s","remote":"127.0.0.1:56624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T10:19:57.571379Z","caller":"traceutil/trace.go:171","msg":"trace[173980175] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"1.270892024s","start":"2026-04-23T10:19:56.297884Z","end":"2026-04-23T10:19:57.568776Z","steps":["trace[173980175] 'process raft request' (duration: 1.270422947s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:19:57.571522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:19:56.297871Z","time spent":"1.273580589s","remote":"127.0.0.1:56624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T10:19:57.571772Z","caller":"traceutil/trace.go:171","msg":"trace[2006634700] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"1.223772551s","start":"2026-04-23T10:19:56.347986Z","end":"2026-04-23T10:19:57.571759Z","steps":["trace[2006634700] 'process raft request' (duration: 1.223687648s)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:19:57.571802Z","caller":"traceutil/trace.go:171","msg":"trace[734716335] linearizableReadLoop","detail":"{readStateIndex:560; appliedIndex:551; }","duration":"1.090651584s","start":"2026-04-23T10:19:56.481109Z","end":"2026-04-23T10:19:57.57176Z","steps":["trace[734716335] 'read index received' (duration: 1.060210126s)","trace[734716335] 'applied index is now lower than readState.Index' (duration: 30.440618ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T10:19:57.571831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:19:56.347969Z","time spent":"1.223837444s","remote":"127.0.0.1:56624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-23T10:19:57.571936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.090830591s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.25\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-23T10:19:57.571979Z","caller":"traceutil/trace.go:171","msg":"trace[521765707] range","detail":"{range_begin:/registry/masterleases/199.204.45.25; range_end:; response_count:1; response_revision:542; }","duration":"1.090913614s","start":"2026-04-23T10:19:56.481055Z","end":"2026-04-23T10:19:57.571968Z","steps":["trace[521765707] 'agreement among raft nodes before linearized reading' (duration: 1.090826621s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:19:57.572011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:19:56.481033Z","time spent":"1.090970686s","remote":"127.0.0.1:56604","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.25\" "} {"level":"warn","ts":"2026-04-23T10:19:57.571947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.708936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T10:19:57.572193Z","caller":"traceutil/trace.go:171","msg":"trace[206288868] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:542; }","duration":"239.002685ms","start":"2026-04-23T10:19:57.333179Z","end":"2026-04-23T10:19:57.572182Z","steps":["trace[206288868] 'agreement among raft nodes before linearized reading' (duration: 238.743156ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:19:57.571791Z","caller":"traceutil/trace.go:171","msg":"trace[1498237330] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"1.26385271s","start":"2026-04-23T10:19:56.307891Z","end":"2026-04-23T10:19:57.571744Z","steps":["trace[1498237330] 'process raft request' (duration: 1.263487596s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:19:57.576642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:19:56.307884Z","time spent":"1.2686429s","remote":"127.0.0.1:56624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58844,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T10:20:04.782039Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3986422041727690857,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-23T10:20:05.243853Z","caller":"traceutil/trace.go:171","msg":"trace[1805327529] linearizableReadLoop","detail":"{readStateIndex:649; appliedIndex:648; }","duration":"961.877755ms","start":"2026-04-23T10:20:04.281954Z","end":"2026-04-23T10:20:05.243831Z","steps":["trace[1805327529] 'read index received' (duration: 935.08532ms)","trace[1805327529] 'applied index is now lower than readState.Index' (duration: 26.791715ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T10:20:05.243955Z","caller":"traceutil/trace.go:171","msg":"trace[159118438] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"1.02585192s","start":"2026-04-23T10:20:04.218095Z","end":"2026-04-23T10:20:05.243947Z","steps":["trace[159118438] 'process raft request' (duration: 999.22134ms)","trace[159118438] 'compare' (duration: 26.175215ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T10:20:05.244034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:20:04.218062Z","time spent":"1.025911392s","remote":"127.0.0.1:56670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T10:20:05.244125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"908.881486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T10:20:05.244234Z","caller":"traceutil/trace.go:171","msg":"trace[810580383] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:629; }","duration":"909.058973ms","start":"2026-04-23T10:20:04.335152Z","end":"2026-04-23T10:20:05.244211Z","steps":["trace[810580383] 'agreement among raft nodes before linearized reading' (duration: 908.852536ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:20:05.24431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:20:04.33513Z","time spent":"909.169285ms","remote":"127.0.0.1:56566","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-04-23T10:20:05.244342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"962.397152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-2mzxl\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-04-23T10:20:05.244371Z","caller":"traceutil/trace.go:171","msg":"trace[390836295] range","detail":"{range_begin:/registry/pods/kube-system/cilium-2mzxl; range_end:; response_count:1; response_revision:629; }","duration":"962.481415ms","start":"2026-04-23T10:20:04.281883Z","end":"2026-04-23T10:20:05.244364Z","steps":["trace[390836295] 'agreement among raft nodes before linearized reading' (duration: 962.383821ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:20:05.244457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:20:04.281857Z","time spent":"962.595188ms","remote":"127.0.0.1:56744","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-2mzxl\" "} {"level":"warn","ts":"2026-04-23T10:20:05.836131Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3986422041727690861,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-23T10:20:06.336423Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3986422041727690861,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-23T10:20:06.378285Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.115559856s","expected-duration":"1s"} {"level":"info","ts":"2026-04-23T10:20:06.378792Z","caller":"traceutil/trace.go:171","msg":"trace[184214442] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"1.116145945s","start":"2026-04-23T10:20:05.262604Z","end":"2026-04-23T10:20:06.37875Z","steps":["trace[184214442] 'process raft request' (duration: 1.115908778s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:20:06.379023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:20:05.262587Z","time spent":"1.11626614s","remote":"127.0.0.1:56744","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T10:20:06.411452Z","caller":"traceutil/trace.go:171","msg":"trace[1791776776] linearizableReadLoop","detail":"{readStateIndex:652; appliedIndex:649; }","duration":"1.076095192s","start":"2026-04-23T10:20:05.335333Z","end":"2026-04-23T10:20:06.411428Z","steps":["trace[1791776776] 'read index received' (duration: 1.043345079s)","trace[1791776776] 'applied index is now lower than readState.Index' (duration: 32.749153ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T10:20:06.411565Z","caller":"traceutil/trace.go:171","msg":"trace[1619532141] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"1.106536608s","start":"2026-04-23T10:20:05.305019Z","end":"2026-04-23T10:20:06.411555Z","steps":["trace[1619532141] 'process raft request' (duration: 1.106210057s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:20:06.411663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:20:05.304994Z","time spent":"1.10659932s","remote":"127.0.0.1:56800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-23T10:20:06.411853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.076486164s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-23T10:20:06.41233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"567.667916ms","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-04-23T10:20:06.41237Z","caller":"traceutil/trace.go:171","msg":"trace[1593316019] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:632; }","duration":"1.077047052s","start":"2026-04-23T10:20:05.335296Z","end":"2026-04-23T10:20:06.412343Z","steps":["trace[1593316019] 'agreement among raft nodes before linearized reading' (duration: 1.07637074s)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:20:06.412509Z","caller":"traceutil/trace.go:171","msg":"trace[2016637794] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:632; }","duration":"568.034938ms","start":"2026-04-23T10:20:05.844348Z","end":"2026-04-23T10:20:06.412383Z","steps":["trace[2016637794] 'agreement among raft nodes before linearized reading' (duration: 567.595603ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:20:06.412534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:20:05.33528Z","time spent":"1.077237879s","remote":"127.0.0.1:56566","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-04-23T10:20:06.412592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:20:05.844332Z","time spent":"568.230043ms","remote":"127.0.0.1:56820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-23T10:20:06.41209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"791.123782ms","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-04-23T10:20:06.41285Z","caller":"traceutil/trace.go:171","msg":"trace[546417919] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:632; }","duration":"791.905907ms","start":"2026-04-23T10:20:05.620926Z","end":"2026-04-23T10:20:06.412832Z","steps":["trace[546417919] 'agreement among raft nodes before linearized reading' (duration: 791.113801ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:20:06.412002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"802.561699ms","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-04-23T10:20:06.41296Z","caller":"traceutil/trace.go:171","msg":"trace[498869950] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:632; }","duration":"803.555703ms","start":"2026-04-23T10:20:05.609384Z","end":"2026-04-23T10:20:06.41294Z","steps":["trace[498869950] 'agreement among raft nodes before linearized reading' (duration: 802.552629ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:20:06.412147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"795.27924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-23T10:20:06.412895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:20:05.62091Z","time spent":"791.972111ms","remote":"127.0.0.1:56820","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":"info","ts":"2026-04-23T10:20:06.413389Z","caller":"traceutil/trace.go:171","msg":"trace[1036319193] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:632; }","duration":"796.526851ms","start":"2026-04-23T10:20:05.616836Z","end":"2026-04-23T10:20:06.413362Z","steps":["trace[1036319193] 'agreement among raft nodes before linearized reading' (duration: 795.28086ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:20:06.41348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:20:05.616823Z","time spent":"796.637664ms","remote":"127.0.0.1:56820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-23T10:20:06.412069Z","caller":"traceutil/trace.go:171","msg":"trace[692369226] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"348.017134ms","start":"2026-04-23T10:20:06.064017Z","end":"2026-04-23T10:20:06.412034Z","steps":["trace[692369226] 'process raft request' (duration: 347.352933ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:20:06.413871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:20:06.063998Z","time spent":"349.812843ms","remote":"127.0.0.1:56820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T10:20:06.413349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:20:05.609363Z","time spent":"803.968356ms","remote":"127.0.0.1:56820","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-04-23T10:20:08.424362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000676855s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-23T10:20:08.424468Z","caller":"traceutil/trace.go:171","msg":"trace[2037338793] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000800558s","start":"2026-04-23T10:20:06.423631Z","end":"2026-04-23T10:20:08.424432Z","steps":["trace[2037338793] 'agreement among raft nodes before linearized reading' (duration: 2.000686854s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:20:08.424537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:20:06.42362Z","time spent":"2.000903252s","remote":"127.0.0.1:56566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/23 10:20:08 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-23T10:20:10.144155Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.209386698s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-23T10:20:10.424511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.99967437s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-23T10:20:10.424673Z","caller":"traceutil/trace.go:171","msg":"trace[397373011] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.999889678s","start":"2026-04-23T10:20:08.424759Z","end":"2026-04-23T10:20:10.424649Z","steps":["trace[397373011] 'agreement among raft nodes before linearized reading' (duration: 1.999710252s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:20:10.424752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:20:08.424731Z","time spent":"2.000007592s","remote":"127.0.0.1:56576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/23 10:20:10 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-23T10:20:10.46137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.174717963s","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-04-23T10:20:10.461473Z","caller":"traceutil/trace.go:171","msg":"trace[1846320569] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:633; }","duration":"2.174831527s","start":"2026-04-23T10:20:08.286626Z","end":"2026-04-23T10:20:10.461458Z","steps":["trace[1846320569] 'range keys from in-memory index tree' (duration: 2.174705063s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:20:10.461707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:20:07.361453Z","time spent":"3.100250441s","remote":"127.0.0.1:51352","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-23T10:20:10.462409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.983066303s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-23T10:20:10.4633Z","caller":"traceutil/trace.go:171","msg":"trace[1334381708] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"4.04443152s","start":"2026-04-23T10:20:06.418849Z","end":"2026-04-23T10:20:10.463281Z","steps":["trace[1334381708] 'process raft request' (duration: 60.216781ms)","trace[1334381708] 'compare' (duration: 3.981660058s)"],"step_count":2} {"level":"warn","ts":"2026-04-23T10:20:10.463395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:20:06.418841Z","time spent":"4.044502863s","remote":"127.0.0.1:56820","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-04-23T10:20:10.463408Z","caller":"traceutil/trace.go:171","msg":"trace[1387635160] linearizableReadLoop","detail":"{readStateIndex:656; appliedIndex:652; }","duration":"4.04351556s","start":"2026-04-23T10:20:06.419868Z","end":"2026-04-23T10:20:10.463384Z","steps":["trace[1387635160] 'read index received' (duration: 41.760587ms)","trace[1387635160] 'applied index is now lower than readState.Index' (duration: 4.001752233s)"],"step_count":2} {"level":"info","ts":"2026-04-23T10:20:10.463492Z","caller":"traceutil/trace.go:171","msg":"trace[658310677] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"1.528840731s","start":"2026-04-23T10:20:08.934639Z","end":"2026-04-23T10:20:10.46348Z","steps":["trace[658310677] 'process raft request' (duration: 1.528214631s)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:20:10.46352Z","caller":"traceutil/trace.go:171","msg":"trace[1574036448] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"4.043918503s","start":"2026-04-23T10:20:06.419592Z","end":"2026-04-23T10:20:10.463511Z","steps":["trace[1574036448] 'process raft request' (duration: 4.042889091s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:20:10.463557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:20:08.934616Z","time spent":"1.528909903s","remote":"127.0.0.1:56820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T10:20:10.463606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:20:06.419534Z","time spent":"4.044007406s","remote":"127.0.0.1:56820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T10:20:10.463788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.043905814s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-04-23T10:20:10.463854Z","caller":"traceutil/trace.go:171","msg":"trace[132764881] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:638; }","duration":"4.044070979s","start":"2026-04-23T10:20:06.419768Z","end":"2026-04-23T10:20:10.463839Z","steps":["trace[132764881] 'agreement among raft nodes before linearized reading' (duration: 4.043918043s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:20:10.463891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:20:06.419705Z","time spent":"4.044180693s","remote":"127.0.0.1:56776","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":216,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"warn","ts":"2026-04-23T10:20:10.463996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.997400724s","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-04-23T10:20:10.464056Z","caller":"traceutil/trace.go:171","msg":"trace[1975145341] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:638; }","duration":"1.997499087s","start":"2026-04-23T10:20:08.466541Z","end":"2026-04-23T10:20:10.46404Z","steps":["trace[1975145341] 'agreement among raft nodes before linearized reading' (duration: 1.99724948s)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:20:10.464087Z","caller":"traceutil/trace.go:171","msg":"trace[1734762117] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"4.044364487s","start":"2026-04-23T10:20:06.41971Z","end":"2026-04-23T10:20:10.464075Z","steps":["trace[1734762117] 'process raft request' (duration: 4.043102077s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:20:10.464096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:20:08.46651Z","time spent":"1.99757904s","remote":"127.0.0.1:56820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-23T10:20:10.464172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:20:06.419701Z","time spent":"4.04441533s","remote":"127.0.0.1:56820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T10:20:10.46418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.98245603s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.25\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-23T10:20:10.464325Z","caller":"traceutil/trace.go:171","msg":"trace[1449027666] range","detail":"{range_begin:/registry/masterleases/199.204.45.25; range_end:; response_count:1; response_revision:638; }","duration":"3.982637897s","start":"2026-04-23T10:20:06.481676Z","end":"2026-04-23T10:20:10.464314Z","steps":["trace[1449027666] 'agreement among raft nodes before linearized reading' (duration: 3.982025117s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:20:10.464368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:20:06.481655Z","time spent":"3.982703218s","remote":"127.0.0.1:56604","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.25\" "} {"level":"info","ts":"2026-04-23T10:20:12.757561Z","caller":"traceutil/trace.go:171","msg":"trace[796286485] linearizableReadLoop","detail":"{readStateIndex:691; appliedIndex:690; }","duration":"289.351677ms","start":"2026-04-23T10:20:12.46818Z","end":"2026-04-23T10:20:12.757531Z","steps":["trace[796286485] 'read index received' (duration: 289.272064ms)","trace[796286485] 'applied index is now lower than readState.Index' (duration: 78.433µs)"],"step_count":2} {"level":"info","ts":"2026-04-23T10:20:12.757645Z","caller":"traceutil/trace.go:171","msg":"trace[185959715] transaction","detail":"{read_only:false; response_revision:670; number_of_response:1; }","duration":"349.162268ms","start":"2026-04-23T10:20:12.408444Z","end":"2026-04-23T10:20:12.757606Z","steps":["trace[185959715] 'process raft request' (duration: 348.852189ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:20:12.757757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.561783ms","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-04-23T10:20:12.757919Z","caller":"traceutil/trace.go:171","msg":"trace[1248238496] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:670; }","duration":"289.759589ms","start":"2026-04-23T10:20:12.46814Z","end":"2026-04-23T10:20:12.757899Z","steps":["trace[1248238496] 'agreement among raft nodes before linearized reading' (duration: 289.498081ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:20:12.757837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:20:12.408434Z","time spent":"349.300212ms","remote":"127.0.0.1:56624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4059,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T10:20:12.764345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.827828ms","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-04-23T10:20:12.764408Z","caller":"traceutil/trace.go:171","msg":"trace[2062237119] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:671; }","duration":"295.943832ms","start":"2026-04-23T10:20:12.468449Z","end":"2026-04-23T10:20:12.764393Z","steps":["trace[2062237119] 'agreement among raft nodes before linearized reading' (duration: 295.768766ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:20:12.764611Z","caller":"traceutil/trace.go:171","msg":"trace[1881264107] transaction","detail":"{read_only:false; response_revision:671; number_of_response:1; }","duration":"189.063923ms","start":"2026-04-23T10:20:12.575536Z","end":"2026-04-23T10:20:12.7646Z","steps":["trace[1881264107] 'process raft request' (duration: 188.603409ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:20:12.764743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.928182ms","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-04-23T10:20:12.764768Z","caller":"traceutil/trace.go:171","msg":"trace[1802286473] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:671; }","duration":"275.955803ms","start":"2026-04-23T10:20:12.488806Z","end":"2026-04-23T10:20:12.764762Z","steps":["trace[1802286473] 'agreement among raft nodes before linearized reading' (duration: 275.882711ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:20:12.764875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.955572ms","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-04-23T10:20:12.764901Z","caller":"traceutil/trace.go:171","msg":"trace[501825572] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:671; }","duration":"295.999903ms","start":"2026-04-23T10:20:12.468894Z","end":"2026-04-23T10:20:12.764894Z","steps":["trace[501825572] 'agreement among raft nodes before linearized reading' (duration: 295.940191ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:20:26.992558Z","caller":"traceutil/trace.go:171","msg":"trace[1034968276] linearizableReadLoop","detail":"{readStateIndex:827; appliedIndex:826; }","duration":"134.992418ms","start":"2026-04-23T10:20:26.857537Z","end":"2026-04-23T10:20:26.992529Z","steps":["trace[1034968276] 'read index received' (duration: 39.004757ms)","trace[1034968276] 'applied index is now lower than readState.Index' (duration: 95.986611ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T10:20:26.992586Z","caller":"traceutil/trace.go:171","msg":"trace[55921476] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"141.783634ms","start":"2026-04-23T10:20:26.85076Z","end":"2026-04-23T10:20:26.992544Z","steps":["trace[55921476] 'process raft request' (duration: 45.757283ms)","trace[55921476] 'compare' (duration: 95.879607ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T10:20:26.993149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.590973ms","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-04-23T10:20:26.993246Z","caller":"traceutil/trace.go:171","msg":"trace[1719662218] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:800; }","duration":"135.730667ms","start":"2026-04-23T10:20:26.857498Z","end":"2026-04-23T10:20:26.993228Z","steps":["trace[1719662218] 'agreement among raft nodes before linearized reading' (duration: 135.180523ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:20:27.693987Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3986422041727691202,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-23T10:20:28.194577Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3986422041727691202,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-23T10:20:28.695642Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3986422041727691202,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-23T10:20:29.195928Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3986422041727691202,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-23T10:20:29.39778Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.400246863s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-23T10:20:29.39838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.111795142s","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-04-23T10:20:29.398515Z","caller":"traceutil/trace.go:171","msg":"trace[1862301053] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:800; }","duration":"1.111948836s","start":"2026-04-23T10:20:28.286547Z","end":"2026-04-23T10:20:29.398496Z","steps":["trace[1862301053] 'range keys from in-memory index tree' (duration: 1.11177797s)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:20:29.399222Z","caller":"traceutil/trace.go:171","msg":"trace[1511344792] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"2.401769575s","start":"2026-04-23T10:20:26.997443Z","end":"2026-04-23T10:20:29.399212Z","steps":["trace[1511344792] 'process raft request' (duration: 2.40047441s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:20:29.399325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:20:26.997424Z","time spent":"2.401825577s","remote":"127.0.0.1:56820","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-04-23T10:20:29.449878Z","caller":"traceutil/trace.go:171","msg":"trace[476344737] linearizableReadLoop","detail":"{readStateIndex:832; appliedIndex:827; }","duration":"2.256487985s","start":"2026-04-23T10:20:27.193365Z","end":"2026-04-23T10:20:29.449853Z","steps":["trace[476344737] 'read index received' (duration: 2.20576562s)","trace[476344737] 'applied index is now lower than readState.Index' (duration: 50.721255ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T10:20:29.450006Z","caller":"traceutil/trace.go:171","msg":"trace[21320243] transaction","detail":"{read_only:false; response_revision:802; number_of_response:1; }","duration":"2.451893133s","start":"2026-04-23T10:20:26.997928Z","end":"2026-04-23T10:20:29.449822Z","steps":["trace[21320243] 'process raft request' (duration: 2.451676578s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:20:29.450655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:20:26.9979Z","time spent":"2.452664254s","remote":"127.0.0.1:56820","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-04-23T10:20:29.45007Z","caller":"traceutil/trace.go:171","msg":"trace[1033294472] transaction","detail":"{read_only:false; response_revision:803; number_of_response:1; }","duration":"2.451947335s","start":"2026-04-23T10:20:26.99811Z","end":"2026-04-23T10:20:29.450057Z","steps":["trace[1033294472] 'process raft request' (duration: 2.451632626s)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:20:29.450027Z","caller":"traceutil/trace.go:171","msg":"trace[490488795] transaction","detail":"{read_only:false; response_revision:805; number_of_response:1; }","duration":"2.025080467s","start":"2026-04-23T10:20:27.424887Z","end":"2026-04-23T10:20:29.449967Z","steps":["trace[490488795] 'process raft request' (duration: 2.024922313s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:20:29.450184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.256806943s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-23T10:20:29.451051Z","caller":"traceutil/trace.go:171","msg":"trace[1385387191] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:805; }","duration":"2.257723137s","start":"2026-04-23T10:20:27.193311Z","end":"2026-04-23T10:20:29.451034Z","steps":["trace[1385387191] 'agreement among raft nodes before linearized reading' (duration: 2.256818073s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:20:29.451109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:20:27.193287Z","time spent":"2.25780667s","remote":"127.0.0.1:56980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":30,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-04-23T10:20:29.451146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:20:27.424862Z","time spent":"2.026109265s","remote":"127.0.0.1:56800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T10:20:29.450165Z","caller":"traceutil/trace.go:171","msg":"trace[1152310714] transaction","detail":"{read_only:false; response_revision:804; number_of_response:1; }","duration":"2.451518013s","start":"2026-04-23T10:20:26.998403Z","end":"2026-04-23T10:20:29.449921Z","steps":["trace[1152310714] 'process raft request' (duration: 2.451376089s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:20:29.451089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:20:26.998066Z","time spent":"2.452847569s","remote":"127.0.0.1:56820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T10:20:29.451465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:20:26.998384Z","time spent":"2.452994312s","remote":"127.0.0.1:56820","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-04-23T10:20:29.469453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.134186869s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-23T10:20:29.469511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"771.30202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T10:20:29.46956Z","caller":"traceutil/trace.go:171","msg":"trace[124992412] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:806; }","duration":"1.134342283s","start":"2026-04-23T10:20:28.335197Z","end":"2026-04-23T10:20:29.46954Z","steps":["trace[124992412] 'agreement among raft nodes before linearized reading' (duration: 1.134175509s)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:20:29.469596Z","caller":"traceutil/trace.go:171","msg":"trace[1572050018] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:806; }","duration":"771.449644ms","start":"2026-04-23T10:20:28.698123Z","end":"2026-04-23T10:20:29.469573Z","steps":["trace[1572050018] 'agreement among raft nodes before linearized reading' (duration: 771.28388ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:20:29.46967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:20:28.698102Z","time spent":"771.557227ms","remote":"127.0.0.1:57054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-04-23T10:20:29.469605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:20:28.335175Z","time spent":"1.134420255s","remote":"127.0.0.1:56566","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-04-23T10:20:29.46978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"978.047661ms","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-04-23T10:20:29.46982Z","caller":"traceutil/trace.go:171","msg":"trace[374315336] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:806; }","duration":"978.128173ms","start":"2026-04-23T10:20:28.491682Z","end":"2026-04-23T10:20:29.469811Z","steps":["trace[374315336] 'agreement among raft nodes before linearized reading' (duration: 977.941638ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:20:29.469852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:20:28.491634Z","time spent":"978.212035ms","remote":"127.0.0.1:56820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-23T10:21:07.765836Z","caller":"traceutil/trace.go:171","msg":"trace[192188174] transaction","detail":"{read_only:false; response_revision:1058; number_of_response:1; }","duration":"168.178511ms","start":"2026-04-23T10:21:07.597642Z","end":"2026-04-23T10:21:07.765821Z","steps":["trace[192188174] 'process raft request' (duration: 168.007508ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:21:07.765815Z","caller":"traceutil/trace.go:171","msg":"trace[321083254] linearizableReadLoop","detail":"{readStateIndex:1094; appliedIndex:1093; }","duration":"103.570606ms","start":"2026-04-23T10:21:07.662221Z","end":"2026-04-23T10:21:07.765792Z","steps":["trace[321083254] 'read index received' (duration: 103.355811ms)","trace[321083254] 'applied index is now lower than readState.Index' (duration: 213.754µs)"],"step_count":2} {"level":"warn","ts":"2026-04-23T10:21:07.76603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.7339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-23T10:21:07.766215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.722018ms","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-04-23T10:21:07.766333Z","caller":"traceutil/trace.go:171","msg":"trace[1403439097] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1058; }","duration":"102.878021ms","start":"2026-04-23T10:21:07.663434Z","end":"2026-04-23T10:21:07.766312Z","steps":["trace[1403439097] 'agreement among raft nodes before linearized reading' (duration: 102.592705ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:21:07.7662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.698558ms","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-04-23T10:21:07.766442Z","caller":"traceutil/trace.go:171","msg":"trace[1950905839] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1058; }","duration":"102.942532ms","start":"2026-04-23T10:21:07.663484Z","end":"2026-04-23T10:21:07.766427Z","steps":["trace[1950905839] 'agreement among raft nodes before linearized reading' (duration: 102.672057ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:21:07.766803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.085466ms","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-04-23T10:21:07.766953Z","caller":"traceutil/trace.go:171","msg":"trace[1563805576] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1058; }","duration":"103.276029ms","start":"2026-04-23T10:21:07.663651Z","end":"2026-04-23T10:21:07.766927Z","steps":["trace[1563805576] 'agreement among raft nodes before linearized reading' (duration: 102.432302ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:21:07.767584Z","caller":"traceutil/trace.go:171","msg":"trace[1082207435] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1058; }","duration":"104.038316ms","start":"2026-04-23T10:21:07.662189Z","end":"2026-04-23T10:21:07.766228Z","steps":["trace[1082207435] 'agreement among raft nodes before linearized reading' (duration: 103.676648ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:21:38.07672Z","caller":"traceutil/trace.go:171","msg":"trace[1351984132] linearizableReadLoop","detail":"{readStateIndex:1199; appliedIndex:1198; }","duration":"141.129919ms","start":"2026-04-23T10:21:37.935573Z","end":"2026-04-23T10:21:38.076703Z","steps":["trace[1351984132] 'read index received' (duration: 140.947925ms)","trace[1351984132] 'applied index is now lower than readState.Index' (duration: 180.814µs)"],"step_count":2} {"level":"info","ts":"2026-04-23T10:21:38.076855Z","caller":"traceutil/trace.go:171","msg":"trace[1350228294] transaction","detail":"{read_only:false; response_revision:1157; number_of_response:1; }","duration":"143.275577ms","start":"2026-04-23T10:21:37.933547Z","end":"2026-04-23T10:21:38.076823Z","steps":["trace[1350228294] 'process raft request' (duration: 143.019652ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:21:38.076997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.421194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-23T10:21:38.077006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.844701ms","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-04-23T10:21:38.077043Z","caller":"traceutil/trace.go:171","msg":"trace[307771636] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1157; }","duration":"137.895032ms","start":"2026-04-23T10:21:37.939138Z","end":"2026-04-23T10:21:38.077033Z","steps":["trace[307771636] 'agreement among raft nodes before linearized reading' (duration: 137.810101ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:21:38.07703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.975297ms","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-04-23T10:21:38.077097Z","caller":"traceutil/trace.go:171","msg":"trace[852089426] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1157; }","duration":"141.073178ms","start":"2026-04-23T10:21:37.936009Z","end":"2026-04-23T10:21:38.077082Z","steps":["trace[852089426] 'agreement among raft nodes before linearized reading' (duration: 140.854394ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:21:38.077169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.918365ms","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-04-23T10:21:38.077192Z","caller":"traceutil/trace.go:171","msg":"trace[1709112485] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1157; }","duration":"140.940856ms","start":"2026-04-23T10:21:37.936245Z","end":"2026-04-23T10:21:38.077186Z","steps":["trace[1709112485] 'agreement among raft nodes before linearized reading' (duration: 140.883595ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:21:38.077038Z","caller":"traceutil/trace.go:171","msg":"trace[347779634] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1157; }","duration":"141.516866ms","start":"2026-04-23T10:21:37.935509Z","end":"2026-04-23T10:21:38.077026Z","steps":["trace[347779634] 'agreement among raft nodes before linearized reading' (duration: 141.308132ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:22:18.419479Z","caller":"traceutil/trace.go:171","msg":"trace[1522567484] transaction","detail":"{read_only:false; response_revision:1321; number_of_response:1; }","duration":"125.388404ms","start":"2026-04-23T10:22:18.294058Z","end":"2026-04-23T10:22:18.419446Z","steps":["trace[1522567484] 'process raft request' (duration: 125.195461ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:22:18.480306Z","caller":"traceutil/trace.go:171","msg":"trace[2137469071] linearizableReadLoop","detail":"{readStateIndex:1375; appliedIndex:1371; }","duration":"178.29355ms","start":"2026-04-23T10:22:18.301991Z","end":"2026-04-23T10:22:18.480284Z","steps":["trace[2137469071] 'read index received' (duration: 117.250679ms)","trace[2137469071] 'applied index is now lower than readState.Index' (duration: 61.041871ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T10:22:18.480352Z","caller":"traceutil/trace.go:171","msg":"trace[507455856] transaction","detail":"{read_only:false; response_revision:1323; number_of_response:1; }","duration":"183.683693ms","start":"2026-04-23T10:22:18.296641Z","end":"2026-04-23T10:22:18.480324Z","steps":["trace[507455856] 'process raft request' (duration: 183.555361ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:22:18.480486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.473193ms","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-04-23T10:22:18.480524Z","caller":"traceutil/trace.go:171","msg":"trace[959434251] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1324; }","duration":"178.542314ms","start":"2026-04-23T10:22:18.301972Z","end":"2026-04-23T10:22:18.480515Z","steps":["trace[959434251] 'agreement among raft nodes before linearized reading' (duration: 178.403202ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:22:18.480526Z","caller":"traceutil/trace.go:171","msg":"trace[1009732649] transaction","detail":"{read_only:false; response_revision:1324; number_of_response:1; }","duration":"183.533831ms","start":"2026-04-23T10:22:18.296974Z","end":"2026-04-23T10:22:18.480508Z","steps":["trace[1009732649] 'process raft request' (duration: 183.273887ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:22:18.480613Z","caller":"traceutil/trace.go:171","msg":"trace[1393193343] transaction","detail":"{read_only:false; response_revision:1322; number_of_response:1; }","duration":"184.034848ms","start":"2026-04-23T10:22:18.296552Z","end":"2026-04-23T10:22:18.480587Z","steps":["trace[1393193343] 'process raft request' (duration: 182.579786ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:22:39.934965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.789977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:pvc-protection-controller\" ","response":"range_response_count:1 size:775"} {"level":"info","ts":"2026-04-23T10:22:39.935061Z","caller":"traceutil/trace.go:171","msg":"trace[1459149903] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:pvc-protection-controller; range_end:; response_count:1; response_revision:1404; }","duration":"164.915039ms","start":"2026-04-23T10:22:39.770127Z","end":"2026-04-23T10:22:39.935042Z","steps":["trace[1459149903] 'range keys from in-memory index tree' (duration: 164.720397ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:22:39.935068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.325879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:kube-controller-manager\" ","response":"range_response_count:1 size:1041"} {"level":"info","ts":"2026-04-23T10:22:39.935171Z","caller":"traceutil/trace.go:171","msg":"trace[876862153] range","detail":"{range_begin:/registry/clusterroles/system:kube-controller-manager; range_end:; response_count:1; response_revision:1404; }","duration":"168.488312ms","start":"2026-04-23T10:22:39.766657Z","end":"2026-04-23T10:22:39.935145Z","steps":["trace[876862153] 'range keys from in-memory index tree' (duration: 168.197977ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:22:40.780758Z","caller":"traceutil/trace.go:171","msg":"trace[1192629497] linearizableReadLoop","detail":"{readStateIndex:1462; appliedIndex:1460; }","duration":"193.547526ms","start":"2026-04-23T10:22:40.58718Z","end":"2026-04-23T10:22:40.780727Z","steps":["trace[1192629497] 'read index received' (duration: 46.432882ms)","trace[1192629497] 'applied index is now lower than readState.Index' (duration: 147.113073ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T10:22:40.780937Z","caller":"traceutil/trace.go:171","msg":"trace[296113207] transaction","detail":"{read_only:false; response_revision:1407; number_of_response:1; }","duration":"195.735008ms","start":"2026-04-23T10:22:40.585184Z","end":"2026-04-23T10:22:40.780919Z","steps":["trace[296113207] 'process raft request' (duration: 187.963304ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:22:40.781259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.317419ms","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":"warn","ts":"2026-04-23T10:22:40.781277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.127068ms","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-04-23T10:22:40.781321Z","caller":"traceutil/trace.go:171","msg":"trace[2000691608] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1407; }","duration":"186.41586ms","start":"2026-04-23T10:22:40.594893Z","end":"2026-04-23T10:22:40.781308Z","steps":["trace[2000691608] 'agreement among raft nodes before linearized reading' (duration: 186.239927ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:22:40.78133Z","caller":"traceutil/trace.go:171","msg":"trace[1229138098] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1407; }","duration":"180.222429ms","start":"2026-04-23T10:22:40.601092Z","end":"2026-04-23T10:22:40.781314Z","steps":["trace[1229138098] 'agreement among raft nodes before linearized reading' (duration: 180.083787ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:22:40.781481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.289676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:monitoring\" ","response":"range_response_count:1 size:634"} {"level":"info","ts":"2026-04-23T10:22:40.78156Z","caller":"traceutil/trace.go:171","msg":"trace[675931399] range","detail":"{range_begin:/registry/clusterroles/system:monitoring; range_end:; response_count:1; response_revision:1407; }","duration":"194.379177ms","start":"2026-04-23T10:22:40.587163Z","end":"2026-04-23T10:22:40.781542Z","steps":["trace[675931399] 'agreement among raft nodes before linearized reading' (duration: 194.170144ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:22:40.781532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.712063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:root-ca-cert-publisher\" ","response":"range_response_count:1 size:763"} {"level":"info","ts":"2026-04-23T10:22:40.782564Z","caller":"traceutil/trace.go:171","msg":"trace[1406974348] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:root-ca-cert-publisher; range_end:; response_count:1; response_revision:1407; }","duration":"127.79435ms","start":"2026-04-23T10:22:40.654753Z","end":"2026-04-23T10:22:40.782548Z","steps":["trace[1406974348] 'agreement among raft nodes before linearized reading' (duration: 126.394439ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:22:42.81775Z","caller":"traceutil/trace.go:171","msg":"trace[1436440485] transaction","detail":"{read_only:false; response_revision:1412; number_of_response:1; }","duration":"165.27128ms","start":"2026-04-23T10:22:42.652455Z","end":"2026-04-23T10:22:42.817726Z","steps":["trace[1436440485] 'process raft request' (duration: 165.056587ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:22:43.133169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.633015ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-23T10:22:43.133518Z","caller":"traceutil/trace.go:171","msg":"trace[1000708500] linearizableReadLoop","detail":"{readStateIndex:1472; appliedIndex:1471; }","duration":"136.166401ms","start":"2026-04-23T10:22:42.997278Z","end":"2026-04-23T10:22:43.133444Z","steps":["trace[1000708500] 'read index received' (duration: 28.083711ms)","trace[1000708500] 'applied index is now lower than readState.Index' (duration: 108.07949ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T10:22:43.133798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.621764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:volume-scheduler\" ","response":"range_response_count:1 size:715"} {"level":"info","ts":"2026-04-23T10:22:43.133926Z","caller":"traceutil/trace.go:171","msg":"trace[914088305] range","detail":"{range_begin:/registry/clusterrolebindings/system:volume-scheduler; range_end:; response_count:1; response_revision:1417; }","duration":"133.770536ms","start":"2026-04-23T10:22:43.000132Z","end":"2026-04-23T10:22:43.133902Z","steps":["trace[914088305] 'agreement among raft nodes before linearized reading' (duration: 133.601014ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:22:43.133998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.71324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:service-account-issuer-discovery\" ","response":"range_response_count:1 size:765"} {"level":"info","ts":"2026-04-23T10:22:43.134086Z","caller":"traceutil/trace.go:171","msg":"trace[1054250310] range","detail":"{range_begin:/registry/clusterrolebindings/system:service-account-issuer-discovery; range_end:; response_count:1; response_revision:1417; }","duration":"136.845711ms","start":"2026-04-23T10:22:42.997219Z","end":"2026-04-23T10:22:43.134065Z","steps":["trace[1054250310] 'agreement among raft nodes before linearized reading' (duration: 136.581177ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:22:43.133658Z","caller":"traceutil/trace.go:171","msg":"trace[1370917511] transaction","detail":"{read_only:false; response_revision:1416; number_of_response:1; }","duration":"158.186294ms","start":"2026-04-23T10:22:42.975452Z","end":"2026-04-23T10:22:43.133638Z","steps":["trace[1370917511] 'process raft request' (duration: 49.963421ms)","trace[1370917511] 'compare' (duration: 107.495673ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T10:22:44.973185Z","caller":"traceutil/trace.go:171","msg":"trace[1233060474] transaction","detail":"{read_only:false; response_revision:1421; number_of_response:1; }","duration":"112.543864ms","start":"2026-04-23T10:22:44.860603Z","end":"2026-04-23T10:22:44.973147Z","steps":["trace[1233060474] 'process raft request' (duration: 96.661782ms)","trace[1233060474] 'compare' (duration: 15.724678ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T10:22:47.12065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.014059ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-23T10:22:47.120759Z","caller":"traceutil/trace.go:171","msg":"trace[224877722] linearizableReadLoop","detail":"{readStateIndex:1484; appliedIndex:1483; }","duration":"148.251413ms","start":"2026-04-23T10:22:46.972491Z","end":"2026-04-23T10:22:47.120742Z","steps":["trace[224877722] 'read index received' (duration: 22.03075ms)","trace[224877722] 'applied index is now lower than readState.Index' (duration: 126.219563ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T10:22:47.12085Z","caller":"traceutil/trace.go:171","msg":"trace[1998899715] transaction","detail":"{read_only:false; response_revision:1427; number_of_response:1; }","duration":"153.292596ms","start":"2026-04-23T10:22:46.967544Z","end":"2026-04-23T10:22:47.120837Z","steps":["trace[1998899715] 'process raft request' (duration: 27.015073ms)","trace[1998899715] 'compare' (duration: 125.870197ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T10:22:47.121023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.656989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/kube-node-lease/\" range_end:\"/registry/services/endpoints/kube-node-lease0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T10:22:47.121095Z","caller":"traceutil/trace.go:171","msg":"trace[409447764] range","detail":"{range_begin:/registry/services/endpoints/kube-node-lease/; range_end:/registry/services/endpoints/kube-node-lease0; response_count:0; response_revision:1427; }","duration":"146.74923ms","start":"2026-04-23T10:22:46.974323Z","end":"2026-04-23T10:22:47.121072Z","steps":["trace[409447764] 'agreement among raft nodes before linearized reading' (duration: 146.639199ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:22:47.121208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.100954ms","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-04-23T10:22:47.121278Z","caller":"traceutil/trace.go:171","msg":"trace[2011101569] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1427; }","duration":"140.187835ms","start":"2026-04-23T10:22:46.981069Z","end":"2026-04-23T10:22:47.121257Z","steps":["trace[2011101569] 'agreement among raft nodes before linearized reading' (duration: 139.993562ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:22:47.121322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.815951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/envoy-gateway\" ","response":"range_response_count:1 size:4637"} {"level":"info","ts":"2026-04-23T10:22:47.121373Z","caller":"traceutil/trace.go:171","msg":"trace[1775353519] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/envoy-gateway; range_end:; response_count:1; response_revision:1427; }","duration":"148.885461ms","start":"2026-04-23T10:22:46.972473Z","end":"2026-04-23T10:22:47.121359Z","steps":["trace[1775353519] 'agreement among raft nodes before linearized reading' (duration: 148.720069ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:22:47.121371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.126946ms","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-04-23T10:22:47.12142Z","caller":"traceutil/trace.go:171","msg":"trace[428492741] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1427; }","duration":"145.188647ms","start":"2026-04-23T10:22:46.976218Z","end":"2026-04-23T10:22:47.121406Z","steps":["trace[428492741] 'agreement among raft nodes before linearized reading' (duration: 145.025965ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:22:47.121474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.560116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/envoy\" ","response":"range_response_count:1 size:4438"} {"level":"info","ts":"2026-04-23T10:22:47.121507Z","caller":"traceutil/trace.go:171","msg":"trace[753225999] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/envoy; range_end:; response_count:1; response_revision:1427; }","duration":"139.620446ms","start":"2026-04-23T10:22:46.981877Z","end":"2026-04-23T10:22:47.121497Z","steps":["trace[753225999] 'agreement among raft nodes before linearized reading' (duration: 139.504045ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:22:47.121575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.000944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-public/\" range_end:\"/registry/deployments/kube-public0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T10:22:47.121618Z","caller":"traceutil/trace.go:171","msg":"trace[256238252] range","detail":"{range_begin:/registry/deployments/kube-public/; range_end:/registry/deployments/kube-public0; response_count:0; response_revision:1427; }","duration":"145.050315ms","start":"2026-04-23T10:22:46.976549Z","end":"2026-04-23T10:22:47.121599Z","steps":["trace[256238252] 'agreement among raft nodes before linearized reading' (duration: 144.994044ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:22:47.292281Z","caller":"traceutil/trace.go:171","msg":"trace[1953800541] transaction","detail":"{read_only:false; response_revision:1428; number_of_response:1; }","duration":"166.805081ms","start":"2026-04-23T10:22:47.125452Z","end":"2026-04-23T10:22:47.292257Z","steps":["trace[1953800541] 'process raft request' (duration: 165.387891ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:22:47.472163Z","caller":"traceutil/trace.go:171","msg":"trace[1129969945] linearizableReadLoop","detail":"{readStateIndex:1487; appliedIndex:1484; }","duration":"262.506821ms","start":"2026-04-23T10:22:47.209637Z","end":"2026-04-23T10:22:47.472144Z","steps":["trace[1129969945] 'read index received' (duration: 81.230269ms)","trace[1129969945] 'applied index is now lower than readState.Index' (duration: 181.275712ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T10:22:47.472222Z","caller":"traceutil/trace.go:171","msg":"trace[2123044371] transaction","detail":"{read_only:false; response_revision:1429; number_of_response:1; }","duration":"346.291518ms","start":"2026-04-23T10:22:47.125912Z","end":"2026-04-23T10:22:47.472203Z","steps":["trace[2123044371] 'process raft request' (duration: 344.777315ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:22:47.472252Z","caller":"traceutil/trace.go:171","msg":"trace[880124621] transaction","detail":"{read_only:false; response_revision:1430; number_of_response:1; }","duration":"327.571965ms","start":"2026-04-23T10:22:47.144673Z","end":"2026-04-23T10:22:47.472245Z","steps":["trace[880124621] 'process raft request' (duration: 327.429613ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:22:47.472329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:22:47.125896Z","time spent":"346.367989ms","remote":"127.0.0.1:56820","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-04-23T10:22:47.472445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.801905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/kube-node-lease/\" range_end:\"/registry/jobs/kube-node-lease0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T10:22:47.472477Z","caller":"traceutil/trace.go:171","msg":"trace[2092870354] range","detail":"{range_begin:/registry/jobs/kube-node-lease/; range_end:/registry/jobs/kube-node-lease0; response_count:0; response_revision:1430; }","duration":"262.854906ms","start":"2026-04-23T10:22:47.209612Z","end":"2026-04-23T10:22:47.472467Z","steps":["trace[2092870354] 'agreement among raft nodes before linearized reading' (duration: 262.753145ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:22:47.472524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.537452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/kube-node-lease/\" range_end:\"/registry/ingress/kube-node-lease0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T10:22:47.472602Z","caller":"traceutil/trace.go:171","msg":"trace[1710330442] range","detail":"{range_begin:/registry/ingress/kube-node-lease/; range_end:/registry/ingress/kube-node-lease0; response_count:0; response_revision:1430; }","duration":"262.667423ms","start":"2026-04-23T10:22:47.209914Z","end":"2026-04-23T10:22:47.472582Z","steps":["trace[1710330442] 'agreement among raft nodes before linearized reading' (duration: 262.509991ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:22:47.472676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.718739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-23T10:22:47.472345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:22:47.144653Z","time spent":"327.615497ms","remote":"127.0.0.1:56820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T10:22:47.472676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.637737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/envoy-oidc-hmac\" ","response":"range_response_count:1 size:452"} {"level":"info","ts":"2026-04-23T10:22:47.472729Z","caller":"traceutil/trace.go:171","msg":"trace[9824163] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1430; }","duration":"137.804351ms","start":"2026-04-23T10:22:47.33491Z","end":"2026-04-23T10:22:47.472714Z","steps":["trace[9824163] 'agreement among raft nodes before linearized reading' (duration: 137.71861ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:22:47.472788Z","caller":"traceutil/trace.go:171","msg":"trace[1080772669] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/envoy-oidc-hmac; range_end:; response_count:1; response_revision:1430; }","duration":"252.745249ms","start":"2026-04-23T10:22:47.219987Z","end":"2026-04-23T10:22:47.472733Z","steps":["trace[1080772669] 'agreement among raft nodes before linearized reading' (duration: 252.502136ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:22:47.472867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.293636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/envoy-rate-limit\" ","response":"range_response_count:1 size:4456"} {"level":"info","ts":"2026-04-23T10:22:47.472921Z","caller":"traceutil/trace.go:171","msg":"trace[27291051] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/envoy-rate-limit; range_end:; response_count:1; response_revision:1430; }","duration":"255.386977ms","start":"2026-04-23T10:22:47.21752Z","end":"2026-04-23T10:22:47.472907Z","steps":["trace[27291051] 'agreement among raft nodes before linearized reading' (duration: 255.168434ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:22:49.879618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.173207ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-23T10:22:49.879716Z","caller":"traceutil/trace.go:171","msg":"trace[2082733319] linearizableReadLoop","detail":"{readStateIndex:1493; appliedIndex:1492; }","duration":"338.264295ms","start":"2026-04-23T10:22:49.541437Z","end":"2026-04-23T10:22:49.879702Z","steps":["trace[2082733319] 'read index received' (duration: 90.798404ms)","trace[2082733319] 'applied index is now lower than readState.Index' (duration: 247.464481ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T10:22:49.879934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.316249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/kube-system/\" range_end:\"/registry/persistentvolumeclaims/kube-system0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T10:22:49.879979Z","caller":"traceutil/trace.go:171","msg":"trace[1739541706] range","detail":"{range_begin:/registry/persistentvolumeclaims/kube-system/; range_end:/registry/persistentvolumeclaims/kube-system0; response_count:0; response_revision:1436; }","duration":"153.398721ms","start":"2026-04-23T10:22:49.726567Z","end":"2026-04-23T10:22:49.879965Z","steps":["trace[1739541706] 'agreement among raft nodes before linearized reading' (duration: 153.32928ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:22:49.879932Z","caller":"traceutil/trace.go:171","msg":"trace[678926896] transaction","detail":"{read_only:false; response_revision:1436; number_of_response:1; }","duration":"395.107378ms","start":"2026-04-23T10:22:49.484778Z","end":"2026-04-23T10:22:49.879885Z","steps":["trace[678926896] 'process raft request' (duration: 147.592476ms)","trace[678926896] 'compare' (duration: 247.008365ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T10:22:49.879994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.546063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/local-path-storage/\" range_end:\"/registry/networkpolicies/local-path-storage0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-23T10:22:49.880018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.5389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" ","response":"range_response_count:1 size:3017"} {"level":"info","ts":"2026-04-23T10:22:49.880071Z","caller":"traceutil/trace.go:171","msg":"trace[817392239] range","detail":"{range_begin:/registry/networkpolicies/local-path-storage/; range_end:/registry/networkpolicies/local-path-storage0; response_count:0; response_revision:1436; }","duration":"294.641154ms","start":"2026-04-23T10:22:49.58541Z","end":"2026-04-23T10:22:49.880052Z","steps":["trace[817392239] 'agreement among raft nodes before linearized reading' (duration: 294.488662ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:22:49.880089Z","caller":"traceutil/trace.go:171","msg":"trace[1439838120] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:1; response_revision:1436; }","duration":"338.690571ms","start":"2026-04-23T10:22:49.541379Z","end":"2026-04-23T10:22:49.880069Z","steps":["trace[1439838120] 'agreement among raft nodes before linearized reading' (duration: 338.451088ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:22:49.880096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.226136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/kube-apiserver-legacy-service-account-token-tracking\" ","response":"range_response_count:1 size:370"} {"level":"warn","ts":"2026-04-23T10:22:49.880131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:22:49.541363Z","time spent":"338.759822ms","remote":"127.0.0.1:56682","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":3040,"request content":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" "} {"level":"warn","ts":"2026-04-23T10:22:49.880137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:22:49.484771Z","time spent":"395.26353ms","remote":"127.0.0.1:56820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T10:22:49.880186Z","caller":"traceutil/trace.go:171","msg":"trace[1738604152] range","detail":"{range_begin:/registry/configmaps/kube-system/kube-apiserver-legacy-service-account-token-tracking; range_end:; response_count:1; response_revision:1436; }","duration":"278.375689ms","start":"2026-04-23T10:22:49.601788Z","end":"2026-04-23T10:22:49.880163Z","steps":["trace[1738604152] 'agreement among raft nodes before linearized reading' (duration: 278.148645ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:22:50.063052Z","caller":"traceutil/trace.go:171","msg":"trace[182081408] transaction","detail":"{read_only:false; response_revision:1437; number_of_response:1; }","duration":"114.818639ms","start":"2026-04-23T10:22:49.948199Z","end":"2026-04-23T10:22:50.063018Z","steps":["trace[182081408] 'process raft request' (duration: 70.294437ms)","trace[182081408] 'compare' (duration: 44.323259ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T10:22:50.283658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.928462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/kube-proxy\" ","response":"range_response_count:1 size:1948"} {"level":"info","ts":"2026-04-23T10:22:50.283737Z","caller":"traceutil/trace.go:171","msg":"trace[278265353] range","detail":"{range_begin:/registry/configmaps/kube-system/kube-proxy; range_end:; response_count:1; response_revision:1437; }","duration":"120.050105ms","start":"2026-04-23T10:22:50.16367Z","end":"2026-04-23T10:22:50.28372Z","steps":["trace[278265353] 'range keys from in-memory index tree' (duration: 119.777901ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:22:50.283734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.098973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/kube-root-ca.crt\" ","response":"range_response_count:1 size:1746"} {"level":"info","ts":"2026-04-23T10:22:50.283802Z","caller":"traceutil/trace.go:171","msg":"trace[1277289184] range","detail":"{range_begin:/registry/configmaps/kube-system/kube-root-ca.crt; range_end:; response_count:1; response_revision:1437; }","duration":"115.205235ms","start":"2026-04-23T10:22:50.168578Z","end":"2026-04-23T10:22:50.283783Z","steps":["trace[1277289184] 'range keys from in-memory index tree' (duration: 114.999431ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:22:51.570111Z","caller":"traceutil/trace.go:171","msg":"trace[88489689] linearizableReadLoop","detail":"{readStateIndex:1498; appliedIndex:1497; }","duration":"142.663546ms","start":"2026-04-23T10:22:51.427409Z","end":"2026-04-23T10:22:51.570073Z","steps":["trace[88489689] 'read index received' (duration: 142.363932ms)","trace[88489689] 'applied index is now lower than readState.Index' (duration: 298.024µs)"],"step_count":2} {"level":"info","ts":"2026-04-23T10:22:51.570227Z","caller":"traceutil/trace.go:171","msg":"trace[2092535650] transaction","detail":"{read_only:false; response_revision:1441; number_of_response:1; }","duration":"178.684507ms","start":"2026-04-23T10:22:51.391531Z","end":"2026-04-23T10:22:51.570216Z","steps":["trace[2092535650] 'process raft request' (duration: 178.2566ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:22:51.57048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.053024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:3760"} {"level":"info","ts":"2026-04-23T10:22:51.570587Z","caller":"traceutil/trace.go:171","msg":"trace[941922889] range","detail":"{range_begin:/registry/deployments/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:1441; }","duration":"143.191865ms","start":"2026-04-23T10:22:51.427374Z","end":"2026-04-23T10:22:51.570566Z","steps":["trace[941922889] 'agreement among raft nodes before linearized reading' (duration: 142.962992ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:22:51.619541Z","caller":"traceutil/trace.go:171","msg":"trace[1122358067] transaction","detail":"{read_only:false; response_revision:1442; number_of_response:1; }","duration":"134.420329ms","start":"2026-04-23T10:22:51.485083Z","end":"2026-04-23T10:22:51.619503Z","steps":["trace[1122358067] 'process raft request' (duration: 125.001043ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:22:51.619661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.80929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/kube-system/kube-dns\" ","response":"range_response_count:1 size:757"} {"level":"info","ts":"2026-04-23T10:22:51.619747Z","caller":"traceutil/trace.go:171","msg":"trace[533100789] range","detail":"{range_begin:/registry/services/endpoints/kube-system/kube-dns; range_end:; response_count:1; response_revision:1442; }","duration":"158.934353ms","start":"2026-04-23T10:22:51.460792Z","end":"2026-04-23T10:22:51.619726Z","steps":["trace[533100789] 'agreement among raft nodes before linearized reading' (duration: 158.456776ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:22:53.477039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.726026ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-23T10:22:53.477223Z","caller":"traceutil/trace.go:171","msg":"trace[495759683] linearizableReadLoop","detail":"{readStateIndex:1505; appliedIndex:1504; }","duration":"163.287017ms","start":"2026-04-23T10:22:53.313919Z","end":"2026-04-23T10:22:53.477206Z","steps":["trace[495759683] 'read index received' (duration: 58.251587ms)","trace[495759683] 'applied index is now lower than readState.Index' (duration: 105.03386ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T10:22:53.477334Z","caller":"traceutil/trace.go:171","msg":"trace[1468309422] transaction","detail":"{read_only:false; response_revision:1447; number_of_response:1; }","duration":"247.468458ms","start":"2026-04-23T10:22:53.229852Z","end":"2026-04-23T10:22:53.47732Z","steps":["trace[1468309422] 'process raft request' (duration: 142.378067ms)","trace[1468309422] 'compare' (duration: 104.521683ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T10:22:53.477464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.918284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T10:22:53.477551Z","caller":"traceutil/trace.go:171","msg":"trace[112771538] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1447; }","duration":"143.051757ms","start":"2026-04-23T10:22:53.334479Z","end":"2026-04-23T10:22:53.47753Z","steps":["trace[112771538] 'agreement among raft nodes before linearized reading' (duration: 142.916945ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:22:53.477629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.702133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/kubeadm:kubelet-config\" ","response":"range_response_count:1 size:538"} {"level":"warn","ts":"2026-04-23T10:22:53.477629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.855836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/kubeadm:nodes-kubeadm-config\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-04-23T10:22:53.477708Z","caller":"traceutil/trace.go:171","msg":"trace[1682970740] range","detail":"{range_begin:/registry/rolebindings/kube-system/kubeadm:nodes-kubeadm-config; range_end:; response_count:1; response_revision:1447; }","duration":"138.965097ms","start":"2026-04-23T10:22:53.338726Z","end":"2026-04-23T10:22:53.477691Z","steps":["trace[1682970740] 'agreement among raft nodes before linearized reading' (duration: 138.674563ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:22:53.477705Z","caller":"traceutil/trace.go:171","msg":"trace[1726857563] range","detail":"{range_begin:/registry/rolebindings/kube-system/kubeadm:kubelet-config; range_end:; response_count:1; response_revision:1447; }","duration":"163.801044ms","start":"2026-04-23T10:22:53.313884Z","end":"2026-04-23T10:22:53.477685Z","steps":["trace[1726857563] 'agreement among raft nodes before linearized reading' (duration: 163.50982ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:22:55.220695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.367017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/bootstrap-token-hd2vfw\" ","response":"range_response_count:1 size:692"} {"level":"info","ts":"2026-04-23T10:22:55.220795Z","caller":"traceutil/trace.go:171","msg":"trace[1782841163] range","detail":"{range_begin:/registry/secrets/kube-system/bootstrap-token-hd2vfw; range_end:; response_count:1; response_revision:1451; }","duration":"178.514179ms","start":"2026-04-23T10:22:55.042257Z","end":"2026-04-23T10:22:55.220771Z","steps":["trace[1782841163] 'range keys from in-memory index tree' (duration: 178.274706ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:22:55.220774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.376634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-system/system:controller:token-cleaner\" ","response":"range_response_count:1 size:670"} {"level":"warn","ts":"2026-04-23T10:22:55.220962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.787961ms","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-04-23T10:22:55.221022Z","caller":"traceutil/trace.go:171","msg":"trace[706804091] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1451; }","duration":"115.880892ms","start":"2026-04-23T10:22:55.105127Z","end":"2026-04-23T10:22:55.221007Z","steps":["trace[706804091] 'range keys from in-memory index tree' (duration: 115.609828ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:22:55.220879Z","caller":"traceutil/trace.go:171","msg":"trace[1774573318] range","detail":"{range_begin:/registry/roles/kube-system/system:controller:token-cleaner; range_end:; response_count:1; response_revision:1451; }","duration":"198.540407ms","start":"2026-04-23T10:22:55.022316Z","end":"2026-04-23T10:22:55.220856Z","steps":["trace[1774573318] 'range keys from in-memory index tree' (duration: 198.268172ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:22:55.462459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.42832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T10:22:55.46256Z","caller":"traceutil/trace.go:171","msg":"trace[1153365090] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1452; }","duration":"128.574013ms","start":"2026-04-23T10:22:55.333967Z","end":"2026-04-23T10:22:55.462541Z","steps":["trace[1153365090] 'range keys from in-memory index tree' (duration: 128.325259ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:22:55.708735Z","caller":"traceutil/trace.go:171","msg":"trace[630962663] linearizableReadLoop","detail":"{readStateIndex:1511; appliedIndex:1510; }","duration":"169.662462ms","start":"2026-04-23T10:22:55.539051Z","end":"2026-04-23T10:22:55.708713Z","steps":["trace[630962663] 'read index received' (duration: 169.53794ms)","trace[630962663] 'applied index is now lower than readState.Index' (duration: 123.662µs)"],"step_count":2} {"level":"info","ts":"2026-04-23T10:22:55.708841Z","caller":"traceutil/trace.go:171","msg":"trace[707169256] transaction","detail":"{read_only:false; response_revision:1453; number_of_response:1; }","duration":"223.022067ms","start":"2026-04-23T10:22:55.485808Z","end":"2026-04-23T10:22:55.70883Z","steps":["trace[707169256] 'process raft request' (duration: 222.771393ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:22:55.708988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.907136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/kubeadm-certs\" ","response":"range_response_count:1 size:11443"} {"level":"info","ts":"2026-04-23T10:22:55.709072Z","caller":"traceutil/trace.go:171","msg":"trace[1756796438] range","detail":"{range_begin:/registry/secrets/kube-system/kubeadm-certs; range_end:; response_count:1; response_revision:1453; }","duration":"170.036297ms","start":"2026-04-23T10:22:55.539014Z","end":"2026-04-23T10:22:55.70905Z","steps":["trace[1756796438] 'agreement among raft nodes before linearized reading' (duration: 169.860454ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:22:55.940791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.664751ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-23T10:22:55.940901Z","caller":"traceutil/trace.go:171","msg":"trace[1883391049] linearizableReadLoop","detail":"{readStateIndex:1512; appliedIndex:1511; }","duration":"232.084687ms","start":"2026-04-23T10:22:55.708798Z","end":"2026-04-23T10:22:55.940883Z","steps":["trace[1883391049] 'read index received' (duration: 69.104401ms)","trace[1883391049] 'applied index is now lower than readState.Index' (duration: 162.979106ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T10:22:55.941023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.490274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T10:22:55.941177Z","caller":"traceutil/trace.go:171","msg":"trace[81268870] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:1454; }","duration":"288.687687ms","start":"2026-04-23T10:22:55.652468Z","end":"2026-04-23T10:22:55.941155Z","steps":["trace[81268870] 'agreement among raft nodes before linearized reading' (duration: 288.486494ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:22:55.941183Z","caller":"traceutil/trace.go:171","msg":"trace[1835988286] transaction","detail":"{read_only:false; response_revision:1454; number_of_response:1; }","duration":"305.63661ms","start":"2026-04-23T10:22:55.635527Z","end":"2026-04-23T10:22:55.941164Z","steps":["trace[1835988286] 'process raft request' (duration: 142.444781ms)","trace[1835988286] 'compare' (duration: 162.503079ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T10:22:55.941117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.365794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/kubeadm-certs\" ","response":"range_response_count:1 size:11443"} {"level":"warn","ts":"2026-04-23T10:22:55.941282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:22:55.635505Z","time spent":"305.733602ms","remote":"127.0.0.1:56820","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-04-23T10:22:55.941097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.301455ms","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-04-23T10:22:55.941365Z","caller":"traceutil/trace.go:171","msg":"trace[1852921365] range","detail":"{range_begin:/registry/secrets/kube-system/kubeadm-certs; range_end:; response_count:1; response_revision:1454; }","duration":"226.561227ms","start":"2026-04-23T10:22:55.714739Z","end":"2026-04-23T10:22:55.941301Z","steps":["trace[1852921365] 'agreement among raft nodes before linearized reading' (duration: 226.321403ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:22:55.941416Z","caller":"traceutil/trace.go:171","msg":"trace[577757111] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1454; }","duration":"307.668619ms","start":"2026-04-23T10:22:55.633734Z","end":"2026-04-23T10:22:55.941403Z","steps":["trace[577757111] 'agreement among raft nodes before linearized reading' (duration: 307.232873ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:22:55.941429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.647315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/sh.helm.release.v1.cilium.v1\" ","response":"range_response_count:1 size:317290"} {"level":"info","ts":"2026-04-23T10:22:55.941533Z","caller":"traceutil/trace.go:171","msg":"trace[1816478145] range","detail":"{range_begin:/registry/secrets/kube-system/sh.helm.release.v1.cilium.v1; range_end:; response_count:1; response_revision:1454; }","duration":"396.797728ms","start":"2026-04-23T10:22:55.544712Z","end":"2026-04-23T10:22:55.94151Z","steps":["trace[1816478145] 'agreement among raft nodes before linearized reading' (duration: 396.306111ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:22:55.941606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:22:55.544696Z","time spent":"396.899639ms","remote":"127.0.0.1:56670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":317313,"request content":"key:\"/registry/secrets/kube-system/sh.helm.release.v1.cilium.v1\" "} {"level":"warn","ts":"2026-04-23T10:22:55.941533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:22:55.633714Z","time spent":"307.804232ms","remote":"127.0.0.1:56820","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-04-23T10:22:57.834288Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3986422041727693678,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-23T10:22:58.335246Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3986422041727693678,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-23T10:22:58.335643Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.043279523s","expected-duration":"1s"} {"level":"info","ts":"2026-04-23T10:22:58.33617Z","caller":"traceutil/trace.go:171","msg":"trace[1177960393] transaction","detail":"{read_only:false; response_revision:1459; number_of_response:1; }","duration":"1.043884851s","start":"2026-04-23T10:22:57.292249Z","end":"2026-04-23T10:22:58.336134Z","steps":["trace[1177960393] 'process raft request' (duration: 1.043664538s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:22:58.336361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:22:57.292236Z","time spent":"1.044000932s","remote":"127.0.0.1:56820","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-04-23T10:22:58.479082Z","caller":"traceutil/trace.go:171","msg":"trace[302968520] linearizableReadLoop","detail":"{readStateIndex:1519; appliedIndex:1517; }","duration":"1.145488949s","start":"2026-04-23T10:22:57.333567Z","end":"2026-04-23T10:22:58.479056Z","steps":["trace[302968520] 'read index received' (duration: 1.002486229s)","trace[302968520] 'applied index is now lower than readState.Index' (duration: 143.00172ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T10:22:58.479187Z","caller":"traceutil/trace.go:171","msg":"trace[1302068509] transaction","detail":"{read_only:false; response_revision:1460; number_of_response:1; }","duration":"532.497089ms","start":"2026-04-23T10:22:57.946667Z","end":"2026-04-23T10:22:58.479164Z","steps":["trace[1302068509] 'process raft request' (duration: 514.086455ms)","trace[1302068509] 'compare' (duration: 18.177621ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T10:22:58.479269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.145683422s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-23T10:22:58.479296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:22:57.946642Z","time spent":"532.584701ms","remote":"127.0.0.1:56820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T10:22:58.479338Z","caller":"traceutil/trace.go:171","msg":"trace[1995569628] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1460; }","duration":"1.145786854s","start":"2026-04-23T10:22:57.333535Z","end":"2026-04-23T10:22:58.479322Z","steps":["trace[1995569628] 'agreement among raft nodes before linearized reading' (duration: 1.145675503s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:22:58.479397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.145295447s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-04-23T10:22:58.479456Z","caller":"traceutil/trace.go:171","msg":"trace[36773191] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:1460; }","duration":"1.145363898s","start":"2026-04-23T10:22:57.334077Z","end":"2026-04-23T10:22:58.479441Z","steps":["trace[36773191] 'agreement among raft nodes before linearized reading' (duration: 1.145275267s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:22:58.479495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:22:57.334072Z","time spent":"1.145415248s","remote":"127.0.0.1:56776","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":226,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" "} {"level":"warn","ts":"2026-04-23T10:22:58.479529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"834.594907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T10:22:58.479555Z","caller":"traceutil/trace.go:171","msg":"trace[234739214] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1460; }","duration":"834.662107ms","start":"2026-04-23T10:22:57.644885Z","end":"2026-04-23T10:22:58.479547Z","steps":["trace[234739214] 'agreement among raft nodes before linearized reading' (duration: 834.613827ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:22:58.479584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.017069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-23T10:22:58.479625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:22:57.644863Z","time spent":"834.751639ms","remote":"127.0.0.1:56702","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":28,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "} {"level":"info","ts":"2026-04-23T10:22:58.479642Z","caller":"traceutil/trace.go:171","msg":"trace[1195859035] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1460; }","duration":"475.086769ms","start":"2026-04-23T10:22:58.004541Z","end":"2026-04-23T10:22:58.479628Z","steps":["trace[1195859035] 'agreement among raft nodes before linearized reading' (duration: 474.929627ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:22:58.479688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.131777964s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/disruption-controller\" ","response":"range_response_count:1 size:207"} {"level":"warn","ts":"2026-04-23T10:22:58.479688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:22:58.004534Z","time spent":"475.1429ms","remote":"127.0.0.1:56820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-23T10:22:58.479727Z","caller":"traceutil/trace.go:171","msg":"trace[1077400212] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/disruption-controller; range_end:; response_count:1; response_revision:1460; }","duration":"1.131884906s","start":"2026-04-23T10:22:57.347831Z","end":"2026-04-23T10:22:58.479716Z","steps":["trace[1077400212] 'agreement among raft nodes before linearized reading' (duration: 1.131824715s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:22:58.479804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:22:57.347787Z","time spent":"1.131966426s","remote":"127.0.0.1:56776","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/disruption-controller\" "} {"level":"warn","ts":"2026-04-23T10:22:58.479913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.557886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-23T10:22:58.479411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:22:57.333521Z","time spent":"1.145877245s","remote":"127.0.0.1:56566","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-04-23T10:22:58.479968Z","caller":"traceutil/trace.go:171","msg":"trace[365090493] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1460; }","duration":"482.663217ms","start":"2026-04-23T10:22:57.997291Z","end":"2026-04-23T10:22:58.479955Z","steps":["trace[365090493] 'agreement among raft nodes before linearized reading' (duration: 482.535925ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:22:58.480686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:22:57.997266Z","time spent":"483.411468ms","remote":"127.0.0.1:56820","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-04-23T10:22:58.479897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"608.391764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T10:22:58.480988Z","caller":"traceutil/trace.go:171","msg":"trace[1144986465] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:1460; }","duration":"609.787884ms","start":"2026-04-23T10:22:57.871176Z","end":"2026-04-23T10:22:58.480964Z","steps":["trace[1144986465] 'agreement among raft nodes before linearized reading' (duration: 608.270093ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:22:58.480117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"766.184838ms","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-04-23T10:22:58.481352Z","caller":"traceutil/trace.go:171","msg":"trace[306624107] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1460; }","duration":"767.503468ms","start":"2026-04-23T10:22:57.713818Z","end":"2026-04-23T10:22:58.481322Z","steps":["trace[306624107] 'agreement among raft nodes before linearized reading' (duration: 766.138338ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:22:58.481463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:22:57.713783Z","time spent":"767.66786ms","remote":"127.0.0.1:56820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-23T10:22:58.48204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:22:57.871157Z","time spent":"610.038998ms","remote":"127.0.0.1:43976","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "} {"level":"warn","ts":"2026-04-23T10:22:59.255453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.169453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/expand-controller\" ","response":"range_response_count:1 size:199"} {"level":"info","ts":"2026-04-23T10:22:59.255666Z","caller":"traceutil/trace.go:171","msg":"trace[340391420] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/expand-controller; range_end:; response_count:1; response_revision:1464; }","duration":"226.417536ms","start":"2026-04-23T10:22:59.029216Z","end":"2026-04-23T10:22:59.255634Z","steps":["trace[340391420] 'agreement among raft nodes before linearized reading' (duration: 34.267888ms)","trace[340391420] 'range keys from in-memory index tree' (duration: 191.861564ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T10:22:59.255972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.598896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/\" range_end:\"/registry/events/kube-system0\" limit:500 ","response":"range_response_count:87 size:64730"} {"level":"info","ts":"2026-04-23T10:22:59.256061Z","caller":"traceutil/trace.go:171","msg":"trace[2053286758] range","detail":"{range_begin:/registry/events/kube-system/; range_end:/registry/events/kube-system0; response_count:87; response_revision:1464; }","duration":"223.729168ms","start":"2026-04-23T10:22:59.03231Z","end":"2026-04-23T10:22:59.256039Z","steps":["trace[2053286758] 'agreement among raft nodes before linearized reading' (duration: 31.212364ms)","trace[2053286758] 'range keys from in-memory index tree' (duration: 191.994546ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T10:23:00.296676Z","caller":"traceutil/trace.go:171","msg":"trace[500152232] transaction","detail":"{read_only:false; response_revision:1465; number_of_response:1; }","duration":"113.8616ms","start":"2026-04-23T10:23:00.182777Z","end":"2026-04-23T10:23:00.296639Z","steps":["trace[500152232] 'process raft request' (duration: 113.457653ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:23:00.658654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.734206ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-23T10:23:00.658891Z","caller":"traceutil/trace.go:171","msg":"trace[629162463] transaction","detail":"{read_only:false; response_revision:1467; number_of_response:1; }","duration":"172.80732ms","start":"2026-04-23T10:23:00.486061Z","end":"2026-04-23T10:23:00.658869Z","steps":["trace[629162463] 'process raft request' (duration: 172.732399ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:23:00.658968Z","caller":"traceutil/trace.go:171","msg":"trace[248324706] transaction","detail":"{read_only:false; response_revision:1466; number_of_response:1; }","duration":"315.176055ms","start":"2026-04-23T10:23:00.343741Z","end":"2026-04-23T10:23:00.658917Z","steps":["trace[248324706] 'process raft request' (duration: 41.069305ms)","trace[248324706] 'compare' (duration: 273.544393ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T10:23:00.659113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:23:00.343716Z","time spent":"315.332647ms","remote":"127.0.0.1:56820","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-04-23T10:23:00.659249Z","caller":"traceutil/trace.go:171","msg":"trace[1139946710] linearizableReadLoop","detail":"{readStateIndex:1525; appliedIndex:1524; }","duration":"234.082231ms","start":"2026-04-23T10:23:00.42512Z","end":"2026-04-23T10:23:00.659202Z","steps":["trace[1139946710] 'read index received' (duration: 35.761µs)","trace[1139946710] 'applied index is now lower than readState.Index' (duration: 234.04157ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T10:23:00.659506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.867597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replication-controller\" ","response":"range_response_count:1 size:209"} {"level":"warn","ts":"2026-04-23T10:23:00.6595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.353695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-04-23T10:23:00.659564Z","caller":"traceutil/trace.go:171","msg":"trace[1124513368] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replication-controller; range_end:; response_count:1; response_revision:1467; }","duration":"233.946008ms","start":"2026-04-23T10:23:00.4256Z","end":"2026-04-23T10:23:00.659546Z","steps":["trace[1124513368] 'agreement among raft nodes before linearized reading' (duration: 233.836307ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:23:00.659582Z","caller":"traceutil/trace.go:171","msg":"trace[1391710986] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:1467; }","duration":"234.454576ms","start":"2026-04-23T10:23:00.425103Z","end":"2026-04-23T10:23:00.659558Z","steps":["trace[1391710986] 'agreement among raft nodes before linearized reading' (duration: 234.266154ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:23:00.65962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.281327ms","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":"warn","ts":"2026-04-23T10:23:00.659626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.072201ms","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-04-23T10:23:00.659669Z","caller":"traceutil/trace.go:171","msg":"trace[116466305] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1467; }","duration":"164.3869ms","start":"2026-04-23T10:23:00.495267Z","end":"2026-04-23T10:23:00.659654Z","steps":["trace[116466305] 'agreement among raft nodes before linearized reading' (duration: 164.201147ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:23:00.659686Z","caller":"traceutil/trace.go:171","msg":"trace[283834771] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1467; }","duration":"163.148802ms","start":"2026-04-23T10:23:00.496518Z","end":"2026-04-23T10:23:00.659667Z","steps":["trace[283834771] 'agreement among raft nodes before linearized reading' (duration: 162.935319ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:23:00.659735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.932719ms","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-04-23T10:23:00.659801Z","caller":"traceutil/trace.go:171","msg":"trace[1400428687] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1467; }","duration":"168.043541ms","start":"2026-04-23T10:23:00.491739Z","end":"2026-04-23T10:23:00.659782Z","steps":["trace[1400428687] 'agreement among raft nodes before linearized reading' (duration: 167.837568ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:23:00.961981Z","caller":"traceutil/trace.go:171","msg":"trace[833408788] transaction","detail":"{read_only:false; response_revision:1469; number_of_response:1; }","duration":"295.449263ms","start":"2026-04-23T10:23:00.666507Z","end":"2026-04-23T10:23:00.961956Z","steps":["trace[833408788] 'process raft request' (duration: 260.12915ms)","trace[833408788] 'compare' (duration: 35.152631ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T10:23:00.962223Z","caller":"traceutil/trace.go:171","msg":"trace[23936885] linearizableReadLoop","detail":"{readStateIndex:1529; appliedIndex:1527; }","duration":"215.844091ms","start":"2026-04-23T10:23:00.746338Z","end":"2026-04-23T10:23:00.962182Z","steps":["trace[23936885] 'read index received' (duration: 180.298565ms)","trace[23936885] 'applied index is now lower than readState.Index' (duration: 35.543816ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T10:23:00.962343Z","caller":"traceutil/trace.go:171","msg":"trace[448330232] transaction","detail":"{read_only:false; response_revision:1470; number_of_response:1; }","duration":"295.602646ms","start":"2026-04-23T10:23:00.666684Z","end":"2026-04-23T10:23:00.962287Z","steps":["trace[448330232] 'process raft request' (duration: 295.225911ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:23:00.962465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.099125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"warn","ts":"2026-04-23T10:23:00.96248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.221119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replication-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-04-23T10:23:00.962512Z","caller":"traceutil/trace.go:171","msg":"trace[211007700] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:1470; }","duration":"216.274978ms","start":"2026-04-23T10:23:00.746225Z","end":"2026-04-23T10:23:00.9625Z","steps":["trace[211007700] 'agreement among raft nodes before linearized reading' (duration: 216.138286ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:23:00.962531Z","caller":"traceutil/trace.go:171","msg":"trace[1556768837] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replication-controller; range_end:; response_count:1; response_revision:1470; }","duration":"212.336492ms","start":"2026-04-23T10:23:00.750181Z","end":"2026-04-23T10:23:00.962518Z","steps":["trace[1556768837] 'agreement among raft nodes before linearized reading' (duration: 212.19949ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:23:01.751527Z","caller":"traceutil/trace.go:171","msg":"trace[1960791624] linearizableReadLoop","detail":"{readStateIndex:1531; appliedIndex:1530; }","duration":"102.980974ms","start":"2026-04-23T10:23:01.64852Z","end":"2026-04-23T10:23:01.751501Z","steps":["trace[1960791624] 'read index received' (duration: 5.532659ms)","trace[1960791624] 'applied index is now lower than readState.Index' (duration: 97.446905ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T10:23:01.751704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.168286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/statefulset-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-04-23T10:23:01.751809Z","caller":"traceutil/trace.go:171","msg":"trace[885082825] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/statefulset-controller; range_end:; response_count:1; response_revision:1471; }","duration":"103.321239ms","start":"2026-04-23T10:23:01.648465Z","end":"2026-04-23T10:23:01.751786Z","steps":["trace[885082825] 'agreement among raft nodes before linearized reading' (duration: 103.123236ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:23:04.926151Z","caller":"traceutil/trace.go:171","msg":"trace[1205461529] linearizableReadLoop","detail":"{readStateIndex:1541; appliedIndex:1539; }","duration":"117.171648ms","start":"2026-04-23T10:23:04.808954Z","end":"2026-04-23T10:23:04.926126Z","steps":["trace[1205461529] 'read index received' (duration: 3.818605ms)","trace[1205461529] 'applied index is now lower than readState.Index' (duration: 113.352183ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T10:23:04.926404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.423321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-2mzxl\" ","response":"range_response_count:1 size:18521"} {"level":"info","ts":"2026-04-23T10:23:04.926459Z","caller":"traceutil/trace.go:171","msg":"trace[1112610184] range","detail":"{range_begin:/registry/pods/kube-system/cilium-2mzxl; range_end:; response_count:1; response_revision:1481; }","duration":"117.513072ms","start":"2026-04-23T10:23:04.808931Z","end":"2026-04-23T10:23:04.926444Z","steps":["trace[1112610184] 'agreement among raft nodes before linearized reading' (duration: 117.289209ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:23:04.926367Z","caller":"traceutil/trace.go:171","msg":"trace[1288934766] transaction","detail":"{read_only:false; response_revision:1481; number_of_response:1; }","duration":"121.303406ms","start":"2026-04-23T10:23:04.804873Z","end":"2026-04-23T10:23:04.926177Z","steps":["trace[1288934766] 'process raft request' (duration: 114.531ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:23:05.315442Z","caller":"traceutil/trace.go:171","msg":"trace[542152916] linearizableReadLoop","detail":"{readStateIndex:1542; appliedIndex:1541; }","duration":"301.743264ms","start":"2026-04-23T10:23:05.013673Z","end":"2026-04-23T10:23:05.315416Z","steps":["trace[542152916] 'read index received' (duration: 246.553384ms)","trace[542152916] 'applied index is now lower than readState.Index' (duration: 55.18891ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T10:23:05.31555Z","caller":"traceutil/trace.go:171","msg":"trace[2127657030] transaction","detail":"{read_only:false; response_revision:1482; number_of_response:1; }","duration":"322.152453ms","start":"2026-04-23T10:23:04.993358Z","end":"2026-04-23T10:23:05.31551Z","steps":["trace[2127657030] 'process raft request' (duration: 266.841982ms)","trace[2127657030] 'compare' (duration: 54.991737ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T10:23:05.315668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.895692ms","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":"warn","ts":"2026-04-23T10:23:05.315685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.991108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-2mzxl\" ","response":"range_response_count:1 size:18521"} {"level":"warn","ts":"2026-04-23T10:23:05.315708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:23:04.993336Z","time spent":"322.292385ms","remote":"127.0.0.1:56820","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-04-23T10:23:05.315725Z","caller":"traceutil/trace.go:171","msg":"trace[915386534] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1482; }","duration":"247.997664ms","start":"2026-04-23T10:23:05.067714Z","end":"2026-04-23T10:23:05.315711Z","steps":["trace[915386534] 'agreement among raft nodes before linearized reading' (duration: 247.844642ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:23:05.315725Z","caller":"traceutil/trace.go:171","msg":"trace[1809222836] range","detail":"{range_begin:/registry/pods/kube-system/cilium-2mzxl; range_end:; response_count:1; response_revision:1482; }","duration":"302.055659ms","start":"2026-04-23T10:23:05.013659Z","end":"2026-04-23T10:23:05.315714Z","steps":["trace[1809222836] 'agreement among raft nodes before linearized reading' (duration: 301.894927ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:23:05.315766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T10:23:05.013613Z","time spent":"302.14579ms","remote":"127.0.0.1:56744","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":18544,"request content":"key:\"/registry/pods/kube-system/cilium-2mzxl\" "} {"level":"warn","ts":"2026-04-23T10:23:05.315864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.9875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-23T10:23:05.315975Z","caller":"traceutil/trace.go:171","msg":"trace[594750333] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1482; }","duration":"109.141393ms","start":"2026-04-23T10:23:05.206814Z","end":"2026-04-23T10:23:05.315955Z","steps":["trace[594750333] 'agreement among raft nodes before linearized reading' (duration: 108.791098ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T10:23:07.113459Z","caller":"traceutil/trace.go:171","msg":"trace[2062648057] transaction","detail":"{read_only:false; response_revision:1488; number_of_response:1; }","duration":"114.963141ms","start":"2026-04-23T10:23:06.998467Z","end":"2026-04-23T10:23:07.11343Z","steps":["trace[2062648057] 'process raft request' (duration: 114.733298ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T10:23:07.360995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.899719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:5911"} {"level":"info","ts":"2026-04-23T10:23:07.361077Z","caller":"traceutil/trace.go:171","msg":"trace[482200016] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:1488; }","duration":"164.014002ms","start":"2026-04-23T10:23:07.197044Z","end":"2026-04-23T10:23:07.361058Z","steps":["trace[482200016] 'range keys from in-memory index tree' (duration: 163.735067ms)"],"step_count":1}