{"level":"warn","ts":"2026-04-14T05:40:16.198655Z","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-14T05:40:16.19876Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.242: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.242:2380","--initial-cluster=instance=https://199.204.45.242:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.242:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.242: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-14T05:40:16.198837Z","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-14T05:40:16.198853Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.242:2380"]} {"level":"info","ts":"2026-04-14T05:40:16.198873Z","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-14T05:40:16.199702Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.242:2379"]} {"level":"info","ts":"2026-04-14T05:40:16.199784Z","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.242:2380"],"listen-peer-urls":["https://199.204.45.242:2380"],"advertise-client-urls":["https://199.204.45.242:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.242:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.242: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-14T05:40:16.203626Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.623971ms"} {"level":"info","ts":"2026-04-14T05:40:16.2123Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b844c110b9783e73","cluster-id":"49dc9693ccd466a9"} {"level":"info","ts":"2026-04-14T05:40:16.21237Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 switched to configuration voters=()"} {"level":"info","ts":"2026-04-14T05:40:16.212388Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became follower at term 0"} {"level":"info","ts":"2026-04-14T05:40:16.212402Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b844c110b9783e73 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-14T05:40:16.21241Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became follower at term 1"} {"level":"info","ts":"2026-04-14T05:40:16.212438Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 switched to configuration voters=(13277949878970367603)"} {"level":"warn","ts":"2026-04-14T05:40:16.220017Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-14T05:40:16.221882Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-14T05:40:16.222987Z","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-14T05:40:16.224617Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b844c110b9783e73","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-14T05:40:16.224856Z","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-14T05:40:16.224937Z","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-14T05:40:16.224949Z","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-14T05:40:16.224858Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b844c110b9783e73","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-14T05:40:16.22752Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 switched to configuration voters=(13277949878970367603)"} {"level":"info","ts":"2026-04-14T05:40:16.227679Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"49dc9693ccd466a9","local-member-id":"b844c110b9783e73","added-peer-id":"b844c110b9783e73","added-peer-peer-urls":["https://199.204.45.242:2380"]} {"level":"info","ts":"2026-04-14T05:40:16.228492Z","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-14T05:40:16.22863Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.242:2380"} {"level":"info","ts":"2026-04-14T05:40:16.228675Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.242:2380"} {"level":"info","ts":"2026-04-14T05:40:16.228772Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b844c110b9783e73","initial-advertise-peer-urls":["https://199.204.45.242:2380"],"listen-peer-urls":["https://199.204.45.242:2380"],"advertise-client-urls":["https://199.204.45.242:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.242:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-14T05:40:16.228821Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-14T05:40:16.512833Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 is starting a new election at term 1"} {"level":"info","ts":"2026-04-14T05:40:16.512895Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-14T05:40:16.512941Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 received MsgPreVoteResp from b844c110b9783e73 at term 1"} {"level":"info","ts":"2026-04-14T05:40:16.513005Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became candidate at term 2"} {"level":"info","ts":"2026-04-14T05:40:16.513019Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 received MsgVoteResp from b844c110b9783e73 at term 2"} {"level":"info","ts":"2026-04-14T05:40:16.513036Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became leader at term 2"} {"level":"info","ts":"2026-04-14T05:40:16.513051Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b844c110b9783e73 elected leader b844c110b9783e73 at term 2"} {"level":"info","ts":"2026-04-14T05:40:16.543764Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T05:40:16.544082Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b844c110b9783e73","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.242:2379]}","request-path":"/0/members/b844c110b9783e73/attributes","cluster-id":"49dc9693ccd466a9","publish-timeout":"7s"} {"level":"info","ts":"2026-04-14T05:40:16.544095Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-14T05:40:16.544113Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-14T05:40:16.544591Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-14T05:40:16.544702Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-14T05:40:16.546368Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-14T05:40:16.548603Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.242:2379"} {"level":"info","ts":"2026-04-14T05:40:16.555494Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"49dc9693ccd466a9","local-member-id":"b844c110b9783e73","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T05:40:16.555654Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T05:40:16.555699Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T05:40:18.268344Z","caller":"traceutil/trace.go:171","msg":"trace[2130747005] linearizableReadLoop","detail":"{readStateIndex:7; appliedIndex:6; }","duration":"256.518634ms","start":"2026-04-14T05:40:18.011802Z","end":"2026-04-14T05:40:18.268321Z","steps":["trace[2130747005] 'read index received' (duration: 252.038603ms)","trace[2130747005] 'applied index is now lower than readState.Index' (duration: 4.479231ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T05:40:18.268431Z","caller":"traceutil/trace.go:171","msg":"trace[1474220215] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"258.778517ms","start":"2026-04-14T05:40:18.009626Z","end":"2026-04-14T05:40:18.268404Z","steps":["trace[1474220215] 'process raft request' (duration: 254.089991ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:40:18.268563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.737331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-14T05:40:18.268803Z","caller":"traceutil/trace.go:171","msg":"trace[10584181] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:4; }","duration":"256.970939ms","start":"2026-04-14T05:40:18.011773Z","end":"2026-04-14T05:40:18.268743Z","steps":["trace[10584181] 'agreement among raft nodes before linearized reading' (duration: 256.660632ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:40:18.338312Z","caller":"traceutil/trace.go:171","msg":"trace[34809515] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"325.767479ms","start":"2026-04-14T05:40:18.012509Z","end":"2026-04-14T05:40:18.338277Z","steps":["trace[34809515] 'process raft request' (duration: 325.678998ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:40:18.338375Z","caller":"traceutil/trace.go:171","msg":"trace[1597751882] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"307.497141ms","start":"2026-04-14T05:40:18.030849Z","end":"2026-04-14T05:40:18.338346Z","steps":["trace[1597751882] 'process raft request' (duration: 307.40784ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:40:18.338528Z","caller":"traceutil/trace.go:171","msg":"trace[1416848114] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"326.001687ms","start":"2026-04-14T05:40:18.012508Z","end":"2026-04-14T05:40:18.338509Z","steps":["trace[1416848114] 'process raft request' (duration: 325.699671ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:40:18.338546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.648843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-14T05:40:18.338547Z","caller":"traceutil/trace.go:171","msg":"trace[605670142] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"326.175488ms","start":"2026-04-14T05:40:18.012353Z","end":"2026-04-14T05:40:18.338528Z","steps":["trace[605670142] 'process raft request' (duration: 325.762358ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:40:18.338577Z","caller":"traceutil/trace.go:171","msg":"trace[411300834] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"326.015839ms","start":"2026-04-14T05:40:18.012553Z","end":"2026-04-14T05:40:18.338569Z","steps":["trace[411300834] 'process raft request' (duration: 325.668627ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:40:18.338599Z","caller":"traceutil/trace.go:171","msg":"trace[1253915429] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:11; }","duration":"298.728863ms","start":"2026-04-14T05:40:18.039856Z","end":"2026-04-14T05:40:18.338585Z","steps":["trace[1253915429] 'agreement among raft nodes before linearized reading' (duration: 298.599017ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:40:18.338604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.960941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-14T05:40:18.338614Z","caller":"traceutil/trace.go:171","msg":"trace[858818713] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"326.02449ms","start":"2026-04-14T05:40:18.012582Z","end":"2026-04-14T05:40:18.338607Z","steps":["trace[858818713] 'process raft request' (duration: 325.657305ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:40:18.33862Z","caller":"traceutil/trace.go:171","msg":"trace[1472615895] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"304.542145ms","start":"2026-04-14T05:40:18.034054Z","end":"2026-04-14T05:40:18.338596Z","steps":["trace[1472615895] 'process raft request' (duration: 304.227207ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:40:18.338541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.156178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-14T05:40:18.338683Z","caller":"traceutil/trace.go:171","msg":"trace[1005271152] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"278.370494ms","start":"2026-04-14T05:40:18.060301Z","end":"2026-04-14T05:40:18.338671Z","steps":["trace[1005271152] 'agreement among raft nodes before linearized reading' (duration: 278.124775ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:40:18.33885Z","caller":"traceutil/trace.go:171","msg":"trace[388905401] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:11; }","duration":"147.215162ms","start":"2026-04-14T05:40:18.191616Z","end":"2026-04-14T05:40:18.338831Z","steps":["trace[388905401] 'agreement among raft nodes before linearized reading' (duration: 146.966532ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:40:18.339152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:40:18.012502Z","time spent":"325.866731ms","remote":"127.0.0.1:41050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-14T05:40:18.3394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:40:18.030828Z","time spent":"307.65037ms","remote":"127.0.0.1:40718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3159,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-14T05:40:18.339564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:40:18.012461Z","time spent":"326.099519ms","remote":"127.0.0.1:41050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-14T05:40:18.339735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:40:18.012537Z","time spent":"326.062125ms","remote":"127.0.0.1:41050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-14T05:40:18.339823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:40:18.012338Z","time spent":"326.259189ms","remote":"127.0.0.1:41050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-14T05:40:18.340091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:40:18.034041Z","time spent":"304.610543ms","remote":"127.0.0.1:40802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-14T05:40:18.34025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:40:18.012575Z","time spent":"326.067805ms","remote":"127.0.0.1:41050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T05:40:18.557439Z","caller":"traceutil/trace.go:171","msg":"trace[516754579] transaction","detail":"{read_only:false; response_revision:42; number_of_response:1; }","duration":"128.566989ms","start":"2026-04-14T05:40:18.428846Z","end":"2026-04-14T05:40:18.557413Z","steps":["trace[516754579] 'process raft request' (duration: 123.453612ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:40:18.557641Z","caller":"traceutil/trace.go:171","msg":"trace[1162610712] transaction","detail":"{read_only:false; response_revision:44; number_of_response:1; }","duration":"107.255785ms","start":"2026-04-14T05:40:18.45037Z","end":"2026-04-14T05:40:18.557625Z","steps":["trace[1162610712] 'process raft request' (duration: 106.730742ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:40:18.557472Z","caller":"traceutil/trace.go:171","msg":"trace[1242576622] transaction","detail":"{read_only:false; response_revision:43; number_of_response:1; }","duration":"107.521346ms","start":"2026-04-14T05:40:18.449928Z","end":"2026-04-14T05:40:18.557449Z","steps":["trace[1242576622] 'process raft request' (duration: 107.123979ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:40:18.963001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.129742ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-04-14T05:40:18.963402Z","caller":"traceutil/trace.go:171","msg":"trace[641971428] transaction","detail":"{read_only:false; response_revision:48; number_of_response:1; }","duration":"372.488732ms","start":"2026-04-14T05:40:18.59087Z","end":"2026-04-14T05:40:18.963359Z","steps":["trace[641971428] 'process raft request' (duration: 160.605729ms)","trace[641971428] 'compare' (duration: 210.844677ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T05:40:18.963542Z","caller":"traceutil/trace.go:171","msg":"trace[931290907] transaction","detail":"{read_only:false; response_revision:49; number_of_response:1; }","duration":"370.462026ms","start":"2026-04-14T05:40:18.593058Z","end":"2026-04-14T05:40:18.96352Z","steps":["trace[931290907] 'process raft request' (duration: 370.230908ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:40:18.963562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:40:18.590846Z","time spent":"372.63947ms","remote":"127.0.0.1:40960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":706,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-14T05:40:18.963814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:40:18.593048Z","time spent":"370.549767ms","remote":"127.0.0.1:40960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1058,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T05:40:19.526875Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4500113670871897282,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-14T05:40:20.027698Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4500113670871897282,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-14T05:40:20.528742Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4500113670871897282,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-14T05:40:21.029928Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4500113670871897282,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-14T05:40:21.237884Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.212460405s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-14T05:40:22.013063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999888687s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-14T05:40:22.013176Z","caller":"traceutil/trace.go:171","msg":"trace[1617209759] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000065372s","start":"2026-04-14T05:40:20.013089Z","end":"2026-04-14T05:40:22.013155Z","steps":["trace[1617209759] 'agreement among raft nodes before linearized reading' (duration: 1.999929142s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:40:22.013234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:40:20.013065Z","time spent":"2.00014985s","remote":"127.0.0.1:40540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-14T05:40:23.228571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999847403s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-14T05:40:23.228632Z","caller":"traceutil/trace.go:171","msg":"trace[717776519] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.99995443s","start":"2026-04-14T05:40:21.228664Z","end":"2026-04-14T05:40:23.228619Z","steps":["trace[717776519] 'agreement among raft nodes before linearized reading' (duration: 1.999873825s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:40:23.22866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:40:21.228643Z","time spent":"2.000012224s","remote":"127.0.0.1:40540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-14T05:40:24.008475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.770281179s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-04-14T05:40:24.008589Z","caller":"traceutil/trace.go:171","msg":"trace[194504908] transaction","detail":"{read_only:false; response_revision:53; number_of_response:1; }","duration":"4.983287559s","start":"2026-04-14T05:40:19.02528Z","end":"2026-04-14T05:40:24.008568Z","steps":["trace[194504908] 'process raft request' (duration: 2.212847671s)","trace[194504908] 'compare' (duration: 2.769758971s)"],"step_count":2} {"level":"warn","ts":"2026-04-14T05:40:24.008656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:40:19.025254Z","time spent":"4.983373205s","remote":"127.0.0.1:40892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-14T05:40:24.014006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000122963s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-14T05:40:24.01407Z","caller":"traceutil/trace.go:171","msg":"trace[606317261] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000223839s","start":"2026-04-14T05:40:22.013834Z","end":"2026-04-14T05:40:24.014058Z","steps":["trace[606317261] 'agreement among raft nodes before linearized reading' (duration: 2.000149445s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:40:24.014106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:40:22.013816Z","time spent":"2.000283303s","remote":"127.0.0.1:40554","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-14T05:40:25.314227Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"4.07603019s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-14T05:40:25.72941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999980748s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-14T05:40:25.729517Z","caller":"traceutil/trace.go:171","msg":"trace[1935617473] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000153277s","start":"2026-04-14T05:40:23.729346Z","end":"2026-04-14T05:40:25.729499Z","steps":["trace[1935617473] 'agreement among raft nodes before linearized reading' (duration: 2.0000011s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:40:25.729579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:40:23.72933Z","time spent":"2.00023562s","remote":"127.0.0.1:40540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/14 05:40:25 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-14T05:40:26.027038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:40:19.025872Z","time spent":"7.001160193s","remote":"127.0.0.1:40960","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-04-14T05:40:26.028201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:40:19.027661Z","time spent":"7.000533939s","remote":"127.0.0.1:40960","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-04-14T05:40:26.113446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000226258s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-14T05:40:26.113529Z","caller":"traceutil/trace.go:171","msg":"trace[610481402] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000372604s","start":"2026-04-14T05:40:24.11314Z","end":"2026-04-14T05:40:26.113513Z","steps":["trace[610481402] 'agreement among raft nodes before linearized reading' (duration: 2.000273811s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:40:26.113572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:40:24.11311Z","time spent":"2.000453347s","remote":"127.0.0.1:40554","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/14 05:40:26 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-14T05:40:26.353883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.039398921s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-04-14T05:40:26.354653Z","caller":"traceutil/trace.go:171","msg":"trace[1891587461] transaction","detail":"{read_only:false; response_revision:56; number_of_response:1; }","duration":"6.076386127s","start":"2026-04-14T05:40:20.278244Z","end":"2026-04-14T05:40:26.35463Z","steps":["trace[1891587461] 'process raft request' (duration: 6.07587033s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:40:26.354783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:40:20.278223Z","time spent":"6.076494072s","remote":"127.0.0.1:40730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5882,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T05:40:26.354942Z","caller":"traceutil/trace.go:171","msg":"trace[1487665077] linearizableReadLoop","detail":"{readStateIndex:61; appliedIndex:56; }","duration":"7.328616592s","start":"2026-04-14T05:40:19.026307Z","end":"2026-04-14T05:40:26.354924Z","steps":["trace[1487665077] 'read index received' (duration: 2.211924909s)","trace[1487665077] 'applied index is now lower than readState.Index' (duration: 5.116688963s)"],"step_count":2} {"level":"info","ts":"2026-04-14T05:40:26.354892Z","caller":"traceutil/trace.go:171","msg":"trace[1378741471] transaction","detail":"{read_only:false; response_revision:57; number_of_response:1; }","duration":"5.655870511s","start":"2026-04-14T05:40:20.698941Z","end":"2026-04-14T05:40:26.354812Z","steps":["trace[1378741471] 'process raft request' (duration: 5.65552346s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:40:26.355094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.328765949s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-admin\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-14T05:40:26.354929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:40:21.583827Z","time spent":"4.771098143s","remote":"127.0.0.1:40602","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-04-14T05:40:26.355178Z","caller":"traceutil/trace.go:171","msg":"trace[439072056] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-admin; range_end:; response_count:0; response_revision:57; }","duration":"7.328900435s","start":"2026-04-14T05:40:19.026258Z","end":"2026-04-14T05:40:26.355158Z","steps":["trace[439072056] 'agreement among raft nodes before linearized reading' (duration: 7.32874593s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:40:26.355239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:40:19.026243Z","time spent":"7.328983829s","remote":"127.0.0.1:40884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/system:aggregate-to-admin\" "} {"level":"warn","ts":"2026-04-14T05:40:26.355339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:40:20.698917Z","time spent":"5.656200304s","remote":"127.0.0.1:40730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2905,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T05:40:26.836127Z","caller":"traceutil/trace.go:171","msg":"trace[60638725] transaction","detail":"{read_only:false; response_revision:60; number_of_response:1; }","duration":"478.516838ms","start":"2026-04-14T05:40:26.357586Z","end":"2026-04-14T05:40:26.836102Z","steps":["trace[60638725] 'process raft request' (duration: 478.480167ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:40:26.836341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:40:26.357563Z","time spent":"478.655972ms","remote":"127.0.0.1:40602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":592,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T05:40:26.836489Z","caller":"traceutil/trace.go:171","msg":"trace[1627986409] transaction","detail":"{read_only:false; response_revision:58; number_of_response:1; }","duration":"1.178413959s","start":"2026-04-14T05:40:25.658039Z","end":"2026-04-14T05:40:26.836453Z","steps":["trace[1627986409] 'process raft request' (duration: 1.093680782s)","trace[1627986409] 'compare' (duration: 84.115816ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T05:40:26.83664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:40:25.658014Z","time spent":"1.178561684s","remote":"127.0.0.1:40730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5498,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-14T05:40:26.836643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.432569228s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:3465"} {"level":"info","ts":"2026-04-14T05:40:26.836711Z","caller":"traceutil/trace.go:171","msg":"trace[1081888785] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:60; }","duration":"1.432671102s","start":"2026-04-14T05:40:25.404021Z","end":"2026-04-14T05:40:26.836692Z","steps":["trace[1081888785] 'agreement among raft nodes before linearized reading' (duration: 1.432520167s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:40:26.836758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:40:25.404002Z","time spent":"1.432743325s","remote":"127.0.0.1:40730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":3488,"request content":"key:\"/registry/pods/kube-system/kube-vip-instance\" "} {"level":"warn","ts":"2026-04-14T05:40:26.836958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"624.281055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-14T05:40:26.83701Z","caller":"traceutil/trace.go:171","msg":"trace[1199829878] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:60; }","duration":"624.361328ms","start":"2026-04-14T05:40:26.212635Z","end":"2026-04-14T05:40:26.836996Z","steps":["trace[1199829878] 'agreement among raft nodes before linearized reading' (duration: 624.288466ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:40:26.837085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:40:26.212622Z","time spent":"624.451141ms","remote":"127.0.0.1:40540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-14T05:40:26.837094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.38668674s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-14T05:40:26.837142Z","caller":"traceutil/trace.go:171","msg":"trace[1302003023] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:60; }","duration":"6.386774485s","start":"2026-04-14T05:40:20.450356Z","end":"2026-04-14T05:40:26.837131Z","steps":["trace[1302003023] 'agreement among raft nodes before linearized reading' (duration: 6.386687313s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:40:26.837171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:40:20.450341Z","time spent":"6.386823349s","remote":"127.0.0.1:40804","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-14T05:40:26.836745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.38531172s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-04-14T05:40:26.837303Z","caller":"traceutil/trace.go:171","msg":"trace[1403874794] transaction","detail":"{read_only:false; response_revision:59; number_of_response:1; }","duration":"803.61608ms","start":"2026-04-14T05:40:26.03269Z","end":"2026-04-14T05:40:26.836306Z","steps":["trace[1403874794] 'process raft request' (duration: 803.31128ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:40:26.837479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:40:26.032671Z","time spent":"804.683045ms","remote":"127.0.0.1:40960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1059,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T05:40:26.836499Z","caller":"traceutil/trace.go:171","msg":"trace[1631291352] linearizableReadLoop","detail":"{readStateIndex:64; appliedIndex:62; }","duration":"481.494638ms","start":"2026-04-14T05:40:26.354981Z","end":"2026-04-14T05:40:26.836476Z","steps":["trace[1631291352] 'read index received' (duration: 396.74115ms)","trace[1631291352] 'applied index is now lower than readState.Index' (duration: 84.749908ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T05:40:26.838511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.474144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/admin\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-14T05:40:26.83856Z","caller":"traceutil/trace.go:171","msg":"trace[287384537] range","detail":"{range_begin:/registry/clusterroles/admin; range_end:; response_count:0; response_revision:60; }","duration":"480.523576ms","start":"2026-04-14T05:40:26.358024Z","end":"2026-04-14T05:40:26.838548Z","steps":["trace[287384537] 'agreement among raft nodes before linearized reading' (duration: 480.454103ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:40:26.838668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:40:26.35797Z","time spent":"480.688021ms","remote":"127.0.0.1:40884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":30,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/admin\" "} {"level":"info","ts":"2026-04-14T05:40:26.838799Z","caller":"traceutil/trace.go:171","msg":"trace[1925148233] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:60; }","duration":"6.387363511s","start":"2026-04-14T05:40:20.451389Z","end":"2026-04-14T05:40:26.838753Z","steps":["trace[1925148233] 'agreement among raft nodes before linearized reading' (duration: 6.385214059s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:40:26.838862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:40:20.451374Z","time spent":"6.387471895s","remote":"127.0.0.1:40804","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-14T05:40:27.047902Z","caller":"traceutil/trace.go:171","msg":"trace[1508082927] transaction","detail":"{read_only:false; response_revision:67; number_of_response:1; }","duration":"154.896404ms","start":"2026-04-14T05:40:26.892991Z","end":"2026-04-14T05:40:27.047887Z","steps":["trace[1508082927] 'process raft request' (duration: 100.612451ms)","trace[1508082927] 'compare' (duration: 54.010386ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T05:40:27.048084Z","caller":"traceutil/trace.go:171","msg":"trace[1608780194] transaction","detail":"{read_only:false; response_revision:68; number_of_response:1; }","duration":"153.219646ms","start":"2026-04-14T05:40:26.894859Z","end":"2026-04-14T05:40:27.048078Z","steps":["trace[1608780194] 'process raft request' (duration: 152.846047ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:40:27.484427Z","caller":"traceutil/trace.go:171","msg":"trace[1725029751] transaction","detail":"{read_only:false; response_revision:108; number_of_response:1; }","duration":"128.549276ms","start":"2026-04-14T05:40:27.355851Z","end":"2026-04-14T05:40:27.4844Z","steps":["trace[1725029751] 'process raft request' (duration: 70.315399ms)","trace[1725029751] 'compare' (duration: 57.960301ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T05:40:28.85252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.631376ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-14T05:40:28.852789Z","caller":"traceutil/trace.go:171","msg":"trace[797639736] transaction","detail":"{read_only:false; response_revision:192; number_of_response:1; }","duration":"188.992305ms","start":"2026-04-14T05:40:28.66377Z","end":"2026-04-14T05:40:28.852763Z","steps":["trace[797639736] 'process raft request' (duration: 70.011453ms)","trace[797639736] 'compare' (duration: 118.351922ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T05:40:29.026373Z","caller":"traceutil/trace.go:171","msg":"trace[133557549] transaction","detail":"{read_only:false; response_revision:196; number_of_response:1; }","duration":"130.942283ms","start":"2026-04-14T05:40:28.895405Z","end":"2026-04-14T05:40:29.026347Z","steps":["trace[133557549] 'process raft request' (duration: 122.490821ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:40:29.026518Z","caller":"traceutil/trace.go:171","msg":"trace[738807177] transaction","detail":"{read_only:false; response_revision:197; number_of_response:1; }","duration":"129.753673ms","start":"2026-04-14T05:40:28.896742Z","end":"2026-04-14T05:40:29.026495Z","steps":["trace[738807177] 'process raft request' (duration: 129.361901ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:40:29.906317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.941893ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-14T05:40:29.906433Z","caller":"traceutil/trace.go:171","msg":"trace[509475162] transaction","detail":"{read_only:false; response_revision:224; number_of_response:1; }","duration":"276.481135ms","start":"2026-04-14T05:40:29.629937Z","end":"2026-04-14T05:40:29.906418Z","steps":["trace[509475162] 'process raft request' (duration: 90.393061ms)","trace[509475162] 'compare' (duration: 185.795082ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T05:40:30.1396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.220261ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-14T05:40:30.139772Z","caller":"traceutil/trace.go:171","msg":"trace[830147834] transaction","detail":"{read_only:false; response_revision:226; number_of_response:1; }","duration":"221.961694ms","start":"2026-04-14T05:40:29.917781Z","end":"2026-04-14T05:40:30.139743Z","steps":["trace[830147834] 'process raft request' (duration: 116.536794ms)","trace[830147834] 'compare' (duration: 105.076971ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T05:40:30.507062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.382405ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-14T05:40:30.507164Z","caller":"traceutil/trace.go:171","msg":"trace[1657418647] linearizableReadLoop","detail":"{readStateIndex:234; appliedIndex:233; }","duration":"227.491441ms","start":"2026-04-14T05:40:30.279657Z","end":"2026-04-14T05:40:30.507149Z","steps":["trace[1657418647] 'read index received' (duration: 64.885717ms)","trace[1657418647] 'applied index is now lower than readState.Index' (duration: 162.604694ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T05:40:30.507334Z","caller":"traceutil/trace.go:171","msg":"trace[441288000] transaction","detail":"{read_only:false; response_revision:229; number_of_response:1; }","duration":"287.976918ms","start":"2026-04-14T05:40:30.219334Z","end":"2026-04-14T05:40:30.507311Z","steps":["trace[441288000] 'process raft request' (duration: 125.282793ms)","trace[441288000] 'compare' (duration: 162.257826ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T05:40:30.507377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.708292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T05:40:30.507505Z","caller":"traceutil/trace.go:171","msg":"trace[367880431] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:229; }","duration":"227.862021ms","start":"2026-04-14T05:40:30.279632Z","end":"2026-04-14T05:40:30.507494Z","steps":["trace[367880431] 'agreement among raft nodes before linearized reading' (duration: 227.559611ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:40:30.711017Z","caller":"traceutil/trace.go:171","msg":"trace[837926972] transaction","detail":"{read_only:false; response_revision:231; number_of_response:1; }","duration":"197.294022ms","start":"2026-04-14T05:40:30.513665Z","end":"2026-04-14T05:40:30.710959Z","steps":["trace[837926972] 'process raft request' (duration: 197.195473ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:40:30.711134Z","caller":"traceutil/trace.go:171","msg":"trace[860022914] transaction","detail":"{read_only:false; response_revision:230; number_of_response:1; }","duration":"198.0751ms","start":"2026-04-14T05:40:30.513032Z","end":"2026-04-14T05:40:30.711107Z","steps":["trace[860022914] 'process raft request' (duration: 104.434103ms)","trace[860022914] 'compare' (duration: 93.243868ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T05:40:31.048974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.189829ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-14T05:40:31.049105Z","caller":"traceutil/trace.go:171","msg":"trace[884072230] transaction","detail":"{read_only:false; response_revision:232; number_of_response:1; }","duration":"332.349019ms","start":"2026-04-14T05:40:30.716734Z","end":"2026-04-14T05:40:31.049083Z","steps":["trace[884072230] 'process raft request' (duration: 215.038692ms)","trace[884072230] 'compare' (duration: 117.01588ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T05:40:31.049158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:40:30.716721Z","time spent":"332.415168ms","remote":"127.0.0.1:40886","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":724,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T05:40:31.100813Z","caller":"traceutil/trace.go:171","msg":"trace[1732651149] linearizableReadLoop","detail":"{readStateIndex:238; appliedIndex:236; }","duration":"171.238679ms","start":"2026-04-14T05:40:30.929551Z","end":"2026-04-14T05:40:31.10079Z","steps":["trace[1732651149] 'read index received' (duration: 2.199095ms)","trace[1732651149] 'applied index is now lower than readState.Index' (duration: 169.038474ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T05:40:31.100906Z","caller":"traceutil/trace.go:171","msg":"trace[2003167236] transaction","detail":"{read_only:false; response_revision:233; number_of_response:1; }","duration":"381.967321ms","start":"2026-04-14T05:40:30.718904Z","end":"2026-04-14T05:40:31.100871Z","steps":["trace[2003167236] 'process raft request' (duration: 381.698763ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:40:31.100995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.426327ms","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-14T05:40:31.101158Z","caller":"traceutil/trace.go:171","msg":"trace[1829225439] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:233; }","duration":"171.648086ms","start":"2026-04-14T05:40:30.929488Z","end":"2026-04-14T05:40:31.101136Z","steps":["trace[1829225439] 'agreement among raft nodes before linearized reading' (duration: 171.422558ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:40:31.101072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:40:30.718871Z","time spent":"382.106549ms","remote":"127.0.0.1:40730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4311,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T05:40:31.218498Z","caller":"traceutil/trace.go:171","msg":"trace[46245592] transaction","detail":"{read_only:false; response_revision:236; number_of_response:1; }","duration":"112.535959ms","start":"2026-04-14T05:40:31.105916Z","end":"2026-04-14T05:40:31.218452Z","steps":["trace[46245592] 'process raft request' (duration: 112.325831ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:40:31.21866Z","caller":"traceutil/trace.go:171","msg":"trace[1819957278] transaction","detail":"{read_only:false; response_revision:235; number_of_response:1; }","duration":"113.240151ms","start":"2026-04-14T05:40:31.105395Z","end":"2026-04-14T05:40:31.218635Z","steps":["trace[1819957278] 'process raft request' (duration: 87.98744ms)","trace[1819957278] 'compare' (duration: 24.677207ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T05:40:31.622633Z","caller":"traceutil/trace.go:171","msg":"trace[434522572] linearizableReadLoop","detail":"{readStateIndex:248; appliedIndex:247; }","duration":"309.753166ms","start":"2026-04-14T05:40:31.312856Z","end":"2026-04-14T05:40:31.622609Z","steps":["trace[434522572] 'read index received' (duration: 221.135022ms)","trace[434522572] 'applied index is now lower than readState.Index' (duration: 88.617144ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T05:40:31.62276Z","caller":"traceutil/trace.go:171","msg":"trace[758825912] transaction","detail":"{read_only:false; response_revision:243; number_of_response:1; }","duration":"323.395901ms","start":"2026-04-14T05:40:31.299306Z","end":"2026-04-14T05:40:31.622702Z","steps":["trace[758825912] 'process raft request' (duration: 234.715488ms)","trace[758825912] 'compare' (duration: 88.418276ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T05:40:31.622811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.942364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T05:40:31.622851Z","caller":"traceutil/trace.go:171","msg":"trace[795220044] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:243; }","duration":"310.039983ms","start":"2026-04-14T05:40:31.312799Z","end":"2026-04-14T05:40:31.622839Z","steps":["trace[795220044] 'agreement among raft nodes before linearized reading' (duration: 309.937804ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:40:31.622895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:40:31.312779Z","time spent":"310.107612ms","remote":"127.0.0.1:40540","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-14T05:40:31.622923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:40:31.299291Z","time spent":"323.562629ms","remote":"127.0.0.1:40886","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":756,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-14T05:40:31.623095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.779343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T05:40:31.623295Z","caller":"traceutil/trace.go:171","msg":"trace[618005408] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:243; }","duration":"238.04169ms","start":"2026-04-14T05:40:31.38522Z","end":"2026-04-14T05:40:31.623261Z","steps":["trace[618005408] 'agreement among raft nodes before linearized reading' (duration: 237.691464ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:40:31.98063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.037936ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-14T05:40:31.980789Z","caller":"traceutil/trace.go:171","msg":"trace[1552901331] transaction","detail":"{read_only:false; response_revision:251; number_of_response:1; }","duration":"132.620435ms","start":"2026-04-14T05:40:31.848142Z","end":"2026-04-14T05:40:31.980762Z","steps":["trace[1552901331] 'compare' (duration: 124.820258ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:40:32.179161Z","caller":"traceutil/trace.go:171","msg":"trace[431278398] transaction","detail":"{read_only:false; response_revision:252; number_of_response:1; }","duration":"190.015695ms","start":"2026-04-14T05:40:31.989117Z","end":"2026-04-14T05:40:32.179133Z","steps":["trace[431278398] 'process raft request' (duration: 188.598672ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:40:32.451343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.020015ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-14T05:40:32.451519Z","caller":"traceutil/trace.go:171","msg":"trace[533070768] transaction","detail":"{read_only:false; response_revision:256; number_of_response:1; }","duration":"198.621534ms","start":"2026-04-14T05:40:32.252857Z","end":"2026-04-14T05:40:32.451479Z","steps":["trace[533070768] 'process raft request' (duration: 54.366792ms)","trace[533070768] 'compare' (duration: 143.771201ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T05:40:32.451759Z","caller":"traceutil/trace.go:171","msg":"trace[1459480779] linearizableReadLoop","detail":"{readStateIndex:261; appliedIndex:260; }","duration":"137.893401ms","start":"2026-04-14T05:40:32.313557Z","end":"2026-04-14T05:40:32.451451Z","steps":["trace[1459480779] 'read index received' (duration: 59.609µs)","trace[1459480779] 'applied index is now lower than readState.Index' (duration: 137.832152ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T05:40:32.452008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.407381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T05:40:32.452185Z","caller":"traceutil/trace.go:171","msg":"trace[1868627409] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:256; }","duration":"138.681676ms","start":"2026-04-14T05:40:32.313484Z","end":"2026-04-14T05:40:32.452165Z","steps":["trace[1868627409] 'agreement among raft nodes before linearized reading' (duration: 138.283994ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:40:33.038179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.978722ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-14T05:40:33.038289Z","caller":"traceutil/trace.go:171","msg":"trace[1685898765] transaction","detail":"{read_only:false; response_revision:272; number_of_response:1; }","duration":"191.833952ms","start":"2026-04-14T05:40:32.846435Z","end":"2026-04-14T05:40:33.038269Z","steps":["trace[1685898765] 'process raft request' (duration: 21.688774ms)","trace[1685898765] 'compare' (duration: 169.818127ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T05:40:33.484125Z","caller":"traceutil/trace.go:171","msg":"trace[1538120773] transaction","detail":"{read_only:false; response_revision:276; number_of_response:1; }","duration":"104.459762ms","start":"2026-04-14T05:40:33.379643Z","end":"2026-04-14T05:40:33.484102Z","steps":["trace[1538120773] 'process raft request' (duration: 104.316625ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:40:34.644231Z","caller":"traceutil/trace.go:171","msg":"trace[1078771380] transaction","detail":"{read_only:false; response_revision:307; number_of_response:1; }","duration":"100.086352ms","start":"2026-04-14T05:40:34.544112Z","end":"2026-04-14T05:40:34.644198Z","steps":["trace[1078771380] 'process raft request' (duration: 44.557422ms)","trace[1078771380] 'compare' (duration: 55.361155ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T05:40:41.655572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.048365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4369"} {"level":"info","ts":"2026-04-14T05:40:41.655673Z","caller":"traceutil/trace.go:171","msg":"trace[656444612] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:413; }","duration":"138.199592ms","start":"2026-04-14T05:40:41.517453Z","end":"2026-04-14T05:40:41.655653Z","steps":["trace[656444612] 'range keys from in-memory index tree' (duration: 137.810104ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:40:41.820553Z","caller":"traceutil/trace.go:171","msg":"trace[83055396] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"154.530734ms","start":"2026-04-14T05:40:41.665997Z","end":"2026-04-14T05:40:41.820528Z","steps":["trace[83055396] 'process raft request' (duration: 154.394615ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:40:41.944663Z","caller":"traceutil/trace.go:171","msg":"trace[631725285] linearizableReadLoop","detail":"{readStateIndex:432; appliedIndex:429; }","duration":"155.265546ms","start":"2026-04-14T05:40:41.78938Z","end":"2026-04-14T05:40:41.944646Z","steps":["trace[631725285] 'read index received' (duration: 31.079863ms)","trace[631725285] 'applied index is now lower than readState.Index' (duration: 124.184093ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T05:40:41.94468Z","caller":"traceutil/trace.go:171","msg":"trace[1302322306] transaction","detail":"{read_only:false; response_revision:415; number_of_response:1; }","duration":"278.449738ms","start":"2026-04-14T05:40:41.666204Z","end":"2026-04-14T05:40:41.944654Z","steps":["trace[1302322306] 'process raft request' (duration: 278.087247ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:40:41.944775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.382387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-14T05:40:41.944803Z","caller":"traceutil/trace.go:171","msg":"trace[8425418] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:415; }","duration":"155.46448ms","start":"2026-04-14T05:40:41.789332Z","end":"2026-04-14T05:40:41.944797Z","steps":["trace[8425418] 'agreement among raft nodes before linearized reading' (duration: 155.390626ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:40:42.281744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.082612ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T05:40:42.281884Z","caller":"traceutil/trace.go:171","msg":"trace[1276432338] transaction","detail":"{read_only:false; response_revision:418; number_of_response:1; }","duration":"305.209746ms","start":"2026-04-14T05:40:41.976656Z","end":"2026-04-14T05:40:42.281866Z","steps":["trace[1276432338] 'process raft request' (duration: 189.930041ms)","trace[1276432338] 'compare' (duration: 114.948814ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T05:40:42.281944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:40:41.976641Z","time spent":"305.274771ms","remote":"127.0.0.1:40730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6740,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T05:40:42.871505Z","caller":"traceutil/trace.go:171","msg":"trace[1628849627] transaction","detail":"{read_only:false; response_revision:421; number_of_response:1; }","duration":"173.305405ms","start":"2026-04-14T05:40:42.698147Z","end":"2026-04-14T05:40:42.871452Z","steps":["trace[1628849627] 'process raft request' (duration: 134.142383ms)","trace[1628849627] 'compare' (duration: 38.813112ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T05:40:45.986062Z","caller":"traceutil/trace.go:171","msg":"trace[493205131] transaction","detail":"{read_only:false; response_revision:434; number_of_response:1; }","duration":"209.837465ms","start":"2026-04-14T05:40:45.776209Z","end":"2026-04-14T05:40:45.986046Z","steps":["trace[493205131] 'process raft request' (duration: 209.564223ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:40:49.243738Z","caller":"traceutil/trace.go:171","msg":"trace[979795037] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"147.709697ms","start":"2026-04-14T05:40:49.096001Z","end":"2026-04-14T05:40:49.243711Z","steps":["trace[979795037] 'process raft request' (duration: 147.52555ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:40:59.143574Z","caller":"traceutil/trace.go:171","msg":"trace[2001781728] linearizableReadLoop","detail":"{readStateIndex:514; appliedIndex:513; }","duration":"317.777461ms","start":"2026-04-14T05:40:58.825773Z","end":"2026-04-14T05:40:59.14355Z","steps":["trace[2001781728] 'read index received' (duration: 317.084743ms)","trace[2001781728] 'applied index is now lower than readState.Index' (duration: 691.648µs)"],"step_count":2} {"level":"info","ts":"2026-04-14T05:40:59.143649Z","caller":"traceutil/trace.go:171","msg":"trace[1004995660] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"527.671827ms","start":"2026-04-14T05:40:58.615934Z","end":"2026-04-14T05:40:59.143606Z","steps":["trace[1004995660] 'process raft request' (duration: 527.236787ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:40:59.143725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.937125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-14T05:40:59.143765Z","caller":"traceutil/trace.go:171","msg":"trace[170883723] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:492; }","duration":"317.996696ms","start":"2026-04-14T05:40:58.825757Z","end":"2026-04-14T05:40:59.143754Z","steps":["trace[170883723] 'agreement among raft nodes before linearized reading' (duration: 317.886284ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:40:59.143775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:40:58.615912Z","time spent":"527.805305ms","remote":"127.0.0.1:40626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":317296,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-14T05:40:59.143806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:40:58.825692Z","time spent":"318.105847ms","remote":"127.0.0.1:40804","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-14T05:40:59.539014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.290168ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-14T05:40:59.539368Z","caller":"traceutil/trace.go:171","msg":"trace[1374930522] linearizableReadLoop","detail":"{readStateIndex:529; appliedIndex:527; }","duration":"210.114984ms","start":"2026-04-14T05:40:59.329083Z","end":"2026-04-14T05:40:59.539198Z","steps":["trace[1374930522] 'read index received' (duration: 99.640247ms)","trace[1374930522] 'applied index is now lower than readState.Index' (duration: 110.474007ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T05:40:59.539522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.423284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T05:40:59.539578Z","caller":"traceutil/trace.go:171","msg":"trace[610135881] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"263.02726ms","start":"2026-04-14T05:40:59.276515Z","end":"2026-04-14T05:40:59.539543Z","steps":["trace[610135881] 'process raft request' (duration: 152.128372ms)","trace[610135881] 'compare' (duration: 110.153019ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T05:40:59.539591Z","caller":"traceutil/trace.go:171","msg":"trace[247856790] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:507; }","duration":"210.501361ms","start":"2026-04-14T05:40:59.329051Z","end":"2026-04-14T05:40:59.539552Z","steps":["trace[247856790] 'agreement among raft nodes before linearized reading' (duration: 210.359604ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:40:59.53965Z","caller":"traceutil/trace.go:171","msg":"trace[1271605389] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"217.324413ms","start":"2026-04-14T05:40:59.322273Z","end":"2026-04-14T05:40:59.539597Z","steps":["trace[1271605389] 'process raft request' (duration: 216.861089ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:40:59.540452Z","caller":"traceutil/trace.go:171","msg":"trace[335634428] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"198.415982ms","start":"2026-04-14T05:40:59.342011Z","end":"2026-04-14T05:40:59.540427Z","steps":["trace[335634428] 'process raft request' (duration: 197.832976ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:00.15221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.45285ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T05:41:00.152329Z","caller":"traceutil/trace.go:171","msg":"trace[474670587] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"400.967156ms","start":"2026-04-14T05:40:59.751333Z","end":"2026-04-14T05:41:00.1523Z","steps":["trace[474670587] 'process raft request' (duration: 242.334176ms)","trace[474670587] 'compare' (duration: 158.337779ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T05:41:00.15234Z","caller":"traceutil/trace.go:171","msg":"trace[523395599] linearizableReadLoop","detail":"{readStateIndex:549; appliedIndex:547; }","duration":"400.901457ms","start":"2026-04-14T05:40:59.751393Z","end":"2026-04-14T05:41:00.152295Z","steps":["trace[523395599] 'read index received' (duration: 41.717872ms)","trace[523395599] 'applied index is now lower than readState.Index' (duration: 359.182455ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T05:41:00.152471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:40:59.751316Z","time spent":"401.083587ms","remote":"127.0.0.1:40730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4668,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T05:41:00.152594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.192839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/kube-system/cilium-operator-869df985b8\" ","response":"range_response_count:1 size:4354"} {"level":"warn","ts":"2026-04-14T05:41:00.152589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.704513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium-operator\" ","response":"range_response_count:1 size:538"} {"level":"info","ts":"2026-04-14T05:41:00.152635Z","caller":"traceutil/trace.go:171","msg":"trace[1867102652] range","detail":"{range_begin:/registry/replicasets/kube-system/cilium-operator-869df985b8; range_end:; response_count:1; response_revision:527; }","duration":"401.257258ms","start":"2026-04-14T05:40:59.751364Z","end":"2026-04-14T05:41:00.152621Z","steps":["trace[1867102652] 'agreement among raft nodes before linearized reading' (duration: 401.069039ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:00.152667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.34018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium\" ","response":"range_response_count:1 size:520"} {"level":"warn","ts":"2026-04-14T05:41:00.152677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:40:59.751349Z","time spent":"401.320328ms","remote":"127.0.0.1:40998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":4377,"request content":"key:\"/registry/replicasets/kube-system/cilium-operator-869df985b8\" "} {"level":"info","ts":"2026-04-14T05:41:00.152715Z","caller":"traceutil/trace.go:171","msg":"trace[695758304] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium; range_end:; response_count:1; response_revision:527; }","duration":"340.414697ms","start":"2026-04-14T05:40:59.812286Z","end":"2026-04-14T05:41:00.152701Z","steps":["trace[695758304] 'agreement among raft nodes before linearized reading' (duration: 340.354177ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:00.152766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:40:59.812268Z","time spent":"340.490175ms","remote":"127.0.0.1:40744","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":543,"request content":"key:\"/registry/serviceaccounts/kube-system/cilium\" "} {"level":"info","ts":"2026-04-14T05:41:00.152662Z","caller":"traceutil/trace.go:171","msg":"trace[1767628062] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium-operator; range_end:; response_count:1; response_revision:527; }","duration":"339.831323ms","start":"2026-04-14T05:40:59.812811Z","end":"2026-04-14T05:41:00.152643Z","steps":["trace[1767628062] 'agreement among raft nodes before linearized reading' (duration: 339.707674ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:00.152872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.7192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329956"} {"level":"warn","ts":"2026-04-14T05:41:00.152885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:40:59.81279Z","time spent":"340.08548ms","remote":"127.0.0.1:40744","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":561,"request content":"key:\"/registry/serviceaccounts/kube-system/cilium-operator\" "} {"level":"warn","ts":"2026-04-14T05:41:00.152609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.082779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/cilium\" ","response":"range_response_count:1 size:14463"} {"level":"info","ts":"2026-04-14T05:41:00.153017Z","caller":"traceutil/trace.go:171","msg":"trace[1990590121] range","detail":"{range_begin:/registry/daemonsets/kube-system/cilium; range_end:; response_count:1; response_revision:527; }","duration":"400.517647ms","start":"2026-04-14T05:40:59.752487Z","end":"2026-04-14T05:41:00.153005Z","steps":["trace[1990590121] 'agreement among raft nodes before linearized reading' (duration: 399.990164ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:00.153051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:40:59.75248Z","time spent":"400.56245ms","remote":"127.0.0.1:40986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":14486,"request content":"key:\"/registry/daemonsets/kube-system/cilium\" "} {"level":"info","ts":"2026-04-14T05:41:00.152905Z","caller":"traceutil/trace.go:171","msg":"trace[1407529720] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:527; }","duration":"389.789037ms","start":"2026-04-14T05:40:59.763105Z","end":"2026-04-14T05:41:00.152894Z","steps":["trace[1407529720] 'agreement among raft nodes before linearized reading' (duration: 389.601209ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:00.154603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:40:59.763084Z","time spent":"391.445854ms","remote":"127.0.0.1:40626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":4,"response size":329979,"request content":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" "} {"level":"warn","ts":"2026-04-14T05:41:02.162713Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4500113670871898289,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-14T05:41:02.232108Z","caller":"traceutil/trace.go:171","msg":"trace[2129183171] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"614.983061ms","start":"2026-04-14T05:41:01.617098Z","end":"2026-04-14T05:41:02.232082Z","steps":["trace[2129183171] 'process raft request' (duration: 601.608499ms)","trace[2129183171] 'compare' (duration: 13.163479ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T05:41:02.232313Z","caller":"traceutil/trace.go:171","msg":"trace[1749151747] linearizableReadLoop","detail":"{readStateIndex:585; appliedIndex:582; }","duration":"570.00222ms","start":"2026-04-14T05:41:01.662287Z","end":"2026-04-14T05:41:02.23229Z","steps":["trace[1749151747] 'read index received' (duration: 556.509899ms)","trace[1749151747] 'applied index is now lower than readState.Index' (duration: 13.491322ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T05:41:02.232349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:01.617077Z","time spent":"615.082424ms","remote":"127.0.0.1:40584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T05:41:02.232429Z","caller":"traceutil/trace.go:171","msg":"trace[805057100] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"573.160357ms","start":"2026-04-14T05:41:01.659259Z","end":"2026-04-14T05:41:02.232419Z","steps":["trace[805057100] 'process raft request' (duration: 572.85355ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:02.232518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:01.659228Z","time spent":"573.233394ms","remote":"127.0.0.1:40584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T05:41:02.232524Z","caller":"traceutil/trace.go:171","msg":"trace[1333794400] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"615.102089ms","start":"2026-04-14T05:41:01.61735Z","end":"2026-04-14T05:41:02.232452Z","steps":["trace[1333794400] 'process raft request' (duration: 614.662335ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:02.232632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.980491ms","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-14T05:41:02.232722Z","caller":"traceutil/trace.go:171","msg":"trace[1938654975] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:560; }","duration":"490.076295ms","start":"2026-04-14T05:41:01.742624Z","end":"2026-04-14T05:41:02.232701Z","steps":["trace[1938654975] 'agreement among raft nodes before linearized reading' (duration: 489.842565ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:02.232737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"570.443544ms","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-14T05:41:02.23277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:01.742574Z","time spent":"490.186065ms","remote":"127.0.0.1:40804","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-14T05:41:02.232772Z","caller":"traceutil/trace.go:171","msg":"trace[689442607] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:560; }","duration":"570.503654ms","start":"2026-04-14T05:41:01.662259Z","end":"2026-04-14T05:41:02.232762Z","steps":["trace[689442607] 'agreement among raft nodes before linearized reading' (duration: 570.376616ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:02.232808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:01.66225Z","time spent":"570.552325ms","remote":"127.0.0.1:40804","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-14T05:41:02.232808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:01.617317Z","time spent":"615.353677ms","remote":"127.0.0.1:40584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29452,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T05:41:02.233014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.506624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T05:41:02.233042Z","caller":"traceutil/trace.go:171","msg":"trace[152407512] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:560; }","duration":"212.569103ms","start":"2026-04-14T05:41:02.020467Z","end":"2026-04-14T05:41:02.233036Z","steps":["trace[152407512] 'agreement among raft nodes before linearized reading' (duration: 212.52653ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:41:08.409663Z","caller":"traceutil/trace.go:171","msg":"trace[1651825197] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"134.405251ms","start":"2026-04-14T05:41:08.275245Z","end":"2026-04-14T05:41:08.409651Z","steps":["trace[1651825197] 'process raft request' (duration: 134.318608ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:41:08.410434Z","caller":"traceutil/trace.go:171","msg":"trace[1905784861] linearizableReadLoop","detail":"{readStateIndex:666; appliedIndex:666; }","duration":"134.559503ms","start":"2026-04-14T05:41:08.275867Z","end":"2026-04-14T05:41:08.410426Z","steps":["trace[1905784861] 'read index received' (duration: 134.556434ms)","trace[1905784861] 'applied index is now lower than readState.Index' (duration: 2.479µs)"],"step_count":2} {"level":"warn","ts":"2026-04-14T05:41:08.410501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.619772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T05:41:08.410518Z","caller":"traceutil/trace.go:171","msg":"trace[420358270] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:640; }","duration":"134.686918ms","start":"2026-04-14T05:41:08.275826Z","end":"2026-04-14T05:41:08.410513Z","steps":["trace[420358270] 'agreement among raft nodes before linearized reading' (duration: 134.642487ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.020863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.294501ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-14T05:41:09.020946Z","caller":"traceutil/trace.go:171","msg":"trace[1372034046] linearizableReadLoop","detail":"{readStateIndex:667; appliedIndex:666; }","duration":"610.464477ms","start":"2026-04-14T05:41:08.410455Z","end":"2026-04-14T05:41:09.020919Z","steps":["trace[1372034046] 'read index received' (duration: 107.209658ms)","trace[1372034046] 'applied index is now lower than readState.Index' (duration: 503.253959ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T05:41:09.021247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"729.088133ms","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-14T05:41:09.021233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"718.65854ms","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-14T05:41:09.02135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"745.466136ms","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-14T05:41:09.021373Z","caller":"traceutil/trace.go:171","msg":"trace[1298104668] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:640; }","duration":"745.49823ms","start":"2026-04-14T05:41:08.275869Z","end":"2026-04-14T05:41:09.021367Z","steps":["trace[1298104668] 'agreement among raft nodes before linearized reading' (duration: 745.412597ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.021391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:08.275822Z","time spent":"745.564258ms","remote":"127.0.0.1:46210","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-14T05:41:09.021354Z","caller":"traceutil/trace.go:171","msg":"trace[360436371] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:640; }","duration":"718.8115ms","start":"2026-04-14T05:41:08.302525Z","end":"2026-04-14T05:41:09.021337Z","steps":["trace[360436371] 'agreement among raft nodes before linearized reading' (duration: 718.562848ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.021697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:08.30251Z","time spent":"719.12697ms","remote":"127.0.0.1:40804","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-14T05:41:09.02183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.937681ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T05:41:09.021887Z","caller":"traceutil/trace.go:171","msg":"trace[2069254850] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:640; }","duration":"126.99706ms","start":"2026-04-14T05:41:08.894883Z","end":"2026-04-14T05:41:09.02188Z","steps":["trace[2069254850] 'range keys from in-memory index tree' (duration: 126.930702ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:41:09.021273Z","caller":"traceutil/trace.go:171","msg":"trace[1508326633] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:640; }","duration":"729.149202ms","start":"2026-04-14T05:41:08.292118Z","end":"2026-04-14T05:41:09.021268Z","steps":["trace[1508326633] 'agreement among raft nodes before linearized reading' (duration: 729.048252ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.022134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:08.292108Z","time spent":"729.981933ms","remote":"127.0.0.1:40804","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-14T05:41:09.078962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.609709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T05:41:09.079022Z","caller":"traceutil/trace.go:171","msg":"trace[908147473] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:641; }","duration":"376.704952ms","start":"2026-04-14T05:41:08.702303Z","end":"2026-04-14T05:41:09.079008Z","steps":["trace[908147473] 'agreement among raft nodes before linearized reading' (duration: 376.601991ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.07905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:08.702291Z","time spent":"376.752622ms","remote":"127.0.0.1:46276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "} {"level":"info","ts":"2026-04-14T05:41:09.079024Z","caller":"traceutil/trace.go:171","msg":"trace[1607856259] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"663.385376ms","start":"2026-04-14T05:41:08.415624Z","end":"2026-04-14T05:41:09.07901Z","steps":["trace[1607856259] 'process raft request' (duration: 662.84477ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.079184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:08.4156Z","time spent":"663.498434ms","remote":"127.0.0.1:40626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T05:41:09.079262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.929139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T05:41:09.07929Z","caller":"traceutil/trace.go:171","msg":"trace[2083713546] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:641; }","duration":"376.980319ms","start":"2026-04-14T05:41:08.702303Z","end":"2026-04-14T05:41:09.079283Z","steps":["trace[2083713546] 'agreement among raft nodes before linearized reading' (duration: 376.937437ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.079338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:08.702286Z","time spent":"377.044866ms","remote":"127.0.0.1:46276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 "} {"level":"warn","ts":"2026-04-14T05:41:09.079455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.067252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T05:41:09.079462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.093882ms","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":"warn","ts":"2026-04-14T05:41:09.079508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.688033ms","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":"warn","ts":"2026-04-14T05:41:09.079494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.415814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T05:41:09.079531Z","caller":"traceutil/trace.go:171","msg":"trace[1928054062] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:641; }","duration":"262.148627ms","start":"2026-04-14T05:41:08.817364Z","end":"2026-04-14T05:41:09.079512Z","steps":["trace[1928054062] 'agreement among raft nodes before linearized reading' (duration: 262.036838ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:41:09.079563Z","caller":"traceutil/trace.go:171","msg":"trace[576379260] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:641; }","duration":"402.518333ms","start":"2026-04-14T05:41:08.677029Z","end":"2026-04-14T05:41:09.079547Z","steps":["trace[576379260] 'agreement among raft nodes before linearized reading' (duration: 402.409364ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.07959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.81366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T05:41:09.079615Z","caller":"traceutil/trace.go:171","msg":"trace[512741866] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:641; }","duration":"518.894884ms","start":"2026-04-14T05:41:08.560714Z","end":"2026-04-14T05:41:09.079608Z","steps":["trace[512741866] 'agreement among raft nodes before linearized reading' (duration: 518.828686ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.079609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:08.677013Z","time spent":"402.585431ms","remote":"127.0.0.1:46262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-14T05:41:09.079597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.224705ms","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-14T05:41:09.079656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:08.560694Z","time spent":"518.954342ms","remote":"127.0.0.1:46238","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/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 "} {"level":"info","ts":"2026-04-14T05:41:09.079664Z","caller":"traceutil/trace.go:171","msg":"trace[2022178044] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:641; }","duration":"284.30096ms","start":"2026-04-14T05:41:08.795349Z","end":"2026-04-14T05:41:09.07965Z","steps":["trace[2022178044] 'agreement among raft nodes before linearized reading' (duration: 284.224074ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:41:09.079626Z","caller":"traceutil/trace.go:171","msg":"trace[431363016] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:641; }","duration":"454.228106ms","start":"2026-04-14T05:41:08.625333Z","end":"2026-04-14T05:41:09.079524Z","steps":["trace[431363016] 'agreement among raft nodes before linearized reading' (duration: 454.003809ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.079802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.79769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T05:41:09.079856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"543.42261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T05:41:09.07953Z","caller":"traceutil/trace.go:171","msg":"trace[1340062605] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:641; }","duration":"518.739383ms","start":"2026-04-14T05:41:08.560784Z","end":"2026-04-14T05:41:09.079523Z","steps":["trace[1340062605] 'agreement among raft nodes before linearized reading' (duration: 518.676995ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.079821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:08.625328Z","time spent":"454.461402ms","remote":"127.0.0.1:46256","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-14T05:41:09.079933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"543.512163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T05:41:09.079934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.812734ms","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":"warn","ts":"2026-04-14T05:41:09.080005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"667.920079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T05:41:09.080029Z","caller":"traceutil/trace.go:171","msg":"trace[1203308902] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:641; }","duration":"667.952193ms","start":"2026-04-14T05:41:08.412071Z","end":"2026-04-14T05:41:09.080023Z","steps":["trace[1203308902] 'agreement among raft nodes before linearized reading' (duration: 667.91511ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.080045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.033329ms","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":"warn","ts":"2026-04-14T05:41:09.080075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:08.412068Z","time spent":"667.997484ms","remote":"127.0.0.1:46222","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"info","ts":"2026-04-14T05:41:09.080087Z","caller":"traceutil/trace.go:171","msg":"trace[1364950194] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:641; }","duration":"486.075311ms","start":"2026-04-14T05:41:08.594002Z","end":"2026-04-14T05:41:09.080078Z","steps":["trace[1364950194] 'agreement among raft nodes before linearized reading' (duration: 486.018992ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.080124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:08.593965Z","time spent":"486.150257ms","remote":"127.0.0.1:46242","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-14T05:41:09.080155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.647726ms","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":"warn","ts":"2026-04-14T05:41:09.080183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.678186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T05:41:09.080218Z","caller":"traceutil/trace.go:171","msg":"trace[1828796829] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:641; }","duration":"129.721122ms","start":"2026-04-14T05:41:08.95048Z","end":"2026-04-14T05:41:09.080201Z","steps":["trace[1828796829] 'agreement among raft nodes before linearized reading' (duration: 129.639698ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.080254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"668.186388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T05:41:09.080269Z","caller":"traceutil/trace.go:171","msg":"trace[86714766] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:641; }","duration":"296.776097ms","start":"2026-04-14T05:41:08.783462Z","end":"2026-04-14T05:41:09.080239Z","steps":["trace[86714766] 'agreement among raft nodes before linearized reading' (duration: 296.686484ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.079824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.500724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T05:41:09.080428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.138353ms","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-14T05:41:09.080443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.37641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T05:41:09.080456Z","caller":"traceutil/trace.go:171","msg":"trace[1350737095] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:641; }","duration":"543.152279ms","start":"2026-04-14T05:41:08.537287Z","end":"2026-04-14T05:41:09.080439Z","steps":["trace[1350737095] 'agreement among raft nodes before linearized reading' (duration: 542.487486ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:41:09.080474Z","caller":"traceutil/trace.go:171","msg":"trace[738388826] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:641; }","duration":"403.436549ms","start":"2026-04-14T05:41:08.677029Z","end":"2026-04-14T05:41:09.080465Z","steps":["trace[738388826] 'agreement among raft nodes before linearized reading' (duration: 403.393127ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.080471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.794176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T05:41:09.080475Z","caller":"traceutil/trace.go:171","msg":"trace[1530047662] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:641; }","duration":"130.227086ms","start":"2026-04-14T05:41:08.950235Z","end":"2026-04-14T05:41:09.080462Z","steps":["trace[1530047662] 'agreement among raft nodes before linearized reading' (duration: 130.152331ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.080505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:08.677013Z","time spent":"403.48304ms","remote":"127.0.0.1:46262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "} {"level":"info","ts":"2026-04-14T05:41:09.080537Z","caller":"traceutil/trace.go:171","msg":"trace[130312225] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:641; }","duration":"297.846765ms","start":"2026-04-14T05:41:08.782653Z","end":"2026-04-14T05:41:09.0805Z","steps":["trace[130312225] 'agreement among raft nodes before linearized reading' (duration: 297.789906ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.080558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:08.537273Z","time spent":"543.225475ms","remote":"127.0.0.1:46222","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 "} {"level":"warn","ts":"2026-04-14T05:41:09.080666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.559782ms","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-14T05:41:09.080694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.702071ms","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-14T05:41:09.080714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.708503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T05:41:09.080776Z","caller":"traceutil/trace.go:171","msg":"trace[1270281372] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:641; }","duration":"489.808435ms","start":"2026-04-14T05:41:08.59096Z","end":"2026-04-14T05:41:09.080768Z","steps":["trace[1270281372] 'agreement among raft nodes before linearized reading' (duration: 489.72761ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.080752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.064384ms","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-14T05:41:09.080783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.988479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T05:41:09.08081Z","caller":"traceutil/trace.go:171","msg":"trace[961773856] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:641; }","duration":"298.187221ms","start":"2026-04-14T05:41:08.782613Z","end":"2026-04-14T05:41:09.0808Z","steps":["trace[961773856] 'agreement among raft nodes before linearized reading' (duration: 298.08464ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:41:09.080833Z","caller":"traceutil/trace.go:171","msg":"trace[1353201364] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:641; }","duration":"225.043599ms","start":"2026-04-14T05:41:08.855775Z","end":"2026-04-14T05:41:09.080818Z","steps":["trace[1353201364] 'agreement among raft nodes before linearized reading' (duration: 224.982811ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.080963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.148251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-stlq9\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-14T05:41:09.081006Z","caller":"traceutil/trace.go:171","msg":"trace[1131502184] range","detail":"{range_begin:/registry/pods/kube-system/cilium-stlq9; range_end:; response_count:1; response_revision:641; }","duration":"348.196891ms","start":"2026-04-14T05:41:08.732785Z","end":"2026-04-14T05:41:09.080981Z","steps":["trace[1131502184] 'agreement among raft nodes before linearized reading' (duration: 348.031423ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.081031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:08.732768Z","time spent":"348.257669ms","remote":"127.0.0.1:40730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-stlq9\" "} {"level":"info","ts":"2026-04-14T05:41:09.079854Z","caller":"traceutil/trace.go:171","msg":"trace[899771559] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:641; }","duration":"401.867047ms","start":"2026-04-14T05:41:08.677976Z","end":"2026-04-14T05:41:09.079843Z","steps":["trace[899771559] 'agreement among raft nodes before linearized reading' (duration: 401.79709ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.080276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.031323ms","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-14T05:41:09.081132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:08.677967Z","time spent":"403.149861ms","remote":"127.0.0.1:46262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 "} {"level":"warn","ts":"2026-04-14T05:41:09.081219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.549299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T05:41:09.081264Z","caller":"traceutil/trace.go:171","msg":"trace[292311577] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:641; }","duration":"263.64773ms","start":"2026-04-14T05:41:08.817606Z","end":"2026-04-14T05:41:09.081254Z","steps":["trace[292311577] 'agreement among raft nodes before linearized reading' (duration: 263.551158ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:41:09.079955Z","caller":"traceutil/trace.go:171","msg":"trace[1538406741] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:641; }","duration":"543.570082ms","start":"2026-04-14T05:41:08.536379Z","end":"2026-04-14T05:41:09.079949Z","steps":["trace[1538406741] 'agreement among raft nodes before linearized reading' (duration: 543.537289ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:41:09.081245Z","caller":"traceutil/trace.go:171","msg":"trace[945800921] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:641; }","duration":"455.962765ms","start":"2026-04-14T05:41:08.625208Z","end":"2026-04-14T05:41:09.081171Z","steps":["trace[945800921] 'agreement among raft nodes before linearized reading' (duration: 455.04464ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.07955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.132203ms","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":"warn","ts":"2026-04-14T05:41:09.081359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:08.536365Z","time spent":"544.957737ms","remote":"127.0.0.1:46224","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-14T05:41:09.079476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.18581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T05:41:09.080029Z","caller":"traceutil/trace.go:171","msg":"trace[697875772] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:641; }","duration":"284.88581ms","start":"2026-04-14T05:41:08.795109Z","end":"2026-04-14T05:41:09.079994Z","steps":["trace[697875772] 'agreement among raft nodes before linearized reading' (duration: 284.787519ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.079892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:08.560777Z","time spent":"519.105914ms","remote":"127.0.0.1:46238","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/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-14T05:41:09.081406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:08.625196Z","time spent":"456.189802ms","remote":"127.0.0.1:46256","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":"info","ts":"2026-04-14T05:41:09.080283Z","caller":"traceutil/trace.go:171","msg":"trace[1775941893] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:641; }","duration":"668.234279ms","start":"2026-04-14T05:41:08.412041Z","end":"2026-04-14T05:41:09.080275Z","steps":["trace[1775941893] 'agreement among raft nodes before linearized reading' (duration: 668.166052ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.08155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:08.412034Z","time spent":"669.500287ms","remote":"127.0.0.1:46222","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"info","ts":"2026-04-14T05:41:09.080725Z","caller":"traceutil/trace.go:171","msg":"trace[1099577970] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:641; }","duration":"130.641407ms","start":"2026-04-14T05:41:08.95007Z","end":"2026-04-14T05:41:09.080711Z","steps":["trace[1099577970] 'agreement among raft nodes before linearized reading' (duration: 130.557913ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.080781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.552812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T05:41:09.078968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.099545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T05:41:09.081705Z","caller":"traceutil/trace.go:171","msg":"trace[1803658425] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:641; }","duration":"378.864668ms","start":"2026-04-14T05:41:08.702833Z","end":"2026-04-14T05:41:09.081698Z","steps":["trace[1803658425] 'agreement among raft nodes before linearized reading' (duration: 376.07875ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.081736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:08.702826Z","time spent":"378.90103ms","remote":"127.0.0.1:46276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 "} {"level":"info","ts":"2026-04-14T05:41:09.080724Z","caller":"traceutil/trace.go:171","msg":"trace[1335956049] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:641; }","duration":"486.742443ms","start":"2026-04-14T05:41:08.593973Z","end":"2026-04-14T05:41:09.080716Z","steps":["trace[1335956049] 'agreement among raft nodes before linearized reading' (duration: 486.697021ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.081819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"520.26541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T05:41:09.081755Z","caller":"traceutil/trace.go:171","msg":"trace[1478161810] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:641; }","duration":"225.524486ms","start":"2026-04-14T05:41:08.8562Z","end":"2026-04-14T05:41:09.081724Z","steps":["trace[1478161810] 'agreement among raft nodes before linearized reading' (duration: 224.549262ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.080803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:08.590946Z","time spent":"489.850897ms","remote":"127.0.0.1:40554","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-14T05:41:09.081814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:08.593967Z","time spent":"487.818477ms","remote":"127.0.0.1:46242","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":"info","ts":"2026-04-14T05:41:09.082027Z","caller":"traceutil/trace.go:171","msg":"trace[825843564] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:641; }","duration":"520.438297ms","start":"2026-04-14T05:41:08.561413Z","end":"2026-04-14T05:41:09.081852Z","steps":["trace[825843564] 'agreement among raft nodes before linearized reading' (duration: 517.884865ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:41:09.081426Z","caller":"traceutil/trace.go:171","msg":"trace[1552517352] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:641; }","duration":"286.066474ms","start":"2026-04-14T05:41:08.795351Z","end":"2026-04-14T05:41:09.081417Z","steps":["trace[1552517352] 'agreement among raft nodes before linearized reading' (duration: 284.149829ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.082106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:08.561404Z","time spent":"520.671964ms","remote":"127.0.0.1:46238","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/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 "} {"level":"info","ts":"2026-04-14T05:41:09.081447Z","caller":"traceutil/trace.go:171","msg":"trace[620153019] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:641; }","duration":"264.188927ms","start":"2026-04-14T05:41:08.817251Z","end":"2026-04-14T05:41:09.08144Z","steps":["trace[620153019] 'agreement among raft nodes before linearized reading' (duration: 262.188699ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:41:09.079902Z","caller":"traceutil/trace.go:171","msg":"trace[1305664516] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:641; }","duration":"543.475269ms","start":"2026-04-14T05:41:08.536401Z","end":"2026-04-14T05:41:09.079876Z","steps":["trace[1305664516] 'agreement among raft nodes before linearized reading' (duration: 543.437007ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.082262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:08.536385Z","time spent":"545.854324ms","remote":"127.0.0.1:46224","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-14T05:41:09.080402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.178042ms","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-14T05:41:09.08236Z","caller":"traceutil/trace.go:171","msg":"trace[47814726] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:641; }","duration":"456.148416ms","start":"2026-04-14T05:41:08.626202Z","end":"2026-04-14T05:41:09.08235Z","steps":["trace[47814726] 'agreement among raft nodes before linearized reading' (duration: 454.177543ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.081128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.35087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T05:41:09.082449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:08.626194Z","time spent":"456.222082ms","remote":"127.0.0.1:46256","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":"info","ts":"2026-04-14T05:41:09.082457Z","caller":"traceutil/trace.go:171","msg":"trace[308716926] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:641; }","duration":"226.713979ms","start":"2026-04-14T05:41:08.855731Z","end":"2026-04-14T05:41:09.082445Z","steps":["trace[308716926] 'agreement among raft nodes before linearized reading' (duration: 225.355159ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.857954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"726.380714ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T05:41:09.85811Z","caller":"traceutil/trace.go:171","msg":"trace[238944259] linearizableReadLoop","detail":"{readStateIndex:670; appliedIndex:668; }","duration":"779.204695ms","start":"2026-04-14T05:41:09.07889Z","end":"2026-04-14T05:41:09.858094Z","steps":["trace[238944259] 'read index received' (duration: 52.572559ms)","trace[238944259] 'applied index is now lower than readState.Index' (duration: 726.631266ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T05:41:09.858191Z","caller":"traceutil/trace.go:171","msg":"trace[2102425355] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"832.376378ms","start":"2026-04-14T05:41:09.025805Z","end":"2026-04-14T05:41:09.858181Z","steps":["trace[2102425355] 'process raft request' (duration: 105.694541ms)","trace[2102425355] 'compare' (duration: 726.259208ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T05:41:09.85825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:09.025781Z","time spent":"832.439516ms","remote":"127.0.0.1:40804","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T05:41:09.858356Z","caller":"traceutil/trace.go:171","msg":"trace[1437642393] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"832.099421ms","start":"2026-04-14T05:41:09.026248Z","end":"2026-04-14T05:41:09.858347Z","steps":["trace[1437642393] 'process raft request' (duration: 831.787641ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.858425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:09.026229Z","time spent":"832.171688ms","remote":"127.0.0.1:40804","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-14T05:41:09.858508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"799.69873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T05:41:09.858542Z","caller":"traceutil/trace.go:171","msg":"trace[2071927865] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:643; }","duration":"799.741822ms","start":"2026-04-14T05:41:09.058789Z","end":"2026-04-14T05:41:09.858531Z","steps":["trace[2071927865] 'agreement among raft nodes before linearized reading' (duration: 799.691912ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.858572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:09.058783Z","time spent":"799.780415ms","remote":"127.0.0.1:46336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-14T05:41:09.858727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"800.11629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T05:41:09.858761Z","caller":"traceutil/trace.go:171","msg":"trace[2051290452] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:643; }","duration":"800.161982ms","start":"2026-04-14T05:41:09.058591Z","end":"2026-04-14T05:41:09.858753Z","steps":["trace[2051290452] 'agreement among raft nodes before linearized reading' (duration: 800.111241ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.8588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:09.058587Z","time spent":"800.195036ms","remote":"127.0.0.1:46336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-14T05:41:09.858915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"800.32993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T05:41:09.858949Z","caller":"traceutil/trace.go:171","msg":"trace[589634287] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:643; }","duration":"800.362703ms","start":"2026-04-14T05:41:09.058576Z","end":"2026-04-14T05:41:09.858939Z","steps":["trace[589634287] 'agreement among raft nodes before linearized reading' (duration: 800.317962ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.858977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:09.058537Z","time spent":"800.43122ms","remote":"127.0.0.1:46336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-14T05:41:09.859036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"828.384291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T05:41:09.859181Z","caller":"traceutil/trace.go:171","msg":"trace[734645901] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:643; }","duration":"828.588872ms","start":"2026-04-14T05:41:09.030578Z","end":"2026-04-14T05:41:09.859167Z","steps":["trace[734645901] 'agreement among raft nodes before linearized reading' (duration: 828.349808ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.859252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:09.030563Z","time spent":"828.674026ms","remote":"127.0.0.1:46328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-04-14T05:41:09.859345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"828.404727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T05:41:09.859386Z","caller":"traceutil/trace.go:171","msg":"trace[93444851] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:643; }","duration":"828.455538ms","start":"2026-04-14T05:41:09.030919Z","end":"2026-04-14T05:41:09.859374Z","steps":["trace[93444851] 'agreement among raft nodes before linearized reading' (duration: 828.400978ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.859414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:09.030914Z","time spent":"828.492641ms","remote":"127.0.0.1:46322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 "} {"level":"warn","ts":"2026-04-14T05:41:09.859634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"828.889215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T05:41:09.859696Z","caller":"traceutil/trace.go:171","msg":"trace[1303455126] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:643; }","duration":"828.96581ms","start":"2026-04-14T05:41:09.030719Z","end":"2026-04-14T05:41:09.859685Z","steps":["trace[1303455126] 'agreement among raft nodes before linearized reading' (duration: 828.878357ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.859762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:09.030714Z","time spent":"829.035987ms","remote":"127.0.0.1:46328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"info","ts":"2026-04-14T05:41:09.866593Z","caller":"traceutil/trace.go:171","msg":"trace[1781835755] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"754.473568ms","start":"2026-04-14T05:41:09.112106Z","end":"2026-04-14T05:41:09.866579Z","steps":["trace[1781835755] 'process raft request' (duration: 754.388444ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.866708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:09.112085Z","time spent":"754.585906ms","remote":"127.0.0.1:40730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T05:41:09.925145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"836.522456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T05:41:09.925181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"820.871786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T05:41:09.925225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"785.920611ms","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-14T05:41:09.92525Z","caller":"traceutil/trace.go:171","msg":"trace[482250672] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:646; }","duration":"836.678896ms","start":"2026-04-14T05:41:09.088548Z","end":"2026-04-14T05:41:09.925227Z","steps":["trace[482250672] 'agreement among raft nodes before linearized reading' (duration: 836.493871ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:41:09.925258Z","caller":"traceutil/trace.go:171","msg":"trace[970800373] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:646; }","duration":"820.971916ms","start":"2026-04-14T05:41:09.104267Z","end":"2026-04-14T05:41:09.925239Z","steps":["trace[970800373] 'agreement among raft nodes before linearized reading' (duration: 820.819266ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:41:09.925284Z","caller":"traceutil/trace.go:171","msg":"trace[711796297] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:646; }","duration":"785.965863ms","start":"2026-04-14T05:41:09.139292Z","end":"2026-04-14T05:41:09.925258Z","steps":["trace[711796297] 'agreement among raft nodes before linearized reading' (duration: 785.905064ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.925301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"821.105041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T05:41:09.925312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:09.088529Z","time spent":"836.766829ms","remote":"127.0.0.1:46342","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/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 "} {"level":"warn","ts":"2026-04-14T05:41:09.925349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:09.139284Z","time spent":"786.050296ms","remote":"127.0.0.1:46364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 "} {"level":"info","ts":"2026-04-14T05:41:09.925353Z","caller":"traceutil/trace.go:171","msg":"trace[788292245] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:646; }","duration":"821.157911ms","start":"2026-04-14T05:41:09.104177Z","end":"2026-04-14T05:41:09.925335Z","steps":["trace[788292245] 'agreement among raft nodes before linearized reading' (duration: 821.104531ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.925404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"803.451542ms","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-14T05:41:09.925433Z","caller":"traceutil/trace.go:171","msg":"trace[700456743] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:646; }","duration":"803.493714ms","start":"2026-04-14T05:41:09.121929Z","end":"2026-04-14T05:41:09.925423Z","steps":["trace[700456743] 'agreement among raft nodes before linearized reading' (duration: 803.442654ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.925439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.557269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T05:41:09.925461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:09.121921Z","time spent":"803.532557ms","remote":"127.0.0.1:46364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"info","ts":"2026-04-14T05:41:09.925495Z","caller":"traceutil/trace.go:171","msg":"trace[265121877] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"789.384939ms","start":"2026-04-14T05:41:09.136102Z","end":"2026-04-14T05:41:09.925487Z","steps":["trace[265121877] 'process raft request' (duration: 788.689872ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.925354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"803.294603ms","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-14T05:41:09.925552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:09.13609Z","time spent":"789.427211ms","remote":"127.0.0.1:40778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T05:41:09.925577Z","caller":"traceutil/trace.go:171","msg":"trace[1822695635] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:646; }","duration":"803.531658ms","start":"2026-04-14T05:41:09.122038Z","end":"2026-04-14T05:41:09.92557Z","steps":["trace[1822695635] 'agreement among raft nodes before linearized reading' (duration: 803.291013ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.925608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:09.122034Z","time spent":"803.565292ms","remote":"127.0.0.1:46364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-14T05:41:09.925304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:09.104263Z","time spent":"821.030555ms","remote":"127.0.0.1:46358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-14T05:41:09.925645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"836.982889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T05:41:09.925708Z","caller":"traceutil/trace.go:171","msg":"trace[121125903] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:646; }","duration":"837.059614ms","start":"2026-04-14T05:41:09.088631Z","end":"2026-04-14T05:41:09.925691Z","steps":["trace[121125903] 'agreement among raft nodes before linearized reading' (duration: 836.967222ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:41:09.925463Z","caller":"traceutil/trace.go:171","msg":"trace[1409668728] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:646; }","duration":"331.60384ms","start":"2026-04-14T05:41:09.593851Z","end":"2026-04-14T05:41:09.925455Z","steps":["trace[1409668728] 'agreement among raft nodes before linearized reading' (duration: 331.572016ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.925759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:09.593835Z","time spent":"331.915841ms","remote":"127.0.0.1:40540","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-14T05:41:09.925814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"837.183061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T05:41:09.925401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:09.104171Z","time spent":"821.220549ms","remote":"127.0.0.1:46358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-14T05:41:09.92525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"821.16255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T05:41:09.926095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"770.197605ms","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":"warn","ts":"2026-04-14T05:41:09.925758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:09.088627Z","time spent":"837.117293ms","remote":"127.0.0.1:46342","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/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 "} {"level":"info","ts":"2026-04-14T05:41:09.926137Z","caller":"traceutil/trace.go:171","msg":"trace[365954866] 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:646; }","duration":"770.262633ms","start":"2026-04-14T05:41:09.155864Z","end":"2026-04-14T05:41:09.926127Z","steps":["trace[365954866] 'agreement among raft nodes before linearized reading' (duration: 770.198225ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.926169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:09.155857Z","time spent":"770.302835ms","remote":"127.0.0.1:46378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 "} {"level":"warn","ts":"2026-04-14T05:41:09.926178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"770.503556ms","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":"info","ts":"2026-04-14T05:41:09.92622Z","caller":"traceutil/trace.go:171","msg":"trace[1612413022] 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:646; }","duration":"770.563775ms","start":"2026-04-14T05:41:09.155642Z","end":"2026-04-14T05:41:09.926206Z","steps":["trace[1612413022] 'agreement among raft nodes before linearized reading' (duration: 770.497078ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:41:09.925871Z","caller":"traceutil/trace.go:171","msg":"trace[740094847] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:646; }","duration":"837.250078ms","start":"2026-04-14T05:41:09.088609Z","end":"2026-04-14T05:41:09.925859Z","steps":["trace[740094847] 'agreement among raft nodes before linearized reading' (duration: 837.172653ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.926272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:09.155635Z","time spent":"770.623353ms","remote":"127.0.0.1:46378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"warn","ts":"2026-04-14T05:41:09.926317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:09.088605Z","time spent":"837.694073ms","remote":"127.0.0.1:46342","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/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-14T05:41:09.926443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"731.074328ms","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-14T05:41:09.925156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"785.922071ms","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-14T05:41:09.926484Z","caller":"traceutil/trace.go:171","msg":"trace[158872284] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:646; }","duration":"731.11611ms","start":"2026-04-14T05:41:09.195358Z","end":"2026-04-14T05:41:09.926474Z","steps":["trace[158872284] 'agreement among raft nodes before linearized reading' (duration: 730.945373ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:41:09.926501Z","caller":"traceutil/trace.go:171","msg":"trace[557157472] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:646; }","duration":"787.307887ms","start":"2026-04-14T05:41:09.139177Z","end":"2026-04-14T05:41:09.926485Z","steps":["trace[557157472] 'agreement among raft nodes before linearized reading' (duration: 785.93031ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.926514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:09.195327Z","time spent":"731.179968ms","remote":"127.0.0.1:40804","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-14T05:41:09.92654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"770.991203ms","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-14T05:41:09.925869Z","caller":"traceutil/trace.go:171","msg":"trace[138276023] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"344.469842ms","start":"2026-04-14T05:41:09.581387Z","end":"2026-04-14T05:41:09.925857Z","steps":["trace[138276023] 'process raft request' (duration: 343.547778ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:41:09.926569Z","caller":"traceutil/trace.go:171","msg":"trace[550428327] 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:646; }","duration":"771.047973ms","start":"2026-04-14T05:41:09.155512Z","end":"2026-04-14T05:41:09.92656Z","steps":["trace[550428327] 'agreement among raft nodes before linearized reading' (duration: 770.997182ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.926568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:09.13915Z","time spent":"787.39809ms","remote":"127.0.0.1:46368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-14T05:41:09.926592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:09.155499Z","time spent":"771.087375ms","remote":"127.0.0.1:46378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 "} {"level":"info","ts":"2026-04-14T05:41:09.926107Z","caller":"traceutil/trace.go:171","msg":"trace[1031469120] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:646; }","duration":"822.045662ms","start":"2026-04-14T05:41:09.104042Z","end":"2026-04-14T05:41:09.926088Z","steps":["trace[1031469120] 'agreement among raft nodes before linearized reading' (duration: 821.158781ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.926633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:09.581364Z","time spent":"345.222319ms","remote":"127.0.0.1:40804","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-14T05:41:09.926674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:09.104028Z","time spent":"822.639568ms","remote":"127.0.0.1:46358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-14T05:41:09.927057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"787.725797ms","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-14T05:41:09.927121Z","caller":"traceutil/trace.go:171","msg":"trace[8438248] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:646; }","duration":"787.834336ms","start":"2026-04-14T05:41:09.139272Z","end":"2026-04-14T05:41:09.927106Z","steps":["trace[8438248] 'agreement among raft nodes before linearized reading' (duration: 785.776469ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:09.927168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:09.13925Z","time spent":"787.905803ms","remote":"127.0.0.1:46368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-04-14T05:41:10.283474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.098845ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T05:41:10.283575Z","caller":"traceutil/trace.go:171","msg":"trace[2000441939] linearizableReadLoop","detail":"{readStateIndex:674; appliedIndex:673; }","duration":"347.806559ms","start":"2026-04-14T05:41:09.935754Z","end":"2026-04-14T05:41:10.283561Z","steps":["trace[2000441939] 'read index received' (duration: 50.494335ms)","trace[2000441939] 'applied index is now lower than readState.Index' (duration: 297.311244ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T05:41:10.283642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.886083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-04-14T05:41:10.283673Z","caller":"traceutil/trace.go:171","msg":"trace[192431080] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:647; }","duration":"347.940773ms","start":"2026-04-14T05:41:09.935723Z","end":"2026-04-14T05:41:10.283664Z","steps":["trace[192431080] 'agreement among raft nodes before linearized reading' (duration: 347.879915ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:41:10.283679Z","caller":"traceutil/trace.go:171","msg":"trace[547592703] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"349.721063ms","start":"2026-04-14T05:41:09.933916Z","end":"2026-04-14T05:41:10.283637Z","steps":["trace[547592703] 'process raft request' (duration: 52.382255ms)","trace[547592703] 'compare' (duration: 296.983247ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T05:41:10.283823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:09.933898Z","time spent":"349.857027ms","remote":"127.0.0.1:40804","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-14T05:41:10.28371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:09.935713Z","time spent":"347.989853ms","remote":"127.0.0.1:40744","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":216,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"warn","ts":"2026-04-14T05:41:10.914292Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4500113670871898467,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-14T05:41:11.415254Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4500113670871898467,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-14T05:41:11.915663Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4500113670871898467,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-14T05:41:12.202941Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.910162471s","expected-duration":"1s"} {"level":"info","ts":"2026-04-14T05:41:12.257315Z","caller":"traceutil/trace.go:171","msg":"trace[1269261586] linearizableReadLoop","detail":"{readStateIndex:675; appliedIndex:674; }","duration":"1.843038665s","start":"2026-04-14T05:41:10.414252Z","end":"2026-04-14T05:41:12.257291Z","steps":["trace[1269261586] 'read index received' (duration: 1.788809933s)","trace[1269261586] 'applied index is now lower than readState.Index' (duration: 54.227682ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T05:41:12.257344Z","caller":"traceutil/trace.go:171","msg":"trace[1580333286] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"1.964652862s","start":"2026-04-14T05:41:10.29268Z","end":"2026-04-14T05:41:12.257333Z","steps":["trace[1580333286] 'process raft request' (duration: 1.910455294s)","trace[1580333286] 'compare' (duration: 53.748817ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T05:41:12.257438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.843176167s","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-14T05:41:12.25747Z","caller":"traceutil/trace.go:171","msg":"trace[873069030] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:648; }","duration":"1.843257192s","start":"2026-04-14T05:41:10.414206Z","end":"2026-04-14T05:41:12.257463Z","steps":["trace[873069030] 'agreement among raft nodes before linearized reading' (duration: 1.8431665s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:12.257499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:10.414183Z","time spent":"1.843309681s","remote":"127.0.0.1:40804","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-14T05:41:12.257524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:10.292657Z","time spent":"1.964750103s","remote":"127.0.0.1:40730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-14T05:41:12.257643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"668.836521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T05:41:12.257724Z","caller":"traceutil/trace.go:171","msg":"trace[432093635] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:648; }","duration":"668.961256ms","start":"2026-04-14T05:41:11.588753Z","end":"2026-04-14T05:41:12.257714Z","steps":["trace[432093635] 'agreement among raft nodes before linearized reading' (duration: 668.795149ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:12.257759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.324201ms","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-14T05:41:12.257779Z","caller":"traceutil/trace.go:171","msg":"trace[124891016] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:648; }","duration":"393.384828ms","start":"2026-04-14T05:41:11.86439Z","end":"2026-04-14T05:41:12.257775Z","steps":["trace[124891016] 'agreement among raft nodes before linearized reading' (duration: 393.312093ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:12.257791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:11.864334Z","time spent":"393.454165ms","remote":"127.0.0.1:40804","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-14T05:41:12.25778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:11.588733Z","time spent":"669.037631ms","remote":"127.0.0.1:40540","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-14T05:41:12.25796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.728431ms","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-14T05:41:12.257984Z","caller":"traceutil/trace.go:171","msg":"trace[1793567093] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:648; }","duration":"393.787739ms","start":"2026-04-14T05:41:11.86419Z","end":"2026-04-14T05:41:12.257978Z","steps":["trace[1793567093] 'agreement among raft nodes before linearized reading' (duration: 393.727661ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:12.257997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:11.864166Z","time spent":"393.827282ms","remote":"127.0.0.1:40804","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-14T05:41:14.158796Z","caller":"traceutil/trace.go:171","msg":"trace[164506956] transaction","detail":"{read_only:false; response_revision:689; number_of_response:1; }","duration":"122.149268ms","start":"2026-04-14T05:41:14.036628Z","end":"2026-04-14T05:41:14.158777Z","steps":["trace[164506956] 'process raft request' (duration: 122.044729ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:41:17.064391Z","caller":"traceutil/trace.go:171","msg":"trace[35555770] transaction","detail":"{read_only:false; response_revision:727; number_of_response:1; }","duration":"125.839852ms","start":"2026-04-14T05:41:16.938488Z","end":"2026-04-14T05:41:17.064328Z","steps":["trace[35555770] 'process raft request' (duration: 125.388096ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:41:24.447773Z","caller":"traceutil/trace.go:171","msg":"trace[34473372] linearizableReadLoop","detail":"{readStateIndex:819; appliedIndex:818; }","duration":"117.066803ms","start":"2026-04-14T05:41:24.330683Z","end":"2026-04-14T05:41:24.44775Z","steps":["trace[34473372] 'read index received' (duration: 116.867577ms)","trace[34473372] 'applied index is now lower than readState.Index' (duration: 198.286µs)"],"step_count":2} {"level":"info","ts":"2026-04-14T05:41:24.447887Z","caller":"traceutil/trace.go:171","msg":"trace[1887669432] transaction","detail":"{read_only:false; response_revision:787; number_of_response:1; }","duration":"120.466914ms","start":"2026-04-14T05:41:24.327401Z","end":"2026-04-14T05:41:24.447868Z","steps":["trace[1887669432] 'process raft request' (duration: 120.202662ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:24.448247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.537219ms","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-14T05:41:24.448313Z","caller":"traceutil/trace.go:171","msg":"trace[1894667550] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:787; }","duration":"117.642026ms","start":"2026-04-14T05:41:24.330655Z","end":"2026-04-14T05:41:24.448297Z","steps":["trace[1894667550] 'agreement among raft nodes before linearized reading' (duration: 117.232426ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:24.448418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.830666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-14T05:41:24.448516Z","caller":"traceutil/trace.go:171","msg":"trace[1767469396] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:787; }","duration":"111.956648ms","start":"2026-04-14T05:41:24.336536Z","end":"2026-04-14T05:41:24.448492Z","steps":["trace[1767469396] 'agreement among raft nodes before linearized reading' (duration: 111.670851ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:24.448706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.231037ms","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-14T05:41:24.448974Z","caller":"traceutil/trace.go:171","msg":"trace[1039270296] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:787; }","duration":"116.572702ms","start":"2026-04-14T05:41:24.332268Z","end":"2026-04-14T05:41:24.448841Z","steps":["trace[1039270296] 'agreement among raft nodes before linearized reading' (duration: 115.888982ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:41:27.50405Z","caller":"traceutil/trace.go:171","msg":"trace[661185585] transaction","detail":"{read_only:false; response_revision:809; number_of_response:1; }","duration":"666.615623ms","start":"2026-04-14T05:41:26.837411Z","end":"2026-04-14T05:41:27.504026Z","steps":["trace[661185585] 'process raft request' (duration: 666.461788ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:27.504208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:26.837392Z","time spent":"666.743505ms","remote":"127.0.0.1:40730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4028,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T05:41:28.135998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.679662ms","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-14T05:41:28.136061Z","caller":"traceutil/trace.go:171","msg":"trace[181377294] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:809; }","duration":"163.785078ms","start":"2026-04-14T05:41:27.972263Z","end":"2026-04-14T05:41:28.136048Z","steps":["trace[181377294] 'count revisions from in-memory index tree' (duration: 163.615327ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:28.136173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.833949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T05:41:28.136476Z","caller":"traceutil/trace.go:171","msg":"trace[1364553233] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:809; }","duration":"549.187419ms","start":"2026-04-14T05:41:27.58727Z","end":"2026-04-14T05:41:28.136458Z","steps":["trace[1364553233] 'range keys from in-memory index tree' (duration: 548.705098ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:28.13652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:27.587249Z","time spent":"549.260522ms","remote":"127.0.0.1:40540","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-14T05:41:28.136294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.190529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-14T05:41:28.136619Z","caller":"traceutil/trace.go:171","msg":"trace[2018759489] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:809; }","duration":"384.7164ms","start":"2026-04-14T05:41:27.751889Z","end":"2026-04-14T05:41:28.136605Z","steps":["trace[2018759489] 'range keys from in-memory index tree' (duration: 384.015238ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:28.13665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:41:27.751855Z","time spent":"384.784615ms","remote":"127.0.0.1:40804","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-14T05:41:30.749457Z","caller":"traceutil/trace.go:171","msg":"trace[1401676944] linearizableReadLoop","detail":"{readStateIndex:857; appliedIndex:854; }","duration":"161.392203ms","start":"2026-04-14T05:41:30.588043Z","end":"2026-04-14T05:41:30.749435Z","steps":["trace[1401676944] 'read index received' (duration: 161.2319ms)","trace[1401676944] 'applied index is now lower than readState.Index' (duration: 159.453µs)"],"step_count":2} {"level":"info","ts":"2026-04-14T05:41:30.749523Z","caller":"traceutil/trace.go:171","msg":"trace[1493440747] transaction","detail":"{read_only:false; response_revision:822; number_of_response:1; }","duration":"211.624476ms","start":"2026-04-14T05:41:30.537864Z","end":"2026-04-14T05:41:30.749488Z","steps":["trace[1493440747] 'process raft request' (duration: 211.34431ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:41:30.749595Z","caller":"traceutil/trace.go:171","msg":"trace[660337085] transaction","detail":"{read_only:false; response_revision:823; number_of_response:1; }","duration":"211.634243ms","start":"2026-04-14T05:41:30.537923Z","end":"2026-04-14T05:41:30.749557Z","steps":["trace[660337085] 'process raft request' (duration: 211.433309ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:41:30.749638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.571112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T05:41:30.749681Z","caller":"traceutil/trace.go:171","msg":"trace[206507519] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:824; }","duration":"161.650204ms","start":"2026-04-14T05:41:30.588018Z","end":"2026-04-14T05:41:30.749668Z","steps":["trace[206507519] 'agreement among raft nodes before linearized reading' (duration: 161.515365ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:41:30.749788Z","caller":"traceutil/trace.go:171","msg":"trace[510717030] transaction","detail":"{read_only:false; response_revision:824; number_of_response:1; }","duration":"187.711829ms","start":"2026-04-14T05:41:30.561981Z","end":"2026-04-14T05:41:30.749693Z","steps":["trace[510717030] 'process raft request' (duration: 187.415637ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:42:19.175988Z","caller":"traceutil/trace.go:171","msg":"trace[1376643905] transaction","detail":"{read_only:false; response_revision:1112; number_of_response:1; }","duration":"161.437511ms","start":"2026-04-14T05:42:19.014517Z","end":"2026-04-14T05:42:19.175955Z","steps":["trace[1376643905] 'process raft request' (duration: 129.020824ms)","trace[1376643905] 'compare' (duration: 32.260746ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T05:42:37.104364Z","caller":"traceutil/trace.go:171","msg":"trace[904318027] transaction","detail":"{read_only:false; response_revision:1169; number_of_response:1; }","duration":"138.463059ms","start":"2026-04-14T05:42:36.965875Z","end":"2026-04-14T05:42:37.104338Z","steps":["trace[904318027] 'process raft request' (duration: 138.326989ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:43:21.514149Z","caller":"traceutil/trace.go:171","msg":"trace[1194837056] linearizableReadLoop","detail":"{readStateIndex:1409; appliedIndex:1408; }","duration":"208.376499ms","start":"2026-04-14T05:43:21.305749Z","end":"2026-04-14T05:43:21.514126Z","steps":["trace[1194837056] 'read index received' (duration: 208.183024ms)","trace[1194837056] 'applied index is now lower than readState.Index' (duration: 192.725µs)"],"step_count":2} {"level":"warn","ts":"2026-04-14T05:43:21.514633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.858408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-14T05:43:21.514765Z","caller":"traceutil/trace.go:171","msg":"trace[1210157685] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1352; }","duration":"209.039635ms","start":"2026-04-14T05:43:21.305712Z","end":"2026-04-14T05:43:21.514752Z","steps":["trace[1210157685] 'agreement among raft nodes before linearized reading' (duration: 208.728322ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:43:21.514621Z","caller":"traceutil/trace.go:171","msg":"trace[658535726] transaction","detail":"{read_only:false; response_revision:1352; number_of_response:1; }","duration":"349.490681ms","start":"2026-04-14T05:43:21.165099Z","end":"2026-04-14T05:43:21.51459Z","steps":["trace[658535726] 'process raft request' (duration: 348.906595ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:43:21.515549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:43:21.165078Z","time spent":"350.404309ms","remote":"127.0.0.1:40804","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"}