{"level":"warn","ts":"2026-06-05T04:18:18.757985Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-05T04:18:18.75807Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.72: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.72:2380","--initial-cluster=instance=https://199.204.45.72:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.72:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.72: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-06-05T04:18:18.758127Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-05T04:18:18.758137Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.72:2380"]} {"level":"info","ts":"2026-06-05T04:18:18.758153Z","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-06-05T04:18:18.75879Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"]} {"level":"info","ts":"2026-06-05T04:18:18.758864Z","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.72:2380"],"listen-peer-urls":["https://199.204.45.72:2380"],"advertise-client-urls":["https://199.204.45.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.72: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-06-05T04:18:18.813169Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"54.096227ms"} {"level":"info","ts":"2026-06-05T04:18:18.867079Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"50e03cebfd94cbba","cluster-id":"120c03c1d5b80f94"} {"level":"info","ts":"2026-06-05T04:18:18.86725Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=()"} {"level":"info","ts":"2026-06-05T04:18:18.867299Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became follower at term 0"} {"level":"info","ts":"2026-06-05T04:18:18.867327Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 50e03cebfd94cbba [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-05T04:18:18.867343Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became follower at term 1"} {"level":"info","ts":"2026-06-05T04:18:18.867419Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=(5827724902086790074)"} {"level":"warn","ts":"2026-06-05T04:18:18.900593Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-05T04:18:18.906403Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-05T04:18:18.908071Z","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-06-05T04:18:18.914302Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"50e03cebfd94cbba","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-05T04:18:18.914691Z","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-06-05T04:18:18.914788Z","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-06-05T04:18:18.914808Z","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-06-05T04:18:18.914958Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"50e03cebfd94cbba","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-05T04:18:18.916555Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=(5827724902086790074)"} {"level":"info","ts":"2026-06-05T04:18:18.917154Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"120c03c1d5b80f94","local-member-id":"50e03cebfd94cbba","added-peer-id":"50e03cebfd94cbba","added-peer-peer-urls":["https://199.204.45.72:2380"]} {"level":"info","ts":"2026-06-05T04:18:18.918437Z","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-06-05T04:18:18.918538Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.72:2380"} {"level":"info","ts":"2026-06-05T04:18:18.918586Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.72:2380"} {"level":"info","ts":"2026-06-05T04:18:18.918665Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"50e03cebfd94cbba","initial-advertise-peer-urls":["https://199.204.45.72:2380"],"listen-peer-urls":["https://199.204.45.72:2380"],"advertise-client-urls":["https://199.204.45.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-05T04:18:18.918721Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-05T04:18:19.868076Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba is starting a new election at term 1"} {"level":"info","ts":"2026-06-05T04:18:19.868174Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became pre-candidate at term 1"} {"level":"info","ts":"2026-06-05T04:18:19.868199Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba received MsgPreVoteResp from 50e03cebfd94cbba at term 1"} {"level":"info","ts":"2026-06-05T04:18:19.868229Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became candidate at term 2"} {"level":"info","ts":"2026-06-05T04:18:19.868243Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba received MsgVoteResp from 50e03cebfd94cbba at term 2"} {"level":"info","ts":"2026-06-05T04:18:19.86826Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became leader at term 2"} {"level":"info","ts":"2026-06-05T04:18:19.868274Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 50e03cebfd94cbba elected leader 50e03cebfd94cbba at term 2"} {"level":"info","ts":"2026-06-05T04:18:19.968354Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-05T04:18:19.997091Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-05T04:18:19.997104Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"50e03cebfd94cbba","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.72:2379]}","request-path":"/0/members/50e03cebfd94cbba/attributes","cluster-id":"120c03c1d5b80f94","publish-timeout":"7s"} {"level":"info","ts":"2026-06-05T04:18:19.997172Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-05T04:18:19.997598Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-05T04:18:19.997666Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-05T04:18:20.000882Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.72:2379"} {"level":"info","ts":"2026-06-05T04:18:20.00137Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-05T04:18:20.032636Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"120c03c1d5b80f94","local-member-id":"50e03cebfd94cbba","cluster-version":"3.5"} {"level":"info","ts":"2026-06-05T04:18:20.032799Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-05T04:18:20.03283Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-05T04:18:21.537276Z","caller":"traceutil/trace.go:171","msg":"trace[337191117] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"209.537914ms","start":"2026-06-05T04:18:21.327709Z","end":"2026-06-05T04:18:21.537247Z","steps":["trace[337191117] 'process raft request' (duration: 209.318493ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:18:21.707181Z","caller":"traceutil/trace.go:171","msg":"trace[564066904] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"379.349225ms","start":"2026-06-05T04:18:21.327802Z","end":"2026-06-05T04:18:21.707151Z","steps":["trace[564066904] 'process raft request' (duration: 367.223031ms)","trace[564066904] 'compare' (duration: 11.952653ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:18:21.707448Z","caller":"traceutil/trace.go:171","msg":"trace[581623602] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"307.05201ms","start":"2026-06-05T04:18:21.400328Z","end":"2026-06-05T04:18:21.70738Z","steps":["trace[581623602] 'process raft request' (duration: 306.842389ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:18:21.70753Z","caller":"traceutil/trace.go:171","msg":"trace[1797830476] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:4; }","duration":"374.883314ms","start":"2026-06-05T04:18:21.332624Z","end":"2026-06-05T04:18:21.707507Z","steps":["trace[1797830476] 'read index received' (duration: 204.516839ms)","trace[1797830476] 'applied index is now lower than readState.Index' (duration: 170.365635ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:18:21.707636Z","caller":"traceutil/trace.go:171","msg":"trace[281670710] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"307.234552ms","start":"2026-06-05T04:18:21.400391Z","end":"2026-06-05T04:18:21.707626Z","steps":["trace[281670710] 'process raft request' (duration: 306.88947ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:18:21.707716Z","caller":"traceutil/trace.go:171","msg":"trace[57858495] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"306.885299ms","start":"2026-06-05T04:18:21.400821Z","end":"2026-06-05T04:18:21.707707Z","steps":["trace[57858495] 'process raft request' (duration: 306.485437ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:18:21.70793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:21.327791Z","time spent":"379.491706ms","remote":"127.0.0.1:47280","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T04:18:21.707976Z","caller":"traceutil/trace.go:171","msg":"trace[476162202] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"307.428513ms","start":"2026-06-05T04:18:21.400504Z","end":"2026-06-05T04:18:21.707932Z","steps":["trace[476162202] 'process raft request' (duration: 306.709098ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:18:21.708091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:21.400457Z","time spent":"307.581855ms","remote":"127.0.0.1:47676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-05T04:18:21.708287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:21.400314Z","time spent":"307.246902ms","remote":"127.0.0.1:47588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-05T04:18:21.708386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:21.400327Z","time spent":"307.336582ms","remote":"127.0.0.1:47676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-05T04:18:21.708666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.610392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-05T04:18:21.708756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.775875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-05T04:18:21.708643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.274756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-05T04:18:21.708802Z","caller":"traceutil/trace.go:171","msg":"trace[419125358] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:9; }","duration":"307.840535ms","start":"2026-06-05T04:18:21.400949Z","end":"2026-06-05T04:18:21.70879Z","steps":["trace[419125358] 'agreement among raft nodes before linearized reading' (duration: 307.776265ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:18:21.708829Z","caller":"traceutil/trace.go:171","msg":"trace[21897091] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:9; }","duration":"258.505377ms","start":"2026-06-05T04:18:21.450298Z","end":"2026-06-05T04:18:21.708803Z","steps":["trace[21897091] 'agreement among raft nodes before linearized reading' (duration: 258.176715ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:18:21.708842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:21.400939Z","time spent":"307.894487ms","remote":"127.0.0.1:47300","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":26,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"info","ts":"2026-06-05T04:18:21.708818Z","caller":"traceutil/trace.go:171","msg":"trace[1155785706] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:9; }","duration":"231.768614ms","start":"2026-06-05T04:18:21.477004Z","end":"2026-06-05T04:18:21.708773Z","steps":["trace[1155785706] 'agreement among raft nodes before linearized reading' (duration: 231.618053ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:18:21.708699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.945867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.72\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-05T04:18:21.708707Z","caller":"traceutil/trace.go:171","msg":"trace[1330989249] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"307.342023ms","start":"2026-06-05T04:18:21.400585Z","end":"2026-06-05T04:18:21.707928Z","steps":["trace[1330989249] 'process raft request' (duration: 306.664838ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:18:21.709033Z","caller":"traceutil/trace.go:171","msg":"trace[1261073026] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"307.978427ms","start":"2026-06-05T04:18:21.401044Z","end":"2026-06-05T04:18:21.709023Z","steps":["trace[1261073026] 'process raft request' (duration: 306.428977ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:18:21.707811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:21.400794Z","time spent":"306.94831ms","remote":"127.0.0.1:47676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-05T04:18:21.709038Z","caller":"traceutil/trace.go:171","msg":"trace[1408582837] range","detail":"{range_begin:/registry/masterleases/199.204.45.72; range_end:; response_count:0; response_revision:9; }","duration":"311.314899ms","start":"2026-06-05T04:18:21.397712Z","end":"2026-06-05T04:18:21.709027Z","steps":["trace[1408582837] 'agreement among raft nodes before linearized reading' (duration: 310.564044ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:18:21.709548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:21.400577Z","time spent":"308.596801ms","remote":"127.0.0.1:47676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-05T04:18:21.708962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.747988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-05T04:18:21.709857Z","caller":"traceutil/trace.go:171","msg":"trace[1794210819] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:9; }","duration":"310.659225ms","start":"2026-06-05T04:18:21.399179Z","end":"2026-06-05T04:18:21.709839Z","steps":["trace[1794210819] 'agreement among raft nodes before linearized reading' (duration: 309.708288ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:18:21.709888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:21.399169Z","time spent":"310.707995ms","remote":"127.0.0.1:47322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-06-05T04:18:21.709424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:21.397697Z","time spent":"311.712092ms","remote":"127.0.0.1:47240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":26,"request content":"key:\"/registry/masterleases/199.204.45.72\" "} {"level":"warn","ts":"2026-06-05T04:18:21.709811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.17544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-05T04:18:21.710109Z","caller":"traceutil/trace.go:171","msg":"trace[86981064] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:9; }","duration":"377.484082ms","start":"2026-06-05T04:18:21.33261Z","end":"2026-06-05T04:18:21.710094Z","steps":["trace[86981064] 'agreement among raft nodes before linearized reading' (duration: 375.631649ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:18:21.710295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:21.332604Z","time spent":"377.677393ms","remote":"127.0.0.1:47532","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":26,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-06-05T04:18:21.710647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:21.401036Z","time spent":"308.073457ms","remote":"127.0.0.1:47676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-05T04:18:22.106815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.197334ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-06-05T04:18:22.1072Z","caller":"traceutil/trace.go:171","msg":"trace[1678872588] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"393.454387ms","start":"2026-06-05T04:18:21.713708Z","end":"2026-06-05T04:18:22.107162Z","steps":["trace[1678872588] 'process raft request' (duration: 393.219094ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:18:22.10723Z","caller":"traceutil/trace.go:171","msg":"trace[1711904019] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"393.581767ms","start":"2026-06-05T04:18:21.713605Z","end":"2026-06-05T04:18:22.107187Z","steps":["trace[1711904019] 'process raft request' (duration: 116.805188ms)","trace[1711904019] 'compare' (duration: 276.050323ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:18:22.107311Z","caller":"traceutil/trace.go:171","msg":"trace[1094170077] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"388.412271ms","start":"2026-06-05T04:18:21.718881Z","end":"2026-06-05T04:18:22.107293Z","steps":["trace[1094170077] 'process raft request' (duration: 388.374261ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:18:22.10735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:21.713593Z","time spent":"393.695268ms","remote":"127.0.0.1:47676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-05T04:18:22.107357Z","caller":"traceutil/trace.go:171","msg":"trace[359825268] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"392.542431ms","start":"2026-06-05T04:18:21.71479Z","end":"2026-06-05T04:18:22.107333Z","steps":["trace[359825268] 'process raft request' (duration: 392.293899ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:18:22.10746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:21.718866Z","time spent":"388.520252ms","remote":"127.0.0.1:47320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":357,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-05T04:18:22.107475Z","caller":"traceutil/trace.go:171","msg":"trace[268825534] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"392.62367ms","start":"2026-06-05T04:18:21.71484Z","end":"2026-06-05T04:18:22.107464Z","steps":["trace[268825534] 'process raft request' (duration: 392.323439ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:18:22.1076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:21.714779Z","time spent":"392.708962ms","remote":"127.0.0.1:47676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":923,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-05T04:18:22.107653Z","caller":"traceutil/trace.go:171","msg":"trace[1175143085] linearizableReadLoop","detail":"{readStateIndex:20; appliedIndex:13; }","duration":"390.746397ms","start":"2026-06-05T04:18:21.716845Z","end":"2026-06-05T04:18:22.107591Z","steps":["trace[1175143085] 'read index received' (duration: 113.581506ms)","trace[1175143085] 'applied index is now lower than readState.Index' (duration: 277.154961ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:18:22.107757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:21.713681Z","time spent":"393.602057ms","remote":"127.0.0.1:47676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-05T04:18:22.107619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:21.714827Z","time spent":"392.706751ms","remote":"127.0.0.1:47676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-05T04:18:22.107948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.085084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-05T04:18:22.107944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.16294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-05T04:18:22.107999Z","caller":"traceutil/trace.go:171","msg":"trace[1084486055] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:17; }","duration":"394.273342ms","start":"2026-06-05T04:18:21.713715Z","end":"2026-06-05T04:18:22.107988Z","steps":["trace[1084486055] 'agreement among raft nodes before linearized reading' (duration: 394.095751ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:18:22.108003Z","caller":"traceutil/trace.go:171","msg":"trace[1873918231] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:17; }","duration":"333.173154ms","start":"2026-06-05T04:18:21.77482Z","end":"2026-06-05T04:18:22.107993Z","steps":["trace[1873918231] 'agreement among raft nodes before linearized reading' (duration: 333.082063ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:18:22.108006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.11339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-05T04:18:22.108039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:21.774807Z","time spent":"333.224724ms","remote":"127.0.0.1:47532","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":26,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-06-05T04:18:22.108039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:21.713689Z","time spent":"394.343372ms","remote":"127.0.0.1:47208","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-05T04:18:22.108067Z","caller":"traceutil/trace.go:171","msg":"trace[1504899027] range","detail":"{range_begin:/registry/resourcequotas/kube-public/; range_end:/registry/resourcequotas/kube-public0; response_count:0; response_revision:17; }","duration":"388.21101ms","start":"2026-06-05T04:18:21.719837Z","end":"2026-06-05T04:18:22.108048Z","steps":["trace[1504899027] 'agreement among raft nodes before linearized reading' (duration: 388.061259ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:18:22.107775Z","caller":"traceutil/trace.go:171","msg":"trace[421236028] transaction","detail":"{read_only:false; number_of_response:0; response_revision:13; }","duration":"393.286975ms","start":"2026-06-05T04:18:21.714476Z","end":"2026-06-05T04:18:22.107763Z","steps":["trace[421236028] 'process raft request' (duration: 392.53423ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:18:22.108117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:21.719794Z","time spent":"388.312661ms","remote":"127.0.0.1:47300","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":26,"request content":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" "} {"level":"warn","ts":"2026-06-05T04:18:22.108205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:21.714466Z","time spent":"393.679638ms","remote":"127.0.0.1:47322","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":26,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-05T04:18:22.107817Z","caller":"traceutil/trace.go:171","msg":"trace[676382350] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"393.538337ms","start":"2026-06-05T04:18:21.714267Z","end":"2026-06-05T04:18:22.107805Z","steps":["trace[676382350] 'process raft request' (duration: 392.70263ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:18:22.107396Z","caller":"traceutil/trace.go:171","msg":"trace[1741965275] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"392.268068ms","start":"2026-06-05T04:18:21.715097Z","end":"2026-06-05T04:18:22.107365Z","steps":["trace[1741965275] 'process raft request' (duration: 392.093537ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:18:22.108539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:21.715084Z","time spent":"393.405665ms","remote":"127.0.0.1:47676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-05T04:18:22.108056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.18369ms","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-06-05T04:18:22.108701Z","caller":"traceutil/trace.go:171","msg":"trace[1794911709] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:17; }","duration":"192.823395ms","start":"2026-06-05T04:18:21.915777Z","end":"2026-06-05T04:18:22.108601Z","steps":["trace[1794911709] 'agreement among raft nodes before linearized reading' (duration: 192.10094ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:18:22.108724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:21.714252Z","time spent":"394.14318ms","remote":"127.0.0.1:47588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-05T04:18:22.498414Z","caller":"traceutil/trace.go:171","msg":"trace[1992706330] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"385.415638ms","start":"2026-06-05T04:18:22.112951Z","end":"2026-06-05T04:18:22.498366Z","steps":["trace[1992706330] 'process raft request' (duration: 352.284943ms)","trace[1992706330] 'compare' (duration: 32.875694ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:18:22.498472Z","caller":"traceutil/trace.go:171","msg":"trace[814581442] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"385.230458ms","start":"2026-06-05T04:18:22.113191Z","end":"2026-06-05T04:18:22.498421Z","steps":["trace[814581442] 'process raft request' (duration: 385.088897ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:18:22.498577Z","caller":"traceutil/trace.go:171","msg":"trace[124364515] linearizableReadLoop","detail":"{readStateIndex:29; appliedIndex:21; }","duration":"384.01861ms","start":"2026-06-05T04:18:22.114533Z","end":"2026-06-05T04:18:22.498551Z","steps":["trace[124364515] 'read index received' (duration: 58.642018ms)","trace[124364515] 'applied index is now lower than readState.Index' (duration: 325.375562ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:18:22.498716Z","caller":"traceutil/trace.go:171","msg":"trace[1161056302] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"385.300078ms","start":"2026-06-05T04:18:22.113405Z","end":"2026-06-05T04:18:22.498705Z","steps":["trace[1161056302] 'process raft request' (duration: 384.966985ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:18:22.498742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:22.113155Z","time spent":"385.442639ms","remote":"127.0.0.1:47676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1007,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-05T04:18:22.498788Z","caller":"traceutil/trace.go:171","msg":"trace[1678038569] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"385.396639ms","start":"2026-06-05T04:18:22.11336Z","end":"2026-06-05T04:18:22.498757Z","steps":["trace[1678038569] 'process raft request' (duration: 384.951046ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:18:22.498808Z","caller":"traceutil/trace.go:171","msg":"trace[1657040717] transaction","detail":"{read_only:false; response_revision:25; number_of_response:1; }","duration":"384.614283ms","start":"2026-06-05T04:18:22.114148Z","end":"2026-06-05T04:18:22.498762Z","steps":["trace[1657040717] 'process raft request' (duration: 384.336921ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:18:22.498845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:22.113389Z","time spent":"385.361908ms","remote":"127.0.0.1:47588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":716,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-05T04:18:22.498922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:22.11335Z","time spent":"385.50527ms","remote":"127.0.0.1:47676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1007,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-05T04:18:22.498959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:22.11413Z","time spent":"384.751395ms","remote":"127.0.0.1:47676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":947,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-05T04:18:22.498962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:22.112925Z","time spent":"385.613089ms","remote":"127.0.0.1:47676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":956,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-05T04:18:22.499105Z","caller":"traceutil/trace.go:171","msg":"trace[1153084960] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"385.353518ms","start":"2026-06-05T04:18:22.11374Z","end":"2026-06-05T04:18:22.499094Z","steps":["trace[1153084960] 'process raft request' (duration: 384.710854ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:18:22.499141Z","caller":"traceutil/trace.go:171","msg":"trace[1334100746] transaction","detail":"{read_only:false; response_revision:23; number_of_response:1; }","duration":"385.65835ms","start":"2026-06-05T04:18:22.113462Z","end":"2026-06-05T04:18:22.499127Z","steps":["trace[1334100746] 'process raft request' (duration: 384.955976ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:18:22.49915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:22.113732Z","time spent":"385.398668ms","remote":"127.0.0.1:47426","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-05T04:18:22.499111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.700686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-node-lease/\" range_end:\"/registry/resourcequotas/kube-node-lease0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-05T04:18:22.499177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.639003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-05T04:18:22.499225Z","caller":"traceutil/trace.go:171","msg":"trace[1883547566] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:0; response_revision:25; }","duration":"384.704404ms","start":"2026-06-05T04:18:22.114509Z","end":"2026-06-05T04:18:22.499214Z","steps":["trace[1883547566] 'agreement among raft nodes before linearized reading' (duration: 384.616243ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:18:22.499226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:22.113427Z","time spent":"385.757511ms","remote":"127.0.0.1:47676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-05T04:18:22.499266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:22.114503Z","time spent":"384.756325ms","remote":"127.0.0.1:47320","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":0,"response size":26,"request content":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" "} {"level":"warn","ts":"2026-06-05T04:18:22.4991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.355646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-05T04:18:22.499316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.650153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-05T04:18:22.499432Z","caller":"traceutil/trace.go:171","msg":"trace[369904320] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:25; }","duration":"131.853347ms","start":"2026-06-05T04:18:22.367563Z","end":"2026-06-05T04:18:22.499416Z","steps":["trace[369904320] 'agreement among raft nodes before linearized reading' (duration: 131.636805ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:18:22.499357Z","caller":"traceutil/trace.go:171","msg":"trace[1507927895] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25; }","duration":"186.628079ms","start":"2026-06-05T04:18:22.312707Z","end":"2026-06-05T04:18:22.499335Z","steps":["trace[1507927895] 'agreement among raft nodes before linearized reading' (duration: 186.203945ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:18:22.499266Z","caller":"traceutil/trace.go:171","msg":"trace[1334140362] range","detail":"{range_begin:/registry/resourcequotas/kube-node-lease/; range_end:/registry/resourcequotas/kube-node-lease0; response_count:0; response_revision:25; }","duration":"321.888427ms","start":"2026-06-05T04:18:22.177321Z","end":"2026-06-05T04:18:22.49921Z","steps":["trace[1334140362] 'agreement among raft nodes before linearized reading' (duration: 321.535575ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:18:22.499707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:22.177311Z","time spent":"322.378051ms","remote":"127.0.0.1:47300","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":26,"request content":"key:\"/registry/resourcequotas/kube-node-lease/\" range_end:\"/registry/resourcequotas/kube-node-lease0\" "} {"level":"warn","ts":"2026-06-05T04:18:22.500131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.133627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-05T04:18:22.499445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.089557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-05T04:18:22.500333Z","caller":"traceutil/trace.go:171","msg":"trace[1003193126] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:25; }","duration":"202.012103ms","start":"2026-06-05T04:18:22.298305Z","end":"2026-06-05T04:18:22.500317Z","steps":["trace[1003193126] 'agreement among raft nodes before linearized reading' (duration: 201.023667ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:18:22.500307Z","caller":"traceutil/trace.go:171","msg":"trace[1419820677] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:25; }","duration":"201.930083ms","start":"2026-06-05T04:18:22.298361Z","end":"2026-06-05T04:18:22.500291Z","steps":["trace[1419820677] 'agreement among raft nodes before linearized reading' (duration: 201.120138ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:18:22.813718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.553495ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-06-05T04:18:22.813963Z","caller":"traceutil/trace.go:171","msg":"trace[1903125354] transaction","detail":"{read_only:false; response_revision:27; number_of_response:1; }","duration":"308.788558ms","start":"2026-06-05T04:18:22.505111Z","end":"2026-06-05T04:18:22.813899Z","steps":["trace[1903125354] 'process raft request' (duration: 114.966391ms)","trace[1903125354] 'compare' (duration: 193.410874ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:18:22.814242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:22.50509Z","time spent":"309.06645ms","remote":"127.0.0.1:47676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-05T04:18:22.81458Z","caller":"traceutil/trace.go:171","msg":"trace[1367340371] transaction","detail":"{read_only:false; response_revision:29; number_of_response:1; }","duration":"309.256601ms","start":"2026-06-05T04:18:22.505293Z","end":"2026-06-05T04:18:22.81455Z","steps":["trace[1367340371] 'process raft request' (duration: 308.712988ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:18:22.814723Z","caller":"traceutil/trace.go:171","msg":"trace[2113924020] transaction","detail":"{read_only:false; response_revision:30; number_of_response:1; }","duration":"309.400402ms","start":"2026-06-05T04:18:22.505312Z","end":"2026-06-05T04:18:22.814713Z","steps":["trace[2113924020] 'process raft request' (duration: 308.787378ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:18:22.814743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:22.505287Z","time spent":"309.407402ms","remote":"127.0.0.1:47676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":959,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-05T04:18:22.814786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:22.505301Z","time spent":"309.456003ms","remote":"127.0.0.1:47320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3004,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-05T04:18:22.81501Z","caller":"traceutil/trace.go:171","msg":"trace[828755566] transaction","detail":"{read_only:false; response_revision:28; number_of_response:1; }","duration":"309.755265ms","start":"2026-06-05T04:18:22.505217Z","end":"2026-06-05T04:18:22.814972Z","steps":["trace[828755566] 'process raft request' (duration: 308.619928ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:18:22.814629Z","caller":"traceutil/trace.go:171","msg":"trace[776437530] transaction","detail":"{read_only:false; response_revision:35; number_of_response:1; }","duration":"293.241594ms","start":"2026-06-05T04:18:22.521371Z","end":"2026-06-05T04:18:22.814613Z","steps":["trace[776437530] 'process raft request' (duration: 293.183143ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:18:22.815214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:22.5052Z","time spent":"309.919086ms","remote":"127.0.0.1:47676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":926,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-05T04:18:22.814604Z","caller":"traceutil/trace.go:171","msg":"trace[51804030] transaction","detail":"{read_only:false; response_revision:32; number_of_response:1; }","duration":"308.989189ms","start":"2026-06-05T04:18:22.505603Z","end":"2026-06-05T04:18:22.814592Z","steps":["trace[51804030] 'process raft request' (duration: 308.641887ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:18:22.815422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:22.505581Z","time spent":"309.793645ms","remote":"127.0.0.1:47676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":983,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-05T04:18:22.815589Z","caller":"traceutil/trace.go:171","msg":"trace[50269962] transaction","detail":"{read_only:false; response_revision:34; number_of_response:1; }","duration":"308.853839ms","start":"2026-06-05T04:18:22.506711Z","end":"2026-06-05T04:18:22.815565Z","steps":["trace[50269962] 'process raft request' (duration: 307.741062ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:18:22.815734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:22.506694Z","time spent":"308.970939ms","remote":"127.0.0.1:47506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":429,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-05T04:18:22.815918Z","caller":"traceutil/trace.go:171","msg":"trace[1564022549] transaction","detail":"{read_only:false; response_revision:31; number_of_response:1; }","duration":"309.917216ms","start":"2026-06-05T04:18:22.505479Z","end":"2026-06-05T04:18:22.815397Z","steps":["trace[1564022549] 'process raft request' (duration: 308.673538ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:18:22.815954Z","caller":"traceutil/trace.go:171","msg":"trace[957601174] transaction","detail":"{read_only:false; response_revision:33; number_of_response:1; }","duration":"309.419223ms","start":"2026-06-05T04:18:22.506523Z","end":"2026-06-05T04:18:22.815943Z","steps":["trace[957601174] 'process raft request' (duration: 307.832162ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:18:22.816008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:22.5065Z","time spent":"309.479443ms","remote":"127.0.0.1:47676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":959,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-05T04:18:22.816433Z","caller":"traceutil/trace.go:171","msg":"trace[1918687017] linearizableReadLoop","detail":"{readStateIndex:34; appliedIndex:29; }","duration":"311.010764ms","start":"2026-06-05T04:18:22.505357Z","end":"2026-06-05T04:18:22.816368Z","steps":["trace[1918687017] 'read index received' (duration: 12.793987ms)","trace[1918687017] 'applied index is now lower than readState.Index' (duration: 298.213817ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:18:22.815996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:22.505466Z","time spent":"310.50046ms","remote":"127.0.0.1:47322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":350,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-05T04:18:22.817346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.344369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-admin\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-05T04:18:22.817594Z","caller":"traceutil/trace.go:171","msg":"trace[1731876144] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-admin; range_end:; response_count:0; response_revision:35; }","duration":"310.616791ms","start":"2026-06-05T04:18:22.506963Z","end":"2026-06-05T04:18:22.81758Z","steps":["trace[1731876144] 'agreement among raft nodes before linearized reading' (duration: 309.656305ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:18:22.818077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:22.506951Z","time spent":"311.110764ms","remote":"127.0.0.1:47496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":26,"request content":"key:\"/registry/clusterroles/system:aggregate-to-admin\" "} {"level":"warn","ts":"2026-06-05T04:18:22.816604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.229265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-05T04:18:22.820541Z","caller":"traceutil/trace.go:171","msg":"trace[2095957634] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:0; response_revision:35; }","duration":"314.286756ms","start":"2026-06-05T04:18:22.505336Z","end":"2026-06-05T04:18:22.819622Z","steps":["trace[2095957634] 'agreement among raft nodes before linearized reading' (duration: 311.150695ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:18:22.820725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:22.505326Z","time spent":"315.350503ms","remote":"127.0.0.1:47364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":0,"response size":26,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-06-05T04:18:23.0546Z","caller":"traceutil/trace.go:171","msg":"trace[1955809165] linearizableReadLoop","detail":"{readStateIndex:41; appliedIndex:40; }","duration":"166.677781ms","start":"2026-06-05T04:18:22.887883Z","end":"2026-06-05T04:18:23.054561Z","steps":["trace[1955809165] 'read index received' (duration: 72.107011ms)","trace[1955809165] 'applied index is now lower than readState.Index' (duration: 94.56981ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:18:23.054702Z","caller":"traceutil/trace.go:171","msg":"trace[1415451656] transaction","detail":"{read_only:false; response_revision:37; number_of_response:1; }","duration":"232.533998ms","start":"2026-06-05T04:18:22.82209Z","end":"2026-06-05T04:18:23.054623Z","steps":["trace[1415451656] 'process raft request' (duration: 137.934607ms)","trace[1415451656] 'compare' (duration: 94.359019ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:18:23.054951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.939321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/default/\" range_end:\"/registry/resourcequotas/default0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-05T04:18:23.054778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.210393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/admin\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-05T04:18:23.055095Z","caller":"traceutil/trace.go:171","msg":"trace[1157866355] range","detail":"{range_begin:/registry/resourcequotas/default/; range_end:/registry/resourcequotas/default0; response_count:0; response_revision:37; }","duration":"233.068701ms","start":"2026-06-05T04:18:22.821957Z","end":"2026-06-05T04:18:23.055026Z","steps":["trace[1157866355] 'agreement among raft nodes before linearized reading' (duration: 232.88071ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:18:23.055199Z","caller":"traceutil/trace.go:171","msg":"trace[1301813491] range","detail":"{range_begin:/registry/clusterroles/admin; range_end:; response_count:0; response_revision:37; }","duration":"233.637445ms","start":"2026-06-05T04:18:22.82149Z","end":"2026-06-05T04:18:23.055127Z","steps":["trace[1301813491] 'agreement among raft nodes before linearized reading' (duration: 233.183482ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:18:23.054821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.708747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-05T04:18:23.055427Z","caller":"traceutil/trace.go:171","msg":"trace[563839108] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:37; }","duration":"215.338862ms","start":"2026-06-05T04:18:22.840059Z","end":"2026-06-05T04:18:23.055398Z","steps":["trace[563839108] 'agreement among raft nodes before linearized reading' (duration: 214.742388ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:18:23.057424Z","caller":"traceutil/trace.go:171","msg":"trace[501482551] transaction","detail":"{read_only:false; response_revision:38; number_of_response:1; }","duration":"166.312399ms","start":"2026-06-05T04:18:22.891095Z","end":"2026-06-05T04:18:23.057407Z","steps":["trace[501482551] 'process raft request' (duration: 166.171918ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:18:23.44503Z","caller":"traceutil/trace.go:171","msg":"trace[1229044005] transaction","detail":"{read_only:false; response_revision:46; number_of_response:1; }","duration":"190.440167ms","start":"2026-06-05T04:18:23.254582Z","end":"2026-06-05T04:18:23.445022Z","steps":["trace[1229044005] 'process raft request' (duration: 179.11344ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:18:23.445012Z","caller":"traceutil/trace.go:171","msg":"trace[1713187545] transaction","detail":"{read_only:false; response_revision:48; number_of_response:1; }","duration":"150.79313ms","start":"2026-06-05T04:18:23.294193Z","end":"2026-06-05T04:18:23.444986Z","steps":["trace[1713187545] 'process raft request' (duration: 150.75071ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:18:23.445564Z","caller":"traceutil/trace.go:171","msg":"trace[17691304] transaction","detail":"{read_only:false; response_revision:47; number_of_response:1; }","duration":"189.363399ms","start":"2026-06-05T04:18:23.256113Z","end":"2026-06-05T04:18:23.445477Z","steps":["trace[17691304] 'process raft request' (duration: 188.761325ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:18:23.445674Z","caller":"traceutil/trace.go:171","msg":"trace[455196719] linearizableReadLoop","detail":"{readStateIndex:51; appliedIndex:48; }","duration":"163.568475ms","start":"2026-06-05T04:18:23.282062Z","end":"2026-06-05T04:18:23.44563Z","steps":["trace[455196719] 'read index received' (duration: 7.060957ms)","trace[455196719] 'applied index is now lower than readState.Index' (duration: 156.505428ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:18:23.445791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.718556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-05T04:18:23.445825Z","caller":"traceutil/trace.go:171","msg":"trace[165342253] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:48; }","duration":"163.812067ms","start":"2026-06-05T04:18:23.282Z","end":"2026-06-05T04:18:23.445812Z","steps":["trace[165342253] 'agreement among raft nodes before linearized reading' (duration: 163.739287ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:18:23.445988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.931581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-05T04:18:23.446038Z","caller":"traceutil/trace.go:171","msg":"trace[986159981] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:48; }","duration":"129.006442ms","start":"2026-06-05T04:18:23.317013Z","end":"2026-06-05T04:18:23.446019Z","steps":["trace[986159981] 'agreement among raft nodes before linearized reading' (duration: 128.878721ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:18:24.609042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.306547ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-06-05T04:18:24.609149Z","caller":"traceutil/trace.go:171","msg":"trace[1840664795] linearizableReadLoop","detail":"{readStateIndex:101; appliedIndex:100; }","duration":"438.492247ms","start":"2026-06-05T04:18:24.17064Z","end":"2026-06-05T04:18:24.609133Z","steps":["trace[1840664795] 'read index received' (duration: 60.949219ms)","trace[1840664795] 'applied index is now lower than readState.Index' (duration: 377.541848ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:18:24.609298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.646829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-05T04:18:24.609335Z","caller":"traceutil/trace.go:171","msg":"trace[769928874] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:97; }","duration":"438.711779ms","start":"2026-06-05T04:18:24.170613Z","end":"2026-06-05T04:18:24.609325Z","steps":["trace[769928874] 'agreement among raft nodes before linearized reading' (duration: 438.610249ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:18:24.609371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:24.170601Z","time spent":"438.7632ms","remote":"127.0.0.1:47532","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":26,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"info","ts":"2026-06-05T04:18:24.609474Z","caller":"traceutil/trace.go:171","msg":"trace[1375697256] transaction","detail":"{read_only:false; response_revision:97; number_of_response:1; }","duration":"492.607891ms","start":"2026-06-05T04:18:24.116579Z","end":"2026-06-05T04:18:24.609187Z","steps":["trace[1375697256] 'process raft request' (duration: 115.079063ms)","trace[1375697256] 'compare' (duration: 377.158266ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:18:24.609722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:24.116564Z","time spent":"493.063584ms","remote":"127.0.0.1:47496","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":686,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-05T04:18:24.609954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.173378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-05T04:18:24.610258Z","caller":"traceutil/trace.go:171","msg":"trace[825584460] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:97; }","duration":"196.977213ms","start":"2026-06-05T04:18:24.413257Z","end":"2026-06-05T04:18:24.610234Z","steps":["trace[825584460] 'agreement among raft nodes before linearized reading' (duration: 196.108058ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:18:24.81001Z","caller":"traceutil/trace.go:171","msg":"trace[188328939] transaction","detail":"{read_only:false; response_revision:99; number_of_response:1; }","duration":"119.567563ms","start":"2026-06-05T04:18:24.690423Z","end":"2026-06-05T04:18:24.80999Z","steps":["trace[188328939] 'process raft request' (duration: 119.472853ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:18:25.054746Z","caller":"traceutil/trace.go:171","msg":"trace[1935373714] transaction","detail":"{read_only:false; response_revision:102; number_of_response:1; }","duration":"100.061951ms","start":"2026-06-05T04:18:24.954654Z","end":"2026-06-05T04:18:25.054716Z","steps":["trace[1935373714] 'process raft request' (duration: 52.639704ms)","trace[1935373714] 'compare' (duration: 47.269706ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:18:25.244676Z","caller":"traceutil/trace.go:171","msg":"trace[515728995] linearizableReadLoop","detail":"{readStateIndex:113; appliedIndex:112; }","duration":"102.467776ms","start":"2026-06-05T04:18:25.142184Z","end":"2026-06-05T04:18:25.244652Z","steps":["trace[515728995] 'read index received' (duration: 13.376169ms)","trace[515728995] 'applied index is now lower than readState.Index' (duration: 89.090767ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:18:25.244776Z","caller":"traceutil/trace.go:171","msg":"trace[1523068388] transaction","detail":"{read_only:false; response_revision:109; number_of_response:1; }","duration":"102.892928ms","start":"2026-06-05T04:18:25.141852Z","end":"2026-06-05T04:18:25.244744Z","steps":["trace[1523068388] 'process raft request' (duration: 13.682331ms)","trace[1523068388] 'compare' (duration: 89.009365ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:18:25.24515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.727591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:429"} {"level":"warn","ts":"2026-06-05T04:18:25.245247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.997969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-05T04:18:25.245468Z","caller":"traceutil/trace.go:171","msg":"trace[154025360] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:109; }","duration":"103.263201ms","start":"2026-06-05T04:18:25.142167Z","end":"2026-06-05T04:18:25.245431Z","steps":["trace[154025360] 'agreement among raft nodes before linearized reading' (duration: 102.628207ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:18:25.245215Z","caller":"traceutil/trace.go:171","msg":"trace[595114934] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:109; }","duration":"101.817222ms","start":"2026-06-05T04:18:25.14338Z","end":"2026-06-05T04:18:25.245198Z","steps":["trace[595114934] 'agreement among raft nodes before linearized reading' (duration: 101.44898ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:18:25.495429Z","caller":"traceutil/trace.go:171","msg":"trace[2003839662] transaction","detail":"{read_only:false; response_revision:111; number_of_response:1; }","duration":"244.762665ms","start":"2026-06-05T04:18:25.250631Z","end":"2026-06-05T04:18:25.495394Z","steps":["trace[2003839662] 'process raft request' (duration: 232.03455ms)","trace[2003839662] 'compare' (duration: 12.275663ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:18:25.495554Z","caller":"traceutil/trace.go:171","msg":"trace[477535887] transaction","detail":"{read_only:false; response_revision:112; number_of_response:1; }","duration":"244.729955ms","start":"2026-06-05T04:18:25.250806Z","end":"2026-06-05T04:18:25.495536Z","steps":["trace[477535887] 'process raft request' (duration: 244.445764ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:18:25.495585Z","caller":"traceutil/trace.go:171","msg":"trace[1807063813] transaction","detail":"{read_only:false; response_revision:113; number_of_response:1; }","duration":"243.483457ms","start":"2026-06-05T04:18:25.252075Z","end":"2026-06-05T04:18:25.495559Z","steps":["trace[1807063813] 'process raft request' (duration: 243.282046ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:18:25.678016Z","caller":"traceutil/trace.go:171","msg":"trace[1840940699] transaction","detail":"{read_only:false; response_revision:115; number_of_response:1; }","duration":"116.439298ms","start":"2026-06-05T04:18:25.561548Z","end":"2026-06-05T04:18:25.677988Z","steps":["trace[1840940699] 'process raft request' (duration: 45.204102ms)","trace[1840940699] 'compare' (duration: 71.076215ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:18:26.168088Z","caller":"traceutil/trace.go:171","msg":"trace[1971389563] transaction","detail":"{read_only:false; response_revision:125; number_of_response:1; }","duration":"125.229994ms","start":"2026-06-05T04:18:26.042811Z","end":"2026-06-05T04:18:26.168041Z","steps":["trace[1971389563] 'process raft request' (duration: 48.405443ms)","trace[1971389563] 'compare' (duration: 76.362668ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:18:26.335257Z","caller":"traceutil/trace.go:171","msg":"trace[1741945393] transaction","detail":"{read_only:false; response_revision:127; number_of_response:1; }","duration":"160.602478ms","start":"2026-06-05T04:18:26.174626Z","end":"2026-06-05T04:18:26.335229Z","steps":["trace[1741945393] 'process raft request' (duration: 160.468307ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:18:26.335416Z","caller":"traceutil/trace.go:171","msg":"trace[69531810] transaction","detail":"{read_only:false; response_revision:126; number_of_response:1; }","duration":"163.619999ms","start":"2026-06-05T04:18:26.171612Z","end":"2026-06-05T04:18:26.335232Z","steps":["trace[69531810] 'process raft request' (duration: 108.531722ms)","trace[69531810] 'compare' (duration: 54.743135ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:18:26.63416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.412135ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-05T04:18:26.634268Z","caller":"traceutil/trace.go:171","msg":"trace[1586484539] transaction","detail":"{read_only:false; response_revision:128; number_of_response:1; }","duration":"293.227951ms","start":"2026-06-05T04:18:26.341021Z","end":"2026-06-05T04:18:26.634249Z","steps":["trace[1586484539] 'process raft request' (duration: 173.644695ms)","trace[1586484539] 'compare' (duration: 119.263963ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:18:26.64373Z","caller":"traceutil/trace.go:171","msg":"trace[1098964047] linearizableReadLoop","detail":"{readStateIndex:133; appliedIndex:131; }","duration":"130.407828ms","start":"2026-06-05T04:18:26.51331Z","end":"2026-06-05T04:18:26.643717Z","steps":["trace[1098964047] 'read index received' (duration: 1.42029ms)","trace[1098964047] 'applied index is now lower than readState.Index' (duration: 128.986478ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:18:26.643881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.552008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:18:26.643906Z","caller":"traceutil/trace.go:171","msg":"trace[1207960308] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:129; }","duration":"130.65048ms","start":"2026-06-05T04:18:26.513246Z","end":"2026-06-05T04:18:26.643897Z","steps":["trace[1207960308] 'agreement among raft nodes before linearized reading' (duration: 130.558849ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:18:26.644126Z","caller":"traceutil/trace.go:171","msg":"trace[648576225] transaction","detail":"{read_only:false; response_revision:129; number_of_response:1; }","duration":"189.805963ms","start":"2026-06-05T04:18:26.454059Z","end":"2026-06-05T04:18:26.643865Z","steps":["trace[648576225] 'process raft request' (duration: 189.581471ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:18:26.839266Z","caller":"traceutil/trace.go:171","msg":"trace[963203349] transaction","detail":"{read_only:false; response_revision:132; number_of_response:1; }","duration":"148.140636ms","start":"2026-06-05T04:18:26.691098Z","end":"2026-06-05T04:18:26.839239Z","steps":["trace[963203349] 'process raft request' (duration: 83.704277ms)","trace[963203349] 'compare' (duration: 64.040606ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:18:27.497839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.19545ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-05T04:18:27.498001Z","caller":"traceutil/trace.go:171","msg":"trace[793376285] linearizableReadLoop","detail":"{readStateIndex:154; appliedIndex:153; }","duration":"274.192525ms","start":"2026-06-05T04:18:27.223784Z","end":"2026-06-05T04:18:27.497977Z","steps":["trace[793376285] 'read index received' (duration: 95.618653ms)","trace[793376285] 'applied index is now lower than readState.Index' (duration: 178.572162ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:18:27.498087Z","caller":"traceutil/trace.go:171","msg":"trace[411950154] transaction","detail":"{read_only:false; response_revision:149; number_of_response:1; }","duration":"275.812556ms","start":"2026-06-05T04:18:27.222228Z","end":"2026-06-05T04:18:27.498041Z","steps":["trace[411950154] 'process raft request' (duration: 97.274774ms)","trace[411950154] 'compare' (duration: 178.019149ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:18:27.498256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.986161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-05T04:18:27.498298Z","caller":"traceutil/trace.go:171","msg":"trace[530318672] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:149; }","duration":"180.079402ms","start":"2026-06-05T04:18:27.318204Z","end":"2026-06-05T04:18:27.498283Z","steps":["trace[530318672] 'agreement among raft nodes before linearized reading' (duration: 179.911481ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:18:27.498294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.478037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/cluster-admin\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:18:27.498397Z","caller":"traceutil/trace.go:171","msg":"trace[159156346] range","detail":"{range_begin:/registry/clusterrolebindings/cluster-admin; range_end:; response_count:0; response_revision:149; }","duration":"274.634517ms","start":"2026-06-05T04:18:27.223739Z","end":"2026-06-05T04:18:27.498373Z","steps":["trace[159156346] 'agreement among raft nodes before linearized reading' (duration: 274.365166ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:18:28.022477Z","caller":"traceutil/trace.go:171","msg":"trace[1712473775] transaction","detail":"{read_only:false; response_revision:170; number_of_response:1; }","duration":"141.853558ms","start":"2026-06-05T04:18:27.880596Z","end":"2026-06-05T04:18:28.02245Z","steps":["trace[1712473775] 'process raft request' (duration: 141.804228ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:18:28.022527Z","caller":"traceutil/trace.go:171","msg":"trace[1545679469] transaction","detail":"{read_only:false; response_revision:169; number_of_response:1; }","duration":"141.989649ms","start":"2026-06-05T04:18:27.880503Z","end":"2026-06-05T04:18:28.022493Z","steps":["trace[1545679469] 'process raft request' (duration: 50.565276ms)","trace[1545679469] 'compare' (duration: 91.214232ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:18:28.194446Z","caller":"traceutil/trace.go:171","msg":"trace[1686910446] transaction","detail":"{read_only:false; response_revision:175; number_of_response:1; }","duration":"112.942634ms","start":"2026-06-05T04:18:28.081468Z","end":"2026-06-05T04:18:28.19441Z","steps":["trace[1686910446] 'process raft request' (duration: 72.680129ms)","trace[1686910446] 'compare' (duration: 40.111983ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:18:28.400105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.396758ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-05T04:18:28.400268Z","caller":"traceutil/trace.go:171","msg":"trace[1996452366] transaction","detail":"{read_only:false; response_revision:176; number_of_response:1; }","duration":"202.839066ms","start":"2026-06-05T04:18:28.197377Z","end":"2026-06-05T04:18:28.400217Z","steps":["trace[1996452366] 'process raft request' (duration: 98.254137ms)","trace[1996452366] 'compare' (duration: 104.268397ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:18:28.40022Z","caller":"traceutil/trace.go:171","msg":"trace[1971143691] linearizableReadLoop","detail":"{readStateIndex:181; appliedIndex:180; }","duration":"202.035651ms","start":"2026-06-05T04:18:28.198163Z","end":"2026-06-05T04:18:28.400199Z","steps":["trace[1971143691] 'read index received' (duration: 97.420952ms)","trace[1971143691] 'applied index is now lower than readState.Index' (duration: 104.613409ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:18:28.400634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.418503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.18b6145cfdc207ef\" ","response":"range_response_count:1 size:651"} {"level":"info","ts":"2026-06-05T04:18:28.400755Z","caller":"traceutil/trace.go:171","msg":"trace[1201938492] range","detail":"{range_begin:/registry/events/default/instance.18b6145cfdc207ef; range_end:; response_count:1; response_revision:176; }","duration":"202.620764ms","start":"2026-06-05T04:18:28.198108Z","end":"2026-06-05T04:18:28.400729Z","steps":["trace[1201938492] 'agreement among raft nodes before linearized reading' (duration: 202.257392ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:18:30.303604Z","caller":"traceutil/trace.go:171","msg":"trace[230605237] transaction","detail":"{read_only:false; response_revision:261; number_of_response:1; }","duration":"214.002296ms","start":"2026-06-05T04:18:30.089576Z","end":"2026-06-05T04:18:30.303578Z","steps":["trace[230605237] 'process raft request' (duration: 213.844485ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:18:35.172792Z","caller":"traceutil/trace.go:171","msg":"trace[850563137] transaction","detail":"{read_only:false; response_revision:349; number_of_response:1; }","duration":"144.496973ms","start":"2026-06-05T04:18:35.028275Z","end":"2026-06-05T04:18:35.172772Z","steps":["trace[850563137] 'process raft request' (duration: 144.383163ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:18:36.228136Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680220302464153151,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-05T04:18:36.337393Z","caller":"traceutil/trace.go:171","msg":"trace[925715529] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"621.152791ms","start":"2026-06-05T04:18:35.716132Z","end":"2026-06-05T04:18:36.337285Z","steps":["trace[925715529] 'process raft request' (duration: 575.914293ms)","trace[925715529] 'compare' (duration: 44.815976ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:18:36.337554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:35.716106Z","time spent":"621.362562ms","remote":"127.0.0.1:47426","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T04:18:36.338769Z","caller":"traceutil/trace.go:171","msg":"trace[1563131668] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"622.074257ms","start":"2026-06-05T04:18:35.716677Z","end":"2026-06-05T04:18:36.338752Z","steps":["trace[1563131668] 'process raft request' (duration: 621.893486ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:18:36.338772Z","caller":"traceutil/trace.go:171","msg":"trace[704544678] linearizableReadLoop","detail":"{readStateIndex:370; appliedIndex:367; }","duration":"610.916136ms","start":"2026-06-05T04:18:35.727831Z","end":"2026-06-05T04:18:36.338747Z","steps":["trace[704544678] 'read index received' (duration: 564.219148ms)","trace[704544678] 'applied index is now lower than readState.Index' (duration: 46.695918ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:18:36.338817Z","caller":"traceutil/trace.go:171","msg":"trace[1947656586] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"621.429093ms","start":"2026-06-05T04:18:35.717362Z","end":"2026-06-05T04:18:36.338791Z","steps":["trace[1947656586] 'process raft request' (duration: 621.327233ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:18:36.338846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:35.716665Z","time spent":"622.147968ms","remote":"127.0.0.1:47320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1739,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-05T04:18:36.338929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:35.717339Z","time spent":"621.528664ms","remote":"127.0.0.1:47426","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T04:18:36.339119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4196"} {"level":"warn","ts":"2026-06-05T04:18:36.339091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"561.241948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-06-05T04:18:36.339162Z","caller":"traceutil/trace.go:171","msg":"trace[1953109526] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:356; }","duration":"155.53681ms","start":"2026-06-05T04:18:36.183611Z","end":"2026-06-05T04:18:36.339148Z","steps":["trace[1953109526] 'agreement among raft nodes before linearized reading' (duration: 155.46252ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:18:36.339126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.01169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"warn","ts":"2026-06-05T04:18:36.339128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"611.291558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"warn","ts":"2026-06-05T04:18:36.339319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.346153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"warn","ts":"2026-06-05T04:18:36.339329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.761085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"warn","ts":"2026-06-05T04:18:36.339379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.245982ms","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-06-05T04:18:36.339384Z","caller":"traceutil/trace.go:171","msg":"trace[1853295221] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:356; }","duration":"510.461034ms","start":"2026-06-05T04:18:35.828897Z","end":"2026-06-05T04:18:36.339358Z","steps":["trace[1853295221] 'agreement among raft nodes before linearized reading' (duration: 510.399073ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:18:36.339373Z","caller":"traceutil/trace.go:171","msg":"trace[109250144] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:356; }","duration":"460.861207ms","start":"2026-06-05T04:18:35.878502Z","end":"2026-06-05T04:18:36.339363Z","steps":["trace[109250144] 'agreement among raft nodes before linearized reading' (duration: 460.750356ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:18:36.339436Z","caller":"traceutil/trace.go:171","msg":"trace[885510130] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:356; }","duration":"355.359553ms","start":"2026-06-05T04:18:35.984059Z","end":"2026-06-05T04:18:36.339419Z","steps":["trace[885510130] 'agreement among raft nodes before linearized reading' (duration: 355.280663ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:18:36.339444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:35.828881Z","time spent":"510.551904ms","remote":"127.0.0.1:47372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":215,"request content":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" "} {"level":"warn","ts":"2026-06-05T04:18:36.339491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:35.984008Z","time spent":"355.471283ms","remote":"127.0.0.1:47426","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-06-05T04:18:36.339384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.922651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"warn","ts":"2026-06-05T04:18:36.339462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:35.878469Z","time spent":"460.981427ms","remote":"127.0.0.1:47372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":256,"request content":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" "} {"level":"info","ts":"2026-06-05T04:18:36.339529Z","caller":"traceutil/trace.go:171","msg":"trace[432467146] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:356; }","duration":"261.127233ms","start":"2026-06-05T04:18:36.078394Z","end":"2026-06-05T04:18:36.339522Z","steps":["trace[432467146] 'agreement among raft nodes before linearized reading' (duration: 260.958622ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:18:36.339408Z","caller":"traceutil/trace.go:171","msg":"trace[10817585] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:356; }","duration":"611.54422ms","start":"2026-06-05T04:18:35.727767Z","end":"2026-06-05T04:18:36.339311Z","steps":["trace[10817585] 'agreement among raft nodes before linearized reading' (duration: 611.163528ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:18:36.339173Z","caller":"traceutil/trace.go:171","msg":"trace[1726069981] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:356; }","duration":"561.379079ms","start":"2026-06-05T04:18:35.777778Z","end":"2026-06-05T04:18:36.339157Z","steps":["trace[1726069981] 'agreement among raft nodes before linearized reading' (duration: 561.195818ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:18:36.339698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:35.777759Z","time spent":"561.928303ms","remote":"127.0.0.1:47372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":219,"request content":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" "} {"level":"warn","ts":"2026-06-05T04:18:36.339307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.83485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"warn","ts":"2026-06-05T04:18:36.339803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:35.727739Z","time spent":"611.924072ms","remote":"127.0.0.1:47372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":231,"request content":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" "} {"level":"warn","ts":"2026-06-05T04:18:36.339529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.421686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-06-05T04:18:36.339994Z","caller":"traceutil/trace.go:171","msg":"trace[890625506] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:356; }","duration":"360.883728ms","start":"2026-06-05T04:18:35.979097Z","end":"2026-06-05T04:18:36.339981Z","steps":["trace[890625506] 'agreement among raft nodes before linearized reading' (duration: 360.397625ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:18:36.34004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:35.979022Z","time spent":"361.003609ms","remote":"127.0.0.1:47372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":225,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" "} {"level":"info","ts":"2026-06-05T04:18:36.339817Z","caller":"traceutil/trace.go:171","msg":"trace[1174762291] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:356; }","duration":"410.386044ms","start":"2026-06-05T04:18:35.929419Z","end":"2026-06-05T04:18:36.339805Z","steps":["trace[1174762291] 'agreement among raft nodes before linearized reading' (duration: 409.822881ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:18:36.340136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:35.929402Z","time spent":"410.727746ms","remote":"127.0.0.1:47372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":1,"response size":240,"request content":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" "} {"level":"info","ts":"2026-06-05T04:18:36.339276Z","caller":"traceutil/trace.go:171","msg":"trace[827371021] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:356; }","duration":"311.168301ms","start":"2026-06-05T04:18:36.02809Z","end":"2026-06-05T04:18:36.339258Z","steps":["trace[827371021] 'agreement among raft nodes before linearized reading' (duration: 310.905659ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:18:36.340205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:18:36.027971Z","time spent":"312.226978ms","remote":"127.0.0.1:47372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":229,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" "} {"level":"warn","ts":"2026-06-05T04:18:36.339265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.434976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:1 size:536"} {"level":"info","ts":"2026-06-05T04:18:36.340373Z","caller":"traceutil/trace.go:171","msg":"trace[1842190427] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:1; response_revision:356; }","duration":"157.535032ms","start":"2026-06-05T04:18:36.182772Z","end":"2026-06-05T04:18:36.340307Z","steps":["trace[1842190427] 'agreement among raft nodes before linearized reading' (duration: 156.462866ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:18:36.339178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.191713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-06-05T04:18:36.340569Z","caller":"traceutil/trace.go:171","msg":"trace[26914401] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:356; }","duration":"212.646123ms","start":"2026-06-05T04:18:36.127906Z","end":"2026-06-05T04:18:36.340553Z","steps":["trace[26914401] 'agreement among raft nodes before linearized reading' (duration: 211.179574ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:18:36.340409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.634258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-06-05T04:18:36.340985Z","caller":"traceutil/trace.go:171","msg":"trace[586435680] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:356; }","duration":"162.214662ms","start":"2026-06-05T04:18:36.178755Z","end":"2026-06-05T04:18:36.34097Z","steps":["trace[586435680] 'agreement among raft nodes before linearized reading' (duration: 160.29633ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:19:03.666221Z","caller":"traceutil/trace.go:171","msg":"trace[274361589] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"118.251488ms","start":"2026-06-05T04:19:03.547937Z","end":"2026-06-05T04:19:03.666188Z","steps":["trace[274361589] 'process raft request' (duration: 118.04773ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:19:03.72216Z","caller":"traceutil/trace.go:171","msg":"trace[1696244794] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"149.283779ms","start":"2026-06-05T04:19:03.572852Z","end":"2026-06-05T04:19:03.722136Z","steps":["trace[1696244794] 'process raft request' (duration: 148.188815ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:19:03.722919Z","caller":"traceutil/trace.go:171","msg":"trace[1451956285] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"108.179025ms","start":"2026-06-05T04:19:03.614716Z","end":"2026-06-05T04:19:03.722895Z","steps":["trace[1451956285] 'process raft request' (duration: 106.729017ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:19:03.723138Z","caller":"traceutil/trace.go:171","msg":"trace[884759637] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"150.203446ms","start":"2026-06-05T04:19:03.57292Z","end":"2026-06-05T04:19:03.723123Z","steps":["trace[884759637] 'process raft request' (duration: 148.232367ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:19:03.723296Z","caller":"traceutil/trace.go:171","msg":"trace[1423998721] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"150.270469ms","start":"2026-06-05T04:19:03.572985Z","end":"2026-06-05T04:19:03.723256Z","steps":["trace[1423998721] 'process raft request' (duration: 148.217086ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:19:03.7234Z","caller":"traceutil/trace.go:171","msg":"trace[1424290107] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"119.200225ms","start":"2026-06-05T04:19:03.60419Z","end":"2026-06-05T04:19:03.723391Z","steps":["trace[1424290107] 'process raft request' (duration: 117.055189ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:19:03.723377Z","caller":"traceutil/trace.go:171","msg":"trace[406693577] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"100.616873ms","start":"2026-06-05T04:19:03.62272Z","end":"2026-06-05T04:19:03.723337Z","steps":["trace[406693577] 'process raft request' (duration: 98.79247ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:19:03.723452Z","caller":"traceutil/trace.go:171","msg":"trace[2091254387] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"114.992968ms","start":"2026-06-05T04:19:03.608419Z","end":"2026-06-05T04:19:03.723412Z","steps":["trace[2091254387] 'process raft request' (duration: 112.875653ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:19:03.723493Z","caller":"traceutil/trace.go:171","msg":"trace[47961553] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"112.127664ms","start":"2026-06-05T04:19:03.611356Z","end":"2026-06-05T04:19:03.723483Z","steps":["trace[47961553] 'process raft request' (duration: 110.0416ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:19:04.744911Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680220302464153552,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-05T04:19:05.245973Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680220302464153552,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-05T04:19:05.287448Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.340879772s","expected-duration":"1s"} {"level":"info","ts":"2026-06-05T04:19:05.376771Z","caller":"traceutil/trace.go:171","msg":"trace[1630296116] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"1.44187618s","start":"2026-06-05T04:19:03.934867Z","end":"2026-06-05T04:19:05.376743Z","steps":["trace[1630296116] 'process raft request' (duration: 1.441779626s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:19:05.376947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:03.934841Z","time spent":"1.441999054s","remote":"127.0.0.1:47268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29546,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T04:19:05.376798Z","caller":"traceutil/trace.go:171","msg":"trace[67887853] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"1.453307458s","start":"2026-06-05T04:19:03.923459Z","end":"2026-06-05T04:19:05.376766Z","steps":["trace[67887853] 'process raft request' (duration: 1.364331831s)","trace[67887853] 'compare' (duration: 88.439676ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:19:05.377252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:03.923434Z","time spent":"1.453746955s","remote":"127.0.0.1:47676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":986,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-05T04:19:05.429488Z","caller":"traceutil/trace.go:171","msg":"trace[543136788] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"1.474601661s","start":"2026-06-05T04:19:03.954825Z","end":"2026-06-05T04:19:05.429426Z","steps":["trace[543136788] 'process raft request' (duration: 1.474368832s)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:19:05.42969Z","caller":"traceutil/trace.go:171","msg":"trace[53025136] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"1.427958587s","start":"2026-06-05T04:19:04.00167Z","end":"2026-06-05T04:19:05.429629Z","steps":["trace[53025136] 'process raft request' (duration: 1.427690906s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:19:05.429832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:03.954803Z","time spent":"1.474875952s","remote":"127.0.0.1:47268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23066,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T04:19:05.429907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:04.001638Z","time spent":"1.428159814s","remote":"127.0.0.1:47268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97665,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-05T04:19:05.451699Z","caller":"traceutil/trace.go:171","msg":"trace[1352407692] linearizableReadLoop","detail":"{readStateIndex:607; appliedIndex:602; }","duration":"1.207791402s","start":"2026-06-05T04:19:04.243882Z","end":"2026-06-05T04:19:05.451674Z","steps":["trace[1352407692] 'read index received' (duration: 1.043922218s)","trace[1352407692] 'applied index is now lower than readState.Index' (duration: 163.867244ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:19:05.451928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.208055873s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:19:05.45196Z","caller":"traceutil/trace.go:171","msg":"trace[468707137] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:583; }","duration":"1.208144886s","start":"2026-06-05T04:19:04.243804Z","end":"2026-06-05T04:19:05.451949Z","steps":["trace[468707137] 'agreement among raft nodes before linearized reading' (duration: 1.207974869s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:19:05.451989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:04.243785Z","time spent":"1.208196308s","remote":"127.0.0.1:47202","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-06-05T04:19:05.487581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.005451908s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-05T04:19:05.487682Z","caller":"traceutil/trace.go:171","msg":"trace[1600221151] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:584; }","duration":"1.005604025s","start":"2026-06-05T04:19:04.482056Z","end":"2026-06-05T04:19:05.48766Z","steps":["trace[1600221151] 'agreement among raft nodes before linearized reading' (duration: 1.005349885s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:19:05.48772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"997.843037ms","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-06-05T04:19:05.487791Z","caller":"traceutil/trace.go:171","msg":"trace[623878152] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:584; }","duration":"997.958092ms","start":"2026-06-05T04:19:04.489814Z","end":"2026-06-05T04:19:05.487772Z","steps":["trace[623878152] 'agreement among raft nodes before linearized reading' (duration: 997.742624ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:19:05.487817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.011610252s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-06-05T04:19:05.487894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:04.489784Z","time spent":"998.040305ms","remote":"127.0.0.1:47426","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-06-05T04:19:05.48773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:04.482036Z","time spent":"1.005684697s","remote":"127.0.0.1:47426","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":"info","ts":"2026-06-05T04:19:05.487935Z","caller":"traceutil/trace.go:171","msg":"trace[191096836] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:584; }","duration":"1.011764428s","start":"2026-06-05T04:19:04.476153Z","end":"2026-06-05T04:19:05.487918Z","steps":["trace[191096836] 'agreement among raft nodes before linearized reading' (duration: 1.011428365s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:19:05.487982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:04.476132Z","time spent":"1.011837711s","remote":"127.0.0.1:47426","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-06-05T04:19:05.650228Z","caller":"traceutil/trace.go:171","msg":"trace[2140253725] linearizableReadLoop","detail":"{readStateIndex:616; appliedIndex:611; }","duration":"115.095198ms","start":"2026-06-05T04:19:05.535102Z","end":"2026-06-05T04:19:05.650197Z","steps":["trace[2140253725] 'read index received' (duration: 21.076283ms)","trace[2140253725] 'applied index is now lower than readState.Index' (duration: 94.017705ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:19:05.650311Z","caller":"traceutil/trace.go:171","msg":"trace[858388921] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"122.780158ms","start":"2026-06-05T04:19:05.527478Z","end":"2026-06-05T04:19:05.650258Z","steps":["trace[858388921] 'process raft request' (duration: 60.408381ms)","trace[858388921] 'compare' (duration: 61.986182ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:19:05.65037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.239413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:19:05.65036Z","caller":"traceutil/trace.go:171","msg":"trace[356751470] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"121.346722ms","start":"2026-06-05T04:19:05.528983Z","end":"2026-06-05T04:19:05.65033Z","steps":["trace[356751470] 'process raft request' (duration: 121.114623ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:19:05.650408Z","caller":"traceutil/trace.go:171","msg":"trace[532952632] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:591; }","duration":"115.333798ms","start":"2026-06-05T04:19:05.535064Z","end":"2026-06-05T04:19:05.650398Z","steps":["trace[532952632] 'agreement among raft nodes before linearized reading' (duration: 115.241954ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:19:06.657865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"881.831986ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-05T04:19:06.65795Z","caller":"traceutil/trace.go:171","msg":"trace[302169832] linearizableReadLoop","detail":"{readStateIndex:619; appliedIndex:617; }","duration":"984.52718ms","start":"2026-06-05T04:19:05.67341Z","end":"2026-06-05T04:19:06.657937Z","steps":["trace[302169832] 'read index received' (duration: 13.782379ms)","trace[302169832] 'applied index is now lower than readState.Index' (duration: 970.742261ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:19:06.65802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"984.611053ms","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-06-05T04:19:06.658046Z","caller":"traceutil/trace.go:171","msg":"trace[1289127704] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:594; }","duration":"984.673006ms","start":"2026-06-05T04:19:05.673364Z","end":"2026-06-05T04:19:06.658037Z","steps":["trace[1289127704] 'agreement among raft nodes before linearized reading' (duration: 984.625284ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:19:06.658069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:05.673343Z","time spent":"984.720918ms","remote":"127.0.0.1:47426","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-05T04:19:06.658071Z","caller":"traceutil/trace.go:171","msg":"trace[253171865] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"988.749944ms","start":"2026-06-05T04:19:05.669251Z","end":"2026-06-05T04:19:06.658001Z","steps":["trace[253171865] 'process raft request' (duration: 106.69491ms)","trace[253171865] 'compare' (duration: 881.694929ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:19:06.658272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:05.669227Z","time spent":"988.936001ms","remote":"127.0.0.1:47268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31111,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T04:19:07.081354Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.29619105s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-05T04:19:07.205218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.356793ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-05T04:19:07.205521Z","caller":"traceutil/trace.go:171","msg":"trace[476223548] linearizableReadLoop","detail":"{readStateIndex:621; appliedIndex:619; }","duration":"547.540419ms","start":"2026-06-05T04:19:06.657967Z","end":"2026-06-05T04:19:07.205508Z","steps":["trace[476223548] 'read index received' (duration: 423.786581ms)","trace[476223548] 'applied index is now lower than readState.Index' (duration: 123.752948ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:19:07.205601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.306683s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:19:07.205637Z","caller":"traceutil/trace.go:171","msg":"trace[1905064072] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:596; }","duration":"1.306771654s","start":"2026-06-05T04:19:05.898854Z","end":"2026-06-05T04:19:07.205626Z","steps":["trace[1905064072] 'agreement among raft nodes before linearized reading' (duration: 1.306691851s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:19:07.205647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.207001325s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-05T04:19:07.205729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.207847307s","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-06-05T04:19:07.205739Z","caller":"traceutil/trace.go:171","msg":"trace[1703307869] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:596; }","duration":"1.207121039s","start":"2026-06-05T04:19:05.998593Z","end":"2026-06-05T04:19:07.205714Z","steps":["trace[1703307869] 'agreement among raft nodes before linearized reading' (duration: 1.206938312s)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:19:07.205762Z","caller":"traceutil/trace.go:171","msg":"trace[360671569] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:596; }","duration":"1.20789511s","start":"2026-06-05T04:19:05.99786Z","end":"2026-06-05T04:19:07.205755Z","steps":["trace[360671569] 'agreement among raft nodes before linearized reading' (duration: 1.207847318s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:19:07.205791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:05.99785Z","time spent":"1.207935351s","remote":"127.0.0.1:60118","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-05T04:19:07.205806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:05.998588Z","time spent":"1.207200773s","remote":"127.0.0.1:60110","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 "} {"level":"warn","ts":"2026-06-05T04:19:07.205925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.275424768s","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":"info","ts":"2026-06-05T04:19:07.205988Z","caller":"traceutil/trace.go:171","msg":"trace[1365987563] 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:596; }","duration":"1.275514272s","start":"2026-06-05T04:19:05.930456Z","end":"2026-06-05T04:19:07.205971Z","steps":["trace[1365987563] 'agreement among raft nodes before linearized reading' (duration: 1.275416348s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:19:07.205993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"959.523749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-05T04:19:07.206041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:05.930445Z","time spent":"1.275581285s","remote":"127.0.0.1:60108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":27,"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-06-05T04:19:07.206014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.292809497s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:19:07.206105Z","caller":"traceutil/trace.go:171","msg":"trace[293707378] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:596; }","duration":"1.292910762s","start":"2026-06-05T04:19:05.913188Z","end":"2026-06-05T04:19:07.206099Z","steps":["trace[293707378] 'agreement among raft nodes before linearized reading' (duration: 1.292806078s)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:19:07.206104Z","caller":"traceutil/trace.go:171","msg":"trace[220708434] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:596; }","duration":"959.656453ms","start":"2026-06-05T04:19:06.246407Z","end":"2026-06-05T04:19:07.206063Z","steps":["trace[220708434] 'agreement among raft nodes before linearized reading' (duration: 959.473666ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:19:07.20613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:05.913182Z","time spent":"1.292943023s","remote":"127.0.0.1:60106","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 "} {"level":"warn","ts":"2026-06-05T04:19:07.206086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"996.728497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:19:07.206241Z","caller":"traceutil/trace.go:171","msg":"trace[1521976812] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"1.51601387s","start":"2026-06-05T04:19:05.69021Z","end":"2026-06-05T04:19:07.206224Z","steps":["trace[1521976812] 'process raft request' (duration: 1.391590137s)","trace[1521976812] 'compare' (duration: 123.141835ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:19:07.206258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.293742493s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:19:07.206281Z","caller":"traceutil/trace.go:171","msg":"trace[278047578] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:596; }","duration":"1.293804496s","start":"2026-06-05T04:19:05.91247Z","end":"2026-06-05T04:19:07.206275Z","steps":["trace[278047578] 'agreement among raft nodes before linearized reading' (duration: 1.293762905s)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:19:07.206271Z","caller":"traceutil/trace.go:171","msg":"trace[624703930] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"1.502854646s","start":"2026-06-05T04:19:05.703396Z","end":"2026-06-05T04:19:07.206251Z","steps":["trace[624703930] 'process raft request' (duration: 1.501940562s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:19:07.206309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:05.912463Z","time spent":"1.293832918s","remote":"127.0.0.1:60106","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 "} {"level":"warn","ts":"2026-06-05T04:19:07.206348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.208600627s","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-06-05T04:19:07.206276Z","caller":"traceutil/trace.go:171","msg":"trace[226990748] 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:596; }","duration":"997.014598ms","start":"2026-06-05T04:19:06.209242Z","end":"2026-06-05T04:19:07.206257Z","steps":["trace[226990748] 'agreement among raft nodes before linearized reading' (duration: 996.703736ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:19:07.206475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.307522112s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-05T04:19:07.206478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"959.775209ms","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-06-05T04:19:07.206505Z","caller":"traceutil/trace.go:171","msg":"trace[82981292] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:596; }","duration":"1.307549553s","start":"2026-06-05T04:19:05.898945Z","end":"2026-06-05T04:19:07.206494Z","steps":["trace[82981292] 'agreement among raft nodes before linearized reading' (duration: 1.307511101s)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:19:07.206523Z","caller":"traceutil/trace.go:171","msg":"trace[1842283187] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:596; }","duration":"959.84011ms","start":"2026-06-05T04:19:06.246668Z","end":"2026-06-05T04:19:07.206509Z","steps":["trace[1842283187] 'agreement among raft nodes before linearized reading' (duration: 959.778908ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:19:07.20653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.236290439s","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":"warn","ts":"2026-06-05T04:19:07.206542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:05.898915Z","time spent":"1.307617546s","remote":"127.0.0.1:60098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 "} {"level":"warn","ts":"2026-06-05T04:19:07.206565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:06.246655Z","time spent":"959.896693ms","remote":"127.0.0.1:60136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"info","ts":"2026-06-05T04:19:07.206572Z","caller":"traceutil/trace.go:171","msg":"trace[2018907951] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:596; }","duration":"1.23634477s","start":"2026-06-05T04:19:05.970216Z","end":"2026-06-05T04:19:07.206561Z","steps":["trace[2018907951] 'agreement among raft nodes before linearized reading' (duration: 1.236288388s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:19:07.206549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:06.209232Z","time spent":"997.251057ms","remote":"127.0.0.1:60120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"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-06-05T04:19:07.206166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"997.525538ms","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":"warn","ts":"2026-06-05T04:19:07.206716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.275304243s","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":"info","ts":"2026-06-05T04:19:07.206738Z","caller":"traceutil/trace.go:171","msg":"trace[628215119] 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:596; }","duration":"998.135601ms","start":"2026-06-05T04:19:06.208594Z","end":"2026-06-05T04:19:07.20673Z","steps":["trace[628215119] 'agreement among raft nodes before linearized reading' (duration: 997.545968ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:19:07.206755Z","caller":"traceutil/trace.go:171","msg":"trace[121495554] 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:596; }","duration":"1.275365436s","start":"2026-06-05T04:19:05.931379Z","end":"2026-06-05T04:19:07.206745Z","steps":["trace[121495554] 'agreement among raft nodes before linearized reading' (duration: 1.275291432s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:19:07.206773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:06.208574Z","time spent":"998.188914ms","remote":"127.0.0.1:60120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 "} {"level":"warn","ts":"2026-06-05T04:19:07.206798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:05.931369Z","time spent":"1.275414889s","remote":"127.0.0.1:60108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":27,"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-06-05T04:19:07.206478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.236167654s","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":"warn","ts":"2026-06-05T04:19:07.206645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:05.970204Z","time spent":"1.236427934s","remote":"127.0.0.1:60110","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"info","ts":"2026-06-05T04:19:07.206926Z","caller":"traceutil/trace.go:171","msg":"trace[401002177] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:596; }","duration":"1.236623821s","start":"2026-06-05T04:19:05.970288Z","end":"2026-06-05T04:19:07.206912Z","steps":["trace[401002177] 'agreement among raft nodes before linearized reading' (duration: 1.236154943s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:19:07.20698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:05.970271Z","time spent":"1.236693634s","remote":"127.0.0.1:60110","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-06-05T04:19:07.207017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.276381406s","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-06-05T04:19:07.206174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:06.246399Z","time spent":"959.756488ms","remote":"127.0.0.1:60136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"info","ts":"2026-06-05T04:19:07.20708Z","caller":"traceutil/trace.go:171","msg":"trace[201946455] 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:596; }","duration":"1.276475479s","start":"2026-06-05T04:19:05.930588Z","end":"2026-06-05T04:19:07.207064Z","steps":["trace[201946455] 'agreement among raft nodes before linearized reading' (duration: 1.276379896s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:19:07.205687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:05.898826Z","time spent":"1.306849547s","remote":"127.0.0.1:60098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"warn","ts":"2026-06-05T04:19:07.207135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:05.930582Z","time spent":"1.276536541s","remote":"127.0.0.1:60108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":27,"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-06-05T04:19:07.206392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:05.703373Z","time spent":"1.50294859s","remote":"127.0.0.1:47268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":65190,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T04:19:07.20642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"959.584401ms","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-06-05T04:19:07.207253Z","caller":"traceutil/trace.go:171","msg":"trace[1998490934] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:596; }","duration":"960.460435ms","start":"2026-06-05T04:19:06.246784Z","end":"2026-06-05T04:19:07.207244Z","steps":["trace[1998490934] 'agreement among raft nodes before linearized reading' (duration: 959.598981ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:19:07.207285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:06.246762Z","time spent":"960.513407ms","remote":"127.0.0.1:60132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 "} {"level":"info","ts":"2026-06-05T04:19:07.206413Z","caller":"traceutil/trace.go:171","msg":"trace[1887378022] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:596; }","duration":"1.208677709s","start":"2026-06-05T04:19:05.997718Z","end":"2026-06-05T04:19:07.206396Z","steps":["trace[1887378022] 'agreement among raft nodes before linearized reading' (duration: 1.208528173s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:19:07.207342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:05.997712Z","time spent":"1.209611986s","remote":"127.0.0.1:60118","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-06-05T04:19:07.206351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:05.690191Z","time spent":"1.516086933s","remote":"127.0.0.1:47268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":19834,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-05T04:19:07.207378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"977.497094ms","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-06-05T04:19:07.206109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"997.420653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-05T04:19:07.207459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"977.65613ms","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-06-05T04:19:07.207482Z","caller":"traceutil/trace.go:171","msg":"trace[1266747305] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:596; }","duration":"977.692061ms","start":"2026-06-05T04:19:06.229783Z","end":"2026-06-05T04:19:07.207475Z","steps":["trace[1266747305] 'agreement among raft nodes before linearized reading' (duration: 977.652369ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:19:07.20747Z","caller":"traceutil/trace.go:171","msg":"trace[439840903] 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:596; }","duration":"998.800427ms","start":"2026-06-05T04:19:06.208655Z","end":"2026-06-05T04:19:07.207455Z","steps":["trace[439840903] 'agreement among raft nodes before linearized reading' (duration: 997.399203ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:19:07.206443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.307025473s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-05T04:19:07.20751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:06.229776Z","time spent":"977.727292ms","remote":"127.0.0.1:60132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"info","ts":"2026-06-05T04:19:07.207528Z","caller":"traceutil/trace.go:171","msg":"trace[1319203404] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:596; }","duration":"1.308134726s","start":"2026-06-05T04:19:05.899382Z","end":"2026-06-05T04:19:07.207516Z","steps":["trace[1319203404] 'agreement among raft nodes before linearized reading' (duration: 1.307042444s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:19:07.207584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:05.899366Z","time spent":"1.308199048s","remote":"127.0.0.1:60098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 "} {"level":"warn","ts":"2026-06-05T04:19:07.20641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.293897929s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:19:07.207654Z","caller":"traceutil/trace.go:171","msg":"trace[383467782] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:596; }","duration":"1.295142657s","start":"2026-06-05T04:19:05.912502Z","end":"2026-06-05T04:19:07.207645Z","steps":["trace[383467782] 'agreement among raft nodes before linearized reading' (duration: 1.293886969s)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:19:07.207579Z","caller":"traceutil/trace.go:171","msg":"trace[406686871] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:596; }","duration":"977.596417ms","start":"2026-06-05T04:19:06.229813Z","end":"2026-06-05T04:19:07.207409Z","steps":["trace[406686871] 'agreement among raft nodes before linearized reading' (duration: 977.341648ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:19:07.207697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:05.912481Z","time spent":"1.295200671s","remote":"127.0.0.1:60106","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"warn","ts":"2026-06-05T04:19:07.207729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:06.208647Z","time spent":"999.060687ms","remote":"127.0.0.1:60120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"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-06-05T04:19:07.207762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:06.229809Z","time spent":"977.889048ms","remote":"127.0.0.1:60132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"info","ts":"2026-06-05T04:19:07.284879Z","caller":"traceutil/trace.go:171","msg":"trace[1265001988] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"622.343526ms","start":"2026-06-05T04:19:06.662501Z","end":"2026-06-05T04:19:07.284844Z","steps":["trace[1265001988] 'process raft request' (duration: 622.136138ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:19:07.285044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:06.662472Z","time spent":"622.481281ms","remote":"127.0.0.1:47426","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T04:19:07.285098Z","caller":"traceutil/trace.go:171","msg":"trace[140271675] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"599.081976ms","start":"2026-06-05T04:19:06.685997Z","end":"2026-06-05T04:19:07.285079Z","steps":["trace[140271675] 'process raft request' (duration: 598.752164ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:19:07.285214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:06.685971Z","time spent":"599.18169ms","remote":"127.0.0.1:47268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":59616,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T04:19:07.78719Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680220302464153587,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-05T04:19:08.166749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.520183ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-05T04:19:08.166862Z","caller":"traceutil/trace.go:171","msg":"trace[1438840091] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"922.405363ms","start":"2026-06-05T04:19:07.244439Z","end":"2026-06-05T04:19:08.166844Z","steps":["trace[1438840091] 'process raft request' (duration: 819.708364ms)","trace[1438840091] 'compare' (duration: 102.289014ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:19:08.166922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:07.244429Z","time spent":"922.464825ms","remote":"127.0.0.1:47268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":80679,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T04:19:08.169455Z","caller":"traceutil/trace.go:171","msg":"trace[1455089726] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"863.048724ms","start":"2026-06-05T04:19:07.306379Z","end":"2026-06-05T04:19:08.169428Z","steps":["trace[1455089726] 'process raft request' (duration: 862.297796ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:19:08.169559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:07.306353Z","time spent":"863.158128ms","remote":"127.0.0.1:47268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31130,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T04:19:08.16957Z","caller":"traceutil/trace.go:171","msg":"trace[1807293568] linearizableReadLoop","detail":"{readStateIndex:626; appliedIndex:623; }","duration":"883.381851ms","start":"2026-06-05T04:19:07.286129Z","end":"2026-06-05T04:19:08.169511Z","steps":["trace[1807293568] 'read index received' (duration: 777.706708ms)","trace[1807293568] 'applied index is now lower than readState.Index' (duration: 105.674023ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:19:08.169635Z","caller":"traceutil/trace.go:171","msg":"trace[371994249] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"704.427423ms","start":"2026-06-05T04:19:07.465173Z","end":"2026-06-05T04:19:08.169601Z","steps":["trace[371994249] 'process raft request' (duration: 703.897294ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:19:08.16975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"883.598299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-05T04:19:08.169772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:07.465143Z","time spent":"704.564998ms","remote":"127.0.0.1:47268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":569094,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-05T04:19:08.169789Z","caller":"traceutil/trace.go:171","msg":"trace[2051084042] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:601; }","duration":"883.673192ms","start":"2026-06-05T04:19:07.286103Z","end":"2026-06-05T04:19:08.169776Z","steps":["trace[2051084042] 'agreement among raft nodes before linearized reading' (duration: 883.570808ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:19:08.169827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:07.286087Z","time spent":"883.731885ms","remote":"127.0.0.1:47208","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-06-05T04:19:08.170037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"609.423393ms","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-06-05T04:19:08.170077Z","caller":"traceutil/trace.go:171","msg":"trace[1909359749] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:601; }","duration":"609.499926ms","start":"2026-06-05T04:19:07.560564Z","end":"2026-06-05T04:19:08.170064Z","steps":["trace[1909359749] 'agreement among raft nodes before linearized reading' (duration: 609.36059ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:19:08.170114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:07.560543Z","time spent":"609.563288ms","remote":"127.0.0.1:47426","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-06-05T04:19:08.170184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"608.303621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-06-05T04:19:08.170217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"609.021378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-05T04:19:08.170228Z","caller":"traceutil/trace.go:171","msg":"trace[604821364] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:601; }","duration":"608.355923ms","start":"2026-06-05T04:19:07.561858Z","end":"2026-06-05T04:19:08.170214Z","steps":["trace[604821364] 'agreement among raft nodes before linearized reading' (duration: 608.228289ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:19:08.170255Z","caller":"traceutil/trace.go:171","msg":"trace[1062091375] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:601; }","duration":"609.08884ms","start":"2026-06-05T04:19:07.561152Z","end":"2026-06-05T04:19:08.170241Z","steps":["trace[1062091375] 'agreement among raft nodes before linearized reading' (duration: 608.980406ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:19:08.170264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:07.561852Z","time spent":"608.404295ms","remote":"127.0.0.1:47426","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-05T04:19:08.170279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:07.561134Z","time spent":"609.138912ms","remote":"127.0.0.1:47426","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":"info","ts":"2026-06-05T04:19:12.222174Z","caller":"traceutil/trace.go:171","msg":"trace[1457402584] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"167.428141ms","start":"2026-06-05T04:19:12.054717Z","end":"2026-06-05T04:19:12.222145Z","steps":["trace[1457402584] 'process raft request' (duration: 166.8411ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:19:12.955831Z","caller":"traceutil/trace.go:171","msg":"trace[1350853946] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"111.539741ms","start":"2026-06-05T04:19:12.844261Z","end":"2026-06-05T04:19:12.955801Z","steps":["trace[1350853946] 'process raft request' (duration: 76.715162ms)","trace[1350853946] 'compare' (duration: 34.715225ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:19:13.532307Z","caller":"traceutil/trace.go:171","msg":"trace[78886596] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"147.196181ms","start":"2026-06-05T04:19:13.385079Z","end":"2026-06-05T04:19:13.532275Z","steps":["trace[78886596] 'process raft request' (duration: 136.393895ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:19:14.222668Z","caller":"traceutil/trace.go:171","msg":"trace[643098854] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"181.662953ms","start":"2026-06-05T04:19:14.040972Z","end":"2026-06-05T04:19:14.222635Z","steps":["trace[643098854] 'process raft request' (duration: 181.091123ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:19:14.885605Z","caller":"traceutil/trace.go:171","msg":"trace[1288507686] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"171.64245ms","start":"2026-06-05T04:19:14.713931Z","end":"2026-06-05T04:19:14.885573Z","steps":["trace[1288507686] 'process raft request' (duration: 171.040818ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:19:15.314752Z","caller":"traceutil/trace.go:171","msg":"trace[1931661377] transaction","detail":"{read_only:false; response_revision:663; number_of_response:1; }","duration":"358.8703ms","start":"2026-06-05T04:19:14.955624Z","end":"2026-06-05T04:19:15.314494Z","steps":["trace[1931661377] 'process raft request' (duration: 358.752166ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:19:15.31485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:14.955588Z","time spent":"359.217752ms","remote":"127.0.0.1:47412","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-05T04:19:16.352313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"573.629242ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-05T04:19:16.352462Z","caller":"traceutil/trace.go:171","msg":"trace[131218251] transaction","detail":"{read_only:false; response_revision:665; number_of_response:1; }","duration":"1.000102978s","start":"2026-06-05T04:19:15.352333Z","end":"2026-06-05T04:19:16.352436Z","steps":["trace[131218251] 'process raft request' (duration: 426.242638ms)","trace[131218251] 'compare' (duration: 573.26528ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:19:16.352544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:15.352313Z","time spent":"1.000194062s","remote":"127.0.0.1:47296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":905,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-05T04:19:17.027241Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.248715901s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-05T04:19:17.361178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.63801ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-05T04:19:17.361419Z","caller":"traceutil/trace.go:171","msg":"trace[1039473528] transaction","detail":"{read_only:false; response_revision:666; number_of_response:1; }","duration":"2.009059935s","start":"2026-06-05T04:19:15.352333Z","end":"2026-06-05T04:19:17.361393Z","steps":["trace[1039473528] 'process raft request' (duration: 1.675131395s)","trace[1039473528] 'compare' (duration: 333.364691ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:19:17.36154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:15.352313Z","time spent":"2.00917221s","remote":"127.0.0.1:47296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":775,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-05T04:19:17.361573Z","caller":"traceutil/trace.go:171","msg":"trace[834264990] linearizableReadLoop","detail":"{readStateIndex:695; appliedIndex:691; }","duration":"1.930575891s","start":"2026-06-05T04:19:15.430974Z","end":"2026-06-05T04:19:17.36155Z","steps":["trace[834264990] 'read index received' (duration: 347.620899ms)","trace[834264990] 'applied index is now lower than readState.Index' (duration: 1.582953812s)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:19:17.361712Z","caller":"traceutil/trace.go:171","msg":"trace[1231292469] transaction","detail":"{read_only:false; response_revision:668; number_of_response:1; }","duration":"2.000899579s","start":"2026-06-05T04:19:15.360791Z","end":"2026-06-05T04:19:17.361691Z","steps":["trace[1231292469] 'process raft request' (duration: 2.000688762s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:19:17.361898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.930907953s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-05T04:19:17.361929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:15.36077Z","time spent":"2.000988813s","remote":"127.0.0.1:47412","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T04:19:17.361979Z","caller":"traceutil/trace.go:171","msg":"trace[1162717129] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:668; }","duration":"1.931031757s","start":"2026-06-05T04:19:15.430931Z","end":"2026-06-05T04:19:17.361962Z","steps":["trace[1162717129] 'agreement among raft nodes before linearized reading' (duration: 1.930748306s)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:19:17.362009Z","caller":"traceutil/trace.go:171","msg":"trace[954837498] transaction","detail":"{read_only:false; response_revision:667; number_of_response:1; }","duration":"2.009570424s","start":"2026-06-05T04:19:15.352423Z","end":"2026-06-05T04:19:17.361993Z","steps":["trace[954837498] 'process raft request' (duration: 2.00890078s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:19:17.362031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.040923404s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-05T04:19:17.362036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:15.430912Z","time spent":"1.93110829s","remote":"127.0.0.1:47426","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-06-05T04:19:17.362033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.118345923s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:19:17.362079Z","caller":"traceutil/trace.go:171","msg":"trace[1788896333] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:668; }","duration":"1.041016127s","start":"2026-06-05T04:19:16.321048Z","end":"2026-06-05T04:19:17.362064Z","steps":["trace[1788896333] 'agreement among raft nodes before linearized reading' (duration: 1.040892313s)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:19:17.362088Z","caller":"traceutil/trace.go:171","msg":"trace[789604360] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:668; }","duration":"1.118446927s","start":"2026-06-05T04:19:16.243628Z","end":"2026-06-05T04:19:17.362075Z","steps":["trace[789604360] 'agreement among raft nodes before linearized reading' (duration: 1.118293151s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:19:17.362105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:15.352414Z","time spent":"2.009640866s","remote":"127.0.0.1:47366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3209,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T04:19:17.362128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:16.243591Z","time spent":"1.118530719s","remote":"127.0.0.1:47202","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-06-05T04:19:17.362122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:16.321021Z","time spent":"1.041094279s","remote":"127.0.0.1:47426","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-06-05T04:19:17.362167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.041202573s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-06-05T04:19:17.362194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.040922103s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-05T04:19:17.362226Z","caller":"traceutil/trace.go:171","msg":"trace[1895636514] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:668; }","duration":"1.040974995s","start":"2026-06-05T04:19:16.321243Z","end":"2026-06-05T04:19:17.362218Z","steps":["trace[1895636514] 'agreement among raft nodes before linearized reading' (duration: 1.040897493s)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:19:17.362237Z","caller":"traceutil/trace.go:171","msg":"trace[326830924] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:668; }","duration":"1.041301226s","start":"2026-06-05T04:19:16.320915Z","end":"2026-06-05T04:19:17.362216Z","steps":["trace[326830924] 'agreement among raft nodes before linearized reading' (duration: 1.04112211s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:19:17.362283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:16.320894Z","time spent":"1.041376749s","remote":"127.0.0.1:47426","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-06-05T04:19:17.362335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:16.321235Z","time spent":"1.041017917s","remote":"127.0.0.1:47426","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-06-05T04:19:17.61735Z","caller":"traceutil/trace.go:171","msg":"trace[650949544] transaction","detail":"{read_only:false; response_revision:669; number_of_response:1; }","duration":"248.556927ms","start":"2026-06-05T04:19:17.368745Z","end":"2026-06-05T04:19:17.617302Z","steps":["trace[650949544] 'process raft request' (duration: 248.404152ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:19:17.622458Z","caller":"traceutil/trace.go:171","msg":"trace[402872093] transaction","detail":"{read_only:false; response_revision:671; number_of_response:1; }","duration":"253.634852ms","start":"2026-06-05T04:19:17.368788Z","end":"2026-06-05T04:19:17.622423Z","steps":["trace[402872093] 'process raft request' (duration: 253.536077ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:19:17.622532Z","caller":"traceutil/trace.go:171","msg":"trace[618059823] transaction","detail":"{read_only:false; response_revision:670; number_of_response:1; }","duration":"253.693854ms","start":"2026-06-05T04:19:17.368793Z","end":"2026-06-05T04:19:17.622487Z","steps":["trace[618059823] 'process raft request' (duration: 253.365352ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:19:17.622639Z","caller":"traceutil/trace.go:171","msg":"trace[1648491504] linearizableReadLoop","detail":"{readStateIndex:699; appliedIndex:695; }","duration":"247.863524ms","start":"2026-06-05T04:19:17.374747Z","end":"2026-06-05T04:19:17.622611Z","steps":["trace[1648491504] 'read index received' (duration: 242.49094ms)","trace[1648491504] 'applied index is now lower than readState.Index' (duration: 5.371324ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:19:17.622691Z","caller":"traceutil/trace.go:171","msg":"trace[294877604] transaction","detail":"{read_only:false; response_revision:672; number_of_response:1; }","duration":"253.670043ms","start":"2026-06-05T04:19:17.369005Z","end":"2026-06-05T04:19:17.622675Z","steps":["trace[294877604] 'process raft request' (duration: 253.367542ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:19:17.622762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.992978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:19:17.622807Z","caller":"traceutil/trace.go:171","msg":"trace[341132432] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:672; }","duration":"248.069901ms","start":"2026-06-05T04:19:17.374721Z","end":"2026-06-05T04:19:17.622791Z","steps":["trace[341132432] 'agreement among raft nodes before linearized reading' (duration: 247.989038ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:19:20.591081Z","caller":"traceutil/trace.go:171","msg":"trace[1612611362] transaction","detail":"{read_only:false; response_revision:718; number_of_response:1; }","duration":"123.788113ms","start":"2026-06-05T04:19:20.467263Z","end":"2026-06-05T04:19:20.591052Z","steps":["trace[1612611362] 'process raft request' (duration: 123.035279ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:19:27.867451Z","caller":"traceutil/trace.go:171","msg":"trace[378779718] transaction","detail":"{read_only:false; response_revision:774; number_of_response:1; }","duration":"153.338998ms","start":"2026-06-05T04:19:27.714082Z","end":"2026-06-05T04:19:27.867421Z","steps":["trace[378779718] 'process raft request' (duration: 150.4954ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:19:27.867924Z","caller":"traceutil/trace.go:171","msg":"trace[1426323139] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"150.386697ms","start":"2026-06-05T04:19:27.717523Z","end":"2026-06-05T04:19:27.86791Z","steps":["trace[1426323139] 'process raft request' (duration: 150.043227ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:19:27.867648Z","caller":"traceutil/trace.go:171","msg":"trace[2145019455] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"151.597254ms","start":"2026-06-05T04:19:27.716019Z","end":"2026-06-05T04:19:27.867616Z","steps":["trace[2145019455] 'process raft request' (duration: 151.47341ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:19:31.173329Z","caller":"traceutil/trace.go:171","msg":"trace[106659465] transaction","detail":"{read_only:false; response_revision:802; number_of_response:1; }","duration":"637.085437ms","start":"2026-06-05T04:19:30.536207Z","end":"2026-06-05T04:19:31.173293Z","steps":["trace[106659465] 'process raft request' (duration: 636.84655ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:19:31.173831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:30.536163Z","time spent":"637.291463ms","remote":"127.0.0.1:47366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5031,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T04:19:31.5533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.548647ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-05T04:19:31.553485Z","caller":"traceutil/trace.go:171","msg":"trace[1494944082] transaction","detail":"{read_only:false; response_revision:803; number_of_response:1; }","duration":"371.986436ms","start":"2026-06-05T04:19:31.181471Z","end":"2026-06-05T04:19:31.553458Z","steps":["trace[1494944082] 'process raft request' (duration: 114.13755ms)","trace[1494944082] 'compare' (duration: 256.911588ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:19:31.553572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:31.181439Z","time spent":"372.090289ms","remote":"127.0.0.1:47362","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":780,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T04:19:31.765058Z","caller":"traceutil/trace.go:171","msg":"trace[1680668605] linearizableReadLoop","detail":"{readStateIndex:837; appliedIndex:834; }","duration":"560.302592ms","start":"2026-06-05T04:19:31.20472Z","end":"2026-06-05T04:19:31.765022Z","steps":["trace[1680668605] 'read index received' (duration: 90.917332ms)","trace[1680668605] 'applied index is now lower than readState.Index' (duration: 469.38364ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:19:31.765148Z","caller":"traceutil/trace.go:171","msg":"trace[20529627] transaction","detail":"{read_only:false; response_revision:804; number_of_response:1; }","duration":"583.382606ms","start":"2026-06-05T04:19:31.181727Z","end":"2026-06-05T04:19:31.76511Z","steps":["trace[20529627] 'process raft request' (duration: 505.86576ms)","trace[20529627] 'compare' (duration: 76.850466ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:19:31.765245Z","caller":"traceutil/trace.go:171","msg":"trace[1364758668] transaction","detail":"{read_only:false; response_revision:805; number_of_response:1; }","duration":"576.446581ms","start":"2026-06-05T04:19:31.188746Z","end":"2026-06-05T04:19:31.765193Z","steps":["trace[1364758668] 'process raft request' (duration: 576.118892ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:19:31.765309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"520.33945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-05T04:19:31.765336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:31.181665Z","time spent":"583.564641ms","remote":"127.0.0.1:47430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1289,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T04:19:31.765352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"560.602292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-06-05T04:19:31.765379Z","caller":"traceutil/trace.go:171","msg":"trace[1852772794] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:805; }","duration":"520.484384ms","start":"2026-06-05T04:19:31.244868Z","end":"2026-06-05T04:19:31.765353Z","steps":["trace[1852772794] 'agreement among raft nodes before linearized reading' (duration: 520.36223ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:19:31.765455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:31.244831Z","time spent":"520.610908ms","remote":"127.0.0.1:47202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-05T04:19:31.765458Z","caller":"traceutil/trace.go:171","msg":"trace[1485463697] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:805; }","duration":"560.760186ms","start":"2026-06-05T04:19:31.204666Z","end":"2026-06-05T04:19:31.765426Z","steps":["trace[1485463697] 'agreement among raft nodes before linearized reading' (duration: 560.488698ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:19:31.76551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:31.204643Z","time spent":"560.856799ms","remote":"127.0.0.1:47426","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":512,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-05T04:19:31.76551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:31.18874Z","time spent":"576.615196ms","remote":"127.0.0.1:47366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4853,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T04:19:31.973713Z","caller":"traceutil/trace.go:171","msg":"trace[1919822182] transaction","detail":"{read_only:false; response_revision:806; number_of_response:1; }","duration":"201.381843ms","start":"2026-06-05T04:19:31.772303Z","end":"2026-06-05T04:19:31.973685Z","steps":["trace[1919822182] 'process raft request' (duration: 123.121475ms)","trace[1919822182] 'compare' (duration: 77.97378ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:19:31.97402Z","caller":"traceutil/trace.go:171","msg":"trace[939893042] transaction","detail":"{read_only:false; response_revision:807; number_of_response:1; }","duration":"201.663362ms","start":"2026-06-05T04:19:31.772273Z","end":"2026-06-05T04:19:31.973936Z","steps":["trace[939893042] 'process raft request' (duration: 201.290211ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:19:31.974313Z","caller":"traceutil/trace.go:171","msg":"trace[128909107] transaction","detail":"{read_only:false; response_revision:808; number_of_response:1; }","duration":"201.850477ms","start":"2026-06-05T04:19:31.772449Z","end":"2026-06-05T04:19:31.974299Z","steps":["trace[128909107] 'process raft request' (duration: 201.184977ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:19:31.974451Z","caller":"traceutil/trace.go:171","msg":"trace[1470271315] transaction","detail":"{read_only:false; response_revision:809; number_of_response:1; }","duration":"201.417195ms","start":"2026-06-05T04:19:31.773001Z","end":"2026-06-05T04:19:31.974418Z","steps":["trace[1470271315] 'process raft request' (duration: 201.083565ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:19:31.974641Z","caller":"traceutil/trace.go:171","msg":"trace[981834229] linearizableReadLoop","detail":"{readStateIndex:840; appliedIndex:837; }","duration":"202.046464ms","start":"2026-06-05T04:19:31.77258Z","end":"2026-06-05T04:19:31.974627Z","steps":["trace[981834229] 'read index received' (duration: 122.772805ms)","trace[981834229] 'applied index is now lower than readState.Index' (duration: 79.272139ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:19:31.974712Z","caller":"traceutil/trace.go:171","msg":"trace[1362964289] transaction","detail":"{read_only:false; response_revision:810; number_of_response:1; }","duration":"199.947552ms","start":"2026-06-05T04:19:31.774757Z","end":"2026-06-05T04:19:31.974704Z","steps":["trace[1362964289] 'process raft request' (duration: 199.585431ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:19:31.974936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.346002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-h7hzr\" ","response":"range_response_count:1 size:4868"} {"level":"info","ts":"2026-06-05T04:19:31.974962Z","caller":"traceutil/trace.go:171","msg":"trace[1426097581] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-h7hzr; range_end:; response_count:1; response_revision:810; }","duration":"202.429664ms","start":"2026-06-05T04:19:31.772524Z","end":"2026-06-05T04:19:31.974954Z","steps":["trace[1426097581] 'agreement among raft nodes before linearized reading' (duration: 202.28454ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:19:35.229218Z","caller":"traceutil/trace.go:171","msg":"trace[498433286] linearizableReadLoop","detail":"{readStateIndex:864; appliedIndex:863; }","duration":"369.704486ms","start":"2026-06-05T04:19:34.859488Z","end":"2026-06-05T04:19:35.229193Z","steps":["trace[498433286] 'read index received' (duration: 369.496029ms)","trace[498433286] 'applied index is now lower than readState.Index' (duration: 207.447µs)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:19:35.229339Z","caller":"traceutil/trace.go:171","msg":"trace[790040711] transaction","detail":"{read_only:false; response_revision:831; number_of_response:1; }","duration":"679.918715ms","start":"2026-06-05T04:19:34.549411Z","end":"2026-06-05T04:19:35.22933Z","steps":["trace[790040711] 'process raft request' (duration: 679.645946ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:19:35.229422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.518469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-05T04:19:35.229453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:34.549393Z","time spent":"679.976976ms","remote":"127.0.0.1:47366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4024,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T04:19:35.229449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.962414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:19:35.229474Z","caller":"traceutil/trace.go:171","msg":"trace[1752692019] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:831; }","duration":"181.647032ms","start":"2026-06-05T04:19:35.047814Z","end":"2026-06-05T04:19:35.229461Z","steps":["trace[1752692019] 'agreement among raft nodes before linearized reading' (duration: 181.548349ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:19:35.229503Z","caller":"traceutil/trace.go:171","msg":"trace[910399023] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:831; }","duration":"370.074956ms","start":"2026-06-05T04:19:34.859415Z","end":"2026-06-05T04:19:35.22949Z","steps":["trace[910399023] 'agreement among raft nodes before linearized reading' (duration: 369.981104ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:19:35.229548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:19:34.859391Z","time spent":"370.147479ms","remote":"127.0.0.1:47338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true "} {"level":"info","ts":"2026-06-05T04:19:46.172095Z","caller":"traceutil/trace.go:171","msg":"trace[896839176] linearizableReadLoop","detail":"{readStateIndex:984; appliedIndex:982; }","duration":"119.823437ms","start":"2026-06-05T04:19:46.05225Z","end":"2026-06-05T04:19:46.172074Z","steps":["trace[896839176] 'read index received' (duration: 25.067094ms)","trace[896839176] 'applied index is now lower than readState.Index' (duration: 94.755723ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:19:46.172462Z","caller":"traceutil/trace.go:171","msg":"trace[662972579] transaction","detail":"{read_only:false; response_revision:949; number_of_response:1; }","duration":"126.057577ms","start":"2026-06-05T04:19:46.046397Z","end":"2026-06-05T04:19:46.172455Z","steps":["trace[662972579] 'process raft request' (duration: 125.593865ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:19:46.172681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.415372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-06-05T04:19:46.172739Z","caller":"traceutil/trace.go:171","msg":"trace[1760165215] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:949; }","duration":"120.496804ms","start":"2026-06-05T04:19:46.052233Z","end":"2026-06-05T04:19:46.172729Z","steps":["trace[1760165215] 'agreement among raft nodes before linearized reading' (duration: 120.37041ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:20:03.627435Z","caller":"traceutil/trace.go:171","msg":"trace[1273620996] transaction","detail":"{read_only:false; response_revision:1048; number_of_response:1; }","duration":"111.278961ms","start":"2026-06-05T04:20:03.516091Z","end":"2026-06-05T04:20:03.62738Z","steps":["trace[1273620996] 'process raft request' (duration: 111.070146ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:20:10.355031Z","caller":"traceutil/trace.go:171","msg":"trace[1129444825] linearizableReadLoop","detail":"{readStateIndex:1117; appliedIndex:1116; }","duration":"111.702309ms","start":"2026-06-05T04:20:10.243311Z","end":"2026-06-05T04:20:10.355013Z","steps":["trace[1129444825] 'read index received' (duration: 111.534975ms)","trace[1129444825] 'applied index is now lower than readState.Index' (duration: 166.664µs)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:20:10.355261Z","caller":"traceutil/trace.go:171","msg":"trace[1503140706] transaction","detail":"{read_only:false; response_revision:1075; number_of_response:1; }","duration":"115.235073ms","start":"2026-06-05T04:20:10.240018Z","end":"2026-06-05T04:20:10.355253Z","steps":["trace[1503140706] 'process raft request' (duration: 114.894146ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:20:10.355408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.090887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:20:10.355436Z","caller":"traceutil/trace.go:171","msg":"trace[2087416494] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1075; }","duration":"112.151058ms","start":"2026-06-05T04:20:10.243278Z","end":"2026-06-05T04:20:10.355429Z","steps":["trace[2087416494] 'agreement among raft nodes before linearized reading' (duration: 112.097677ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:20:14.561899Z","caller":"traceutil/trace.go:171","msg":"trace[1621891901] transaction","detail":"{read_only:false; response_revision:1093; number_of_response:1; }","duration":"167.775414ms","start":"2026-06-05T04:20:14.3941Z","end":"2026-06-05T04:20:14.561875Z","steps":["trace[1621891901] 'process raft request' (duration: 167.692122ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:20:14.56193Z","caller":"traceutil/trace.go:171","msg":"trace[1812706319] transaction","detail":"{read_only:false; response_revision:1092; number_of_response:1; }","duration":"167.869847ms","start":"2026-06-05T04:20:14.394035Z","end":"2026-06-05T04:20:14.561905Z","steps":["trace[1812706319] 'process raft request' (duration: 166.890497ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:20:26.902803Z","caller":"traceutil/trace.go:171","msg":"trace[104195700] transaction","detail":"{read_only:false; response_revision:1132; number_of_response:1; }","duration":"255.255381ms","start":"2026-06-05T04:20:26.647522Z","end":"2026-06-05T04:20:26.902777Z","steps":["trace[104195700] 'process raft request' (duration: 178.196685ms)","trace[104195700] 'compare' (duration: 76.962674ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:20:30.748655Z","caller":"traceutil/trace.go:171","msg":"trace[1996763731] transaction","detail":"{read_only:false; response_revision:1144; number_of_response:1; }","duration":"102.386292ms","start":"2026-06-05T04:20:30.646245Z","end":"2026-06-05T04:20:30.748632Z","steps":["trace[1996763731] 'process raft request' (duration: 102.233609ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:20:55.300507Z","caller":"traceutil/trace.go:171","msg":"trace[115036102] transaction","detail":"{read_only:false; response_revision:1225; number_of_response:1; }","duration":"114.374616ms","start":"2026-06-05T04:20:55.186095Z","end":"2026-06-05T04:20:55.300469Z","steps":["trace[115036102] 'process raft request' (duration: 114.085222ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:21:11.471225Z","caller":"traceutil/trace.go:171","msg":"trace[1013297855] linearizableReadLoop","detail":"{readStateIndex:1331; appliedIndex:1330; }","duration":"228.137692ms","start":"2026-06-05T04:21:11.243064Z","end":"2026-06-05T04:21:11.471202Z","steps":["trace[1013297855] 'read index received' (duration: 227.920669ms)","trace[1013297855] 'applied index is now lower than readState.Index' (duration: 216.123µs)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:21:11.471291Z","caller":"traceutil/trace.go:171","msg":"trace[646429799] transaction","detail":"{read_only:false; response_revision:1277; number_of_response:1; }","duration":"228.660019ms","start":"2026-06-05T04:21:11.242601Z","end":"2026-06-05T04:21:11.471261Z","steps":["trace[646429799] 'process raft request' (duration: 228.448736ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:21:11.47147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.341655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:21:11.471591Z","caller":"traceutil/trace.go:171","msg":"trace[1779739412] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1277; }","duration":"228.504157ms","start":"2026-06-05T04:21:11.243039Z","end":"2026-06-05T04:21:11.471544Z","steps":["trace[1779739412] 'agreement among raft nodes before linearized reading' (duration: 228.264024ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:21:21.409335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.035718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:21:21.409431Z","caller":"traceutil/trace.go:171","msg":"trace[681693370] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1341; }","duration":"168.17373ms","start":"2026-06-05T04:21:21.241236Z","end":"2026-06-05T04:21:21.40941Z","steps":["trace[681693370] 'range keys from in-memory index tree' (duration: 167.962147ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:21:27.035236Z","caller":"traceutil/trace.go:171","msg":"trace[401316399] linearizableReadLoop","detail":"{readStateIndex:1423; appliedIndex:1422; }","duration":"168.873726ms","start":"2026-06-05T04:21:26.866343Z","end":"2026-06-05T04:21:27.035217Z","steps":["trace[401316399] 'read index received' (duration: 168.684773ms)","trace[401316399] 'applied index is now lower than readState.Index' (duration: 188.283µs)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:21:27.03551Z","caller":"traceutil/trace.go:171","msg":"trace[1082612310] transaction","detail":"{read_only:false; response_revision:1364; number_of_response:1; }","duration":"210.214313ms","start":"2026-06-05T04:21:26.825262Z","end":"2026-06-05T04:21:27.035476Z","steps":["trace[1082612310] 'process raft request' (duration: 209.842278ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:21:27.036195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.833938ms","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-06-05T04:21:27.036283Z","caller":"traceutil/trace.go:171","msg":"trace[1622688738] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1364; }","duration":"169.993922ms","start":"2026-06-05T04:21:26.86627Z","end":"2026-06-05T04:21:27.036264Z","steps":["trace[1622688738] 'agreement among raft nodes before linearized reading' (duration: 169.751509ms)"],"step_count":1}