{"level":"warn","ts":"2026-03-25T21:01:49.539275Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-25T21:01:49.539374Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.156: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.156:2380","--initial-cluster=instance=https://199.204.45.156:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.156:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.156: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-03-25T21:01:49.539454Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-25T21:01:49.539466Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.156:2380"]} {"level":"info","ts":"2026-03-25T21:01:49.539489Z","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-03-25T21:01:49.5403Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"]} {"level":"info","ts":"2026-03-25T21:01:49.540388Z","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.156:2380"],"listen-peer-urls":["https://199.204.45.156:2380"],"advertise-client-urls":["https://199.204.45.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.156: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-03-25T21:01:49.547786Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.168797ms"} {"level":"info","ts":"2026-03-25T21:01:49.5637Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5ac240a6daec2148","cluster-id":"62163637a46c33c2"} {"level":"info","ts":"2026-03-25T21:01:49.563852Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=()"} {"level":"info","ts":"2026-03-25T21:01:49.563891Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became follower at term 0"} {"level":"info","ts":"2026-03-25T21:01:49.563946Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5ac240a6daec2148 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-03-25T21:01:49.563978Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became follower at term 1"} {"level":"info","ts":"2026-03-25T21:01:49.564086Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=(6539860694277038408)"} {"level":"warn","ts":"2026-03-25T21:01:49.572593Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-25T21:01:49.57403Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-25T21:01:49.575234Z","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-03-25T21:01:49.578099Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5ac240a6daec2148","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-03-25T21:01:49.578441Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5ac240a6daec2148","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-03-25T21:01:49.57859Z","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-03-25T21:01:49.578653Z","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-03-25T21:01:49.578662Z","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-03-25T21:01:49.579347Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=(6539860694277038408)"} {"level":"info","ts":"2026-03-25T21:01:49.579516Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"62163637a46c33c2","local-member-id":"5ac240a6daec2148","added-peer-id":"5ac240a6daec2148","added-peer-peer-urls":["https://199.204.45.156:2380"]} {"level":"info","ts":"2026-03-25T21:01:49.585905Z","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-03-25T21:01:49.585984Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.156:2380"} {"level":"info","ts":"2026-03-25T21:01:49.586184Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.156:2380"} {"level":"info","ts":"2026-03-25T21:01:49.586416Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5ac240a6daec2148","initial-advertise-peer-urls":["https://199.204.45.156:2380"],"listen-peer-urls":["https://199.204.45.156:2380"],"advertise-client-urls":["https://199.204.45.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-03-25T21:01:49.586526Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-25T21:01:49.664356Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 is starting a new election at term 1"} {"level":"info","ts":"2026-03-25T21:01:49.664399Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became pre-candidate at term 1"} {"level":"info","ts":"2026-03-25T21:01:49.664434Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 received MsgPreVoteResp from 5ac240a6daec2148 at term 1"} {"level":"info","ts":"2026-03-25T21:01:49.664466Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became candidate at term 2"} {"level":"info","ts":"2026-03-25T21:01:49.6646Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 received MsgVoteResp from 5ac240a6daec2148 at term 2"} {"level":"info","ts":"2026-03-25T21:01:49.664614Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became leader at term 2"} {"level":"info","ts":"2026-03-25T21:01:49.664624Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5ac240a6daec2148 elected leader 5ac240a6daec2148 at term 2"} {"level":"info","ts":"2026-03-25T21:01:49.665435Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5ac240a6daec2148","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.156:2379]}","request-path":"/0/members/5ac240a6daec2148/attributes","cluster-id":"62163637a46c33c2","publish-timeout":"7s"} {"level":"info","ts":"2026-03-25T21:01:49.665579Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-25T21:01:49.665641Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-25T21:01:49.667745Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-03-25T21:01:49.668981Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.156:2379"} {"level":"info","ts":"2026-03-25T21:01:49.665538Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-03-25T21:01:49.672748Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-25T21:01:49.676569Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-03-25T21:01:49.676654Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"62163637a46c33c2","local-member-id":"5ac240a6daec2148","cluster-version":"3.5"} {"level":"info","ts":"2026-03-25T21:01:49.676879Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-03-25T21:01:49.676981Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-03-25T21:01:51.923516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"608.365736ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-03-25T21:01:51.92381Z","caller":"traceutil/trace.go:171","msg":"trace[337782797] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"633.425866ms","start":"2026-03-25T21:01:51.290363Z","end":"2026-03-25T21:01:51.923789Z","steps":["trace[337782797] 'process raft request' (duration: 633.383145ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:01:51.92393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:01:51.29035Z","time spent":"633.517647ms","remote":"127.0.0.1:45570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-25T21:01:51.923976Z","caller":"traceutil/trace.go:171","msg":"trace[1186725342] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"633.69734ms","start":"2026-03-25T21:01:51.290153Z","end":"2026-03-25T21:01:51.923851Z","steps":["trace[1186725342] 'process raft request' (duration: 633.536218ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:01:51.924077Z","caller":"traceutil/trace.go:171","msg":"trace[1984457845] transaction","detail":"{read_only:false; number_of_response:0; response_revision:10; }","duration":"634.140415ms","start":"2026-03-25T21:01:51.289883Z","end":"2026-03-25T21:01:51.924023Z","steps":["trace[1984457845] 'process raft request' (duration: 633.76682ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:01:51.924127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:01:51.29014Z","time spent":"633.902912ms","remote":"127.0.0.1:45634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-25T21:01:51.924254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:01:51.289865Z","time spent":"634.323397ms","remote":"127.0.0.1:45244","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":26,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-25T21:01:51.92441Z","caller":"traceutil/trace.go:171","msg":"trace[2147092947] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"636.369504ms","start":"2026-03-25T21:01:51.28744Z","end":"2026-03-25T21:01:51.923809Z","steps":["trace[2147092947] 'process raft request' (duration: 27.197688ms)","trace[2147092947] 'compare' (duration: 608.232414ms)"],"step_count":2} {"level":"warn","ts":"2026-03-25T21:01:51.924739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:01:51.287378Z","time spent":"637.177385ms","remote":"127.0.0.1:45634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-25T21:01:52.812136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"589.096659ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-03-25T21:01:52.81247Z","caller":"traceutil/trace.go:171","msg":"trace[106480193] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"1.515035635s","start":"2026-03-25T21:01:51.297383Z","end":"2026-03-25T21:01:52.812419Z","steps":["trace[106480193] 'process raft request' (duration: 925.591912ms)","trace[106480193] 'compare' (duration: 588.963217ms)"],"step_count":2} {"level":"info","ts":"2026-03-25T21:01:52.812533Z","caller":"traceutil/trace.go:171","msg":"trace[1046641484] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"1.514628589s","start":"2026-03-25T21:01:51.297854Z","end":"2026-03-25T21:01:52.812482Z","steps":["trace[1046641484] 'process raft request' (duration: 1.514469667s)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:01:52.812663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:01:51.297355Z","time spent":"1.515188767s","remote":"127.0.0.1:45324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3159,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-25T21:01:52.812693Z","caller":"traceutil/trace.go:171","msg":"trace[852804454] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"1.513069089s","start":"2026-03-25T21:01:51.299589Z","end":"2026-03-25T21:01:52.812658Z","steps":["trace[852804454] 'process raft request' (duration: 1.512811106s)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:01:52.812772Z","caller":"traceutil/trace.go:171","msg":"trace[1442219577] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"1.507580928s","start":"2026-03-25T21:01:51.305177Z","end":"2026-03-25T21:01:52.812758Z","steps":["trace[1442219577] 'process raft request' (duration: 1.507287654s)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:01:52.812782Z","caller":"traceutil/trace.go:171","msg":"trace[1161735282] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"1.510384494s","start":"2026-03-25T21:01:51.302387Z","end":"2026-03-25T21:01:52.812772Z","steps":["trace[1161735282] 'process raft request' (duration: 1.510039719s)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:01:52.812832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:01:51.302372Z","time spent":"1.510435844s","remote":"127.0.0.1:45634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":923,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-25T21:01:52.812835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:01:51.305166Z","time spent":"1.507638568s","remote":"127.0.0.1:45384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-25T21:01:52.812844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:01:51.299573Z","time spent":"1.513196041s","remote":"127.0.0.1:45634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-25T21:01:52.812797Z","caller":"traceutil/trace.go:171","msg":"trace[549079691] linearizableReadLoop","detail":"{readStateIndex:18; appliedIndex:12; }","duration":"1.514485427s","start":"2026-03-25T21:01:51.298189Z","end":"2026-03-25T21:01:52.812675Z","steps":["trace[549079691] 'read index received' (duration: 16.466757ms)","trace[549079691] 'applied index is now lower than readState.Index' (duration: 1.497871729s)"],"step_count":2} {"level":"warn","ts":"2026-03-25T21:01:52.812715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:01:51.297844Z","time spent":"1.514805351s","remote":"127.0.0.1:45634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-25T21:01:52.81295Z","caller":"traceutil/trace.go:171","msg":"trace[12161550] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"1.499073395s","start":"2026-03-25T21:01:51.313866Z","end":"2026-03-25T21:01:52.812939Z","steps":["trace[12161550] 'process raft request' (duration: 1.498628669s)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:01:52.813002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:01:51.313849Z","time spent":"1.499129235s","remote":"127.0.0.1:45398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-25T21:01:52.813101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.514901043s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-03-25T21:01:52.81315Z","caller":"traceutil/trace.go:171","msg":"trace[742028931] range","detail":"{range_begin:/registry/resourcequotas/kube-public/; range_end:/registry/resourcequotas/kube-public0; response_count:0; response_revision:18; }","duration":"1.514988473s","start":"2026-03-25T21:01:51.298146Z","end":"2026-03-25T21:01:52.813134Z","steps":["trace[742028931] 'agreement among raft nodes before linearized reading' (duration: 1.514871132s)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:01:52.813183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:01:51.298133Z","time spent":"1.515041944s","remote":"127.0.0.1:45212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":26,"request content":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" "} {"level":"info","ts":"2026-03-25T21:01:52.983621Z","caller":"traceutil/trace.go:171","msg":"trace[399386876] linearizableReadLoop","detail":"{readStateIndex:26; appliedIndex:22; }","duration":"170.647944ms","start":"2026-03-25T21:01:52.812945Z","end":"2026-03-25T21:01:52.983593Z","steps":["trace[399386876] 'read index received' (duration: 106.417797ms)","trace[399386876] 'applied index is now lower than readState.Index' (duration: 64.228747ms)"],"step_count":2} {"level":"warn","ts":"2026-03-25T21:01:52.983824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"748.88767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-03-25T21:01:52.98382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"696.169773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-03-25T21:01:52.983876Z","caller":"traceutil/trace.go:171","msg":"trace[1012690933] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:22; }","duration":"749.090683ms","start":"2026-03-25T21:01:52.234772Z","end":"2026-03-25T21:01:52.983862Z","steps":["trace[1012690933] 'agreement among raft nodes before linearized reading' (duration: 748.987282ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:01:52.983939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:01:52.234759Z","time spent":"749.170164ms","remote":"127.0.0.1:45120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-25T21:01:52.983933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"800.558804ms","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-03-25T21:01:52.983993Z","caller":"traceutil/trace.go:171","msg":"trace[819435954] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"1.055680697s","start":"2026-03-25T21:01:51.928301Z","end":"2026-03-25T21:01:52.983982Z","steps":["trace[819435954] 'process raft request' (duration: 1.05514514s)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:01:52.984008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.058716027s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-03-25T21:01:52.984015Z","caller":"traceutil/trace.go:171","msg":"trace[1313343651] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:22; }","duration":"800.681875ms","start":"2026-03-25T21:01:52.183312Z","end":"2026-03-25T21:01:52.983994Z","steps":["trace[1313343651] 'agreement among raft nodes before linearized reading' (duration: 800.535713ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:01:52.984054Z","caller":"traceutil/trace.go:171","msg":"trace[1853516366] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:22; }","duration":"1.058747307s","start":"2026-03-25T21:01:51.925286Z","end":"2026-03-25T21:01:52.984033Z","steps":["trace[1853516366] 'agreement among raft nodes before linearized reading' (duration: 1.058684847s)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:01:52.98409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:01:51.92828Z","time spent":"1.055757099s","remote":"127.0.0.1:45570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":716,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-25T21:01:52.984118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"800.344301ms","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-03-25T21:01:52.984149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.514745523s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-03-25T21:01:52.984153Z","caller":"traceutil/trace.go:171","msg":"trace[1272439745] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:22; }","duration":"800.380702ms","start":"2026-03-25T21:01:52.183764Z","end":"2026-03-25T21:01:52.984144Z","steps":["trace[1272439745] 'agreement among raft nodes before linearized reading' (duration: 800.31476ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:01:52.983903Z","caller":"traceutil/trace.go:171","msg":"trace[1222824146] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:22; }","duration":"696.295444ms","start":"2026-03-25T21:01:52.28758Z","end":"2026-03-25T21:01:52.983876Z","steps":["trace[1222824146] 'agreement among raft nodes before linearized reading' (duration: 696.081752ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:01:52.984188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:01:52.183697Z","time spent":"800.483183ms","remote":"127.0.0.1:45474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":26,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" "} {"level":"warn","ts":"2026-03-25T21:01:52.984227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:01:52.287558Z","time spent":"696.659441ms","remote":"127.0.0.1:45112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-03-25T21:01:52.984184Z","caller":"traceutil/trace.go:171","msg":"trace[1515173663] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:22; }","duration":"1.514808993s","start":"2026-03-25T21:01:51.469365Z","end":"2026-03-25T21:01:52.984174Z","steps":["trace[1515173663] 'agreement among raft nodes before linearized reading' (duration: 1.514762133s)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:01:52.984382Z","caller":"traceutil/trace.go:171","msg":"trace[298104715] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"1.055707079s","start":"2026-03-25T21:01:51.928665Z","end":"2026-03-25T21:01:52.984372Z","steps":["trace[298104715] 'process raft request' (duration: 1.054819527s)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:01:52.984401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:01:51.469353Z","time spent":"1.515038406s","remote":"127.0.0.1:45398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":26,"request content":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" "} {"level":"warn","ts":"2026-03-25T21:01:52.984461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:01:51.928641Z","time spent":"1.055768639s","remote":"127.0.0.1:45634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-25T21:01:52.984097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:01:51.925271Z","time spent":"1.058819479s","remote":"127.0.0.1:45244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":372,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-03-25T21:01:52.984057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:01:52.183295Z","time spent":"800.752766ms","remote":"127.0.0.1:45480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":26,"request content":"key:\"/registry/priorityclasses/system-node-critical\" "} {"level":"warn","ts":"2026-03-25T21:01:52.983936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.444350126s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-03-25T21:01:52.983543Z","caller":"traceutil/trace.go:171","msg":"trace[1869096656] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"1.055271992s","start":"2026-03-25T21:01:51.928244Z","end":"2026-03-25T21:01:52.983516Z","steps":["trace[1869096656] 'process raft request' (duration: 1.055160861s)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:01:52.98466Z","caller":"traceutil/trace.go:171","msg":"trace[2113050266] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:22; }","duration":"1.445111387s","start":"2026-03-25T21:01:51.539536Z","end":"2026-03-25T21:01:52.984648Z","steps":["trace[2113050266] 'agreement among raft nodes before linearized reading' (duration: 1.444270346s)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:01:52.984765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:01:51.539523Z","time spent":"1.445169688s","remote":"127.0.0.1:45508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":26,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-03-25T21:01:52.984808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:01:51.928225Z","time spent":"1.056465818s","remote":"127.0.0.1:45634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-25T21:01:52.985216Z","caller":"traceutil/trace.go:171","msg":"trace[477521757] transaction","detail":"{read_only:false; response_revision:23; number_of_response:1; }","duration":"169.56612ms","start":"2026-03-25T21:01:52.815609Z","end":"2026-03-25T21:01:52.985175Z","steps":["trace[477521757] 'process raft request' (duration: 168.130731ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:01:52.985342Z","caller":"traceutil/trace.go:171","msg":"trace[1310095602] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"166.704883ms","start":"2026-03-25T21:01:52.818628Z","end":"2026-03-25T21:01:52.985333Z","steps":["trace[1310095602] 'process raft request' (duration: 166.45949ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:01:52.985529Z","caller":"traceutil/trace.go:171","msg":"trace[2052435265] transaction","detail":"{read_only:false; response_revision:26; number_of_response:1; }","duration":"165.855871ms","start":"2026-03-25T21:01:52.819664Z","end":"2026-03-25T21:01:52.98552Z","steps":["trace[2052435265] 'process raft request' (duration: 165.528257ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:01:52.985625Z","caller":"traceutil/trace.go:171","msg":"trace[1111668427] transaction","detail":"{read_only:false; response_revision:25; number_of_response:1; }","duration":"166.902795ms","start":"2026-03-25T21:01:52.818707Z","end":"2026-03-25T21:01:52.98561Z","steps":["trace[1111668427] 'process raft request' (duration: 166.44896ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:01:52.985823Z","caller":"traceutil/trace.go:171","msg":"trace[2124423581] transaction","detail":"{read_only:false; response_revision:27; number_of_response:1; }","duration":"161.072509ms","start":"2026-03-25T21:01:52.824734Z","end":"2026-03-25T21:01:52.985806Z","steps":["trace[2124423581] 'process raft request' (duration: 160.502522ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:01:52.98588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.168629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-03-25T21:01:52.985919Z","caller":"traceutil/trace.go:171","msg":"trace[885625169] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:27; }","duration":"167.247279ms","start":"2026-03-25T21:01:52.818663Z","end":"2026-03-25T21:01:52.98591Z","steps":["trace[885625169] 'agreement among raft nodes before linearized reading' (duration: 167.182268ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:01:52.986058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.575119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-nwqv5\" ","response":"range_response_count:1 size:861"} {"level":"info","ts":"2026-03-25T21:01:52.986255Z","caller":"traceutil/trace.go:171","msg":"trace[297101127] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-nwqv5; range_end:; response_count:1; response_revision:27; }","duration":"169.776382ms","start":"2026-03-25T21:01:52.816359Z","end":"2026-03-25T21:01:52.986135Z","steps":["trace[297101127] 'agreement among raft nodes before linearized reading' (duration: 169.436998ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:01:52.986773Z","caller":"traceutil/trace.go:171","msg":"trace[562001636] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"1.651023113s","start":"2026-03-25T21:01:51.335731Z","end":"2026-03-25T21:01:52.986755Z","steps":["trace[562001636] 'process raft request' (duration: 1.583619235s)","trace[562001636] 'compare' (duration: 63.883862ms)"],"step_count":2} {"level":"warn","ts":"2026-03-25T21:01:52.986895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:01:51.335717Z","time spent":"1.651096684s","remote":"127.0.0.1:45230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":357,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-25T21:01:59.307729Z","caller":"traceutil/trace.go:171","msg":"trace[265736371] linearizableReadLoop","detail":"{readStateIndex:313; appliedIndex:312; }","duration":"125.436779ms","start":"2026-03-25T21:01:59.182271Z","end":"2026-03-25T21:01:59.307708Z","steps":["trace[265736371] 'read index received' (duration: 125.263677ms)","trace[265736371] 'applied index is now lower than readState.Index' (duration: 172.192µs)"],"step_count":2} {"level":"info","ts":"2026-03-25T21:01:59.307795Z","caller":"traceutil/trace.go:171","msg":"trace[284261889] transaction","detail":"{read_only:false; response_revision:304; number_of_response:1; }","duration":"136.870461ms","start":"2026-03-25T21:01:59.170895Z","end":"2026-03-25T21:01:59.307765Z","steps":["trace[284261889] 'process raft request' (duration: 136.670959ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:01:59.307907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.608391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:1 size:535"} {"level":"info","ts":"2026-03-25T21:01:59.307942Z","caller":"traceutil/trace.go:171","msg":"trace[200504856] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:1; response_revision:304; }","duration":"125.688363ms","start":"2026-03-25T21:01:59.182245Z","end":"2026-03-25T21:01:59.307933Z","steps":["trace[200504856] 'agreement among raft nodes before linearized reading' (duration: 125.598412ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:01:59.30807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.369277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-03-25T21:01:59.308165Z","caller":"traceutil/trace.go:171","msg":"trace[1878231097] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:304; }","duration":"120.513618ms","start":"2026-03-25T21:01:59.187628Z","end":"2026-03-25T21:01:59.308141Z","steps":["trace[1878231097] 'agreement among raft nodes before linearized reading' (duration: 120.282426ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:02:05.282917Z","caller":"traceutil/trace.go:171","msg":"trace[175652977] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"142.622004ms","start":"2026-03-25T21:02:05.140266Z","end":"2026-03-25T21:02:05.282888Z","steps":["trace[175652977] 'process raft request' (duration: 142.26696ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:05.800093Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2398339591560527689,"retry-timeout":"500ms"} {"level":"info","ts":"2026-03-25T21:02:05.882189Z","caller":"traceutil/trace.go:171","msg":"trace[305992277] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"592.525939ms","start":"2026-03-25T21:02:05.289632Z","end":"2026-03-25T21:02:05.882158Z","steps":["trace[305992277] 'process raft request' (duration: 592.242166ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:05.882731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:05.2896Z","time spent":"592.674771ms","remote":"127.0.0.1:45326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4649,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-25T21:02:05.894175Z","caller":"traceutil/trace.go:171","msg":"trace[444258168] linearizableReadLoop","detail":"{readStateIndex:384; appliedIndex:383; }","duration":"594.492752ms","start":"2026-03-25T21:02:05.299659Z","end":"2026-03-25T21:02:05.894152Z","steps":["trace[444258168] 'read index received' (duration: 582.765203ms)","trace[444258168] 'applied index is now lower than readState.Index' (duration: 11.726439ms)"],"step_count":2} {"level":"info","ts":"2026-03-25T21:02:05.894362Z","caller":"traceutil/trace.go:171","msg":"trace[238840615] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"271.190182ms","start":"2026-03-25T21:02:05.623071Z","end":"2026-03-25T21:02:05.894261Z","steps":["trace[238840615] 'process raft request' (duration: 270.937159ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:05.894418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.029973ms","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-03-25T21:02:05.894417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"594.747615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4369"} {"level":"info","ts":"2026-03-25T21:02:05.894465Z","caller":"traceutil/trace.go:171","msg":"trace[1260330793] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:373; }","duration":"390.137425ms","start":"2026-03-25T21:02:05.504312Z","end":"2026-03-25T21:02:05.894449Z","steps":["trace[1260330793] 'agreement among raft nodes before linearized reading' (duration: 390.044823ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:02:05.894478Z","caller":"traceutil/trace.go:171","msg":"trace[343699514] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:373; }","duration":"594.874727ms","start":"2026-03-25T21:02:05.299588Z","end":"2026-03-25T21:02:05.894463Z","steps":["trace[343699514] 'agreement among raft nodes before linearized reading' (duration: 594.717995ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:05.894506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:05.50426Z","time spent":"390.237126ms","remote":"127.0.0.1:45398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-03-25T21:02:05.894506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:05.299567Z","time spent":"594.932097ms","remote":"127.0.0.1:45324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4391,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-03-25T21:02:05.894583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.877969ms","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-03-25T21:02:05.894565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.769825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:02:05.89463Z","caller":"traceutil/trace.go:171","msg":"trace[1454013329] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:373; }","duration":"164.966679ms","start":"2026-03-25T21:02:05.729652Z","end":"2026-03-25T21:02:05.894618Z","steps":["trace[1454013329] 'agreement among raft nodes before linearized reading' (duration: 164.880538ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:02:05.894641Z","caller":"traceutil/trace.go:171","msg":"trace[368740444] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:373; }","duration":"227.909877ms","start":"2026-03-25T21:02:05.666721Z","end":"2026-03-25T21:02:05.894631Z","steps":["trace[368740444] 'agreement among raft nodes before linearized reading' (duration: 227.815856ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:05.894497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.173422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-03-25T21:02:05.895508Z","caller":"traceutil/trace.go:171","msg":"trace[1104663374] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:373; }","duration":"150.231494ms","start":"2026-03-25T21:02:05.745248Z","end":"2026-03-25T21:02:05.89548Z","steps":["trace[1104663374] 'agreement among raft nodes before linearized reading' (duration: 149.140442ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:07.788538Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2398339591560527702,"retry-timeout":"500ms"} {"level":"info","ts":"2026-03-25T21:02:07.889226Z","caller":"traceutil/trace.go:171","msg":"trace[28644040] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"669.026314ms","start":"2026-03-25T21:02:07.220155Z","end":"2026-03-25T21:02:07.889181Z","steps":["trace[28644040] 'process raft request' (duration: 668.736621ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:02:07.889415Z","caller":"traceutil/trace.go:171","msg":"trace[2076695561] linearizableReadLoop","detail":"{readStateIndex:390; appliedIndex:389; }","duration":"601.453401ms","start":"2026-03-25T21:02:07.287634Z","end":"2026-03-25T21:02:07.889087Z","steps":["trace[2076695561] 'read index received' (duration: 601.115887ms)","trace[2076695561] 'applied index is now lower than readState.Index' (duration: 336.594µs)"],"step_count":2} {"level":"warn","ts":"2026-03-25T21:02:07.889448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"601.789705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-03-25T21:02:07.889537Z","caller":"traceutil/trace.go:171","msg":"trace[1524724435] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:379; }","duration":"601.930397ms","start":"2026-03-25T21:02:07.287578Z","end":"2026-03-25T21:02:07.889509Z","steps":["trace[1524724435] 'agreement among raft nodes before linearized reading' (duration: 601.739765ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:07.889593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"550.954877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4056"} {"level":"warn","ts":"2026-03-25T21:02:07.889595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:07.287552Z","time spent":"602.033858ms","remote":"127.0.0.1:45398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-03-25T21:02:07.889615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:07.220126Z","time spent":"669.219336ms","remote":"127.0.0.1:45326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5321,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-25T21:02:07.889703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.063488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:02:07.889741Z","caller":"traceutil/trace.go:171","msg":"trace[104630902] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:379; }","duration":"223.138509ms","start":"2026-03-25T21:02:07.666591Z","end":"2026-03-25T21:02:07.889729Z","steps":["trace[104630902] 'agreement among raft nodes before linearized reading' (duration: 223.087499ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:02:07.889636Z","caller":"traceutil/trace.go:171","msg":"trace[264394032] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:379; }","duration":"551.041378ms","start":"2026-03-25T21:02:07.338583Z","end":"2026-03-25T21:02:07.889624Z","steps":["trace[264394032] 'agreement among raft nodes before linearized reading' (duration: 550.951857ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:07.890171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:07.338563Z","time spent":"551.565365ms","remote":"127.0.0.1:45574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":4078,"request content":"key:\"/registry/deployments/kube-system/coredns\" "} {"level":"info","ts":"2026-03-25T21:02:10.040101Z","caller":"traceutil/trace.go:171","msg":"trace[2140629436] linearizableReadLoop","detail":"{readStateIndex:428; appliedIndex:427; }","duration":"120.880831ms","start":"2026-03-25T21:02:09.919198Z","end":"2026-03-25T21:02:10.040079Z","steps":["trace[2140629436] 'read index received' (duration: 120.659008ms)","trace[2140629436] 'applied index is now lower than readState.Index' (duration: 220.423µs)"],"step_count":2} {"level":"info","ts":"2026-03-25T21:02:10.040151Z","caller":"traceutil/trace.go:171","msg":"trace[447957771] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"132.210792ms","start":"2026-03-25T21:02:09.90792Z","end":"2026-03-25T21:02:10.040131Z","steps":["trace[447957771] 'process raft request' (duration: 132.01828ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:10.04026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.931571ms","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-03-25T21:02:10.040259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.038303ms","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-03-25T21:02:10.040347Z","caller":"traceutil/trace.go:171","msg":"trace[1725507002] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:414; }","duration":"121.154564ms","start":"2026-03-25T21:02:09.919168Z","end":"2026-03-25T21:02:10.040323Z","steps":["trace[1725507002] 'agreement among raft nodes before linearized reading' (duration: 121.001482ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:02:10.040344Z","caller":"traceutil/trace.go:171","msg":"trace[10744257] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:414; }","duration":"120.031151ms","start":"2026-03-25T21:02:09.920274Z","end":"2026-03-25T21:02:10.040306Z","steps":["trace[10744257] 'agreement among raft nodes before linearized reading' (duration: 119.93186ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:10.040481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.16574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-03-25T21:02:10.040624Z","caller":"traceutil/trace.go:171","msg":"trace[274232107] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:414; }","duration":"118.345762ms","start":"2026-03-25T21:02:09.922248Z","end":"2026-03-25T21:02:10.040594Z","steps":["trace[274232107] 'agreement among raft nodes before linearized reading' (duration: 118.035968ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:02:16.297118Z","caller":"traceutil/trace.go:171","msg":"trace[1224222778] transaction","detail":"{read_only:false; response_revision:432; number_of_response:1; }","duration":"175.939463ms","start":"2026-03-25T21:02:16.121143Z","end":"2026-03-25T21:02:16.297082Z","steps":["trace[1224222778] 'process raft request' (duration: 175.870652ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:02:16.29751Z","caller":"traceutil/trace.go:171","msg":"trace[143981774] transaction","detail":"{read_only:false; response_revision:431; number_of_response:1; }","duration":"178.879546ms","start":"2026-03-25T21:02:16.118587Z","end":"2026-03-25T21:02:16.297467Z","steps":["trace[143981774] 'process raft request' (duration: 119.622051ms)","trace[143981774] 'compare' (duration: 58.564576ms)"],"step_count":2} {"level":"info","ts":"2026-03-25T21:02:21.162951Z","caller":"traceutil/trace.go:171","msg":"trace[1621513563] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"285.289168ms","start":"2026-03-25T21:02:20.877626Z","end":"2026-03-25T21:02:21.162915Z","steps":["trace[1621513563] 'process raft request' (duration: 285.161636ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:02:21.175786Z","caller":"traceutil/trace.go:171","msg":"trace[1785593001] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"292.332924ms","start":"2026-03-25T21:02:20.883393Z","end":"2026-03-25T21:02:21.175726Z","steps":["trace[1785593001] 'process raft request' (duration: 292.162312ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:02:21.175946Z","caller":"traceutil/trace.go:171","msg":"trace[971347943] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"290.325882ms","start":"2026-03-25T21:02:20.885605Z","end":"2026-03-25T21:02:21.175931Z","steps":["trace[971347943] 'process raft request' (duration: 290.032939ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:02:21.176297Z","caller":"traceutil/trace.go:171","msg":"trace[1845248830] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"285.328088ms","start":"2026-03-25T21:02:20.890941Z","end":"2026-03-25T21:02:21.176269Z","steps":["trace[1845248830] 'process raft request' (duration: 285.223627ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:02:21.176457Z","caller":"traceutil/trace.go:171","msg":"trace[1705813738] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"284.813142ms","start":"2026-03-25T21:02:20.891621Z","end":"2026-03-25T21:02:21.176434Z","steps":["trace[1705813738] 'process raft request' (duration: 284.592539ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:02:21.176631Z","caller":"traceutil/trace.go:171","msg":"trace[411571282] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"278.545323ms","start":"2026-03-25T21:02:20.898076Z","end":"2026-03-25T21:02:21.176621Z","steps":["trace[411571282] 'process raft request' (duration: 278.28854ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:02:21.177454Z","caller":"traceutil/trace.go:171","msg":"trace[1825560475] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"278.078639ms","start":"2026-03-25T21:02:20.899227Z","end":"2026-03-25T21:02:21.177305Z","steps":["trace[1825560475] 'process raft request' (duration: 277.211359ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:02:21.177823Z","caller":"traceutil/trace.go:171","msg":"trace[1792011308] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"284.258016ms","start":"2026-03-25T21:02:20.893235Z","end":"2026-03-25T21:02:21.177493Z","steps":["trace[1792011308] 'process raft request' (duration: 283.059352ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:02:21.178707Z","caller":"traceutil/trace.go:171","msg":"trace[780756632] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"263.870921ms","start":"2026-03-25T21:02:20.914789Z","end":"2026-03-25T21:02:21.17866Z","steps":["trace[780756632] 'process raft request' (duration: 261.703977ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:02:21.17878Z","caller":"traceutil/trace.go:171","msg":"trace[512227619] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"256.116605ms","start":"2026-03-25T21:02:20.922616Z","end":"2026-03-25T21:02:21.178732Z","steps":["trace[512227619] 'process raft request' (duration: 253.916961ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:02:21.181758Z","caller":"traceutil/trace.go:171","msg":"trace[846814910] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"136.540368ms","start":"2026-03-25T21:02:21.045192Z","end":"2026-03-25T21:02:21.181732Z","steps":["trace[846814910] 'process raft request' (duration: 136.369026ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:02:21.181999Z","caller":"traceutil/trace.go:171","msg":"trace[2084666784] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"249.785505ms","start":"2026-03-25T21:02:20.932198Z","end":"2026-03-25T21:02:21.181984Z","steps":["trace[2084666784] 'process raft request' (duration: 247.215537ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:22.154962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"797.221186ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-25T21:02:22.155406Z","caller":"traceutil/trace.go:171","msg":"trace[427797702] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"914.473544ms","start":"2026-03-25T21:02:21.240882Z","end":"2026-03-25T21:02:22.155356Z","steps":["trace[427797702] 'process raft request' (duration: 116.448229ms)","trace[427797702] 'compare' (duration: 797.056383ms)"],"step_count":2} {"level":"info","ts":"2026-03-25T21:02:22.155636Z","caller":"traceutil/trace.go:171","msg":"trace[2110723095] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"907.88745ms","start":"2026-03-25T21:02:21.247726Z","end":"2026-03-25T21:02:22.155614Z","steps":["trace[2110723095] 'process raft request' (duration: 907.601917ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:22.15564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:21.240875Z","time spent":"914.631975ms","remote":"127.0.0.1:45166","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9125,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-25T21:02:22.155738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:21.247706Z","time spent":"907.980631ms","remote":"127.0.0.1:45166","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79947,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-25T21:02:22.156254Z","caller":"traceutil/trace.go:171","msg":"trace[1062961287] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"907.606538ms","start":"2026-03-25T21:02:21.247975Z","end":"2026-03-25T21:02:22.155582Z","steps":["trace[1062961287] 'process raft request' (duration: 907.495347ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:22.156351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:21.247969Z","time spent":"908.349726ms","remote":"127.0.0.1:45166","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17062,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-25T21:02:22.165363Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2398339591560527921,"retry-timeout":"500ms"} {"level":"info","ts":"2026-03-25T21:02:22.171859Z","caller":"traceutil/trace.go:171","msg":"trace[1957233782] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"855.264513ms","start":"2026-03-25T21:02:21.316565Z","end":"2026-03-25T21:02:22.171829Z","steps":["trace[1957233782] 'process raft request' (duration: 852.715585ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:22.172028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:21.316535Z","time spent":"855.395664ms","remote":"127.0.0.1:45166","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":150480,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-25T21:02:22.17493Z","caller":"traceutil/trace.go:171","msg":"trace[1305441491] linearizableReadLoop","detail":"{readStateIndex:522; appliedIndex:520; }","duration":"510.017422ms","start":"2026-03-25T21:02:21.664895Z","end":"2026-03-25T21:02:22.174912Z","steps":["trace[1305441491] 'read index received' (duration: 504.445351ms)","trace[1305441491] 'applied index is now lower than readState.Index' (duration: 5.570911ms)"],"step_count":2} {"level":"warn","ts":"2026-03-25T21:02:22.175152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.241874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:02:22.17522Z","caller":"traceutil/trace.go:171","msg":"trace[298785397] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:503; }","duration":"510.355556ms","start":"2026-03-25T21:02:21.664851Z","end":"2026-03-25T21:02:22.175207Z","steps":["trace[298785397] 'agreement among raft nodes before linearized reading' (duration: 510.253575ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:22.175244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:21.664832Z","time spent":"510.407406ms","remote":"127.0.0.1:45120","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-03-25T21:02:28.667293Z","caller":"traceutil/trace.go:171","msg":"trace[638940971] linearizableReadLoop","detail":"{readStateIndex:602; appliedIndex:601; }","duration":"422.559934ms","start":"2026-03-25T21:02:28.244704Z","end":"2026-03-25T21:02:28.667264Z","steps":["trace[638940971] 'read index received' (duration: 421.712655ms)","trace[638940971] 'applied index is now lower than readState.Index' (duration: 846.409µs)"],"step_count":2} {"level":"info","ts":"2026-03-25T21:02:28.667359Z","caller":"traceutil/trace.go:171","msg":"trace[292430778] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"627.708502ms","start":"2026-03-25T21:02:28.039603Z","end":"2026-03-25T21:02:28.667311Z","steps":["trace[292430778] 'process raft request' (duration: 626.978104ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:28.667447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.734876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-03-25T21:02:28.667479Z","caller":"traceutil/trace.go:171","msg":"trace[365640657] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:582; }","duration":"422.819786ms","start":"2026-03-25T21:02:28.244649Z","end":"2026-03-25T21:02:28.667469Z","steps":["trace[365640657] 'agreement among raft nodes before linearized reading' (duration: 422.740215ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:28.667508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:28.244628Z","time spent":"422.873547ms","remote":"127.0.0.1:45398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-03-25T21:02:28.667509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:28.039574Z","time spent":"627.843663ms","remote":"127.0.0.1:45220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036281,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-25T21:02:28.667741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.019087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-03-25T21:02:28.667769Z","caller":"traceutil/trace.go:171","msg":"trace[1724767016] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:582; }","duration":"419.106868ms","start":"2026-03-25T21:02:28.248653Z","end":"2026-03-25T21:02:28.66776Z","steps":["trace[1724767016] 'agreement among raft nodes before linearized reading' (duration: 419.059868ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:28.667794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:28.248622Z","time spent":"419.165508ms","remote":"127.0.0.1:45398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-03-25T21:02:28.66797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.605772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-03-25T21:02:28.668Z","caller":"traceutil/trace.go:171","msg":"trace[1974191052] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:582; }","duration":"206.683814ms","start":"2026-03-25T21:02:28.461308Z","end":"2026-03-25T21:02:28.667992Z","steps":["trace[1974191052] 'agreement among raft nodes before linearized reading' (duration: 206.585232ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:28.668164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.20018ms","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-03-25T21:02:28.668255Z","caller":"traceutil/trace.go:171","msg":"trace[718080586] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:582; }","duration":"236.327221ms","start":"2026-03-25T21:02:28.431905Z","end":"2026-03-25T21:02:28.668232Z","steps":["trace[718080586] 'agreement among raft nodes before linearized reading' (duration: 236.143989ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:28.668832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.424788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-c6mmr\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-03-25T21:02:28.668976Z","caller":"traceutil/trace.go:171","msg":"trace[987091373] range","detail":"{range_begin:/registry/pods/kube-system/cilium-c6mmr; range_end:; response_count:1; response_revision:582; }","duration":"329.334227ms","start":"2026-03-25T21:02:28.339541Z","end":"2026-03-25T21:02:28.668875Z","steps":["trace[987091373] 'agreement among raft nodes before linearized reading' (duration: 328.411367ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:28.669052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:28.339523Z","time spent":"329.515588ms","remote":"127.0.0.1:45326","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-c6mmr\" "} {"level":"info","ts":"2026-03-25T21:02:29.187243Z","caller":"traceutil/trace.go:171","msg":"trace[1168923468] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"513.600782ms","start":"2026-03-25T21:02:28.673622Z","end":"2026-03-25T21:02:29.187223Z","steps":["trace[1168923468] 'process raft request' (duration: 513.546242ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:02:29.187246Z","caller":"traceutil/trace.go:171","msg":"trace[1926896776] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"513.612842ms","start":"2026-03-25T21:02:28.673612Z","end":"2026-03-25T21:02:29.187224Z","steps":["trace[1926896776] 'process raft request' (duration: 513.459551ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:29.187349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:28.673609Z","time spent":"513.684514ms","remote":"127.0.0.1:45398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-25T21:02:29.187512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:28.673599Z","time spent":"513.703104ms","remote":"127.0.0.1:45398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-25T21:02:29.187651Z","caller":"traceutil/trace.go:171","msg":"trace[1737631627] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"513.945117ms","start":"2026-03-25T21:02:28.673698Z","end":"2026-03-25T21:02:29.187643Z","steps":["trace[1737631627] 'process raft request' (duration: 513.497752ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:29.187715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:28.67369Z","time spent":"514.002947ms","remote":"127.0.0.1:45398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-25T21:02:29.187733Z","caller":"traceutil/trace.go:171","msg":"trace[839381932] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"497.758233ms","start":"2026-03-25T21:02:28.689953Z","end":"2026-03-25T21:02:29.187712Z","steps":["trace[839381932] 'process raft request' (duration: 497.516481ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:29.187864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:28.689933Z","time spent":"497.866344ms","remote":"127.0.0.1:45326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-25T21:02:29.209812Z","caller":"traceutil/trace.go:171","msg":"trace[907639684] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"489.482834ms","start":"2026-03-25T21:02:28.7203Z","end":"2026-03-25T21:02:29.209782Z","steps":["trace[907639684] 'process raft request' (duration: 489.142981ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:29.209942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:28.720278Z","time spent":"489.604265ms","remote":"127.0.0.1:45628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-25T21:02:29.426796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.229669ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-03-25T21:02:29.426869Z","caller":"traceutil/trace.go:171","msg":"trace[1942219624] linearizableReadLoop","detail":"{readStateIndex:608; appliedIndex:603; }","duration":"533.729661ms","start":"2026-03-25T21:02:28.893125Z","end":"2026-03-25T21:02:29.426855Z","steps":["trace[1942219624] 'read index received' (duration: 294.018482ms)","trace[1942219624] 'applied index is now lower than readState.Index' (duration: 239.710069ms)"],"step_count":2} {"level":"warn","ts":"2026-03-25T21:02:29.426951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.816252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:02:29.42697Z","caller":"traceutil/trace.go:171","msg":"trace[777520789] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:588; }","duration":"533.868883ms","start":"2026-03-25T21:02:28.893095Z","end":"2026-03-25T21:02:29.426964Z","steps":["trace[777520789] 'agreement among raft nodes before linearized reading' (duration: 533.823492ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:29.426993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:28.89308Z","time spent":"533.906253ms","remote":"127.0.0.1:54480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-03-25T21:02:29.42701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.827032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:02:29.427066Z","caller":"traceutil/trace.go:171","msg":"trace[1492163612] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:588; }","duration":"533.921753ms","start":"2026-03-25T21:02:28.893131Z","end":"2026-03-25T21:02:29.427053Z","steps":["trace[1492163612] 'agreement among raft nodes before linearized reading' (duration: 533.834522ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:29.427218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.442635ms","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":"warn","ts":"2026-03-25T21:02:29.42722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:28.893108Z","time spent":"534.064635ms","remote":"127.0.0.1:54480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-03-25T21:02:29.42747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.90361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:02:29.427515Z","caller":"traceutil/trace.go:171","msg":"trace[1863574533] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:588; }","duration":"208.994921ms","start":"2026-03-25T21:02:29.218508Z","end":"2026-03-25T21:02:29.427503Z","steps":["trace[1863574533] 'agreement among raft nodes before linearized reading' (duration: 208.930091ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:29.427746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.245813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-25T21:02:29.427785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.824468ms","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-03-25T21:02:29.427791Z","caller":"traceutil/trace.go:171","msg":"trace[1892000660] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:588; }","duration":"237.323723ms","start":"2026-03-25T21:02:29.190455Z","end":"2026-03-25T21:02:29.427779Z","steps":["trace[1892000660] 'agreement among raft nodes before linearized reading' (duration: 237.261013ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:02:29.427804Z","caller":"traceutil/trace.go:171","msg":"trace[1531213925] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:588; }","duration":"102.842918ms","start":"2026-03-25T21:02:29.324955Z","end":"2026-03-25T21:02:29.427798Z","steps":["trace[1531213925] 'agreement among raft nodes before linearized reading' (duration: 102.817558ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:29.427896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.005759ms","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-03-25T21:02:29.42792Z","caller":"traceutil/trace.go:171","msg":"trace[647686427] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:588; }","duration":"103.055491ms","start":"2026-03-25T21:02:29.324859Z","end":"2026-03-25T21:02:29.427915Z","steps":["trace[647686427] 'agreement among raft nodes before linearized reading' (duration: 103.02368ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:29.427996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.324518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:02:29.428018Z","caller":"traceutil/trace.go:171","msg":"trace[878424684] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:588; }","duration":"155.359449ms","start":"2026-03-25T21:02:29.272654Z","end":"2026-03-25T21:02:29.428013Z","steps":["trace[878424684] 'agreement among raft nodes before linearized reading' (duration: 155.328138ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:29.428055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.099561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:02:29.428141Z","caller":"traceutil/trace.go:171","msg":"trace[1812998528] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:588; }","duration":"238.241613ms","start":"2026-03-25T21:02:29.189888Z","end":"2026-03-25T21:02:29.42813Z","steps":["trace[1812998528] 'agreement among raft nodes before linearized reading' (duration: 238.132982ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:29.428105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.828943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:02:29.428233Z","caller":"traceutil/trace.go:171","msg":"trace[296862718] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:588; }","duration":"155.966745ms","start":"2026-03-25T21:02:29.27226Z","end":"2026-03-25T21:02:29.428227Z","steps":["trace[296862718] 'agreement among raft nodes before linearized reading' (duration: 155.831023ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:29.428442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.546093ms","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":"warn","ts":"2026-03-25T21:02:29.428509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.324893ms","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":"warn","ts":"2026-03-25T21:02:29.428491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.584657ms","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":"warn","ts":"2026-03-25T21:02:29.428547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.408323ms","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-03-25T21:02:29.428544Z","caller":"traceutil/trace.go:171","msg":"trace[45092136] 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:588; }","duration":"281.382963ms","start":"2026-03-25T21:02:29.147151Z","end":"2026-03-25T21:02:29.428534Z","steps":["trace[45092136] 'agreement among raft nodes before linearized reading' (duration: 281.338702ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:02:29.428569Z","caller":"traceutil/trace.go:171","msg":"trace[1808568232] 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:588; }","duration":"281.459563ms","start":"2026-03-25T21:02:29.147102Z","end":"2026-03-25T21:02:29.428562Z","steps":["trace[1808568232] 'agreement among raft nodes before linearized reading' (duration: 281.430373ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:02:29.428568Z","caller":"traceutil/trace.go:171","msg":"trace[96734217] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:588; }","duration":"209.710838ms","start":"2026-03-25T21:02:29.218839Z","end":"2026-03-25T21:02:29.42855Z","steps":["trace[96734217] 'agreement among raft nodes before linearized reading' (duration: 209.559577ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:29.428602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.49816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-25T21:02:29.428676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.549784ms","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-03-25T21:02:29.428702Z","caller":"traceutil/trace.go:171","msg":"trace[1168378255] 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:588; }","duration":"281.671576ms","start":"2026-03-25T21:02:29.147024Z","end":"2026-03-25T21:02:29.428696Z","steps":["trace[1168378255] 'agreement among raft nodes before linearized reading' (duration: 281.635025ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:29.428719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.175966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:02:29.428768Z","caller":"traceutil/trace.go:171","msg":"trace[1419080610] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:588; }","duration":"184.215916ms","start":"2026-03-25T21:02:29.244526Z","end":"2026-03-25T21:02:29.428742Z","steps":["trace[1419080610] 'agreement among raft nodes before linearized reading' (duration: 184.170236ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:29.428802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.442763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-25T21:02:29.428456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.663837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:02:29.428826Z","caller":"traceutil/trace.go:171","msg":"trace[1781753050] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:588; }","duration":"309.498223ms","start":"2026-03-25T21:02:29.119322Z","end":"2026-03-25T21:02:29.42882Z","steps":["trace[1781753050] 'agreement among raft nodes before linearized reading' (duration: 309.467413ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:29.428845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:29.11928Z","time spent":"309.559283ms","remote":"127.0.0.1:52714","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 "} {"level":"info","ts":"2026-03-25T21:02:29.428841Z","caller":"traceutil/trace.go:171","msg":"trace[1865697331] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:588; }","duration":"239.087572ms","start":"2026-03-25T21:02:29.189742Z","end":"2026-03-25T21:02:29.42883Z","steps":["trace[1865697331] 'agreement among raft nodes before linearized reading' (duration: 238.676408ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:29.428937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.617434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:02:29.428961Z","caller":"traceutil/trace.go:171","msg":"trace[886181291] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:588; }","duration":"309.655204ms","start":"2026-03-25T21:02:29.1193Z","end":"2026-03-25T21:02:29.428955Z","steps":["trace[886181291] 'agreement among raft nodes before linearized reading' (duration: 309.622454ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:29.428981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:29.119294Z","time spent":"309.682104ms","remote":"127.0.0.1:52714","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"info","ts":"2026-03-25T21:02:29.428523Z","caller":"traceutil/trace.go:171","msg":"trace[567572989] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:588; }","duration":"203.664484ms","start":"2026-03-25T21:02:29.224841Z","end":"2026-03-25T21:02:29.428506Z","steps":["trace[567572989] 'agreement among raft nodes before linearized reading' (duration: 203.500712ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:29.429061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.619583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:02:29.429079Z","caller":"traceutil/trace.go:171","msg":"trace[2055421931] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:588; }","duration":"323.646943ms","start":"2026-03-25T21:02:29.105427Z","end":"2026-03-25T21:02:29.429074Z","steps":["trace[2055421931] 'agreement among raft nodes before linearized reading' (duration: 323.617283ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:29.429104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:29.105422Z","time spent":"323.677174ms","remote":"127.0.0.1:52712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 "} {"level":"info","ts":"2026-03-25T21:02:29.428673Z","caller":"traceutil/trace.go:171","msg":"trace[1734099130] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:588; }","duration":"156.653492ms","start":"2026-03-25T21:02:29.27201Z","end":"2026-03-25T21:02:29.428664Z","steps":["trace[1734099130] 'agreement among raft nodes before linearized reading' (duration: 156.534781ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:29.429043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.57416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-25T21:02:29.429296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.416172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:02:29.429326Z","caller":"traceutil/trace.go:171","msg":"trace[356215172] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:588; }","duration":"324.484282ms","start":"2026-03-25T21:02:29.104834Z","end":"2026-03-25T21:02:29.429318Z","steps":["trace[356215172] 'agreement among raft nodes before linearized reading' (duration: 324.438461ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:29.429362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:29.10481Z","time spent":"324.538293ms","remote":"127.0.0.1:52712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 "} {"level":"warn","ts":"2026-03-25T21:02:29.42945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.654664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:02:29.429478Z","caller":"traceutil/trace.go:171","msg":"trace[1141220009] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:588; }","duration":"324.707184ms","start":"2026-03-25T21:02:29.104765Z","end":"2026-03-25T21:02:29.429472Z","steps":["trace[1141220009] 'agreement among raft nodes before linearized reading' (duration: 324.665264ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:29.4295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:29.104752Z","time spent":"324.742085ms","remote":"127.0.0.1:52712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"warn","ts":"2026-03-25T21:02:29.427757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.315053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-25T21:02:29.429597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.697282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-25T21:02:29.42961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.12171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:02:29.429618Z","caller":"traceutil/trace.go:171","msg":"trace[866535180] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:588; }","duration":"104.188123ms","start":"2026-03-25T21:02:29.32542Z","end":"2026-03-25T21:02:29.429608Z","steps":["trace[866535180] 'agreement among raft nodes before linearized reading' (duration: 102.317723ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:02:29.429636Z","caller":"traceutil/trace.go:171","msg":"trace[1608043062] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:588; }","duration":"455.14539ms","start":"2026-03-25T21:02:28.97448Z","end":"2026-03-25T21:02:29.429626Z","steps":["trace[1608043062] 'agreement among raft nodes before linearized reading' (duration: 455.10827ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:29.429666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:28.974453Z","time spent":"455.20574ms","remote":"127.0.0.1:52698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-03-25T21:02:29.429669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.326321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:02:29.429695Z","caller":"traceutil/trace.go:171","msg":"trace[1049953315] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:588; }","duration":"456.368693ms","start":"2026-03-25T21:02:28.973319Z","end":"2026-03-25T21:02:29.429688Z","steps":["trace[1049953315] 'agreement among raft nodes before linearized reading' (duration: 456.329672ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:29.429733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:28.973309Z","time spent":"456.415863ms","remote":"127.0.0.1:52698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-03-25T21:02:29.42724Z","caller":"traceutil/trace.go:171","msg":"trace[1173493952] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:588; }","duration":"208.490516ms","start":"2026-03-25T21:02:29.218743Z","end":"2026-03-25T21:02:29.427234Z","steps":["trace[1173493952] 'agreement among raft nodes before linearized reading' (duration: 208.446825ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:29.428776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.715614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-25T21:02:29.429079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.63464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:02:29.429863Z","caller":"traceutil/trace.go:171","msg":"trace[145772928] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:588; }","duration":"185.43264ms","start":"2026-03-25T21:02:29.244423Z","end":"2026-03-25T21:02:29.429855Z","steps":["trace[145772928] 'agreement among raft nodes before linearized reading' (duration: 184.636851ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:29.429869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.948383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:02:29.429896Z","caller":"traceutil/trace.go:171","msg":"trace[2044841421] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:588; }","duration":"506.985024ms","start":"2026-03-25T21:02:28.922902Z","end":"2026-03-25T21:02:29.429887Z","steps":["trace[2044841421] 'agreement among raft nodes before linearized reading' (duration: 506.943523ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:29.429931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:28.922898Z","time spent":"507.024575ms","remote":"127.0.0.1:52694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-03-25T21:02:29.430012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.071245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:02:29.42963Z","caller":"traceutil/trace.go:171","msg":"trace[1486163487] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:588; }","duration":"506.763032ms","start":"2026-03-25T21:02:28.922858Z","end":"2026-03-25T21:02:29.429621Z","steps":["trace[1486163487] 'agreement among raft nodes before linearized reading' (duration: 506.707431ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:29.430139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:28.922843Z","time spent":"507.287027ms","remote":"127.0.0.1:52694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"info","ts":"2026-03-25T21:02:29.430198Z","caller":"traceutil/trace.go:171","msg":"trace[676246625] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:588; }","duration":"507.284937ms","start":"2026-03-25T21:02:28.922817Z","end":"2026-03-25T21:02:29.430102Z","steps":["trace[676246625] 'agreement among raft nodes before linearized reading' (duration: 506.782072ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:29.428518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.070738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:02:29.430333Z","caller":"traceutil/trace.go:171","msg":"trace[622416022] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:588; }","duration":"456.928768ms","start":"2026-03-25T21:02:28.973392Z","end":"2026-03-25T21:02:29.430321Z","steps":["trace[622416022] 'agreement among raft nodes before linearized reading' (duration: 455.102288ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:02:29.429354Z","caller":"traceutil/trace.go:171","msg":"trace[984504599] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:588; }","duration":"184.825123ms","start":"2026-03-25T21:02:29.244452Z","end":"2026-03-25T21:02:29.429277Z","steps":["trace[984504599] 'agreement among raft nodes before linearized reading' (duration: 184.56861ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:29.430353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:28.922797Z","time spent":"507.47648ms","remote":"127.0.0.1:52694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 "} {"level":"warn","ts":"2026-03-25T21:02:29.430393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:28.973372Z","time spent":"456.996739ms","remote":"127.0.0.1:52698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 "} {"level":"info","ts":"2026-03-25T21:02:29.429832Z","caller":"traceutil/trace.go:171","msg":"trace[322304474] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:588; }","duration":"309.794427ms","start":"2026-03-25T21:02:29.120028Z","end":"2026-03-25T21:02:29.429822Z","steps":["trace[322304474] 'agreement among raft nodes before linearized reading' (duration: 308.732665ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:29.430598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:29.120012Z","time spent":"310.574325ms","remote":"127.0.0.1:52714","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 "} {"level":"warn","ts":"2026-03-25T21:02:30.364306Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2398339591560528100,"retry-timeout":"500ms"} {"level":"info","ts":"2026-03-25T21:02:30.446473Z","caller":"traceutil/trace.go:171","msg":"trace[1765217543] linearizableReadLoop","detail":"{readStateIndex:610; appliedIndex:609; }","duration":"582.702855ms","start":"2026-03-25T21:02:29.863743Z","end":"2026-03-25T21:02:30.446446Z","steps":["trace[1765217543] 'read index received' (duration: 581.823975ms)","trace[1765217543] 'applied index is now lower than readState.Index' (duration: 877.65µs)"],"step_count":2} {"level":"info","ts":"2026-03-25T21:02:30.446623Z","caller":"traceutil/trace.go:171","msg":"trace[1047002897] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"640.737465ms","start":"2026-03-25T21:02:29.805845Z","end":"2026-03-25T21:02:30.446583Z","steps":["trace[1047002897] 'process raft request' (duration: 639.943236ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:30.446699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.923568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-25T21:02:30.446745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.644054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:02:30.446781Z","caller":"traceutil/trace.go:171","msg":"trace[1523752863] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:589; }","duration":"583.06378ms","start":"2026-03-25T21:02:29.863701Z","end":"2026-03-25T21:02:30.446764Z","steps":["trace[1523752863] 'agreement among raft nodes before linearized reading' (duration: 582.890438ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:30.446825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:29.863679Z","time spent":"583.13581ms","remote":"127.0.0.1:52854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"info","ts":"2026-03-25T21:02:30.446813Z","caller":"traceutil/trace.go:171","msg":"trace[90814988] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:589; }","duration":"582.787976ms","start":"2026-03-25T21:02:29.863987Z","end":"2026-03-25T21:02:30.446775Z","steps":["trace[90814988] 'agreement among raft nodes before linearized reading' (duration: 582.662305ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:30.446831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:29.805818Z","time spent":"640.906296ms","remote":"127.0.0.1:45220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-25T21:02:30.446886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:29.863971Z","time spent":"582.902317ms","remote":"127.0.0.1:52854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-03-25T21:02:30.446926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.231541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-25T21:02:30.447041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.135209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:02:30.44709Z","caller":"traceutil/trace.go:171","msg":"trace[394865613] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:589; }","duration":"419.548144ms","start":"2026-03-25T21:02:30.027519Z","end":"2026-03-25T21:02:30.447067Z","steps":["trace[394865613] 'agreement among raft nodes before linearized reading' (duration: 419.236531ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:30.447076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.010028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:02:30.447168Z","caller":"traceutil/trace.go:171","msg":"trace[1195032733] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:589; }","duration":"403.27043ms","start":"2026-03-25T21:02:30.043842Z","end":"2026-03-25T21:02:30.447112Z","steps":["trace[1195032733] 'agreement among raft nodes before linearized reading' (duration: 403.061158ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:30.447176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:30.027479Z","time spent":"419.683476ms","remote":"127.0.0.1:52872","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-03-25T21:02:30.447208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.136916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-25T21:02:30.447216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:30.043832Z","time spent":"403.374662ms","remote":"127.0.0.1:52888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"info","ts":"2026-03-25T21:02:30.447226Z","caller":"traceutil/trace.go:171","msg":"trace[1537184150] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:589; }","duration":"403.23439ms","start":"2026-03-25T21:02:30.043966Z","end":"2026-03-25T21:02:30.4472Z","steps":["trace[1537184150] 'agreement among raft nodes before linearized reading' (duration: 402.843216ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:30.44727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.462805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:02:30.447289Z","caller":"traceutil/trace.go:171","msg":"trace[1823606194] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:589; }","duration":"421.482475ms","start":"2026-03-25T21:02:30.025802Z","end":"2026-03-25T21:02:30.447284Z","steps":["trace[1823606194] 'agreement among raft nodes before linearized reading' (duration: 421.454635ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:30.447295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:30.043958Z","time spent":"403.320551ms","remote":"127.0.0.1:52888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 "} {"level":"warn","ts":"2026-03-25T21:02:30.447341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.290305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:02:30.447366Z","caller":"traceutil/trace.go:171","msg":"trace[1658794316] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:589; }","duration":"439.339915ms","start":"2026-03-25T21:02:30.008019Z","end":"2026-03-25T21:02:30.447359Z","steps":["trace[1658794316] 'agreement among raft nodes before linearized reading' (duration: 439.307035ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:30.44739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:30.008002Z","time spent":"439.383415ms","remote":"127.0.0.1:52870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-03-25T21:02:30.447408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.873335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:02:30.447452Z","caller":"traceutil/trace.go:171","msg":"trace[1616301549] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:589; }","duration":"460.943156ms","start":"2026-03-25T21:02:29.986497Z","end":"2026-03-25T21:02:30.44744Z","steps":["trace[1616301549] 'agreement among raft nodes before linearized reading' (duration: 460.888015ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:30.44749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:29.986477Z","time spent":"461.004976ms","remote":"127.0.0.1:52866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-03-25T21:02:30.447507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.454666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-25T21:02:30.447166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.414933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:02:30.447243Z","caller":"traceutil/trace.go:171","msg":"trace[1857094071] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:589; }","duration":"460.193268ms","start":"2026-03-25T21:02:29.987041Z","end":"2026-03-25T21:02:30.447235Z","steps":["trace[1857094071] 'agreement among raft nodes before linearized reading' (duration: 460.151887ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:30.447589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.406182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:02:30.447585Z","caller":"traceutil/trace.go:171","msg":"trace[1014729584] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:589; }","duration":"419.850467ms","start":"2026-03-25T21:02:30.027717Z","end":"2026-03-25T21:02:30.447567Z","steps":["trace[1014729584] 'agreement among raft nodes before linearized reading' (duration: 419.387462ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:02:30.447616Z","caller":"traceutil/trace.go:171","msg":"trace[1300602736] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:589; }","duration":"403.444703ms","start":"2026-03-25T21:02:30.044165Z","end":"2026-03-25T21:02:30.44761Z","steps":["trace[1300602736] 'agreement among raft nodes before linearized reading' (duration: 403.408062ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:30.447647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:30.044158Z","time spent":"403.482643ms","remote":"127.0.0.1:52888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 "} {"level":"warn","ts":"2026-03-25T21:02:30.447314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:30.02577Z","time spent":"421.539135ms","remote":"127.0.0.1:52870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 "} {"level":"warn","ts":"2026-03-25T21:02:30.447684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:30.027701Z","time spent":"419.942678ms","remote":"127.0.0.1:52872","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-03-25T21:02:30.447606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:29.987029Z","time spent":"460.560591ms","remote":"127.0.0.1:52854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 "} {"level":"warn","ts":"2026-03-25T21:02:30.447354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.852085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:02:30.447764Z","caller":"traceutil/trace.go:171","msg":"trace[719660349] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:589; }","duration":"461.31562ms","start":"2026-03-25T21:02:29.986429Z","end":"2026-03-25T21:02:30.447745Z","steps":["trace[719660349] 'agreement among raft nodes before linearized reading' (duration: 460.874405ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:30.447827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:29.986405Z","time spent":"461.403601ms","remote":"127.0.0.1:52866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"info","ts":"2026-03-25T21:02:30.447529Z","caller":"traceutil/trace.go:171","msg":"trace[79098079] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:589; }","duration":"439.493767ms","start":"2026-03-25T21:02:30.008029Z","end":"2026-03-25T21:02:30.447523Z","steps":["trace[79098079] 'agreement among raft nodes before linearized reading' (duration: 439.460596ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:30.447961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:30.00802Z","time spent":"439.931191ms","remote":"127.0.0.1:52870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"info","ts":"2026-03-25T21:02:32.657308Z","caller":"traceutil/trace.go:171","msg":"trace[136847548] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"195.527239ms","start":"2026-03-25T21:02:32.461768Z","end":"2026-03-25T21:02:32.657295Z","steps":["trace[136847548] 'process raft request' (duration: 173.479845ms)","trace[136847548] 'compare' (duration: 21.809151ms)"],"step_count":2} {"level":"warn","ts":"2026-03-25T21:02:37.938342Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2398339591560528285,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-25T21:02:38.439016Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2398339591560528285,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-25T21:02:38.798644Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.379444645s","expected-duration":"1s"} {"level":"info","ts":"2026-03-25T21:02:38.799136Z","caller":"traceutil/trace.go:171","msg":"trace[632284490] transaction","detail":"{read_only:false; response_revision:693; number_of_response:1; }","duration":"1.380008991s","start":"2026-03-25T21:02:37.419102Z","end":"2026-03-25T21:02:38.799111Z","steps":["trace[632284490] 'process raft request' (duration: 1.379791519s)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:38.799358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:37.419071Z","time spent":"1.380153223s","remote":"127.0.0.1:45324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4317,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-25T21:02:38.805781Z","caller":"traceutil/trace.go:171","msg":"trace[131610061] transaction","detail":"{read_only:false; response_revision:694; number_of_response:1; }","duration":"1.376353254s","start":"2026-03-25T21:02:37.429398Z","end":"2026-03-25T21:02:38.805751Z","steps":["trace[131610061] 'process raft request' (duration: 1.37607774s)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:38.805919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:37.429364Z","time spent":"1.376480226s","remote":"127.0.0.1:45326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18698,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-25T21:02:38.806319Z","caller":"traceutil/trace.go:171","msg":"trace[1422782119] linearizableReadLoop","detail":"{readStateIndex:717; appliedIndex:714; }","duration":"1.368621593s","start":"2026-03-25T21:02:37.437642Z","end":"2026-03-25T21:02:38.806264Z","steps":["trace[1422782119] 'read index received' (duration: 1.361245196s)","trace[1422782119] 'applied index is now lower than readState.Index' (duration: 7.374677ms)"],"step_count":2} {"level":"info","ts":"2026-03-25T21:02:38.806468Z","caller":"traceutil/trace.go:171","msg":"trace[361902587] transaction","detail":"{read_only:false; response_revision:695; number_of_response:1; }","duration":"1.139668394s","start":"2026-03-25T21:02:37.666782Z","end":"2026-03-25T21:02:38.806451Z","steps":["trace[361902587] 'process raft request' (duration: 1.138798224s)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:38.806585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:37.666767Z","time spent":"1.139747375s","remote":"127.0.0.1:45204","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":780,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-25T21:02:38.807349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.369632324s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:02:38.807412Z","caller":"traceutil/trace.go:171","msg":"trace[1188857207] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:695; }","duration":"1.369705575s","start":"2026-03-25T21:02:37.437692Z","end":"2026-03-25T21:02:38.807398Z","steps":["trace[1188857207] 'agreement among raft nodes before linearized reading' (duration: 1.369595053s)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:38.807442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:37.437681Z","time spent":"1.369752735s","remote":"127.0.0.1:52914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-03-25T21:02:38.807601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.140893176s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-25T21:02:38.807594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.710466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-03-25T21:02:38.807633Z","caller":"traceutil/trace.go:171","msg":"trace[1978172387] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:695; }","duration":"1.140964377s","start":"2026-03-25T21:02:37.66666Z","end":"2026-03-25T21:02:38.807625Z","steps":["trace[1978172387] 'agreement among raft nodes before linearized reading' (duration: 1.140906926s)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:38.807658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:37.666644Z","time spent":"1.141008347s","remote":"127.0.0.1:45120","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-03-25T21:02:38.807651Z","caller":"traceutil/trace.go:171","msg":"trace[1817769127] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:695; }","duration":"532.813197ms","start":"2026-03-25T21:02:38.274819Z","end":"2026-03-25T21:02:38.807632Z","steps":["trace[1817769127] 'agreement among raft nodes before linearized reading' (duration: 532.622745ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:38.807696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:38.274797Z","time spent":"532.890277ms","remote":"127.0.0.1:45398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":512,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-03-25T21:02:38.807673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.180942624s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:02:38.807733Z","caller":"traceutil/trace.go:171","msg":"trace[572178794] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:695; }","duration":"1.181022765s","start":"2026-03-25T21:02:37.6267Z","end":"2026-03-25T21:02:38.807723Z","steps":["trace[572178794] 'agreement among raft nodes before linearized reading' (duration: 1.180945964s)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:38.807768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:37.626686Z","time spent":"1.181067945s","remote":"127.0.0.1:52930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" limit:10000 "} {"level":"warn","ts":"2026-03-25T21:02:38.807802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.180810003s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:02:38.807831Z","caller":"traceutil/trace.go:171","msg":"trace[869622245] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:695; }","duration":"1.180848283s","start":"2026-03-25T21:02:37.626974Z","end":"2026-03-25T21:02:38.807822Z","steps":["trace[869622245] 'agreement among raft nodes before linearized reading' (duration: 1.180799812s)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:38.807856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:37.626971Z","time spent":"1.180877423s","remote":"127.0.0.1:52930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" limit:500 "} {"level":"warn","ts":"2026-03-25T21:02:38.807874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.727329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:02:38.807905Z","caller":"traceutil/trace.go:171","msg":"trace[473134340] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/instance; range_end:; response_count:0; response_revision:695; }","duration":"344.79816ms","start":"2026-03-25T21:02:38.463098Z","end":"2026-03-25T21:02:38.807896Z","steps":["trace[473134340] 'agreement among raft nodes before linearized reading' (duration: 344.751049ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:38.807931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:38.463077Z","time spent":"344.8467ms","remote":"127.0.0.1:52898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumnodes/instance\" "} {"level":"warn","ts":"2026-03-25T21:02:38.807982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.193894059s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:02:38.808015Z","caller":"traceutil/trace.go:171","msg":"trace[1384828877] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:695; }","duration":"1.19396214s","start":"2026-03-25T21:02:37.614043Z","end":"2026-03-25T21:02:38.808005Z","steps":["trace[1384828877] 'agreement among raft nodes before linearized reading' (duration: 1.193908829s)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:38.808045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:37.614026Z","time spent":"1.194010971s","remote":"127.0.0.1:52916","response type":"/etcdserverpb.KV/Range","request count":0,"request size":113,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:500 "} {"level":"warn","ts":"2026-03-25T21:02:38.808072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.992801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:02:38.808105Z","caller":"traceutil/trace.go:171","msg":"trace[1301589070] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/instance; range_end:; response_count:0; response_revision:695; }","duration":"345.055723ms","start":"2026-03-25T21:02:38.463039Z","end":"2026-03-25T21:02:38.808095Z","steps":["trace[1301589070] 'agreement among raft nodes before linearized reading' (duration: 345.012902ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:38.808139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:38.463022Z","time spent":"345.108883ms","remote":"127.0.0.1:52898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumnodes/instance\" "} {"level":"warn","ts":"2026-03-25T21:02:38.807347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.18060053s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:02:38.808211Z","caller":"traceutil/trace.go:171","msg":"trace[2061410879] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:695; }","duration":"1.18148793s","start":"2026-03-25T21:02:37.626714Z","end":"2026-03-25T21:02:38.808201Z","steps":["trace[2061410879] 'agreement among raft nodes before linearized reading' (duration: 1.180583931s)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:38.808245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:37.626708Z","time spent":"1.18152605s","remote":"127.0.0.1:52930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true "} {"level":"warn","ts":"2026-03-25T21:02:38.808375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.345457701s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:02:38.808405Z","caller":"traceutil/trace.go:171","msg":"trace[173659654] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:695; }","duration":"1.345507122s","start":"2026-03-25T21:02:37.462887Z","end":"2026-03-25T21:02:38.808394Z","steps":["trace[173659654] 'agreement among raft nodes before linearized reading' (duration: 1.345462071s)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:38.808438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:37.462877Z","time spent":"1.345549463s","remote":"127.0.0.1:52916","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10 "} {"level":"warn","ts":"2026-03-25T21:02:38.808546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.346733635s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:02:38.808573Z","caller":"traceutil/trace.go:171","msg":"trace[1063337420] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:695; }","duration":"1.346793955s","start":"2026-03-25T21:02:37.461771Z","end":"2026-03-25T21:02:38.808565Z","steps":["trace[1063337420] 'agreement among raft nodes before linearized reading' (duration: 1.346718404s)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:38.808598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:37.461754Z","time spent":"1.346836055s","remote":"127.0.0.1:52916","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-03-25T21:02:38.808667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.347075978s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:02:38.808693Z","caller":"traceutil/trace.go:171","msg":"trace[617285933] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:695; }","duration":"1.347124948s","start":"2026-03-25T21:02:37.461561Z","end":"2026-03-25T21:02:38.808686Z","steps":["trace[617285933] 'agreement among raft nodes before linearized reading' (duration: 1.347085058s)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:38.808721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:37.461548Z","time spent":"1.347163539s","remote":"127.0.0.1:52916","response type":"/etcdserverpb.KV/Range","request count":0,"request size":113,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-03-25T21:02:38.80818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.194497345s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:02:38.808778Z","caller":"traceutil/trace.go:171","msg":"trace[1579141231] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:695; }","duration":"1.195143873s","start":"2026-03-25T21:02:37.613608Z","end":"2026-03-25T21:02:38.808752Z","steps":["trace[1579141231] 'agreement among raft nodes before linearized reading' (duration: 1.194546386s)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:38.808824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:37.613588Z","time spent":"1.195218964s","remote":"127.0.0.1:52914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":91,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:500 "} {"level":"warn","ts":"2026-03-25T21:02:38.80897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.370885327s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:02:38.809018Z","caller":"traceutil/trace.go:171","msg":"trace[2060370172] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:695; }","duration":"1.370933098s","start":"2026-03-25T21:02:37.438067Z","end":"2026-03-25T21:02:38.809Z","steps":["trace[2060370172] 'agreement among raft nodes before linearized reading' (duration: 1.370873587s)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:38.809051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:37.438063Z","time spent":"1.370974048s","remote":"127.0.0.1:52914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10 "} {"level":"warn","ts":"2026-03-25T21:02:38.806928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.36926396s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:02:38.811827Z","caller":"traceutil/trace.go:171","msg":"trace[1850079432] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:695; }","duration":"1.374195872s","start":"2026-03-25T21:02:37.437612Z","end":"2026-03-25T21:02:38.811808Z","steps":["trace[1850079432] 'agreement among raft nodes before linearized reading' (duration: 1.36922888s)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:38.81189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:37.437603Z","time spent":"1.374264143s","remote":"127.0.0.1:52914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":91,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10000 "} {"level":"info","ts":"2026-03-25T21:02:43.438333Z","caller":"traceutil/trace.go:171","msg":"trace[1803403023] linearizableReadLoop","detail":"{readStateIndex:758; appliedIndex:757; }","duration":"149.322227ms","start":"2026-03-25T21:02:43.288959Z","end":"2026-03-25T21:02:43.438282Z","steps":["trace[1803403023] 'read index received' (duration: 149.266266ms)","trace[1803403023] 'applied index is now lower than readState.Index' (duration: 54.891µs)"],"step_count":2} {"level":"info","ts":"2026-03-25T21:02:43.438435Z","caller":"traceutil/trace.go:171","msg":"trace[771519829] transaction","detail":"{read_only:false; response_revision:734; number_of_response:1; }","duration":"149.61555ms","start":"2026-03-25T21:02:43.288781Z","end":"2026-03-25T21:02:43.438397Z","steps":["trace[771519829] 'process raft request' (duration: 149.352798ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:43.438601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.980254ms","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-03-25T21:02:43.438638Z","caller":"traceutil/trace.go:171","msg":"trace[898549323] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:734; }","duration":"149.071564ms","start":"2026-03-25T21:02:43.289554Z","end":"2026-03-25T21:02:43.438626Z","steps":["trace[898549323] 'agreement among raft nodes before linearized reading' (duration: 148.919653ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:43.438701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.694481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-03-25T21:02:43.43886Z","caller":"traceutil/trace.go:171","msg":"trace[60019896] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:734; }","duration":"149.911112ms","start":"2026-03-25T21:02:43.288923Z","end":"2026-03-25T21:02:43.438834Z","steps":["trace[60019896] 'agreement among raft nodes before linearized reading' (duration: 149.500578ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:45.660215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.702083ms","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-03-25T21:02:45.6603Z","caller":"traceutil/trace.go:171","msg":"trace[1743759656] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:748; }","duration":"209.847929ms","start":"2026-03-25T21:02:45.450431Z","end":"2026-03-25T21:02:45.660279Z","steps":["trace[1743759656] 'range keys from in-memory index tree' (duration: 209.473952ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:45.660351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.807523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-03-25T21:02:45.660367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.670311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-03-25T21:02:45.660412Z","caller":"traceutil/trace.go:171","msg":"trace[592100255] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:748; }","duration":"217.888067ms","start":"2026-03-25T21:02:45.442511Z","end":"2026-03-25T21:02:45.660399Z","steps":["trace[592100255] 'range keys from in-memory index tree' (duration: 217.707008ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:45.66042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.33839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-4rflk\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-03-25T21:02:45.660473Z","caller":"traceutil/trace.go:171","msg":"trace[29708630] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:748; }","duration":"209.834279ms","start":"2026-03-25T21:02:45.450612Z","end":"2026-03-25T21:02:45.660447Z","steps":["trace[29708630] 'range keys from in-memory index tree' (duration: 209.442321ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:02:45.660511Z","caller":"traceutil/trace.go:171","msg":"trace[925585161] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-4rflk; range_end:; response_count:1; response_revision:748; }","duration":"222.478317ms","start":"2026-03-25T21:02:45.438012Z","end":"2026-03-25T21:02:45.66049Z","steps":["trace[925585161] 'range keys from in-memory index tree' (duration: 222.165392ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:02:45.9657Z","caller":"traceutil/trace.go:171","msg":"trace[311416364] transaction","detail":"{read_only:false; response_revision:749; number_of_response:1; }","duration":"297.37647ms","start":"2026-03-25T21:02:45.668293Z","end":"2026-03-25T21:02:45.965669Z","steps":["trace[311416364] 'process raft request' (duration: 297.187672ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:02:46.044979Z","caller":"traceutil/trace.go:171","msg":"trace[1792206696] linearizableReadLoop","detail":"{readStateIndex:777; appliedIndex:773; }","duration":"270.867888ms","start":"2026-03-25T21:02:45.774083Z","end":"2026-03-25T21:02:46.044951Z","steps":["trace[1792206696] 'read index received' (duration: 191.403757ms)","trace[1792206696] 'applied index is now lower than readState.Index' (duration: 79.462701ms)"],"step_count":2} {"level":"info","ts":"2026-03-25T21:02:46.046516Z","caller":"traceutil/trace.go:171","msg":"trace[797832127] transaction","detail":"{read_only:false; response_revision:750; number_of_response:1; }","duration":"377.72891ms","start":"2026-03-25T21:02:45.668764Z","end":"2026-03-25T21:02:46.046493Z","steps":["trace[797832127] 'process raft request' (duration: 375.845606ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:02:46.046512Z","caller":"traceutil/trace.go:171","msg":"trace[915604701] transaction","detail":"{read_only:false; response_revision:752; number_of_response:1; }","duration":"377.247047ms","start":"2026-03-25T21:02:45.669223Z","end":"2026-03-25T21:02:46.04647Z","steps":["trace[915604701] 'process raft request' (duration: 375.666146ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:46.046572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.390636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:02:46.046563Z","caller":"traceutil/trace.go:171","msg":"trace[1510009129] transaction","detail":"{read_only:false; response_revision:751; number_of_response:1; }","duration":"377.754152ms","start":"2026-03-25T21:02:45.668769Z","end":"2026-03-25T21:02:46.046523Z","steps":["trace[1510009129] 'process raft request' (duration: 376.007043ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:02:46.046635Z","caller":"traceutil/trace.go:171","msg":"trace[333187950] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:752; }","duration":"272.584845ms","start":"2026-03-25T21:02:45.774032Z","end":"2026-03-25T21:02:46.046617Z","steps":["trace[333187950] 'agreement among raft nodes before linearized reading' (duration: 271.029605ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:02:46.046638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:45.668739Z","time spent":"377.832595ms","remote":"127.0.0.1:45398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-25T21:02:46.046769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:45.668752Z","time spent":"377.910819ms","remote":"127.0.0.1:45398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-25T21:02:46.04676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:02:45.669208Z","time spent":"377.392824ms","remote":"127.0.0.1:45326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4022,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-25T21:04:37.668775Z","caller":"traceutil/trace.go:171","msg":"trace[38972593] transaction","detail":"{read_only:false; response_revision:1288; number_of_response:1; }","duration":"100.268117ms","start":"2026-03-25T21:04:37.568482Z","end":"2026-03-25T21:04:37.668751Z","steps":["trace[38972593] 'process raft request' (duration: 38.449005ms)","trace[38972593] 'compare' (duration: 61.498515ms)"],"step_count":2} {"level":"warn","ts":"2026-03-25T21:04:38.450993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"647.963423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:04:38.451089Z","caller":"traceutil/trace.go:171","msg":"trace[713138857] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1288; }","duration":"648.090756ms","start":"2026-03-25T21:04:37.802971Z","end":"2026-03-25T21:04:38.451062Z","steps":["trace[713138857] 'count revisions from in-memory index tree' (duration: 647.892662ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:04:38.451132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:04:37.802959Z","time spent":"648.161817ms","remote":"127.0.0.1:52812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-03-25T21:04:38.451189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.34076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:04:38.451331Z","caller":"traceutil/trace.go:171","msg":"trace[2065905573] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:1288; }","duration":"412.523634ms","start":"2026-03-25T21:04:38.038791Z","end":"2026-03-25T21:04:38.451314Z","steps":["trace[2065905573] 'count revisions from in-memory index tree' (duration: 412.269219ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:04:38.451478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T21:04:38.038773Z","time spent":"412.690707ms","remote":"127.0.0.1:52712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"warn","ts":"2026-03-25T21:04:59.432228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.164783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/kube-public/\" range_end:\"/registry/ingress/kube-public0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-25T21:04:59.432297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.971374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/kube-public/\" range_end:\"/registry/jobs/kube-public0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T21:04:59.432362Z","caller":"traceutil/trace.go:171","msg":"trace[1327272424] range","detail":"{range_begin:/registry/ingress/kube-public/; range_end:/registry/ingress/kube-public0; response_count:0; response_revision:1364; }","duration":"149.384187ms","start":"2026-03-25T21:04:59.28295Z","end":"2026-03-25T21:04:59.432335Z","steps":["trace[1327272424] 'range keys from in-memory index tree' (duration: 149.06212ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:04:59.432401Z","caller":"traceutil/trace.go:171","msg":"trace[23613089] range","detail":"{range_begin:/registry/jobs/kube-public/; range_end:/registry/jobs/kube-public0; response_count:0; response_revision:1364; }","duration":"111.144577ms","start":"2026-03-25T21:04:59.321235Z","end":"2026-03-25T21:04:59.43238Z","steps":["trace[23613089] 'range keys from in-memory index tree' (duration: 110.867851ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:04:59.432553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.893216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/envoy-gateway-system/\" range_end:\"/registry/events/envoy-gateway-system0\" limit:500 ","response":"range_response_count:15 size:12285"} {"level":"info","ts":"2026-03-25T21:04:59.432614Z","caller":"traceutil/trace.go:171","msg":"trace[2115255808] range","detail":"{range_begin:/registry/events/envoy-gateway-system/; range_end:/registry/events/envoy-gateway-system0; response_count:15; response_revision:1364; }","duration":"161.984447ms","start":"2026-03-25T21:04:59.270607Z","end":"2026-03-25T21:04:59.432591Z","steps":["trace[2115255808] 'range keys from in-memory index tree' (duration: 161.615601ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T21:04:59.432596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.842817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/envoy\" ","response":"range_response_count:1 size:4438"} {"level":"info","ts":"2026-03-25T21:04:59.43268Z","caller":"traceutil/trace.go:171","msg":"trace[13158911] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/envoy; range_end:; response_count:1; response_revision:1364; }","duration":"156.964399ms","start":"2026-03-25T21:04:59.275697Z","end":"2026-03-25T21:04:59.432661Z","steps":["trace[13158911] 'range keys from in-memory index tree' (duration: 156.594962ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T21:05:11.059754Z","caller":"traceutil/trace.go:171","msg":"trace[57558076] transaction","detail":"{read_only:false; response_revision:1402; number_of_response:1; }","duration":"129.366483ms","start":"2026-03-25T21:05:10.930358Z","end":"2026-03-25T21:05:11.059724Z","steps":["trace[57558076] 'process raft request' (duration: 123.489854ms)"],"step_count":1}