{"level":"warn","ts":"2026-04-28T06:01:21.731738Z","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-28T06:01:21.731815Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.115: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.115:2380","--initial-cluster=instance=https://199.204.45.115:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.115:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.115: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-28T06:01:21.731876Z","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-28T06:01:21.731888Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.115:2380"]} {"level":"info","ts":"2026-04-28T06:01:21.731902Z","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-28T06:01:21.732656Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"]} {"level":"info","ts":"2026-04-28T06:01:21.732747Z","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.115:2380"],"listen-peer-urls":["https://199.204.45.115:2380"],"advertise-client-urls":["https://199.204.45.115:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.115: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-28T06:01:21.744384Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"11.434098ms"} {"level":"info","ts":"2026-04-28T06:01:21.770982Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e3aaa5c123e150e0","cluster-id":"61ec519698823541"} {"level":"info","ts":"2026-04-28T06:01:21.7711Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=()"} {"level":"info","ts":"2026-04-28T06:01:21.771127Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became follower at term 0"} {"level":"info","ts":"2026-04-28T06:01:21.771157Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e3aaa5c123e150e0 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-28T06:01:21.77119Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became follower at term 1"} {"level":"info","ts":"2026-04-28T06:01:21.77124Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=(16405106841599693024)"} {"level":"warn","ts":"2026-04-28T06:01:21.781451Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-28T06:01:21.784065Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-28T06:01:21.787429Z","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-28T06:01:21.791972Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e3aaa5c123e150e0","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-28T06:01:21.792159Z","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-28T06:01:21.792837Z","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-28T06:01:21.792921Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e3aaa5c123e150e0","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-28T06:01:21.792984Z","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-28T06:01:21.795613Z","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-28T06:01:21.79578Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.115:2380"} {"level":"info","ts":"2026-04-28T06:01:21.795822Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.115:2380"} {"level":"info","ts":"2026-04-28T06:01:21.796579Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e3aaa5c123e150e0","initial-advertise-peer-urls":["https://199.204.45.115:2380"],"listen-peer-urls":["https://199.204.45.115:2380"],"advertise-client-urls":["https://199.204.45.115:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-28T06:01:21.796607Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-28T06:01:21.796932Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=(16405106841599693024)"} {"level":"info","ts":"2026-04-28T06:01:21.797161Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"61ec519698823541","local-member-id":"e3aaa5c123e150e0","added-peer-id":"e3aaa5c123e150e0","added-peer-peer-urls":["https://199.204.45.115:2380"]} {"level":"info","ts":"2026-04-28T06:01:22.27211Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 is starting a new election at term 1"} {"level":"info","ts":"2026-04-28T06:01:22.272183Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-28T06:01:22.272259Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 received MsgPreVoteResp from e3aaa5c123e150e0 at term 1"} {"level":"info","ts":"2026-04-28T06:01:22.272282Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became candidate at term 2"} {"level":"info","ts":"2026-04-28T06:01:22.272294Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 received MsgVoteResp from e3aaa5c123e150e0 at term 2"} {"level":"info","ts":"2026-04-28T06:01:22.272313Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became leader at term 2"} {"level":"info","ts":"2026-04-28T06:01:22.272343Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e3aaa5c123e150e0 elected leader e3aaa5c123e150e0 at term 2"} {"level":"info","ts":"2026-04-28T06:01:22.273255Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e3aaa5c123e150e0","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.115:2379]}","request-path":"/0/members/e3aaa5c123e150e0/attributes","cluster-id":"61ec519698823541","publish-timeout":"7s"} {"level":"info","ts":"2026-04-28T06:01:22.273313Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-28T06:01:22.273269Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-28T06:01:22.273319Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-28T06:01:22.273676Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-28T06:01:22.273737Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-28T06:01:22.274686Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"61ec519698823541","local-member-id":"e3aaa5c123e150e0","cluster-version":"3.5"} {"level":"info","ts":"2026-04-28T06:01:22.274866Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-28T06:01:22.274953Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-28T06:01:22.279588Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-28T06:01:22.279798Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.115:2379"} {"level":"warn","ts":"2026-04-28T06:01:24.055765Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827831445997644662,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-28T06:01:24.143218Z","caller":"traceutil/trace.go:171","msg":"trace[561999026] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"587.987131ms","start":"2026-04-28T06:01:23.555203Z","end":"2026-04-28T06:01:24.14319Z","steps":["trace[561999026] 'process raft request' (duration: 587.737085ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:24.143841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:23.55519Z","time spent":"588.146867ms","remote":"127.0.0.1:38158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T06:01:24.667417Z","caller":"traceutil/trace.go:171","msg":"trace[795103464] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"1.111668187s","start":"2026-04-28T06:01:23.555712Z","end":"2026-04-28T06:01:24.66738Z","steps":["trace[795103464] 'process raft request' (duration: 1.11146444s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:24.667587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:23.5557Z","time spent":"1.111805534s","remote":"127.0.0.1:38146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T06:01:24.667714Z","caller":"traceutil/trace.go:171","msg":"trace[1142527518] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"1.05785385s","start":"2026-04-28T06:01:23.609826Z","end":"2026-04-28T06:01:24.66768Z","steps":["trace[1142527518] 'process raft request' (duration: 1.057558846s)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:24.66775Z","caller":"traceutil/trace.go:171","msg":"trace[52332510] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"1.057480597s","start":"2026-04-28T06:01:23.610231Z","end":"2026-04-28T06:01:24.667712Z","steps":["trace[52332510] 'process raft request' (duration: 1.057267741s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:24.667957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:23.610216Z","time spent":"1.057645144s","remote":"127.0.0.1:38588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T06:01:24.667938Z","caller":"traceutil/trace.go:171","msg":"trace[1374090842] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"1.057795572s","start":"2026-04-28T06:01:23.610093Z","end":"2026-04-28T06:01:24.667889Z","steps":["trace[1374090842] 'process raft request' (duration: 1.057342099s)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:24.667752Z","caller":"traceutil/trace.go:171","msg":"trace[483575372] linearizableReadLoop","detail":"{readStateIndex:14; appliedIndex:4; }","duration":"1.112358385s","start":"2026-04-28T06:01:23.555364Z","end":"2026-04-28T06:01:24.667723Z","steps":["trace[483575372] 'read index received' (duration: 587.559117ms)","trace[483575372] 'applied index is now lower than readState.Index' (duration: 524.798068ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T06:01:24.668164Z","caller":"traceutil/trace.go:171","msg":"trace[2021706089] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"1.058042677s","start":"2026-04-28T06:01:23.610083Z","end":"2026-04-28T06:01:24.668126Z","steps":["trace[2021706089] 'process raft request' (duration: 1.057386528s)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:24.668073Z","caller":"traceutil/trace.go:171","msg":"trace[1156322500] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"1.057622175s","start":"2026-04-28T06:01:23.610375Z","end":"2026-04-28T06:01:24.667997Z","steps":["trace[1156322500] 'process raft request' (duration: 1.057155572s)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:24.66824Z","caller":"traceutil/trace.go:171","msg":"trace[1871373627] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"1.021990818s","start":"2026-04-28T06:01:23.646239Z","end":"2026-04-28T06:01:24.66823Z","steps":["trace[1871373627] 'process raft request' (duration: 1.021439976s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:24.668277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:23.610329Z","time spent":"1.057919289s","remote":"127.0.0.1:38588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T06:01:24.668301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.058374133s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-28T06:01:24.6683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:23.610058Z","time spent":"1.058177524s","remote":"127.0.0.1:38588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T06:01:24.668319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:23.646226Z","time spent":"1.022052586s","remote":"127.0.0.1:38234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3159,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T06:01:24.66835Z","caller":"traceutil/trace.go:171","msg":"trace[970294560] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"1.058451581s","start":"2026-04-28T06:01:23.609881Z","end":"2026-04-28T06:01:24.668333Z","steps":["trace[970294560] 'agreement among raft nodes before linearized reading' (duration: 1.058379562s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:24.667928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.112535752s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3171"} {"level":"warn","ts":"2026-04-28T06:01:24.668373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"973.804948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-28T06:01:24.668307Z","caller":"traceutil/trace.go:171","msg":"trace[1749748908] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"1.024040103s","start":"2026-04-28T06:01:23.644256Z","end":"2026-04-28T06:01:24.668296Z","steps":["trace[1749748908] 'process raft request' (duration: 1.023301526s)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:24.668416Z","caller":"traceutil/trace.go:171","msg":"trace[899327694] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:11; }","duration":"973.889216ms","start":"2026-04-28T06:01:23.694517Z","end":"2026-04-28T06:01:24.668406Z","steps":["trace[899327694] 'agreement among raft nodes before linearized reading' (duration: 973.816698ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:24.668447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:23.6945Z","time spent":"973.940796ms","remote":"127.0.0.1:38186","response type":"/etcdserverpb.KV/Range","request count":0,"request size":30,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/default\" "} {"level":"warn","ts":"2026-04-28T06:01:24.668457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:23.64424Z","time spent":"1.024191121s","remote":"127.0.0.1:38318","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":845,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T06:01:24.668474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.058251943s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-28T06:01:24.668492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.058351383s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.115\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-28T06:01:24.668506Z","caller":"traceutil/trace.go:171","msg":"trace[1334229699] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"1.058315294s","start":"2026-04-28T06:01:23.610182Z","end":"2026-04-28T06:01:24.668498Z","steps":["trace[1334229699] 'agreement among raft nodes before linearized reading' (duration: 1.058252524s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:24.668539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:23.609992Z","time spent":"1.058541109s","remote":"127.0.0.1:38186","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-04-28T06:01:24.668538Z","caller":"traceutil/trace.go:171","msg":"trace[409549460] range","detail":"{range_begin:/registry/masterleases/199.204.45.115; range_end:; response_count:0; response_revision:11; }","duration":"1.058408671s","start":"2026-04-28T06:01:23.610117Z","end":"2026-04-28T06:01:24.668525Z","steps":["trace[409549460] 'agreement among raft nodes before linearized reading' (duration: 1.058353561s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:24.668199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:23.610075Z","time spent":"1.058046697s","remote":"127.0.0.1:38588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T06:01:24.668585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:23.610105Z","time spent":"1.05846913s","remote":"127.0.0.1:38128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/199.204.45.115\" "} {"level":"warn","ts":"2026-04-28T06:01:24.668628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.95455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-28T06:01:24.668666Z","caller":"traceutil/trace.go:171","msg":"trace[1072628531] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:11; }","duration":"161.00499ms","start":"2026-04-28T06:01:24.507648Z","end":"2026-04-28T06:01:24.668653Z","steps":["trace[1072628531] 'agreement among raft nodes before linearized reading' (duration: 160.965281ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:24.668404Z","caller":"traceutil/trace.go:171","msg":"trace[431068896] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:11; }","duration":"1.113040864s","start":"2026-04-28T06:01:23.55535Z","end":"2026-04-28T06:01:24.668391Z","steps":["trace[431068896] 'agreement among raft nodes before linearized reading' (duration: 1.112491173s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:24.668805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"965.477426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-28T06:01:24.668833Z","caller":"traceutil/trace.go:171","msg":"trace[1984914028] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"965.545415ms","start":"2026-04-28T06:01:23.70328Z","end":"2026-04-28T06:01:24.668826Z","steps":["trace[1984914028] 'agreement among raft nodes before linearized reading' (duration: 965.502796ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:24.66845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.007682275s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-28T06:01:24.668867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:23.70326Z","time spent":"965.600834ms","remote":"127.0.0.1:38186","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-04-28T06:01:24.668875Z","caller":"traceutil/trace.go:171","msg":"trace[1758262822] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"1.008134517s","start":"2026-04-28T06:01:23.660729Z","end":"2026-04-28T06:01:24.668864Z","steps":["trace[1758262822] 'agreement among raft nodes before linearized reading' (duration: 1.007695994s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:24.668901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:23.660716Z","time spent":"1.008178677s","remote":"127.0.0.1:38186","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-04-28T06:01:24.66883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:23.555346Z","time spent":"1.113472907s","remote":"127.0.0.1:38234","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3194,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-04-28T06:01:24.668068Z","caller":"traceutil/trace.go:171","msg":"trace[912848786] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"1.058348243s","start":"2026-04-28T06:01:23.609657Z","end":"2026-04-28T06:01:24.668005Z","steps":["trace[912848786] 'process raft request' (duration: 1.057656234s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:24.668595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.842665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-28T06:01:24.669014Z","caller":"traceutil/trace.go:171","msg":"trace[2032795382] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:11; }","duration":"156.290237ms","start":"2026-04-28T06:01:24.512711Z","end":"2026-04-28T06:01:24.669001Z","steps":["trace[2032795382] 'agreement among raft nodes before linearized reading' (duration: 155.861194ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:24.669011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:23.60963Z","time spent":"1.059338206s","remote":"127.0.0.1:38504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T06:01:24.668402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:23.609871Z","time spent":"1.05851926s","remote":"127.0.0.1:38172","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"warn","ts":"2026-04-28T06:01:24.669026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:23.609801Z","time spent":"1.058057508s","remote":"127.0.0.1:38588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T06:01:25.174292Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827831445997644674,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-28T06:01:25.443894Z","caller":"traceutil/trace.go:171","msg":"trace[499335327] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"770.750354ms","start":"2026-04-28T06:01:24.673115Z","end":"2026-04-28T06:01:25.443865Z","steps":["trace[499335327] 'process raft request' (duration: 762.908323ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:25.444029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:24.673086Z","time spent":"770.883042ms","remote":"127.0.0.1:38186","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":338,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T06:01:25.444889Z","caller":"traceutil/trace.go:171","msg":"trace[1357360204] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"767.321521ms","start":"2026-04-28T06:01:24.677527Z","end":"2026-04-28T06:01:25.444848Z","steps":["trace[1357360204] 'process raft request' (duration: 766.964938ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:25.445038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:24.677508Z","time spent":"767.460899ms","remote":"127.0.0.1:38426","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":429,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T06:01:25.445715Z","caller":"traceutil/trace.go:171","msg":"trace[1326580612] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"772.564154ms","start":"2026-04-28T06:01:24.673133Z","end":"2026-04-28T06:01:25.445697Z","steps":["trace[1326580612] 'process raft request' (duration: 771.214886ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:25.445854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:24.673113Z","time spent":"772.692192ms","remote":"127.0.0.1:38504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T06:01:25.445887Z","caller":"traceutil/trace.go:171","msg":"trace[292505955] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"768.231066ms","start":"2026-04-28T06:01:24.677644Z","end":"2026-04-28T06:01:25.445875Z","steps":["trace[292505955] 'process raft request' (duration: 766.909418ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:25.445955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:24.67763Z","time spent":"768.294624ms","remote":"127.0.0.1:38448","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":651,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T06:01:25.445947Z","caller":"traceutil/trace.go:171","msg":"trace[1113610723] transaction","detail":"{read_only:false; number_of_response:0; response_revision:16; }","duration":"768.319305ms","start":"2026-04-28T06:01:24.677566Z","end":"2026-04-28T06:01:25.445885Z","steps":["trace[1113610723] 'process raft request' (duration: 766.952477ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:25.446003Z","caller":"traceutil/trace.go:171","msg":"trace[1884091268] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"772.677233ms","start":"2026-04-28T06:01:24.673307Z","end":"2026-04-28T06:01:25.445984Z","steps":["trace[1884091268] 'process raft request' (duration: 771.157358ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:25.446036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:24.677552Z","time spent":"768.446033ms","remote":"127.0.0.1:38186","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T06:01:25.446057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:24.673294Z","time spent":"772.738571ms","remote":"127.0.0.1:38588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T06:01:25.44625Z","caller":"traceutil/trace.go:171","msg":"trace[542864626] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"773.040017ms","start":"2026-04-28T06:01:24.673198Z","end":"2026-04-28T06:01:25.446238Z","steps":["trace[542864626] 'process raft request' (duration: 771.231397ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:25.446297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:24.673182Z","time spent":"773.096176ms","remote":"127.0.0.1:38588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T06:01:25.446338Z","caller":"traceutil/trace.go:171","msg":"trace[1433188748] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"768.61013ms","start":"2026-04-28T06:01:24.677718Z","end":"2026-04-28T06:01:25.446328Z","steps":["trace[1433188748] 'process raft request' (duration: 766.876588ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:25.446371Z","caller":"traceutil/trace.go:171","msg":"trace[1873158631] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"768.557421ms","start":"2026-04-28T06:01:24.677805Z","end":"2026-04-28T06:01:25.446363Z","steps":["trace[1873158631] 'process raft request' (duration: 766.81805ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:25.446404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:24.677794Z","time spent":"768.59425ms","remote":"127.0.0.1:38588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T06:01:25.44643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:24.67771Z","time spent":"768.660699ms","remote":"127.0.0.1:38588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T06:01:25.44664Z","caller":"traceutil/trace.go:171","msg":"trace[2112958478] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"768.668779ms","start":"2026-04-28T06:01:24.677932Z","end":"2026-04-28T06:01:25.446601Z","steps":["trace[2112958478] 'process raft request' (duration: 766.712361ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:25.446715Z","caller":"traceutil/trace.go:171","msg":"trace[533250535] linearizableReadLoop","detail":"{readStateIndex:25; appliedIndex:14; }","duration":"773.488979ms","start":"2026-04-28T06:01:24.67321Z","end":"2026-04-28T06:01:25.446699Z","steps":["trace[533250535] 'read index received' (duration: 762.852774ms)","trace[533250535] 'applied index is now lower than readState.Index' (duration: 10.635575ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T06:01:25.446823Z","caller":"traceutil/trace.go:171","msg":"trace[166326400] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"764.239611ms","start":"2026-04-28T06:01:24.682575Z","end":"2026-04-28T06:01:25.446815Z","steps":["trace[166326400] 'process raft request' (duration: 762.101317ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:25.446885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:24.682556Z","time spent":"764.292311ms","remote":"127.0.0.1:38234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3479,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T06:01:25.447038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:24.677914Z","time spent":"768.797996ms","remote":"127.0.0.1:38588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":923,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T06:01:25.447062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"772.351549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-28T06:01:25.447119Z","caller":"traceutil/trace.go:171","msg":"trace[1366798702] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:21; }","duration":"772.469816ms","start":"2026-04-28T06:01:24.674632Z","end":"2026-04-28T06:01:25.447101Z","steps":["trace[1366798702] 'agreement among raft nodes before linearized reading' (duration: 772.357428ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:25.447138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"715.34839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-04-28T06:01:25.447164Z","caller":"traceutil/trace.go:171","msg":"trace[1542369153] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:21; }","duration":"715.381209ms","start":"2026-04-28T06:01:24.731775Z","end":"2026-04-28T06:01:25.447157Z","steps":["trace[1542369153] 'agreement among raft nodes before linearized reading' (duration: 715.3364ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:25.4472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:24.731771Z","time spent":"715.420629ms","remote":"127.0.0.1:38186","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-04-28T06:01:25.44718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:24.674619Z","time spent":"772.541525ms","remote":"127.0.0.1:38424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":27,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" "} {"level":"warn","ts":"2026-04-28T06:01:25.44734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"774.127759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-28T06:01:25.447372Z","caller":"traceutil/trace.go:171","msg":"trace[2009313444] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21; }","duration":"774.190547ms","start":"2026-04-28T06:01:24.673174Z","end":"2026-04-28T06:01:25.447365Z","steps":["trace[2009313444] 'agreement among raft nodes before linearized reading' (duration: 774.138198ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:25.447398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:24.673158Z","time spent":"774.227547ms","remote":"127.0.0.1:38086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-28T06:01:25.447448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"718.427109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-28T06:01:25.447499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"570.049191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-28T06:01:25.447509Z","caller":"traceutil/trace.go:171","msg":"trace[945500681] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:21; }","duration":"718.505157ms","start":"2026-04-28T06:01:24.728989Z","end":"2026-04-28T06:01:25.447494Z","steps":["trace[945500681] 'agreement among raft nodes before linearized reading' (duration: 718.424039ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:25.447561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:24.728977Z","time spent":"718.564346ms","remote":"127.0.0.1:38186","response type":"/etcdserverpb.KV/Range","request count":0,"request size":30,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/default\" "} {"level":"warn","ts":"2026-04-28T06:01:25.447689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"772.87695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-zjk45\" ","response":"range_response_count:1 size:857"} {"level":"info","ts":"2026-04-28T06:01:25.447518Z","caller":"traceutil/trace.go:171","msg":"trace[82250084] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:21; }","duration":"570.10338ms","start":"2026-04-28T06:01:24.877409Z","end":"2026-04-28T06:01:25.447512Z","steps":["trace[82250084] 'agreement among raft nodes before linearized reading' (duration: 570.07548ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:25.447717Z","caller":"traceutil/trace.go:171","msg":"trace[2109745588] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-zjk45; range_end:; response_count:1; response_revision:21; }","duration":"772.919348ms","start":"2026-04-28T06:01:24.67479Z","end":"2026-04-28T06:01:25.44771Z","steps":["trace[2109745588] 'agreement among raft nodes before linearized reading' (duration: 772.867069ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:25.447736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:24.674756Z","time spent":"772.974699ms","remote":"127.0.0.1:38318","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":880,"request content":"key:\"/registry/certificatesigningrequests/csr-zjk45\" "} {"level":"warn","ts":"2026-04-28T06:01:25.44774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:24.877389Z","time spent":"570.336257ms","remote":"127.0.0.1:38324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" "} {"level":"info","ts":"2026-04-28T06:01:28.957056Z","caller":"traceutil/trace.go:171","msg":"trace[51592002] transaction","detail":"{read_only:false; response_revision:308; number_of_response:1; }","duration":"166.792103ms","start":"2026-04-28T06:01:28.790222Z","end":"2026-04-28T06:01:28.957014Z","steps":["trace[51592002] 'process raft request' (duration: 166.650875ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:28.964382Z","caller":"traceutil/trace.go:171","msg":"trace[1013244153] transaction","detail":"{read_only:false; number_of_response:0; response_revision:309; }","duration":"163.639935ms","start":"2026-04-28T06:01:28.800716Z","end":"2026-04-28T06:01:28.964356Z","steps":["trace[1013244153] 'process raft request' (duration: 163.556926ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:28.964623Z","caller":"traceutil/trace.go:171","msg":"trace[718424893] transaction","detail":"{read_only:false; number_of_response:0; response_revision:309; }","duration":"132.782092ms","start":"2026-04-28T06:01:28.831831Z","end":"2026-04-28T06:01:28.964613Z","steps":["trace[718424893] 'process raft request' (duration: 132.480878ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:28.964457Z","caller":"traceutil/trace.go:171","msg":"trace[1290957582] transaction","detail":"{read_only:false; response_revision:309; number_of_response:1; }","duration":"166.822732ms","start":"2026-04-28T06:01:28.797615Z","end":"2026-04-28T06:01:28.964437Z","steps":["trace[1290957582] 'process raft request' (duration: 165.812509ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:30.261573Z","caller":"traceutil/trace.go:171","msg":"trace[1633651800] transaction","detail":"{read_only:false; response_revision:328; number_of_response:1; }","duration":"114.124403ms","start":"2026-04-28T06:01:30.147419Z","end":"2026-04-28T06:01:30.261543Z","steps":["trace[1633651800] 'process raft request' (duration: 112.246583ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:30.553037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.519199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-04-28T06:01:30.553165Z","caller":"traceutil/trace.go:171","msg":"trace[1915369433] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:329; }","duration":"187.718476ms","start":"2026-04-28T06:01:30.365414Z","end":"2026-04-28T06:01:30.553133Z","steps":["trace[1915369433] 'range keys from in-memory index tree' (duration: 187.361052ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:30.879364Z","caller":"traceutil/trace.go:171","msg":"trace[552245818] transaction","detail":"{read_only:false; response_revision:332; number_of_response:1; }","duration":"121.546874ms","start":"2026-04-28T06:01:30.757796Z","end":"2026-04-28T06:01:30.879343Z","steps":["trace[552245818] 'process raft request' (duration: 116.560204ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:31.938545Z","caller":"traceutil/trace.go:171","msg":"trace[1664648542] transaction","detail":"{read_only:false; response_revision:342; number_of_response:1; }","duration":"184.074578ms","start":"2026-04-28T06:01:31.754162Z","end":"2026-04-28T06:01:31.938237Z","steps":["trace[1664648542] 'process raft request' (duration: 183.909651ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:31.990197Z","caller":"traceutil/trace.go:171","msg":"trace[707256270] transaction","detail":"{read_only:false; response_revision:343; number_of_response:1; }","duration":"192.567883ms","start":"2026-04-28T06:01:31.797595Z","end":"2026-04-28T06:01:31.990163Z","steps":["trace[707256270] 'process raft request' (duration: 192.351167ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:32.16107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.320545ms","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-28T06:01:32.161137Z","caller":"traceutil/trace.go:171","msg":"trace[1263377111] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:344; }","duration":"123.430603ms","start":"2026-04-28T06:01:32.03769Z","end":"2026-04-28T06:01:32.16112Z","steps":["trace[1263377111] 'range keys from in-memory index tree' (duration: 123.254556ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:32.161068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.984415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-04-28T06:01:32.161244Z","caller":"traceutil/trace.go:171","msg":"trace[1847731327] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:344; }","duration":"112.123213ms","start":"2026-04-28T06:01:32.049072Z","end":"2026-04-28T06:01:32.161195Z","steps":["trace[1847731327] 'range keys from in-memory index tree' (duration: 111.916576ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:32.681061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.819875ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-28T06:01:32.681195Z","caller":"traceutil/trace.go:171","msg":"trace[933671839] linearizableReadLoop","detail":"{readStateIndex:358; appliedIndex:357; }","duration":"383.431512ms","start":"2026-04-28T06:01:32.297721Z","end":"2026-04-28T06:01:32.681153Z","steps":["trace[933671839] 'read index received' (duration: 67.185155ms)","trace[933671839] 'applied index is now lower than readState.Index' (duration: 316.245048ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T06:01:32.681274Z","caller":"traceutil/trace.go:171","msg":"trace[1694436917] transaction","detail":"{read_only:false; response_revision:346; number_of_response:1; }","duration":"427.191369ms","start":"2026-04-28T06:01:32.254072Z","end":"2026-04-28T06:01:32.681264Z","steps":["trace[1694436917] 'process raft request' (duration: 110.892162ms)","trace[1694436917] 'compare' (duration: 315.651077ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T06:01:32.681327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:32.254051Z","time spent":"427.253558ms","remote":"127.0.0.1:38182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1723,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T06:01:32.6815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.779688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-04-28T06:01:32.681537Z","caller":"traceutil/trace.go:171","msg":"trace[1678909032] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:346; }","duration":"383.854517ms","start":"2026-04-28T06:01:32.297672Z","end":"2026-04-28T06:01:32.681526Z","steps":["trace[1678909032] 'agreement among raft nodes before linearized reading' (duration: 383.760259ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:32.681565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:32.297653Z","time spent":"383.905555ms","remote":"127.0.0.1:38250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":232,"request content":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" "} {"level":"warn","ts":"2026-04-28T06:01:32.68181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.032786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-04-28T06:01:32.681894Z","caller":"traceutil/trace.go:171","msg":"trace[330390168] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:346; }","duration":"334.167913ms","start":"2026-04-28T06:01:32.347703Z","end":"2026-04-28T06:01:32.681871Z","steps":["trace[330390168] 'agreement among raft nodes before linearized reading' (duration: 333.991976ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:32.681967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:32.347681Z","time spent":"334.270281ms","remote":"127.0.0.1:38250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":220,"request content":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" "} {"level":"warn","ts":"2026-04-28T06:01:32.682168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.417181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-04-28T06:01:32.682187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.472764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-04-28T06:01:32.682214Z","caller":"traceutil/trace.go:171","msg":"trace[1284184517] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:346; }","duration":"315.517079ms","start":"2026-04-28T06:01:32.366686Z","end":"2026-04-28T06:01:32.682204Z","steps":["trace[1284184517] 'agreement among raft nodes before linearized reading' (duration: 315.45195ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:32.682245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:32.366664Z","time spent":"315.574109ms","remote":"127.0.0.1:38324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-28T06:01:32.682227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.032453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-04-28T06:01:32.682265Z","caller":"traceutil/trace.go:171","msg":"trace[643737400] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:346; }","duration":"234.557752ms","start":"2026-04-28T06:01:32.447665Z","end":"2026-04-28T06:01:32.682223Z","steps":["trace[643737400] 'agreement among raft nodes before linearized reading' (duration: 234.459944ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:32.682302Z","caller":"traceutil/trace.go:171","msg":"trace[939995973] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:346; }","duration":"285.148491ms","start":"2026-04-28T06:01:32.397135Z","end":"2026-04-28T06:01:32.682284Z","steps":["trace[939995973] 'agreement among raft nodes before linearized reading' (duration: 285.044203ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:32.68233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.371047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"warn","ts":"2026-04-28T06:01:32.682347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.444377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-04-28T06:01:32.682406Z","caller":"traceutil/trace.go:171","msg":"trace[1689140125] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:346; }","duration":"184.533965ms","start":"2026-04-28T06:01:32.497858Z","end":"2026-04-28T06:01:32.682392Z","steps":["trace[1689140125] 'agreement among raft nodes before linearized reading' (duration: 184.447097ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:32.682367Z","caller":"traceutil/trace.go:171","msg":"trace[682579851] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:346; }","duration":"121.450676ms","start":"2026-04-28T06:01:32.560903Z","end":"2026-04-28T06:01:32.682354Z","steps":["trace[682579851] 'agreement among raft nodes before linearized reading' (duration: 121.385257ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:32.962011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.765719ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-28T06:01:32.962215Z","caller":"traceutil/trace.go:171","msg":"trace[364114967] transaction","detail":"{read_only:false; response_revision:347; number_of_response:1; }","duration":"273.405517ms","start":"2026-04-28T06:01:32.688745Z","end":"2026-04-28T06:01:32.96215Z","steps":["trace[364114967] 'process raft request' (duration: 103.443521ms)","trace[364114967] 'compare' (duration: 169.628911ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T06:01:32.962389Z","caller":"traceutil/trace.go:171","msg":"trace[1215275655] transaction","detail":"{read_only:false; response_revision:348; number_of_response:1; }","duration":"272.303324ms","start":"2026-04-28T06:01:32.69001Z","end":"2026-04-28T06:01:32.962314Z","steps":["trace[1215275655] 'process raft request' (duration: 272.095427ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:32.962584Z","caller":"traceutil/trace.go:171","msg":"trace[1085482286] transaction","detail":"{read_only:false; response_revision:349; number_of_response:1; }","duration":"270.398674ms","start":"2026-04-28T06:01:32.69215Z","end":"2026-04-28T06:01:32.962549Z","steps":["trace[1085482286] 'process raft request' (duration: 270.04948ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:32.962643Z","caller":"traceutil/trace.go:171","msg":"trace[85878779] linearizableReadLoop","detail":"{readStateIndex:360; appliedIndex:358; }","duration":"272.443952ms","start":"2026-04-28T06:01:32.690191Z","end":"2026-04-28T06:01:32.962635Z","steps":["trace[85878779] 'read index received' (duration: 102.028963ms)","trace[85878779] 'applied index is now lower than readState.Index' (duration: 170.414339ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T06:01:32.962599Z","caller":"traceutil/trace.go:171","msg":"trace[1396620547] transaction","detail":"{read_only:false; response_revision:350; number_of_response:1; }","duration":"269.213332ms","start":"2026-04-28T06:01:32.693345Z","end":"2026-04-28T06:01:32.962558Z","steps":["trace[1396620547] 'process raft request' (duration: 269.102054ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:32.962746Z","caller":"traceutil/trace.go:171","msg":"trace[1276559801] transaction","detail":"{read_only:false; response_revision:351; number_of_response:1; }","duration":"268.898068ms","start":"2026-04-28T06:01:32.693843Z","end":"2026-04-28T06:01:32.962741Z","steps":["trace[1276559801] 'process raft request' (duration: 268.666452ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:32.962911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.710728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6965"} {"level":"info","ts":"2026-04-28T06:01:32.962955Z","caller":"traceutil/trace.go:171","msg":"trace[1397175427] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:355; }","duration":"272.781917ms","start":"2026-04-28T06:01:32.690162Z","end":"2026-04-28T06:01:32.962944Z","steps":["trace[1397175427] 'agreement among raft nodes before linearized reading' (duration: 272.702338ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:32.963098Z","caller":"traceutil/trace.go:171","msg":"trace[1013151021] transaction","detail":"{read_only:false; response_revision:352; number_of_response:1; }","duration":"267.962943ms","start":"2026-04-28T06:01:32.695124Z","end":"2026-04-28T06:01:32.963087Z","steps":["trace[1013151021] 'process raft request' (duration: 267.412052ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:32.963192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.232387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-04-28T06:01:32.963257Z","caller":"traceutil/trace.go:171","msg":"trace[226407238] transaction","detail":"{read_only:false; response_revision:353; number_of_response:1; }","duration":"268.017552ms","start":"2026-04-28T06:01:32.695231Z","end":"2026-04-28T06:01:32.963248Z","steps":["trace[226407238] 'process raft request' (duration: 267.328963ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:32.963262Z","caller":"traceutil/trace.go:171","msg":"trace[993145381] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:355; }","duration":"116.330726ms","start":"2026-04-28T06:01:32.846914Z","end":"2026-04-28T06:01:32.963245Z","steps":["trace[993145381] 'agreement among raft nodes before linearized reading' (duration: 116.227348ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:32.963364Z","caller":"traceutil/trace.go:171","msg":"trace[992769851] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"267.781435ms","start":"2026-04-28T06:01:32.695572Z","end":"2026-04-28T06:01:32.963354Z","steps":["trace[992769851] 'process raft request' (duration: 267.007028ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:32.963482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.172258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4197"} {"level":"info","ts":"2026-04-28T06:01:32.96349Z","caller":"traceutil/trace.go:171","msg":"trace[1934625249] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"267.418611ms","start":"2026-04-28T06:01:32.696055Z","end":"2026-04-28T06:01:32.963474Z","steps":["trace[1934625249] 'process raft request' (duration: 266.542445ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:32.963529Z","caller":"traceutil/trace.go:171","msg":"trace[1728445518] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:355; }","duration":"270.250107ms","start":"2026-04-28T06:01:32.693267Z","end":"2026-04-28T06:01:32.963517Z","steps":["trace[1728445518] 'agreement among raft nodes before linearized reading' (duration: 270.144368ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:32.963928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.146415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"warn","ts":"2026-04-28T06:01:32.963954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.68815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4197"} {"level":"info","ts":"2026-04-28T06:01:32.963968Z","caller":"traceutil/trace.go:171","msg":"trace[606747229] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:355; }","duration":"216.216573ms","start":"2026-04-28T06:01:32.747741Z","end":"2026-04-28T06:01:32.963958Z","steps":["trace[606747229] 'agreement among raft nodes before linearized reading' (duration: 216.151824ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:32.963993Z","caller":"traceutil/trace.go:171","msg":"trace[756863174] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:355; }","duration":"270.7342ms","start":"2026-04-28T06:01:32.693245Z","end":"2026-04-28T06:01:32.963979Z","steps":["trace[756863174] 'agreement among raft nodes before linearized reading' (duration: 270.673881ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:32.963952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.281237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-04-28T06:01:32.964098Z","caller":"traceutil/trace.go:171","msg":"trace[49807677] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:355; }","duration":"268.435295ms","start":"2026-04-28T06:01:32.69565Z","end":"2026-04-28T06:01:32.964085Z","steps":["trace[49807677] 'agreement among raft nodes before linearized reading' (duration: 268.234008ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:32.96414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.380502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"warn","ts":"2026-04-28T06:01:32.963079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.749019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4197"} {"level":"info","ts":"2026-04-28T06:01:32.964237Z","caller":"traceutil/trace.go:171","msg":"trace[1616552634] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:355; }","duration":"166.50776ms","start":"2026-04-28T06:01:32.797716Z","end":"2026-04-28T06:01:32.964224Z","steps":["trace[1616552634] 'agreement among raft nodes before linearized reading' (duration: 166.084958ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:32.964453Z","caller":"traceutil/trace.go:171","msg":"trace[299857643] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:355; }","duration":"272.061378ms","start":"2026-04-28T06:01:32.692283Z","end":"2026-04-28T06:01:32.964344Z","steps":["trace[299857643] 'agreement among raft nodes before linearized reading' (duration: 270.71078ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:32.964627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.994279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4197"} {"level":"info","ts":"2026-04-28T06:01:32.964647Z","caller":"traceutil/trace.go:171","msg":"trace[2086164723] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:355; }","duration":"272.047268ms","start":"2026-04-28T06:01:32.692594Z","end":"2026-04-28T06:01:32.964642Z","steps":["trace[2086164723] 'agreement among raft nodes before linearized reading' (duration: 271.95395ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:32.964706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.378033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4197"} {"level":"info","ts":"2026-04-28T06:01:32.964717Z","caller":"traceutil/trace.go:171","msg":"trace[1384300172] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:355; }","duration":"272.391693ms","start":"2026-04-28T06:01:32.692321Z","end":"2026-04-28T06:01:32.964713Z","steps":["trace[1384300172] 'agreement among raft nodes before linearized reading' (duration: 272.366913ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:32.964335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.745784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4197"} {"level":"info","ts":"2026-04-28T06:01:32.967794Z","caller":"traceutil/trace.go:171","msg":"trace[1432367638] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:355; }","duration":"275.230539ms","start":"2026-04-28T06:01:32.69255Z","end":"2026-04-28T06:01:32.967781Z","steps":["trace[1432367638] 'agreement among raft nodes before linearized reading' (duration: 271.745394ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:33.431763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.542093ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-28T06:01:33.431965Z","caller":"traceutil/trace.go:171","msg":"trace[596870442] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"460.792507ms","start":"2026-04-28T06:01:32.971144Z","end":"2026-04-28T06:01:33.431936Z","steps":["trace[596870442] 'process raft request' (duration: 281.997127ms)","trace[596870442] 'compare' (duration: 177.791216ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T06:01:33.432106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:32.971139Z","time spent":"460.909265ms","remote":"127.0.0.1:38164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":680,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T06:01:33.432407Z","caller":"traceutil/trace.go:171","msg":"trace[1591838121] transaction","detail":"{read_only:false; response_revision:360; number_of_response:1; }","duration":"459.968109ms","start":"2026-04-28T06:01:32.972427Z","end":"2026-04-28T06:01:33.432395Z","steps":["trace[1591838121] 'process raft request' (duration: 459.816762ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:33.432474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:32.97241Z","time spent":"460.026139ms","remote":"127.0.0.1:38506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3691,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T06:01:33.432633Z","caller":"traceutil/trace.go:171","msg":"trace[98505123] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"461.060722ms","start":"2026-04-28T06:01:32.971563Z","end":"2026-04-28T06:01:33.432623Z","steps":["trace[98505123] 'process raft request' (duration: 460.502721ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:33.432616Z","caller":"traceutil/trace.go:171","msg":"trace[870778764] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"423.35453ms","start":"2026-04-28T06:01:33.009231Z","end":"2026-04-28T06:01:33.432585Z","steps":["trace[870778764] 'process raft request' (duration: 423.311271ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:33.432685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:32.971558Z","time spent":"461.105462ms","remote":"127.0.0.1:38250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":172,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T06:01:33.432727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:33.009203Z","time spent":"423.482278ms","remote":"127.0.0.1:38182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1731,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T06:01:33.432879Z","caller":"traceutil/trace.go:171","msg":"trace[628926381] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"460.305975ms","start":"2026-04-28T06:01:32.972564Z","end":"2026-04-28T06:01:33.43287Z","steps":["trace[628926381] 'process raft request' (duration: 459.768413ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:33.432868Z","caller":"traceutil/trace.go:171","msg":"trace[708833589] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"459.347ms","start":"2026-04-28T06:01:32.973501Z","end":"2026-04-28T06:01:33.432848Z","steps":["trace[708833589] 'process raft request' (duration: 458.901766ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:33.432942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:32.972557Z","time spent":"460.353304ms","remote":"127.0.0.1:38412","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2264,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T06:01:33.432989Z","caller":"traceutil/trace.go:171","msg":"trace[207952517] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"455.708027ms","start":"2026-04-28T06:01:32.977262Z","end":"2026-04-28T06:01:33.43297Z","steps":["trace[207952517] 'process raft request' (duration: 455.229475ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:33.433066Z","caller":"traceutil/trace.go:171","msg":"trace[1281412609] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"460.638079ms","start":"2026-04-28T06:01:32.972419Z","end":"2026-04-28T06:01:33.433057Z","steps":["trace[1281412609] 'process raft request' (duration: 459.879031ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:33.433094Z","caller":"traceutil/trace.go:171","msg":"trace[424402398] linearizableReadLoop","detail":"{readStateIndex:370; appliedIndex:367; }","duration":"461.566675ms","start":"2026-04-28T06:01:32.97151Z","end":"2026-04-28T06:01:33.433076Z","steps":["trace[424402398] 'read index received' (duration: 33.110455ms)","trace[424402398] 'applied index is now lower than readState.Index' (duration: 428.45479ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T06:01:33.433112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:32.977255Z","time spent":"455.792706ms","remote":"127.0.0.1:38318","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2259,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T06:01:33.433117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:32.972392Z","time spent":"460.703048ms","remote":"127.0.0.1:38164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":649,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T06:01:33.43331Z","caller":"traceutil/trace.go:171","msg":"trace[2108095813] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"459.36089ms","start":"2026-04-28T06:01:32.973934Z","end":"2026-04-28T06:01:33.433295Z","steps":["trace[2108095813] 'process raft request' (duration: 458.506413ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:33.433338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.782191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-04-28T06:01:33.433392Z","caller":"traceutil/trace.go:171","msg":"trace[878293875] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:367; }","duration":"461.84407ms","start":"2026-04-28T06:01:32.971534Z","end":"2026-04-28T06:01:33.433378Z","steps":["trace[878293875] 'agreement among raft nodes before linearized reading' (duration: 461.751431ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:33.433403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:32.973927Z","time spent":"459.429229ms","remote":"127.0.0.1:38234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4355,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T06:01:33.43344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:32.971531Z","time spent":"461.898909ms","remote":"127.0.0.1:38250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" "} {"level":"warn","ts":"2026-04-28T06:01:33.433452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.934398ms","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-28T06:01:33.433488Z","caller":"traceutil/trace.go:171","msg":"trace[608380063] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:367; }","duration":"461.991268ms","start":"2026-04-28T06:01:32.971486Z","end":"2026-04-28T06:01:33.433477Z","steps":["trace[608380063] 'agreement among raft nodes before linearized reading' (duration: 461.919189ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:33.433123Z","caller":"traceutil/trace.go:171","msg":"trace[1778445011] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"459.908331ms","start":"2026-04-28T06:01:32.973201Z","end":"2026-04-28T06:01:33.43311Z","steps":["trace[1778445011] 'process raft request' (duration: 459.166813ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:33.433527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:32.97148Z","time spent":"462.040967ms","remote":"127.0.0.1:38250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" "} {"level":"warn","ts":"2026-04-28T06:01:33.433005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:32.973494Z","time spent":"459.430608ms","remote":"127.0.0.1:38412","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3461,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T06:01:33.435416Z","caller":"traceutil/trace.go:171","msg":"trace[1578590522] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"460.819906ms","start":"2026-04-28T06:01:32.971321Z","end":"2026-04-28T06:01:33.432141Z","steps":["trace[1578590522] 'process raft request' (duration: 460.559339ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:33.435558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:32.971316Z","time spent":"464.164163ms","remote":"127.0.0.1:38238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6950,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T06:01:33.43357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:32.973193Z","time spent":"460.353904ms","remote":"127.0.0.1:38336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1050,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T06:01:33.779592Z","caller":"traceutil/trace.go:171","msg":"trace[1950767565] transaction","detail":"{read_only:false; response_revision:385; number_of_response:1; }","duration":"190.783879ms","start":"2026-04-28T06:01:33.588782Z","end":"2026-04-28T06:01:33.779566Z","steps":["trace[1950767565] 'process raft request' (duration: 161.191566ms)","trace[1950767565] 'compare' (duration: 29.085311ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T06:01:33.779893Z","caller":"traceutil/trace.go:171","msg":"trace[250707647] linearizableReadLoop","detail":"{readStateIndex:397; appliedIndex:396; }","duration":"191.009837ms","start":"2026-04-28T06:01:33.588862Z","end":"2026-04-28T06:01:33.779872Z","steps":["trace[250707647] 'read index received' (duration: 35.44432ms)","trace[250707647] 'applied index is now lower than readState.Index' (duration: 155.564647ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T06:01:33.780184Z","caller":"traceutil/trace.go:171","msg":"trace[1919059940] transaction","detail":"{read_only:false; response_revision:386; number_of_response:1; }","duration":"191.219592ms","start":"2026-04-28T06:01:33.588953Z","end":"2026-04-28T06:01:33.780172Z","steps":["trace[1919059940] 'process raft request' (duration: 190.568283ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:33.780246Z","caller":"traceutil/trace.go:171","msg":"trace[49996515] transaction","detail":"{read_only:false; response_revision:387; number_of_response:1; }","duration":"188.8883ms","start":"2026-04-28T06:01:33.591343Z","end":"2026-04-28T06:01:33.780231Z","steps":["trace[49996515] 'process raft request' (duration: 188.471837ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:33.780304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.41749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/kube-proxy\" ","response":"range_response_count:1 size:2839"} {"level":"info","ts":"2026-04-28T06:01:33.78038Z","caller":"traceutil/trace.go:171","msg":"trace[1741174853] range","detail":"{range_begin:/registry/daemonsets/kube-system/kube-proxy; range_end:; response_count:1; response_revision:387; }","duration":"191.507198ms","start":"2026-04-28T06:01:33.588856Z","end":"2026-04-28T06:01:33.780363Z","steps":["trace[1741174853] 'agreement among raft nodes before linearized reading' (duration: 191.350771ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:34.055822Z","caller":"traceutil/trace.go:171","msg":"trace[269625346] transaction","detail":"{read_only:false; response_revision:391; number_of_response:1; }","duration":"266.975602ms","start":"2026-04-28T06:01:33.788814Z","end":"2026-04-28T06:01:34.05579Z","steps":["trace[269625346] 'process raft request' (duration: 171.652942ms)","trace[269625346] 'compare' (duration: 95.060793ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T06:01:34.0559Z","caller":"traceutil/trace.go:171","msg":"trace[622790872] transaction","detail":"{read_only:false; response_revision:393; number_of_response:1; }","duration":"249.152693ms","start":"2026-04-28T06:01:33.806727Z","end":"2026-04-28T06:01:34.05588Z","steps":["trace[622790872] 'process raft request' (duration: 249.118074ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:34.055992Z","caller":"traceutil/trace.go:171","msg":"trace[674399463] linearizableReadLoop","detail":"{readStateIndex:404; appliedIndex:402; }","duration":"256.638346ms","start":"2026-04-28T06:01:33.799342Z","end":"2026-04-28T06:01:34.055981Z","steps":["trace[674399463] 'read index received' (duration: 161.10393ms)","trace[674399463] 'applied index is now lower than readState.Index' (duration: 95.533016ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T06:01:34.056065Z","caller":"traceutil/trace.go:171","msg":"trace[351401697] transaction","detail":"{read_only:false; response_revision:392; number_of_response:1; }","duration":"266.528499ms","start":"2026-04-28T06:01:33.789528Z","end":"2026-04-28T06:01:34.056057Z","steps":["trace[351401697] 'process raft request' (duration: 266.236024ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:34.056163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.585711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-proxy-ddxrb\" ","response":"range_response_count:1 size:3439"} {"level":"info","ts":"2026-04-28T06:01:34.056215Z","caller":"traceutil/trace.go:171","msg":"trace[1021088865] range","detail":"{range_begin:/registry/pods/kube-system/kube-proxy-ddxrb; range_end:; response_count:1; response_revision:393; }","duration":"269.658469ms","start":"2026-04-28T06:01:33.786545Z","end":"2026-04-28T06:01:34.056204Z","steps":["trace[1021088865] 'agreement among raft nodes before linearized reading' (duration: 269.56045ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:34.056214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.501024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" ","response":"range_response_count:1 size:185"} {"level":"info","ts":"2026-04-28T06:01:34.056296Z","caller":"traceutil/trace.go:171","msg":"trace[1724458689] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:393; }","duration":"123.628413ms","start":"2026-04-28T06:01:33.932646Z","end":"2026-04-28T06:01:34.056275Z","steps":["trace[1724458689] 'agreement among raft nodes before linearized reading' (duration: 123.476415ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:34.443072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.043928ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-28T06:01:34.44319Z","caller":"traceutil/trace.go:171","msg":"trace[929365249] transaction","detail":"{read_only:false; response_revision:394; number_of_response:1; }","duration":"378.352307ms","start":"2026-04-28T06:01:34.064818Z","end":"2026-04-28T06:01:34.44317Z","steps":["trace[929365249] 'process raft request' (duration: 178.133382ms)","trace[929365249] 'compare' (duration: 199.9063ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T06:01:34.443249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:34.0648Z","time spent":"378.421815ms","remote":"127.0.0.1:38238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4451,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T06:01:34.984278Z","caller":"traceutil/trace.go:171","msg":"trace[1538134372] transaction","detail":"{read_only:false; response_revision:396; number_of_response:1; }","duration":"149.141987ms","start":"2026-04-28T06:01:34.835097Z","end":"2026-04-28T06:01:34.984239Z","steps":["trace[1538134372] 'process raft request' (duration: 148.9906ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:55.445798Z","caller":"traceutil/trace.go:171","msg":"trace[231263397] linearizableReadLoop","detail":"{readStateIndex:533; appliedIndex:532; }","duration":"294.803991ms","start":"2026-04-28T06:01:55.150976Z","end":"2026-04-28T06:01:55.44578Z","steps":["trace[231263397] 'read index received' (duration: 294.660254ms)","trace[231263397] 'applied index is now lower than readState.Index' (duration: 143.087µs)"],"step_count":2} {"level":"warn","ts":"2026-04-28T06:01:55.445897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.906697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T06:01:55.445918Z","caller":"traceutil/trace.go:171","msg":"trace[1599658664] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:515; }","duration":"294.977141ms","start":"2026-04-28T06:01:55.150934Z","end":"2026-04-28T06:01:55.445911Z","steps":["trace[1599658664] 'agreement among raft nodes before linearized reading' (duration: 294.920058ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:55.445882Z","caller":"traceutil/trace.go:171","msg":"trace[801447053] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"357.07553ms","start":"2026-04-28T06:01:55.088757Z","end":"2026-04-28T06:01:55.445833Z","steps":["trace[801447053] 'process raft request' (duration: 356.8851ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:55.446048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:55.088746Z","time spent":"357.222987ms","remote":"127.0.0.1:38324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T06:01:56.427724Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827831445997645647,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-28T06:01:56.928744Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827831445997645647,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-28T06:01:57.209521Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.59467644s","expected-duration":"1s"} {"level":"info","ts":"2026-04-28T06:01:57.20997Z","caller":"traceutil/trace.go:171","msg":"trace[1727930758] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"1.59524918s","start":"2026-04-28T06:01:55.614696Z","end":"2026-04-28T06:01:57.209945Z","steps":["trace[1727930758] 'process raft request' (duration: 1.595111692s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:57.210152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:55.614624Z","time spent":"1.595419619s","remote":"127.0.0.1:38136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T06:01:57.377198Z","caller":"traceutil/trace.go:171","msg":"trace[1130651430] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"1.748869766s","start":"2026-04-28T06:01:55.628305Z","end":"2026-04-28T06:01:57.377175Z","steps":["trace[1130651430] 'process raft request' (duration: 1.74875633s)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:57.377407Z","caller":"traceutil/trace.go:171","msg":"trace[383357619] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"1.742190029s","start":"2026-04-28T06:01:55.635156Z","end":"2026-04-28T06:01:57.377346Z","steps":["trace[383357619] 'process raft request' (duration: 1.741957566s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:57.377444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:55.628294Z","time spent":"1.749055327s","remote":"127.0.0.1:38136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T06:01:57.377534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:55.635142Z","time spent":"1.742334416s","remote":"127.0.0.1:38136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T06:01:57.377195Z","caller":"traceutil/trace.go:171","msg":"trace[497415317] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"1.755266039s","start":"2026-04-28T06:01:55.621895Z","end":"2026-04-28T06:01:57.377161Z","steps":["trace[497415317] 'process raft request' (duration: 1.755049068s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:57.377731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:55.621887Z","time spent":"1.755800797s","remote":"127.0.0.1:38136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T06:01:57.378084Z","caller":"traceutil/trace.go:171","msg":"trace[1767991629] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"1.7418644s","start":"2026-04-28T06:01:55.636199Z","end":"2026-04-28T06:01:57.378064Z","steps":["trace[1767991629] 'process raft request' (duration: 1.741231397s)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:57.378074Z","caller":"traceutil/trace.go:171","msg":"trace[1259498457] linearizableReadLoop","detail":"{readStateIndex:546; appliedIndex:533; }","duration":"1.450776017s","start":"2026-04-28T06:01:55.927266Z","end":"2026-04-28T06:01:57.378042Z","steps":["trace[1259498457] 'read index received' (duration: 1.282526667s)","trace[1259498457] 'applied index is now lower than readState.Index' (duration: 168.24805ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T06:01:57.378222Z","caller":"traceutil/trace.go:171","msg":"trace[710118884] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"1.730831458s","start":"2026-04-28T06:01:55.64737Z","end":"2026-04-28T06:01:57.378201Z","steps":["trace[710118884] 'process raft request' (duration: 1.730117541s)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:57.378262Z","caller":"traceutil/trace.go:171","msg":"trace[342506246] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"1.743096955s","start":"2026-04-28T06:01:55.635154Z","end":"2026-04-28T06:01:57.37825Z","steps":["trace[342506246] 'process raft request' (duration: 1.742111895s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:57.378347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:55.635136Z","time spent":"1.743155688s","remote":"127.0.0.1:38136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T06:01:57.378436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:55.64735Z","time spent":"1.730920452s","remote":"127.0.0.1:38136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T06:01:57.378617Z","caller":"traceutil/trace.go:171","msg":"trace[1831952767] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"1.731161675s","start":"2026-04-28T06:01:55.647444Z","end":"2026-04-28T06:01:57.378606Z","steps":["trace[1831952767] 'process raft request' (duration: 1.730204075s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:57.378672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:55.647441Z","time spent":"1.731209938s","remote":"127.0.0.1:38136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T06:01:57.378814Z","caller":"traceutil/trace.go:171","msg":"trace[30143025] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"1.703134222s","start":"2026-04-28T06:01:55.67567Z","end":"2026-04-28T06:01:57.378804Z","steps":["trace[30143025] 'process raft request' (duration: 1.702098738s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:57.378867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:55.675654Z","time spent":"1.703192025s","remote":"127.0.0.1:38136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T06:01:57.37896Z","caller":"traceutil/trace.go:171","msg":"trace[1341696904] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"1.604270383s","start":"2026-04-28T06:01:55.774681Z","end":"2026-04-28T06:01:57.378951Z","steps":["trace[1341696904] 'process raft request' (duration: 1.603182636s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:57.379009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:55.774652Z","time spent":"1.604335266s","remote":"127.0.0.1:38136","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-28T06:01:57.378193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:55.636186Z","time spent":"1.741969695s","remote":"127.0.0.1:38136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T06:01:57.379311Z","caller":"traceutil/trace.go:171","msg":"trace[2084427809] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"1.522913461s","start":"2026-04-28T06:01:55.856343Z","end":"2026-04-28T06:01:57.379256Z","steps":["trace[2084427809] 'process raft request' (duration: 1.521631745s)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:57.3794Z","caller":"traceutil/trace.go:171","msg":"trace[58500743] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"1.743420263s","start":"2026-04-28T06:01:55.635217Z","end":"2026-04-28T06:01:57.378637Z","steps":["trace[58500743] 'process raft request' (duration: 1.742144907s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:57.382911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:55.635212Z","time spent":"1.747628611s","remote":"127.0.0.1:38136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T06:01:57.379668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.452359969s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-28T06:01:57.383179Z","caller":"traceutil/trace.go:171","msg":"trace[96793554] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:528; }","duration":"1.455929945s","start":"2026-04-28T06:01:55.927225Z","end":"2026-04-28T06:01:57.383155Z","steps":["trace[96793554] 'agreement among raft nodes before linearized reading' (duration: 1.452305337s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:57.38331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:55.927204Z","time spent":"1.456088663s","remote":"127.0.0.1:38324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-28T06:01:57.377136Z","caller":"traceutil/trace.go:171","msg":"trace[1439612434] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"1.758842471s","start":"2026-04-28T06:01:55.618245Z","end":"2026-04-28T06:01:57.377088Z","steps":["trace[1439612434] 'process raft request' (duration: 1.75475416s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:57.383502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:55.618227Z","time spent":"1.765225122s","remote":"127.0.0.1:38136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T06:01:57.386202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:55.856321Z","time spent":"1.523020587s","remote":"127.0.0.1:38324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T06:01:57.427054Z","caller":"traceutil/trace.go:171","msg":"trace[1299147988] transaction","detail":"{read_only:false; number_of_response:1; response_revision:530; }","duration":"208.60625ms","start":"2026-04-28T06:01:57.218428Z","end":"2026-04-28T06:01:57.427034Z","steps":["trace[1299147988] 'process raft request' (duration: 208.575108ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:57.427304Z","caller":"traceutil/trace.go:171","msg":"trace[852876738] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"210.024013ms","start":"2026-04-28T06:01:57.217275Z","end":"2026-04-28T06:01:57.427299Z","steps":["trace[852876738] 'process raft request' (duration: 209.684156ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:57.434894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.468428185s","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-28T06:01:57.434996Z","caller":"traceutil/trace.go:171","msg":"trace[1027669556] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:530; }","duration":"1.476008178s","start":"2026-04-28T06:01:55.958949Z","end":"2026-04-28T06:01:57.434957Z","steps":["trace[1027669556] 'agreement among raft nodes before linearized reading' (duration: 1.468353501s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:57.435036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:55.958935Z","time spent":"1.476087632s","remote":"127.0.0.1:38324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-28T06:01:57.43541Z","caller":"traceutil/trace.go:171","msg":"trace[1135211651] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"218.180217ms","start":"2026-04-28T06:01:57.21721Z","end":"2026-04-28T06:01:57.43539Z","steps":["trace[1135211651] 'process raft request' (duration: 209.664595ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:57.435716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.17834473s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.115\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-28T06:01:57.435752Z","caller":"traceutil/trace.go:171","msg":"trace[1888473743] range","detail":"{range_begin:/registry/masterleases/199.204.45.115; range_end:; response_count:1; response_revision:530; }","duration":"1.178515249s","start":"2026-04-28T06:01:56.25722Z","end":"2026-04-28T06:01:57.435735Z","steps":["trace[1888473743] 'agreement among raft nodes before linearized reading' (duration: 1.178443525s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:57.435769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:56.257192Z","time spent":"1.178572621s","remote":"127.0.0.1:38128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.115\" "} {"level":"warn","ts":"2026-04-28T06:01:57.435881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"653.666827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T06:01:57.435909Z","caller":"traceutil/trace.go:171","msg":"trace[231536152] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:530; }","duration":"653.72346ms","start":"2026-04-28T06:01:56.782172Z","end":"2026-04-28T06:01:57.435896Z","steps":["trace[231536152] 'agreement among raft nodes before linearized reading' (duration: 653.688858ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:57.435927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:56.782153Z","time spent":"653.770103ms","remote":"127.0.0.1:38086","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-28T06:01:57.436218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.271486768s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-28T06:01:57.436243Z","caller":"traceutil/trace.go:171","msg":"trace[1661664702] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:530; }","duration":"1.271737242s","start":"2026-04-28T06:01:56.164498Z","end":"2026-04-28T06:01:57.436236Z","steps":["trace[1661664702] 'agreement among raft nodes before linearized reading' (duration: 1.271649588s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:57.43627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:01:56.164476Z","time spent":"1.271788595s","remote":"127.0.0.1:38324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-28T06:01:57.598794Z","caller":"traceutil/trace.go:171","msg":"trace[989474391] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"207.002828ms","start":"2026-04-28T06:01:57.391726Z","end":"2026-04-28T06:01:57.598729Z","steps":["trace[989474391] 'process raft request' (duration: 205.930742ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:57.598964Z","caller":"traceutil/trace.go:171","msg":"trace[116280571] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"202.095591ms","start":"2026-04-28T06:01:57.39685Z","end":"2026-04-28T06:01:57.598946Z","steps":["trace[116280571] 'process raft request' (duration: 201.878451ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:57.598995Z","caller":"traceutil/trace.go:171","msg":"trace[868426688] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"202.226139ms","start":"2026-04-28T06:01:57.396711Z","end":"2026-04-28T06:01:57.598937Z","steps":["trace[868426688] 'process raft request' (duration: 201.780157ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:57.599243Z","caller":"traceutil/trace.go:171","msg":"trace[384273710] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"201.288001ms","start":"2026-04-28T06:01:57.39794Z","end":"2026-04-28T06:01:57.599228Z","steps":["trace[384273710] 'process raft request' (duration: 200.959783ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:57.599273Z","caller":"traceutil/trace.go:171","msg":"trace[648401656] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"192.3951ms","start":"2026-04-28T06:01:57.40686Z","end":"2026-04-28T06:01:57.599255Z","steps":["trace[648401656] 'process raft request' (duration: 192.142806ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:57.599292Z","caller":"traceutil/trace.go:171","msg":"trace[1922296973] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"192.116986ms","start":"2026-04-28T06:01:57.407162Z","end":"2026-04-28T06:01:57.599279Z","steps":["trace[1922296973] 'process raft request' (duration: 191.921745ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:57.599388Z","caller":"traceutil/trace.go:171","msg":"trace[1085870406] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"201.306762ms","start":"2026-04-28T06:01:57.398071Z","end":"2026-04-28T06:01:57.599378Z","steps":["trace[1085870406] 'process raft request' (duration: 200.88492ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:57.599242Z","caller":"traceutil/trace.go:171","msg":"trace[322311451] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"189.242417ms","start":"2026-04-28T06:01:57.409979Z","end":"2026-04-28T06:01:57.599222Z","steps":["trace[322311451] 'process raft request' (duration: 189.172984ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:57.599656Z","caller":"traceutil/trace.go:171","msg":"trace[1708155634] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"202.672182ms","start":"2026-04-28T06:01:57.396969Z","end":"2026-04-28T06:01:57.599641Z","steps":["trace[1708155634] 'process raft request' (duration: 201.880131ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:57.603988Z","caller":"traceutil/trace.go:171","msg":"trace[659935815] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"154.159008ms","start":"2026-04-28T06:01:57.449797Z","end":"2026-04-28T06:01:57.603956Z","steps":["trace[659935815] 'process raft request' (duration: 153.858383ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:57.603983Z","caller":"traceutil/trace.go:171","msg":"trace[271564829] linearizableReadLoop","detail":"{readStateIndex:559; appliedIndex:549; }","duration":"166.606473ms","start":"2026-04-28T06:01:57.437351Z","end":"2026-04-28T06:01:57.603958Z","steps":["trace[271564829] 'read index received' (duration: 160.341548ms)","trace[271564829] 'applied index is now lower than readState.Index' (duration: 6.264095ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T06:01:57.604187Z","caller":"traceutil/trace.go:171","msg":"trace[737496827] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"154.37126ms","start":"2026-04-28T06:01:57.449797Z","end":"2026-04-28T06:01:57.604168Z","steps":["trace[737496827] 'process raft request' (duration: 153.954608ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:57.604305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.941182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T06:01:57.604417Z","caller":"traceutil/trace.go:171","msg":"trace[1683458158] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:544; }","duration":"167.069158ms","start":"2026-04-28T06:01:57.437333Z","end":"2026-04-28T06:01:57.604402Z","steps":["trace[1683458158] 'agreement among raft nodes before linearized reading' (duration: 166.92626ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:01:57.606219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.304167ms","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-28T06:01:57.606255Z","caller":"traceutil/trace.go:171","msg":"trace[633353372] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:544; }","duration":"154.35974ms","start":"2026-04-28T06:01:57.451886Z","end":"2026-04-28T06:01:57.606246Z","steps":["trace[633353372] 'agreement among raft nodes before linearized reading' (duration: 154.285756ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:58.201287Z","caller":"traceutil/trace.go:171","msg":"trace[1116009490] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"176.362676ms","start":"2026-04-28T06:01:58.024907Z","end":"2026-04-28T06:01:58.20127Z","steps":["trace[1116009490] 'process raft request' (duration: 107.784782ms)","trace[1116009490] 'compare' (duration: 68.438146ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T06:01:58.204982Z","caller":"traceutil/trace.go:171","msg":"trace[1408552874] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"178.841903ms","start":"2026-04-28T06:01:58.026116Z","end":"2026-04-28T06:01:58.204958Z","steps":["trace[1408552874] 'process raft request' (duration: 178.677085ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:58.323082Z","caller":"traceutil/trace.go:171","msg":"trace[1496379966] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"138.844714ms","start":"2026-04-28T06:01:58.184214Z","end":"2026-04-28T06:01:58.323059Z","steps":["trace[1496379966] 'process raft request' (duration: 138.393931ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:58.326985Z","caller":"traceutil/trace.go:171","msg":"trace[634095529] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"117.379301ms","start":"2026-04-28T06:01:58.209592Z","end":"2026-04-28T06:01:58.326971Z","steps":["trace[634095529] 'process raft request' (duration: 116.902417ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:01:58.327107Z","caller":"traceutil/trace.go:171","msg":"trace[423535919] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"103.456751ms","start":"2026-04-28T06:01:58.223643Z","end":"2026-04-28T06:01:58.3271Z","steps":["trace[423535919] 'process raft request' (duration: 102.954886ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:02:04.138542Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827831445997645878,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-28T06:02:04.638706Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827831445997645878,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-28T06:02:04.806074Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.174899713s","expected-duration":"1s"} {"level":"info","ts":"2026-04-28T06:02:04.814846Z","caller":"traceutil/trace.go:171","msg":"trace[757867417] linearizableReadLoop","detail":"{readStateIndex:643; appliedIndex:642; }","duration":"1.176955782s","start":"2026-04-28T06:02:03.637833Z","end":"2026-04-28T06:02:04.814789Z","steps":["trace[757867417] 'read index received' (duration: 1.168376267s)","trace[757867417] 'applied index is now lower than readState.Index' (duration: 8.578475ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T06:02:04.814899Z","caller":"traceutil/trace.go:171","msg":"trace[1252900589] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"1.185406657s","start":"2026-04-28T06:02:03.629458Z","end":"2026-04-28T06:02:04.814865Z","steps":["trace[1252900589] 'process raft request' (duration: 1.182628789s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:02:04.815035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.176115972s","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-28T06:02:04.815056Z","caller":"traceutil/trace.go:171","msg":"trace[1698915050] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:620; }","duration":"1.176177615s","start":"2026-04-28T06:02:03.638872Z","end":"2026-04-28T06:02:04.81505Z","steps":["trace[1698915050] 'agreement among raft nodes before linearized reading' (duration: 1.176078191s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:02:04.815077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:02:03.638856Z","time spent":"1.176216006s","remote":"127.0.0.1:38324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-28T06:02:04.815056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.029892409s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T06:02:04.815083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.174500826s","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-28T06:02:04.815121Z","caller":"traceutil/trace.go:171","msg":"trace[1103532918] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:620; }","duration":"1.029991383s","start":"2026-04-28T06:02:03.785112Z","end":"2026-04-28T06:02:04.815103Z","steps":["trace[1103532918] 'agreement among raft nodes before linearized reading' (duration: 1.029865567s)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:02:04.815129Z","caller":"traceutil/trace.go:171","msg":"trace[1052018310] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:620; }","duration":"1.174562888s","start":"2026-04-28T06:02:03.640556Z","end":"2026-04-28T06:02:04.815119Z","steps":["trace[1052018310] 'agreement among raft nodes before linearized reading' (duration: 1.174435393s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:02:04.81513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.174922416s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-28T06:02:04.815151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:02:03.785091Z","time spent":"1.030054956s","remote":"127.0.0.1:38086","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-28T06:02:04.81517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:02:03.640547Z","time spent":"1.174617612s","remote":"127.0.0.1:38324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-28T06:02:04.815175Z","caller":"traceutil/trace.go:171","msg":"trace[1574458820] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:620; }","duration":"1.174998139s","start":"2026-04-28T06:02:03.640162Z","end":"2026-04-28T06:02:04.815161Z","steps":["trace[1574458820] 'agreement among raft nodes before linearized reading' (duration: 1.174845793s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:02:04.8152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:02:03.640153Z","time spent":"1.175041573s","remote":"127.0.0.1:38324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-28T06:02:04.815576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:02:03.629434Z","time spent":"1.185540363s","remote":"127.0.0.1:38180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036277,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T06:02:04.81581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.177970358s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-28T06:02:04.815877Z","caller":"traceutil/trace.go:171","msg":"trace[1138683032] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:620; }","duration":"1.178069783s","start":"2026-04-28T06:02:03.637795Z","end":"2026-04-28T06:02:04.815864Z","steps":["trace[1138683032] 'agreement among raft nodes before linearized reading' (duration: 1.177161411s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:02:04.815917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:02:03.637764Z","time spent":"1.178145677s","remote":"127.0.0.1:38324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-28T06:02:05.983424Z","caller":"traceutil/trace.go:171","msg":"trace[1856263838] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"670.559331ms","start":"2026-04-28T06:02:05.312833Z","end":"2026-04-28T06:02:05.983392Z","steps":["trace[1856263838] 'process raft request' (duration: 669.8741ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:02:05.983677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:02:05.312814Z","time spent":"670.687466ms","remote":"127.0.0.1:38180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036301,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T06:02:07.253545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.144756042s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-28T06:02:07.253716Z","caller":"traceutil/trace.go:171","msg":"trace[1167463565] linearizableReadLoop","detail":"{readStateIndex:654; appliedIndex:652; }","duration":"996.738181ms","start":"2026-04-28T06:02:06.256949Z","end":"2026-04-28T06:02:07.253688Z","steps":["trace[1167463565] 'read index received' (duration: 44.352µs)","trace[1167463565] 'applied index is now lower than readState.Index' (duration: 996.692909ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T06:02:07.253847Z","caller":"traceutil/trace.go:171","msg":"trace[970044293] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"1.208500807s","start":"2026-04-28T06:02:06.045303Z","end":"2026-04-28T06:02:07.253803Z","steps":["trace[970044293] 'process raft request' (duration: 1.208337289s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:02:07.254018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"997.071866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.115\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-28T06:02:07.254062Z","caller":"traceutil/trace.go:171","msg":"trace[1648689050] range","detail":"{range_begin:/registry/masterleases/199.204.45.115; range_end:; response_count:1; response_revision:631; }","duration":"997.150469ms","start":"2026-04-28T06:02:06.256899Z","end":"2026-04-28T06:02:07.25405Z","steps":["trace[1648689050] 'agreement among raft nodes before linearized reading' (duration: 997.018904ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:02:07.254074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.497575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T06:02:07.254096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:02:06.256872Z","time spent":"997.216222ms","remote":"127.0.0.1:38128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.115\" "} {"level":"info","ts":"2026-04-28T06:02:07.254122Z","caller":"traceutil/trace.go:171","msg":"trace[1164907254] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:631; }","duration":"473.587338ms","start":"2026-04-28T06:02:06.780523Z","end":"2026-04-28T06:02:07.254111Z","steps":["trace[1164907254] 'agreement among raft nodes before linearized reading' (duration: 473.498564ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:02:07.25416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:02:06.780505Z","time spent":"473.648161ms","remote":"127.0.0.1:38086","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-28T06:02:07.254383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.657432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-28T06:02:07.254422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.103338ms","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-28T06:02:07.25446Z","caller":"traceutil/trace.go:171","msg":"trace[564555907] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:631; }","duration":"397.15624ms","start":"2026-04-28T06:02:06.857292Z","end":"2026-04-28T06:02:07.254448Z","steps":["trace[564555907] 'agreement among raft nodes before linearized reading' (duration: 397.060976ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:02:07.2545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:02:06.857284Z","time spent":"397.208842ms","remote":"127.0.0.1:38324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-28T06:02:07.254499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.469114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-28T06:02:07.254114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:02:06.045279Z","time spent":"1.208637853s","remote":"127.0.0.1:38292","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T06:02:07.254535Z","caller":"traceutil/trace.go:171","msg":"trace[1205010151] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:631; }","duration":"397.521376ms","start":"2026-04-28T06:02:06.857006Z","end":"2026-04-28T06:02:07.254527Z","steps":["trace[1205010151] 'agreement among raft nodes before linearized reading' (duration: 397.439152ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:02:07.254426Z","caller":"traceutil/trace.go:171","msg":"trace[1577456341] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:631; }","duration":"397.722975ms","start":"2026-04-28T06:02:06.856692Z","end":"2026-04-28T06:02:07.254415Z","steps":["trace[1577456341] 'agreement among raft nodes before linearized reading' (duration: 397.582298ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:02:07.254585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:02:06.856997Z","time spent":"397.581889ms","remote":"127.0.0.1:38324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-28T06:02:07.254628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:02:06.856678Z","time spent":"397.939164ms","remote":"127.0.0.1:38324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-28T06:02:07.254389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.181005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-28T06:02:07.254703Z","caller":"traceutil/trace.go:171","msg":"trace[1873062850] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:631; }","duration":"398.517469ms","start":"2026-04-28T06:02:06.856174Z","end":"2026-04-28T06:02:07.254692Z","steps":["trace[1873062850] 'agreement among raft nodes before linearized reading' (duration: 398.143593ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:02:07.254738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:02:06.856158Z","time spent":"398.569412ms","remote":"127.0.0.1:38324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-28T06:02:07.253847Z","caller":"traceutil/trace.go:171","msg":"trace[1322416760] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"1.257039301s","start":"2026-04-28T06:02:05.996782Z","end":"2026-04-28T06:02:07.253821Z","steps":["trace[1322416760] 'process raft request' (duration: 111.927732ms)","trace[1322416760] 'compare' (duration: 1.144650648s)"],"step_count":2} {"level":"warn","ts":"2026-04-28T06:02:07.254832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:02:05.996764Z","time spent":"1.258027514s","remote":"127.0.0.1:38238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T06:02:08.20293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.9795ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-28T06:02:08.203455Z","caller":"traceutil/trace.go:171","msg":"trace[1388017195] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"446.583152ms","start":"2026-04-28T06:02:07.75685Z","end":"2026-04-28T06:02:08.203433Z","steps":["trace[1388017195] 'process raft request' (duration: 446.52384ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:02:08.203556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:02:07.756825Z","time spent":"446.679076ms","remote":"127.0.0.1:38324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T06:02:08.203742Z","caller":"traceutil/trace.go:171","msg":"trace[290294992] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"944.80837ms","start":"2026-04-28T06:02:07.258911Z","end":"2026-04-28T06:02:08.203719Z","steps":["trace[290294992] 'process raft request' (duration: 944.276307ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:02:08.203806Z","caller":"traceutil/trace.go:171","msg":"trace[3434798] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"746.132765ms","start":"2026-04-28T06:02:07.457658Z","end":"2026-04-28T06:02:08.203791Z","steps":["trace[3434798] 'process raft request' (duration: 745.634854ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:02:08.203847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:02:07.258898Z","time spent":"944.906875ms","remote":"127.0.0.1:38324","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-28T06:02:08.203895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:02:07.457618Z","time spent":"746.226519ms","remote":"127.0.0.1:38128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T06:02:08.203918Z","caller":"traceutil/trace.go:171","msg":"trace[743873988] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"945.255279ms","start":"2026-04-28T06:02:07.258634Z","end":"2026-04-28T06:02:08.203889Z","steps":["trace[743873988] 'process raft request' (duration: 758.14874ms)","trace[743873988] 'compare' (duration: 185.754301ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T06:02:08.203933Z","caller":"traceutil/trace.go:171","msg":"trace[1169789495] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"945.04604ms","start":"2026-04-28T06:02:07.258877Z","end":"2026-04-28T06:02:08.203923Z","steps":["trace[1169789495] 'process raft request' (duration: 944.188303ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:02:08.204059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:02:07.258867Z","time spent":"945.163435ms","remote":"127.0.0.1:38324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T06:02:08.204061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:02:07.258611Z","time spent":"945.367354ms","remote":"127.0.0.1:38324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T06:02:08.204184Z","caller":"traceutil/trace.go:171","msg":"trace[1670158273] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"942.718568ms","start":"2026-04-28T06:02:07.261447Z","end":"2026-04-28T06:02:08.204165Z","steps":["trace[1670158273] 'process raft request' (duration: 941.792538ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:02:08.204265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:02:07.261428Z","time spent":"942.79422ms","remote":"127.0.0.1:38324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T06:02:08.204645Z","caller":"traceutil/trace.go:171","msg":"trace[1600967039] linearizableReadLoop","detail":"{readStateIndex:656; appliedIndex:654; }","duration":"945.828294ms","start":"2026-04-28T06:02:07.258795Z","end":"2026-04-28T06:02:08.204623Z","steps":["trace[1600967039] 'read index received' (duration: 120.014776ms)","trace[1600967039] 'applied index is now lower than readState.Index' (duration: 825.811318ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T06:02:08.204758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"945.953049ms","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-28T06:02:08.204803Z","caller":"traceutil/trace.go:171","msg":"trace[643920686] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:637; }","duration":"946.048393ms","start":"2026-04-28T06:02:07.258741Z","end":"2026-04-28T06:02:08.204789Z","steps":["trace[643920686] 'agreement among raft nodes before linearized reading' (duration: 945.958689ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:02:08.204849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:02:07.258725Z","time spent":"946.113466ms","remote":"127.0.0.1:38250","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":"info","ts":"2026-04-28T06:02:10.272009Z","caller":"traceutil/trace.go:171","msg":"trace[319418210] transaction","detail":"{read_only:false; response_revision:671; number_of_response:1; }","duration":"145.931759ms","start":"2026-04-28T06:02:10.126057Z","end":"2026-04-28T06:02:10.271988Z","steps":["trace[319418210] 'process raft request' (duration: 145.48851ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:02:22.550806Z","caller":"traceutil/trace.go:171","msg":"trace[151192245] transaction","detail":"{read_only:false; response_revision:783; number_of_response:1; }","duration":"169.563325ms","start":"2026-04-28T06:02:22.38119Z","end":"2026-04-28T06:02:22.550753Z","steps":["trace[151192245] 'process raft request' (duration: 169.192243ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:02:22.597655Z","caller":"traceutil/trace.go:171","msg":"trace[782632130] transaction","detail":"{read_only:false; response_revision:784; number_of_response:1; }","duration":"176.272781ms","start":"2026-04-28T06:02:22.421361Z","end":"2026-04-28T06:02:22.597634Z","steps":["trace[782632130] 'process raft request' (duration: 176.156728ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:02:24.921549Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827831445997646218,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-28T06:02:25.422387Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827831445997646218,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-28T06:02:25.695563Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.310324779s","expected-duration":"1s"} {"level":"info","ts":"2026-04-28T06:02:25.696062Z","caller":"traceutil/trace.go:171","msg":"trace[152637427] transaction","detail":"{read_only:false; response_revision:795; number_of_response:1; }","duration":"1.310867547s","start":"2026-04-28T06:02:24.385171Z","end":"2026-04-28T06:02:25.696038Z","steps":["trace[152637427] 'process raft request' (duration: 1.310656961s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:02:25.696202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:02:24.385158Z","time spent":"1.310974881s","remote":"127.0.0.1:38324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T06:02:25.736568Z","caller":"traceutil/trace.go:171","msg":"trace[422022857] linearizableReadLoop","detail":"{readStateIndex:824; appliedIndex:822; }","duration":"1.315277518s","start":"2026-04-28T06:02:24.421249Z","end":"2026-04-28T06:02:25.736526Z","steps":["trace[422022857] 'read index received' (duration: 1.274534315s)","trace[422022857] 'applied index is now lower than readState.Index' (duration: 40.741773ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T06:02:25.736874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.181973089s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-28T06:02:25.736838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.315575067s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-28T06:02:25.736936Z","caller":"traceutil/trace.go:171","msg":"trace[1938569148] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:796; }","duration":"1.182086562s","start":"2026-04-28T06:02:24.554835Z","end":"2026-04-28T06:02:25.736921Z","steps":["trace[1938569148] 'agreement among raft nodes before linearized reading' (duration: 1.181881916s)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:02:25.736949Z","caller":"traceutil/trace.go:171","msg":"trace[1445756692] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:796; }","duration":"1.315700281s","start":"2026-04-28T06:02:24.421233Z","end":"2026-04-28T06:02:25.736934Z","steps":["trace[1445756692] 'agreement among raft nodes before linearized reading' (duration: 1.315420463s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:02:25.736992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:02:24.554814Z","time spent":"1.182165275s","remote":"127.0.0.1:38324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-28T06:02:25.737022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:02:24.421227Z","time spent":"1.315783484s","remote":"127.0.0.1:38324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-28T06:02:25.737134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.135454725s","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-28T06:02:25.737295Z","caller":"traceutil/trace.go:171","msg":"trace[71510195] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:796; }","duration":"1.135671102s","start":"2026-04-28T06:02:24.601569Z","end":"2026-04-28T06:02:25.73724Z","steps":["trace[71510195] 'agreement among raft nodes before linearized reading' (duration: 1.135223817s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:02:25.7374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:02:24.601549Z","time spent":"1.135833207s","remote":"127.0.0.1:38324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-28T06:02:25.737393Z","caller":"traceutil/trace.go:171","msg":"trace[1639262194] transaction","detail":"{read_only:false; response_revision:796; number_of_response:1; }","duration":"698.496425ms","start":"2026-04-28T06:02:25.038805Z","end":"2026-04-28T06:02:25.737301Z","steps":["trace[1639262194] 'process raft request' (duration: 697.506183ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:02:25.737902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:02:25.038747Z","time spent":"699.069314ms","remote":"127.0.0.1:38292","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-28T06:02:58.349773Z","caller":"traceutil/trace.go:171","msg":"trace[1668930237] transaction","detail":"{read_only:false; response_revision:1035; number_of_response:1; }","duration":"268.661802ms","start":"2026-04-28T06:02:58.081093Z","end":"2026-04-28T06:02:58.349755Z","steps":["trace[1668930237] 'process raft request' (duration: 267.99158ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:02:58.561778Z","caller":"traceutil/trace.go:171","msg":"trace[1009387151] linearizableReadLoop","detail":"{readStateIndex:1072; appliedIndex:1071; }","duration":"154.62112ms","start":"2026-04-28T06:02:58.407128Z","end":"2026-04-28T06:02:58.561749Z","steps":["trace[1009387151] 'read index received' (duration: 123.534476ms)","trace[1009387151] 'applied index is now lower than readState.Index' (duration: 31.085354ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T06:02:58.561817Z","caller":"traceutil/trace.go:171","msg":"trace[1802857161] transaction","detail":"{read_only:false; response_revision:1036; number_of_response:1; }","duration":"198.156851ms","start":"2026-04-28T06:02:58.36364Z","end":"2026-04-28T06:02:58.561797Z","steps":["trace[1802857161] 'process raft request' (duration: 167.085087ms)","trace[1802857161] 'compare' (duration: 30.87028ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T06:02:58.561934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.759002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-28T06:02:58.561968Z","caller":"traceutil/trace.go:171","msg":"trace[1583550514] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1036; }","duration":"154.858934ms","start":"2026-04-28T06:02:58.4071Z","end":"2026-04-28T06:02:58.561959Z","steps":["trace[1583550514] 'agreement among raft nodes before linearized reading' (duration: 154.756263ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:04:22.548523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.084193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-28T06:04:22.54863Z","caller":"traceutil/trace.go:171","msg":"trace[1183647507] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:1349; }","duration":"115.232723ms","start":"2026-04-28T06:04:22.433378Z","end":"2026-04-28T06:04:22.548611Z","steps":["trace[1183647507] 'count revisions from in-memory index tree' (duration: 114.977413ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:04:48.686994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.935634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/envoy-gateway-system/envoy-gateway\" ","response":"range_response_count:1 size:1120"} {"level":"info","ts":"2026-04-28T06:04:48.68708Z","caller":"traceutil/trace.go:171","msg":"trace[1278818991] range","detail":"{range_begin:/registry/services/endpoints/envoy-gateway-system/envoy-gateway; range_end:; response_count:1; response_revision:1439; }","duration":"112.064483ms","start":"2026-04-28T06:04:48.574997Z","end":"2026-04-28T06:04:48.687062Z","steps":["trace[1278818991] 'range keys from in-memory index tree' (duration: 111.767583ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:04:48.926466Z","caller":"traceutil/trace.go:171","msg":"trace[694815295] linearizableReadLoop","detail":"{readStateIndex:1501; appliedIndex:1500; }","duration":"145.19932ms","start":"2026-04-28T06:04:48.781239Z","end":"2026-04-28T06:04:48.926438Z","steps":["trace[694815295] 'read index received' (duration: 108.708962ms)","trace[694815295] 'applied index is now lower than readState.Index' (duration: 36.489118ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T06:04:48.926552Z","caller":"traceutil/trace.go:171","msg":"trace[1578744670] transaction","detail":"{read_only:false; response_revision:1441; number_of_response:1; }","duration":"157.703151ms","start":"2026-04-28T06:04:48.768807Z","end":"2026-04-28T06:04:48.92651Z","steps":["trace[1578744670] 'process raft request' (duration: 121.051042ms)","trace[1578744670] 'compare' (duration: 36.460918ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T06:04:48.926675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.39314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T06:04:48.926825Z","caller":"traceutil/trace.go:171","msg":"trace[696395778] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1441; }","duration":"145.60168ms","start":"2026-04-28T06:04:48.781197Z","end":"2026-04-28T06:04:48.926798Z","steps":["trace[696395778] 'agreement among raft nodes before linearized reading' (duration: 145.341771ms)"],"step_count":1}