{"level":"warn","ts":"2026-05-13T16:05:46.546009Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-13T16:05:46.546248Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.223: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.223:2380","--initial-cluster=instance=https://199.204.45.223:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.223:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.223: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-05-13T16:05:46.546322Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-13T16:05:46.546336Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.223:2380"]} {"level":"info","ts":"2026-05-13T16:05:46.546355Z","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-05-13T16:05:46.546997Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"]} {"level":"info","ts":"2026-05-13T16:05:46.547072Z","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.223:2380"],"listen-peer-urls":["https://199.204.45.223:2380"],"advertise-client-urls":["https://199.204.45.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.223: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-05-13T16:05:46.554522Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.099352ms"} {"level":"info","ts":"2026-05-13T16:05:46.564653Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"11f26225a5bb9fe3","cluster-id":"75c25101f01fd4c6"} {"level":"info","ts":"2026-05-13T16:05:46.564747Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=()"} {"level":"info","ts":"2026-05-13T16:05:46.564778Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became follower at term 0"} {"level":"info","ts":"2026-05-13T16:05:46.564801Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 11f26225a5bb9fe3 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-13T16:05:46.564817Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became follower at term 1"} {"level":"info","ts":"2026-05-13T16:05:46.564868Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=(1293203956842602467)"} {"level":"warn","ts":"2026-05-13T16:05:46.575069Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-13T16:05:46.57634Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-13T16:05:46.577754Z","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-05-13T16:05:46.57958Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"11f26225a5bb9fe3","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-13T16:05:46.581619Z","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-05-13T16:05:46.581714Z","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-05-13T16:05:46.581723Z","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-05-13T16:05:46.58185Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"11f26225a5bb9fe3","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-13T16:05:46.586474Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=(1293203956842602467)"} {"level":"info","ts":"2026-05-13T16:05:46.586632Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"75c25101f01fd4c6","local-member-id":"11f26225a5bb9fe3","added-peer-id":"11f26225a5bb9fe3","added-peer-peer-urls":["https://199.204.45.223:2380"]} {"level":"info","ts":"2026-05-13T16:05:46.587392Z","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-05-13T16:05:46.58752Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.223:2380"} {"level":"info","ts":"2026-05-13T16:05:46.587575Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.223:2380"} {"level":"info","ts":"2026-05-13T16:05:46.587726Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"11f26225a5bb9fe3","initial-advertise-peer-urls":["https://199.204.45.223:2380"],"listen-peer-urls":["https://199.204.45.223:2380"],"advertise-client-urls":["https://199.204.45.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-13T16:05:46.587779Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-13T16:05:47.265616Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 is starting a new election at term 1"} {"level":"info","ts":"2026-05-13T16:05:47.265677Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-13T16:05:47.265709Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 received MsgPreVoteResp from 11f26225a5bb9fe3 at term 1"} {"level":"info","ts":"2026-05-13T16:05:47.265724Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became candidate at term 2"} {"level":"info","ts":"2026-05-13T16:05:47.265731Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 received MsgVoteResp from 11f26225a5bb9fe3 at term 2"} {"level":"info","ts":"2026-05-13T16:05:47.265743Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became leader at term 2"} {"level":"info","ts":"2026-05-13T16:05:47.265752Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 11f26225a5bb9fe3 elected leader 11f26225a5bb9fe3 at term 2"} {"level":"info","ts":"2026-05-13T16:05:47.270996Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"11f26225a5bb9fe3","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.223:2379]}","request-path":"/0/members/11f26225a5bb9fe3/attributes","cluster-id":"75c25101f01fd4c6","publish-timeout":"7s"} {"level":"info","ts":"2026-05-13T16:05:47.27106Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-13T16:05:47.271167Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-13T16:05:47.271224Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-13T16:05:47.271894Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-13T16:05:47.271208Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-13T16:05:47.274877Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-13T16:05:47.277839Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.223:2379"} {"level":"info","ts":"2026-05-13T16:05:47.300768Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"75c25101f01fd4c6","local-member-id":"11f26225a5bb9fe3","cluster-version":"3.5"} {"level":"info","ts":"2026-05-13T16:05:47.300882Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-13T16:05:47.300913Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-05-13T16:05:49.986464Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521226140983870924,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-13T16:05:50.001911Z","caller":"traceutil/trace.go:171","msg":"trace[1127967342] linearizableReadLoop","detail":"{readStateIndex:75; appliedIndex:74; }","duration":"516.189561ms","start":"2026-05-13T16:05:49.4857Z","end":"2026-05-13T16:05:50.001889Z","steps":["trace[1127967342] 'read index received' (duration: 516.046025ms)","trace[1127967342] 'applied index is now lower than readState.Index' (duration: 142.586µs)"],"step_count":2} {"level":"info","ts":"2026-05-13T16:05:50.002005Z","caller":"traceutil/trace.go:171","msg":"trace[778131825] transaction","detail":"{read_only:false; response_revision:71; number_of_response:1; }","duration":"517.442508ms","start":"2026-05-13T16:05:49.484522Z","end":"2026-05-13T16:05:50.001964Z","steps":["trace[778131825] 'process raft request' (duration: 517.248179ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:05:50.002291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"516.545657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-13T16:05:50.002346Z","caller":"traceutil/trace.go:171","msg":"trace[1845962807] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:71; }","duration":"516.639572ms","start":"2026-05-13T16:05:49.485696Z","end":"2026-05-13T16:05:50.002336Z","steps":["trace[1845962807] 'agreement among raft nodes before linearized reading' (duration: 516.445943ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:05:50.002324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.158983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-13T16:05:50.002396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:05:49.485665Z","time spent":"516.703454ms","remote":"127.0.0.1:53378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":26,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" "} {"level":"info","ts":"2026-05-13T16:05:50.002425Z","caller":"traceutil/trace.go:171","msg":"trace[1638428034] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:71; }","duration":"509.282619ms","start":"2026-05-13T16:05:49.493112Z","end":"2026-05-13T16:05:50.002394Z","steps":["trace[1638428034] 'agreement among raft nodes before linearized reading' (duration: 509.047999ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:05:50.002501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:05:49.493101Z","time spent":"509.391434ms","remote":"127.0.0.1:53034","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-05-13T16:05:50.002668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:05:49.484492Z","time spent":"517.584704ms","remote":"127.0.0.1:53384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":429,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-13T16:05:55.518809Z","caller":"traceutil/trace.go:171","msg":"trace[328750007] transaction","detail":"{read_only:false; response_revision:290; number_of_response:1; }","duration":"470.953063ms","start":"2026-05-13T16:05:55.047827Z","end":"2026-05-13T16:05:55.51878Z","steps":["trace[328750007] 'process raft request' (duration: 470.570134ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:05:55.518943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:05:55.047799Z","time spent":"471.09013ms","remote":"127.0.0.1:53236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":194,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-13T16:06:00.920492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.89828ms","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-05-13T16:06:00.920625Z","caller":"traceutil/trace.go:171","msg":"trace[236415735] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:367; }","duration":"136.088458ms","start":"2026-05-13T16:06:00.784512Z","end":"2026-05-13T16:06:00.9206Z","steps":["trace[236415735] 'range keys from in-memory index tree' (duration: 135.791425ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T16:06:02.528224Z","caller":"traceutil/trace.go:171","msg":"trace[2128213438] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"111.016629ms","start":"2026-05-13T16:06:02.417183Z","end":"2026-05-13T16:06:02.5282Z","steps":["trace[2128213438] 'process raft request' (duration: 110.876322ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T16:06:06.371522Z","caller":"traceutil/trace.go:171","msg":"trace[926786466] linearizableReadLoop","detail":"{readStateIndex:424; appliedIndex:423; }","duration":"265.544665ms","start":"2026-05-13T16:06:06.105958Z","end":"2026-05-13T16:06:06.371503Z","steps":["trace[926786466] 'read index received' (duration: 263.567023ms)","trace[926786466] 'applied index is now lower than readState.Index' (duration: 1.976701ms)"],"step_count":2} {"level":"warn","ts":"2026-05-13T16:06:06.371621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.643679ms","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-05-13T16:06:06.37168Z","caller":"traceutil/trace.go:171","msg":"trace[1862903896] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:413; }","duration":"265.759156ms","start":"2026-05-13T16:06:06.105905Z","end":"2026-05-13T16:06:06.371665Z","steps":["trace[1862903896] 'agreement among raft nodes before linearized reading' (duration: 265.63788ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:06.371774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.343046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-13T16:06:06.371832Z","caller":"traceutil/trace.go:171","msg":"trace[2010844459] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:413; }","duration":"259.456002ms","start":"2026-05-13T16:06:06.112366Z","end":"2026-05-13T16:06:06.371822Z","steps":["trace[2010844459] 'agreement among raft nodes before linearized reading' (duration: 259.265582ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T16:06:12.851061Z","caller":"traceutil/trace.go:171","msg":"trace[1853104305] transaction","detail":"{read_only:false; response_revision:428; number_of_response:1; }","duration":"444.434454ms","start":"2026-05-13T16:06:12.406599Z","end":"2026-05-13T16:06:12.851033Z","steps":["trace[1853104305] 'process raft request' (duration: 444.262555ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:12.852055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:12.406574Z","time spent":"444.584122ms","remote":"127.0.0.1:53306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-13T16:06:12.852821Z","caller":"traceutil/trace.go:171","msg":"trace[1378165495] linearizableReadLoop","detail":"{readStateIndex:441; appliedIndex:439; }","duration":"399.239126ms","start":"2026-05-13T16:06:12.453558Z","end":"2026-05-13T16:06:12.852797Z","steps":["trace[1378165495] 'read index received' (duration: 397.315003ms)","trace[1378165495] 'applied index is now lower than readState.Index' (duration: 1.923023ms)"],"step_count":2} {"level":"warn","ts":"2026-05-13T16:06:12.853027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.460458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-13T16:06:12.853071Z","caller":"traceutil/trace.go:171","msg":"trace[1281403608] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:429; }","duration":"399.555763ms","start":"2026-05-13T16:06:12.453501Z","end":"2026-05-13T16:06:12.853057Z","steps":["trace[1281403608] 'agreement among raft nodes before linearized reading' (duration: 399.476268ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:12.853109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:12.45348Z","time spent":"399.621466ms","remote":"127.0.0.1:53034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-13T16:06:12.853304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.746196ms","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-05-13T16:06:12.85337Z","caller":"traceutil/trace.go:171","msg":"trace[1108199102] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:429; }","duration":"312.843371ms","start":"2026-05-13T16:06:12.540494Z","end":"2026-05-13T16:06:12.853338Z","steps":["trace[1108199102] 'agreement among raft nodes before linearized reading' (duration: 312.753077ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:12.853414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:12.540467Z","time spent":"312.938946ms","remote":"127.0.0.1:53306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-13T16:06:12.854388Z","caller":"traceutil/trace.go:171","msg":"trace[2103301065] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"445.472759ms","start":"2026-05-13T16:06:12.407505Z","end":"2026-05-13T16:06:12.852978Z","steps":["trace[2103301065] 'process raft request' (duration: 445.10024ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:12.854492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:12.407485Z","time spent":"446.953968ms","remote":"127.0.0.1:53306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-13T16:06:19.37522Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521226140983871770,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-13T16:06:19.855025Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.581403851s","expected-duration":"1s"} {"level":"info","ts":"2026-05-13T16:06:19.855538Z","caller":"traceutil/trace.go:171","msg":"trace[1504434242] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"1.581992014s","start":"2026-05-13T16:06:18.273517Z","end":"2026-05-13T16:06:19.855509Z","steps":["trace[1504434242] 'process raft request' (duration: 1.581803193s)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:19.855716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:18.273497Z","time spent":"1.582131531s","remote":"127.0.0.1:53104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-13T16:06:19.877643Z","caller":"traceutil/trace.go:171","msg":"trace[1185005643] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"1.58713829s","start":"2026-05-13T16:06:18.290476Z","end":"2026-05-13T16:06:19.877614Z","steps":["trace[1185005643] 'process raft request' (duration: 1.587009613s)"],"step_count":1} {"level":"info","ts":"2026-05-13T16:06:19.877798Z","caller":"traceutil/trace.go:171","msg":"trace[778800342] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"1.587020264s","start":"2026-05-13T16:06:18.290756Z","end":"2026-05-13T16:06:19.877776Z","steps":["trace[778800342] 'process raft request' (duration: 1.58677131s)"],"step_count":1} {"level":"info","ts":"2026-05-13T16:06:19.877811Z","caller":"traceutil/trace.go:171","msg":"trace[1084337387] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"1.58566025s","start":"2026-05-13T16:06:18.292089Z","end":"2026-05-13T16:06:19.877749Z","steps":["trace[1084337387] 'process raft request' (duration: 1.585473669s)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:19.877793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:18.290459Z","time spent":"1.587261257s","remote":"127.0.0.1:53104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-13T16:06:19.877852Z","caller":"traceutil/trace.go:171","msg":"trace[738002199] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"1.599496427s","start":"2026-05-13T16:06:18.278305Z","end":"2026-05-13T16:06:19.877801Z","steps":["trace[738002199] 'process raft request' (duration: 1.599084134s)"],"step_count":1} {"level":"info","ts":"2026-05-13T16:06:19.877883Z","caller":"traceutil/trace.go:171","msg":"trace[1344747056] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"1.577210628s","start":"2026-05-13T16:06:18.30065Z","end":"2026-05-13T16:06:19.87786Z","steps":["trace[1344747056] 'process raft request' (duration: 1.576999186s)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:19.87791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:18.292082Z","time spent":"1.585784416s","remote":"127.0.0.1:53104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-13T16:06:19.877988Z","caller":"traceutil/trace.go:171","msg":"trace[1956453725] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"1.579389877s","start":"2026-05-13T16:06:18.298584Z","end":"2026-05-13T16:06:19.877974Z","steps":["trace[1956453725] 'process raft request' (duration: 1.579019607s)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:19.878025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:18.300638Z","time spent":"1.577315313s","remote":"127.0.0.1:53104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-13T16:06:19.878017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:18.278282Z","time spent":"1.599658555s","remote":"127.0.0.1:53104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-13T16:06:19.878073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:18.298563Z","time spent":"1.579476392s","remote":"127.0.0.1:53104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-13T16:06:19.878089Z","caller":"traceutil/trace.go:171","msg":"trace[1171177826] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"1.576040404s","start":"2026-05-13T16:06:18.302034Z","end":"2026-05-13T16:06:19.878074Z","steps":["trace[1171177826] 'process raft request' (duration: 1.575660253s)"],"step_count":1} {"level":"info","ts":"2026-05-13T16:06:19.878193Z","caller":"traceutil/trace.go:171","msg":"trace[361072830] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"1.551140291s","start":"2026-05-13T16:06:18.327042Z","end":"2026-05-13T16:06:19.878182Z","steps":["trace[361072830] 'process raft request' (duration: 1.550722689s)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:19.878269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:18.327017Z","time spent":"1.551217265s","remote":"127.0.0.1:53104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-13T16:06:19.87826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:18.290749Z","time spent":"1.587099788s","remote":"127.0.0.1:53104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-13T16:06:19.878321Z","caller":"traceutil/trace.go:171","msg":"trace[684627185] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"1.501162838s","start":"2026-05-13T16:06:18.377147Z","end":"2026-05-13T16:06:19.87831Z","steps":["trace[684627185] 'process raft request' (duration: 1.500882313s)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:19.878291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:18.301943Z","time spent":"1.576293457s","remote":"127.0.0.1:53104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-13T16:06:19.878372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:18.377124Z","time spent":"1.501222422s","remote":"127.0.0.1:53104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-13T16:06:19.878198Z","caller":"traceutil/trace.go:171","msg":"trace[1585812295] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"1.525705081s","start":"2026-05-13T16:06:18.352481Z","end":"2026-05-13T16:06:19.878186Z","steps":["trace[1585812295] 'process raft request' (duration: 1.525400744s)"],"step_count":1} {"level":"info","ts":"2026-05-13T16:06:19.878477Z","caller":"traceutil/trace.go:171","msg":"trace[258569858] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"1.393013262s","start":"2026-05-13T16:06:18.485447Z","end":"2026-05-13T16:06:19.878461Z","steps":["trace[258569858] 'process raft request' (duration: 1.392819581s)"],"step_count":1} {"level":"info","ts":"2026-05-13T16:06:19.878497Z","caller":"traceutil/trace.go:171","msg":"trace[340887315] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"326.97461ms","start":"2026-05-13T16:06:19.551503Z","end":"2026-05-13T16:06:19.878478Z","steps":["trace[340887315] 'process raft request' (duration: 326.882565ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:19.878523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:18.352459Z","time spent":"1.526003327s","remote":"127.0.0.1:53104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-13T16:06:19.878563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:18.485432Z","time spent":"1.393097187s","remote":"127.0.0.1:53104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-13T16:06:19.878567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.004335012s","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-05-13T16:06:19.878477Z","caller":"traceutil/trace.go:171","msg":"trace[758928909] linearizableReadLoop","detail":"{readStateIndex:500; appliedIndex:488; }","duration":"1.004227726s","start":"2026-05-13T16:06:18.87423Z","end":"2026-05-13T16:06:19.878457Z","steps":["trace[758928909] 'read index received' (duration: 981.063853ms)","trace[758928909] 'applied index is now lower than readState.Index' (duration: 23.162783ms)"],"step_count":2} {"level":"info","ts":"2026-05-13T16:06:19.878622Z","caller":"traceutil/trace.go:171","msg":"trace[1182660481] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:487; }","duration":"1.004431537s","start":"2026-05-13T16:06:18.874175Z","end":"2026-05-13T16:06:19.878606Z","steps":["trace[1182660481] 'agreement among raft nodes before linearized reading' (duration: 1.004338152s)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:19.878611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:19.551479Z","time spent":"327.081515ms","remote":"127.0.0.1:53306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-13T16:06:19.878666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:18.874157Z","time spent":"1.00449824s","remote":"127.0.0.1:53306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-13T16:06:19.886478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.009224491s","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-05-13T16:06:19.886547Z","caller":"traceutil/trace.go:171","msg":"trace[1595448195] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:489; }","duration":"1.009321987s","start":"2026-05-13T16:06:18.877208Z","end":"2026-05-13T16:06:19.88653Z","steps":["trace[1595448195] 'agreement among raft nodes before linearized reading' (duration: 1.00919597s)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:19.886591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:18.877197Z","time spent":"1.00938442s","remote":"127.0.0.1:53306","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-05-13T16:06:19.887184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.306685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-13T16:06:19.887223Z","caller":"traceutil/trace.go:171","msg":"trace[1776335478] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:489; }","duration":"399.379769ms","start":"2026-05-13T16:06:19.487833Z","end":"2026-05-13T16:06:19.887213Z","steps":["trace[1776335478] 'agreement among raft nodes before linearized reading' (duration: 399.326246ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:19.887255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:19.487811Z","time spent":"399.436382ms","remote":"127.0.0.1:53034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-13T16:06:19.887399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"872.905992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-13T16:06:19.887433Z","caller":"traceutil/trace.go:171","msg":"trace[165882926] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:489; }","duration":"872.979235ms","start":"2026-05-13T16:06:19.014445Z","end":"2026-05-13T16:06:19.887424Z","steps":["trace[165882926] 'agreement among raft nodes before linearized reading' (duration: 872.920892ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:19.887461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:19.014422Z","time spent":"873.033329ms","remote":"127.0.0.1:53306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-13T16:06:19.887593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.00737783s","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-05-13T16:06:19.887618Z","caller":"traceutil/trace.go:171","msg":"trace[1555235787] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:489; }","duration":"1.007452295s","start":"2026-05-13T16:06:18.880159Z","end":"2026-05-13T16:06:19.887611Z","steps":["trace[1555235787] 'agreement among raft nodes before linearized reading' (duration: 1.007403422s)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:19.887637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:18.880139Z","time spent":"1.007492557s","remote":"127.0.0.1:53306","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-05-13T16:06:24.026278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.790021ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-13T16:06:24.026384Z","caller":"traceutil/trace.go:171","msg":"trace[1581762348] linearizableReadLoop","detail":"{readStateIndex:587; appliedIndex:586; }","duration":"574.038031ms","start":"2026-05-13T16:06:23.45233Z","end":"2026-05-13T16:06:24.026368Z","steps":["trace[1581762348] 'read index received' (duration: 439.937903ms)","trace[1581762348] 'applied index is now lower than readState.Index' (duration: 134.098668ms)"],"step_count":2} {"level":"info","ts":"2026-05-13T16:06:24.026467Z","caller":"traceutil/trace.go:171","msg":"trace[1314996892] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"608.51891ms","start":"2026-05-13T16:06:23.417938Z","end":"2026-05-13T16:06:24.026457Z","steps":["trace[1314996892] 'process raft request' (duration: 474.295865ms)","trace[1314996892] 'compare' (duration: 133.655693ms)"],"step_count":2} {"level":"warn","ts":"2026-05-13T16:06:24.026521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:23.417918Z","time spent":"608.579713ms","remote":"127.0.0.1:53236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":818,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-13T16:06:24.026708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"574.38164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-13T16:06:24.026736Z","caller":"traceutil/trace.go:171","msg":"trace[965033971] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:567; }","duration":"574.455614ms","start":"2026-05-13T16:06:23.452272Z","end":"2026-05-13T16:06:24.026727Z","steps":["trace[965033971] 'agreement among raft nodes before linearized reading' (duration: 574.375879ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:24.026764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:23.45225Z","time spent":"574.508988ms","remote":"127.0.0.1:53044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-13T16:06:24.027001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.128449ms","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-05-13T16:06:24.027085Z","caller":"traceutil/trace.go:171","msg":"trace[974441096] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:567; }","duration":"107.262287ms","start":"2026-05-13T16:06:23.919801Z","end":"2026-05-13T16:06:24.027063Z","steps":["trace[974441096] 'agreement among raft nodes before linearized reading' (duration: 107.088977ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:24.027358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.411066ms","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-05-13T16:06:24.027433Z","caller":"traceutil/trace.go:171","msg":"trace[887598440] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:567; }","duration":"102.530962ms","start":"2026-05-13T16:06:23.924883Z","end":"2026-05-13T16:06:24.027414Z","steps":["trace[887598440] 'agreement among raft nodes before linearized reading' (duration: 102.3097ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T16:06:25.588134Z","caller":"traceutil/trace.go:171","msg":"trace[661735841] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"114.279227ms","start":"2026-05-13T16:06:25.473827Z","end":"2026-05-13T16:06:25.588106Z","steps":["trace[661735841] 'process raft request' (duration: 107.725498ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:25.834597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.727851ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-13T16:06:25.834729Z","caller":"traceutil/trace.go:171","msg":"trace[1947393920] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"188.94619ms","start":"2026-05-13T16:06:25.645758Z","end":"2026-05-13T16:06:25.834704Z","steps":["trace[1947393920] 'process raft request' (duration: 29.028428ms)","trace[1947393920] 'compare' (duration: 159.546891ms)"],"step_count":2} {"level":"warn","ts":"2026-05-13T16:06:26.956317Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521226140983871955,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-13T16:06:26.978074Z","caller":"traceutil/trace.go:171","msg":"trace[1057214608] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"667.400708ms","start":"2026-05-13T16:06:26.31066Z","end":"2026-05-13T16:06:26.978061Z","steps":["trace[1057214608] 'process raft request' (duration: 667.276181ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:26.978239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:26.310636Z","time spent":"667.556557ms","remote":"127.0.0.1:53220","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-05-13T16:06:27.352013Z","caller":"traceutil/trace.go:171","msg":"trace[1497507269] linearizableReadLoop","detail":"{readStateIndex:608; appliedIndex:606; }","duration":"898.987706ms","start":"2026-05-13T16:06:26.452999Z","end":"2026-05-13T16:06:27.351987Z","steps":["trace[1497507269] 'read index received' (duration: 525.014321ms)","trace[1497507269] 'applied index is now lower than readState.Index' (duration: 373.972215ms)"],"step_count":2} {"level":"info","ts":"2026-05-13T16:06:27.352162Z","caller":"traceutil/trace.go:171","msg":"trace[1432470215] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"1.00832588s","start":"2026-05-13T16:06:26.34382Z","end":"2026-05-13T16:06:27.352145Z","steps":["trace[1432470215] 'process raft request' (duration: 990.282544ms)","trace[1432470215] 'compare' (duration: 17.738029ms)"],"step_count":2} {"level":"warn","ts":"2026-05-13T16:06:27.352271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:26.343779Z","time spent":"1.008426636s","remote":"127.0.0.1:53378","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-13T16:06:27.352536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.495695ms","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-05-13T16:06:27.352566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"519.020622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-13T16:06:27.352704Z","caller":"traceutil/trace.go:171","msg":"trace[298882145] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:587; }","duration":"241.655365ms","start":"2026-05-13T16:06:27.110986Z","end":"2026-05-13T16:06:27.352642Z","steps":["trace[298882145] 'agreement among raft nodes before linearized reading' (duration: 241.449933ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T16:06:27.352734Z","caller":"traceutil/trace.go:171","msg":"trace[173582734] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:587; }","duration":"519.15815ms","start":"2026-05-13T16:06:26.833506Z","end":"2026-05-13T16:06:27.352664Z","steps":["trace[173582734] 'agreement among raft nodes before linearized reading' (duration: 518.915886ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:27.352963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"899.957812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-13T16:06:27.353027Z","caller":"traceutil/trace.go:171","msg":"trace[311948001] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:587; }","duration":"900.051947ms","start":"2026-05-13T16:06:26.452957Z","end":"2026-05-13T16:06:27.353009Z","steps":["trace[311948001] 'agreement among raft nodes before linearized reading' (duration: 899.968763ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:27.353074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:26.45294Z","time spent":"900.123352ms","remote":"127.0.0.1:53044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-13T16:06:27.353237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:26.833467Z","time spent":"519.454676ms","remote":"127.0.0.1:59524","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-05-13T16:06:27.353698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.051158ms","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-05-13T16:06:27.353795Z","caller":"traceutil/trace.go:171","msg":"trace[2087752856] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:587; }","duration":"277.189665ms","start":"2026-05-13T16:06:27.076591Z","end":"2026-05-13T16:06:27.353781Z","steps":["trace[2087752856] 'agreement among raft nodes before linearized reading' (duration: 277.069679ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:27.353992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.870685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-13T16:06:27.35402Z","caller":"traceutil/trace.go:171","msg":"trace[2103119714] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:587; }","duration":"187.938148ms","start":"2026-05-13T16:06:27.166074Z","end":"2026-05-13T16:06:27.354012Z","steps":["trace[2103119714] 'agreement among raft nodes before linearized reading' (duration: 187.881575ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:27.354045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.360145ms","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-05-13T16:06:27.354163Z","caller":"traceutil/trace.go:171","msg":"trace[1659198364] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:587; }","duration":"242.496692ms","start":"2026-05-13T16:06:27.111643Z","end":"2026-05-13T16:06:27.354139Z","steps":["trace[1659198364] 'agreement among raft nodes before linearized reading' (duration: 242.344373ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:27.354193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.150853ms","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-05-13T16:06:27.354271Z","caller":"traceutil/trace.go:171","msg":"trace[1848751774] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:587; }","duration":"216.25141ms","start":"2026-05-13T16:06:27.138012Z","end":"2026-05-13T16:06:27.354263Z","steps":["trace[1848751774] 'agreement among raft nodes before linearized reading' (duration: 216.158574ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:27.354411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-13T16:06:27.354455Z","caller":"traceutil/trace.go:171","msg":"trace[1836066326] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:587; }","duration":"216.871795ms","start":"2026-05-13T16:06:27.137572Z","end":"2026-05-13T16:06:27.354444Z","steps":["trace[1836066326] 'agreement among raft nodes before linearized reading' (duration: 216.804741ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:27.354589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.211399ms","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-05-13T16:06:27.35462Z","caller":"traceutil/trace.go:171","msg":"trace[277561327] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:587; }","duration":"386.274832ms","start":"2026-05-13T16:06:26.968338Z","end":"2026-05-13T16:06:27.354613Z","steps":["trace[277561327] 'agreement among raft nodes before linearized reading' (duration: 386.226679ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:27.354641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:26.968236Z","time spent":"386.399579ms","remote":"127.0.0.1:59550","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/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"warn","ts":"2026-05-13T16:06:27.354773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.178592ms","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-05-13T16:06:27.354794Z","caller":"traceutil/trace.go:171","msg":"trace[1759491745] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:587; }","duration":"278.229814ms","start":"2026-05-13T16:06:27.076556Z","end":"2026-05-13T16:06:27.354786Z","steps":["trace[1759491745] 'agreement among raft nodes before linearized reading' (duration: 278.176961ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:27.354896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.943315ms","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-05-13T16:06:27.354919Z","caller":"traceutil/trace.go:171","msg":"trace[1771239940] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:587; }","duration":"310.991548ms","start":"2026-05-13T16:06:27.04392Z","end":"2026-05-13T16:06:27.354912Z","steps":["trace[1771239940] 'agreement among raft nodes before linearized reading' (duration: 310.954866ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:27.354938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:27.043904Z","time spent":"311.02811ms","remote":"127.0.0.1:59576","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-05-13T16:06:27.355037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.406881ms","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-05-13T16:06:27.35506Z","caller":"traceutil/trace.go:171","msg":"trace[33090421] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:587; }","duration":"311.432813ms","start":"2026-05-13T16:06:27.043621Z","end":"2026-05-13T16:06:27.355054Z","steps":["trace[33090421] 'agreement among raft nodes before linearized reading' (duration: 311.399001ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:27.355078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:27.043557Z","time spent":"311.515088ms","remote":"127.0.0.1:59576","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":"warn","ts":"2026-05-13T16:06:27.355149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.942132ms","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-05-13T16:06:27.355165Z","caller":"traceutil/trace.go:171","msg":"trace[1937039076] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:587; }","duration":"311.998056ms","start":"2026-05-13T16:06:27.043162Z","end":"2026-05-13T16:06:27.35516Z","steps":["trace[1937039076] 'agreement among raft nodes before linearized reading' (duration: 311.972694ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:27.355182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:27.043142Z","time spent":"312.035278ms","remote":"127.0.0.1:59576","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":"warn","ts":"2026-05-13T16:06:27.355258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.487961ms","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":"info","ts":"2026-05-13T16:06:27.355281Z","caller":"traceutil/trace.go:171","msg":"trace[791336477] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:587; }","duration":"369.513292ms","start":"2026-05-13T16:06:26.985762Z","end":"2026-05-13T16:06:27.355276Z","steps":["trace[791336477] 'agreement among raft nodes before linearized reading' (duration: 369.47816ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:27.3553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:26.985755Z","time spent":"369.539704ms","remote":"127.0.0.1:59562","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-05-13T16:06:27.355463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.424298ms","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":"info","ts":"2026-05-13T16:06:27.355488Z","caller":"traceutil/trace.go:171","msg":"trace[1620284793] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:587; }","duration":"372.46048ms","start":"2026-05-13T16:06:26.983021Z","end":"2026-05-13T16:06:27.355482Z","steps":["trace[1620284793] 'agreement among raft nodes before linearized reading' (duration: 372.422368ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:27.355503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.482563ms","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":"warn","ts":"2026-05-13T16:06:27.355563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.555105ms","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-05-13T16:06:27.355591Z","caller":"traceutil/trace.go:171","msg":"trace[2086589263] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:587; }","duration":"464.567898ms","start":"2026-05-13T16:06:26.890978Z","end":"2026-05-13T16:06:27.355546Z","steps":["trace[2086589263] 'agreement among raft nodes before linearized reading' (duration: 464.486433ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T16:06:27.355615Z","caller":"traceutil/trace.go:171","msg":"trace[1396887654] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:587; }","duration":"372.628919ms","start":"2026-05-13T16:06:26.982976Z","end":"2026-05-13T16:06:27.355605Z","steps":["trace[1396887654] 'agreement among raft nodes before linearized reading' (duration: 372.567326ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:27.355638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:26.98296Z","time spent":"372.670672ms","remote":"127.0.0.1:59562","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":"warn","ts":"2026-05-13T16:06:27.35375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.186847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-13T16:06:27.355747Z","caller":"traceutil/trace.go:171","msg":"trace[2064961692] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:587; }","duration":"189.206311ms","start":"2026-05-13T16:06:27.166516Z","end":"2026-05-13T16:06:27.355722Z","steps":["trace[2064961692] 'agreement among raft nodes before linearized reading' (duration: 187.196246ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:27.355793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.578349ms","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-05-13T16:06:27.355815Z","caller":"traceutil/trace.go:171","msg":"trace[474236351] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:587; }","duration":"387.088009ms","start":"2026-05-13T16:06:26.96872Z","end":"2026-05-13T16:06:27.355808Z","steps":["trace[474236351] 'agreement among raft nodes before linearized reading' (duration: 387.021865ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:27.355873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:26.968637Z","time spent":"387.226806ms","remote":"127.0.0.1:59550","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/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 "} {"level":"warn","ts":"2026-05-13T16:06:27.355932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.876818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-13T16:06:27.355906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:26.890963Z","time spent":"464.925368ms","remote":"127.0.0.1:59526","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":"info","ts":"2026-05-13T16:06:27.355971Z","caller":"traceutil/trace.go:171","msg":"trace[1754950171] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:587; }","duration":"244.949401ms","start":"2026-05-13T16:06:27.111012Z","end":"2026-05-13T16:06:27.355961Z","steps":["trace[1754950171] 'agreement among raft nodes before linearized reading' (duration: 244.888548ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:27.356025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.417948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-13T16:06:27.35605Z","caller":"traceutil/trace.go:171","msg":"trace[1913422305] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:587; }","duration":"387.45945ms","start":"2026-05-13T16:06:26.968584Z","end":"2026-05-13T16:06:27.356043Z","steps":["trace[1913422305] 'agreement among raft nodes before linearized reading' (duration: 387.421828ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:27.356069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:26.968566Z","time spent":"387.498132ms","remote":"127.0.0.1:59550","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/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 "} {"level":"warn","ts":"2026-05-13T16:06:27.356144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.403926ms","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-05-13T16:06:27.356185Z","caller":"traceutil/trace.go:171","msg":"trace[2031199840] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:587; }","duration":"420.460139ms","start":"2026-05-13T16:06:26.935714Z","end":"2026-05-13T16:06:27.356174Z","steps":["trace[2031199840] 'agreement among raft nodes before linearized reading' (duration: 420.399866ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:27.356215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:26.935709Z","time spent":"420.499001ms","remote":"127.0.0.1:59540","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-05-13T16:06:27.356385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.714613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-13T16:06:27.35644Z","caller":"traceutil/trace.go:171","msg":"trace[472118294] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:587; }","duration":"420.83485ms","start":"2026-05-13T16:06:26.935596Z","end":"2026-05-13T16:06:27.356431Z","steps":["trace[472118294] 'agreement among raft nodes before linearized reading' (duration: 420.720474ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:27.356469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:26.93559Z","time spent":"420.871223ms","remote":"127.0.0.1:59526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 "} {"level":"warn","ts":"2026-05-13T16:06:27.356562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.020399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-13T16:06:27.353909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.251139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-13T16:06:27.353943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.762169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-13T16:06:27.356597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.271385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-13T16:06:27.356618Z","caller":"traceutil/trace.go:171","msg":"trace[985827043] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:587; }","duration":"190.467053ms","start":"2026-05-13T16:06:27.16614Z","end":"2026-05-13T16:06:27.356607Z","steps":["trace[985827043] 'agreement among raft nodes before linearized reading' (duration: 187.787671ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:27.356623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.659739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-13T16:06:27.356626Z","caller":"traceutil/trace.go:171","msg":"trace[576983457] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:587; }","duration":"421.330409ms","start":"2026-05-13T16:06:26.935288Z","end":"2026-05-13T16:06:27.356618Z","steps":["trace[576983457] 'agreement among raft nodes before linearized reading' (duration: 421.285156ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T16:06:27.35665Z","caller":"traceutil/trace.go:171","msg":"trace[1202723264] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:587; }","duration":"522.697151ms","start":"2026-05-13T16:06:26.833944Z","end":"2026-05-13T16:06:27.356641Z","steps":["trace[1202723264] 'agreement among raft nodes before linearized reading' (duration: 522.658089ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:27.356655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:26.93527Z","time spent":"421.377841ms","remote":"127.0.0.1:59540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"warn","ts":"2026-05-13T16:06:27.356676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:26.833938Z","time spent":"522.732843ms","remote":"127.0.0.1:59524","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-05-13T16:06:27.356765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.682542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-13T16:06:27.356796Z","caller":"traceutil/trace.go:171","msg":"trace[1730028155] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:587; }","duration":"219.154834ms","start":"2026-05-13T16:06:27.137634Z","end":"2026-05-13T16:06:27.356789Z","steps":["trace[1730028155] 'agreement among raft nodes before linearized reading' (duration: 216.222468ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T16:06:27.356808Z","caller":"traceutil/trace.go:171","msg":"trace[1140535894] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:587; }","duration":"465.735154ms","start":"2026-05-13T16:06:26.891064Z","end":"2026-05-13T16:06:27.356799Z","steps":["trace[1140535894] 'agreement among raft nodes before linearized reading' (duration: 465.676591ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T16:06:27.356814Z","caller":"traceutil/trace.go:171","msg":"trace[1927982271] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:587; }","duration":"523.224081ms","start":"2026-05-13T16:06:26.833519Z","end":"2026-05-13T16:06:27.356727Z","steps":["trace[1927982271] 'agreement among raft nodes before linearized reading' (duration: 523.014659ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:27.356841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:26.89106Z","time spent":"465.769576ms","remote":"127.0.0.1:59526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"warn","ts":"2026-05-13T16:06:27.356852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:26.833516Z","time spent":"523.323556ms","remote":"127.0.0.1:59524","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-13T16:06:27.35551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:26.983017Z","time spent":"372.487561ms","remote":"127.0.0.1:59562","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":"warn","ts":"2026-05-13T16:06:28.2091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"646.058462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-13T16:06:28.209202Z","caller":"traceutil/trace.go:171","msg":"trace[178258531] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:587; }","duration":"646.20372ms","start":"2026-05-13T16:06:27.56298Z","end":"2026-05-13T16:06:28.209183Z","steps":["trace[178258531] 'count revisions from in-memory index tree' (duration: 645.990268ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:28.209239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:27.562964Z","time spent":"646.266674ms","remote":"127.0.0.1:59682","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-13T16:06:28.209531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"757.564404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-13T16:06:28.209567Z","caller":"traceutil/trace.go:171","msg":"trace[907267954] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:587; }","duration":"757.629307ms","start":"2026-05-13T16:06:27.451927Z","end":"2026-05-13T16:06:28.209556Z","steps":["trace[907267954] 'range keys from in-memory index tree' (duration: 757.512221ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:28.209595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:27.45191Z","time spent":"757.67777ms","remote":"127.0.0.1:53034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-13T16:06:28.209613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"595.73084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-13T16:06:28.209675Z","caller":"traceutil/trace.go:171","msg":"trace[1942541424] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:587; }","duration":"595.832585ms","start":"2026-05-13T16:06:27.613825Z","end":"2026-05-13T16:06:28.209658Z","steps":["trace[1942541424] 'range keys from in-memory index tree' (duration: 595.684297ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:28.209705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:27.613819Z","time spent":"595.878378ms","remote":"127.0.0.1:59684","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/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 "} {"level":"warn","ts":"2026-05-13T16:06:28.209745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.104471ms","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-05-13T16:06:28.209792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"728.110338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-13T16:06:28.209813Z","caller":"traceutil/trace.go:171","msg":"trace[302535800] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:587; }","duration":"452.190845ms","start":"2026-05-13T16:06:27.757594Z","end":"2026-05-13T16:06:28.209785Z","steps":["trace[302535800] 'range keys from in-memory index tree' (duration: 452.032247ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:28.209848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"727.373497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-13T16:06:28.209849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:27.757559Z","time spent":"452.28034ms","remote":"127.0.0.1:59692","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":"warn","ts":"2026-05-13T16:06:28.209868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"646.827326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-13T16:06:28.209871Z","caller":"traceutil/trace.go:171","msg":"trace[55497389] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:587; }","duration":"727.439011ms","start":"2026-05-13T16:06:27.482426Z","end":"2026-05-13T16:06:28.209865Z","steps":["trace[55497389] 'range keys from in-memory index tree' (duration: 727.318103ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T16:06:28.209887Z","caller":"traceutil/trace.go:171","msg":"trace[2015214276] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:587; }","duration":"646.866928ms","start":"2026-05-13T16:06:27.563014Z","end":"2026-05-13T16:06:28.209881Z","steps":["trace[2015214276] 'range keys from in-memory index tree' (duration: 646.781133ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:28.209901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:27.482408Z","time spent":"727.484723ms","remote":"127.0.0.1:59648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 "} {"level":"warn","ts":"2026-05-13T16:06:28.209924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"646.443414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-13T16:06:28.209941Z","caller":"traceutil/trace.go:171","msg":"trace[1326598733] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:587; }","duration":"646.476846ms","start":"2026-05-13T16:06:27.56346Z","end":"2026-05-13T16:06:28.209936Z","steps":["trace[1326598733] 'range keys from in-memory index tree' (duration: 646.398031ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:28.209961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:27.56345Z","time spent":"646.500807ms","remote":"127.0.0.1:59668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 "} {"level":"warn","ts":"2026-05-13T16:06:28.210011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.219858ms","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":"warn","ts":"2026-05-13T16:06:28.210048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"596.802941ms","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-05-13T16:06:28.21005Z","caller":"traceutil/trace.go:171","msg":"trace[1299049768] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:587; }","duration":"452.299792ms","start":"2026-05-13T16:06:27.757741Z","end":"2026-05-13T16:06:28.210041Z","steps":["trace[1299049768] 'count revisions from in-memory index tree' (duration: 452.122602ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:28.210058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"710.779083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-13T16:06:28.210083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"596.903016ms","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":"warn","ts":"2026-05-13T16:06:28.21008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:27.757718Z","time spent":"452.354125ms","remote":"127.0.0.1:59692","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":"info","ts":"2026-05-13T16:06:28.210092Z","caller":"traceutil/trace.go:171","msg":"trace[469029104] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:587; }","duration":"710.816545ms","start":"2026-05-13T16:06:27.499261Z","end":"2026-05-13T16:06:28.210077Z","steps":["trace[469029104] 'range keys from in-memory index tree' (duration: 710.748691ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T16:06:28.210128Z","caller":"traceutil/trace.go:171","msg":"trace[1282426404] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:587; }","duration":"596.943398ms","start":"2026-05-13T16:06:27.613157Z","end":"2026-05-13T16:06:28.2101Z","steps":["trace[1282426404] 'range keys from in-memory index tree' (duration: 596.78986ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:28.210141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:27.499255Z","time spent":"710.880559ms","remote":"127.0.0.1:59658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 "} {"level":"warn","ts":"2026-05-13T16:06:28.210176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:27.613145Z","time spent":"596.996842ms","remote":"127.0.0.1:59684","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/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 "} {"level":"warn","ts":"2026-05-13T16:06:28.20976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"728.034554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-13T16:06:28.21029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"710.915131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-13T16:06:28.210294Z","caller":"traceutil/trace.go:171","msg":"trace[370391367] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:587; }","duration":"728.575505ms","start":"2026-05-13T16:06:27.481708Z","end":"2026-05-13T16:06:28.210283Z","steps":["trace[370391367] 'range keys from in-memory index tree' (duration: 728.010133ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:28.210329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:27.481705Z","time spent":"728.612498ms","remote":"127.0.0.1:59648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 "} {"level":"warn","ts":"2026-05-13T16:06:28.210361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"710.129457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-13T16:06:28.210385Z","caller":"traceutil/trace.go:171","msg":"trace[915392497] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:587; }","duration":"710.163688ms","start":"2026-05-13T16:06:27.500215Z","end":"2026-05-13T16:06:28.210379Z","steps":["trace[915392497] 'range keys from in-memory index tree' (duration: 710.100435ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T16:06:28.20982Z","caller":"traceutil/trace.go:171","msg":"trace[2036091010] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:587; }","duration":"728.155551ms","start":"2026-05-13T16:06:27.481655Z","end":"2026-05-13T16:06:28.20981Z","steps":["trace[2036091010] 'count revisions from in-memory index tree' (duration: 728.035764ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:28.210453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:27.481642Z","time spent":"728.801668ms","remote":"127.0.0.1:59648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"warn","ts":"2026-05-13T16:06:28.209906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:27.563004Z","time spent":"646.89719ms","remote":"127.0.0.1:59682","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-05-13T16:06:28.210491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"667.886343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-13T16:06:28.210518Z","caller":"traceutil/trace.go:171","msg":"trace[1593518226] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:587; }","duration":"667.912235ms","start":"2026-05-13T16:06:27.542597Z","end":"2026-05-13T16:06:28.210509Z","steps":["trace[1593518226] 'range keys from in-memory index tree' (duration: 667.834431ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:28.210545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:27.542488Z","time spent":"668.048833ms","remote":"127.0.0.1:59668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"info","ts":"2026-05-13T16:06:28.210661Z","caller":"traceutil/trace.go:171","msg":"trace[2075476667] linearizableReadLoop","detail":"{readStateIndex:609; appliedIndex:608; }","duration":"280.998529ms","start":"2026-05-13T16:06:27.929649Z","end":"2026-05-13T16:06:28.210647Z","steps":["trace[2075476667] 'read index received' (duration: 225.804837ms)","trace[2075476667] 'applied index is now lower than readState.Index' (duration: 55.192591ms)"],"step_count":2} {"level":"info","ts":"2026-05-13T16:06:28.210064Z","caller":"traceutil/trace.go:171","msg":"trace[1195438566] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:587; }","duration":"596.832662ms","start":"2026-05-13T16:06:27.613227Z","end":"2026-05-13T16:06:28.210059Z","steps":["trace[1195438566] 'count revisions from in-memory index tree' (duration: 596.770219ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:28.210709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:27.61322Z","time spent":"597.48012ms","remote":"127.0.0.1:59684","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/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "} {"level":"info","ts":"2026-05-13T16:06:28.21033Z","caller":"traceutil/trace.go:171","msg":"trace[911643631] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:587; }","duration":"710.969044ms","start":"2026-05-13T16:06:27.499351Z","end":"2026-05-13T16:06:28.21032Z","steps":["trace[911643631] 'count revisions from in-memory index tree' (duration: 710.88741ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:28.210761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:27.499348Z","time spent":"711.396418ms","remote":"127.0.0.1:59658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"warn","ts":"2026-05-13T16:06:28.210425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:27.500211Z","time spent":"710.20593ms","remote":"127.0.0.1:59658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 "} {"level":"warn","ts":"2026-05-13T16:06:28.210463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"667.930566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-13T16:06:28.211004Z","caller":"traceutil/trace.go:171","msg":"trace[1169125937] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:587; }","duration":"668.498898ms","start":"2026-05-13T16:06:27.542494Z","end":"2026-05-13T16:06:28.210993Z","steps":["trace[1169125937] 'count revisions from in-memory index tree' (duration: 667.871693ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:28.211054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:27.542483Z","time spent":"668.556002ms","remote":"127.0.0.1:59668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-13T16:06:28.21117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.517648ms","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-05-13T16:06:28.211183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.482337ms","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-05-13T16:06:28.211197Z","caller":"traceutil/trace.go:171","msg":"trace[350926200] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:588; }","duration":"281.565981ms","start":"2026-05-13T16:06:27.929624Z","end":"2026-05-13T16:06:28.21119Z","steps":["trace[350926200] 'agreement among raft nodes before linearized reading' (duration: 281.444424ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T16:06:28.211218Z","caller":"traceutil/trace.go:171","msg":"trace[262919474] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:588; }","duration":"281.517858ms","start":"2026-05-13T16:06:27.929683Z","end":"2026-05-13T16:06:28.211201Z","steps":["trace[262919474] 'agreement among raft nodes before linearized reading' (duration: 281.476916ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:28.211372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.742846ms","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-05-13T16:06:28.211418Z","caller":"traceutil/trace.go:171","msg":"trace[1716671149] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:588; }","duration":"140.80116ms","start":"2026-05-13T16:06:28.0706Z","end":"2026-05-13T16:06:28.211401Z","steps":["trace[1716671149] 'agreement among raft nodes before linearized reading' (duration: 140.749977ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:28.211621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.528801ms","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-05-13T16:06:28.211663Z","caller":"traceutil/trace.go:171","msg":"trace[37072017] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:588; }","duration":"141.618547ms","start":"2026-05-13T16:06:28.070035Z","end":"2026-05-13T16:06:28.211653Z","steps":["trace[37072017] 'agreement among raft nodes before linearized reading' (duration: 141.558364ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:28.211801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.738713ms","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-05-13T16:06:28.211835Z","caller":"traceutil/trace.go:171","msg":"trace[321929886] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:588; }","duration":"141.823308ms","start":"2026-05-13T16:06:28.070003Z","end":"2026-05-13T16:06:28.211827Z","steps":["trace[321929886] 'agreement among raft nodes before linearized reading' (duration: 141.765395ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:28.211942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.254948ms","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-05-13T16:06:28.21198Z","caller":"traceutil/trace.go:171","msg":"trace[712724964] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:588; }","duration":"161.306761ms","start":"2026-05-13T16:06:28.050666Z","end":"2026-05-13T16:06:28.211973Z","steps":["trace[712724964] 'agreement among raft nodes before linearized reading' (duration: 161.256778ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:28.212096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.482261ms","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-05-13T16:06:28.212131Z","caller":"traceutil/trace.go:171","msg":"trace[698475276] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:588; }","duration":"161.533254ms","start":"2026-05-13T16:06:28.05059Z","end":"2026-05-13T16:06:28.212123Z","steps":["trace[698475276] 'agreement among raft nodes before linearized reading' (duration: 161.481691ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T16:06:28.212157Z","caller":"traceutil/trace.go:171","msg":"trace[1086793788] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"428.109266ms","start":"2026-05-13T16:06:27.784038Z","end":"2026-05-13T16:06:28.212147Z","steps":["trace[1086793788] 'process raft request' (duration: 371.622201ms)","trace[1086793788] 'compare' (duration: 53.606701ms)"],"step_count":2} {"level":"warn","ts":"2026-05-13T16:06:28.212239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:27.784009Z","time spent":"428.16773ms","remote":"127.0.0.1:53158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-13T16:06:28.212261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.077554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-13T16:06:28.212285Z","caller":"traceutil/trace.go:171","msg":"trace[1788065037] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:588; }","duration":"162.135808ms","start":"2026-05-13T16:06:28.050142Z","end":"2026-05-13T16:06:28.212278Z","steps":["trace[1788065037] 'agreement among raft nodes before linearized reading' (duration: 162.078514ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:28.212403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.405773ms","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-05-13T16:06:28.212434Z","caller":"traceutil/trace.go:171","msg":"trace[166353255] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:588; }","duration":"162.437085ms","start":"2026-05-13T16:06:28.04999Z","end":"2026-05-13T16:06:28.212427Z","steps":["trace[166353255] 'agreement among raft nodes before linearized reading' (duration: 162.389712ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:28.212552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.566563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-13T16:06:28.212586Z","caller":"traceutil/trace.go:171","msg":"trace[1985061099] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:588; }","duration":"162.709621ms","start":"2026-05-13T16:06:28.049867Z","end":"2026-05-13T16:06:28.212576Z","steps":["trace[1985061099] 'agreement among raft nodes before linearized reading' (duration: 162.657048ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:28.212695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.732222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-13T16:06:28.212729Z","caller":"traceutil/trace.go:171","msg":"trace[1316120710] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:588; }","duration":"162.783645ms","start":"2026-05-13T16:06:28.049934Z","end":"2026-05-13T16:06:28.212718Z","steps":["trace[1316120710] 'agreement among raft nodes before linearized reading' (duration: 162.736942ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:28.212844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.665353ms","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-05-13T16:06:28.212876Z","caller":"traceutil/trace.go:171","msg":"trace[508605506] 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:588; }","duration":"181.705855ms","start":"2026-05-13T16:06:28.031163Z","end":"2026-05-13T16:06:28.212868Z","steps":["trace[508605506] 'agreement among raft nodes before linearized reading' (duration: 181.653812ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:28.212999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.856624ms","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-05-13T16:06:28.213031Z","caller":"traceutil/trace.go:171","msg":"trace[1857862645] 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:588; }","duration":"181.917467ms","start":"2026-05-13T16:06:28.031106Z","end":"2026-05-13T16:06:28.213024Z","steps":["trace[1857862645] 'agreement among raft nodes before linearized reading' (duration: 181.874015ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:28.213132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.514682ms","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-05-13T16:06:28.213162Z","caller":"traceutil/trace.go:171","msg":"trace[626987386] 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:588; }","duration":"182.747355ms","start":"2026-05-13T16:06:28.030408Z","end":"2026-05-13T16:06:28.213155Z","steps":["trace[626987386] 'agreement among raft nodes before linearized reading' (duration: 182.705102ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:28.213279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.700588ms","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-05-13T16:06:28.213315Z","caller":"traceutil/trace.go:171","msg":"trace[319496688] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:588; }","duration":"204.767952ms","start":"2026-05-13T16:06:28.008536Z","end":"2026-05-13T16:06:28.213304Z","steps":["trace[319496688] 'agreement among raft nodes before linearized reading' (duration: 204.706269ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:28.213338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.821126ms","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-05-13T16:06:28.213587Z","caller":"traceutil/trace.go:171","msg":"trace[797945874] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:588; }","duration":"205.094501ms","start":"2026-05-13T16:06:28.008485Z","end":"2026-05-13T16:06:28.21358Z","steps":["trace[797945874] 'agreement among raft nodes before linearized reading' (duration: 204.830676ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:28.213745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.230449ms","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":"info","ts":"2026-05-13T16:06:28.213767Z","caller":"traceutil/trace.go:171","msg":"trace[334881327] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:588; }","duration":"205.294732ms","start":"2026-05-13T16:06:28.008466Z","end":"2026-05-13T16:06:28.213761Z","steps":["trace[334881327] 'agreement among raft nodes before linearized reading' (duration: 205.25857ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:28.213852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.175354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-13T16:06:28.21389Z","caller":"traceutil/trace.go:171","msg":"trace[703165261] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:588; }","duration":"257.193805ms","start":"2026-05-13T16:06:27.95667Z","end":"2026-05-13T16:06:28.213864Z","steps":["trace[703165261] 'agreement among raft nodes before linearized reading' (duration: 257.164144ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:28.214124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.117488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-13T16:06:28.214148Z","caller":"traceutil/trace.go:171","msg":"trace[1781431157] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:588; }","duration":"258.167271ms","start":"2026-05-13T16:06:27.955975Z","end":"2026-05-13T16:06:28.214142Z","steps":["trace[1781431157] 'agreement among raft nodes before linearized reading' (duration: 258.114408ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:28.214229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.450568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-13T16:06:28.214244Z","caller":"traceutil/trace.go:171","msg":"trace[1332708343] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:588; }","duration":"258.4894ms","start":"2026-05-13T16:06:27.95575Z","end":"2026-05-13T16:06:28.21424Z","steps":["trace[1332708343] 'agreement among raft nodes before linearized reading' (duration: 258.460148ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:28.214381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.060313ms","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":"info","ts":"2026-05-13T16:06:28.214403Z","caller":"traceutil/trace.go:171","msg":"trace[2071666523] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:588; }","duration":"284.095976ms","start":"2026-05-13T16:06:27.930302Z","end":"2026-05-13T16:06:28.214398Z","steps":["trace[2071666523] 'agreement among raft nodes before linearized reading' (duration: 284.041523ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:28.953664Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521226140983871981,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-13T16:06:29.453796Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521226140983871981,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-13T16:06:29.804381Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.584880421s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-13T16:06:30.45358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000409589s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-13T16:06:30.453679Z","caller":"traceutil/trace.go:171","msg":"trace[141636556] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000580188s","start":"2026-05-13T16:06:28.453082Z","end":"2026-05-13T16:06:30.453662Z","steps":["trace[141636556] 'agreement among raft nodes before linearized reading' (duration: 2.00043179s)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:30.453736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:28.453064Z","time spent":"2.000659983s","remote":"127.0.0.1:53034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/13 16:06:30 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-13T16:06:31.091678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:28.662217Z","time spent":"2.429456525s","remote":"127.0.0.1:59740","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-05-13T16:06:31.091841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.287043007s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-13T16:06:31.091957Z","caller":"traceutil/trace.go:171","msg":"trace[189406566] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"2.872513083s","start":"2026-05-13T16:06:28.219425Z","end":"2026-05-13T16:06:31.091938Z","steps":["trace[189406566] 'process raft request' (duration: 1.585298025s)","trace[189406566] 'compare' (duration: 1.286367489s)"],"step_count":2} {"level":"warn","ts":"2026-05-13T16:06:31.092021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:28.219412Z","time spent":"2.872580587s","remote":"127.0.0.1:53306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-13T16:06:31.180623Z","caller":"traceutil/trace.go:171","msg":"trace[210831065] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"2.960568229s","start":"2026-05-13T16:06:28.220014Z","end":"2026-05-13T16:06:31.180582Z","steps":["trace[210831065] 'process raft request' (duration: 2.960142144s)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:31.180766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:28.220006Z","time spent":"2.960685425s","remote":"127.0.0.1:53306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-13T16:06:31.18064Z","caller":"traceutil/trace.go:171","msg":"trace[421425130] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"2.960523656s","start":"2026-05-13T16:06:28.220094Z","end":"2026-05-13T16:06:31.180618Z","steps":["trace[421425130] 'process raft request' (duration: 2.960415s)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:31.180997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:28.220089Z","time spent":"2.960855605s","remote":"127.0.0.1:53306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-13T16:06:31.181052Z","caller":"traceutil/trace.go:171","msg":"trace[32262149] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"2.960747669s","start":"2026-05-13T16:06:28.220287Z","end":"2026-05-13T16:06:31.181035Z","steps":["trace[32262149] 'process raft request' (duration: 2.960278292s)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:31.181874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:28.22028Z","time spent":"2.961519013s","remote":"127.0.0.1:53306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-13T16:06:31.181106Z","caller":"traceutil/trace.go:171","msg":"trace[210738154] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"2.909047087s","start":"2026-05-13T16:06:28.272052Z","end":"2026-05-13T16:06:31.181099Z","steps":["trace[210738154] 'process raft request' (duration: 2.908846785s)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:31.181995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:28.272026Z","time spent":"2.90995371s","remote":"127.0.0.1:53528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-13T16:06:31.1811Z","caller":"traceutil/trace.go:171","msg":"trace[1574714814] linearizableReadLoop","detail":"{readStateIndex:614; appliedIndex:609; }","duration":"2.727966047s","start":"2026-05-13T16:06:28.453116Z","end":"2026-05-13T16:06:31.181082Z","steps":["trace[1574714814] 'read index received' (duration: 1.351619532s)","trace[1574714814] 'applied index is now lower than readState.Index' (duration: 1.376345195s)"],"step_count":2} {"level":"info","ts":"2026-05-13T16:06:31.18322Z","caller":"traceutil/trace.go:171","msg":"trace[1370085322] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"1.023741471s","start":"2026-05-13T16:06:30.159458Z","end":"2026-05-13T16:06:31.1832Z","steps":["trace[1370085322] 'process raft request' (duration: 1.023450874s)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:31.183279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:30.159422Z","time spent":"1.023827856s","remote":"127.0.0.1:53306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-13T16:06:31.183919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.534459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.223\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-13T16:06:31.184025Z","caller":"traceutil/trace.go:171","msg":"trace[1641847649] range","detail":"{range_begin:/registry/masterleases/199.204.45.223; range_end:; response_count:1; response_revision:594; }","duration":"487.70937ms","start":"2026-05-13T16:06:30.696298Z","end":"2026-05-13T16:06:31.184008Z","steps":["trace[1641847649] 'agreement among raft nodes before linearized reading' (duration: 487.430163ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:31.184181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:30.69628Z","time spent":"487.88533ms","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.223\" "} {"level":"warn","ts":"2026-05-13T16:06:31.184693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"730.826908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-13T16:06:31.184772Z","caller":"traceutil/trace.go:171","msg":"trace[1810960930] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:594; }","duration":"730.935373ms","start":"2026-05-13T16:06:30.453811Z","end":"2026-05-13T16:06:31.184746Z","steps":["trace[1810960930] 'agreement among raft nodes before linearized reading' (duration: 729.223594ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:31.18499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:30.453795Z","time spent":"731.184138ms","remote":"127.0.0.1:53044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-13T16:06:33.072619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"621.817314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-13T16:06:33.072738Z","caller":"traceutil/trace.go:171","msg":"trace[1523228065] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:614; }","duration":"621.985674ms","start":"2026-05-13T16:06:32.450729Z","end":"2026-05-13T16:06:33.072715Z","steps":["trace[1523228065] 'range keys from in-memory index tree' (duration: 621.714078ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:33.072795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:32.450712Z","time spent":"622.070149ms","remote":"127.0.0.1:53034","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-05-13T16:06:43.261996Z","caller":"traceutil/trace.go:171","msg":"trace[1014610338] transaction","detail":"{read_only:false; response_revision:737; number_of_response:1; }","duration":"108.310415ms","start":"2026-05-13T16:06:43.153659Z","end":"2026-05-13T16:06:43.261969Z","steps":["trace[1014610338] 'process raft request' (duration: 98.23009ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T16:06:44.043065Z","caller":"traceutil/trace.go:171","msg":"trace[1610632152] transaction","detail":"{read_only:false; response_revision:741; number_of_response:1; }","duration":"235.873683ms","start":"2026-05-13T16:06:43.807164Z","end":"2026-05-13T16:06:44.043037Z","steps":["trace[1610632152] 'process raft request' (duration: 235.736285ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:47.675697Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521226140983872303,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-13T16:06:47.818752Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.430106446s","expected-duration":"1s"} {"level":"info","ts":"2026-05-13T16:06:47.819264Z","caller":"traceutil/trace.go:171","msg":"trace[861032773] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"1.430692181s","start":"2026-05-13T16:06:46.388552Z","end":"2026-05-13T16:06:47.819244Z","steps":["trace[861032773] 'process raft request' (duration: 1.43050678s)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:47.819411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:46.388538Z","time spent":"1.430798348s","remote":"127.0.0.1:53220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4025,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-13T16:06:47.824985Z","caller":"traceutil/trace.go:171","msg":"trace[1426285485] linearizableReadLoop","detail":"{readStateIndex:781; appliedIndex:779; }","duration":"649.979399ms","start":"2026-05-13T16:06:47.174978Z","end":"2026-05-13T16:06:47.824957Z","steps":["trace[1426285485] 'read index received' (duration: 644.131474ms)","trace[1426285485] 'applied index is now lower than readState.Index' (duration: 5.845905ms)"],"step_count":2} {"level":"warn","ts":"2026-05-13T16:06:47.82529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"550.2061ms","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-05-13T16:06:47.825338Z","caller":"traceutil/trace.go:171","msg":"trace[893620916] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:755; }","duration":"550.321797ms","start":"2026-05-13T16:06:47.275005Z","end":"2026-05-13T16:06:47.825327Z","steps":["trace[893620916] 'agreement among raft nodes before linearized reading' (duration: 550.111564ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:47.825329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"650.332431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-05-13T16:06:47.825375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:47.274984Z","time spent":"550.38319ms","remote":"127.0.0.1:53306","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":"info","ts":"2026-05-13T16:06:47.825432Z","caller":"traceutil/trace.go:171","msg":"trace[1895663792] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:755; }","duration":"650.471719ms","start":"2026-05-13T16:06:47.174919Z","end":"2026-05-13T16:06:47.825391Z","steps":["trace[1895663792] 'agreement among raft nodes before linearized reading' (duration: 650.155179ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:47.825541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:47.1749Z","time spent":"650.629939ms","remote":"127.0.0.1:53306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-13T16:06:47.825664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"536.875ms","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-05-13T16:06:47.825697Z","caller":"traceutil/trace.go:171","msg":"trace[1938638316] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:755; }","duration":"536.917363ms","start":"2026-05-13T16:06:47.288769Z","end":"2026-05-13T16:06:47.825686Z","steps":["trace[1938638316] 'agreement among raft nodes before linearized reading' (duration: 536.841168ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:47.825713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.694857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-13T16:06:47.825791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:47.288763Z","time spent":"537.013568ms","remote":"127.0.0.1:53306","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":"info","ts":"2026-05-13T16:06:47.825797Z","caller":"traceutil/trace.go:171","msg":"trace[1892583071] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:755; }","duration":"370.810404ms","start":"2026-05-13T16:06:47.454975Z","end":"2026-05-13T16:06:47.825785Z","steps":["trace[1892583071] 'agreement among raft nodes before linearized reading' (duration: 370.697497ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:47.82573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"537.316197ms","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-05-13T16:06:47.825885Z","caller":"traceutil/trace.go:171","msg":"trace[579443198] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:755; }","duration":"537.517339ms","start":"2026-05-13T16:06:47.288356Z","end":"2026-05-13T16:06:47.825874Z","steps":["trace[579443198] 'agreement among raft nodes before linearized reading' (duration: 537.272004ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:47.825914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:47.288337Z","time spent":"537.570262ms","remote":"127.0.0.1:53306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-13T16:06:47.825866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:47.454958Z","time spent":"370.895649ms","remote":"127.0.0.1:53034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-13T16:06:47.826698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"537.762764ms","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-05-13T16:06:47.826796Z","caller":"traceutil/trace.go:171","msg":"trace[2061465146] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:755; }","duration":"537.905513ms","start":"2026-05-13T16:06:47.288869Z","end":"2026-05-13T16:06:47.826775Z","steps":["trace[2061465146] 'agreement among raft nodes before linearized reading' (duration: 537.595474ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:47.826859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:47.288852Z","time spent":"537.994778ms","remote":"127.0.0.1:53306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-13T16:06:49.957887Z","caller":"traceutil/trace.go:171","msg":"trace[1363049525] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"100.808706ms","start":"2026-05-13T16:06:49.85706Z","end":"2026-05-13T16:06:49.957869Z","steps":["trace[1363049525] 'process raft request' (duration: 95.824211ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T16:06:49.957892Z","caller":"traceutil/trace.go:171","msg":"trace[818192324] transaction","detail":"{read_only:false; response_revision:766; number_of_response:1; }","duration":"100.633815ms","start":"2026-05-13T16:06:49.857237Z","end":"2026-05-13T16:06:49.957871Z","steps":["trace[818192324] 'process raft request' (duration: 100.517108ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T16:06:49.958031Z","caller":"traceutil/trace.go:171","msg":"trace[179934840] transaction","detail":"{read_only:false; response_revision:767; number_of_response:1; }","duration":"100.046019ms","start":"2026-05-13T16:06:49.857948Z","end":"2026-05-13T16:06:49.957994Z","steps":["trace[179934840] 'process raft request' (duration: 99.873588ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T16:06:52.181036Z","caller":"traceutil/trace.go:171","msg":"trace[804007170] linearizableReadLoop","detail":"{readStateIndex:828; appliedIndex:826; }","duration":"256.282607ms","start":"2026-05-13T16:06:51.924716Z","end":"2026-05-13T16:06:52.180999Z","steps":["trace[804007170] 'read index received' (duration: 7.851972ms)","trace[804007170] 'applied index is now lower than readState.Index' (duration: 248.429825ms)"],"step_count":2} {"level":"info","ts":"2026-05-13T16:06:52.181135Z","caller":"traceutil/trace.go:171","msg":"trace[1365080882] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"311.027617ms","start":"2026-05-13T16:06:51.870067Z","end":"2026-05-13T16:06:52.181094Z","steps":["trace[1365080882] 'process raft request' (duration: 307.627198ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:52.18127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.011029ms","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-05-13T16:06:52.181272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.550004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-13T16:06:52.181307Z","caller":"traceutil/trace.go:171","msg":"trace[185822503] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:801; }","duration":"219.066222ms","start":"2026-05-13T16:06:51.96223Z","end":"2026-05-13T16:06:52.181296Z","steps":["trace[185822503] 'agreement among raft nodes before linearized reading' (duration: 218.932564ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T16:06:52.181324Z","caller":"traceutil/trace.go:171","msg":"trace[1362865208] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:801; }","duration":"256.66091ms","start":"2026-05-13T16:06:51.924649Z","end":"2026-05-13T16:06:52.18131Z","steps":["trace[1362865208] 'agreement among raft nodes before linearized reading' (duration: 256.457708ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:52.181319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-13T16:06:51.870017Z","time spent":"311.215049ms","remote":"127.0.0.1:53158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036294,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-13T16:06:52.181531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.978987ms","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-05-13T16:06:52.181572Z","caller":"traceutil/trace.go:171","msg":"trace[405942503] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:801; }","duration":"219.076564ms","start":"2026-05-13T16:06:51.962485Z","end":"2026-05-13T16:06:52.181561Z","steps":["trace[405942503] 'agreement among raft nodes before linearized reading' (duration: 218.968877ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:06:52.181704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.165379ms","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-05-13T16:06:52.181734Z","caller":"traceutil/trace.go:171","msg":"trace[1103187222] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:801; }","duration":"219.215842ms","start":"2026-05-13T16:06:51.962508Z","end":"2026-05-13T16:06:52.181724Z","steps":["trace[1103187222] 'agreement among raft nodes before linearized reading' (duration: 219.131377ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T16:07:01.733957Z","caller":"traceutil/trace.go:171","msg":"trace[3191659] transaction","detail":"{read_only:false; response_revision:912; number_of_response:1; }","duration":"158.892749ms","start":"2026-05-13T16:07:01.575038Z","end":"2026-05-13T16:07:01.73393Z","steps":["trace[3191659] 'process raft request' (duration: 158.742439ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T16:07:26.647317Z","caller":"traceutil/trace.go:171","msg":"trace[2061498441] linearizableReadLoop","detail":"{readStateIndex:1051; appliedIndex:1050; }","duration":"152.803333ms","start":"2026-05-13T16:07:26.494481Z","end":"2026-05-13T16:07:26.647284Z","steps":["trace[2061498441] 'read index received' (duration: 69.643764ms)","trace[2061498441] 'applied index is now lower than readState.Index' (duration: 83.158049ms)"],"step_count":2} {"level":"info","ts":"2026-05-13T16:07:26.647407Z","caller":"traceutil/trace.go:171","msg":"trace[277423011] transaction","detail":"{read_only:false; response_revision:1016; number_of_response:1; }","duration":"161.041433ms","start":"2026-05-13T16:07:26.486318Z","end":"2026-05-13T16:07:26.647359Z","steps":["trace[277423011] 'process raft request' (duration: 77.860572ms)","trace[277423011] 'compare' (duration: 82.986208ms)"],"step_count":2} {"level":"warn","ts":"2026-05-13T16:07:26.647545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.046939ms","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-05-13T16:07:26.647583Z","caller":"traceutil/trace.go:171","msg":"trace[735389061] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1016; }","duration":"153.172698ms","start":"2026-05-13T16:07:26.494399Z","end":"2026-05-13T16:07:26.647571Z","steps":["trace[735389061] 'agreement among raft nodes before linearized reading' (duration: 153.017098ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T16:07:39.568787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.139859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-13T16:07:39.568882Z","caller":"traceutil/trace.go:171","msg":"trace[656625428] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1057; }","duration":"114.269177ms","start":"2026-05-13T16:07:39.454593Z","end":"2026-05-13T16:07:39.568862Z","steps":["trace[656625428] 'range keys from in-memory index tree' (duration: 114.081365ms)"],"step_count":1}