{"level":"warn","ts":"2026-04-28T13:47:11.198127Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-28T13:47:11.198223Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.19: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.19:2380","--initial-cluster=instance=https://199.204.45.19:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.19:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.19:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-28T13:47:11.198395Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-28T13:47:11.198414Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.19:2380"]} {"level":"info","ts":"2026-04-28T13:47:11.198583Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-28T13:47:11.199434Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"]} {"level":"info","ts":"2026-04-28T13:47:11.199564Z","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.19:2380"],"listen-peer-urls":["https://199.204.45.19:2380"],"advertise-client-urls":["https://199.204.45.19:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.19:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-28T13:47:11.203628Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.7452ms"} {"level":"info","ts":"2026-04-28T13:47:11.212826Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a847c2e9c7010db6","cluster-id":"2b11a68e27507b05"} {"level":"info","ts":"2026-04-28T13:47:11.212907Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=()"} {"level":"info","ts":"2026-04-28T13:47:11.212944Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became follower at term 0"} {"level":"info","ts":"2026-04-28T13:47:11.212961Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a847c2e9c7010db6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-28T13:47:11.212971Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became follower at term 1"} {"level":"info","ts":"2026-04-28T13:47:11.213012Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=(12125874831040253366)"} {"level":"warn","ts":"2026-04-28T13:47:11.220318Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-28T13:47:11.221602Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-28T13:47:11.222839Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-28T13:47:11.224904Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a847c2e9c7010db6","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-28T13:47:11.225123Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-28T13:47:11.225225Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-28T13:47:11.225237Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-28T13:47:11.225238Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a847c2e9c7010db6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-28T13:47:11.233394Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=(12125874831040253366)"} {"level":"info","ts":"2026-04-28T13:47:11.233817Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2b11a68e27507b05","local-member-id":"a847c2e9c7010db6","added-peer-id":"a847c2e9c7010db6","added-peer-peer-urls":["https://199.204.45.19:2380"]} {"level":"info","ts":"2026-04-28T13:47:11.236421Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-28T13:47:11.23666Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.19:2380"} {"level":"info","ts":"2026-04-28T13:47:11.236763Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.19:2380"} {"level":"info","ts":"2026-04-28T13:47:11.237564Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a847c2e9c7010db6","initial-advertise-peer-urls":["https://199.204.45.19:2380"],"listen-peer-urls":["https://199.204.45.19:2380"],"advertise-client-urls":["https://199.204.45.19:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-28T13:47:11.237613Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-28T13:47:12.213553Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 is starting a new election at term 1"} {"level":"info","ts":"2026-04-28T13:47:12.213598Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-28T13:47:12.213632Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 received MsgPreVoteResp from a847c2e9c7010db6 at term 1"} {"level":"info","ts":"2026-04-28T13:47:12.213644Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became candidate at term 2"} {"level":"info","ts":"2026-04-28T13:47:12.213651Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 received MsgVoteResp from a847c2e9c7010db6 at term 2"} {"level":"info","ts":"2026-04-28T13:47:12.21366Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became leader at term 2"} {"level":"info","ts":"2026-04-28T13:47:12.213667Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a847c2e9c7010db6 elected leader a847c2e9c7010db6 at term 2"} {"level":"info","ts":"2026-04-28T13:47:12.269365Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a847c2e9c7010db6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.19:2379]}","request-path":"/0/members/a847c2e9c7010db6/attributes","cluster-id":"2b11a68e27507b05","publish-timeout":"7s"} {"level":"info","ts":"2026-04-28T13:47:12.269418Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-28T13:47:12.270708Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-28T13:47:12.271228Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-28T13:47:12.271293Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-28T13:47:12.273825Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.19:2379"} {"level":"info","ts":"2026-04-28T13:47:12.273938Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-28T13:47:12.277123Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-28T13:47:12.290405Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2b11a68e27507b05","local-member-id":"a847c2e9c7010db6","cluster-version":"3.5"} {"level":"info","ts":"2026-04-28T13:47:12.290632Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-28T13:47:12.29101Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-04-28T13:47:14.692463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"627.741941ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:14"} {"level":"info","ts":"2026-04-28T13:47:14.692884Z","caller":"traceutil/trace.go:171","msg":"trace[2124573282] linearizableReadLoop","detail":"{readStateIndex:57; appliedIndex:53; }","duration":"640.906327ms","start":"2026-04-28T13:47:14.051959Z","end":"2026-04-28T13:47:14.692866Z","steps":["trace[2124573282] 'read index received' (duration: 12.029998ms)","trace[2124573282] 'applied index is now lower than readState.Index' (duration: 628.875439ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:47:14.692818Z","caller":"traceutil/trace.go:171","msg":"trace[1188218698] transaction","detail":"{read_only:false; response_revision:50; number_of_response:1; }","duration":"916.117677ms","start":"2026-04-28T13:47:13.776664Z","end":"2026-04-28T13:47:14.692782Z","steps":["trace[1188218698] 'process raft request' (duration: 287.266489ms)","trace[1188218698] 'compare' (duration: 627.607389ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:47:14.692984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:13.798233Z","time spent":"894.743951ms","remote":"127.0.0.1:39244","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-04-28T13:47:14.693155Z","caller":"traceutil/trace.go:171","msg":"trace[1914864597] transaction","detail":"{read_only:false; response_revision:52; number_of_response:1; }","duration":"867.30422ms","start":"2026-04-28T13:47:13.825829Z","end":"2026-04-28T13:47:14.693133Z","steps":["trace[1914864597] 'process raft request' (duration: 867.002175ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:14.693311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.778761ms","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-04-28T13:47:14.693361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:13.82581Z","time spent":"867.433691ms","remote":"127.0.0.1:39438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T13:47:14.693394Z","caller":"traceutil/trace.go:171","msg":"trace[65319587] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:52; }","duration":"197.900292ms","start":"2026-04-28T13:47:14.495467Z","end":"2026-04-28T13:47:14.693367Z","steps":["trace[65319587] 'agreement among raft nodes before linearized reading' (duration: 197.658079ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:14.693476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:13.776638Z","time spent":"916.656606ms","remote":"127.0.0.1:39616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1199,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T13:47:14.693546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.343474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-28T13:47:14.693606Z","caller":"traceutil/trace.go:171","msg":"trace[903551899] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:52; }","duration":"195.453076ms","start":"2026-04-28T13:47:14.498137Z","end":"2026-04-28T13:47:14.69359Z","steps":["trace[903551899] 'agreement among raft nodes before linearized reading' (duration: 195.360064ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:47:14.693015Z","caller":"traceutil/trace.go:171","msg":"trace[1936057595] transaction","detail":"{read_only:false; response_revision:51; number_of_response:1; }","duration":"868.429779ms","start":"2026-04-28T13:47:13.824567Z","end":"2026-04-28T13:47:14.692996Z","steps":["trace[1936057595] 'process raft request' (duration: 868.208595ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:14.693849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:13.824538Z","time spent":"869.253602ms","remote":"127.0.0.1:39616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T13:47:14.69391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"641.944644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-28T13:47:14.693947Z","caller":"traceutil/trace.go:171","msg":"trace[845508034] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:52; }","duration":"642.014685ms","start":"2026-04-28T13:47:14.051919Z","end":"2026-04-28T13:47:14.693934Z","steps":["trace[845508034] 'agreement among raft nodes before linearized reading' (duration: 641.914123ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:14.693985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:14.051898Z","time spent":"642.078917ms","remote":"127.0.0.1:39296","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":27,"request content":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" "} {"level":"warn","ts":"2026-04-28T13:47:15.701455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"717.259784ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-04-28T13:47:15.701657Z","caller":"traceutil/trace.go:171","msg":"trace[1408672828] transaction","detail":"{read_only:false; response_revision:53; number_of_response:1; }","duration":"1.007329557s","start":"2026-04-28T13:47:14.694268Z","end":"2026-04-28T13:47:15.701598Z","steps":["trace[1408672828] 'process raft request' (duration: 289.834299ms)","trace[1408672828] 'compare' (duration: 717.098232ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:47:15.701795Z","caller":"traceutil/trace.go:171","msg":"trace[1473169932] transaction","detail":"{read_only:false; response_revision:57; number_of_response:1; }","duration":"1.002575062s","start":"2026-04-28T13:47:14.6992Z","end":"2026-04-28T13:47:15.701776Z","steps":["trace[1473169932] 'process raft request' (duration: 1.002523052s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:15.701887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:14.699193Z","time spent":"1.002649143s","remote":"127.0.0.1:39616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1216,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T13:47:15.701911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:14.694247Z","time spent":"1.007470818s","remote":"127.0.0.1:39244","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":592,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T13:47:15.701913Z","caller":"traceutil/trace.go:171","msg":"trace[672672532] transaction","detail":"{read_only:false; response_revision:55; number_of_response:1; }","duration":"1.004681285s","start":"2026-04-28T13:47:14.697198Z","end":"2026-04-28T13:47:15.701879Z","steps":["trace[672672532] 'process raft request' (duration: 1.004448341s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:15.70199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:14.697185Z","time spent":"1.004768467s","remote":"127.0.0.1:39544","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":429,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T13:47:15.702304Z","caller":"traceutil/trace.go:171","msg":"trace[717867484] transaction","detail":"{read_only:false; response_revision:56; number_of_response:1; }","duration":"1.004242339s","start":"2026-04-28T13:47:14.697872Z","end":"2026-04-28T13:47:15.702115Z","steps":["trace[717867484] 'process raft request' (duration: 1.003819612s)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:47:15.702014Z","caller":"traceutil/trace.go:171","msg":"trace[1700899838] linearizableReadLoop","detail":"{readStateIndex:58; appliedIndex:57; }","duration":"1.006358652s","start":"2026-04-28T13:47:14.695467Z","end":"2026-04-28T13:47:15.701825Z","steps":["trace[1700899838] 'read index received' (duration: 288.683282ms)","trace[1700899838] 'applied index is now lower than readState.Index' (duration: 717.67184ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:47:15.702392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:14.697853Z","time spent":"1.004494743s","remote":"127.0.0.1:39342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3453,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T13:47:15.702488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.007025043s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-28T13:47:15.702537Z","caller":"traceutil/trace.go:171","msg":"trace[2065748448] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:57; }","duration":"1.007094594s","start":"2026-04-28T13:47:14.695427Z","end":"2026-04-28T13:47:15.702522Z","steps":["trace[2065748448] 'agreement among raft nodes before linearized reading' (duration: 1.007007572s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:15.702576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:14.695416Z","time spent":"1.007153444s","remote":"127.0.0.1:39162","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-28T13:47:15.702386Z","caller":"traceutil/trace.go:171","msg":"trace[200897580] transaction","detail":"{read_only:false; response_revision:54; number_of_response:1; }","duration":"1.005173383s","start":"2026-04-28T13:47:14.697194Z","end":"2026-04-28T13:47:15.702367Z","steps":["trace[200897580] 'process raft request' (duration: 1.00438551s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:15.702697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:14.697181Z","time spent":"1.005462899s","remote":"127.0.0.1:39616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":671,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T13:47:15.702799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.006554266s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-28T13:47:15.702925Z","caller":"traceutil/trace.go:171","msg":"trace[1058194082] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:57; }","duration":"1.006771579s","start":"2026-04-28T13:47:14.696111Z","end":"2026-04-28T13:47:15.702883Z","steps":["trace[1058194082] 'agreement among raft nodes before linearized reading' (duration: 1.006549006s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:15.703027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:14.696101Z","time spent":"1.006913331s","remote":"127.0.0.1:39530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":27,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" "} {"level":"info","ts":"2026-04-28T13:47:40.518689Z","caller":"traceutil/trace.go:171","msg":"trace[1436345337] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"134.612912ms","start":"2026-04-28T13:47:40.384046Z","end":"2026-04-28T13:47:40.518659Z","steps":["trace[1436345337] 'process raft request' (duration: 48.19405ms)","trace[1436345337] 'compare' (duration: 86.039456ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:47:40.90708Z","caller":"traceutil/trace.go:171","msg":"trace[1126936586] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"194.340403ms","start":"2026-04-28T13:47:40.712711Z","end":"2026-04-28T13:47:40.907051Z","steps":["trace[1126936586] 'process raft request' (duration: 120.891052ms)","trace[1126936586] 'compare' (duration: 73.319419ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:47:41.056508Z","caller":"traceutil/trace.go:171","msg":"trace[1866932248] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"139.290064ms","start":"2026-04-28T13:47:40.917191Z","end":"2026-04-28T13:47:41.056481Z","steps":["trace[1866932248] 'process raft request' (duration: 109.912588ms)","trace[1866932248] 'compare' (duration: 29.269414ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:47:41.057349Z","caller":"traceutil/trace.go:171","msg":"trace[1334573389] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"102.824187ms","start":"2026-04-28T13:47:40.954495Z","end":"2026-04-28T13:47:41.057319Z","steps":["trace[1334573389] 'process raft request' (duration: 102.594974ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:47:43.31168Z","caller":"traceutil/trace.go:171","msg":"trace[1829624534] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"139.594918ms","start":"2026-04-28T13:47:43.172069Z","end":"2026-04-28T13:47:43.311664Z","steps":["trace[1829624534] 'process raft request' (duration: 139.523708ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:47:43.312128Z","caller":"traceutil/trace.go:171","msg":"trace[401257203] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"187.894865ms","start":"2026-04-28T13:47:43.124226Z","end":"2026-04-28T13:47:43.312121Z","steps":["trace[401257203] 'process raft request' (duration: 164.041666ms)","trace[401257203] 'compare' (duration: 23.204269ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:47:44.404888Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988150703589683645,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-28T13:47:44.493329Z","caller":"traceutil/trace.go:171","msg":"trace[342205260] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"607.594638ms","start":"2026-04-28T13:47:43.885654Z","end":"2026-04-28T13:47:44.493249Z","steps":["trace[342205260] 'process raft request' (duration: 555.365764ms)","trace[342205260] 'compare' (duration: 51.815249ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:47:44.493755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:43.885641Z","time spent":"607.874232ms","remote":"127.0.0.1:39220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":208461,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T13:47:44.501412Z","caller":"traceutil/trace.go:171","msg":"trace[1404261965] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"522.474697ms","start":"2026-04-28T13:47:43.978906Z","end":"2026-04-28T13:47:44.501381Z","steps":["trace[1404261965] 'process raft request' (duration: 521.24748ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:44.501597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:43.978857Z","time spent":"522.624789ms","remote":"127.0.0.1:39220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570090,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T13:47:44.501679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"596.911531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-28T13:47:44.501758Z","caller":"traceutil/trace.go:171","msg":"trace[2075160457] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:587; }","duration":"596.997992ms","start":"2026-04-28T13:47:43.904724Z","end":"2026-04-28T13:47:44.501722Z","steps":["trace[2075160457] 'agreement among raft nodes before linearized reading' (duration: 596.720339ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:44.501795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:43.904648Z","time spent":"597.139394ms","remote":"127.0.0.1:39438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-28T13:47:44.501282Z","caller":"traceutil/trace.go:171","msg":"trace[562900905] linearizableReadLoop","detail":"{readStateIndex:609; appliedIndex:607; }","duration":"596.537436ms","start":"2026-04-28T13:47:43.904731Z","end":"2026-04-28T13:47:44.501268Z","steps":["trace[562900905] 'read index received' (duration: 536.273622ms)","trace[562900905] 'applied index is now lower than readState.Index' (duration: 60.262644ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:47:44.503203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.973072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-28T13:47:44.503244Z","caller":"traceutil/trace.go:171","msg":"trace[1056147191] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:587; }","duration":"317.053732ms","start":"2026-04-28T13:47:44.186177Z","end":"2026-04-28T13:47:44.503231Z","steps":["trace[1056147191] 'agreement among raft nodes before linearized reading' (duration: 316.931631ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:44.503248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"580.017728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:7708"} {"level":"warn","ts":"2026-04-28T13:47:44.503284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:44.186151Z","time spent":"317.127214ms","remote":"127.0.0.1:39438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-28T13:47:44.503309Z","caller":"traceutil/trace.go:171","msg":"trace[1011566513] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:587; }","duration":"580.11014ms","start":"2026-04-28T13:47:43.923172Z","end":"2026-04-28T13:47:44.503282Z","steps":["trace[1011566513] 'agreement among raft nodes before linearized reading' (duration: 579.906807ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:44.503358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:43.923138Z","time spent":"580.209861ms","remote":"127.0.0.1:39220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":1,"response size":7731,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io\" "} {"level":"info","ts":"2026-04-28T13:47:44.744933Z","caller":"traceutil/trace.go:171","msg":"trace[1671520233] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"231.618963ms","start":"2026-04-28T13:47:44.513288Z","end":"2026-04-28T13:47:44.744907Z","steps":["trace[1671520233] 'process raft request' (duration: 173.859531ms)","trace[1671520233] 'compare' (duration: 57.582659ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:47:44.745102Z","caller":"traceutil/trace.go:171","msg":"trace[1356875994] linearizableReadLoop","detail":"{readStateIndex:612; appliedIndex:610; }","duration":"155.467649ms","start":"2026-04-28T13:47:44.589616Z","end":"2026-04-28T13:47:44.745083Z","steps":["trace[1356875994] 'read index received' (duration: 97.499815ms)","trace[1356875994] 'applied index is now lower than readState.Index' (duration: 57.966664ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:47:44.745346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.723162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/tlsroutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:65214"} {"level":"info","ts":"2026-04-28T13:47:44.745388Z","caller":"traceutil/trace.go:171","msg":"trace[532858714] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/tlsroutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:590; }","duration":"155.813634ms","start":"2026-04-28T13:47:44.58956Z","end":"2026-04-28T13:47:44.745373Z","steps":["trace[532858714] 'agreement among raft nodes before linearized reading' (duration: 155.654702ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:44.745536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.007892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-28T13:47:44.745525Z","caller":"traceutil/trace.go:171","msg":"trace[311329883] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"188.758196ms","start":"2026-04-28T13:47:44.556734Z","end":"2026-04-28T13:47:44.745492Z","steps":["trace[311329883] 'process raft request' (duration: 188.120097ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:47:44.745572Z","caller":"traceutil/trace.go:171","msg":"trace[1002524545] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:590; }","duration":"125.071132ms","start":"2026-04-28T13:47:44.620491Z","end":"2026-04-28T13:47:44.745562Z","steps":["trace[1002524545] 'agreement among raft nodes before linearized reading' (duration: 124.930551ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:47:46.360592Z","caller":"traceutil/trace.go:171","msg":"trace[1898404769] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"170.362547ms","start":"2026-04-28T13:47:46.190198Z","end":"2026-04-28T13:47:46.36056Z","steps":["trace[1898404769] 'process raft request' (duration: 170.209835ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:49.971002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.676377ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-28T13:47:49.971201Z","caller":"traceutil/trace.go:171","msg":"trace[1823569934] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"1.137769788s","start":"2026-04-28T13:47:48.833404Z","end":"2026-04-28T13:47:49.971173Z","steps":["trace[1823569934] 'process raft request' (duration: 581.845387ms)","trace[1823569934] 'compare' (duration: 555.581425ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:47:49.971234Z","caller":"traceutil/trace.go:171","msg":"trace[2142384432] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"1.090942505s","start":"2026-04-28T13:47:48.880277Z","end":"2026-04-28T13:47:49.97122Z","steps":["trace[2142384432] 'process raft request' (duration: 1.090875945s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:49.971295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:48.833377Z","time spent":"1.137873809s","remote":"127.0.0.1:39438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T13:47:49.971321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:48.880263Z","time spent":"1.091008026s","remote":"127.0.0.1:39520","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1092,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T13:47:49.971331Z","caller":"traceutil/trace.go:171","msg":"trace[2038944066] linearizableReadLoop","detail":"{readStateIndex:637; appliedIndex:634; }","duration":"985.487261ms","start":"2026-04-28T13:47:48.985826Z","end":"2026-04-28T13:47:49.971313Z","steps":["trace[2038944066] 'read index received' (duration: 429.285476ms)","trace[2038944066] 'applied index is now lower than readState.Index' (duration: 556.200945ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:47:49.97132Z","caller":"traceutil/trace.go:171","msg":"trace[415246287] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"1.137661745s","start":"2026-04-28T13:47:48.833619Z","end":"2026-04-28T13:47:49.971281Z","steps":["trace[415246287] 'process raft request' (duration: 1.137485693s)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:47:49.971427Z","caller":"traceutil/trace.go:171","msg":"trace[301292166] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"849.593752ms","start":"2026-04-28T13:47:49.121823Z","end":"2026-04-28T13:47:49.971417Z","steps":["trace[301292166] 'process raft request' (duration: 849.366369ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:49.971491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:49.121802Z","time spent":"849.649053ms","remote":"127.0.0.1:39438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T13:47:49.971505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"985.658583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T13:47:49.971536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:48.833569Z","time spent":"1.137882018s","remote":"127.0.0.1:39438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T13:47:49.971574Z","caller":"traceutil/trace.go:171","msg":"trace[408757243] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:615; }","duration":"985.771445ms","start":"2026-04-28T13:47:48.985783Z","end":"2026-04-28T13:47:49.971554Z","steps":["trace[408757243] 'agreement among raft nodes before linearized reading' (duration: 985.654743ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:49.971603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.277966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-28T13:47:49.971611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:48.985761Z","time spent":"985.842335ms","remote":"127.0.0.1:39158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-28T13:47:49.971648Z","caller":"traceutil/trace.go:171","msg":"trace[880991633] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:615; }","duration":"374.363408ms","start":"2026-04-28T13:47:49.59727Z","end":"2026-04-28T13:47:49.971634Z","steps":["trace[880991633] 'agreement among raft nodes before linearized reading' (duration: 374.188776ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:49.971681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:49.59725Z","time spent":"374.424958ms","remote":"127.0.0.1:39438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-28T13:47:51.338567Z","caller":"traceutil/trace.go:171","msg":"trace[332454036] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"728.875489ms","start":"2026-04-28T13:47:50.609672Z","end":"2026-04-28T13:47:51.338548Z","steps":["trace[332454036] 'process raft request' (duration: 728.775257ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:51.338666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:50.609648Z","time spent":"728.96534ms","remote":"127.0.0.1:39342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T13:47:51.635016Z","caller":"traceutil/trace.go:171","msg":"trace[816638851] linearizableReadLoop","detail":"{readStateIndex:647; appliedIndex:645; }","duration":"650.86696ms","start":"2026-04-28T13:47:50.984087Z","end":"2026-04-28T13:47:51.634954Z","steps":["trace[816638851] 'read index received' (duration: 354.305887ms)","trace[816638851] 'applied index is now lower than readState.Index' (duration: 296.558833ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:47:51.635083Z","caller":"traceutil/trace.go:171","msg":"trace[141477261] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"731.786625ms","start":"2026-04-28T13:47:50.903252Z","end":"2026-04-28T13:47:51.635039Z","steps":["trace[141477261] 'process raft request' (duration: 724.748011ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:51.635183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"651.090423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:47:51.63523Z","caller":"traceutil/trace.go:171","msg":"trace[266597476] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:624; }","duration":"651.205465ms","start":"2026-04-28T13:47:50.984012Z","end":"2026-04-28T13:47:51.635218Z","steps":["trace[266597476] 'agreement among raft nodes before linearized reading' (duration: 651.104493ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:51.635232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:50.903231Z","time spent":"731.940167ms","remote":"127.0.0.1:39268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T13:47:51.635257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:50.983995Z","time spent":"651.257725ms","remote":"127.0.0.1:39162","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-28T13:47:51.888355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.257339ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-28T13:47:51.88861Z","caller":"traceutil/trace.go:171","msg":"trace[771353570] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"197.57436ms","start":"2026-04-28T13:47:51.690997Z","end":"2026-04-28T13:47:51.888571Z","steps":["trace[771353570] 'process raft request' (duration: 28.991427ms)","trace[771353570] 'compare' (duration: 168.113917ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:47:53.305727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.417257449s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-28T13:47:53.305831Z","caller":"traceutil/trace.go:171","msg":"trace[1344655552] linearizableReadLoop","detail":"{readStateIndex:649; appliedIndex:648; }","duration":"1.405160547s","start":"2026-04-28T13:47:51.900648Z","end":"2026-04-28T13:47:53.305809Z","steps":["trace[1344655552] 'read index received' (duration: 27.8µs)","trace[1344655552] 'applied index is now lower than readState.Index' (duration: 1.405130597s)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:47:53.305978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.405318249s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:47:53.306012Z","caller":"traceutil/trace.go:171","msg":"trace[1852048002] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:625; }","duration":"1.40536139s","start":"2026-04-28T13:47:51.900637Z","end":"2026-04-28T13:47:53.305998Z","steps":["trace[1852048002] 'agreement among raft nodes before linearized reading' (duration: 1.405289349s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:53.306046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:51.900621Z","time spent":"1.405416421s","remote":"127.0.0.1:39410","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-04-28T13:47:53.306214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.331175308s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-28T13:47:53.326866Z","caller":"traceutil/trace.go:171","msg":"trace[2133125228] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:625; }","duration":"1.351866421s","start":"2026-04-28T13:47:51.974986Z","end":"2026-04-28T13:47:53.326852Z","steps":["trace[2133125228] 'agreement among raft nodes before linearized reading' (duration: 1.331177268s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:53.326909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:51.974964Z","time spent":"1.351936684s","remote":"127.0.0.1:39438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-28T13:47:53.326442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.331643962s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-28T13:47:53.326954Z","caller":"traceutil/trace.go:171","msg":"trace[775123582] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:625; }","duration":"1.33221011s","start":"2026-04-28T13:47:51.994731Z","end":"2026-04-28T13:47:53.326941Z","steps":["trace[775123582] 'agreement among raft nodes before linearized reading' (duration: 1.331622931s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:53.327016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:51.994706Z","time spent":"1.332302241s","remote":"127.0.0.1:39438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-28T13:47:53.326506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.342483557s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:47:53.327062Z","caller":"traceutil/trace.go:171","msg":"trace[381763808] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:625; }","duration":"1.343064935s","start":"2026-04-28T13:47:51.983979Z","end":"2026-04-28T13:47:53.327044Z","steps":["trace[381763808] 'agreement among raft nodes before linearized reading' (duration: 1.342468436s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:53.327094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:51.983968Z","time spent":"1.343116886s","remote":"127.0.0.1:39158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-28T13:47:53.326543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"654.783425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-28T13:47:53.327256Z","caller":"traceutil/trace.go:171","msg":"trace[1841277826] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:625; }","duration":"655.446835ms","start":"2026-04-28T13:47:52.671715Z","end":"2026-04-28T13:47:53.327162Z","steps":["trace[1841277826] 'agreement among raft nodes before linearized reading' (duration: 654.722195ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:53.326583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.35096132s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-28T13:47:53.327277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:52.671693Z","time spent":"655.577947ms","remote":"127.0.0.1:39438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-28T13:47:53.32729Z","caller":"traceutil/trace.go:171","msg":"trace[329252953] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:625; }","duration":"1.351711351s","start":"2026-04-28T13:47:51.975568Z","end":"2026-04-28T13:47:53.32728Z","steps":["trace[329252953] 'agreement among raft nodes before linearized reading' (duration: 1.350895249s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:53.327309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:51.975551Z","time spent":"1.351752671s","remote":"127.0.0.1:39438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-28T13:47:53.567546Z","caller":"traceutil/trace.go:171","msg":"trace[1512720788] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"235.054601ms","start":"2026-04-28T13:47:53.332467Z","end":"2026-04-28T13:47:53.567521Z","steps":["trace[1512720788] 'process raft request' (duration: 234.851518ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:47:53.673931Z","caller":"traceutil/trace.go:171","msg":"trace[689845675] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"341.174768ms","start":"2026-04-28T13:47:53.332734Z","end":"2026-04-28T13:47:53.673908Z","steps":["trace[689845675] 'process raft request' (duration: 341.018146ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:53.674058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:53.332715Z","time spent":"341.279519ms","remote":"127.0.0.1:39438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T13:47:53.674219Z","caller":"traceutil/trace.go:171","msg":"trace[459787741] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"341.419691ms","start":"2026-04-28T13:47:53.332789Z","end":"2026-04-28T13:47:53.674209Z","steps":["trace[459787741] 'process raft request' (duration: 341.083917ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:47:53.674223Z","caller":"traceutil/trace.go:171","msg":"trace[440515467] linearizableReadLoop","detail":"{readStateIndex:653; appliedIndex:649; }","duration":"337.420018ms","start":"2026-04-28T13:47:53.336791Z","end":"2026-04-28T13:47:53.674211Z","steps":["trace[440515467] 'read index received' (duration: 230.523259ms)","trace[440515467] 'applied index is now lower than readState.Index' (duration: 106.895919ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:47:53.674279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:53.332784Z","time spent":"341.466614ms","remote":"127.0.0.1:39438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T13:47:53.67432Z","caller":"traceutil/trace.go:171","msg":"trace[1740645670] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"341.519023ms","start":"2026-04-28T13:47:53.332792Z","end":"2026-04-28T13:47:53.674311Z","steps":["trace[1740645670] 'process raft request' (duration: 341.3655ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:53.674374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:53.332775Z","time spent":"341.573985ms","remote":"127.0.0.1:39438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T13:47:53.674539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.717134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:47:53.674607Z","caller":"traceutil/trace.go:171","msg":"trace[521829473] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:629; }","duration":"337.825495ms","start":"2026-04-28T13:47:53.336765Z","end":"2026-04-28T13:47:53.674591Z","steps":["trace[521829473] 'agreement among raft nodes before linearized reading' (duration: 337.559682ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:53.674639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:53.336757Z","time spent":"337.875576ms","remote":"127.0.0.1:39158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-28T13:47:55.159825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.229034ms","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":"info","ts":"2026-04-28T13:47:55.159954Z","caller":"traceutil/trace.go:171","msg":"trace[2017802998] 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:640; }","duration":"259.402506ms","start":"2026-04-28T13:47:54.900532Z","end":"2026-04-28T13:47:55.159934Z","steps":["trace[2017802998] 'count revisions from in-memory index tree' (duration: 259.122942ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:55.160035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.431847ms","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-04-28T13:47:55.160177Z","caller":"traceutil/trace.go:171","msg":"trace[830187258] 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:640; }","duration":"259.564158ms","start":"2026-04-28T13:47:54.900538Z","end":"2026-04-28T13:47:55.160102Z","steps":["trace[830187258] 'range keys from in-memory index tree' (duration: 259.320014ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:55.160234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.900971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:47:55.160258Z","caller":"traceutil/trace.go:171","msg":"trace[1697042417] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:640; }","duration":"398.934441ms","start":"2026-04-28T13:47:54.761317Z","end":"2026-04-28T13:47:55.160251Z","steps":["trace[1697042417] 'range keys from in-memory index tree' (duration: 398.877941ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:55.160282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:54.761313Z","time spent":"398.959251ms","remote":"127.0.0.1:39054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-28T13:47:55.160435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.150894ms","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-04-28T13:47:55.16044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.864098ms","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-04-28T13:47:55.160458Z","caller":"traceutil/trace.go:171","msg":"trace[1652558009] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:640; }","duration":"399.191085ms","start":"2026-04-28T13:47:54.761261Z","end":"2026-04-28T13:47:55.160452Z","steps":["trace[1652558009] 'count revisions from in-memory index tree' (duration: 399.045733ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:55.160477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:54.761248Z","time spent":"399.223635ms","remote":"127.0.0.1:39054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-28T13:47:55.160549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.037257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:47:55.160571Z","caller":"traceutil/trace.go:171","msg":"trace[2032167898] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:640; }","duration":"369.087817ms","start":"2026-04-28T13:47:54.791478Z","end":"2026-04-28T13:47:55.160565Z","steps":["trace[2032167898] 'range keys from in-memory index tree' (duration: 368.975576ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:55.160588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:54.791458Z","time spent":"369.125287ms","remote":"127.0.0.1:39068","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-28T13:47:55.160676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.100187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:47:55.160475Z","caller":"traceutil/trace.go:171","msg":"trace[1215519000] 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:640; }","duration":"258.923259ms","start":"2026-04-28T13:47:54.901543Z","end":"2026-04-28T13:47:55.160466Z","steps":["trace[1215519000] 'range keys from in-memory index tree' (duration: 258.805907ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:55.160717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.203865ms","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":"info","ts":"2026-04-28T13:47:55.160739Z","caller":"traceutil/trace.go:171","msg":"trace[1358420465] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:640; }","duration":"368.242545ms","start":"2026-04-28T13:47:54.79249Z","end":"2026-04-28T13:47:55.160733Z","steps":["trace[1358420465] 'range keys from in-memory index tree' (duration: 368.144534ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:55.16091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:54.792479Z","time spent":"368.420907ms","remote":"127.0.0.1:39054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-28T13:47:55.160986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.308984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:47:55.161066Z","caller":"traceutil/trace.go:171","msg":"trace[1719305344] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:640; }","duration":"228.433165ms","start":"2026-04-28T13:47:54.932619Z","end":"2026-04-28T13:47:55.161052Z","steps":["trace[1719305344] 'count revisions from in-memory index tree' (duration: 228.238073ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:55.161241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.805033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T13:47:55.161272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.920979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:47:55.161273Z","caller":"traceutil/trace.go:171","msg":"trace[1480277479] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:640; }","duration":"176.864023ms","start":"2026-04-28T13:47:54.984401Z","end":"2026-04-28T13:47:55.161265Z","steps":["trace[1480277479] 'range keys from in-memory index tree' (duration: 176.752092ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:47:55.161292Z","caller":"traceutil/trace.go:171","msg":"trace[1268012378] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:640; }","duration":"227.952559ms","start":"2026-04-28T13:47:54.933333Z","end":"2026-04-28T13:47:55.161285Z","steps":["trace[1268012378] 'range keys from in-memory index tree' (duration: 227.853008ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:47:55.160697Z","caller":"traceutil/trace.go:171","msg":"trace[2104313752] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:640; }","duration":"369.161828ms","start":"2026-04-28T13:47:54.79153Z","end":"2026-04-28T13:47:55.160692Z","steps":["trace[2104313752] 'count revisions from in-memory index tree' (duration: 369.020376ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:55.161242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.601958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T13:47:55.161394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:54.791506Z","time spent":"369.869797ms","remote":"127.0.0.1:39068","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"info","ts":"2026-04-28T13:47:55.161414Z","caller":"traceutil/trace.go:171","msg":"trace[1471349810] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:640; }","duration":"228.81031ms","start":"2026-04-28T13:47:54.932597Z","end":"2026-04-28T13:47:55.161407Z","steps":["trace[1471349810] 'range keys from in-memory index tree' (duration: 228.499156ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:55.161466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.233354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:47:55.161496Z","caller":"traceutil/trace.go:171","msg":"trace[964018911] 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:640; }","duration":"343.291145ms","start":"2026-04-28T13:47:54.818198Z","end":"2026-04-28T13:47:55.161489Z","steps":["trace[964018911] 'range keys from in-memory index tree' (duration: 343.168173ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:55.161518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:54.818183Z","time spent":"343.329095ms","remote":"127.0.0.1:39074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"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-04-28T13:47:55.161614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.813811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:47:55.161636Z","caller":"traceutil/trace.go:171","msg":"trace[2037496970] 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:640; }","duration":"343.856673ms","start":"2026-04-28T13:47:54.817773Z","end":"2026-04-28T13:47:55.16163Z","steps":["trace[2037496970] 'range keys from in-memory index tree' (duration: 343.767641ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:55.161656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:54.817762Z","time spent":"343.888003ms","remote":"127.0.0.1:39074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"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-04-28T13:47:55.161225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.818738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:47:55.161718Z","caller":"traceutil/trace.go:171","msg":"trace[463905094] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:640; }","duration":"287.382036ms","start":"2026-04-28T13:47:54.87432Z","end":"2026-04-28T13:47:55.161702Z","steps":["trace[463905094] 'range keys from in-memory index tree' (duration: 286.757537ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:55.161772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.196906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:47:55.161795Z","caller":"traceutil/trace.go:171","msg":"trace[2001059803] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:640; }","duration":"288.267188ms","start":"2026-04-28T13:47:54.873521Z","end":"2026-04-28T13:47:55.161788Z","steps":["trace[2001059803] 'range keys from in-memory index tree' (duration: 288.013834ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:55.161797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.091696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:47:55.161818Z","caller":"traceutil/trace.go:171","msg":"trace[912714980] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:640; }","duration":"288.144196ms","start":"2026-04-28T13:47:54.873667Z","end":"2026-04-28T13:47:55.161811Z","steps":["trace[912714980] 'count revisions from in-memory index tree' (duration: 287.967274ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:55.162054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.443981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:47:55.162212Z","caller":"traceutil/trace.go:171","msg":"trace[1085511377] 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:640; }","duration":"344.618393ms","start":"2026-04-28T13:47:54.817578Z","end":"2026-04-28T13:47:55.162196Z","steps":["trace[1085511377] 'count revisions from in-memory index tree' (duration: 344.36953ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:55.162334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:54.817569Z","time spent":"344.748875ms","remote":"127.0.0.1:39074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"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-04-28T13:48:10.136104Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988150703589684132,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-28T13:48:10.359359Z","caller":"traceutil/trace.go:171","msg":"trace[1982623745] transaction","detail":"{read_only:false; response_revision:790; number_of_response:1; }","duration":"869.478033ms","start":"2026-04-28T13:48:09.48985Z","end":"2026-04-28T13:48:10.359328Z","steps":["trace[1982623745] 'process raft request' (duration: 869.21415ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:10.359582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:09.48983Z","time spent":"869.630665ms","remote":"127.0.0.1:39438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T13:48:10.397891Z","caller":"traceutil/trace.go:171","msg":"trace[1670967314] transaction","detail":"{read_only:false; response_revision:791; number_of_response:1; }","duration":"322.590392ms","start":"2026-04-28T13:48:10.075267Z","end":"2026-04-28T13:48:10.397857Z","steps":["trace[1670967314] 'process raft request' (duration: 322.294478ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:10.398162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:10.075244Z","time spent":"322.717814ms","remote":"127.0.0.1:39438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T13:48:10.398216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"762.456287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-28T13:48:10.398126Z","caller":"traceutil/trace.go:171","msg":"trace[173780274] linearizableReadLoop","detail":"{readStateIndex:819; appliedIndex:817; }","duration":"762.341356ms","start":"2026-04-28T13:48:09.635746Z","end":"2026-04-28T13:48:10.398087Z","steps":["trace[173780274] 'read index received' (duration: 723.308283ms)","trace[173780274] 'applied index is now lower than readState.Index' (duration: 38.699478ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:48:10.398325Z","caller":"traceutil/trace.go:171","msg":"trace[1661341118] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:791; }","duration":"762.63924ms","start":"2026-04-28T13:48:09.635667Z","end":"2026-04-28T13:48:10.398307Z","steps":["trace[1661341118] 'agreement among raft nodes before linearized reading' (duration: 762.301285ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:10.398404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:09.635636Z","time spent":"762.755691ms","remote":"127.0.0.1:39438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-28T13:48:10.398629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"706.612851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-zjwld\" ","response":"range_response_count:1 size:3964"} {"level":"warn","ts":"2026-04-28T13:48:10.398686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"637.744489ms","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-04-28T13:48:10.398681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"647.807837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-28T13:48:10.398695Z","caller":"traceutil/trace.go:171","msg":"trace[267499395] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-zjwld; range_end:; response_count:1; response_revision:791; }","duration":"706.720512ms","start":"2026-04-28T13:48:09.691951Z","end":"2026-04-28T13:48:10.398671Z","steps":["trace[267499395] 'agreement among raft nodes before linearized reading' (duration: 706.495199ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:48:10.398755Z","caller":"traceutil/trace.go:171","msg":"trace[799137113] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:791; }","duration":"637.854139ms","start":"2026-04-28T13:48:09.760881Z","end":"2026-04-28T13:48:10.398735Z","steps":["trace[799137113] 'agreement among raft nodes before linearized reading' (duration: 637.657437ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:10.398772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:09.691928Z","time spent":"706.829044ms","remote":"127.0.0.1:39342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3987,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-zjwld\" "} {"level":"warn","ts":"2026-04-28T13:48:10.398824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:09.760855Z","time spent":"637.956341ms","remote":"127.0.0.1:39438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-28T13:48:10.39876Z","caller":"traceutil/trace.go:171","msg":"trace[1614134911] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:791; }","duration":"647.946218ms","start":"2026-04-28T13:48:09.750797Z","end":"2026-04-28T13:48:10.398743Z","steps":["trace[1614134911] 'agreement among raft nodes before linearized reading' (duration: 647.726545ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:10.398899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:09.750764Z","time spent":"648.11511ms","remote":"127.0.0.1:39438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-28T13:48:10.398921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"634.409727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-28T13:48:10.399087Z","caller":"traceutil/trace.go:171","msg":"trace[340995880] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:791; }","duration":"634.61832ms","start":"2026-04-28T13:48:09.764447Z","end":"2026-04-28T13:48:10.399065Z","steps":["trace[340995880] 'agreement among raft nodes before linearized reading' (duration: 634.368746ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:10.399323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:09.764414Z","time spent":"634.871162ms","remote":"127.0.0.1:39438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-28T13:48:24.515861Z","caller":"traceutil/trace.go:171","msg":"trace[765543644] transaction","detail":"{read_only:false; response_revision:963; number_of_response:1; }","duration":"117.98609ms","start":"2026-04-28T13:48:24.397853Z","end":"2026-04-28T13:48:24.515839Z","steps":["trace[765543644] 'process raft request' (duration: 117.591685ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:48:28.817398Z","caller":"traceutil/trace.go:171","msg":"trace[1963932901] transaction","detail":"{read_only:false; response_revision:985; number_of_response:1; }","duration":"255.885506ms","start":"2026-04-28T13:48:28.561481Z","end":"2026-04-28T13:48:28.817366Z","steps":["trace[1963932901] 'process raft request' (duration: 255.815046ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:48:28.817475Z","caller":"traceutil/trace.go:171","msg":"trace[2076583449] transaction","detail":"{read_only:false; response_revision:982; number_of_response:1; }","duration":"256.554505ms","start":"2026-04-28T13:48:28.560848Z","end":"2026-04-28T13:48:28.817403Z","steps":["trace[2076583449] 'process raft request' (duration: 201.802782ms)","trace[2076583449] 'compare' (duration: 54.396028ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:48:28.817509Z","caller":"traceutil/trace.go:171","msg":"trace[2014792723] transaction","detail":"{read_only:false; response_revision:983; number_of_response:1; }","duration":"256.294822ms","start":"2026-04-28T13:48:28.561172Z","end":"2026-04-28T13:48:28.817467Z","steps":["trace[2014792723] 'process raft request' (duration: 256.042789ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:48:28.817557Z","caller":"traceutil/trace.go:171","msg":"trace[992277990] transaction","detail":"{read_only:false; response_revision:984; number_of_response:1; }","duration":"256.21889ms","start":"2026-04-28T13:48:28.561301Z","end":"2026-04-28T13:48:28.81752Z","steps":["trace[992277990] 'process raft request' (duration: 255.961517ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:49:32.643578Z","caller":"traceutil/trace.go:171","msg":"trace[505939969] transaction","detail":"{read_only:false; response_revision:1196; number_of_response:1; }","duration":"155.025139ms","start":"2026-04-28T13:49:32.488527Z","end":"2026-04-28T13:49:32.643552Z","steps":["trace[505939969] 'process raft request' (duration: 154.821852ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:49:33.159358Z","caller":"traceutil/trace.go:171","msg":"trace[734257704] transaction","detail":"{read_only:false; response_revision:1197; number_of_response:1; }","duration":"126.627857ms","start":"2026-04-28T13:49:33.032694Z","end":"2026-04-28T13:49:33.159322Z","steps":["trace[734257704] 'process raft request' (duration: 126.406069ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:49:33.395121Z","caller":"traceutil/trace.go:171","msg":"trace[1906796987] transaction","detail":"{read_only:false; response_revision:1202; number_of_response:1; }","duration":"173.069703ms","start":"2026-04-28T13:49:33.222021Z","end":"2026-04-28T13:49:33.395091Z","steps":["trace[1906796987] 'process raft request' (duration: 165.060999ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:49:53.680408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.697249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-28T13:49:53.680494Z","caller":"traceutil/trace.go:171","msg":"trace[2062595732] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1283; }","duration":"170.853924ms","start":"2026-04-28T13:49:53.509621Z","end":"2026-04-28T13:49:53.680475Z","steps":["trace[2062595732] 'range keys from in-memory index tree' (duration: 170.444811ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:49:59.443309Z","caller":"traceutil/trace.go:171","msg":"trace[610665947] transaction","detail":"{read_only:false; response_revision:1317; number_of_response:1; }","duration":"133.211737ms","start":"2026-04-28T13:49:59.310056Z","end":"2026-04-28T13:49:59.443268Z","steps":["trace[610665947] 'process raft request' (duration: 53.453792ms)","trace[610665947] 'compare' (duration: 79.015041ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:50:01.502457Z","caller":"traceutil/trace.go:171","msg":"trace[276146583] transaction","detail":"{read_only:false; response_revision:1322; number_of_response:1; }","duration":"193.403021ms","start":"2026-04-28T13:50:01.309028Z","end":"2026-04-28T13:50:01.502431Z","steps":["trace[276146583] 'process raft request' (duration: 193.155033ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:50:03.677519Z","caller":"traceutil/trace.go:171","msg":"trace[1470138240] linearizableReadLoop","detail":"{readStateIndex:1386; appliedIndex:1385; }","duration":"143.365982ms","start":"2026-04-28T13:50:03.534128Z","end":"2026-04-28T13:50:03.677494Z","steps":["trace[1470138240] 'read index received' (duration: 143.315101ms)","trace[1470138240] 'applied index is now lower than readState.Index' (duration: 49.711µs)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:50:03.677735Z","caller":"traceutil/trace.go:171","msg":"trace[526106858] transaction","detail":"{read_only:false; response_revision:1331; number_of_response:1; }","duration":"148.617399ms","start":"2026-04-28T13:50:03.529073Z","end":"2026-04-28T13:50:03.677691Z","steps":["trace[526106858] 'process raft request' (duration: 148.256068ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:03.677825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.648352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-28T13:50:03.677867Z","caller":"traceutil/trace.go:171","msg":"trace[1694332087] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1331; }","duration":"143.770616ms","start":"2026-04-28T13:50:03.534082Z","end":"2026-04-28T13:50:03.677853Z","steps":["trace[1694332087] 'agreement among raft nodes before linearized reading' (duration: 143.513237ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:50:03.709071Z","caller":"traceutil/trace.go:171","msg":"trace[1527879971] transaction","detail":"{read_only:false; response_revision:1332; number_of_response:1; }","duration":"172.22757ms","start":"2026-04-28T13:50:03.536824Z","end":"2026-04-28T13:50:03.709051Z","steps":["trace[1527879971] 'process raft request' (duration: 172.078536ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:50:07.668869Z","caller":"traceutil/trace.go:171","msg":"trace[1266063284] transaction","detail":"{read_only:false; response_revision:1348; number_of_response:1; }","duration":"111.478374ms","start":"2026-04-28T13:50:07.557365Z","end":"2026-04-28T13:50:07.668843Z","steps":["trace[1266063284] 'process raft request' (duration: 85.342247ms)","trace[1266063284] 'compare' (duration: 25.697213ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:50:07.669112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.514208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:2577"} {"level":"info","ts":"2026-04-28T13:50:07.669138Z","caller":"traceutil/trace.go:171","msg":"trace[858471361] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:1349; }","duration":"112.610362ms","start":"2026-04-28T13:50:07.556522Z","end":"2026-04-28T13:50:07.669132Z","steps":["trace[858471361] 'agreement among raft nodes before linearized reading' (duration: 112.488968ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:50:08.20691Z","caller":"traceutil/trace.go:171","msg":"trace[1113897920] linearizableReadLoop","detail":"{readStateIndex:1406; appliedIndex:1405; }","duration":"473.783513ms","start":"2026-04-28T13:50:07.733096Z","end":"2026-04-28T13:50:08.206879Z","steps":["trace[1113897920] 'read index received' (duration: 378.538109ms)","trace[1113897920] 'applied index is now lower than readState.Index' (duration: 95.243614ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:50:08.206965Z","caller":"traceutil/trace.go:171","msg":"trace[1610344962] transaction","detail":"{read_only:false; response_revision:1350; number_of_response:1; }","duration":"473.937748ms","start":"2026-04-28T13:50:07.732984Z","end":"2026-04-28T13:50:08.206922Z","steps":["trace[1610344962] 'process raft request' (duration: 378.491148ms)","trace[1610344962] 'compare' (duration: 94.873931ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:50:08.207175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:50:07.732948Z","time spent":"474.128354ms","remote":"127.0.0.1:39438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T13:50:08.207341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.224637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-28T13:50:08.20737Z","caller":"traceutil/trace.go:171","msg":"trace[827134697] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1350; }","duration":"474.294579ms","start":"2026-04-28T13:50:07.733068Z","end":"2026-04-28T13:50:08.207363Z","steps":["trace[827134697] 'agreement among raft nodes before linearized reading' (duration: 473.939808ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:08.207398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:50:07.733057Z","time spent":"474.33512ms","remote":"127.0.0.1:39438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-28T13:50:08.224931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.533788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:50:08.224969Z","caller":"traceutil/trace.go:171","msg":"trace[2003927640] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1351; }","duration":"240.61103ms","start":"2026-04-28T13:50:07.984347Z","end":"2026-04-28T13:50:08.224958Z","steps":["trace[2003927640] 'agreement among raft nodes before linearized reading' (duration: 240.529467ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:50:08.22506Z","caller":"traceutil/trace.go:171","msg":"trace[221201933] transaction","detail":"{read_only:false; response_revision:1351; number_of_response:1; }","duration":"359.717644ms","start":"2026-04-28T13:50:07.865225Z","end":"2026-04-28T13:50:08.224943Z","steps":["trace[221201933] 'process raft request' (duration: 359.446565ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:08.225045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.218445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-28T13:50:08.225338Z","caller":"traceutil/trace.go:171","msg":"trace[2137611783] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1351; }","duration":"459.571035ms","start":"2026-04-28T13:50:07.765745Z","end":"2026-04-28T13:50:08.225316Z","steps":["trace[2137611783] 'agreement among raft nodes before linearized reading' (duration: 459.09868ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:08.225395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:50:07.765714Z","time spent":"459.668028ms","remote":"127.0.0.1:39438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-28T13:50:08.225165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.832091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-28T13:50:08.225498Z","caller":"traceutil/trace.go:171","msg":"trace[514298103] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1351; }","duration":"419.212293ms","start":"2026-04-28T13:50:07.806265Z","end":"2026-04-28T13:50:08.225477Z","steps":["trace[514298103] 'agreement among raft nodes before linearized reading' (duration: 418.714228ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:08.225559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:50:07.806246Z","time spent":"419.299866ms","remote":"127.0.0.1:39438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-28T13:50:08.225457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:50:07.865191Z","time spent":"360.048514ms","remote":"127.0.0.1:39438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T13:50:08.644576Z","caller":"traceutil/trace.go:171","msg":"trace[1974255741] transaction","detail":"{read_only:false; response_revision:1353; number_of_response:1; }","duration":"415.094167ms","start":"2026-04-28T13:50:08.229458Z","end":"2026-04-28T13:50:08.644553Z","steps":["trace[1974255741] 'process raft request' (duration: 411.94298ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:08.644737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:50:08.22945Z","time spent":"415.19737ms","remote":"127.0.0.1:39438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T13:50:08.645139Z","caller":"traceutil/trace.go:171","msg":"trace[2064722501] transaction","detail":"{read_only:false; response_revision:1354; number_of_response:1; }","duration":"415.041676ms","start":"2026-04-28T13:50:08.230074Z","end":"2026-04-28T13:50:08.645116Z","steps":["trace[2064722501] 'process raft request' (duration: 414.429427ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:08.645289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:50:08.230065Z","time spent":"415.143999ms","remote":"127.0.0.1:39438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T13:50:14.777771Z","caller":"traceutil/trace.go:171","msg":"trace[1290206235] transaction","detail":"{read_only:false; response_revision:1377; number_of_response:1; }","duration":"102.458394ms","start":"2026-04-28T13:50:14.675273Z","end":"2026-04-28T13:50:14.777731Z","steps":["trace[1290206235] 'process raft request' (duration: 102.291269ms)"],"step_count":1}