{"level":"warn","ts":"2026-04-07T01:23:57.065838Z","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-07T01:23:57.065973Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.78: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.78:2380","--initial-cluster=instance=https://199.204.45.78:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.78:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.78: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-07T01:23:57.066071Z","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-07T01:23:57.066087Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.78:2380"]} {"level":"info","ts":"2026-04-07T01:23:57.066109Z","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-07T01:23:57.067099Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.78:2379"]} {"level":"info","ts":"2026-04-07T01:23:57.067204Z","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.78:2380"],"listen-peer-urls":["https://199.204.45.78:2380"],"advertise-client-urls":["https://199.204.45.78:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.78:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.78: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-07T01:23:57.101496Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"34.023448ms"} {"level":"info","ts":"2026-04-07T01:23:57.131767Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6eb8766b1ec86e92","cluster-id":"9bbfe9e5d45d3718"} {"level":"info","ts":"2026-04-07T01:23:57.131967Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 switched to configuration voters=()"} {"level":"info","ts":"2026-04-07T01:23:57.13204Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became follower at term 0"} {"level":"info","ts":"2026-04-07T01:23:57.132075Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6eb8766b1ec86e92 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-07T01:23:57.132106Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became follower at term 1"} {"level":"info","ts":"2026-04-07T01:23:57.132202Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 switched to configuration voters=(7978256942336863890)"} {"level":"warn","ts":"2026-04-07T01:23:57.139531Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-07T01:23:57.141429Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-07T01:23:57.142641Z","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-07T01:23:57.198487Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6eb8766b1ec86e92","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-07T01:23:57.198952Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6eb8766b1ec86e92","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-07T01:23:57.198975Z","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-07T01:23:57.199058Z","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-07T01:23:57.199073Z","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-07T01:23:57.203771Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 switched to configuration voters=(7978256942336863890)"} {"level":"info","ts":"2026-04-07T01:23:57.204018Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9bbfe9e5d45d3718","local-member-id":"6eb8766b1ec86e92","added-peer-id":"6eb8766b1ec86e92","added-peer-peer-urls":["https://199.204.45.78:2380"]} {"level":"info","ts":"2026-04-07T01:23:57.205594Z","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-07T01:23:57.205786Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.78:2380"} {"level":"info","ts":"2026-04-07T01:23:57.205864Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.78:2380"} {"level":"info","ts":"2026-04-07T01:23:57.206963Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6eb8766b1ec86e92","initial-advertise-peer-urls":["https://199.204.45.78:2380"],"listen-peer-urls":["https://199.204.45.78:2380"],"advertise-client-urls":["https://199.204.45.78:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.78:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-07T01:23:57.207007Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-07T01:23:58.132829Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 is starting a new election at term 1"} {"level":"info","ts":"2026-04-07T01:23:58.132925Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-07T01:23:58.132982Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 received MsgPreVoteResp from 6eb8766b1ec86e92 at term 1"} {"level":"info","ts":"2026-04-07T01:23:58.133006Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became candidate at term 2"} {"level":"info","ts":"2026-04-07T01:23:58.133018Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 received MsgVoteResp from 6eb8766b1ec86e92 at term 2"} {"level":"info","ts":"2026-04-07T01:23:58.133036Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became leader at term 2"} {"level":"info","ts":"2026-04-07T01:23:58.133051Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6eb8766b1ec86e92 elected leader 6eb8766b1ec86e92 at term 2"} {"level":"info","ts":"2026-04-07T01:23:58.134857Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6eb8766b1ec86e92","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.78:2379]}","request-path":"/0/members/6eb8766b1ec86e92/attributes","cluster-id":"9bbfe9e5d45d3718","publish-timeout":"7s"} {"level":"info","ts":"2026-04-07T01:23:58.134911Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T01:23:58.135426Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T01:23:58.135571Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T01:23:58.13598Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-07T01:23:58.136071Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-07T01:23:58.136293Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9bbfe9e5d45d3718","local-member-id":"6eb8766b1ec86e92","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T01:23:58.136421Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T01:23:58.136461Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T01:23:58.139513Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-07T01:23:58.139682Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.78:2379"} {"level":"info","ts":"2026-04-07T01:23:59.767913Z","caller":"traceutil/trace.go:171","msg":"trace[1663795803] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"138.037569ms","start":"2026-04-07T01:23:59.629801Z","end":"2026-04-07T01:23:59.767838Z","steps":["trace[1663795803] 'process raft request' (duration: 107.695833ms)","trace[1663795803] 'compare' (duration: 30.056118ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:23:59.768158Z","caller":"traceutil/trace.go:171","msg":"trace[31166908] transaction","detail":"{read_only:false; number_of_response:0; response_revision:13; }","duration":"138.213004ms","start":"2026-04-07T01:23:59.62992Z","end":"2026-04-07T01:23:59.768133Z","steps":["trace[31166908] 'process raft request' (duration: 137.773772ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:23:59.768242Z","caller":"traceutil/trace.go:171","msg":"trace[1137530266] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"132.260588ms","start":"2026-04-07T01:23:59.635956Z","end":"2026-04-07T01:23:59.768217Z","steps":["trace[1137530266] 'process raft request' (duration: 131.831336ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:23:59.768179Z","caller":"traceutil/trace.go:171","msg":"trace[1667370406] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"132.219647ms","start":"2026-04-07T01:23:59.635783Z","end":"2026-04-07T01:23:59.768002Z","steps":["trace[1667370406] 'process raft request' (duration: 131.938469ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:23:59.7687Z","caller":"traceutil/trace.go:171","msg":"trace[1267014857] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"132.33853ms","start":"2026-04-07T01:23:59.636337Z","end":"2026-04-07T01:23:59.768676Z","steps":["trace[1267014857] 'process raft request' (duration: 132.250597ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:23:59.768878Z","caller":"traceutil/trace.go:171","msg":"trace[1851858081] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"126.671543ms","start":"2026-04-07T01:23:59.642156Z","end":"2026-04-07T01:23:59.768827Z","steps":["trace[1851858081] 'process raft request' (duration: 126.551449ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:23:59.768984Z","caller":"traceutil/trace.go:171","msg":"trace[1330704227] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"131.752194ms","start":"2026-04-07T01:23:59.63722Z","end":"2026-04-07T01:23:59.768972Z","steps":["trace[1330704227] 'process raft request' (duration: 131.415024ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:23:59.768861Z","caller":"traceutil/trace.go:171","msg":"trace[1410750571] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"132.825984ms","start":"2026-04-07T01:23:59.636011Z","end":"2026-04-07T01:23:59.768837Z","steps":["trace[1410750571] 'process raft request' (duration: 132.136634ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:23:59.769145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.902252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-cm6rs\" ","response":"range_response_count:1 size:861"} {"level":"info","ts":"2026-04-07T01:23:59.769245Z","caller":"traceutil/trace.go:171","msg":"trace[523239675] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-cm6rs; range_end:; response_count:1; response_revision:20; }","duration":"135.095328ms","start":"2026-04-07T01:23:59.634131Z","end":"2026-04-07T01:23:59.769226Z","steps":["trace[523239675] 'agreement among raft nodes before linearized reading' (duration: 134.891372ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:07.904541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.777152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4368"} {"level":"info","ts":"2026-04-07T01:24:07.904662Z","caller":"traceutil/trace.go:171","msg":"trace[1249752121] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:388; }","duration":"180.970498ms","start":"2026-04-07T01:24:07.723662Z","end":"2026-04-07T01:24:07.904632Z","steps":["trace[1249752121] 'range keys from in-memory index tree' (duration: 180.568926ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:24:14.127342Z","caller":"traceutil/trace.go:171","msg":"trace[1209264309] transaction","detail":"{read_only:false; response_revision:409; number_of_response:1; }","duration":"684.902379ms","start":"2026-04-07T01:24:13.442411Z","end":"2026-04-07T01:24:14.127313Z","steps":["trace[1209264309] 'process raft request' (duration: 684.767856ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:14.127994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:24:13.44239Z","time spent":"685.036453ms","remote":"127.0.0.1:33188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4645,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:24:14.16972Z","caller":"traceutil/trace.go:171","msg":"trace[52339742] linearizableReadLoop","detail":"{readStateIndex:423; appliedIndex:422; }","duration":"512.695768ms","start":"2026-04-07T01:24:13.657Z","end":"2026-04-07T01:24:14.169696Z","steps":["trace[52339742] 'read index received' (duration: 470.341517ms)","trace[52339742] 'applied index is now lower than readState.Index' (duration: 42.353211ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:24:14.169852Z","caller":"traceutil/trace.go:171","msg":"trace[778122878] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"640.977825ms","start":"2026-04-07T01:24:13.528811Z","end":"2026-04-07T01:24:14.169789Z","steps":["trace[778122878] 'process raft request' (duration: 640.761579ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:14.169901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"512.887723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-07T01:24:14.17009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:24:13.528791Z","time spent":"641.17686ms","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T01:24:14.170066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.920161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:24:14.170166Z","caller":"traceutil/trace.go:171","msg":"trace[196340440] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:410; }","duration":"391.042854ms","start":"2026-04-07T01:24:13.779103Z","end":"2026-04-07T01:24:14.170146Z","steps":["trace[196340440] 'agreement among raft nodes before linearized reading' (duration: 390.864309ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:24:14.170142Z","caller":"traceutil/trace.go:171","msg":"trace[520110991] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:410; }","duration":"513.14667ms","start":"2026-04-07T01:24:13.656943Z","end":"2026-04-07T01:24:14.170089Z","steps":["trace[520110991] 'agreement among raft nodes before linearized reading' (duration: 512.893433ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:14.170231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:24:13.779053Z","time spent":"391.168378ms","remote":"127.0.0.1:33004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-07T01:24:14.170276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:24:13.656917Z","time spent":"513.308384ms","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-07T01:24:14.689493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.090231ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T01:24:14.689597Z","caller":"traceutil/trace.go:171","msg":"trace[112315502] linearizableReadLoop","detail":"{readStateIndex:424; appliedIndex:423; }","duration":"438.371115ms","start":"2026-04-07T01:24:14.251209Z","end":"2026-04-07T01:24:14.68958Z","steps":["trace[112315502] 'read index received' (duration: 267.019157ms)","trace[112315502] 'applied index is now lower than readState.Index' (duration: 171.350628ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:24:14.689688Z","caller":"traceutil/trace.go:171","msg":"trace[1030627558] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"514.830197ms","start":"2026-04-07T01:24:14.174847Z","end":"2026-04-07T01:24:14.689677Z","steps":["trace[1030627558] 'process raft request' (duration: 343.340055ms)","trace[1030627558] 'compare' (duration: 170.748971ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:24:14.689744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:24:14.174818Z","time spent":"514.897049ms","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T01:24:14.689953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.755526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-04-07T01:24:14.68999Z","caller":"traceutil/trace.go:171","msg":"trace[420171651] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:411; }","duration":"438.792257ms","start":"2026-04-07T01:24:14.251189Z","end":"2026-04-07T01:24:14.689981Z","steps":["trace[420171651] 'agreement among raft nodes before linearized reading' (duration: 438.718805ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:14.690019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:24:14.251105Z","time spent":"438.90702ms","remote":"127.0.0.1:33250","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":"warn","ts":"2026-04-07T01:24:14.690163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.032714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-04-07T01:24:14.690212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.201413ms","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-07T01:24:14.69023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.740581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4368"} {"level":"info","ts":"2026-04-07T01:24:14.690257Z","caller":"traceutil/trace.go:171","msg":"trace[1970285311] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:411; }","duration":"415.176768ms","start":"2026-04-07T01:24:14.27506Z","end":"2026-04-07T01:24:14.690236Z","steps":["trace[1970285311] 'agreement among raft nodes before linearized reading' (duration: 414.993602ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:24:14.69028Z","caller":"traceutil/trace.go:171","msg":"trace[323589542] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:411; }","duration":"399.337667ms","start":"2026-04-07T01:24:14.290925Z","end":"2026-04-07T01:24:14.690263Z","steps":["trace[323589542] 'agreement among raft nodes before linearized reading' (duration: 399.207484ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:14.690314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:24:14.275044Z","time spent":"415.26022ms","remote":"127.0.0.1:33250","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":"info","ts":"2026-04-07T01:24:14.690315Z","caller":"traceutil/trace.go:171","msg":"trace[1488873995] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:411; }","duration":"246.903746ms","start":"2026-04-07T01:24:14.443389Z","end":"2026-04-07T01:24:14.690293Z","steps":["trace[1488873995] 'agreement among raft nodes before linearized reading' (duration: 246.66853ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:14.690331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:24:14.290897Z","time spent":"399.42632ms","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-07T01:24:15.746296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.850697ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T01:24:15.746502Z","caller":"traceutil/trace.go:171","msg":"trace[1039262965] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"1.052040498s","start":"2026-04-07T01:24:14.694439Z","end":"2026-04-07T01:24:15.746479Z","steps":["trace[1039262965] 'process raft request' (duration: 1.051950716s)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:24:15.746499Z","caller":"traceutil/trace.go:171","msg":"trace[1879921475] transaction","detail":"{read_only:false; response_revision:412; number_of_response:1; }","duration":"1.052047608s","start":"2026-04-07T01:24:14.694424Z","end":"2026-04-07T01:24:15.746471Z","steps":["trace[1879921475] 'process raft request' (duration: 545.937934ms)","trace[1879921475] 'compare' (duration: 505.726194ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:24:15.746571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:24:14.694421Z","time spent":"1.05211986s","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T01:24:15.74662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:24:14.694403Z","time spent":"1.052152682s","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:24:15.900603Z","caller":"traceutil/trace.go:171","msg":"trace[248153926] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"1.205871608s","start":"2026-04-07T01:24:14.694701Z","end":"2026-04-07T01:24:15.900572Z","steps":["trace[248153926] 'process raft request' (duration: 1.203612965s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:15.900749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:24:14.694694Z","time spent":"1.205982991s","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:24:15.900896Z","caller":"traceutil/trace.go:171","msg":"trace[84811983] linearizableReadLoop","detail":"{readStateIndex:428; appliedIndex:424; }","duration":"922.554967ms","start":"2026-04-07T01:24:14.978248Z","end":"2026-04-07T01:24:15.900803Z","steps":["trace[84811983] 'read index received' (duration: 262.119019ms)","trace[84811983] 'applied index is now lower than readState.Index' (duration: 660.434288ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:24:15.90095Z","caller":"traceutil/trace.go:171","msg":"trace[630316733] transaction","detail":"{read_only:false; response_revision:415; number_of_response:1; }","duration":"1.199744836s","start":"2026-04-07T01:24:14.701182Z","end":"2026-04-07T01:24:15.900927Z","steps":["trace[630316733] 'process raft request' (duration: 1.199351156s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:15.901066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"922.812424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4322"} {"level":"warn","ts":"2026-04-07T01:24:15.901116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:24:14.701173Z","time spent":"1.1998806s","remote":"127.0.0.1:33174","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4360,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:24:15.901185Z","caller":"traceutil/trace.go:171","msg":"trace[1967769637] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:415; }","duration":"922.935787ms","start":"2026-04-07T01:24:14.978207Z","end":"2026-04-07T01:24:15.901143Z","steps":["trace[1967769637] 'agreement among raft nodes before linearized reading' (duration: 922.811324ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:15.901233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:24:14.978184Z","time spent":"923.0382ms","remote":"127.0.0.1:33188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":4345,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" "} {"level":"warn","ts":"2026-04-07T01:24:15.901259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.577338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:24:15.901323Z","caller":"traceutil/trace.go:171","msg":"trace[493146803] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:415; }","duration":"122.703882ms","start":"2026-04-07T01:24:15.778594Z","end":"2026-04-07T01:24:15.901298Z","steps":["trace[493146803] 'agreement among raft nodes before linearized reading' (duration: 122.558868ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:24:31.535562Z","caller":"traceutil/trace.go:171","msg":"trace[50622760] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"386.320903ms","start":"2026-04-07T01:24:31.149186Z","end":"2026-04-07T01:24:31.535507Z","steps":["trace[50622760] 'process raft request' (duration: 386.154279ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:31.535775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:24:31.149164Z","time spent":"386.502879ms","remote":"127.0.0.1:33062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T01:24:31.541726Z","caller":"traceutil/trace.go:171","msg":"trace[737903592] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"375.576254ms","start":"2026-04-07T01:24:31.166094Z","end":"2026-04-07T01:24:31.54167Z","steps":["trace[737903592] 'process raft request' (duration: 375.332037ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:24:31.541751Z","caller":"traceutil/trace.go:171","msg":"trace[889485252] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"385.432708ms","start":"2026-04-07T01:24:31.156284Z","end":"2026-04-07T01:24:31.541717Z","steps":["trace[889485252] 'process raft request' (duration: 385.002726ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:24:31.544233Z","caller":"traceutil/trace.go:171","msg":"trace[1474623276] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"360.488032ms","start":"2026-04-07T01:24:31.18356Z","end":"2026-04-07T01:24:31.544048Z","steps":["trace[1474623276] 'process raft request' (duration: 358.138907ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:24:31.54444Z","caller":"traceutil/trace.go:171","msg":"trace[1688485909] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"375.120281ms","start":"2026-04-07T01:24:31.168928Z","end":"2026-04-07T01:24:31.544048Z","steps":["trace[1688485909] 'process raft request' (duration: 372.616971ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:31.544588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:24:31.183548Z","time spent":"360.78899ms","remote":"127.0.0.1:33062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T01:24:31.544573Z","caller":"traceutil/trace.go:171","msg":"trace[1033802351] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"387.735573ms","start":"2026-04-07T01:24:31.156335Z","end":"2026-04-07T01:24:31.544071Z","steps":["trace[1033802351] 'process raft request' (duration: 385.060848ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:31.545935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:24:31.168923Z","time spent":"375.644636ms","remote":"127.0.0.1:33062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T01:24:31.546135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:24:31.156332Z","time spent":"388.430092ms","remote":"127.0.0.1:33062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T01:24:31.546762Z","caller":"traceutil/trace.go:171","msg":"trace[647791240] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"377.914129ms","start":"2026-04-07T01:24:31.168784Z","end":"2026-04-07T01:24:31.546698Z","steps":["trace[647791240] 'process raft request' (duration: 372.729535ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:31.546869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:24:31.168778Z","time spent":"378.049083ms","remote":"127.0.0.1:33062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T01:24:31.546941Z","caller":"traceutil/trace.go:171","msg":"trace[12936231] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"380.46722ms","start":"2026-04-07T01:24:31.166193Z","end":"2026-04-07T01:24:31.54666Z","steps":["trace[12936231] 'process raft request' (duration: 375.262885ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:31.547032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:24:31.166187Z","time spent":"380.797559ms","remote":"127.0.0.1:33062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T01:24:31.547171Z","caller":"traceutil/trace.go:171","msg":"trace[1037313215] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"378.679071ms","start":"2026-04-07T01:24:31.168137Z","end":"2026-04-07T01:24:31.546816Z","steps":["trace[1037313215] 'process raft request' (duration: 373.348012ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:24:31.547279Z","caller":"traceutil/trace.go:171","msg":"trace[939961914] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"326.670159ms","start":"2026-04-07T01:24:31.220575Z","end":"2026-04-07T01:24:31.547245Z","steps":["trace[939961914] 'process raft request' (duration: 321.229088ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:31.547333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:24:31.168118Z","time spent":"379.137833ms","remote":"127.0.0.1:33062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T01:24:31.547357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:24:31.220548Z","time spent":"326.770352ms","remote":"127.0.0.1:33062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T01:24:31.552467Z","caller":"traceutil/trace.go:171","msg":"trace[256736637] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"370.03932ms","start":"2026-04-07T01:24:31.177253Z","end":"2026-04-07T01:24:31.547293Z","steps":["trace[256736637] 'process raft request' (duration: 364.349541ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:31.552551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:24:31.177245Z","time spent":"375.265455ms","remote":"127.0.0.1:33062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T01:24:31.554639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:24:31.166049Z","time spent":"375.784419ms","remote":"127.0.0.1:33062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T01:24:31.552243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:24:31.156267Z","time spent":"385.655264ms","remote":"127.0.0.1:33062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T01:24:31.556244Z","caller":"traceutil/trace.go:171","msg":"trace[2130262366] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"225.930231ms","start":"2026-04-07T01:24:31.330279Z","end":"2026-04-07T01:24:31.556209Z","steps":["trace[2130262366] 'process raft request' (duration: 212.26892ms)","trace[2130262366] 'marshal mvccpb.KeyValue' {req_type:put; key:/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io; req_size:149903; } (duration: 13.449944ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:24:31.900677Z","caller":"traceutil/trace.go:171","msg":"trace[1263287250] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"163.766826ms","start":"2026-04-07T01:24:31.736881Z","end":"2026-04-07T01:24:31.900648Z","steps":["trace[1263287250] 'process raft request' (duration: 91.380019ms)","trace[1263287250] 'compare' (duration: 72.1288ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:24:31.900885Z","caller":"traceutil/trace.go:171","msg":"trace[143577420] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"149.741497ms","start":"2026-04-07T01:24:31.751135Z","end":"2026-04-07T01:24:31.900877Z","steps":["trace[143577420] 'process raft request' (duration: 149.438987ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:24:31.916236Z","caller":"traceutil/trace.go:171","msg":"trace[227502377] linearizableReadLoop","detail":"{readStateIndex:581; appliedIndex:578; }","duration":"139.610534ms","start":"2026-04-07T01:24:31.776602Z","end":"2026-04-07T01:24:31.916213Z","steps":["trace[227502377] 'read index received' (duration: 51.672992ms)","trace[227502377] 'applied index is now lower than readState.Index' (duration: 87.936281ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:24:31.916355Z","caller":"traceutil/trace.go:171","msg":"trace[947795342] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"144.037246ms","start":"2026-04-07T01:24:31.772309Z","end":"2026-04-07T01:24:31.916346Z","steps":["trace[947795342] 'process raft request' (duration: 143.751718ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:31.916522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.903261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:24:31.916553Z","caller":"traceutil/trace.go:171","msg":"trace[985544077] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:558; }","duration":"139.984084ms","start":"2026-04-07T01:24:31.776559Z","end":"2026-04-07T01:24:31.916543Z","steps":["trace[985544077] 'agreement among raft nodes before linearized reading' (duration: 139.918212ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:24:32.138668Z","caller":"traceutil/trace.go:171","msg":"trace[1302654899] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"162.004997ms","start":"2026-04-07T01:24:31.976631Z","end":"2026-04-07T01:24:32.138636Z","steps":["trace[1302654899] 'process raft request' (duration: 161.951395ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:24:32.139351Z","caller":"traceutil/trace.go:171","msg":"trace[480763139] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"224.534941ms","start":"2026-04-07T01:24:31.914802Z","end":"2026-04-07T01:24:32.139337Z","steps":["trace[480763139] 'process raft request' (duration: 193.64565ms)","trace[480763139] 'compare' (duration: 29.877142ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:24:32.139473Z","caller":"traceutil/trace.go:171","msg":"trace[93388169] linearizableReadLoop","detail":"{readStateIndex:582; appliedIndex:581; }","duration":"223.154574ms","start":"2026-04-07T01:24:31.916308Z","end":"2026-04-07T01:24:32.139463Z","steps":["trace[93388169] 'read index received' (duration: 192.15785ms)","trace[93388169] 'applied index is now lower than readState.Index' (duration: 30.995134ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:24:32.139556Z","caller":"traceutil/trace.go:171","msg":"trace[643006898] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"209.731169ms","start":"2026-04-07T01:24:31.929818Z","end":"2026-04-07T01:24:32.139549Z","steps":["trace[643006898] 'process raft request' (duration: 208.670019ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:32.139818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.787097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:24:32.139869Z","caller":"traceutil/trace.go:171","msg":"trace[1899104357] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:561; }","duration":"220.88527ms","start":"2026-04-07T01:24:31.918968Z","end":"2026-04-07T01:24:32.139853Z","steps":["trace[1899104357] 'agreement among raft nodes before linearized reading' (duration: 220.783408ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:32.139961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.313746ms","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-07T01:24:32.140064Z","caller":"traceutil/trace.go:171","msg":"trace[1686550055] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:561; }","duration":"304.457551ms","start":"2026-04-07T01:24:31.835586Z","end":"2026-04-07T01:24:32.140043Z","steps":["trace[1686550055] 'agreement among raft nodes before linearized reading' (duration: 304.219274ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:32.140065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.682473ms","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-07T01:24:32.140164Z","caller":"traceutil/trace.go:171","msg":"trace[923623670] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:561; }","duration":"315.836907ms","start":"2026-04-07T01:24:31.824301Z","end":"2026-04-07T01:24:32.140138Z","steps":["trace[923623670] 'agreement among raft nodes before linearized reading' (duration: 315.653632ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:32.140106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:24:31.835573Z","time spent":"304.524602ms","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-07T01:24:32.140162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.018075ms","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-07T01:24:32.140215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:24:31.824278Z","time spent":"315.9269ms","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-07T01:24:32.140267Z","caller":"traceutil/trace.go:171","msg":"trace[1846547807] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:561; }","duration":"159.175409ms","start":"2026-04-07T01:24:31.981064Z","end":"2026-04-07T01:24:32.140239Z","steps":["trace[1846547807] 'agreement among raft nodes before linearized reading' (duration: 158.917612ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:24:38.159389Z","caller":"traceutil/trace.go:171","msg":"trace[1220980505] linearizableReadLoop","detail":"{readStateIndex:646; appliedIndex:645; }","duration":"380.635732ms","start":"2026-04-07T01:24:37.77868Z","end":"2026-04-07T01:24:38.159315Z","steps":["trace[1220980505] 'read index received' (duration: 379.095287ms)","trace[1220980505] 'applied index is now lower than readState.Index' (duration: 1.538965ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:24:38.160401Z","caller":"traceutil/trace.go:171","msg":"trace[1643554722] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"444.937508ms","start":"2026-04-07T01:24:37.714981Z","end":"2026-04-07T01:24:38.159918Z","steps":["trace[1643554722] 'process raft request' (duration: 443.050465ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:38.160605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.389709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T01:24:38.160638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:24:37.714956Z","time spent":"445.523092ms","remote":"127.0.0.1:33102","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036265,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:24:38.160754Z","caller":"traceutil/trace.go:171","msg":"trace[1884374427] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:622; }","duration":"377.553983ms","start":"2026-04-07T01:24:37.783124Z","end":"2026-04-07T01:24:38.160678Z","steps":["trace[1884374427] 'agreement among raft nodes before linearized reading' (duration: 377.340898ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:38.160831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:24:37.783118Z","time spent":"377.696036ms","remote":"127.0.0.1:50480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-07T01:24:38.161348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.679928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:24:38.16148Z","caller":"traceutil/trace.go:171","msg":"trace[1420169129] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:622; }","duration":"262.77415ms","start":"2026-04-07T01:24:37.898616Z","end":"2026-04-07T01:24:38.161391Z","steps":["trace[1420169129] 'agreement among raft nodes before linearized reading' (duration: 262.666287ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:38.161605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.407217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:24:38.161804Z","caller":"traceutil/trace.go:171","msg":"trace[984167932] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:622; }","duration":"344.52263ms","start":"2026-04-07T01:24:37.817143Z","end":"2026-04-07T01:24:38.161666Z","steps":["trace[984167932] 'agreement among raft nodes before linearized reading' (duration: 344.191943ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:38.16178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.593101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T01:24:38.161867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:24:37.81713Z","time spent":"344.723025ms","remote":"127.0.0.1:50496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"info","ts":"2026-04-07T01:24:38.161933Z","caller":"traceutil/trace.go:171","msg":"trace[70464465] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:622; }","duration":"344.756895ms","start":"2026-04-07T01:24:37.817109Z","end":"2026-04-07T01:24:38.161866Z","steps":["trace[70464465] 'agreement among raft nodes before linearized reading' (duration: 344.280314ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:38.162011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:24:37.817099Z","time spent":"344.896419ms","remote":"127.0.0.1:50496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-07T01:24:38.160378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.648204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:24:38.162425Z","caller":"traceutil/trace.go:171","msg":"trace[1010746945] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:622; }","duration":"383.763792ms","start":"2026-04-07T01:24:37.778629Z","end":"2026-04-07T01:24:38.162393Z","steps":["trace[1010746945] 'agreement among raft nodes before linearized reading' (duration: 380.99384ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:38.162501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:24:37.778603Z","time spent":"383.883125ms","remote":"127.0.0.1:33018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-07T01:24:38.162625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.76345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:24:38.162707Z","caller":"traceutil/trace.go:171","msg":"trace[1807808659] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:622; }","duration":"378.821071ms","start":"2026-04-07T01:24:37.783848Z","end":"2026-04-07T01:24:38.162669Z","steps":["trace[1807808659] 'agreement among raft nodes before linearized reading' (duration: 378.495084ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:38.162734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.456061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:24:38.162801Z","caller":"traceutil/trace.go:171","msg":"trace[2128672374] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:622; }","duration":"301.554764ms","start":"2026-04-07T01:24:37.861232Z","end":"2026-04-07T01:24:38.162787Z","steps":["trace[2128672374] 'agreement among raft nodes before linearized reading' (duration: 301.450192ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:38.162834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.509348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T01:24:38.162848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:24:37.861162Z","time spent":"301.667736ms","remote":"127.0.0.1:50518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 "} {"level":"info","ts":"2026-04-07T01:24:38.162885Z","caller":"traceutil/trace.go:171","msg":"trace[296098414] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:622; }","duration":"379.585118ms","start":"2026-04-07T01:24:37.783275Z","end":"2026-04-07T01:24:38.16286Z","steps":["trace[296098414] 'agreement among raft nodes before linearized reading' (duration: 379.511237ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:38.162929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:24:37.783239Z","time spent":"379.679601ms","remote":"127.0.0.1:50480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-07T01:24:38.163303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.143397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:24:38.163467Z","caller":"traceutil/trace.go:171","msg":"trace[586073833] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:622; }","duration":"246.262429ms","start":"2026-04-07T01:24:37.917129Z","end":"2026-04-07T01:24:38.163392Z","steps":["trace[586073833] 'agreement among raft nodes before linearized reading' (duration: 246.118696ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:38.163538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.10988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:24:38.163585Z","caller":"traceutil/trace.go:171","msg":"trace[1810570597] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:622; }","duration":"324.157482ms","start":"2026-04-07T01:24:37.839406Z","end":"2026-04-07T01:24:38.163563Z","steps":["trace[1810570597] 'agreement among raft nodes before linearized reading' (duration: 323.982198ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:38.163628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:24:37.839401Z","time spent":"324.216663ms","remote":"127.0.0.1:50512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-07T01:24:38.163782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.385267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:24:38.163845Z","caller":"traceutil/trace.go:171","msg":"trace[1895449196] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:622; }","duration":"324.479629ms","start":"2026-04-07T01:24:37.839349Z","end":"2026-04-07T01:24:38.163828Z","steps":["trace[1895449196] 'agreement among raft nodes before linearized reading' (duration: 324.340296ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:38.163928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:24:37.839322Z","time spent":"324.593382ms","remote":"127.0.0.1:50512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-07T01:24:38.162757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:24:37.783828Z","time spent":"378.905183ms","remote":"127.0.0.1:50480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-07T01:24:38.164435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.145591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T01:24:38.164551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.281245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:24:38.164595Z","caller":"traceutil/trace.go:171","msg":"trace[847461568] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:622; }","duration":"248.309436ms","start":"2026-04-07T01:24:37.916247Z","end":"2026-04-07T01:24:38.164557Z","steps":["trace[847461568] 'agreement among raft nodes before linearized reading' (duration: 248.135101ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:24:38.164619Z","caller":"traceutil/trace.go:171","msg":"trace[237201970] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:622; }","duration":"248.356287ms","start":"2026-04-07T01:24:37.916228Z","end":"2026-04-07T01:24:38.164585Z","steps":["trace[237201970] 'agreement among raft nodes before linearized reading' (duration: 248.255803ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:38.164726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.999029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T01:24:38.16475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.430164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:24:38.164795Z","caller":"traceutil/trace.go:171","msg":"trace[273035749] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:622; }","duration":"280.102371ms","start":"2026-04-07T01:24:37.884666Z","end":"2026-04-07T01:24:38.164768Z","steps":["trace[273035749] 'agreement among raft nodes before linearized reading' (duration: 280.005529ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:24:38.164801Z","caller":"traceutil/trace.go:171","msg":"trace[1658762034] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:622; }","duration":"266.513106ms","start":"2026-04-07T01:24:37.898276Z","end":"2026-04-07T01:24:38.164789Z","steps":["trace[1658762034] 'agreement among raft nodes before linearized reading' (duration: 266.431634ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:38.164856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.40421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:24:38.164979Z","caller":"traceutil/trace.go:171","msg":"trace[1727880594] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:622; }","duration":"265.561374ms","start":"2026-04-07T01:24:37.899391Z","end":"2026-04-07T01:24:38.164953Z","steps":["trace[1727880594] 'agreement among raft nodes before linearized reading' (duration: 265.39523ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:38.163329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.803781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:24:38.165145Z","caller":"traceutil/trace.go:171","msg":"trace[19250869] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:622; }","duration":"324.626103ms","start":"2026-04-07T01:24:37.840502Z","end":"2026-04-07T01:24:38.165128Z","steps":["trace[19250869] 'agreement among raft nodes before linearized reading' (duration: 322.779151ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:38.165221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:24:37.840495Z","time spent":"324.708094ms","remote":"127.0.0.1:50512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 "} {"level":"warn","ts":"2026-04-07T01:24:38.165562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.27371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T01:24:38.165601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.092931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:24:38.165626Z","caller":"traceutil/trace.go:171","msg":"trace[1196924694] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:622; }","duration":"282.366761ms","start":"2026-04-07T01:24:37.883245Z","end":"2026-04-07T01:24:38.165612Z","steps":["trace[1196924694] 'agreement among raft nodes before linearized reading' (duration: 282.277119ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:24:38.165659Z","caller":"traceutil/trace.go:171","msg":"trace[383359939] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:622; }","duration":"304.145692ms","start":"2026-04-07T01:24:37.861493Z","end":"2026-04-07T01:24:38.165638Z","steps":["trace[383359939] 'agreement among raft nodes before linearized reading' (duration: 304.06789ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:38.165704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:24:37.861476Z","time spent":"304.207423ms","remote":"127.0.0.1:50518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 "} {"level":"warn","ts":"2026-04-07T01:24:38.170714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.360789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:24:38.170845Z","caller":"traceutil/trace.go:171","msg":"trace[1116169321] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:622; }","duration":"309.512223ms","start":"2026-04-07T01:24:37.861287Z","end":"2026-04-07T01:24:38.170799Z","steps":["trace[1116169321] 'agreement among raft nodes before linearized reading' (duration: 299.961628ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:38.170897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:24:37.861278Z","time spent":"309.608235ms","remote":"127.0.0.1:50518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"info","ts":"2026-04-07T01:24:38.402173Z","caller":"traceutil/trace.go:171","msg":"trace[862656297] linearizableReadLoop","detail":"{readStateIndex:647; appliedIndex:646; }","duration":"195.720602ms","start":"2026-04-07T01:24:38.206421Z","end":"2026-04-07T01:24:38.402142Z","steps":["trace[862656297] 'read index received' (duration: 102.68365ms)","trace[862656297] 'applied index is now lower than readState.Index' (duration: 93.035032ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:24:38.402375Z","caller":"traceutil/trace.go:171","msg":"trace[693744593] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"196.845507ms","start":"2026-04-07T01:24:38.205472Z","end":"2026-04-07T01:24:38.402317Z","steps":["trace[693744593] 'process raft request' (duration: 103.688412ms)","trace[693744593] 'compare' (duration: 92.821828ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:24:38.402514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.07306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-07T01:24:38.40262Z","caller":"traceutil/trace.go:171","msg":"trace[460360427] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:623; }","duration":"196.181713ms","start":"2026-04-07T01:24:38.206416Z","end":"2026-04-07T01:24:38.402598Z","steps":["trace[460360427] 'agreement among raft nodes before linearized reading' (duration: 195.908796ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:39.085004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.53408ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T01:24:39.085255Z","caller":"traceutil/trace.go:171","msg":"trace[262944332] linearizableReadLoop","detail":"{readStateIndex:650; appliedIndex:647; }","duration":"306.34814ms","start":"2026-04-07T01:24:38.778889Z","end":"2026-04-07T01:24:39.085238Z","steps":["trace[262944332] 'read index received' (duration: 89.498613ms)","trace[262944332] 'applied index is now lower than readState.Index' (duration: 216.848377ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:24:39.085304Z","caller":"traceutil/trace.go:171","msg":"trace[92402025] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"876.094507ms","start":"2026-04-07T01:24:38.209175Z","end":"2026-04-07T01:24:39.085269Z","steps":["trace[92402025] 'process raft request' (duration: 659.200119ms)","trace[92402025] 'compare' (duration: 216.269724ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:24:39.085387Z","caller":"traceutil/trace.go:171","msg":"trace[1908402774] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"677.269455ms","start":"2026-04-07T01:24:38.408107Z","end":"2026-04-07T01:24:39.085377Z","steps":["trace[1908402774] 'process raft request' (duration: 677.086701ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:39.085463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:24:38.408073Z","time spent":"677.343336ms","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T01:24:39.085463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:24:38.209164Z","time spent":"876.210559ms","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:24:39.085448Z","caller":"traceutil/trace.go:171","msg":"trace[965906925] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"850.103452ms","start":"2026-04-07T01:24:38.235297Z","end":"2026-04-07T01:24:39.085401Z","steps":["trace[965906925] 'process raft request' (duration: 849.822306ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:39.085791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:24:38.235266Z","time spent":"850.372388ms","remote":"127.0.0.1:33322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T01:24:39.085821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.942774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T01:24:39.085794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.181363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-07T01:24:39.08586Z","caller":"traceutil/trace.go:171","msg":"trace[1143051040] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:626; }","duration":"307.034136ms","start":"2026-04-07T01:24:38.778812Z","end":"2026-04-07T01:24:39.085847Z","steps":["trace[1143051040] 'agreement among raft nodes before linearized reading' (duration: 306.975765ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:39.085892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:24:38.778779Z","time spent":"307.106848ms","remote":"127.0.0.1:33004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-07T01:24:39.085908Z","caller":"traceutil/trace.go:171","msg":"trace[183338345] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:626; }","duration":"252.353907ms","start":"2026-04-07T01:24:38.833526Z","end":"2026-04-07T01:24:39.085879Z","steps":["trace[183338345] 'agreement among raft nodes before linearized reading' (duration: 252.06869ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:24:40.262397Z","caller":"traceutil/trace.go:171","msg":"trace[1543307211] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"752.544638ms","start":"2026-04-07T01:24:39.509821Z","end":"2026-04-07T01:24:40.262366Z","steps":["trace[1543307211] 'process raft request' (duration: 751.915234ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:40.262567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:24:39.509783Z","time spent":"752.69172ms","remote":"127.0.0.1:33102","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:24:40.48741Z","caller":"traceutil/trace.go:171","msg":"trace[569658516] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"161.321179ms","start":"2026-04-07T01:24:40.32605Z","end":"2026-04-07T01:24:40.487371Z","steps":["trace[569658516] 'process raft request' (duration: 161.063003ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:24:42.092654Z","caller":"traceutil/trace.go:171","msg":"trace[1432548540] linearizableReadLoop","detail":"{readStateIndex:676; appliedIndex:675; }","duration":"313.514912ms","start":"2026-04-07T01:24:41.779095Z","end":"2026-04-07T01:24:42.09261Z","steps":["trace[1432548540] 'read index received' (duration: 290.809472ms)","trace[1432548540] 'applied index is now lower than readState.Index' (duration: 22.70302ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:24:42.093204Z","caller":"traceutil/trace.go:171","msg":"trace[2110712100] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"382.711789ms","start":"2026-04-07T01:24:41.710464Z","end":"2026-04-07T01:24:42.093176Z","steps":["trace[2110712100] 'process raft request' (duration: 359.577519ms)","trace[2110712100] 'compare' (duration: 22.203909ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:24:42.093355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:24:41.710432Z","time spent":"382.837182ms","remote":"127.0.0.1:33092","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":854,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T01:24:42.092975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.85669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:24:42.093696Z","caller":"traceutil/trace.go:171","msg":"trace[882875130] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:651; }","duration":"314.669518ms","start":"2026-04-07T01:24:41.779004Z","end":"2026-04-07T01:24:42.093673Z","steps":["trace[882875130] 'agreement among raft nodes before linearized reading' (duration: 313.774918ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:42.094282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:24:41.778967Z","time spent":"315.005255ms","remote":"127.0.0.1:33004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-07T01:24:53.324777Z","caller":"traceutil/trace.go:171","msg":"trace[177959057] transaction","detail":"{read_only:false; response_revision:777; number_of_response:1; }","duration":"166.780331ms","start":"2026-04-07T01:24:53.157963Z","end":"2026-04-07T01:24:53.324743Z","steps":["trace[177959057] 'process raft request' (duration: 166.623167ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:24:53.328911Z","caller":"traceutil/trace.go:171","msg":"trace[716699995] linearizableReadLoop","detail":"{readStateIndex:806; appliedIndex:804; }","duration":"167.200371ms","start":"2026-04-07T01:24:53.161694Z","end":"2026-04-07T01:24:53.328894Z","steps":["trace[716699995] 'read index received' (duration: 162.926385ms)","trace[716699995] 'applied index is now lower than readState.Index' (duration: 4.272806ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:24:53.329136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.417976ms","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-07T01:24:53.329178Z","caller":"traceutil/trace.go:171","msg":"trace[1404976007] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:778; }","duration":"167.513698ms","start":"2026-04-07T01:24:53.161651Z","end":"2026-04-07T01:24:53.329165Z","steps":["trace[1404976007] 'agreement among raft nodes before linearized reading' (duration: 167.306314ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:24:53.329171Z","caller":"traceutil/trace.go:171","msg":"trace[496710653] transaction","detail":"{read_only:false; response_revision:778; number_of_response:1; }","duration":"168.847488ms","start":"2026-04-07T01:24:53.160305Z","end":"2026-04-07T01:24:53.329152Z","steps":["trace[496710653] 'process raft request' (duration: 168.509881ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:56.413455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"742.230593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-fcjhq\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-04-07T01:24:56.413539Z","caller":"traceutil/trace.go:171","msg":"trace[821217312] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-fcjhq; range_end:; response_count:1; response_revision:793; }","duration":"742.373086ms","start":"2026-04-07T01:24:55.671147Z","end":"2026-04-07T01:24:56.41352Z","steps":["trace[821217312] 'range keys from in-memory index tree' (duration: 741.973627ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:56.413583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:24:55.671124Z","time spent":"742.447127ms","remote":"127.0.0.1:33188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3987,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-fcjhq\" "} {"level":"warn","ts":"2026-04-07T01:24:56.414425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"636.175053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:24:56.414486Z","caller":"traceutil/trace.go:171","msg":"trace[653782427] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:793; }","duration":"636.298256ms","start":"2026-04-07T01:24:55.778178Z","end":"2026-04-07T01:24:56.414476Z","steps":["trace[653782427] 'range keys from in-memory index tree' (duration: 636.097651ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:56.414517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:24:55.778157Z","time spent":"636.352366ms","remote":"127.0.0.1:33004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-07T01:25:03.368155Z","caller":"traceutil/trace.go:171","msg":"trace[1971947492] transaction","detail":"{read_only:false; response_revision:863; number_of_response:1; }","duration":"112.587655ms","start":"2026-04-07T01:25:03.25554Z","end":"2026-04-07T01:25:03.368128Z","steps":["trace[1971947492] 'process raft request' (duration: 112.308879ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:25:03.368626Z","caller":"traceutil/trace.go:171","msg":"trace[1431041649] transaction","detail":"{read_only:false; response_revision:864; number_of_response:1; }","duration":"110.820357ms","start":"2026-04-07T01:25:03.25776Z","end":"2026-04-07T01:25:03.36858Z","steps":["trace[1431041649] 'process raft request' (duration: 110.302665ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:25:04.376894Z","caller":"traceutil/trace.go:171","msg":"trace[18773583] transaction","detail":"{read_only:false; response_revision:873; number_of_response:1; }","duration":"124.534504ms","start":"2026-04-07T01:25:04.252323Z","end":"2026-04-07T01:25:04.376858Z","steps":["trace[18773583] 'process raft request' (duration: 124.321559ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:25:10.644639Z","caller":"traceutil/trace.go:171","msg":"trace[1908584576] transaction","detail":"{read_only:false; response_revision:929; number_of_response:1; }","duration":"124.33365ms","start":"2026-04-07T01:25:10.520279Z","end":"2026-04-07T01:25:10.644613Z","steps":["trace[1908584576] 'process raft request' (duration: 52.581969ms)","trace[1908584576] 'compare' (duration: 71.643938ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:25:10.686195Z","caller":"traceutil/trace.go:171","msg":"trace[740390322] linearizableReadLoop","detail":"{readStateIndex:963; appliedIndex:960; }","duration":"144.257477ms","start":"2026-04-07T01:25:10.54192Z","end":"2026-04-07T01:25:10.686177Z","steps":["trace[740390322] 'read index received' (duration: 30.945034ms)","trace[740390322] 'applied index is now lower than readState.Index' (duration: 113.311533ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:25:10.686235Z","caller":"traceutil/trace.go:171","msg":"trace[1530084476] transaction","detail":"{read_only:false; response_revision:930; number_of_response:1; }","duration":"163.780335ms","start":"2026-04-07T01:25:10.522424Z","end":"2026-04-07T01:25:10.686205Z","steps":["trace[1530084476] 'process raft request' (duration: 163.589351ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:25:10.6865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.548704ms","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-07T01:25:10.686492Z","caller":"traceutil/trace.go:171","msg":"trace[1153272525] transaction","detail":"{read_only:false; response_revision:931; number_of_response:1; }","duration":"161.301789ms","start":"2026-04-07T01:25:10.52515Z","end":"2026-04-07T01:25:10.686452Z","steps":["trace[1153272525] 'process raft request' (duration: 160.973592ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:25:10.686551Z","caller":"traceutil/trace.go:171","msg":"trace[1471798314] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:931; }","duration":"144.662646ms","start":"2026-04-07T01:25:10.541875Z","end":"2026-04-07T01:25:10.686538Z","steps":["trace[1471798314] 'agreement among raft nodes before linearized reading' (duration: 144.492483ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:25:11.319373Z","caller":"traceutil/trace.go:171","msg":"trace[1096543625] transaction","detail":"{read_only:false; response_revision:935; number_of_response:1; }","duration":"133.875914ms","start":"2026-04-07T01:25:11.185418Z","end":"2026-04-07T01:25:11.319294Z","steps":["trace[1096543625] 'process raft request' (duration: 133.671339ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:25:31.82114Z","caller":"traceutil/trace.go:171","msg":"trace[923116146] linearizableReadLoop","detail":"{readStateIndex:1048; appliedIndex:1047; }","duration":"339.774292ms","start":"2026-04-07T01:25:31.481332Z","end":"2026-04-07T01:25:31.821107Z","steps":["trace[923116146] 'read index received' (duration: 339.624069ms)","trace[923116146] 'applied index is now lower than readState.Index' (duration: 144.513µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:25:31.821362Z","caller":"traceutil/trace.go:171","msg":"trace[1599178554] transaction","detail":"{read_only:false; response_revision:1010; number_of_response:1; }","duration":"421.690611ms","start":"2026-04-07T01:25:31.399604Z","end":"2026-04-07T01:25:31.821294Z","steps":["trace[1599178554] 'process raft request' (duration: 421.281882ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:25:31.821448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.091009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.78\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-07T01:25:31.821506Z","caller":"traceutil/trace.go:171","msg":"trace[284761957] range","detail":"{range_begin:/registry/masterleases/199.204.45.78; range_end:; response_count:1; response_revision:1010; }","duration":"340.218603ms","start":"2026-04-07T01:25:31.481269Z","end":"2026-04-07T01:25:31.821488Z","steps":["trace[284761957] 'agreement among raft nodes before linearized reading' (duration: 339.998198ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:25:31.82155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:25:31.481249Z","time spent":"340.292434ms","remote":"127.0.0.1:33048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.78\" "} {"level":"warn","ts":"2026-04-07T01:25:31.821603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:25:31.399579Z","time spent":"421.893595ms","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T01:25:32.488089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"574.236194ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T01:25:32.488438Z","caller":"traceutil/trace.go:171","msg":"trace[925928369] linearizableReadLoop","detail":"{readStateIndex:1049; appliedIndex:1048; }","duration":"667.183579ms","start":"2026-04-07T01:25:31.821232Z","end":"2026-04-07T01:25:32.488416Z","steps":["trace[925928369] 'read index received' (duration: 92.435804ms)","trace[925928369] 'applied index is now lower than readState.Index' (duration: 574.745955ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:25:32.489117Z","caller":"traceutil/trace.go:171","msg":"trace[494160010] transaction","detail":"{read_only:false; response_revision:1011; number_of_response:1; }","duration":"753.143007ms","start":"2026-04-07T01:25:31.735955Z","end":"2026-04-07T01:25:32.489098Z","steps":["trace[494160010] 'process raft request' (duration: 177.782298ms)","trace[494160010] 'compare' (duration: 573.857224ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:25:32.489211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:25:31.735931Z","time spent":"753.239589ms","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T01:25:32.489305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"732.75339ms","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-07T01:25:32.489418Z","caller":"traceutil/trace.go:171","msg":"trace[10755315] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1011; }","duration":"732.947484ms","start":"2026-04-07T01:25:31.756446Z","end":"2026-04-07T01:25:32.489394Z","steps":["trace[10755315] 'agreement among raft nodes before linearized reading' (duration: 732.585106ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:25:32.4895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:25:31.756421Z","time spent":"733.053587ms","remote":"127.0.0.1:33250","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-07T01:25:32.489476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"712.503846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:25:32.489563Z","caller":"traceutil/trace.go:171","msg":"trace[506631662] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1011; }","duration":"712.628919ms","start":"2026-04-07T01:25:31.776914Z","end":"2026-04-07T01:25:32.489543Z","steps":["trace[506631662] 'agreement among raft nodes before linearized reading' (duration: 712.447235ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:25:32.489544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"729.838475ms","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-07T01:25:32.489601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:25:31.776906Z","time spent":"712.68868ms","remote":"127.0.0.1:33004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-07T01:25:32.489635Z","caller":"traceutil/trace.go:171","msg":"trace[1060804630] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1011; }","duration":"729.942377ms","start":"2026-04-07T01:25:31.75967Z","end":"2026-04-07T01:25:32.489612Z","steps":["trace[1060804630] 'agreement among raft nodes before linearized reading' (duration: 729.672831ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:25:32.489695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:25:31.7596Z","time spent":"730.08629ms","remote":"127.0.0.1:33250","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-07T01:25:32.489676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"731.814019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-07T01:25:32.489795Z","caller":"traceutil/trace.go:171","msg":"trace[601871098] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1011; }","duration":"731.991733ms","start":"2026-04-07T01:25:31.757778Z","end":"2026-04-07T01:25:32.48977Z","steps":["trace[601871098] 'agreement among raft nodes before linearized reading' (duration: 731.675076ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:25:32.489846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:25:31.757754Z","time spent":"732.083744ms","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-07T01:25:32.508337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:25:31.822986Z","time spent":"685.346736ms","remote":"127.0.0.1:33048","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-07T01:25:33.278852Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967603750204626021,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T01:25:33.654365Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.145687354s","expected-duration":"1s"} {"level":"info","ts":"2026-04-07T01:25:33.659108Z","caller":"traceutil/trace.go:171","msg":"trace[1932182246] transaction","detail":"{read_only:false; response_revision:1012; number_of_response:1; }","duration":"1.165334385s","start":"2026-04-07T01:25:32.493736Z","end":"2026-04-07T01:25:33.659071Z","steps":["trace[1932182246] 'process raft request' (duration: 1.161043379s)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:25:33.659218Z","caller":"traceutil/trace.go:171","msg":"trace[290506608] linearizableReadLoop","detail":"{readStateIndex:1054; appliedIndex:1050; }","duration":"881.398924ms","start":"2026-04-07T01:25:32.77781Z","end":"2026-04-07T01:25:33.659209Z","steps":["trace[290506608] 'read index received' (duration: 876.900334ms)","trace[290506608] 'applied index is now lower than readState.Index' (duration: 4.49769ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:25:33.659217Z","caller":"traceutil/trace.go:171","msg":"trace[1829413513] transaction","detail":"{read_only:false; response_revision:1013; number_of_response:1; }","duration":"1.165333525s","start":"2026-04-07T01:25:32.493829Z","end":"2026-04-07T01:25:33.659162Z","steps":["trace[1829413513] 'process raft request' (duration: 1.16511116s)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:25:33.659291Z","caller":"traceutil/trace.go:171","msg":"trace[723777668] transaction","detail":"{read_only:false; response_revision:1015; number_of_response:1; }","duration":"1.149635792s","start":"2026-04-07T01:25:32.50965Z","end":"2026-04-07T01:25:33.659285Z","steps":["trace[723777668] 'process raft request' (duration: 1.149416327s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:25:33.659314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:25:32.493717Z","time spent":"1.165490958s","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T01:25:33.659383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:25:32.50962Z","time spent":"1.149690384s","remote":"127.0.0.1:33048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T01:25:33.659382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:25:32.493807Z","time spent":"1.165487778s","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T01:25:33.659448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"841.637762ms","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-07T01:25:33.65952Z","caller":"traceutil/trace.go:171","msg":"trace[502332715] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1015; }","duration":"841.809316ms","start":"2026-04-07T01:25:32.817692Z","end":"2026-04-07T01:25:33.659501Z","steps":["trace[502332715] 'agreement among raft nodes before linearized reading' (duration: 841.624992ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:25:33.659139Z","caller":"traceutil/trace.go:171","msg":"trace[136141445] transaction","detail":"{read_only:false; response_revision:1014; number_of_response:1; }","duration":"1.165089099s","start":"2026-04-07T01:25:32.494018Z","end":"2026-04-07T01:25:33.659107Z","steps":["trace[136141445] 'process raft request' (duration: 1.165010437s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:25:33.659555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"881.746882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T01:25:33.659571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:25:32.817663Z","time spent":"841.898878ms","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-07T01:25:33.659585Z","caller":"traceutil/trace.go:171","msg":"trace[392852590] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1015; }","duration":"881.828073ms","start":"2026-04-07T01:25:32.777748Z","end":"2026-04-07T01:25:33.659576Z","steps":["trace[392852590] 'agreement among raft nodes before linearized reading' (duration: 881.767582ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:25:33.65961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:25:32.777721Z","time spent":"881.884445ms","remote":"127.0.0.1:33004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-07T01:25:33.659614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:25:32.493994Z","time spent":"1.165585481s","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T01:25:33.659732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"786.182579ms","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-07T01:25:33.659761Z","caller":"traceutil/trace.go:171","msg":"trace[738744649] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1015; }","duration":"786.25367ms","start":"2026-04-07T01:25:32.873498Z","end":"2026-04-07T01:25:33.659751Z","steps":["trace[738744649] 'agreement among raft nodes before linearized reading' (duration: 786.174298ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:25:33.659788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:25:32.873478Z","time spent":"786.304172ms","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-07T01:26:00.445511Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967603750204626252,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T01:26:00.946577Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967603750204626252,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T01:26:01.447253Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967603750204626252,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T01:26:01.947441Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967603750204626252,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T01:26:02.448502Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967603750204626252,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T01:26:02.949745Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967603750204626252,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T01:26:03.450574Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967603750204626252,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T01:26:03.778045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000116526s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-07T01:26:03.778285Z","caller":"traceutil/trace.go:171","msg":"trace[4843725] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000410553s","start":"2026-04-07T01:26:01.777849Z","end":"2026-04-07T01:26:03.778259Z","steps":["trace[4843725] 'agreement among raft nodes before linearized reading' (duration: 2.000149727s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:03.778371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:01.777821Z","time spent":"2.000531965s","remote":"127.0.0.1:33004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/07 01:26:03 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-07T01:26:03.951296Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967603750204626252,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T01:26:04.45253Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967603750204626252,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T01:26:04.865102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:25:59.86654Z","time spent":"4.998551268s","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-04-07T01:26:04.943503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.998953057s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-07T01:26:04.943597Z","caller":"traceutil/trace.go:171","msg":"trace[1832733609] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"4.999121371s","start":"2026-04-07T01:25:59.944454Z","end":"2026-04-07T01:26:04.943576Z","steps":["trace[1832733609] 'agreement among raft nodes before linearized reading' (duration: 4.998990108s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:04.943651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:25:59.944387Z","time spent":"4.999253413s","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} 2026/04/07 01:26:04 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-07T01:26:04.953642Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967603750204626252,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T01:26:04.96642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999921239s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-07T01:26:04.966744Z","caller":"traceutil/trace.go:171","msg":"trace[942009117] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; }","duration":"5.000364188s","start":"2026-04-07T01:25:59.966332Z","end":"2026-04-07T01:26:04.966696Z","steps":["trace[942009117] 'agreement among raft nodes before linearized reading' (duration: 5.00001655s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:04.966858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:25:59.966308Z","time spent":"5.000534961s","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-07T01:26:05.025602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:00.028024Z","time spent":"4.997571655s","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} 2026/04/07 01:26:05 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-07T01:26:05.447536Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"5.580801725s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-07T01:26:05.778872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000178818s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-07T01:26:05.778943Z","caller":"traceutil/trace.go:171","msg":"trace[771411881] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000378133s","start":"2026-04-07T01:26:03.778548Z","end":"2026-04-07T01:26:05.778926Z","steps":["trace[771411881] 'agreement among raft nodes before linearized reading' (duration: 2.000283141s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:05.778983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:03.778489Z","time spent":"2.000485465s","remote":"127.0.0.1:33018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/07 01:26:05 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-07T01:26:06.808848Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.360804111s","expected-duration":"1s"} {"level":"info","ts":"2026-04-07T01:26:06.809384Z","caller":"traceutil/trace.go:171","msg":"trace[2005456537] linearizableReadLoop","detail":"{readStateIndex:1144; appliedIndex:1141; }","duration":"6.864837338s","start":"2026-04-07T01:25:59.944514Z","end":"2026-04-07T01:26:06.809352Z","steps":["trace[2005456537] 'read index received' (duration: 5.503630858s)","trace[2005456537] 'applied index is now lower than readState.Index' (duration: 1.36120503s)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:26:06.809529Z","caller":"traceutil/trace.go:171","msg":"trace[994104356] transaction","detail":"{read_only:false; response_revision:1100; number_of_response:1; }","duration":"4.012096648s","start":"2026-04-07T01:26:02.79742Z","end":"2026-04-07T01:26:06.809516Z","steps":["trace[994104356] 'process raft request' (duration: 4.011879163s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:06.809666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:02.797389Z","time spent":"4.01217896s","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T01:26:06.817029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:05.782911Z","time spent":"1.034108167s","remote":"127.0.0.1:33092","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-04-07T01:26:06.817081Z","caller":"traceutil/trace.go:171","msg":"trace[447129324] transaction","detail":"{read_only:false; response_revision:1101; number_of_response:1; }","duration":"110.571386ms","start":"2026-04-07T01:26:06.706491Z","end":"2026-04-07T01:26:06.817062Z","steps":["trace[447129324] 'process raft request' (duration: 110.411293ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:07.012257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.2289ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-07T01:26:07.012541Z","caller":"traceutil/trace.go:171","msg":"trace[1028703099] linearizableReadLoop","detail":"{readStateIndex:1147; appliedIndex:1144; }","duration":"203.029575ms","start":"2026-04-07T01:26:06.809472Z","end":"2026-04-07T01:26:07.012502Z","steps":["trace[1028703099] 'read index received' (duration: 7.243841ms)","trace[1028703099] 'applied index is now lower than readState.Index' (duration: 195.784444ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:26:07.012593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.520967698s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:26:07.012658Z","caller":"traceutil/trace.go:171","msg":"trace[1574230640] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1102; }","duration":"1.5210714s","start":"2026-04-07T01:26:05.49157Z","end":"2026-04-07T01:26:07.012641Z","steps":["trace[1574230640] 'agreement among raft nodes before linearized reading' (duration: 1.520943597s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:07.012636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.150952815s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-07T01:26:07.012699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:05.491486Z","time spent":"1.521202563s","remote":"127.0.0.1:50434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"info","ts":"2026-04-07T01:26:07.012729Z","caller":"traceutil/trace.go:171","msg":"trace[471858357] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1102; }","duration":"3.151127919s","start":"2026-04-07T01:26:03.861578Z","end":"2026-04-07T01:26:07.012705Z","steps":["trace[471858357] 'agreement among raft nodes before linearized reading' (duration: 3.150932455s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:07.012786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:03.861554Z","time spent":"3.151218521s","remote":"127.0.0.1:50542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":30,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"info","ts":"2026-04-07T01:26:07.012831Z","caller":"traceutil/trace.go:171","msg":"trace[273578021] transaction","detail":"{read_only:false; response_revision:1103; number_of_response:1; }","duration":"194.121916ms","start":"2026-04-07T01:26:06.818696Z","end":"2026-04-07T01:26:07.012818Z","steps":["trace[273578021] 'process raft request' (duration: 193.698977ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:07.301929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"852.750176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-07T01:26:07.301952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.633497355s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T01:26:07.302058Z","caller":"traceutil/trace.go:171","msg":"trace[1922402062] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1103; }","duration":"5.633655418s","start":"2026-04-07T01:26:01.668376Z","end":"2026-04-07T01:26:07.302031Z","steps":["trace[1922402062] 'agreement among raft nodes before linearized reading' (duration: 5.344310829s)","trace[1922402062] 'count revisions from in-memory index tree' (duration: 289.195336ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:26:07.302056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.485831741s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T01:26:07.302073Z","caller":"traceutil/trace.go:171","msg":"trace[751976845] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1103; }","duration":"852.96196ms","start":"2026-04-07T01:26:06.449062Z","end":"2026-04-07T01:26:07.302024Z","steps":["trace[751976845] 'agreement among raft nodes before linearized reading' (duration: 563.687032ms)","trace[751976845] 'count revisions from in-memory index tree' (duration: 289.082954ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:26:07.302114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:01.668355Z","time spent":"5.633746111s","remote":"127.0.0.1:38252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":3,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true "} {"level":"info","ts":"2026-04-07T01:26:07.30213Z","caller":"traceutil/trace.go:171","msg":"trace[96888529] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1103; }","duration":"1.485979174s","start":"2026-04-07T01:26:05.816135Z","end":"2026-04-07T01:26:07.302114Z","steps":["trace[96888529] 'agreement among raft nodes before linearized reading' (duration: 1.196718516s)","trace[96888529] 'count revisions from in-memory index tree' (duration: 289.163695ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:26:07.302152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.863875ms","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-07T01:26:07.302172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:05.816089Z","time spent":"1.486072476s","remote":"127.0.0.1:33174","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":30,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true "} {"level":"warn","ts":"2026-04-07T01:26:07.302199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.81814624s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.78\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:26:07.302215Z","caller":"traceutil/trace.go:171","msg":"trace[50053958] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1103; }","duration":"433.955357ms","start":"2026-04-07T01:26:06.868231Z","end":"2026-04-07T01:26:07.302187Z","steps":["trace[50053958] 'agreement among raft nodes before linearized reading' (duration: 144.568276ms)","trace[50053958] 'range keys from in-memory index tree' (duration: 289.214887ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:26:07.302233Z","caller":"traceutil/trace.go:171","msg":"trace[1056218995] range","detail":"{range_begin:/registry/masterleases/199.204.45.78; range_end:; response_count:0; response_revision:1103; }","duration":"5.818214801s","start":"2026-04-07T01:26:01.484007Z","end":"2026-04-07T01:26:07.302222Z","steps":["trace[1056218995] 'agreement among raft nodes before linearized reading' (duration: 5.528687668s)","trace[1056218995] 'range keys from in-memory index tree' (duration: 289.488683ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:26:07.302257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:06.86821Z","time spent":"434.037759ms","remote":"127.0.0.1:33250","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-07T01:26:07.302265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:01.483978Z","time spent":"5.818277423s","remote":"127.0.0.1:33048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":28,"request content":"key:\"/registry/masterleases/199.204.45.78\" "} {"level":"warn","ts":"2026-04-07T01:26:07.302414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.346438387s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-07T01:26:07.302405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.23626118s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T01:26:07.302499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.268444195s","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-07T01:26:07.302508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.247020724s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T01:26:07.302514Z","caller":"traceutil/trace.go:171","msg":"trace[1985587184] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:1103; }","duration":"5.236456564s","start":"2026-04-07T01:26:02.066029Z","end":"2026-04-07T01:26:07.302486Z","steps":["trace[1985587184] 'agreement among raft nodes before linearized reading' (duration: 4.946634324s)","trace[1985587184] 'count revisions from in-memory index tree' (duration: 289.636256ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:26:07.30254Z","caller":"traceutil/trace.go:171","msg":"trace[1705411123] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1103; }","duration":"7.268498056s","start":"2026-04-07T01:26:00.034028Z","end":"2026-04-07T01:26:07.302526Z","steps":["trace[1705411123] 'agreement among raft nodes before linearized reading' (duration: 6.978689816s)","trace[1705411123] 'range keys from in-memory index tree' (duration: 289.723118ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:26:07.302551Z","caller":"traceutil/trace.go:171","msg":"trace[1624221975] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:1103; }","duration":"6.247063494s","start":"2026-04-07T01:26:01.055476Z","end":"2026-04-07T01:26:07.30254Z","steps":["trace[1624221975] 'agreement among raft nodes before linearized reading' (duration: 5.957226924s)","trace[1624221975] 'count revisions from in-memory index tree' (duration: 289.785059ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:26:07.302462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.787762ms","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":"warn","ts":"2026-04-07T01:26:07.302581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:02.066Z","time spent":"5.236566416s","remote":"127.0.0.1:50518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"warn","ts":"2026-04-07T01:26:07.302613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:01.055393Z","time spent":"6.247188167s","remote":"127.0.0.1:33430","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":2,"response size":30,"request content":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true "} {"level":"info","ts":"2026-04-07T01:26:07.302633Z","caller":"traceutil/trace.go:171","msg":"trace[1695127418] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1103; }","duration":"333.087879ms","start":"2026-04-07T01:26:06.969517Z","end":"2026-04-07T01:26:07.302605Z","steps":["trace[1695127418] 'agreement among raft nodes before linearized reading' (duration: 43.634708ms)","trace[1695127418] 'range keys from in-memory index tree' (duration: 289.108553ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:26:07.302646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.733040307s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-07T01:26:07.30262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.501556538s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:26:07.302685Z","caller":"traceutil/trace.go:171","msg":"trace[642054510] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:1103; }","duration":"6.733136258s","start":"2026-04-07T01:26:00.569538Z","end":"2026-04-07T01:26:07.302674Z","steps":["trace[642054510] 'agreement among raft nodes before linearized reading' (duration: 6.443172715s)","trace[642054510] 'count revisions from in-memory index tree' (duration: 289.913252ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:26:07.302691Z","caller":"traceutil/trace.go:171","msg":"trace[1319414108] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:1103; }","duration":"4.501678142s","start":"2026-04-07T01:26:02.801002Z","end":"2026-04-07T01:26:07.30268Z","steps":["trace[1319414108] 'agreement among raft nodes before linearized reading' (duration: 4.211633346s)","trace[1319414108] 'count revisions from in-memory index tree' (duration: 289.955433ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:26:07.302694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:06.969486Z","time spent":"333.195421ms","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-07T01:26:07.302713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:00.569509Z","time spent":"6.73319658s","remote":"127.0.0.1:33322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":53,"response size":30,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true "} {"level":"warn","ts":"2026-04-07T01:26:07.302733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:02.800974Z","time spent":"4.501749742s","remote":"127.0.0.1:33260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":28,"request content":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true "} {"level":"info","ts":"2026-04-07T01:26:07.302454Z","caller":"traceutil/trace.go:171","msg":"trace[256318885] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1103; }","duration":"5.346596191s","start":"2026-04-07T01:26:01.955846Z","end":"2026-04-07T01:26:07.302442Z","steps":["trace[256318885] 'agreement among raft nodes before linearized reading' (duration: 5.056830122s)","trace[256318885] 'count revisions from in-memory index tree' (duration: 289.714348ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:26:07.30278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:01.955802Z","time spent":"5.346965489s","remote":"127.0.0.1:33308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":16,"response size":30,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "} {"level":"warn","ts":"2026-04-07T01:26:07.301972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.837701155s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T01:26:07.302874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.760618ms","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-07T01:26:07.302935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.275134695s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:548"} {"level":"info","ts":"2026-04-07T01:26:07.302965Z","caller":"traceutil/trace.go:171","msg":"trace[740522736] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1103; }","duration":"356.919271ms","start":"2026-04-07T01:26:06.946019Z","end":"2026-04-07T01:26:07.302938Z","steps":["trace[740522736] 'agreement among raft nodes before linearized reading' (duration: 67.143273ms)","trace[740522736] 'range keys from in-memory index tree' (duration: 289.529463ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:26:07.302982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.515361562s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:26:07.302983Z","caller":"traceutil/trace.go:171","msg":"trace[1898473564] range","detail":"{range_begin:/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:1103; }","duration":"2.275221137s","start":"2026-04-07T01:26:05.027742Z","end":"2026-04-07T01:26:07.302963Z","steps":["trace[1898473564] 'agreement among raft nodes before linearized reading' (duration: 1.985376547s)","trace[1898473564] 'range keys from in-memory index tree' (duration: 289.756788ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:26:07.302153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:06.44904Z","time spent":"853.099233ms","remote":"127.0.0.1:33334","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":2,"response size":30,"request content":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true "} {"level":"info","ts":"2026-04-07T01:26:07.303015Z","caller":"traceutil/trace.go:171","msg":"trace[812691047] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1103; }","duration":"1.515408333s","start":"2026-04-07T01:26:05.787595Z","end":"2026-04-07T01:26:07.303003Z","steps":["trace[812691047] 'agreement among raft nodes before linearized reading' (duration: 1.225271987s)","trace[812691047] 'range keys from in-memory index tree' (duration: 290.095365ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:26:07.303017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:06.945989Z","time spent":"357.018234ms","remote":"127.0.0.1:33250","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-07T01:26:07.303028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.004407804s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-07T01:26:07.303041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:05.027719Z","time spent":"2.275308368s","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":571,"request content":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" "} {"level":"warn","ts":"2026-04-07T01:26:07.303051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:05.787584Z","time spent":"1.515457164s","remote":"127.0.0.1:33004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-07T01:26:07.30307Z","caller":"traceutil/trace.go:171","msg":"trace[1067629527] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1103; }","duration":"3.004491996s","start":"2026-04-07T01:26:04.298564Z","end":"2026-04-07T01:26:07.303056Z","steps":["trace[1067629527] 'agreement among raft nodes before linearized reading' (duration: 2.714565784s)","trace[1067629527] 'count revisions from in-memory index tree' (duration: 289.859ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:26:07.302572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:00.03402Z","time spent":"7.268546407s","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-07T01:26:07.303109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:04.29853Z","time spent":"3.004569248s","remote":"127.0.0.1:33374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":30,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-04-07T01:26:07.30257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.269509699s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-04-07T01:26:07.303137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.11272753s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:26:07.302934Z","caller":"traceutil/trace.go:171","msg":"trace[198914151] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1103; }","duration":"4.838716198s","start":"2026-04-07T01:26:02.4642Z","end":"2026-04-07T01:26:07.302916Z","steps":["trace[198914151] 'agreement among raft nodes before linearized reading' (duration: 4.548454728s)","trace[198914151] 'count revisions from in-memory index tree' (duration: 289.270868ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:26:07.303173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.914005518s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:26:07.303176Z","caller":"traceutil/trace.go:171","msg":"trace[341018168] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1103; }","duration":"3.112800681s","start":"2026-04-07T01:26:04.190363Z","end":"2026-04-07T01:26:07.303164Z","steps":["trace[341018168] 'agreement among raft nodes before linearized reading' (duration: 2.822779638s)","trace[341018168] 'count revisions from in-memory index tree' (duration: 289.965102ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:26:07.30317Z","caller":"traceutil/trace.go:171","msg":"trace[1384401469] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1103; }","duration":"7.270128352s","start":"2026-04-07T01:26:00.033025Z","end":"2026-04-07T01:26:07.303153Z","steps":["trace[1384401469] 'agreement among raft nodes before linearized reading' (duration: 6.979702478s)","trace[1384401469] 'range keys from in-memory index tree' (duration: 289.781199ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:26:07.303207Z","caller":"traceutil/trace.go:171","msg":"trace[1801550482] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1103; }","duration":"1.91408309s","start":"2026-04-07T01:26:05.389112Z","end":"2026-04-07T01:26:07.303195Z","steps":["trace[1801550482] 'agreement among raft nodes before linearized reading' (duration: 1.623988795s)","trace[1801550482] 'count revisions from in-memory index tree' (duration: 290.046204ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:26:07.303212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:04.190336Z","time spent":"3.112866473s","remote":"127.0.0.1:33344","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":28,"request content":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true "} {"level":"warn","ts":"2026-04-07T01:26:07.303207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:02.464169Z","time spent":"4.839021935s","remote":"127.0.0.1:50352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-07T01:26:07.303221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:00.033014Z","time spent":"7.270193863s","remote":"127.0.0.1:33250","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-07T01:26:07.30324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:05.389087Z","time spent":"1.914145312s","remote":"127.0.0.1:33236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"warn","ts":"2026-04-07T01:26:07.30351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.143828ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-07T01:26:07.303575Z","caller":"traceutil/trace.go:171","msg":"trace[487296450] transaction","detail":"{read_only:false; response_revision:1104; number_of_response:1; }","duration":"285.189566ms","start":"2026-04-07T01:26:07.018372Z","end":"2026-04-07T01:26:07.303562Z","steps":["trace[487296450] 'process raft request' (duration: 169.937565ms)","trace[487296450] 'compare' (duration: 114.064135ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:26:07.800887Z","caller":"traceutil/trace.go:171","msg":"trace[1913435942] transaction","detail":"{read_only:false; response_revision:1105; number_of_response:1; }","duration":"486.491104ms","start":"2026-04-07T01:26:07.314362Z","end":"2026-04-07T01:26:07.800853Z","steps":["trace[1913435942] 'process raft request' (duration: 486.183907ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:07.80119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:07.314349Z","time spent":"486.632337ms","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:26:07.801311Z","caller":"traceutil/trace.go:171","msg":"trace[1797839444] transaction","detail":"{read_only:false; response_revision:1106; number_of_response:1; }","duration":"486.841532ms","start":"2026-04-07T01:26:07.314413Z","end":"2026-04-07T01:26:07.801254Z","steps":["trace[1797839444] 'process raft request' (duration: 486.389692ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:26:07.801417Z","caller":"traceutil/trace.go:171","msg":"trace[146038606] linearizableReadLoop","detail":"{readStateIndex:1154; appliedIndex:1149; }","duration":"485.375119ms","start":"2026-04-07T01:26:07.315999Z","end":"2026-04-07T01:26:07.801375Z","steps":["trace[146038606] 'read index received' (duration: 82.743592ms)","trace[146038606] 'applied index is now lower than readState.Index' (duration: 402.630317ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:26:07.801579Z","caller":"traceutil/trace.go:171","msg":"trace[287859604] transaction","detail":"{read_only:false; response_revision:1109; number_of_response:1; }","duration":"485.524122ms","start":"2026-04-07T01:26:07.316044Z","end":"2026-04-07T01:26:07.801568Z","steps":["trace[287859604] 'process raft request' (duration: 485.283767ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:07.801591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:07.314407Z","time spent":"487.027786ms","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T01:26:07.801698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:07.316021Z","time spent":"485.587434ms","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:26:07.801591Z","caller":"traceutil/trace.go:171","msg":"trace[607426046] transaction","detail":"{read_only:false; response_revision:1108; number_of_response:1; }","duration":"486.696949ms","start":"2026-04-07T01:26:07.314866Z","end":"2026-04-07T01:26:07.801563Z","steps":["trace[607426046] 'process raft request' (duration: 486.424223ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:07.801957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"485.962301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:548"} {"level":"info","ts":"2026-04-07T01:26:07.801988Z","caller":"traceutil/trace.go:171","msg":"trace[1944417406] range","detail":"{range_begin:/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:1109; }","duration":"486.001822ms","start":"2026-04-07T01:26:07.315978Z","end":"2026-04-07T01:26:07.80198Z","steps":["trace[1944417406] 'agreement among raft nodes before linearized reading' (duration: 485.853349ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:07.802011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:07.315973Z","time spent":"486.033183ms","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":571,"request content":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" "} {"level":"info","ts":"2026-04-07T01:26:07.802055Z","caller":"traceutil/trace.go:171","msg":"trace[389726450] transaction","detail":"{read_only:false; response_revision:1107; number_of_response:1; }","duration":"487.615849ms","start":"2026-04-07T01:26:07.314419Z","end":"2026-04-07T01:26:07.802035Z","steps":["trace[389726450] 'process raft request' (duration: 486.72795ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:07.802164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:07.314401Z","time spent":"487.705761ms","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T01:26:07.802325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:07.31484Z","time spent":"487.107787ms","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:26:08.189468Z","caller":"traceutil/trace.go:171","msg":"trace[2047986805] linearizableReadLoop","detail":"{readStateIndex:1156; appliedIndex:1155; }","duration":"387.928166ms","start":"2026-04-07T01:26:07.801497Z","end":"2026-04-07T01:26:08.189425Z","steps":["trace[2047986805] 'read index received' (duration: 385.217527ms)","trace[2047986805] 'applied index is now lower than readState.Index' (duration: 2.708909ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:26:08.189659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"871.254759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:26:08.189701Z","caller":"traceutil/trace.go:171","msg":"trace[173749264] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1110; }","duration":"871.357151ms","start":"2026-04-07T01:26:07.318334Z","end":"2026-04-07T01:26:08.189691Z","steps":["trace[173749264] 'agreement among raft nodes before linearized reading' (duration: 871.217108ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:08.18974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:07.318322Z","time spent":"871.409533ms","remote":"127.0.0.1:33004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-07T01:26:08.189974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"494.255028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:26:08.190013Z","caller":"traceutil/trace.go:171","msg":"trace[735395554] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:1110; }","duration":"494.36096ms","start":"2026-04-07T01:26:07.695642Z","end":"2026-04-07T01:26:08.190003Z","steps":["trace[735395554] 'agreement among raft nodes before linearized reading' (duration: 494.296259ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:08.190042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:07.695617Z","time spent":"494.417962ms","remote":"127.0.0.1:33368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":28,"request content":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true "} {"level":"info","ts":"2026-04-07T01:26:08.189969Z","caller":"traceutil/trace.go:171","msg":"trace[1664332216] transaction","detail":"{read_only:false; response_revision:1110; number_of_response:1; }","duration":"789.645322ms","start":"2026-04-07T01:26:07.400052Z","end":"2026-04-07T01:26:08.189697Z","steps":["trace[1664332216] 'process raft request' (duration: 786.582154ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:08.190386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:07.400026Z","time spent":"790.128562ms","remote":"127.0.0.1:33048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T01:26:08.929999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.329982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:26:08.930156Z","caller":"traceutil/trace.go:171","msg":"trace[953277625] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1110; }","duration":"152.534977ms","start":"2026-04-07T01:26:08.777591Z","end":"2026-04-07T01:26:08.930126Z","steps":["trace[953277625] 'range keys from in-memory index tree' (duration: 152.24937ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:26:09.975758Z","caller":"traceutil/trace.go:171","msg":"trace[387458126] linearizableReadLoop","detail":"{readStateIndex:1157; appliedIndex:1156; }","duration":"167.405189ms","start":"2026-04-07T01:26:09.808319Z","end":"2026-04-07T01:26:09.975724Z","steps":["trace[387458126] 'read index received' (duration: 167.187565ms)","trace[387458126] 'applied index is now lower than readState.Index' (duration: 216.014µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:26:09.97611Z","caller":"traceutil/trace.go:171","msg":"trace[1415440505] transaction","detail":"{read_only:false; response_revision:1111; number_of_response:1; }","duration":"168.019752ms","start":"2026-04-07T01:26:09.807936Z","end":"2026-04-07T01:26:09.975956Z","steps":["trace[1415440505] 'process raft request' (duration: 167.581423ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:09.976462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.088414ms","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-07T01:26:09.976604Z","caller":"traceutil/trace.go:171","msg":"trace[985602874] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1111; }","duration":"168.288058ms","start":"2026-04-07T01:26:09.808293Z","end":"2026-04-07T01:26:09.976581Z","steps":["trace[985602874] 'agreement among raft nodes before linearized reading' (duration: 167.727366ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:26:10.471432Z","caller":"traceutil/trace.go:171","msg":"trace[280630934] transaction","detail":"{read_only:false; response_revision:1112; number_of_response:1; }","duration":"660.03621ms","start":"2026-04-07T01:26:09.811299Z","end":"2026-04-07T01:26:10.471335Z","steps":["trace[280630934] 'process raft request' (duration: 659.795635ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:10.471871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:09.811281Z","time spent":"660.467789ms","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:26:10.472864Z","caller":"traceutil/trace.go:171","msg":"trace[247638255] transaction","detail":"{read_only:false; response_revision:1113; number_of_response:1; }","duration":"661.473222ms","start":"2026-04-07T01:26:09.811367Z","end":"2026-04-07T01:26:10.47284Z","steps":["trace[247638255] 'process raft request' (duration: 659.898547ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:26:10.472995Z","caller":"traceutil/trace.go:171","msg":"trace[776974328] linearizableReadLoop","detail":"{readStateIndex:1160; appliedIndex:1157; }","duration":"497.090601ms","start":"2026-04-07T01:26:09.975871Z","end":"2026-04-07T01:26:10.472961Z","steps":["trace[776974328] 'read index received' (duration: 495.26987ms)","trace[776974328] 'applied index is now lower than readState.Index' (duration: 1.819091ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:26:10.473154Z","caller":"traceutil/trace.go:171","msg":"trace[1744631264] transaction","detail":"{read_only:false; response_revision:1114; number_of_response:1; }","duration":"659.472638ms","start":"2026-04-07T01:26:09.813666Z","end":"2026-04-07T01:26:10.473139Z","steps":["trace[1744631264] 'process raft request' (duration: 659.12544ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:10.473043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:09.811348Z","time spent":"661.619706ms","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T01:26:10.473308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:09.813656Z","time spent":"659.537979ms","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T01:26:10.473469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"664.857158ms","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-07T01:26:10.47358Z","caller":"traceutil/trace.go:171","msg":"trace[1376886909] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1114; }","duration":"664.998991ms","start":"2026-04-07T01:26:09.808566Z","end":"2026-04-07T01:26:10.473565Z","steps":["trace[1376886909] 'agreement among raft nodes before linearized reading' (duration: 664.573192ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:10.473677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:09.808561Z","time spent":"665.099213ms","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-07T01:26:10.535661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"547.54833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T01:26:10.535674Z","caller":"traceutil/trace.go:171","msg":"trace[169170091] transaction","detail":"{read_only:false; response_revision:1115; number_of_response:1; }","duration":"553.658088ms","start":"2026-04-07T01:26:09.981963Z","end":"2026-04-07T01:26:10.535622Z","steps":["trace[169170091] 'process raft request' (duration: 553.418493ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:26:10.535808Z","caller":"traceutil/trace.go:171","msg":"trace[2028532081] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:1115; }","duration":"547.747755ms","start":"2026-04-07T01:26:09.98802Z","end":"2026-04-07T01:26:10.535768Z","steps":["trace[2028532081] 'agreement among raft nodes before linearized reading' (duration: 547.55181ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:10.53599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:09.987993Z","time spent":"547.96253ms","remote":"127.0.0.1:33456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":2,"response size":30,"request content":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true "} {"level":"warn","ts":"2026-04-07T01:26:10.536077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"539.976261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:26:10.536186Z","caller":"traceutil/trace.go:171","msg":"trace[111424833] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:1115; }","duration":"540.132084ms","start":"2026-04-07T01:26:09.996028Z","end":"2026-04-07T01:26:10.53616Z","steps":["trace[111424833] 'agreement among raft nodes before linearized reading' (duration: 539.92632ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:10.536252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:09.996006Z","time spent":"540.232197ms","remote":"127.0.0.1:38220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-07T01:26:10.537289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:09.981928Z","time spent":"555.276864ms","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:26:12.43942Z","caller":"traceutil/trace.go:171","msg":"trace[412174425] transaction","detail":"{read_only:false; response_revision:1118; number_of_response:1; }","duration":"441.75641ms","start":"2026-04-07T01:26:11.992567Z","end":"2026-04-07T01:26:12.434323Z","steps":["trace[412174425] 'process raft request' (duration: 441.482894ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:12.44287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:11.992533Z","time spent":"450.134298ms","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:26:12.652369Z","caller":"traceutil/trace.go:171","msg":"trace[1279042930] transaction","detail":"{read_only:false; response_revision:1121; number_of_response:1; }","duration":"168.234097ms","start":"2026-04-07T01:26:12.484081Z","end":"2026-04-07T01:26:12.652315Z","steps":["trace[1279042930] 'process raft request' (duration: 168.143775ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:26:12.652818Z","caller":"traceutil/trace.go:171","msg":"trace[1039497412] transaction","detail":"{read_only:false; response_revision:1120; number_of_response:1; }","duration":"169.801483ms","start":"2026-04-07T01:26:12.48295Z","end":"2026-04-07T01:26:12.652751Z","steps":["trace[1039497412] 'process raft request' (duration: 91.676174ms)","trace[1039497412] 'compare' (duration: 77.420353ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:26:22.816467Z","caller":"traceutil/trace.go:171","msg":"trace[1657309887] transaction","detail":"{read_only:false; response_revision:1152; number_of_response:1; }","duration":"172.591566ms","start":"2026-04-07T01:26:22.643841Z","end":"2026-04-07T01:26:22.816433Z","steps":["trace[1657309887] 'process raft request' (duration: 104.694205ms)","trace[1657309887] 'compare' (duration: 67.190455ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:26:30.912182Z","caller":"traceutil/trace.go:171","msg":"trace[1961801013] linearizableReadLoop","detail":"{readStateIndex:1279; appliedIndex:1278; }","duration":"141.020198ms","start":"2026-04-07T01:26:30.771139Z","end":"2026-04-07T01:26:30.91216Z","steps":["trace[1961801013] 'read index received' (duration: 140.926926ms)","trace[1961801013] 'applied index is now lower than readState.Index' (duration: 92.092µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:26:30.912294Z","caller":"traceutil/trace.go:171","msg":"trace[606016227] transaction","detail":"{read_only:false; response_revision:1228; number_of_response:1; }","duration":"221.97951ms","start":"2026-04-07T01:26:30.690306Z","end":"2026-04-07T01:26:30.912285Z","steps":["trace[606016227] 'process raft request' (duration: 221.687923ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:30.912437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.282764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:26:30.912463Z","caller":"traceutil/trace.go:171","msg":"trace[1592206273] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:1228; }","duration":"141.365776ms","start":"2026-04-07T01:26:30.771088Z","end":"2026-04-07T01:26:30.912454Z","steps":["trace[1592206273] 'agreement among raft nodes before linearized reading' (duration: 141.309514ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:30.91261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.291985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:26:30.912627Z","caller":"traceutil/trace.go:171","msg":"trace[422106705] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1228; }","duration":"133.346246ms","start":"2026-04-07T01:26:30.779275Z","end":"2026-04-07T01:26:30.912621Z","steps":["trace[422106705] 'agreement among raft nodes before linearized reading' (duration: 133.321206ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:31.470927Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967603750204626547,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T01:26:31.97164Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967603750204626547,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T01:26:32.47281Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967603750204626547,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T01:26:32.617167Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.697350996s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-07T01:26:33.607091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"989.643731ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T01:26:33.607203Z","caller":"traceutil/trace.go:171","msg":"trace[164688578] transaction","detail":"{read_only:false; response_revision:1229; number_of_response:1; }","duration":"2.687415387s","start":"2026-04-07T01:26:30.919752Z","end":"2026-04-07T01:26:33.607167Z","steps":["trace[164688578] 'process raft request' (duration: 1.697626393s)","trace[164688578] 'compare' (duration: 989.320214ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:26:33.607253Z","caller":"traceutil/trace.go:171","msg":"trace[1342356421] transaction","detail":"{read_only:false; response_revision:1230; number_of_response:1; }","duration":"688.924997ms","start":"2026-04-07T01:26:32.918314Z","end":"2026-04-07T01:26:33.607239Z","steps":["trace[1342356421] 'process raft request' (duration: 688.864345ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:26:33.607276Z","caller":"traceutil/trace.go:171","msg":"trace[823405876] linearizableReadLoop","detail":"{readStateIndex:1280; appliedIndex:1279; }","duration":"2.638110023s","start":"2026-04-07T01:26:30.969147Z","end":"2026-04-07T01:26:33.607257Z","steps":["trace[823405876] 'read index received' (duration: 1.648165365s)","trace[823405876] 'applied index is now lower than readState.Index' (duration: 989.943208ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:26:33.607302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:32.918282Z","time spent":"688.999309ms","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T01:26:33.607329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:30.919741Z","time spent":"2.68751923s","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T01:26:33.607486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.638335588s","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-07T01:26:33.607521Z","caller":"traceutil/trace.go:171","msg":"trace[32591068] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1230; }","duration":"2.63841402s","start":"2026-04-07T01:26:30.969095Z","end":"2026-04-07T01:26:33.607509Z","steps":["trace[32591068] 'agreement among raft nodes before linearized reading' (duration: 2.638267616s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:33.607554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"828.688676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:26:33.607585Z","caller":"traceutil/trace.go:171","msg":"trace[533508369] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1230; }","duration":"828.755148ms","start":"2026-04-07T01:26:32.77882Z","end":"2026-04-07T01:26:33.607575Z","steps":["trace[533508369] 'agreement among raft nodes before linearized reading' (duration: 828.719017ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:33.607604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:32.778798Z","time spent":"828.802919ms","remote":"127.0.0.1:33004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-07T01:26:33.607622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.312395749s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T01:26:33.607645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.606158727s","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-07T01:26:33.607653Z","caller":"traceutil/trace.go:171","msg":"trace[19914162] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:1230; }","duration":"2.312474901s","start":"2026-04-07T01:26:31.295169Z","end":"2026-04-07T01:26:33.607644Z","steps":["trace[19914162] 'agreement among raft nodes before linearized reading' (duration: 2.312424039s)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:26:33.607667Z","caller":"traceutil/trace.go:171","msg":"trace[912400129] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1230; }","duration":"2.606230289s","start":"2026-04-07T01:26:31.00143Z","end":"2026-04-07T01:26:33.60766Z","steps":["trace[912400129] 'agreement among raft nodes before linearized reading' (duration: 2.606168468s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:33.607685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:31.001405Z","time spent":"2.606275459s","remote":"127.0.0.1:33250","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-07T01:26:33.607681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:31.295145Z","time spent":"2.312528642s","remote":"127.0.0.1:33278","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-07T01:26:33.607774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.618400561s","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":"warn","ts":"2026-04-07T01:26:33.607553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:30.96907Z","time spent":"2.638475831s","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-07T01:26:33.607803Z","caller":"traceutil/trace.go:171","msg":"trace[485341631] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1230; }","duration":"2.618451733s","start":"2026-04-07T01:26:30.989344Z","end":"2026-04-07T01:26:33.607795Z","steps":["trace[485341631] 'agreement among raft nodes before linearized reading' (duration: 2.618376161s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:33.607522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.625178283s","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-07T01:26:33.607851Z","caller":"traceutil/trace.go:171","msg":"trace[1344851802] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1230; }","duration":"2.625532701s","start":"2026-04-07T01:26:30.982311Z","end":"2026-04-07T01:26:33.607844Z","steps":["trace[1344851802] 'agreement among raft nodes before linearized reading' (duration: 2.625125682s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:33.60785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.402215068s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T01:26:33.607875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:30.982298Z","time spent":"2.625569871s","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-07T01:26:33.607913Z","caller":"traceutil/trace.go:171","msg":"trace[1027021063] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1230; }","duration":"1.402286621s","start":"2026-04-07T01:26:32.205583Z","end":"2026-04-07T01:26:33.607869Z","steps":["trace[1027021063] 'agreement among raft nodes before linearized reading' (duration: 1.402235999s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:33.607947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:32.205559Z","time spent":"1.402379113s","remote":"127.0.0.1:33160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true "} {"level":"warn","ts":"2026-04-07T01:26:33.607828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:30.989328Z","time spent":"2.618494573s","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-07T01:26:33.608193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.122360583s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.78\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-07T01:26:33.608247Z","caller":"traceutil/trace.go:171","msg":"trace[680781907] range","detail":"{range_begin:/registry/masterleases/199.204.45.78; range_end:; response_count:1; response_revision:1230; }","duration":"2.122457746s","start":"2026-04-07T01:26:31.485776Z","end":"2026-04-07T01:26:33.608234Z","steps":["trace[680781907] 'agreement among raft nodes before linearized reading' (duration: 2.122310112s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:33.608278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:31.485747Z","time spent":"2.122524567s","remote":"127.0.0.1:33048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.78\" "} {"level":"warn","ts":"2026-04-07T01:26:36.117093Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967603750204626566,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T01:26:36.61781Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967603750204626566,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T01:26:37.118538Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967603750204626566,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T01:26:37.571677Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.955858515s","expected-duration":"1s"} {"level":"info","ts":"2026-04-07T01:26:37.572143Z","caller":"traceutil/trace.go:171","msg":"trace[570570758] transaction","detail":"{read_only:false; response_revision:1236; number_of_response:1; }","duration":"1.956425748s","start":"2026-04-07T01:26:35.615684Z","end":"2026-04-07T01:26:37.57211Z","steps":["trace[570570758] 'process raft request' (duration: 1.956240334s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:37.572308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:35.61565Z","time spent":"1.956574671s","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T01:26:37.777171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000399593s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-07T01:26:37.777564Z","caller":"traceutil/trace.go:171","msg":"trace[1386325378] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000855934s","start":"2026-04-07T01:26:35.776685Z","end":"2026-04-07T01:26:37.777541Z","steps":["trace[1386325378] 'agreement among raft nodes before linearized reading' (duration: 2.000394272s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:37.777676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:35.776632Z","time spent":"2.001024997s","remote":"127.0.0.1:33004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/07 01:26:37 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-07T01:26:37.781863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.050892ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-07T01:26:37.782762Z","caller":"traceutil/trace.go:171","msg":"trace[523598587] transaction","detail":"{read_only:false; response_revision:1237; number_of_response:1; }","duration":"531.705355ms","start":"2026-04-07T01:26:37.251038Z","end":"2026-04-07T01:26:37.782743Z","steps":["trace[523598587] 'process raft request' (duration: 530.927058ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:37.782969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:37.251012Z","time spent":"531.800537ms","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T01:26:38.142183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.332236ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T01:26:38.142304Z","caller":"traceutil/trace.go:171","msg":"trace[554189040] linearizableReadLoop","detail":"{readStateIndex:1289; appliedIndex:1287; }","duration":"2.526252127s","start":"2026-04-07T01:26:35.61603Z","end":"2026-04-07T01:26:38.142282Z","steps":["trace[554189040] 'read index received' (duration: 1.955934367s)","trace[554189040] 'applied index is now lower than readState.Index' (duration: 570.31615ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:26:38.142537Z","caller":"traceutil/trace.go:171","msg":"trace[69099502] transaction","detail":"{read_only:false; response_revision:1238; number_of_response:1; }","duration":"854.217548ms","start":"2026-04-07T01:26:37.288304Z","end":"2026-04-07T01:26:38.142521Z","steps":["trace[69099502] 'process raft request' (duration: 494.424601ms)","trace[69099502] 'compare' (duration: 358.322993ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:26:38.142629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:37.288266Z","time spent":"854.319199ms","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T01:26:38.142945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.526911742s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-07T01:26:38.14307Z","caller":"traceutil/trace.go:171","msg":"trace[636490202] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1238; }","duration":"2.526982324s","start":"2026-04-07T01:26:35.615995Z","end":"2026-04-07T01:26:38.142977Z","steps":["trace[636490202] 'agreement among raft nodes before linearized reading' (duration: 2.526836611s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:38.143122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:35.615982Z","time spent":"2.527130277s","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-07T01:26:38.143329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.522462992s","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-07T01:26:38.143365Z","caller":"traceutil/trace.go:171","msg":"trace[1559171961] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1238; }","duration":"2.522542594s","start":"2026-04-07T01:26:35.620813Z","end":"2026-04-07T01:26:38.143356Z","steps":["trace[1559171961] 'agreement among raft nodes before linearized reading' (duration: 2.522447492s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:38.143402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:35.620787Z","time spent":"2.522608695s","remote":"127.0.0.1:33250","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-07T01:26:38.143618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.131669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:26:38.143654Z","caller":"traceutil/trace.go:171","msg":"trace[257486448] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1238; }","duration":"366.213671ms","start":"2026-04-07T01:26:37.777431Z","end":"2026-04-07T01:26:38.143645Z","steps":["trace[257486448] 'agreement among raft nodes before linearized reading' (duration: 366.162119ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:38.143679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:37.777404Z","time spent":"366.270751ms","remote":"127.0.0.1:33018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-07T01:26:38.143848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"836.130892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T01:26:38.144652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.514930824s","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-07T01:26:38.144694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.378233612s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T01:26:38.144807Z","caller":"traceutil/trace.go:171","msg":"trace[1576158068] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1238; }","duration":"1.378412516s","start":"2026-04-07T01:26:36.766367Z","end":"2026-04-07T01:26:38.144779Z","steps":["trace[1576158068] 'agreement among raft nodes before linearized reading' (duration: 1.378184921s)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:26:38.144738Z","caller":"traceutil/trace.go:171","msg":"trace[1013613957] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1238; }","duration":"2.515088647s","start":"2026-04-07T01:26:35.62963Z","end":"2026-04-07T01:26:38.144719Z","steps":["trace[1013613957] 'agreement among raft nodes before linearized reading' (duration: 2.514903463s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:38.144843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.515246181s","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-07T01:26:38.144882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:36.766342Z","time spent":"1.378526167s","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-04-07T01:26:38.144913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:35.629607Z","time spent":"2.515288202s","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-07T01:26:38.14494Z","caller":"traceutil/trace.go:171","msg":"trace[823457369] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1238; }","duration":"2.515371654s","start":"2026-04-07T01:26:35.629548Z","end":"2026-04-07T01:26:38.14492Z","steps":["trace[823457369] 'agreement among raft nodes before linearized reading' (duration: 2.515093757s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:38.144995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:35.629538Z","time spent":"2.515449395s","remote":"127.0.0.1:33250","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-07T01:26:38.144654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.523617569s","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-07T01:26:38.145063Z","caller":"traceutil/trace.go:171","msg":"trace[474873473] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1238; }","duration":"2.524109629s","start":"2026-04-07T01:26:35.620938Z","end":"2026-04-07T01:26:38.145048Z","steps":["trace[474873473] 'agreement among raft nodes before linearized reading' (duration: 2.523300231s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:38.14511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:35.620908Z","time spent":"2.524192172s","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-07T01:26:38.144825Z","caller":"traceutil/trace.go:171","msg":"trace[1028516065] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:1238; }","duration":"836.242505ms","start":"2026-04-07T01:26:37.307633Z","end":"2026-04-07T01:26:38.143875Z","steps":["trace[1028516065] 'agreement among raft nodes before linearized reading' (duration: 836.183083ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:38.145359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:37.307608Z","time spent":"837.739438ms","remote":"127.0.0.1:52858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "} {"level":"warn","ts":"2026-04-07T01:26:38.589595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.008271ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T01:26:38.589803Z","caller":"traceutil/trace.go:171","msg":"trace[1952032057] transaction","detail":"{read_only:false; response_revision:1242; number_of_response:1; }","duration":"435.375878ms","start":"2026-04-07T01:26:38.154414Z","end":"2026-04-07T01:26:38.58979Z","steps":["trace[1952032057] 'process raft request' (duration: 435.325777ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:38.589857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:38.154409Z","time spent":"435.427879ms","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:26:38.589921Z","caller":"traceutil/trace.go:171","msg":"trace[43481546] transaction","detail":"{read_only:false; response_revision:1239; number_of_response:1; }","duration":"436.344329ms","start":"2026-04-07T01:26:38.153542Z","end":"2026-04-07T01:26:38.589887Z","steps":["trace[43481546] 'process raft request' (duration: 271.97293ms)","trace[43481546] 'compare' (duration: 163.898519ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:26:38.590008Z","caller":"traceutil/trace.go:171","msg":"trace[1079167850] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"435.686626ms","start":"2026-04-07T01:26:38.154316Z","end":"2026-04-07T01:26:38.590002Z","steps":["trace[1079167850] 'process raft request' (duration: 435.355117ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:38.590044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:38.154292Z","time spent":"435.736337ms","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T01:26:38.59009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:38.15352Z","time spent":"436.475914ms","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:26:38.590118Z","caller":"traceutil/trace.go:171","msg":"trace[1190785803] transaction","detail":"{read_only:false; response_revision:1241; number_of_response:1; }","duration":"435.737427ms","start":"2026-04-07T01:26:38.154376Z","end":"2026-04-07T01:26:38.590114Z","steps":["trace[1190785803] 'process raft request' (duration: 435.330397ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:38.590143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:38.154372Z","time spent":"435.757397ms","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:26:38.590287Z","caller":"traceutil/trace.go:171","msg":"trace[1549417857] linearizableReadLoop","detail":"{readStateIndex:1296; appliedIndex:1291; }","duration":"430.337146ms","start":"2026-04-07T01:26:38.159943Z","end":"2026-04-07T01:26:38.59028Z","steps":["trace[1549417857] 'read index received' (duration: 265.571097ms)","trace[1549417857] 'applied index is now lower than readState.Index' (duration: 164.765389ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:26:38.590432Z","caller":"traceutil/trace.go:171","msg":"trace[1853585596] transaction","detail":"{read_only:false; response_revision:1243; number_of_response:1; }","duration":"435.078462ms","start":"2026-04-07T01:26:38.155348Z","end":"2026-04-07T01:26:38.590426Z","steps":["trace[1853585596] 'process raft request' (duration: 434.415596ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:38.590447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.157632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:26:38.590466Z","caller":"traceutil/trace.go:171","msg":"trace[439375937] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1243; }","duration":"430.175543ms","start":"2026-04-07T01:26:38.160284Z","end":"2026-04-07T01:26:38.59046Z","steps":["trace[439375937] 'agreement among raft nodes before linearized reading' (duration: 430.106131ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:38.590466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:38.155341Z","time spent":"435.107543ms","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T01:26:38.590482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:38.160264Z","time spent":"430.214663ms","remote":"127.0.0.1:33004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-07T01:26:38.590657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.695193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.18a3eebb2c164d95\" ","response":"range_response_count:1 size:774"} {"level":"info","ts":"2026-04-07T01:26:38.590733Z","caller":"traceutil/trace.go:171","msg":"trace[1093047608] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.18a3eebb2c164d95; range_end:; response_count:1; response_revision:1243; }","duration":"430.842937ms","start":"2026-04-07T01:26:38.159872Z","end":"2026-04-07T01:26:38.590715Z","steps":["trace[1093047608] 'agreement among raft nodes before linearized reading' (duration: 430.612412ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:38.590771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:38.159851Z","time spent":"430.913288ms","remote":"127.0.0.1:33092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":797,"request content":"key:\"/registry/events/kube-system/kube-apiserver-instance.18a3eebb2c164d95\" "} {"level":"info","ts":"2026-04-07T01:26:39.863987Z","caller":"traceutil/trace.go:171","msg":"trace[372369981] transaction","detail":"{read_only:false; response_revision:1245; number_of_response:1; }","duration":"285.301858ms","start":"2026-04-07T01:26:39.578666Z","end":"2026-04-07T01:26:39.863968Z","steps":["trace[372369981] 'process raft request' (duration: 284.752776ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:40.884854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.203056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:26:40.884955Z","caller":"traceutil/trace.go:171","msg":"trace[1087644993] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1250; }","duration":"109.338159ms","start":"2026-04-07T01:26:40.775596Z","end":"2026-04-07T01:26:40.884934Z","steps":["trace[1087644993] 'range keys from in-memory index tree' (duration: 109.116813ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:26:51.894115Z","caller":"traceutil/trace.go:171","msg":"trace[1596961136] linearizableReadLoop","detail":"{readStateIndex:1340; appliedIndex:1339; }","duration":"117.181384ms","start":"2026-04-07T01:26:51.776903Z","end":"2026-04-07T01:26:51.894085Z","steps":["trace[1596961136] 'read index received' (duration: 103.13567ms)","trace[1596961136] 'applied index is now lower than readState.Index' (duration: 14.044594ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:26:51.894258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.344037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:26:51.894286Z","caller":"traceutil/trace.go:171","msg":"trace[313261335] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1284; }","duration":"117.614013ms","start":"2026-04-07T01:26:51.776661Z","end":"2026-04-07T01:26:51.894275Z","steps":["trace[313261335] 'agreement among raft nodes before linearized reading' (duration: 117.521471ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:26:51.894517Z","caller":"traceutil/trace.go:171","msg":"trace[1395519679] transaction","detail":"{read_only:false; response_revision:1284; number_of_response:1; }","duration":"350.853857ms","start":"2026-04-07T01:26:51.543383Z","end":"2026-04-07T01:26:51.894237Z","steps":["trace[1395519679] 'process raft request' (duration: 336.766131ms)","trace[1395519679] 'compare' (duration: 13.785029ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:26:51.894798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:51.543347Z","time spent":"351.307507ms","remote":"127.0.0.1:33048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:26:54.463003Z","caller":"traceutil/trace.go:171","msg":"trace[850620106] linearizableReadLoop","detail":"{readStateIndex:1355; appliedIndex:1354; }","duration":"253.360851ms","start":"2026-04-07T01:26:54.209618Z","end":"2026-04-07T01:26:54.462979Z","steps":["trace[850620106] 'read index received' (duration: 253.193667ms)","trace[850620106] 'applied index is now lower than readState.Index' (duration: 166.314µs)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:26:54.463139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.499904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T01:26:54.463099Z","caller":"traceutil/trace.go:171","msg":"trace[1384453869] transaction","detail":"{read_only:false; response_revision:1299; number_of_response:1; }","duration":"548.234982ms","start":"2026-04-07T01:26:53.914802Z","end":"2026-04-07T01:26:54.463037Z","steps":["trace[1384453869] 'process raft request' (duration: 548.018538ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:26:54.463172Z","caller":"traceutil/trace.go:171","msg":"trace[1919839436] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1299; }","duration":"253.604986ms","start":"2026-04-07T01:26:54.209557Z","end":"2026-04-07T01:26:54.463162Z","steps":["trace[1919839436] 'agreement among raft nodes before linearized reading' (duration: 253.515954ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:54.463295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:53.914779Z","time spent":"548.411655ms","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T01:26:55.26535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.889261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-07T01:26:55.265454Z","caller":"traceutil/trace.go:171","msg":"trace[738038449] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1299; }","duration":"490.050114ms","start":"2026-04-07T01:26:54.77538Z","end":"2026-04-07T01:26:55.26543Z","steps":["trace[738038449] 'range keys from in-memory index tree' (duration: 489.625945ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:55.265501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:54.775357Z","time spent":"490.134036ms","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-07T01:26:55.265608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.702052ms","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-07T01:26:55.265696Z","caller":"traceutil/trace.go:171","msg":"trace[1094781750] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1299; }","duration":"487.813905ms","start":"2026-04-07T01:26:54.77786Z","end":"2026-04-07T01:26:55.265674Z","steps":["trace[1094781750] 'range keys from in-memory index tree' (duration: 487.55568ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:55.265766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:54.777857Z","time spent":"487.897596ms","remote":"127.0.0.1:33250","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-07T01:26:55.265822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.959728ms","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-07T01:26:55.265896Z","caller":"traceutil/trace.go:171","msg":"trace[637922327] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1299; }","duration":"488.05872ms","start":"2026-04-07T01:26:54.777822Z","end":"2026-04-07T01:26:55.265881Z","steps":["trace[637922327] 'range keys from in-memory index tree' (duration: 487.811385ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:55.265922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:54.777817Z","time spent":"488.099561ms","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-07T01:26:55.266012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.10247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:26:55.266031Z","caller":"traceutil/trace.go:171","msg":"trace[733502463] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1299; }","duration":"467.12959ms","start":"2026-04-07T01:26:54.798897Z","end":"2026-04-07T01:26:55.266026Z","steps":["trace[733502463] 'range keys from in-memory index tree' (duration: 467.072179ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:55.266044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:54.798892Z","time spent":"467.148831ms","remote":"127.0.0.1:33004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-07T01:26:55.266008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"490.505454ms","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-07T01:26:55.266088Z","caller":"traceutil/trace.go:171","msg":"trace[1021618370] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1299; }","duration":"490.592276ms","start":"2026-04-07T01:26:54.775482Z","end":"2026-04-07T01:26:55.266074Z","steps":["trace[1021618370] 'range keys from in-memory index tree' (duration: 490.280929ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:55.266169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:54.775479Z","time spent":"490.679178ms","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-07T01:26:55.266095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"534.593041ms","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-07T01:26:55.266223Z","caller":"traceutil/trace.go:171","msg":"trace[446068590] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1299; }","duration":"534.787855ms","start":"2026-04-07T01:26:54.731427Z","end":"2026-04-07T01:26:55.266215Z","steps":["trace[446068590] 'range keys from in-memory index tree' (duration: 534.399557ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:55.26625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:54.731403Z","time spent":"534.839717ms","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-07T01:26:55.399989Z","caller":"traceutil/trace.go:171","msg":"trace[1495186876] transaction","detail":"{read_only:false; response_revision:1300; number_of_response:1; }","duration":"130.058204ms","start":"2026-04-07T01:26:55.269882Z","end":"2026-04-07T01:26:55.39994Z","steps":["trace[1495186876] 'process raft request' (duration: 128.841947ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:26:55.412545Z","caller":"traceutil/trace.go:171","msg":"trace[61846963] transaction","detail":"{read_only:false; response_revision:1301; number_of_response:1; }","duration":"141.398463ms","start":"2026-04-07T01:26:55.271132Z","end":"2026-04-07T01:26:55.41253Z","steps":["trace[61846963] 'process raft request' (duration: 141.26443ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:26:55.413073Z","caller":"traceutil/trace.go:171","msg":"trace[2081629364] transaction","detail":"{read_only:false; response_revision:1302; number_of_response:1; }","duration":"126.105158ms","start":"2026-04-07T01:26:55.286954Z","end":"2026-04-07T01:26:55.413059Z","steps":["trace[2081629364] 'process raft request' (duration: 125.541035ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:26:55.413458Z","caller":"traceutil/trace.go:171","msg":"trace[1890890899] transaction","detail":"{read_only:false; response_revision:1303; number_of_response:1; }","duration":"126.22951ms","start":"2026-04-07T01:26:55.287218Z","end":"2026-04-07T01:26:55.413448Z","steps":["trace[1890890899] 'process raft request' (duration: 125.563636ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:26:55.414528Z","caller":"traceutil/trace.go:171","msg":"trace[1133434364] transaction","detail":"{read_only:false; response_revision:1304; number_of_response:1; }","duration":"122.189242ms","start":"2026-04-07T01:26:55.291301Z","end":"2026-04-07T01:26:55.41349Z","steps":["trace[1133434364] 'process raft request' (duration: 121.63611ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:57.212825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.568577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:26:57.213745Z","caller":"traceutil/trace.go:171","msg":"trace[1326826972] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1306; }","duration":"435.521338ms","start":"2026-04-07T01:26:56.778199Z","end":"2026-04-07T01:26:57.213721Z","steps":["trace[1326826972] 'range keys from in-memory index tree' (duration: 434.467425ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:57.213809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:56.778177Z","time spent":"435.61734ms","remote":"127.0.0.1:33018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-07T01:26:57.212484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.808576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T01:26:57.214852Z","caller":"traceutil/trace.go:171","msg":"trace[575083019] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1306; }","duration":"444.25067ms","start":"2026-04-07T01:26:56.770587Z","end":"2026-04-07T01:26:57.214838Z","steps":["trace[575083019] 'count revisions from in-memory index tree' (duration: 441.699984ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:57.214973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:56.770562Z","time spent":"444.393533ms","remote":"127.0.0.1:33114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":17,"response size":30,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "} {"level":"warn","ts":"2026-04-07T01:26:57.601719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.070509ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-07T01:26:57.602219Z","caller":"traceutil/trace.go:171","msg":"trace[1332885775] linearizableReadLoop","detail":"{readStateIndex:1363; appliedIndex:1362; }","duration":"561.009491ms","start":"2026-04-07T01:26:57.041192Z","end":"2026-04-07T01:26:57.602202Z","steps":["trace[1332885775] 'read index received' (duration: 196.458891ms)","trace[1332885775] 'applied index is now lower than readState.Index' (duration: 364.54947ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:26:57.602414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"561.213455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T01:26:57.602892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.781793ms","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":"warn","ts":"2026-04-07T01:26:57.602912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.820214ms","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-07T01:26:57.602977Z","caller":"traceutil/trace.go:171","msg":"trace[1206473304] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1306; }","duration":"183.898386ms","start":"2026-04-07T01:26:57.419055Z","end":"2026-04-07T01:26:57.602954Z","steps":["trace[1206473304] 'agreement among raft nodes before linearized reading' (duration: 183.622339ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:26:57.603018Z","caller":"traceutil/trace.go:171","msg":"trace[1181372033] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1306; }","duration":"183.984338ms","start":"2026-04-07T01:26:57.419003Z","end":"2026-04-07T01:26:57.602988Z","steps":["trace[1181372033] 'agreement among raft nodes before linearized reading' (duration: 183.64175ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:26:57.602844Z","caller":"traceutil/trace.go:171","msg":"trace[824072970] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:1306; }","duration":"561.698917ms","start":"2026-04-07T01:26:57.041134Z","end":"2026-04-07T01:26:57.602833Z","steps":["trace[824072970] 'agreement among raft nodes before linearized reading' (duration: 561.221956ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:57.60318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:57.04111Z","time spent":"562.042005ms","remote":"127.0.0.1:38236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-07T01:26:57.602747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.626981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-07T01:26:57.603253Z","caller":"traceutil/trace.go:171","msg":"trace[1552482952] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1306; }","duration":"185.154254ms","start":"2026-04-07T01:26:57.418087Z","end":"2026-04-07T01:26:57.603241Z","steps":["trace[1552482952] 'agreement among raft nodes before linearized reading' (duration: 184.56719ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:57.602784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.323117ms","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-07T01:26:57.603469Z","caller":"traceutil/trace.go:171","msg":"trace[909594373] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1306; }","duration":"186.030933ms","start":"2026-04-07T01:26:57.417428Z","end":"2026-04-07T01:26:57.603459Z","steps":["trace[909594373] 'agreement among raft nodes before linearized reading' (duration: 185.277626ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:57.602806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.045154ms","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-07T01:26:57.603687Z","caller":"traceutil/trace.go:171","msg":"trace[1615471646] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1306; }","duration":"197.944965ms","start":"2026-04-07T01:26:57.405718Z","end":"2026-04-07T01:26:57.603663Z","steps":["trace[1615471646] 'agreement among raft nodes before linearized reading' (duration: 196.889881ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:26:58.835021Z","caller":"traceutil/trace.go:171","msg":"trace[1979233591] transaction","detail":"{read_only:false; response_revision:1324; number_of_response:1; }","duration":"165.841959ms","start":"2026-04-07T01:26:58.669133Z","end":"2026-04-07T01:26:58.834975Z","steps":["trace[1979233591] 'process raft request' (duration: 165.473731ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:26:59.750804Z","caller":"traceutil/trace.go:171","msg":"trace[1129158791] linearizableReadLoop","detail":"{readStateIndex:1384; appliedIndex:1383; }","duration":"124.670666ms","start":"2026-04-07T01:26:59.626101Z","end":"2026-04-07T01:26:59.750771Z","steps":["trace[1129158791] 'read index received' (duration: 124.430601ms)","trace[1129158791] 'applied index is now lower than readState.Index' (duration: 239.055µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:26:59.750995Z","caller":"traceutil/trace.go:171","msg":"trace[1841771454] transaction","detail":"{read_only:false; response_revision:1327; number_of_response:1; }","duration":"129.385769ms","start":"2026-04-07T01:26:59.621539Z","end":"2026-04-07T01:26:59.750924Z","steps":["trace[1841771454] 'process raft request' (duration: 129.071232ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:59.75125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.880446ms","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-07T01:26:59.751266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.157106ms","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-07T01:26:59.751311Z","caller":"traceutil/trace.go:171","msg":"trace[617960789] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1327; }","duration":"123.040729ms","start":"2026-04-07T01:26:59.628255Z","end":"2026-04-07T01:26:59.751296Z","steps":["trace[617960789] 'agreement among raft nodes before linearized reading' (duration: 122.850355ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:59.751253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.811519ms","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-07T01:26:59.751314Z","caller":"traceutil/trace.go:171","msg":"trace[936272515] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1327; }","duration":"125.236168ms","start":"2026-04-07T01:26:59.626066Z","end":"2026-04-07T01:26:59.751302Z","steps":["trace[936272515] 'agreement among raft nodes before linearized reading' (duration: 125.089645ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:59.751372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.285416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-07T01:26:59.751424Z","caller":"traceutil/trace.go:171","msg":"trace[1969676552] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1327; }","duration":"123.346747ms","start":"2026-04-07T01:26:59.628061Z","end":"2026-04-07T01:26:59.751407Z","steps":["trace[1969676552] 'agreement among raft nodes before linearized reading' (duration: 123.227594ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:26:59.751383Z","caller":"traceutil/trace.go:171","msg":"trace[1094031755] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1327; }","duration":"124.977642ms","start":"2026-04-07T01:26:59.626358Z","end":"2026-04-07T01:26:59.751335Z","steps":["trace[1094031755] 'agreement among raft nodes before linearized reading' (duration: 124.713836ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:27:00.276486Z","caller":"traceutil/trace.go:171","msg":"trace[1392554094] transaction","detail":"{read_only:false; response_revision:1334; number_of_response:1; }","duration":"129.950751ms","start":"2026-04-07T01:27:00.146508Z","end":"2026-04-07T01:27:00.276459Z","steps":["trace[1392554094] 'process raft request' (duration: 129.773308ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:27:00.283771Z","caller":"traceutil/trace.go:171","msg":"trace[1716725262] transaction","detail":"{read_only:false; response_revision:1335; number_of_response:1; }","duration":"135.378012ms","start":"2026-04-07T01:27:00.148374Z","end":"2026-04-07T01:27:00.283752Z","steps":["trace[1716725262] 'process raft request' (duration: 134.945261ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:27:04.805775Z","caller":"traceutil/trace.go:171","msg":"trace[1330876267] transaction","detail":"{read_only:false; response_revision:1376; number_of_response:1; }","duration":"250.941787ms","start":"2026-04-07T01:27:04.554805Z","end":"2026-04-07T01:27:04.805746Z","steps":["trace[1330876267] 'process raft request' (duration: 250.763413ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:27:04.82065Z","caller":"traceutil/trace.go:171","msg":"trace[252852737] transaction","detail":"{read_only:false; response_revision:1377; number_of_response:1; }","duration":"264.27983ms","start":"2026-04-07T01:27:04.556344Z","end":"2026-04-07T01:27:04.820624Z","steps":["trace[252852737] 'process raft request' (duration: 263.808429ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:27:05.435818Z","caller":"traceutil/trace.go:171","msg":"trace[402456638] transaction","detail":"{read_only:false; response_revision:1384; number_of_response:1; }","duration":"123.171783ms","start":"2026-04-07T01:27:05.312611Z","end":"2026-04-07T01:27:05.435783Z","steps":["trace[402456638] 'process raft request' (duration: 123.090931ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:27:05.436587Z","caller":"traceutil/trace.go:171","msg":"trace[1613937735] transaction","detail":"{read_only:false; response_revision:1383; number_of_response:1; }","duration":"127.143831ms","start":"2026-04-07T01:27:05.309392Z","end":"2026-04-07T01:27:05.436536Z","steps":["trace[1613937735] 'process raft request' (duration: 126.243702ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:27:05.437313Z","caller":"traceutil/trace.go:171","msg":"trace[450684897] transaction","detail":"{read_only:false; response_revision:1382; number_of_response:1; }","duration":"127.979209ms","start":"2026-04-07T01:27:05.309319Z","end":"2026-04-07T01:27:05.437298Z","steps":["trace[450684897] 'process raft request' (duration: 126.118158ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:27:06.035224Z","caller":"traceutil/trace.go:171","msg":"trace[1631221740] transaction","detail":"{read_only:false; response_revision:1390; number_of_response:1; }","duration":"173.100659ms","start":"2026-04-07T01:27:05.862084Z","end":"2026-04-07T01:27:06.035185Z","steps":["trace[1631221740] 'process raft request' (duration: 173.038418ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:27:06.03534Z","caller":"traceutil/trace.go:171","msg":"trace[2113516633] transaction","detail":"{read_only:false; response_revision:1388; number_of_response:1; }","duration":"174.753546ms","start":"2026-04-07T01:27:05.860549Z","end":"2026-04-07T01:27:06.035303Z","steps":["trace[2113516633] 'process raft request' (duration: 174.48557ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:27:06.035423Z","caller":"traceutil/trace.go:171","msg":"trace[1184913673] transaction","detail":"{read_only:false; response_revision:1389; number_of_response:1; }","duration":"174.790766ms","start":"2026-04-07T01:27:05.860592Z","end":"2026-04-07T01:27:06.035383Z","steps":["trace[1184913673] 'process raft request' (duration: 174.49188ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:27:06.03534Z","caller":"traceutil/trace.go:171","msg":"trace[1150847115] transaction","detail":"{read_only:false; response_revision:1387; number_of_response:1; }","duration":"175.640415ms","start":"2026-04-07T01:27:05.859646Z","end":"2026-04-07T01:27:06.035286Z","steps":["trace[1150847115] 'process raft request' (duration: 106.929877ms)","trace[1150847115] 'compare' (duration: 68.238587ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:27:08.08526Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967603750204626895,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T01:27:08.585481Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967603750204626895,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T01:27:08.726122Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.438511428s","expected-duration":"1s"} {"level":"info","ts":"2026-04-07T01:27:08.727025Z","caller":"traceutil/trace.go:171","msg":"trace[320643370] linearizableReadLoop","detail":"{readStateIndex:1453; appliedIndex:1452; }","duration":"1.142562974s","start":"2026-04-07T01:27:07.584431Z","end":"2026-04-07T01:27:08.726994Z","steps":["trace[320643370] 'read index received' (duration: 1.142233446s)","trace[320643370] 'applied index is now lower than readState.Index' (duration: 328.257µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:27:08.727139Z","caller":"traceutil/trace.go:171","msg":"trace[91493467] transaction","detail":"{read_only:false; response_revision:1394; number_of_response:1; }","duration":"1.439642613s","start":"2026-04-07T01:27:07.287441Z","end":"2026-04-07T01:27:08.727084Z","steps":["trace[91493467] 'process raft request' (duration: 1.439331706s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:08.727285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.142785719s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T01:27:08.727337Z","caller":"traceutil/trace.go:171","msg":"trace[1658622002] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:1394; }","duration":"1.142943813s","start":"2026-04-07T01:27:07.584382Z","end":"2026-04-07T01:27:08.727325Z","steps":["trace[1658622002] 'agreement among raft nodes before linearized reading' (duration: 1.142765809s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:08.727347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:27:07.287409Z","time spent":"1.439829048s","remote":"127.0.0.1:33174","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T01:27:08.72742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:27:07.584361Z","time spent":"1.143047125s","remote":"127.0.0.1:33298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":17,"response size":30,"request content":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true "} {"level":"warn","ts":"2026-04-07T01:27:08.731462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"691.129777ms","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-07T01:27:08.731577Z","caller":"traceutil/trace.go:171","msg":"trace[164485349] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1395; }","duration":"691.317122ms","start":"2026-04-07T01:27:08.040238Z","end":"2026-04-07T01:27:08.731555Z","steps":["trace[164485349] 'agreement among raft nodes before linearized reading' (duration: 690.976135ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:08.731632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:27:08.040208Z","time spent":"691.415153ms","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-07T01:27:08.732032Z","caller":"traceutil/trace.go:171","msg":"trace[18803891] transaction","detail":"{read_only:false; response_revision:1395; number_of_response:1; }","duration":"133.91275ms","start":"2026-04-07T01:27:08.598087Z","end":"2026-04-07T01:27:08.732Z","steps":["trace[18803891] 'process raft request' (duration: 132.468538ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:08.732098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"691.425243ms","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-07T01:27:08.732135Z","caller":"traceutil/trace.go:171","msg":"trace[673817599] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1395; }","duration":"691.483315ms","start":"2026-04-07T01:27:08.040641Z","end":"2026-04-07T01:27:08.732124Z","steps":["trace[673817599] 'agreement among raft nodes before linearized reading' (duration: 691.22926ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:08.732164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:27:08.040631Z","time spent":"691.526166ms","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-07T01:27:08.732269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"701.995785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T01:27:08.732293Z","caller":"traceutil/trace.go:171","msg":"trace[815103656] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:1395; }","duration":"702.036856ms","start":"2026-04-07T01:27:08.030248Z","end":"2026-04-07T01:27:08.732285Z","steps":["trace[815103656] 'agreement among raft nodes before linearized reading' (duration: 701.986335ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:08.732343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:27:08.030241Z","time spent":"702.095017ms","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":13,"response size":30,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "} {"level":"warn","ts":"2026-04-07T01:27:08.732467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"692.424505ms","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-07T01:27:08.73256Z","caller":"traceutil/trace.go:171","msg":"trace[1818945242] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1395; }","duration":"692.537078ms","start":"2026-04-07T01:27:08.040009Z","end":"2026-04-07T01:27:08.732546Z","steps":["trace[1818945242] 'agreement among raft nodes before linearized reading' (duration: 692.388325ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:08.732611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:27:08.039998Z","time spent":"692.60512ms","remote":"127.0.0.1:33250","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-07T01:27:08.731693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"690.469862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-07T01:27:08.732839Z","caller":"traceutil/trace.go:171","msg":"trace[865777489] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1395; }","duration":"691.6722ms","start":"2026-04-07T01:27:08.041157Z","end":"2026-04-07T01:27:08.732829Z","steps":["trace[865777489] 'agreement among raft nodes before linearized reading' (duration: 690.326289ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:08.732878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:27:08.041141Z","time spent":"691.72886ms","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-07T01:27:08.732934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"946.098283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:27:08.73302Z","caller":"traceutil/trace.go:171","msg":"trace[256367423] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1395; }","duration":"948.284561ms","start":"2026-04-07T01:27:07.784704Z","end":"2026-04-07T01:27:08.732989Z","steps":["trace[256367423] 'agreement among raft nodes before linearized reading' (duration: 946.025961ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:08.733076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:27:07.784682Z","time spent":"948.381764ms","remote":"127.0.0.1:33004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-07T01:27:08.733231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"800.478048ms","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-07T01:27:08.733321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"746.752549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"info","ts":"2026-04-07T01:27:08.733296Z","caller":"traceutil/trace.go:171","msg":"trace[2056100955] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1395; }","duration":"800.5972ms","start":"2026-04-07T01:27:07.932688Z","end":"2026-04-07T01:27:08.733285Z","steps":["trace[2056100955] 'agreement among raft nodes before linearized reading' (duration: 799.649709ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:27:08.733379Z","caller":"traceutil/trace.go:171","msg":"trace[1977277226] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1395; }","duration":"746.85639ms","start":"2026-04-07T01:27:07.986508Z","end":"2026-04-07T01:27:08.733364Z","steps":["trace[1977277226] 'agreement among raft nodes before linearized reading' (duration: 745.751905ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:08.733597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:27:07.986488Z","time spent":"747.094946ms","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":558,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-04-07T01:27:08.733706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:27:07.932664Z","time spent":"800.811154ms","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-07T01:27:21.003961Z","caller":"traceutil/trace.go:171","msg":"trace[932218945] transaction","detail":"{read_only:false; response_revision:1458; number_of_response:1; }","duration":"100.188538ms","start":"2026-04-07T01:27:20.903721Z","end":"2026-04-07T01:27:21.003909Z","steps":["trace[932218945] 'process raft request' (duration: 88.902721ms)","trace[932218945] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io; req_size:531; } (duration: 10.92037ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:30:42.234716Z","caller":"traceutil/trace.go:171","msg":"trace[1282918633] transaction","detail":"{read_only:false; response_revision:2405; number_of_response:1; }","duration":"126.488735ms","start":"2026-04-07T01:30:42.108143Z","end":"2026-04-07T01:30:42.234631Z","steps":["trace[1282918633] 'process raft request' (duration: 97.553387ms)","trace[1282918633] 'compare' (duration: 28.412616ms)"],"step_count":2}