{"level":"warn","ts":"2026-04-17T21:07:10.27575Z","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-17T21:07:10.275839Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.116: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.116:2380","--initial-cluster=instance=https://199.204.45.116:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.116:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.116: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-17T21:07:10.275915Z","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-17T21:07:10.275927Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.116:2380"]} {"level":"info","ts":"2026-04-17T21:07:10.275946Z","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-17T21:07:10.276574Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"]} {"level":"info","ts":"2026-04-17T21:07:10.276668Z","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.116:2380"],"listen-peer-urls":["https://199.204.45.116:2380"],"advertise-client-urls":["https://199.204.45.116:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.116: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-17T21:07:10.396042Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"119.153676ms"} {"level":"info","ts":"2026-04-17T21:07:10.690552Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5caa70ef1dd6dc04","cluster-id":"45afccab143d2c82"} {"level":"info","ts":"2026-04-17T21:07:10.690636Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=()"} {"level":"info","ts":"2026-04-17T21:07:10.690655Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became follower at term 0"} {"level":"info","ts":"2026-04-17T21:07:10.690662Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5caa70ef1dd6dc04 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-17T21:07:10.69067Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became follower at term 1"} {"level":"info","ts":"2026-04-17T21:07:10.6907Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=(6677273569830296580)"} {"level":"warn","ts":"2026-04-17T21:07:10.716479Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-17T21:07:10.719412Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-17T21:07:10.721149Z","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-17T21:07:10.724222Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5caa70ef1dd6dc04","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-17T21:07:10.724448Z","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-17T21:07:10.724537Z","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-17T21:07:10.724546Z","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-17T21:07:10.724813Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5caa70ef1dd6dc04","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-17T21:07:10.733979Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=(6677273569830296580)"} {"level":"info","ts":"2026-04-17T21:07:10.734207Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"45afccab143d2c82","local-member-id":"5caa70ef1dd6dc04","added-peer-id":"5caa70ef1dd6dc04","added-peer-peer-urls":["https://199.204.45.116:2380"]} {"level":"info","ts":"2026-04-17T21:07:10.735841Z","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-17T21:07:10.7359Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.116:2380"} {"level":"info","ts":"2026-04-17T21:07:10.735911Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.116:2380"} {"level":"info","ts":"2026-04-17T21:07:10.736901Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5caa70ef1dd6dc04","initial-advertise-peer-urls":["https://199.204.45.116:2380"],"listen-peer-urls":["https://199.204.45.116:2380"],"advertise-client-urls":["https://199.204.45.116:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-17T21:07:10.736965Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-17T21:07:11.498861Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 is starting a new election at term 1"} {"level":"info","ts":"2026-04-17T21:07:11.498907Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-17T21:07:11.498922Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 received MsgPreVoteResp from 5caa70ef1dd6dc04 at term 1"} {"level":"info","ts":"2026-04-17T21:07:11.498934Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became candidate at term 2"} {"level":"info","ts":"2026-04-17T21:07:11.498947Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 received MsgVoteResp from 5caa70ef1dd6dc04 at term 2"} {"level":"info","ts":"2026-04-17T21:07:11.49896Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became leader at term 2"} {"level":"info","ts":"2026-04-17T21:07:11.498967Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5caa70ef1dd6dc04 elected leader 5caa70ef1dd6dc04 at term 2"} {"level":"info","ts":"2026-04-17T21:07:11.49997Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-17T21:07:11.500021Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T21:07:11.500111Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5caa70ef1dd6dc04","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.116:2379]}","request-path":"/0/members/5caa70ef1dd6dc04/attributes","cluster-id":"45afccab143d2c82","publish-timeout":"7s"} {"level":"info","ts":"2026-04-17T21:07:11.500136Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-17T21:07:11.500215Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-17T21:07:11.500336Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-17T21:07:11.500991Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"45afccab143d2c82","local-member-id":"5caa70ef1dd6dc04","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T21:07:11.501116Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T21:07:11.501154Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T21:07:11.501863Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.116:2379"} {"level":"info","ts":"2026-04-17T21:07:11.504177Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-04-17T21:07:16.776578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.749675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T21:07:16.776766Z","caller":"traceutil/trace.go:171","msg":"trace[846289032] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:240; }","duration":"149.033598ms","start":"2026-04-17T21:07:16.627706Z","end":"2026-04-17T21:07:16.776739Z","steps":["trace[846289032] 'range keys from in-memory index tree' (duration: 148.62357ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:07:16.958892Z","caller":"traceutil/trace.go:171","msg":"trace[1291348753] transaction","detail":"{read_only:false; response_revision:248; number_of_response:1; }","duration":"103.58883ms","start":"2026-04-17T21:07:16.855263Z","end":"2026-04-17T21:07:16.958852Z","steps":["trace[1291348753] 'process raft request' (duration: 103.389972ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:07:16.958918Z","caller":"traceutil/trace.go:171","msg":"trace[2086770560] transaction","detail":"{read_only:false; response_revision:247; number_of_response:1; }","duration":"137.927584ms","start":"2026-04-17T21:07:16.820951Z","end":"2026-04-17T21:07:16.958878Z","steps":["trace[2086770560] 'process raft request' (duration: 72.271926ms)","trace[2086770560] 'compare' (duration: 65.143806ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T21:07:17.155142Z","caller":"traceutil/trace.go:171","msg":"trace[106355041] linearizableReadLoop","detail":"{readStateIndex:261; appliedIndex:260; }","duration":"120.29907ms","start":"2026-04-17T21:07:17.034824Z","end":"2026-04-17T21:07:17.155123Z","steps":["trace[106355041] 'read index received' (duration: 106.448474ms)","trace[106355041] 'applied index is now lower than readState.Index' (duration: 13.849826ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T21:07:17.155236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.407824ms","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-17T21:07:17.155254Z","caller":"traceutil/trace.go:171","msg":"trace[2105878532] transaction","detail":"{read_only:false; response_revision:252; number_of_response:1; }","duration":"148.567967ms","start":"2026-04-17T21:07:17.006672Z","end":"2026-04-17T21:07:17.15524Z","steps":["trace[2105878532] 'process raft request' (duration: 134.597726ms)","trace[2105878532] 'compare' (duration: 13.562284ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T21:07:17.155259Z","caller":"traceutil/trace.go:171","msg":"trace[425620729] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:252; }","duration":"120.474528ms","start":"2026-04-17T21:07:17.034777Z","end":"2026-04-17T21:07:17.155251Z","steps":["trace[425620729] 'agreement among raft nodes before linearized reading' (duration: 120.417305ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:07:17.495489Z","caller":"traceutil/trace.go:171","msg":"trace[294161625] transaction","detail":"{read_only:false; number_of_response:0; response_revision:258; }","duration":"174.648059ms","start":"2026-04-17T21:07:17.320799Z","end":"2026-04-17T21:07:17.495447Z","steps":["trace[294161625] 'process raft request' (duration: 173.658127ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:07:17.495624Z","caller":"traceutil/trace.go:171","msg":"trace[82068449] transaction","detail":"{read_only:false; response_revision:259; number_of_response:1; }","duration":"173.888228ms","start":"2026-04-17T21:07:17.321706Z","end":"2026-04-17T21:07:17.495594Z","steps":["trace[82068449] 'process raft request' (duration: 173.681679ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:07:17.495583Z","caller":"traceutil/trace.go:171","msg":"trace[128829071] transaction","detail":"{read_only:false; number_of_response:0; response_revision:258; }","duration":"174.726183ms","start":"2026-04-17T21:07:17.320827Z","end":"2026-04-17T21:07:17.495553Z","steps":["trace[128829071] 'process raft request' (duration: 174.533515ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:07:17.520149Z","caller":"traceutil/trace.go:171","msg":"trace[264274931] transaction","detail":"{read_only:false; response_revision:260; number_of_response:1; }","duration":"163.396657ms","start":"2026-04-17T21:07:17.356697Z","end":"2026-04-17T21:07:17.520094Z","steps":["trace[264274931] 'process raft request' (duration: 163.050152ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:19.270307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.112529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T21:07:19.270408Z","caller":"traceutil/trace.go:171","msg":"trace[520971554] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:0; response_revision:282; }","duration":"152.280126ms","start":"2026-04-17T21:07:19.11811Z","end":"2026-04-17T21:07:19.27039Z","steps":["trace[520971554] 'range keys from in-memory index tree' (duration: 152.032615ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:19.270354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.260087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-17T21:07:19.270748Z","caller":"traceutil/trace.go:171","msg":"trace[296963780] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:282; }","duration":"111.692426ms","start":"2026-04-17T21:07:19.158999Z","end":"2026-04-17T21:07:19.270692Z","steps":["trace[296963780] 'range keys from in-memory index tree' (duration: 111.152112ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:19.532795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.11503ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T21:07:19.533161Z","caller":"traceutil/trace.go:171","msg":"trace[1637820193] transaction","detail":"{read_only:false; response_revision:285; number_of_response:1; }","duration":"170.650269ms","start":"2026-04-17T21:07:19.362432Z","end":"2026-04-17T21:07:19.533082Z","steps":["trace[1637820193] 'process raft request' (duration: 170.556886ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:07:19.533577Z","caller":"traceutil/trace.go:171","msg":"trace[118967164] transaction","detail":"{read_only:false; response_revision:284; number_of_response:1; }","duration":"171.261596ms","start":"2026-04-17T21:07:19.362306Z","end":"2026-04-17T21:07:19.533568Z","steps":["trace[118967164] 'process raft request' (duration: 54.780949ms)","trace[118967164] 'compare' (duration: 114.922512ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T21:07:20.157187Z","caller":"traceutil/trace.go:171","msg":"trace[624811469] transaction","detail":"{read_only:false; response_revision:287; number_of_response:1; }","duration":"549.845928ms","start":"2026-04-17T21:07:19.607315Z","end":"2026-04-17T21:07:20.157161Z","steps":["trace[624811469] 'process raft request' (duration: 516.212276ms)","trace[624811469] 'compare' (duration: 33.529227ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T21:07:20.157338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:19.607303Z","time spent":"549.963902ms","remote":"127.0.0.1:39138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":194,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T21:07:20.387623Z","caller":"traceutil/trace.go:171","msg":"trace[1188267610] linearizableReadLoop","detail":"{readStateIndex:300; appliedIndex:299; }","duration":"135.256126ms","start":"2026-04-17T21:07:20.252332Z","end":"2026-04-17T21:07:20.387589Z","steps":["trace[1188267610] 'read index received' (duration: 76.288839ms)","trace[1188267610] 'applied index is now lower than readState.Index' (duration: 58.965687ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T21:07:20.387731Z","caller":"traceutil/trace.go:171","msg":"trace[742662802] transaction","detail":"{read_only:false; response_revision:289; number_of_response:1; }","duration":"137.685287ms","start":"2026-04-17T21:07:20.25002Z","end":"2026-04-17T21:07:20.387705Z","steps":["trace[742662802] 'process raft request' (duration: 78.617266ms)","trace[742662802] 'compare' (duration: 58.78953ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T21:07:20.387771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.407643ms","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-17T21:07:20.387815Z","caller":"traceutil/trace.go:171","msg":"trace[761389675] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:289; }","duration":"135.486866ms","start":"2026-04-17T21:07:20.252313Z","end":"2026-04-17T21:07:20.3878Z","steps":["trace[761389675] 'agreement among raft nodes before linearized reading' (duration: 135.386232ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:07:29.022058Z","caller":"traceutil/trace.go:171","msg":"trace[161341326] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"150.322201ms","start":"2026-04-17T21:07:28.871707Z","end":"2026-04-17T21:07:29.022029Z","steps":["trace[161341326] 'process raft request' (duration: 150.100032ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:29.493345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.210437ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-17T21:07:29.493486Z","caller":"traceutil/trace.go:171","msg":"trace[1322994424] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"422.710314ms","start":"2026-04-17T21:07:29.070757Z","end":"2026-04-17T21:07:29.493467Z","steps":["trace[1322994424] 'process raft request' (duration: 106.284909ms)","trace[1322994424] 'compare' (duration: 316.060371ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T21:07:29.493541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:29.070737Z","time spent":"422.782577ms","remote":"127.0.0.1:39012","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":680,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T21:07:29.551051Z","caller":"traceutil/trace.go:171","msg":"trace[565714872] linearizableReadLoop","detail":"{readStateIndex:391; appliedIndex:389; }","duration":"144.082192ms","start":"2026-04-17T21:07:29.406951Z","end":"2026-04-17T21:07:29.551033Z","steps":["trace[565714872] 'read index received' (duration: 143.927856ms)","trace[565714872] 'applied index is now lower than readState.Index' (duration: 153.416µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T21:07:29.551098Z","caller":"traceutil/trace.go:171","msg":"trace[1218624203] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"478.895514ms","start":"2026-04-17T21:07:29.072177Z","end":"2026-04-17T21:07:29.551073Z","steps":["trace[1218624203] 'process raft request' (duration: 478.676526ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:07:29.551154Z","caller":"traceutil/trace.go:171","msg":"trace[1503959468] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"477.730979ms","start":"2026-04-17T21:07:29.07339Z","end":"2026-04-17T21:07:29.551121Z","steps":["trace[1503959468] 'process raft request' (duration: 477.600084ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:29.551224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:29.072153Z","time spent":"479.007269ms","remote":"127.0.0.1:48314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4180,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T21:07:29.551191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.249808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-17T21:07:29.551342Z","caller":"traceutil/trace.go:171","msg":"trace[2013907652] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:378; }","duration":"144.498368ms","start":"2026-04-17T21:07:29.406821Z","end":"2026-04-17T21:07:29.55132Z","steps":["trace[2013907652] 'agreement among raft nodes before linearized reading' (duration: 144.278459ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:29.551344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:29.073354Z","time spent":"477.886226ms","remote":"127.0.0.1:39114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3563,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T21:07:29.817842Z","caller":"traceutil/trace.go:171","msg":"trace[1868500174] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"260.981534ms","start":"2026-04-17T21:07:29.556833Z","end":"2026-04-17T21:07:29.817815Z","steps":["trace[1868500174] 'process raft request' (duration: 174.737794ms)","trace[1868500174] 'compare' (duration: 86.029631ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T21:07:29.817873Z","caller":"traceutil/trace.go:171","msg":"trace[1900203968] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"260.833868ms","start":"2026-04-17T21:07:29.557016Z","end":"2026-04-17T21:07:29.81785Z","steps":["trace[1900203968] 'process raft request' (duration: 260.727843ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:07:29.818244Z","caller":"traceutil/trace.go:171","msg":"trace[1522253838] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"260.694392ms","start":"2026-04-17T21:07:29.557527Z","end":"2026-04-17T21:07:29.818222Z","steps":["trace[1522253838] 'process raft request' (duration: 260.286597ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:07:29.818462Z","caller":"traceutil/trace.go:171","msg":"trace[1231556835] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"258.996099ms","start":"2026-04-17T21:07:29.559458Z","end":"2026-04-17T21:07:29.818454Z","steps":["trace[1231556835] 'process raft request' (duration: 258.663286ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:07:29.818679Z","caller":"traceutil/trace.go:171","msg":"trace[2022404649] transaction","detail":"{read_only:false; response_revision:384; number_of_response:1; }","duration":"258.27086ms","start":"2026-04-17T21:07:29.560378Z","end":"2026-04-17T21:07:29.818649Z","steps":["trace[2022404649] 'process raft request' (duration: 258.0106ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:07:29.818847Z","caller":"traceutil/trace.go:171","msg":"trace[18156482] linearizableReadLoop","detail":"{readStateIndex:397; appliedIndex:391; }","duration":"240.178215ms","start":"2026-04-17T21:07:29.578654Z","end":"2026-04-17T21:07:29.818832Z","steps":["trace[18156482] 'read index received' (duration: 4.183559ms)","trace[18156482] 'applied index is now lower than readState.Index' (duration: 235.992756ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T21:07:29.982414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.742144ms","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-17T21:07:29.982645Z","caller":"traceutil/trace.go:171","msg":"trace[1651402579] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:384; }","duration":"404.007965ms","start":"2026-04-17T21:07:29.57861Z","end":"2026-04-17T21:07:29.982618Z","steps":["trace[1651402579] 'agreement among raft nodes before linearized reading' (duration: 240.445196ms)","trace[1651402579] 'range keys from in-memory index tree' (duration: 163.288329ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T21:07:29.982453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.880051ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"warn","ts":"2026-04-17T21:07:29.982899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:29.578587Z","time spent":"404.261484ms","remote":"127.0.0.1:48108","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-17T21:07:30.135543Z","caller":"traceutil/trace.go:171","msg":"trace[520207619] linearizableReadLoop","detail":"{readStateIndex:399; appliedIndex:398; }","duration":"305.792231ms","start":"2026-04-17T21:07:29.82971Z","end":"2026-04-17T21:07:30.135503Z","steps":["trace[520207619] 'read index received' (duration: 305.750539ms)","trace[520207619] 'applied index is now lower than readState.Index' (duration: 40.572µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T21:07:30.135557Z","caller":"traceutil/trace.go:171","msg":"trace[370021221] transaction","detail":"{read_only:false; response_revision:385; number_of_response:1; }","duration":"311.968205ms","start":"2026-04-17T21:07:29.82356Z","end":"2026-04-17T21:07:30.135528Z","steps":["trace[370021221] 'process raft request' (duration: 311.810769ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:30.135683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.945247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/kube-system/coredns-67659f764b\" ","response":"range_response_count:1 size:3810"} {"level":"warn","ts":"2026-04-17T21:07:30.135695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:29.823541Z","time spent":"312.085969ms","remote":"127.0.0.1:39012","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":689,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T21:07:30.135722Z","caller":"traceutil/trace.go:171","msg":"trace[1266821237] range","detail":"{range_begin:/registry/replicasets/kube-system/coredns-67659f764b; range_end:; response_count:1; response_revision:385; }","duration":"306.008869ms","start":"2026-04-17T21:07:29.829705Z","end":"2026-04-17T21:07:30.135713Z","steps":["trace[1266821237] 'agreement among raft nodes before linearized reading' (duration: 305.891255ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:30.135748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:29.829657Z","time spent":"306.087152ms","remote":"127.0.0.1:48346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":3832,"request content":"key:\"/registry/replicasets/kube-system/coredns-67659f764b\" "} {"level":"info","ts":"2026-04-17T21:07:30.160418Z","caller":"traceutil/trace.go:171","msg":"trace[434155142] transaction","detail":"{read_only:false; response_revision:386; number_of_response:1; }","duration":"173.354412ms","start":"2026-04-17T21:07:29.987032Z","end":"2026-04-17T21:07:30.160387Z","steps":["trace[434155142] 'process raft request' (duration: 173.222047ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:30.160488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.689532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-z64f7\" ","response":"range_response_count:1 size:4016"} {"level":"info","ts":"2026-04-17T21:07:30.160561Z","caller":"traceutil/trace.go:171","msg":"trace[2082109438] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-z64f7; range_end:; response_count:1; response_revision:386; }","duration":"174.819297ms","start":"2026-04-17T21:07:29.985722Z","end":"2026-04-17T21:07:30.160541Z","steps":["trace[2082109438] 'agreement among raft nodes before linearized reading' (duration: 174.676312ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:30.160827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.008868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4195"} {"level":"info","ts":"2026-04-17T21:07:30.160868Z","caller":"traceutil/trace.go:171","msg":"trace[720783298] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:386; }","duration":"331.062929ms","start":"2026-04-17T21:07:29.829796Z","end":"2026-04-17T21:07:30.160859Z","steps":["trace[720783298] 'agreement among raft nodes before linearized reading' (duration: 330.981416ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:30.160897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:29.829791Z","time spent":"331.09772ms","remote":"127.0.0.1:48314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":4217,"request content":"key:\"/registry/deployments/kube-system/coredns\" "} {"level":"info","ts":"2026-04-17T21:07:30.303227Z","caller":"traceutil/trace.go:171","msg":"trace[823693915] transaction","detail":"{read_only:false; response_revision:387; number_of_response:1; }","duration":"140.18142ms","start":"2026-04-17T21:07:30.163012Z","end":"2026-04-17T21:07:30.303193Z","steps":["trace[823693915] 'process raft request' (duration: 124.705789ms)","trace[823693915] 'compare' (duration: 15.335716ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T21:07:30.332994Z","caller":"traceutil/trace.go:171","msg":"trace[1876107379] transaction","detail":"{read_only:false; response_revision:388; number_of_response:1; }","duration":"166.923343ms","start":"2026-04-17T21:07:30.166046Z","end":"2026-04-17T21:07:30.33297Z","steps":["trace[1876107379] 'process raft request' (duration: 166.627532ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:07:30.332999Z","caller":"traceutil/trace.go:171","msg":"trace[787205067] transaction","detail":"{read_only:false; number_of_response:1; response_revision:388; }","duration":"164.304104ms","start":"2026-04-17T21:07:30.168663Z","end":"2026-04-17T21:07:30.332967Z","steps":["trace[787205067] 'process raft request' (duration: 164.240442ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:30.6314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.562567ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T21:07:30.6317Z","caller":"traceutil/trace.go:171","msg":"trace[1239500957] transaction","detail":"{read_only:false; response_revision:393; number_of_response:1; }","duration":"271.380033ms","start":"2026-04-17T21:07:30.360292Z","end":"2026-04-17T21:07:30.631672Z","steps":["trace[1239500957] 'process raft request' (duration: 123.428431ms)","trace[1239500957] 'compare' (duration: 147.439623ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T21:07:30.631758Z","caller":"traceutil/trace.go:171","msg":"trace[790056238] linearizableReadLoop","detail":"{readStateIndex:411; appliedIndex:407; }","duration":"194.859372ms","start":"2026-04-17T21:07:30.436881Z","end":"2026-04-17T21:07:30.63174Z","steps":["trace[790056238] 'read index received' (duration: 46.858989ms)","trace[790056238] 'applied index is now lower than readState.Index' (duration: 147.999353ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T21:07:30.631871Z","caller":"traceutil/trace.go:171","msg":"trace[1001531076] transaction","detail":"{read_only:false; response_revision:394; number_of_response:1; }","duration":"269.102667ms","start":"2026-04-17T21:07:30.362723Z","end":"2026-04-17T21:07:30.631826Z","steps":["trace[1001531076] 'process raft request' (duration: 268.875439ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:07:30.631908Z","caller":"traceutil/trace.go:171","msg":"trace[553272257] transaction","detail":"{read_only:false; response_revision:396; number_of_response:1; }","duration":"266.597193ms","start":"2026-04-17T21:07:30.365265Z","end":"2026-04-17T21:07:30.631862Z","steps":["trace[553272257] 'process raft request' (duration: 266.430727ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:07:30.631886Z","caller":"traceutil/trace.go:171","msg":"trace[1296314526] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"268.945412ms","start":"2026-04-17T21:07:30.362833Z","end":"2026-04-17T21:07:30.631779Z","steps":["trace[1296314526] 'process raft request' (duration: 268.816777ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:30.631971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.07247ms","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-17T21:07:30.632023Z","caller":"traceutil/trace.go:171","msg":"trace[1306925516] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:396; }","duration":"195.160133ms","start":"2026-04-17T21:07:30.436848Z","end":"2026-04-17T21:07:30.632008Z","steps":["trace[1306925516] 'agreement among raft nodes before linearized reading' (duration: 195.019168ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:31.029228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.94468ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-17T21:07:31.02935Z","caller":"traceutil/trace.go:171","msg":"trace[376348863] transaction","detail":"{read_only:false; response_revision:397; number_of_response:1; }","duration":"391.628315ms","start":"2026-04-17T21:07:30.637702Z","end":"2026-04-17T21:07:31.02933Z","steps":["trace[376348863] 'process raft request' (duration: 238.505579ms)","trace[376348863] 'compare' (duration: 152.754763ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T21:07:31.029437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:30.637688Z","time spent":"391.725849ms","remote":"127.0.0.1:39012","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":830,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T21:07:31.048505Z","caller":"traceutil/trace.go:171","msg":"trace[1647634099] transaction","detail":"{read_only:false; response_revision:398; number_of_response:1; }","duration":"409.428695ms","start":"2026-04-17T21:07:30.639061Z","end":"2026-04-17T21:07:31.04849Z","steps":["trace[1647634099] 'process raft request' (duration: 409.263179ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:31.048606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:30.639008Z","time spent":"409.54858ms","remote":"127.0.0.1:48108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T21:07:31.048969Z","caller":"traceutil/trace.go:171","msg":"trace[1263985970] transaction","detail":"{read_only:false; response_revision:399; number_of_response:1; }","duration":"409.079883ms","start":"2026-04-17T21:07:30.639857Z","end":"2026-04-17T21:07:31.048937Z","steps":["trace[1263985970] 'process raft request' (duration: 408.578084ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:07:31.049107Z","caller":"traceutil/trace.go:171","msg":"trace[232690185] transaction","detail":"{read_only:false; response_revision:400; number_of_response:1; }","duration":"408.617455ms","start":"2026-04-17T21:07:30.640463Z","end":"2026-04-17T21:07:31.04908Z","steps":["trace[232690185] 'process raft request' (duration: 408.379896ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:31.049141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:30.639845Z","time spent":"409.208507ms","remote":"127.0.0.1:39114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4037,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T21:07:31.049262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:30.640449Z","time spent":"408.706819ms","remote":"127.0.0.1:39012","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T21:07:31.049449Z","caller":"traceutil/trace.go:171","msg":"trace[1501319672] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"407.763223ms","start":"2026-04-17T21:07:30.641666Z","end":"2026-04-17T21:07:31.049429Z","steps":["trace[1501319672] 'process raft request' (duration: 407.250554ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:07:31.049533Z","caller":"traceutil/trace.go:171","msg":"trace[1440811803] transaction","detail":"{read_only:false; response_revision:402; number_of_response:1; }","duration":"406.996994ms","start":"2026-04-17T21:07:30.642509Z","end":"2026-04-17T21:07:31.049506Z","steps":["trace[1440811803] 'process raft request' (duration: 406.485245ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:07:31.049547Z","caller":"traceutil/trace.go:171","msg":"trace[1580543946] transaction","detail":"{read_only:false; response_revision:403; number_of_response:1; }","duration":"406.472645ms","start":"2026-04-17T21:07:30.643067Z","end":"2026-04-17T21:07:31.049539Z","steps":["trace[1580543946] 'process raft request' (duration: 405.975487ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:31.049544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:30.641657Z","time spent":"407.837185ms","remote":"127.0.0.1:48346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3804,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T21:07:31.049589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:30.643057Z","time spent":"406.508676ms","remote":"127.0.0.1:48314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4180,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T21:07:31.049599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:30.64249Z","time spent":"407.075577ms","remote":"127.0.0.1:48346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3840,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T21:07:31.375961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.867154ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T21:07:31.376113Z","caller":"traceutil/trace.go:171","msg":"trace[1613554082] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"317.640628ms","start":"2026-04-17T21:07:31.058449Z","end":"2026-04-17T21:07:31.376089Z","steps":["trace[1613554082] 'process raft request' (duration: 194.509115ms)","trace[1613554082] 'compare' (duration: 122.707467ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T21:07:31.376188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:31.058423Z","time spent":"317.734511ms","remote":"127.0.0.1:48314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4180,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T21:07:31.431443Z","caller":"traceutil/trace.go:171","msg":"trace[516698649] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"369.597046ms","start":"2026-04-17T21:07:31.061806Z","end":"2026-04-17T21:07:31.431403Z","steps":["trace[516698649] 'process raft request' (duration: 369.521964ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:31.432026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:31.061796Z","time spent":"369.765073ms","remote":"127.0.0.1:48108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T21:07:31.432705Z","caller":"traceutil/trace.go:171","msg":"trace[1897526777] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"372.428343ms","start":"2026-04-17T21:07:31.060262Z","end":"2026-04-17T21:07:31.43269Z","steps":["trace[1897526777] 'process raft request' (duration: 370.876905ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:31.432958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:31.060253Z","time spent":"372.496435ms","remote":"127.0.0.1:48346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3840,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T21:07:31.625805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.795439ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T21:07:31.625981Z","caller":"traceutil/trace.go:171","msg":"trace[474971321] transaction","detail":"{read_only:false; response_revision:407; number_of_response:1; }","duration":"184.533084ms","start":"2026-04-17T21:07:31.441395Z","end":"2026-04-17T21:07:31.625928Z","steps":["trace[474971321] 'process raft request' (duration: 50.493026ms)","trace[474971321] 'compare' (duration: 133.575851ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T21:07:32.50776Z","caller":"traceutil/trace.go:171","msg":"trace[1248281122] transaction","detail":"{read_only:false; response_revision:409; number_of_response:1; }","duration":"337.629174ms","start":"2026-04-17T21:07:32.17011Z","end":"2026-04-17T21:07:32.507739Z","steps":["trace[1248281122] 'process raft request' (duration: 337.53036ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:32.507874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:32.170068Z","time spent":"337.749298ms","remote":"127.0.0.1:48108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T21:07:32.837282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.096228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T21:07:32.837403Z","caller":"traceutil/trace.go:171","msg":"trace[528084260] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:409; }","duration":"215.244662ms","start":"2026-04-17T21:07:32.622099Z","end":"2026-04-17T21:07:32.837344Z","steps":["trace[528084260] 'range keys from in-memory index tree' (duration: 214.949452ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:07:37.364836Z","caller":"traceutil/trace.go:171","msg":"trace[1109887741] transaction","detail":"{read_only:false; response_revision:421; number_of_response:1; }","duration":"287.840658ms","start":"2026-04-17T21:07:37.07697Z","end":"2026-04-17T21:07:37.36481Z","steps":["trace[1109887741] 'process raft request' (duration: 287.61371ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:38.130203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.678805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T21:07:38.130297Z","caller":"traceutil/trace.go:171","msg":"trace[585076217] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:421; }","duration":"509.821451ms","start":"2026-04-17T21:07:37.620447Z","end":"2026-04-17T21:07:38.130269Z","steps":["trace[585076217] 'range keys from in-memory index tree' (duration: 509.591483ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:38.130343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:37.620427Z","time spent":"509.907363ms","remote":"127.0.0.1:38928","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-17T21:07:38.130551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"674.867833ms","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-17T21:07:38.130627Z","caller":"traceutil/trace.go:171","msg":"trace[1618368787] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:421; }","duration":"674.977697ms","start":"2026-04-17T21:07:37.455628Z","end":"2026-04-17T21:07:38.130606Z","steps":["trace[1618368787] 'range keys from in-memory index tree' (duration: 674.716169ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:38.130668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:37.455614Z","time spent":"675.04453ms","remote":"127.0.0.1:48108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-17T21:07:38.130709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.893703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-17T21:07:38.130793Z","caller":"traceutil/trace.go:171","msg":"trace[367279149] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:421; }","duration":"269.009917ms","start":"2026-04-17T21:07:37.861761Z","end":"2026-04-17T21:07:38.130771Z","steps":["trace[367279149] 'range keys from in-memory index tree' (duration: 268.80336ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:43.136293Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15853969887042137364,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-17T21:07:43.428152Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.268726708s","expected-duration":"1s"} {"level":"info","ts":"2026-04-17T21:07:43.428641Z","caller":"traceutil/trace.go:171","msg":"trace[650712338] transaction","detail":"{read_only:false; response_revision:463; number_of_response:1; }","duration":"1.269251385s","start":"2026-04-17T21:07:42.159318Z","end":"2026-04-17T21:07:43.42857Z","steps":["trace[650712338] 'process raft request' (duration: 1.269082729s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:43.428805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:42.159296Z","time spent":"1.269427801s","remote":"127.0.0.1:48108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T21:07:43.535125Z","caller":"traceutil/trace.go:171","msg":"trace[80808105] linearizableReadLoop","detail":"{readStateIndex:482; appliedIndex:479; }","duration":"899.551671ms","start":"2026-04-17T21:07:42.635549Z","end":"2026-04-17T21:07:43.535101Z","steps":["trace[80808105] 'read index received' (duration: 792.858289ms)","trace[80808105] 'applied index is now lower than readState.Index' (duration: 106.692372ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T21:07:43.535217Z","caller":"traceutil/trace.go:171","msg":"trace[172073271] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"974.775288ms","start":"2026-04-17T21:07:42.560433Z","end":"2026-04-17T21:07:43.535208Z","steps":["trace[172073271] 'process raft request' (duration: 974.619853ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:07:43.535155Z","caller":"traceutil/trace.go:171","msg":"trace[813940943] transaction","detail":"{read_only:false; response_revision:464; number_of_response:1; }","duration":"1.374918983s","start":"2026-04-17T21:07:42.160208Z","end":"2026-04-17T21:07:43.535127Z","steps":["trace[813940943] 'process raft request' (duration: 1.360910011s)","trace[813940943] 'compare' (duration: 13.825356ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T21:07:43.535309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:42.56041Z","time spent":"974.84072ms","remote":"127.0.0.1:39012","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":828,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-17T21:07:43.535321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:42.16019Z","time spent":"1.375061038s","remote":"127.0.0.1:48108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T21:07:43.535307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"899.728857ms","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-17T21:07:43.535382Z","caller":"traceutil/trace.go:171","msg":"trace[1123360125] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:465; }","duration":"899.81983ms","start":"2026-04-17T21:07:42.635544Z","end":"2026-04-17T21:07:43.535363Z","steps":["trace[1123360125] 'agreement among raft nodes before linearized reading' (duration: 899.688606ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:43.53541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"895.506286ms","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-17T21:07:43.535429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:42.635488Z","time spent":"899.931734ms","remote":"127.0.0.1:39022","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":27,"request content":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" "} {"level":"info","ts":"2026-04-17T21:07:43.535449Z","caller":"traceutil/trace.go:171","msg":"trace[1318326985] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:465; }","duration":"895.570287ms","start":"2026-04-17T21:07:42.639868Z","end":"2026-04-17T21:07:43.535438Z","steps":["trace[1318326985] 'agreement among raft nodes before linearized reading' (duration: 895.482244ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:43.535461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.95902ms","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-17T21:07:43.535471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:42.639853Z","time spent":"895.613079ms","remote":"127.0.0.1:48108","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-17T21:07:43.535508Z","caller":"traceutil/trace.go:171","msg":"trace[1005481356] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:465; }","duration":"150.051033ms","start":"2026-04-17T21:07:43.38544Z","end":"2026-04-17T21:07:43.535491Z","steps":["trace[1005481356] 'agreement among raft nodes before linearized reading' (duration: 149.95813ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:07:44.483408Z","caller":"traceutil/trace.go:171","msg":"trace[1056924550] transaction","detail":"{read_only:false; number_of_response:1; response_revision:519; }","duration":"284.789173ms","start":"2026-04-17T21:07:44.198579Z","end":"2026-04-17T21:07:44.483368Z","steps":["trace[1056924550] 'process raft request' (duration: 276.44442ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:07:44.483685Z","caller":"traceutil/trace.go:171","msg":"trace[657941555] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"243.528093ms","start":"2026-04-17T21:07:44.240133Z","end":"2026-04-17T21:07:44.483661Z","steps":["trace[657941555] 'process raft request' (duration: 243.297536ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:07:44.483737Z","caller":"traceutil/trace.go:171","msg":"trace[1479967921] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"243.558574ms","start":"2026-04-17T21:07:44.240158Z","end":"2026-04-17T21:07:44.483717Z","steps":["trace[1479967921] 'process raft request' (duration: 243.075498ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:45.932984Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15853969887042137447,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-17T21:07:46.259441Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.629257858s","expected-duration":"1s"} {"level":"info","ts":"2026-04-17T21:07:46.260003Z","caller":"traceutil/trace.go:171","msg":"trace[1866586900] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"1.629968891s","start":"2026-04-17T21:07:44.630006Z","end":"2026-04-17T21:07:46.259975Z","steps":["trace[1866586900] 'process raft request' (duration: 1.629773885s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:46.26015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:44.629982Z","time spent":"1.630104625s","remote":"127.0.0.1:38984","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":73770,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T21:07:46.273923Z","caller":"traceutil/trace.go:171","msg":"trace[904088935] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"1.641065915s","start":"2026-04-17T21:07:44.632828Z","end":"2026-04-17T21:07:46.273893Z","steps":["trace[904088935] 'process raft request' (duration: 1.640794997s)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:07:46.273958Z","caller":"traceutil/trace.go:171","msg":"trace[2066851079] linearizableReadLoop","detail":"{readStateIndex:552; appliedIndex:549; }","duration":"841.203101ms","start":"2026-04-17T21:07:45.432732Z","end":"2026-04-17T21:07:46.273935Z","steps":["trace[2066851079] 'read index received' (duration: 827.093439ms)","trace[2066851079] 'applied index is now lower than readState.Index' (duration: 14.108562ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T21:07:46.274069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:44.63281Z","time spent":"1.641181629s","remote":"127.0.0.1:38984","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":98698,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T21:07:46.274154Z","caller":"traceutil/trace.go:171","msg":"trace[1950579096] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"1.609892956s","start":"2026-04-17T21:07:44.664189Z","end":"2026-04-17T21:07:46.274082Z","steps":["trace[1950579096] 'process raft request' (duration: 1.609613677s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:46.274302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"729.218873ms","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-17T21:07:46.274311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"734.039348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-17T21:07:46.274343Z","caller":"traceutil/trace.go:171","msg":"trace[1408909660] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:529; }","duration":"729.285554ms","start":"2026-04-17T21:07:45.545047Z","end":"2026-04-17T21:07:46.274333Z","steps":["trace[1408909660] 'agreement among raft nodes before linearized reading' (duration: 729.173281ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:07:46.274355Z","caller":"traceutil/trace.go:171","msg":"trace[527930519] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:529; }","duration":"734.110161ms","start":"2026-04-17T21:07:45.540229Z","end":"2026-04-17T21:07:46.274339Z","steps":["trace[527930519] 'agreement among raft nodes before linearized reading' (duration: 733.975437ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:46.274339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"725.492852ms","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-17T21:07:46.274414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"653.896463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T21:07:46.274441Z","caller":"traceutil/trace.go:171","msg":"trace[1786502080] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:529; }","duration":"653.952765ms","start":"2026-04-17T21:07:45.62048Z","end":"2026-04-17T21:07:46.274433Z","steps":["trace[1786502080] 'agreement among raft nodes before linearized reading' (duration: 653.916274ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:46.274464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:45.620459Z","time spent":"653.999146ms","remote":"127.0.0.1:38928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-17T21:07:46.274467Z","caller":"traceutil/trace.go:171","msg":"trace[1726378837] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:529; }","duration":"725.623936ms","start":"2026-04-17T21:07:45.548806Z","end":"2026-04-17T21:07:46.27443Z","steps":["trace[1726378837] 'agreement among raft nodes before linearized reading' (duration: 725.410119ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:46.274428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"841.597003ms","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-17T21:07:46.274559Z","caller":"traceutil/trace.go:171","msg":"trace[1336675261] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:529; }","duration":"841.864122ms","start":"2026-04-17T21:07:45.432682Z","end":"2026-04-17T21:07:46.274546Z","steps":["trace[1336675261] 'agreement among raft nodes before linearized reading' (duration: 841.49077ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:46.274633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:45.432663Z","time spent":"841.957415ms","remote":"127.0.0.1:48108","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-17T21:07:46.274508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:45.548795Z","time spent":"725.703408ms","remote":"127.0.0.1:48108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-17T21:07:46.274375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:45.545032Z","time spent":"729.336876ms","remote":"127.0.0.1:48108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-17T21:07:46.274364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:44.664167Z","time spent":"1.610072792s","remote":"127.0.0.1:38984","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":151212,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T21:07:46.274378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:45.540209Z","time spent":"734.163162ms","remote":"127.0.0.1:48108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-17T21:07:47.531677Z","caller":"traceutil/trace.go:171","msg":"trace[898566070] linearizableReadLoop","detail":"{readStateIndex:571; appliedIndex:570; }","duration":"421.814243ms","start":"2026-04-17T21:07:47.10984Z","end":"2026-04-17T21:07:47.531654Z","steps":["trace[898566070] 'read index received' (duration: 421.40223ms)","trace[898566070] 'applied index is now lower than readState.Index' (duration: 410.953µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T21:07:47.531738Z","caller":"traceutil/trace.go:171","msg":"trace[149954889] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"467.034331ms","start":"2026-04-17T21:07:47.064674Z","end":"2026-04-17T21:07:47.531708Z","steps":["trace[149954889] 'process raft request' (duration: 466.622948ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:47.531864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.00383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:7708"} {"level":"info","ts":"2026-04-17T21:07:47.531898Z","caller":"traceutil/trace.go:171","msg":"trace[1314075195] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:548; }","duration":"422.084982ms","start":"2026-04-17T21:07:47.109802Z","end":"2026-04-17T21:07:47.531887Z","steps":["trace[1314075195] 'agreement among raft nodes before linearized reading' (duration: 421.942358ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:47.531891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:47.064618Z","time spent":"467.188566ms","remote":"127.0.0.1:38984","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570090,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T21:07:47.531937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:47.109782Z","time spent":"422.146364ms","remote":"127.0.0.1:38984","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":1,"response size":7730,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io\" "} {"level":"info","ts":"2026-04-17T21:07:47.633672Z","caller":"traceutil/trace.go:171","msg":"trace[268813929] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"481.872713ms","start":"2026-04-17T21:07:47.151757Z","end":"2026-04-17T21:07:47.633629Z","steps":["trace[268813929] 'process raft request' (duration: 477.457613ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:47.637019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:47.151737Z","time spent":"485.184618ms","remote":"127.0.0.1:38984","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":208461,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T21:07:50.131515Z","caller":"traceutil/trace.go:171","msg":"trace[1266419264] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"244.140727ms","start":"2026-04-17T21:07:49.887355Z","end":"2026-04-17T21:07:50.131496Z","steps":["trace[1266419264] 'process raft request' (duration: 243.794826ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:50.589171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.743146ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-17T21:07:50.589274Z","caller":"traceutil/trace.go:171","msg":"trace[1707101437] linearizableReadLoop","detail":"{readStateIndex:585; appliedIndex:584; }","duration":"276.493754ms","start":"2026-04-17T21:07:50.312764Z","end":"2026-04-17T21:07:50.589258Z","steps":["trace[1707101437] 'read index received' (duration: 26.598693ms)","trace[1707101437] 'applied index is now lower than readState.Index' (duration: 249.893771ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T21:07:50.589419Z","caller":"traceutil/trace.go:171","msg":"trace[178961971] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"405.845297ms","start":"2026-04-17T21:07:50.183503Z","end":"2026-04-17T21:07:50.589348Z","steps":["trace[178961971] 'process raft request' (duration: 155.859653ms)","trace[178961971] 'compare' (duration: 249.583322ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T21:07:50.589781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.071518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-17T21:07:50.589826Z","caller":"traceutil/trace.go:171","msg":"trace[704526691] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:561; }","duration":"273.14796ms","start":"2026-04-17T21:07:50.316667Z","end":"2026-04-17T21:07:50.589815Z","steps":["trace[704526691] 'agreement among raft nodes before linearized reading' (duration: 272.937984ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:50.589764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:50.183478Z","time spent":"406.039242ms","remote":"127.0.0.1:39138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":818,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-17T21:07:50.589838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.205705ms","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-17T21:07:50.589985Z","caller":"traceutil/trace.go:171","msg":"trace[148066661] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:561; }","duration":"276.37343ms","start":"2026-04-17T21:07:50.313599Z","end":"2026-04-17T21:07:50.589972Z","steps":["trace[148066661] 'agreement among raft nodes before linearized reading' (duration: 275.967518ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:50.589783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.035439ms","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-17T21:07:50.590281Z","caller":"traceutil/trace.go:171","msg":"trace[1473616125] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:561; }","duration":"275.529495ms","start":"2026-04-17T21:07:50.314731Z","end":"2026-04-17T21:07:50.59026Z","steps":["trace[1473616125] 'agreement among raft nodes before linearized reading' (duration: 274.917385ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:50.590361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.575589ms","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-17T21:07:50.590448Z","caller":"traceutil/trace.go:171","msg":"trace[1076964532] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:561; }","duration":"277.733204ms","start":"2026-04-17T21:07:50.312692Z","end":"2026-04-17T21:07:50.590425Z","steps":["trace[1076964532] 'agreement among raft nodes before linearized reading' (duration: 277.455764ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:07:50.835634Z","caller":"traceutil/trace.go:171","msg":"trace[2034087714] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"240.873812ms","start":"2026-04-17T21:07:50.594729Z","end":"2026-04-17T21:07:50.835603Z","steps":["trace[2034087714] 'process raft request' (duration: 240.78761ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:50.835967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.762353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T21:07:50.836033Z","caller":"traceutil/trace.go:171","msg":"trace[711668941] range","detail":"{range_begin:/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:565; }","duration":"234.877047ms","start":"2026-04-17T21:07:50.60114Z","end":"2026-04-17T21:07:50.836017Z","steps":["trace[711668941] 'agreement among raft nodes before linearized reading' (duration: 234.748533ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:07:50.835688Z","caller":"traceutil/trace.go:171","msg":"trace[1065139512] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"240.923673ms","start":"2026-04-17T21:07:50.594715Z","end":"2026-04-17T21:07:50.835639Z","steps":["trace[1065139512] 'process raft request' (duration: 205.305361ms)","trace[1065139512] 'compare' (duration: 35.298013ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T21:07:50.835823Z","caller":"traceutil/trace.go:171","msg":"trace[2137370454] linearizableReadLoop","detail":"{readStateIndex:589; appliedIndex:585; }","duration":"234.603378ms","start":"2026-04-17T21:07:50.601187Z","end":"2026-04-17T21:07:50.83579Z","steps":["trace[2137370454] 'read index received' (duration: 79.800979ms)","trace[2137370454] 'applied index is now lower than readState.Index' (duration: 154.799609ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T21:07:50.835911Z","caller":"traceutil/trace.go:171","msg":"trace[1143842391] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"239.958253ms","start":"2026-04-17T21:07:50.595931Z","end":"2026-04-17T21:07:50.835889Z","steps":["trace[1143842391] 'process raft request' (duration: 239.630783ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:50.836813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.115555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T21:07:50.836866Z","caller":"traceutil/trace.go:171","msg":"trace[2027130370] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:565; }","duration":"214.227959ms","start":"2026-04-17T21:07:50.622625Z","end":"2026-04-17T21:07:50.836853Z","steps":["trace[2027130370] 'agreement among raft nodes before linearized reading' (duration: 214.137466ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:07:51.512838Z","caller":"traceutil/trace.go:171","msg":"trace[424885356] linearizableReadLoop","detail":"{readStateIndex:590; appliedIndex:589; }","duration":"197.104114ms","start":"2026-04-17T21:07:51.315711Z","end":"2026-04-17T21:07:51.512815Z","steps":["trace[424885356] 'read index received' (duration: 196.31858ms)","trace[424885356] 'applied index is now lower than readState.Index' (duration: 784.644µs)"],"step_count":2} {"level":"warn","ts":"2026-04-17T21:07:51.513095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.32876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T21:07:51.513198Z","caller":"traceutil/trace.go:171","msg":"trace[1269281857] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:566; }","duration":"197.503256ms","start":"2026-04-17T21:07:51.315674Z","end":"2026-04-17T21:07:51.513178Z","steps":["trace[1269281857] 'agreement among raft nodes before linearized reading' (duration: 197.293119ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:51.513291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.512497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T21:07:51.513416Z","caller":"traceutil/trace.go:171","msg":"trace[676341765] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:566; }","duration":"197.702572ms","start":"2026-04-17T21:07:51.315691Z","end":"2026-04-17T21:07:51.513393Z","steps":["trace[676341765] 'agreement among raft nodes before linearized reading' (duration: 197.496046ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:07:51.512962Z","caller":"traceutil/trace.go:171","msg":"trace[321990922] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"213.150985ms","start":"2026-04-17T21:07:51.299774Z","end":"2026-04-17T21:07:51.512925Z","steps":["trace[321990922] 'process raft request' (duration: 212.536556ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:51.51369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.982106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T21:07:51.5141Z","caller":"traceutil/trace.go:171","msg":"trace[277297129] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:566; }","duration":"177.41511ms","start":"2026-04-17T21:07:51.336652Z","end":"2026-04-17T21:07:51.514067Z","steps":["trace[277297129] 'agreement among raft nodes before linearized reading' (duration: 176.968686ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:51.513772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.699108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T21:07:51.514232Z","caller":"traceutil/trace.go:171","msg":"trace[725843287] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:566; }","duration":"178.169503ms","start":"2026-04-17T21:07:51.336031Z","end":"2026-04-17T21:07:51.514201Z","steps":["trace[725843287] 'agreement among raft nodes before linearized reading' (duration: 177.697109ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:51.513831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.794971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T21:07:51.514394Z","caller":"traceutil/trace.go:171","msg":"trace[2045370267] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:566; }","duration":"178.389519ms","start":"2026-04-17T21:07:51.335993Z","end":"2026-04-17T21:07:51.514383Z","steps":["trace[2045370267] 'agreement among raft nodes before linearized reading' (duration: 177.808552ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:51.513899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.66387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T21:07:51.514482Z","caller":"traceutil/trace.go:171","msg":"trace[1031745433] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:566; }","duration":"198.248528ms","start":"2026-04-17T21:07:51.316222Z","end":"2026-04-17T21:07:51.514471Z","steps":["trace[1031745433] 'agreement among raft nodes before linearized reading' (duration: 197.64665ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:07:51.687018Z","caller":"traceutil/trace.go:171","msg":"trace[253313985] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"118.696659ms","start":"2026-04-17T21:07:51.56825Z","end":"2026-04-17T21:07:51.686947Z","steps":["trace[253313985] 'process raft request' (duration: 28.376089ms)","trace[253313985] 'compare' (duration: 89.99882ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T21:07:54.515986Z","caller":"traceutil/trace.go:171","msg":"trace[443762706] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"439.463309ms","start":"2026-04-17T21:07:54.076479Z","end":"2026-04-17T21:07:54.515942Z","steps":["trace[443762706] 'process raft request' (duration: 380.724086ms)","trace[443762706] 'compare' (duration: 58.560438ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T21:07:54.516174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:54.076459Z","time spent":"439.631594ms","remote":"127.0.0.1:48108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T21:07:54.932823Z","caller":"traceutil/trace.go:171","msg":"trace[1684169243] linearizableReadLoop","detail":"{readStateIndex:608; appliedIndex:606; }","duration":"518.056445ms","start":"2026-04-17T21:07:54.414738Z","end":"2026-04-17T21:07:54.932795Z","steps":["trace[1684169243] 'read index received' (duration: 42.651423ms)","trace[1684169243] 'applied index is now lower than readState.Index' (duration: 475.403702ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T21:07:54.933074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.316173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-77tpx\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-17T21:07:54.933115Z","caller":"traceutil/trace.go:171","msg":"trace[904654127] range","detail":"{range_begin:/registry/pods/kube-system/cilium-77tpx; range_end:; response_count:1; response_revision:584; }","duration":"518.404796ms","start":"2026-04-17T21:07:54.414698Z","end":"2026-04-17T21:07:54.933103Z","steps":["trace[904654127] 'agreement among raft nodes before linearized reading' (duration: 518.238821ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:54.933152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:54.414681Z","time spent":"518.462318ms","remote":"127.0.0.1:39114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-77tpx\" "} {"level":"info","ts":"2026-04-17T21:07:54.932923Z","caller":"traceutil/trace.go:171","msg":"trace[289930883] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"827.474972ms","start":"2026-04-17T21:07:54.10541Z","end":"2026-04-17T21:07:54.932885Z","steps":["trace[289930883] 'process raft request' (duration: 826.038089ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:54.933431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.533862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-17T21:07:54.933599Z","caller":"traceutil/trace.go:171","msg":"trace[904516580] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:584; }","duration":"239.718867ms","start":"2026-04-17T21:07:54.693806Z","end":"2026-04-17T21:07:54.933525Z","steps":["trace[904516580] 'agreement among raft nodes before linearized reading' (duration: 239.299935ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:54.933652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.557504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.116\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-17T21:07:54.93379Z","caller":"traceutil/trace.go:171","msg":"trace[1996783291] range","detail":"{range_begin:/registry/masterleases/199.204.45.116; range_end:; response_count:1; response_revision:584; }","duration":"353.703158ms","start":"2026-04-17T21:07:54.580028Z","end":"2026-04-17T21:07:54.933731Z","steps":["trace[1996783291] 'agreement among raft nodes before linearized reading' (duration: 352.996387ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:54.933859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:54.580007Z","time spent":"353.841633ms","remote":"127.0.0.1:38970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.116\" "} {"level":"warn","ts":"2026-04-17T21:07:54.93386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:54.10538Z","time spent":"828.128741ms","remote":"127.0.0.1:39022","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T21:07:55.077455Z","caller":"traceutil/trace.go:171","msg":"trace[1739293382] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"137.742953ms","start":"2026-04-17T21:07:54.939684Z","end":"2026-04-17T21:07:55.077427Z","steps":["trace[1739293382] 'process raft request' (duration: 137.399343ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:07:55.077797Z","caller":"traceutil/trace.go:171","msg":"trace[1761670012] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"137.513076ms","start":"2026-04-17T21:07:54.940256Z","end":"2026-04-17T21:07:55.077769Z","steps":["trace[1761670012] 'process raft request' (duration: 137.094364ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:07:55.078121Z","caller":"traceutil/trace.go:171","msg":"trace[389023972] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"136.429214ms","start":"2026-04-17T21:07:54.941647Z","end":"2026-04-17T21:07:55.078076Z","steps":["trace[389023972] 'process raft request' (duration: 136.010861ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:07:55.07844Z","caller":"traceutil/trace.go:171","msg":"trace[513947306] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"135.784605ms","start":"2026-04-17T21:07:54.942642Z","end":"2026-04-17T21:07:55.078427Z","steps":["trace[513947306] 'process raft request' (duration: 135.419665ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:07:55.07847Z","caller":"traceutil/trace.go:171","msg":"trace[1301655151] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"127.93496ms","start":"2026-04-17T21:07:54.9505Z","end":"2026-04-17T21:07:55.078435Z","steps":["trace[1301655151] 'process raft request' (duration: 127.759135ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:56.122943Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15853969887042137627,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-17T21:07:56.158004Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.080823105s","expected-duration":"1s"} {"level":"info","ts":"2026-04-17T21:07:56.1584Z","caller":"traceutil/trace.go:171","msg":"trace[1119975877] linearizableReadLoop","detail":"{readStateIndex:616; appliedIndex:614; }","duration":"536.011972ms","start":"2026-04-17T21:07:55.622364Z","end":"2026-04-17T21:07:56.158376Z","steps":["trace[1119975877] 'read index received' (duration: 535.737774ms)","trace[1119975877] 'applied index is now lower than readState.Index' (duration: 273.058µs)"],"step_count":2} {"level":"warn","ts":"2026-04-17T21:07:56.158531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"536.161126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T21:07:56.158583Z","caller":"traceutil/trace.go:171","msg":"trace[598278333] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:591; }","duration":"536.26419ms","start":"2026-04-17T21:07:55.622304Z","end":"2026-04-17T21:07:56.158568Z","steps":["trace[598278333] 'agreement among raft nodes before linearized reading' (duration: 536.147807ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:56.158626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:55.622281Z","time spent":"536.333491ms","remote":"127.0.0.1:38928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-17T21:07:56.158645Z","caller":"traceutil/trace.go:171","msg":"trace[1296084531] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"1.161811704s","start":"2026-04-17T21:07:54.996797Z","end":"2026-04-17T21:07:56.158609Z","steps":["trace[1296084531] 'process raft request' (duration: 1.161524746s)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:07:56.158727Z","caller":"traceutil/trace.go:171","msg":"trace[1061660118] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"1.202483378s","start":"2026-04-17T21:07:54.95621Z","end":"2026-04-17T21:07:56.158694Z","steps":["trace[1061660118] 'process raft request' (duration: 1.201948352s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:56.158784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:54.996781Z","time spent":"1.161935617s","remote":"127.0.0.1:39162","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-17T21:07:56.158838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:54.956198Z","time spent":"1.20257655s","remote":"127.0.0.1:38970","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T21:07:57.584088Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15853969887042137644,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-17T21:07:57.93821Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.758788266s","expected-duration":"1s"} {"level":"info","ts":"2026-04-17T21:07:57.938562Z","caller":"traceutil/trace.go:171","msg":"trace[334080439] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"1.759192959s","start":"2026-04-17T21:07:56.179346Z","end":"2026-04-17T21:07:57.938539Z","steps":["trace[334080439] 'process raft request' (duration: 1.759050825s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:57.938681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:56.179335Z","time spent":"1.759294981s","remote":"127.0.0.1:39114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-17T21:07:59.623554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000568366s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-17T21:07:59.623648Z","caller":"traceutil/trace.go:171","msg":"trace[1202488969] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000669258s","start":"2026-04-17T21:07:57.622952Z","end":"2026-04-17T21:07:59.623621Z","steps":["trace[1202488969] 'agreement among raft nodes before linearized reading' (duration: 2.000566045s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:59.623713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:57.62288Z","time spent":"2.000806462s","remote":"127.0.0.1:38928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/17 21:07:59 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-17T21:07:59.89827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.550452825s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T21:07:59.898385Z","caller":"traceutil/trace.go:171","msg":"trace[225771823] linearizableReadLoop","detail":"{readStateIndex:618; appliedIndex:616; }","duration":"2.815447948s","start":"2026-04-17T21:07:57.082915Z","end":"2026-04-17T21:07:59.898363Z","steps":["trace[225771823] 'read index received' (duration: 855.48849ms)","trace[225771823] 'applied index is now lower than readState.Index' (duration: 1.959957848s)"],"step_count":2} {"level":"info","ts":"2026-04-17T21:07:59.898466Z","caller":"traceutil/trace.go:171","msg":"trace[824126504] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"3.21128938s","start":"2026-04-17T21:07:56.687142Z","end":"2026-04-17T21:07:59.898432Z","steps":["trace[824126504] 'process raft request' (duration: 1.660595459s)","trace[824126504] 'compare' (duration: 1.550157396s)"],"step_count":2} {"level":"warn","ts":"2026-04-17T21:07:59.89856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.815645953s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-17T21:07:59.898575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.815646793s","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-17T21:07:59.898592Z","caller":"traceutil/trace.go:171","msg":"trace[1196170950] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:593; }","duration":"2.815710865s","start":"2026-04-17T21:07:57.08287Z","end":"2026-04-17T21:07:59.898581Z","steps":["trace[1196170950] 'agreement among raft nodes before linearized reading' (duration: 2.815572021s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:59.898627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:56.687114Z","time spent":"3.211429943s","remote":"127.0.0.1:48108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T21:07:59.898636Z","caller":"traceutil/trace.go:171","msg":"trace[1657699526] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:593; }","duration":"2.815753526s","start":"2026-04-17T21:07:57.082866Z","end":"2026-04-17T21:07:59.898619Z","steps":["trace[1657699526] 'agreement among raft nodes before linearized reading' (duration: 2.815560781s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:59.898635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:57.082854Z","time spent":"2.815773638s","remote":"127.0.0.1:48108","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-17T21:07:59.898686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:57.082843Z","time spent":"2.815831499s","remote":"127.0.0.1:48108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-17T21:07:59.973563Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.625766728s","expected-duration":"1s"} {"level":"info","ts":"2026-04-17T21:07:59.974165Z","caller":"traceutil/trace.go:171","msg":"trace[947438994] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"2.031553483s","start":"2026-04-17T21:07:57.942583Z","end":"2026-04-17T21:07:59.974137Z","steps":["trace[947438994] 'process raft request' (duration: 2.031332267s)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:07:59.974221Z","caller":"traceutil/trace.go:171","msg":"trace[953456299] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"2.029754711s","start":"2026-04-17T21:07:57.944442Z","end":"2026-04-17T21:07:59.974197Z","steps":["trace[953456299] 'process raft request' (duration: 2.029634598s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:59.974302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:57.942563Z","time spent":"2.031672667s","remote":"127.0.0.1:39012","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":775,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-17T21:07:59.974363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:57.944431Z","time spent":"2.029855014s","remote":"127.0.0.1:39162","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T21:07:59.974522Z","caller":"traceutil/trace.go:171","msg":"trace[1144074717] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"2.029524494s","start":"2026-04-17T21:07:57.944978Z","end":"2026-04-17T21:07:59.974503Z","steps":["trace[1144074717] 'process raft request' (duration: 2.029155843s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:59.974669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:57.944969Z","time spent":"2.029592956s","remote":"127.0.0.1:39114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3209,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T21:07:59.974818Z","caller":"traceutil/trace.go:171","msg":"trace[1993357195] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"2.0314417s","start":"2026-04-17T21:07:57.943364Z","end":"2026-04-17T21:07:59.974805Z","steps":["trace[1993357195] 'process raft request' (duration: 2.030661888s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:07:59.974889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:57.943337Z","time spent":"2.031515343s","remote":"127.0.0.1:39012","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":905,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T21:08:00.031179Z","caller":"traceutil/trace.go:171","msg":"trace[2031299408] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"127.620233ms","start":"2026-04-17T21:07:59.903535Z","end":"2026-04-17T21:08:00.031155Z","steps":["trace[2031299408] 'process raft request' (duration: 127.543731ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:08:00.031177Z","caller":"traceutil/trace.go:171","msg":"trace[515587112] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"128.25044ms","start":"2026-04-17T21:07:59.902893Z","end":"2026-04-17T21:08:00.031143Z","steps":["trace[515587112] 'process raft request' (duration: 128.010193ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:08:00.031457Z","caller":"traceutil/trace.go:171","msg":"trace[245454837] linearizableReadLoop","detail":"{readStateIndex:623; appliedIndex:618; }","duration":"133.027167ms","start":"2026-04-17T21:07:59.898417Z","end":"2026-04-17T21:08:00.031444Z","steps":["trace[245454837] 'read index received' (duration: 75.434616ms)","trace[245454837] 'applied index is now lower than readState.Index' (duration: 57.588811ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T21:08:00.03156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.564305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-17T21:08:00.031661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.948382362s","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-17T21:08:00.031711Z","caller":"traceutil/trace.go:171","msg":"trace[282615160] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:599; }","duration":"2.948472835s","start":"2026-04-17T21:07:57.083223Z","end":"2026-04-17T21:08:00.031696Z","steps":["trace[282615160] 'agreement among raft nodes before linearized reading' (duration: 2.94830158s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:08:00.03175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:57.083164Z","time spent":"2.948577468s","remote":"127.0.0.1:48108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-17T21:08:00.031817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.948628119s","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-17T21:08:00.031855Z","caller":"traceutil/trace.go:171","msg":"trace[171368969] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:599; }","duration":"2.948692331s","start":"2026-04-17T21:07:57.083154Z","end":"2026-04-17T21:08:00.031846Z","steps":["trace[171368969] 'agreement among raft nodes before linearized reading' (duration: 2.948548227s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:08:00.031888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:57.083142Z","time spent":"2.948738282s","remote":"127.0.0.1:48108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-17T21:08:00.031676Z","caller":"traceutil/trace.go:171","msg":"trace[1096134257] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:599; }","duration":"407.74626ms","start":"2026-04-17T21:07:59.62392Z","end":"2026-04-17T21:08:00.031666Z","steps":["trace[1096134257] 'agreement among raft nodes before linearized reading' (duration: 407.579315ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:08:00.032211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:07:59.623882Z","time spent":"408.319806ms","remote":"127.0.0.1:38918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-17T21:08:00.662142Z","caller":"traceutil/trace.go:171","msg":"trace[106617050] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"227.687135ms","start":"2026-04-17T21:08:00.434432Z","end":"2026-04-17T21:08:00.662119Z","steps":["trace[106617050] 'process raft request' (duration: 227.541731ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:08:00.672922Z","caller":"traceutil/trace.go:171","msg":"trace[717256411] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"222.728344ms","start":"2026-04-17T21:08:00.450172Z","end":"2026-04-17T21:08:00.6729Z","steps":["trace[717256411] 'process raft request' (duration: 222.488927ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:08:02.137152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.24206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-17T21:08:02.13778Z","caller":"traceutil/trace.go:171","msg":"trace[2019882858] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:613; }","duration":"102.92774ms","start":"2026-04-17T21:08:02.034836Z","end":"2026-04-17T21:08:02.137763Z","steps":["trace[2019882858] 'range keys from in-memory index tree' (duration: 102.110087ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:08:02.137196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"514.020368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T21:08:02.137921Z","caller":"traceutil/trace.go:171","msg":"trace[420182541] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:613; }","duration":"514.79568ms","start":"2026-04-17T21:08:01.623112Z","end":"2026-04-17T21:08:02.137908Z","steps":["trace[420182541] 'range keys from in-memory index tree' (duration: 513.934715ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:08:02.13798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:08:01.623089Z","time spent":"514.879253ms","remote":"127.0.0.1:38928","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-17T21:08:02.137414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.373413ms","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-17T21:08:02.138052Z","caller":"traceutil/trace.go:171","msg":"trace[1433791807] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:613; }","duration":"103.005662ms","start":"2026-04-17T21:08:02.035014Z","end":"2026-04-17T21:08:02.13802Z","steps":["trace[1433791807] 'range keys from in-memory index tree' (duration: 101.87407ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:08:15.112695Z","caller":"traceutil/trace.go:171","msg":"trace[1730700279] transaction","detail":"{read_only:false; response_revision:751; number_of_response:1; }","duration":"128.2402ms","start":"2026-04-17T21:08:14.984429Z","end":"2026-04-17T21:08:15.112669Z","steps":["trace[1730700279] 'process raft request' (duration: 126.805885ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:08:15.230739Z","caller":"traceutil/trace.go:171","msg":"trace[588544784] transaction","detail":"{read_only:false; response_revision:753; number_of_response:1; }","duration":"100.307222ms","start":"2026-04-17T21:08:15.130405Z","end":"2026-04-17T21:08:15.230712Z","steps":["trace[588544784] 'process raft request' (duration: 92.741792ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:08:16.121999Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15853969887042137963,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-17T21:08:16.622559Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15853969887042137963,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-17T21:08:17.123568Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15853969887042137963,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-17T21:08:17.160241Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.633115639s","expected-duration":"1s"} {"level":"info","ts":"2026-04-17T21:08:17.160603Z","caller":"traceutil/trace.go:171","msg":"trace[1689702539] linearizableReadLoop","detail":"{readStateIndex:786; appliedIndex:785; }","duration":"1.538870247s","start":"2026-04-17T21:08:15.621713Z","end":"2026-04-17T21:08:17.160583Z","steps":["trace[1689702539] 'read index received' (duration: 1.538636762s)","trace[1689702539] 'applied index is now lower than readState.Index' (duration: 232.785µs)"],"step_count":2} {"level":"warn","ts":"2026-04-17T21:08:17.161039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"946.180319ms","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-17T21:08:17.161073Z","caller":"traceutil/trace.go:171","msg":"trace[473216154] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:756; }","duration":"946.267231ms","start":"2026-04-17T21:08:16.214797Z","end":"2026-04-17T21:08:17.161065Z","steps":["trace[473216154] 'agreement among raft nodes before linearized reading' (duration: 946.137478ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:08:17.161096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:08:16.214778Z","time spent":"946.313303ms","remote":"127.0.0.1:48108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-17T21:08:17.161255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"946.296683ms","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-17T21:08:17.161213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"938.350775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-17T21:08:17.161347Z","caller":"traceutil/trace.go:171","msg":"trace[2044589712] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:756; }","duration":"938.520379ms","start":"2026-04-17T21:08:16.222794Z","end":"2026-04-17T21:08:17.161314Z","steps":["trace[2044589712] 'agreement among raft nodes before linearized reading' (duration: 938.188141ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:08:17.161484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:08:16.222782Z","time spent":"938.687804ms","remote":"127.0.0.1:48108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-17T21:08:17.161494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"937.593546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-17T21:08:17.161515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.682159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-17T21:08:17.161542Z","caller":"traceutil/trace.go:171","msg":"trace[21109902] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:756; }","duration":"256.751271ms","start":"2026-04-17T21:08:16.904783Z","end":"2026-04-17T21:08:17.161535Z","steps":["trace[21109902] 'agreement among raft nodes before linearized reading' (duration: 256.700309ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:08:17.16154Z","caller":"traceutil/trace.go:171","msg":"trace[1784530759] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:756; }","duration":"937.683859ms","start":"2026-04-17T21:08:16.223845Z","end":"2026-04-17T21:08:17.161529Z","steps":["trace[1784530759] 'agreement among raft nodes before linearized reading' (duration: 937.461872ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:08:17.16158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:08:16.223832Z","time spent":"937.73858ms","remote":"127.0.0.1:48108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-17T21:08:17.16128Z","caller":"traceutil/trace.go:171","msg":"trace[1624800769] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:756; }","duration":"946.363084ms","start":"2026-04-17T21:08:16.21491Z","end":"2026-04-17T21:08:17.161274Z","steps":["trace[1624800769] 'agreement among raft nodes before linearized reading' (duration: 946.302773ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:08:17.161246Z","caller":"traceutil/trace.go:171","msg":"trace[23453] transaction","detail":"{read_only:false; response_revision:756; number_of_response:1; }","duration":"1.634214426s","start":"2026-04-17T21:08:15.527Z","end":"2026-04-17T21:08:17.161214Z","steps":["trace[23453] 'process raft request' (duration: 1.633455767s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:08:17.16178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:08:16.214874Z","time spent":"946.836456ms","remote":"127.0.0.1:48108","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-17T21:08:17.161868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:08:15.526973Z","time spent":"1.634828811s","remote":"127.0.0.1:39114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4025,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T21:08:17.162069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.539195985s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T21:08:17.162184Z","caller":"traceutil/trace.go:171","msg":"trace[198907978] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:756; }","duration":"1.540434997s","start":"2026-04-17T21:08:15.621668Z","end":"2026-04-17T21:08:17.162103Z","steps":["trace[198907978] 'agreement among raft nodes before linearized reading' (duration: 1.539096523s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:08:17.162239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:08:15.621648Z","time spent":"1.540579451s","remote":"127.0.0.1:38928","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-17T21:08:17.162321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"905.762681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-04-17T21:08:17.16244Z","caller":"traceutil/trace.go:171","msg":"trace[271565885] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:756; }","duration":"905.845474ms","start":"2026-04-17T21:08:16.256513Z","end":"2026-04-17T21:08:17.162359Z","steps":["trace[271565885] 'agreement among raft nodes before linearized reading' (duration: 904.439328ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:08:17.162997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:08:16.2565Z","time spent":"906.48392ms","remote":"127.0.0.1:48108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":512,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-17T21:08:25.819066Z","caller":"traceutil/trace.go:171","msg":"trace[30837170] transaction","detail":"{read_only:false; response_revision:853; number_of_response:1; }","duration":"142.71196ms","start":"2026-04-17T21:08:25.676337Z","end":"2026-04-17T21:08:25.819049Z","steps":["trace[30837170] 'process raft request' (duration: 142.668389ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:08:25.81915Z","caller":"traceutil/trace.go:171","msg":"trace[309354306] transaction","detail":"{read_only:false; response_revision:852; number_of_response:1; }","duration":"147.830459ms","start":"2026-04-17T21:08:25.671283Z","end":"2026-04-17T21:08:25.819113Z","steps":["trace[309354306] 'process raft request' (duration: 147.638725ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:08:25.980323Z","caller":"traceutil/trace.go:171","msg":"trace[2067396132] transaction","detail":"{read_only:false; response_revision:856; number_of_response:1; }","duration":"153.244757ms","start":"2026-04-17T21:08:25.827042Z","end":"2026-04-17T21:08:25.980287Z","steps":["trace[2067396132] 'process raft request' (duration: 153.162965ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:08:25.980351Z","caller":"traceutil/trace.go:171","msg":"trace[243401663] transaction","detail":"{read_only:false; response_revision:855; number_of_response:1; }","duration":"154.542357ms","start":"2026-04-17T21:08:25.825764Z","end":"2026-04-17T21:08:25.980307Z","steps":["trace[243401663] 'process raft request' (duration: 154.251729ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:08:26.249017Z","caller":"traceutil/trace.go:171","msg":"trace[1433807770] transaction","detail":"{read_only:false; response_revision:857; number_of_response:1; }","duration":"260.597369ms","start":"2026-04-17T21:08:25.988396Z","end":"2026-04-17T21:08:26.248993Z","steps":["trace[1433807770] 'process raft request' (duration: 260.430725ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:08:26.565654Z","caller":"traceutil/trace.go:171","msg":"trace[237788732] transaction","detail":"{read_only:false; response_revision:860; number_of_response:1; }","duration":"308.984432ms","start":"2026-04-17T21:08:26.256652Z","end":"2026-04-17T21:08:26.565636Z","steps":["trace[237788732] 'process raft request' (duration: 308.90857ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:08:26.565741Z","caller":"traceutil/trace.go:171","msg":"trace[1832376474] transaction","detail":"{read_only:false; response_revision:859; number_of_response:1; }","duration":"311.213514ms","start":"2026-04-17T21:08:26.254507Z","end":"2026-04-17T21:08:26.56572Z","steps":["trace[1832376474] 'process raft request' (duration: 308.89761ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:08:26.565924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:08:26.254498Z","time spent":"311.316086ms","remote":"127.0.0.1:39114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4866,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T21:08:26.565782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:08:26.256644Z","time spent":"309.074624ms","remote":"127.0.0.1:48314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4213,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T21:08:26.925782Z","caller":"traceutil/trace.go:171","msg":"trace[490489671] transaction","detail":"{read_only:false; response_revision:862; number_of_response:1; }","duration":"354.505949ms","start":"2026-04-17T21:08:26.571246Z","end":"2026-04-17T21:08:26.925752Z","steps":["trace[490489671] 'process raft request' (duration: 354.325074ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:08:26.925865Z","caller":"traceutil/trace.go:171","msg":"trace[363483097] transaction","detail":"{read_only:false; response_revision:863; number_of_response:1; }","duration":"353.027585ms","start":"2026-04-17T21:08:26.572817Z","end":"2026-04-17T21:08:26.925844Z","steps":["trace[363483097] 'process raft request' (duration: 352.882451ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:08:26.925898Z","caller":"traceutil/trace.go:171","msg":"trace[1521607284] transaction","detail":"{read_only:false; response_revision:864; number_of_response:1; }","duration":"349.644956ms","start":"2026-04-17T21:08:26.576226Z","end":"2026-04-17T21:08:26.925871Z","steps":["trace[1521607284] 'process raft request' (duration: 349.534274ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:08:26.925927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:08:26.571236Z","time spent":"354.619992ms","remote":"127.0.0.1:39012","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":723,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T21:08:26.926033Z","caller":"traceutil/trace.go:171","msg":"trace[1222657628] linearizableReadLoop","detail":"{readStateIndex:898; appliedIndex:894; }","duration":"270.702731ms","start":"2026-04-17T21:08:26.655293Z","end":"2026-04-17T21:08:26.925996Z","steps":["trace[1222657628] 'read index received' (duration: 270.20178ms)","trace[1222657628] 'applied index is now lower than readState.Index' (duration: 499.291µs)"],"step_count":2} {"level":"warn","ts":"2026-04-17T21:08:26.926053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:08:26.576219Z","time spent":"349.753579ms","remote":"127.0.0.1:48114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1452,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T21:08:26.926152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:08:26.57281Z","time spent":"353.113597ms","remote":"127.0.0.1:48346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3852,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T21:08:26.92639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.453055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4228"} {"level":"info","ts":"2026-04-17T21:08:26.926394Z","caller":"traceutil/trace.go:171","msg":"trace[1507252307] transaction","detail":"{read_only:false; response_revision:865; number_of_response:1; }","duration":"350.048956ms","start":"2026-04-17T21:08:26.576334Z","end":"2026-04-17T21:08:26.926382Z","steps":["trace[1507252307] 'process raft request' (duration: 349.462703ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:08:26.926407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.382621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-67659f764b-2tzfz\" ","response":"range_response_count:1 size:5086"} {"level":"info","ts":"2026-04-17T21:08:26.926438Z","caller":"traceutil/trace.go:171","msg":"trace[410990149] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:865; }","duration":"350.517737ms","start":"2026-04-17T21:08:26.575908Z","end":"2026-04-17T21:08:26.926425Z","steps":["trace[410990149] 'agreement among raft nodes before linearized reading' (duration: 350.354333ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:08:26.926451Z","caller":"traceutil/trace.go:171","msg":"trace[1120368851] range","detail":"{range_begin:/registry/pods/kube-system/coredns-67659f764b-2tzfz; range_end:; response_count:1; response_revision:865; }","duration":"266.465733ms","start":"2026-04-17T21:08:26.659972Z","end":"2026-04-17T21:08:26.926438Z","steps":["trace[1120368851] 'agreement among raft nodes before linearized reading' (duration: 266.346161ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:08:26.926433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.684103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-17T21:08:26.926467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:08:26.576328Z","time spent":"350.106087ms","remote":"127.0.0.1:39098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":742,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T21:08:26.926469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:08:26.575901Z","time spent":"350.560508ms","remote":"127.0.0.1:48314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":4250,"request content":"key:\"/registry/deployments/kube-system/coredns\" "} {"level":"info","ts":"2026-04-17T21:08:26.926524Z","caller":"traceutil/trace.go:171","msg":"trace[246304209] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:0; response_revision:865; }","duration":"246.838447ms","start":"2026-04-17T21:08:26.679666Z","end":"2026-04-17T21:08:26.926504Z","steps":["trace[246304209] 'agreement among raft nodes before linearized reading' (duration: 246.663973ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:08:27.077612Z","caller":"traceutil/trace.go:171","msg":"trace[1614808602] transaction","detail":"{read_only:false; response_revision:867; number_of_response:1; }","duration":"141.287831ms","start":"2026-04-17T21:08:26.936281Z","end":"2026-04-17T21:08:27.077569Z","steps":["trace[1614808602] 'process raft request' (duration: 106.347115ms)","trace[1614808602] 'compare' (duration: 34.698781ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T21:08:27.077902Z","caller":"traceutil/trace.go:171","msg":"trace[2068811347] transaction","detail":"{read_only:false; response_revision:868; number_of_response:1; }","duration":"141.313382ms","start":"2026-04-17T21:08:26.936566Z","end":"2026-04-17T21:08:27.077879Z","steps":["trace[2068811347] 'process raft request' (duration: 140.913363ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:08:27.293137Z","caller":"traceutil/trace.go:171","msg":"trace[1418524607] transaction","detail":"{read_only:false; response_revision:872; number_of_response:1; }","duration":"107.767028ms","start":"2026-04-17T21:08:27.185332Z","end":"2026-04-17T21:08:27.293099Z","steps":["trace[1418524607] 'process raft request' (duration: 107.535452ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:08:50.043585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.260576ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-04-17T21:08:50.192602Z","caller":"traceutil/trace.go:171","msg":"trace[1091391070] transaction","detail":"{read_only:false; response_revision:994; number_of_response:1; }","duration":"135.597852ms","start":"2026-04-17T21:08:50.056978Z","end":"2026-04-17T21:08:50.192575Z","steps":["trace[1091391070] 'process raft request' (duration: 135.411968ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:09:20.052167Z","caller":"traceutil/trace.go:171","msg":"trace[647324645] transaction","detail":"{read_only:false; response_revision:1096; number_of_response:1; }","duration":"113.972585ms","start":"2026-04-17T21:09:19.938164Z","end":"2026-04-17T21:09:20.052136Z","steps":["trace[647324645] 'process raft request' (duration: 113.688079ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:09:27.967105Z","caller":"traceutil/trace.go:171","msg":"trace[1420476594] linearizableReadLoop","detail":"{readStateIndex:1165; appliedIndex:1164; }","duration":"216.842849ms","start":"2026-04-17T21:09:27.750247Z","end":"2026-04-17T21:09:27.96709Z","steps":["trace[1420476594] 'read index received' (duration: 216.715347ms)","trace[1420476594] 'applied index is now lower than readState.Index' (duration: 126.722µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T21:09:27.967161Z","caller":"traceutil/trace.go:171","msg":"trace[1223702720] transaction","detail":"{read_only:false; response_revision:1118; number_of_response:1; }","duration":"223.757038ms","start":"2026-04-17T21:09:27.743376Z","end":"2026-04-17T21:09:27.967133Z","steps":["trace[1223702720] 'process raft request' (duration: 223.602325ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:09:27.967268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.053329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-17T21:09:27.967296Z","caller":"traceutil/trace.go:171","msg":"trace[1906339509] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1118; }","duration":"138.1205ms","start":"2026-04-17T21:09:27.829168Z","end":"2026-04-17T21:09:27.967289Z","steps":["trace[1906339509] 'agreement among raft nodes before linearized reading' (duration: 138.022179ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:09:27.967374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.095803ms","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-17T21:09:27.967453Z","caller":"traceutil/trace.go:171","msg":"trace[1809866798] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1118; }","duration":"217.249016ms","start":"2026-04-17T21:09:27.750185Z","end":"2026-04-17T21:09:27.967434Z","steps":["trace[1809866798] 'agreement among raft nodes before linearized reading' (duration: 217.005692ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:09:27.967724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.797268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-17T21:09:27.96778Z","caller":"traceutil/trace.go:171","msg":"trace[650496874] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1118; }","duration":"129.874649ms","start":"2026-04-17T21:09:27.83789Z","end":"2026-04-17T21:09:27.967765Z","steps":["trace[650496874] 'agreement among raft nodes before linearized reading' (duration: 129.431972ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:09:40.310847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.972348ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-04-17T21:09:40.31114Z","caller":"traceutil/trace.go:171","msg":"trace[461851019] transaction","detail":"{read_only:false; response_revision:1157; number_of_response:1; }","duration":"106.72704ms","start":"2026-04-17T21:09:40.204393Z","end":"2026-04-17T21:09:40.31112Z","steps":["trace[461851019] 'process raft request' (duration: 106.580058ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:09:40.311246Z","caller":"traceutil/trace.go:171","msg":"trace[1304413154] linearizableReadLoop","detail":"{readStateIndex:1206; appliedIndex:1205; }","duration":"259.839195ms","start":"2026-04-17T21:09:40.051258Z","end":"2026-04-17T21:09:40.311097Z","steps":["trace[1304413154] 'read index received' (duration: 37.551612ms)","trace[1304413154] 'applied index is now lower than readState.Index' (duration: 222.282813ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T21:09:40.311567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.284884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-17T21:09:40.311605Z","caller":"traceutil/trace.go:171","msg":"trace[1270729062] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1157; }","duration":"260.371255ms","start":"2026-04-17T21:09:40.051223Z","end":"2026-04-17T21:09:40.311594Z","steps":["trace[1270729062] 'agreement among raft nodes before linearized reading' (duration: 260.170801ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:09:40.31163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.827267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-04-17T21:09:40.311631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.855267ms","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-17T21:09:40.311655Z","caller":"traceutil/trace.go:171","msg":"trace[65435347] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1157; }","duration":"202.872928ms","start":"2026-04-17T21:09:40.108774Z","end":"2026-04-17T21:09:40.311647Z","steps":["trace[65435347] 'agreement among raft nodes before linearized reading' (duration: 202.741196ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:09:40.311671Z","caller":"traceutil/trace.go:171","msg":"trace[79491920] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1157; }","duration":"202.924669ms","start":"2026-04-17T21:09:40.108737Z","end":"2026-04-17T21:09:40.311661Z","steps":["trace[79491920] 'agreement among raft nodes before linearized reading' (duration: 202.777777ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:09:40.311685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.129712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"warn","ts":"2026-04-17T21:09:40.31172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.351512ms","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-17T21:09:40.311761Z","caller":"traceutil/trace.go:171","msg":"trace[1223902968] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1157; }","duration":"257.236354ms","start":"2026-04-17T21:09:40.054506Z","end":"2026-04-17T21:09:40.311742Z","steps":["trace[1223902968] 'agreement among raft nodes before linearized reading' (duration: 257.005731ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:09:40.311795Z","caller":"traceutil/trace.go:171","msg":"trace[2020588959] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1157; }","duration":"212.475334ms","start":"2026-04-17T21:09:40.099299Z","end":"2026-04-17T21:09:40.311775Z","steps":["trace[2020588959] 'agreement among raft nodes before linearized reading' (duration: 212.284781ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:09:40.498681Z","caller":"traceutil/trace.go:171","msg":"trace[826976232] transaction","detail":"{read_only:false; response_revision:1159; number_of_response:1; }","duration":"182.740118ms","start":"2026-04-17T21:09:40.315908Z","end":"2026-04-17T21:09:40.498648Z","steps":["trace[826976232] 'process raft request' (duration: 181.869104ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:09:40.498773Z","caller":"traceutil/trace.go:171","msg":"trace[92813515] transaction","detail":"{read_only:false; response_revision:1162; number_of_response:1; }","duration":"140.450829ms","start":"2026-04-17T21:09:40.358286Z","end":"2026-04-17T21:09:40.498737Z","steps":["trace[92813515] 'process raft request' (duration: 140.391848ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:09:40.498866Z","caller":"traceutil/trace.go:171","msg":"trace[489373097] transaction","detail":"{read_only:false; response_revision:1160; number_of_response:1; }","duration":"182.87369ms","start":"2026-04-17T21:09:40.315954Z","end":"2026-04-17T21:09:40.498828Z","steps":["trace[489373097] 'process raft request' (duration: 182.620125ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:09:40.498997Z","caller":"traceutil/trace.go:171","msg":"trace[765860965] transaction","detail":"{read_only:false; response_revision:1161; number_of_response:1; }","duration":"182.84272ms","start":"2026-04-17T21:09:40.31612Z","end":"2026-04-17T21:09:40.498963Z","steps":["trace[765860965] 'process raft request' (duration: 182.510154ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:10:02.520728Z","caller":"traceutil/trace.go:171","msg":"trace[613639310] transaction","detail":"{read_only:false; response_revision:1260; number_of_response:1; }","duration":"118.579465ms","start":"2026-04-17T21:10:02.402119Z","end":"2026-04-17T21:10:02.520699Z","steps":["trace[613639310] 'process raft request' (duration: 118.37043ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:10:04.896967Z","caller":"traceutil/trace.go:171","msg":"trace[876558148] transaction","detail":"{read_only:false; response_revision:1271; number_of_response:1; }","duration":"201.146839ms","start":"2026-04-17T21:10:04.695791Z","end":"2026-04-17T21:10:04.896938Z","steps":["trace[876558148] 'process raft request' (duration: 200.920106ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:10:04.897194Z","caller":"traceutil/trace.go:171","msg":"trace[1834752320] transaction","detail":"{read_only:false; response_revision:1272; number_of_response:1; }","duration":"201.361943ms","start":"2026-04-17T21:10:04.695815Z","end":"2026-04-17T21:10:04.897177Z","steps":["trace[1834752320] 'process raft request' (duration: 201.061598ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:10:04.897344Z","caller":"traceutil/trace.go:171","msg":"trace[1897197757] transaction","detail":"{read_only:false; response_revision:1273; number_of_response:1; }","duration":"201.369273ms","start":"2026-04-17T21:10:04.695942Z","end":"2026-04-17T21:10:04.897312Z","steps":["trace[1897197757] 'process raft request' (duration: 201.17358ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:10:06.09448Z","caller":"traceutil/trace.go:171","msg":"trace[539179601] linearizableReadLoop","detail":"{readStateIndex:1333; appliedIndex:1332; }","duration":"113.276276ms","start":"2026-04-17T21:10:05.981179Z","end":"2026-04-17T21:10:06.094455Z","steps":["trace[539179601] 'read index received' (duration: 113.033553ms)","trace[539179601] 'applied index is now lower than readState.Index' (duration: 241.433µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T21:10:06.094555Z","caller":"traceutil/trace.go:171","msg":"trace[790693826] transaction","detail":"{read_only:false; response_revision:1277; number_of_response:1; }","duration":"187.221036ms","start":"2026-04-17T21:10:05.907298Z","end":"2026-04-17T21:10:06.094519Z","steps":["trace[790693826] 'process raft request' (duration: 186.999253ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:10:06.094728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.52588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/default/test-pvc\" ","response":"range_response_count:1 size:1465"} {"level":"info","ts":"2026-04-17T21:10:06.09477Z","caller":"traceutil/trace.go:171","msg":"trace[633874497] range","detail":"{range_begin:/registry/persistentvolumeclaims/default/test-pvc; range_end:; response_count:1; response_revision:1277; }","duration":"113.626231ms","start":"2026-04-17T21:10:05.981132Z","end":"2026-04-17T21:10:06.094758Z","steps":["trace[633874497] 'agreement among raft nodes before linearized reading' (duration: 113.460789ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:10:06.095145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.96392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-17T21:10:06.095315Z","caller":"traceutil/trace.go:171","msg":"trace[137780443] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1277; }","duration":"107.413688ms","start":"2026-04-17T21:10:05.987817Z","end":"2026-04-17T21:10:06.095231Z","steps":["trace[137780443] 'agreement among raft nodes before linearized reading' (duration: 106.850269ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T21:10:08.72709Z","caller":"traceutil/trace.go:171","msg":"trace[1258782871] transaction","detail":"{read_only:false; response_revision:1286; number_of_response:1; }","duration":"108.04689ms","start":"2026-04-17T21:10:08.619014Z","end":"2026-04-17T21:10:08.727061Z","steps":["trace[1258782871] 'process raft request' (duration: 95.685683ms)","trace[1258782871] 'compare' (duration: 12.258536ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T21:10:11.390718Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15853969887042139244,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-17T21:10:11.428262Z","caller":"traceutil/trace.go:171","msg":"trace[1003451647] linearizableReadLoop","detail":"{readStateIndex:1351; appliedIndex:1350; }","duration":"537.922377ms","start":"2026-04-17T21:10:10.890314Z","end":"2026-04-17T21:10:11.428236Z","steps":["trace[1003451647] 'read index received' (duration: 537.659423ms)","trace[1003451647] 'applied index is now lower than readState.Index' (duration: 261.824µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T21:10:11.428291Z","caller":"traceutil/trace.go:171","msg":"trace[781794741] transaction","detail":"{read_only:false; response_revision:1294; number_of_response:1; }","duration":"693.163073ms","start":"2026-04-17T21:10:10.735103Z","end":"2026-04-17T21:10:11.428266Z","steps":["trace[781794741] 'process raft request' (duration: 692.978201ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:10:11.428443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:10:10.735087Z","time spent":"693.264645ms","remote":"127.0.0.1:48108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T21:10:11.428504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.17909ms","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-17T21:10:11.428545Z","caller":"traceutil/trace.go:171","msg":"trace[755010942] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1294; }","duration":"538.237931ms","start":"2026-04-17T21:10:10.890296Z","end":"2026-04-17T21:10:11.428534Z","steps":["trace[755010942] 'agreement among raft nodes before linearized reading' (duration: 538.085279ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:10:11.428587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:10:10.890277Z","time spent":"538.301073ms","remote":"127.0.0.1:48108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-17T21:10:11.42861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.308777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-17T21:10:11.428636Z","caller":"traceutil/trace.go:171","msg":"trace[805909053] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1294; }","duration":"390.383368ms","start":"2026-04-17T21:10:11.038245Z","end":"2026-04-17T21:10:11.428629Z","steps":["trace[805909053] 'agreement among raft nodes before linearized reading' (duration: 390.283986ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:10:11.42866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:10:11.038234Z","time spent":"390.421938ms","remote":"127.0.0.1:48108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-17T21:10:11.428744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.389463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-17T21:10:11.428823Z","caller":"traceutil/trace.go:171","msg":"trace[2011103257] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1294; }","duration":"391.516304ms","start":"2026-04-17T21:10:11.03729Z","end":"2026-04-17T21:10:11.428806Z","steps":["trace[2011103257] 'agreement among raft nodes before linearized reading' (duration: 391.282931ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:10:11.428885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:10:11.037272Z","time spent":"391.603136ms","remote":"127.0.0.1:48108","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-17T21:10:11.430059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.194261ms","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-17T21:10:11.430112Z","caller":"traceutil/trace.go:171","msg":"trace[906215840] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1294; }","duration":"483.283082ms","start":"2026-04-17T21:10:10.946816Z","end":"2026-04-17T21:10:11.430099Z","steps":["trace[906215840] 'agreement among raft nodes before linearized reading' (duration: 483.12724ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T21:10:11.430146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T21:10:10.9468Z","time spent":"483.336643ms","remote":"127.0.0.1:48108","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\" "}