{"level":"warn","ts":"2026-04-02T17:46:20.830561Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-02T17:46:20.830661Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.65: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.65:2380","--initial-cluster=instance=https://199.204.45.65:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.65:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.65:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-02T17:46:20.830738Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-02T17:46:20.830753Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.65:2380"]} {"level":"info","ts":"2026-04-02T17:46:20.830774Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-02T17:46:20.831423Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.65:2379"]} {"level":"info","ts":"2026-04-02T17:46:20.831524Z","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.65:2380"],"listen-peer-urls":["https://199.204.45.65:2380"],"advertise-client-urls":["https://199.204.45.65:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.65:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.65:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-02T17:46:20.83811Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.383259ms"} {"level":"info","ts":"2026-04-02T17:46:20.850443Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"cf8c3a138c9a77a2","cluster-id":"c278183e1f634dff"} {"level":"info","ts":"2026-04-02T17:46:20.850509Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 switched to configuration voters=()"} {"level":"info","ts":"2026-04-02T17:46:20.85053Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became follower at term 0"} {"level":"info","ts":"2026-04-02T17:46:20.850547Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft cf8c3a138c9a77a2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-02T17:46:20.850556Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became follower at term 1"} {"level":"info","ts":"2026-04-02T17:46:20.850614Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 switched to configuration voters=(14955392318228297634)"} {"level":"warn","ts":"2026-04-02T17:46:20.856889Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-02T17:46:20.858539Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-02T17:46:20.859507Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-02T17:46:20.861559Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"cf8c3a138c9a77a2","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-02T17:46:20.861851Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"cf8c3a138c9a77a2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-02T17:46:20.86202Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-02T17:46:20.862137Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-02T17:46:20.862277Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-02T17:46:20.86367Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 switched to configuration voters=(14955392318228297634)"} {"level":"info","ts":"2026-04-02T17:46:20.864873Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c278183e1f634dff","local-member-id":"cf8c3a138c9a77a2","added-peer-id":"cf8c3a138c9a77a2","added-peer-peer-urls":["https://199.204.45.65:2380"]} {"level":"info","ts":"2026-04-02T17:46:20.866271Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-02T17:46:20.866658Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"cf8c3a138c9a77a2","initial-advertise-peer-urls":["https://199.204.45.65:2380"],"listen-peer-urls":["https://199.204.45.65:2380"],"advertise-client-urls":["https://199.204.45.65:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.65:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-02T17:46:20.866772Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-02T17:46:20.866424Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.65:2380"} {"level":"info","ts":"2026-04-02T17:46:20.866949Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.65:2380"} {"level":"info","ts":"2026-04-02T17:46:21.651203Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 is starting a new election at term 1"} {"level":"info","ts":"2026-04-02T17:46:21.651277Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-02T17:46:21.651495Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 received MsgPreVoteResp from cf8c3a138c9a77a2 at term 1"} {"level":"info","ts":"2026-04-02T17:46:21.651532Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became candidate at term 2"} {"level":"info","ts":"2026-04-02T17:46:21.651545Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 received MsgVoteResp from cf8c3a138c9a77a2 at term 2"} {"level":"info","ts":"2026-04-02T17:46:21.651625Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became leader at term 2"} {"level":"info","ts":"2026-04-02T17:46:21.651721Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: cf8c3a138c9a77a2 elected leader cf8c3a138c9a77a2 at term 2"} {"level":"info","ts":"2026-04-02T17:46:21.652965Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"cf8c3a138c9a77a2","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.65:2379]}","request-path":"/0/members/cf8c3a138c9a77a2/attributes","cluster-id":"c278183e1f634dff","publish-timeout":"7s"} {"level":"info","ts":"2026-04-02T17:46:21.652982Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-02T17:46:21.65311Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-02T17:46:21.653307Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-02T17:46:21.653336Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-02T17:46:21.653508Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T17:46:21.65656Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.65:2379"} {"level":"info","ts":"2026-04-02T17:46:21.657099Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-02T17:46:21.657281Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c278183e1f634dff","local-member-id":"cf8c3a138c9a77a2","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T17:46:21.65743Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T17:46:21.657459Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-04-02T17:46:44.948867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.57973ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T17:46:44.949261Z","caller":"traceutil/trace.go:171","msg":"trace[77337942] transaction","detail":"{read_only:false; response_revision:420; number_of_response:1; }","duration":"268.924389ms","start":"2026-04-02T17:46:44.680297Z","end":"2026-04-02T17:46:44.949221Z","steps":["trace[77337942] 'process raft request' (duration: 132.167981ms)","trace[77337942] 'compare' (duration: 135.456858ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T17:46:44.949315Z","caller":"traceutil/trace.go:171","msg":"trace[1335952536] transaction","detail":"{read_only:false; response_revision:421; number_of_response:1; }","duration":"266.016121ms","start":"2026-04-02T17:46:44.683279Z","end":"2026-04-02T17:46:44.949295Z","steps":["trace[1335952536] 'process raft request' (duration: 265.880497ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:46:50.158928Z","caller":"traceutil/trace.go:171","msg":"trace[1456646382] transaction","detail":"{read_only:false; response_revision:444; number_of_response:1; }","duration":"348.314625ms","start":"2026-04-02T17:46:49.810572Z","end":"2026-04-02T17:46:50.158887Z","steps":["trace[1456646382] 'process raft request' (duration: 342.531459ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:46:50.159298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:46:49.81054Z","time spent":"348.573561ms","remote":"127.0.0.1:33420","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14213,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T17:46:52.544957Z","caller":"traceutil/trace.go:171","msg":"trace[1025323182] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"776.741884ms","start":"2026-04-02T17:46:51.768195Z","end":"2026-04-02T17:46:52.544937Z","steps":["trace[1025323182] 'process raft request' (duration: 776.495958ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:46:52.545193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:46:51.768176Z","time spent":"776.856666ms","remote":"127.0.0.1:55960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T17:46:52.556511Z","caller":"traceutil/trace.go:171","msg":"trace[2001261553] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"785.250523ms","start":"2026-04-02T17:46:51.771237Z","end":"2026-04-02T17:46:52.556487Z","steps":["trace[2001261553] 'process raft request' (duration: 785.074999ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:46:52.556592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:46:51.771219Z","time spent":"785.330634ms","remote":"127.0.0.1:55960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T17:46:52.556709Z","caller":"traceutil/trace.go:171","msg":"trace[1399450602] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"785.395466ms","start":"2026-04-02T17:46:51.771286Z","end":"2026-04-02T17:46:52.556681Z","steps":["trace[1399450602] 'process raft request' (duration: 785.097539ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:46:52.556952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:46:51.771283Z","time spent":"785.55039ms","remote":"127.0.0.1:55960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T17:46:52.557097Z","caller":"traceutil/trace.go:171","msg":"trace[386958310] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"772.73324ms","start":"2026-04-02T17:46:51.784353Z","end":"2026-04-02T17:46:52.557087Z","steps":["trace[386958310] 'process raft request' (duration: 772.105305ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:46:52.557147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:46:51.784335Z","time spent":"772.790751ms","remote":"127.0.0.1:55960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T17:46:52.557239Z","caller":"traceutil/trace.go:171","msg":"trace[1306557815] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"761.63228ms","start":"2026-04-02T17:46:51.79558Z","end":"2026-04-02T17:46:52.557212Z","steps":["trace[1306557815] 'process raft request' (duration: 761.352513ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:46:52.557557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:46:51.795561Z","time spent":"761.848445ms","remote":"127.0.0.1:55960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T17:46:52.557573Z","caller":"traceutil/trace.go:171","msg":"trace[1923167156] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"761.876555ms","start":"2026-04-02T17:46:51.795632Z","end":"2026-04-02T17:46:52.557509Z","steps":["trace[1923167156] 'process raft request' (duration: 761.372774ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:46:52.557705Z","caller":"traceutil/trace.go:171","msg":"trace[165187672] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"756.531201ms","start":"2026-04-02T17:46:51.801164Z","end":"2026-04-02T17:46:52.557695Z","steps":["trace[165187672] 'process raft request' (duration: 756.344826ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:46:52.557733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:46:51.795628Z","time spent":"762.029469ms","remote":"127.0.0.1:55960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T17:46:52.557791Z","caller":"traceutil/trace.go:171","msg":"trace[317721832] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"756.568242ms","start":"2026-04-02T17:46:51.801213Z","end":"2026-04-02T17:46:52.557781Z","steps":["trace[317721832] 'process raft request' (duration: 756.360117ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:46:52.557842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:46:51.80121Z","time spent":"756.611933ms","remote":"127.0.0.1:55960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T17:46:52.557825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:46:51.801149Z","time spent":"756.585422ms","remote":"127.0.0.1:55960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T17:46:52.561359Z","caller":"traceutil/trace.go:171","msg":"trace[378050287] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"756.167211ms","start":"2026-04-02T17:46:51.805147Z","end":"2026-04-02T17:46:52.561314Z","steps":["trace[378050287] 'process raft request' (duration: 752.941596ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:46:52.561575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:46:51.805133Z","time spent":"756.335046ms","remote":"127.0.0.1:55960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T17:46:52.564186Z","caller":"traceutil/trace.go:171","msg":"trace[1095349280] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"750.9585ms","start":"2026-04-02T17:46:51.813205Z","end":"2026-04-02T17:46:52.564164Z","steps":["trace[1095349280] 'process raft request' (duration: 749.66167ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:46:52.56427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:46:51.813184Z","time spent":"751.055943ms","remote":"127.0.0.1:55960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T17:46:52.569888Z","caller":"traceutil/trace.go:171","msg":"trace[10762063] linearizableReadLoop","detail":"{readStateIndex:502; appliedIndex:490; }","duration":"138.484008ms","start":"2026-04-02T17:46:52.431356Z","end":"2026-04-02T17:46:52.56984Z","steps":["trace[10762063] 'read index received' (duration: 113.412942ms)","trace[10762063] 'applied index is now lower than readState.Index' (duration: 25.067746ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T17:46:52.570011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.649342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T17:46:52.570039Z","caller":"traceutil/trace.go:171","msg":"trace[2132086110] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:487; }","duration":"138.723714ms","start":"2026-04-02T17:46:52.431306Z","end":"2026-04-02T17:46:52.57003Z","steps":["trace[2132086110] 'agreement among raft nodes before linearized reading' (duration: 138.618902ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:46:52.570157Z","caller":"traceutil/trace.go:171","msg":"trace[977830555] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"722.829182ms","start":"2026-04-02T17:46:51.842633Z","end":"2026-04-02T17:46:52.565462Z","steps":["trace[977830555] 'process raft request' (duration: 722.604887ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:46:52.570198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:46:51.842601Z","time spent":"727.574134ms","remote":"127.0.0.1:55960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T17:46:52.570253Z","caller":"traceutil/trace.go:171","msg":"trace[76052890] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"621.239317ms","start":"2026-04-02T17:46:51.949009Z","end":"2026-04-02T17:46:52.570248Z","steps":["trace[76052890] 'process raft request' (duration: 616.435345ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:46:52.570278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:46:51.94899Z","time spent":"621.278378ms","remote":"127.0.0.1:55960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T17:46:53.491042Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8620625600670938688,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-02T17:46:53.992021Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8620625600670938688,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-02T17:46:54.014597Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.12304741s","expected-duration":"1s"} {"level":"info","ts":"2026-04-02T17:46:54.015134Z","caller":"traceutil/trace.go:171","msg":"trace[338373276] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"1.134708423s","start":"2026-04-02T17:46:52.880382Z","end":"2026-04-02T17:46:54.015091Z","steps":["trace[338373276] 'process raft request' (duration: 1.134444547s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:46:54.015308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:46:52.880363Z","time spent":"1.134854876s","remote":"127.0.0.1:55960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":80679,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T17:46:54.057292Z","caller":"traceutil/trace.go:171","msg":"trace[1782639265] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"1.174675808s","start":"2026-04-02T17:46:52.8826Z","end":"2026-04-02T17:46:54.057276Z","steps":["trace[1782639265] 'process raft request' (duration: 1.173282825s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:46:54.057402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:46:52.882592Z","time spent":"1.174750679s","remote":"127.0.0.1:55960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":59616,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T17:46:54.057468Z","caller":"traceutil/trace.go:171","msg":"trace[2138707394] linearizableReadLoop","detail":"{readStateIndex:543; appliedIndex:540; }","duration":"1.066479698s","start":"2026-04-02T17:46:52.990962Z","end":"2026-04-02T17:46:54.057442Z","steps":["trace[2138707394] 'read index received' (duration: 1.023942293s)","trace[2138707394] 'applied index is now lower than readState.Index' (duration: 42.536505ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T17:46:54.057547Z","caller":"traceutil/trace.go:171","msg":"trace[1363180064] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"1.153343909s","start":"2026-04-02T17:46:52.904183Z","end":"2026-04-02T17:46:54.057527Z","steps":["trace[1363180064] 'process raft request' (duration: 1.153052712s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:46:54.057639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:46:52.904162Z","time spent":"1.153439s","remote":"127.0.0.1:55960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":73770,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T17:46:54.057665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.066682222s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-02T17:46:54.057692Z","caller":"traceutil/trace.go:171","msg":"trace[1957342521] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:519; }","duration":"1.066760944s","start":"2026-04-02T17:46:52.990923Z","end":"2026-04-02T17:46:54.057684Z","steps":["trace[1957342521] 'agreement among raft nodes before linearized reading' (duration: 1.066625901s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:46:54.057723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:46:52.990909Z","time spent":"1.066808085s","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-02T17:46:54.059903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"836.996772ms","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-04-02T17:46:54.059935Z","caller":"traceutil/trace.go:171","msg":"trace[756519035] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:520; }","duration":"837.067094ms","start":"2026-04-02T17:46:53.22286Z","end":"2026-04-02T17:46:54.059927Z","steps":["trace[756519035] 'agreement among raft nodes before linearized reading' (duration: 836.998232ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:46:54.059954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:46:53.222843Z","time spent":"837.106474ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-02T17:46:54.06017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"603.752918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-02T17:46:54.060196Z","caller":"traceutil/trace.go:171","msg":"trace[452258133] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:520; }","duration":"603.8035ms","start":"2026-04-02T17:46:53.456387Z","end":"2026-04-02T17:46:54.06019Z","steps":["trace[452258133] 'agreement among raft nodes before linearized reading' (duration: 603.761929ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:46:54.060214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:46:53.456376Z","time spent":"603.83405ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-02T17:46:54.060296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"628.674061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T17:46:54.060317Z","caller":"traceutil/trace.go:171","msg":"trace[1057163722] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:520; }","duration":"628.694892ms","start":"2026-04-02T17:46:53.431617Z","end":"2026-04-02T17:46:54.060312Z","steps":["trace[1057163722] 'agreement among raft nodes before linearized reading' (duration: 628.663951ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:46:54.060333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:46:53.431576Z","time spent":"628.754223ms","remote":"127.0.0.1:55882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-02T17:46:54.060447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"836.211824ms","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-04-02T17:46:54.06047Z","caller":"traceutil/trace.go:171","msg":"trace[1457663170] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:520; }","duration":"836.252764ms","start":"2026-04-02T17:46:53.224212Z","end":"2026-04-02T17:46:54.060465Z","steps":["trace[1457663170] 'agreement among raft nodes before linearized reading' (duration: 836.216144ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:46:54.060492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:46:53.224203Z","time spent":"836.285806ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-02T17:46:55.262806Z","caller":"traceutil/trace.go:171","msg":"trace[2029457353] linearizableReadLoop","detail":"{readStateIndex:576; appliedIndex:575; }","duration":"350.397474ms","start":"2026-04-02T17:46:54.912372Z","end":"2026-04-02T17:46:55.26277Z","steps":["trace[2029457353] 'read index received' (duration: 333.782275ms)","trace[2029457353] 'applied index is now lower than readState.Index' (duration: 16.613379ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T17:46:55.26309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.6912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/udproutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:31126"} {"level":"info","ts":"2026-04-02T17:46:55.263141Z","caller":"traceutil/trace.go:171","msg":"trace[770096855] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/udproutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:551; }","duration":"350.792273ms","start":"2026-04-02T17:46:54.912336Z","end":"2026-04-02T17:46:55.263128Z","steps":["trace[770096855] 'agreement among raft nodes before linearized reading' (duration: 350.553468ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:46:55.26318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:46:54.91232Z","time spent":"350.851344ms","remote":"127.0.0.1:55960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":31150,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/udproutes.gateway.networking.k8s.io\" "} {"level":"info","ts":"2026-04-02T17:46:55.263067Z","caller":"traceutil/trace.go:171","msg":"trace[1832145244] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"356.720881ms","start":"2026-04-02T17:46:54.906286Z","end":"2026-04-02T17:46:55.263007Z","steps":["trace[1832145244] 'process raft request' (duration: 339.936949ms)","trace[1832145244] 'compare' (duration: 16.2672ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T17:46:55.263413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:46:54.906239Z","time spent":"357.060849ms","remote":"127.0.0.1:55960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":15673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T17:46:56.760049Z","caller":"traceutil/trace.go:171","msg":"trace[1748394557] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"194.62726ms","start":"2026-04-02T17:46:56.565403Z","end":"2026-04-02T17:46:56.760031Z","steps":["trace[1748394557] 'process raft request' (duration: 194.550348ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:46:56.92942Z","caller":"traceutil/trace.go:171","msg":"trace[2114475804] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"165.291486ms","start":"2026-04-02T17:46:56.7641Z","end":"2026-04-02T17:46:56.929392Z","steps":["trace[2114475804] 'process raft request' (duration: 165.121892ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:46:56.946274Z","caller":"traceutil/trace.go:171","msg":"trace[1983592638] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"180.945461ms","start":"2026-04-02T17:46:56.765317Z","end":"2026-04-02T17:46:56.946262Z","steps":["trace[1983592638] 'process raft request' (duration: 180.546892ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:46:57.357785Z","caller":"traceutil/trace.go:171","msg":"trace[864729265] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"212.840756ms","start":"2026-04-02T17:46:57.144921Z","end":"2026-04-02T17:46:57.357761Z","steps":["trace[864729265] 'process raft request' (duration: 212.15568ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:46:57.49112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.109291ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T17:46:57.491348Z","caller":"traceutil/trace.go:171","msg":"trace[781334027] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"334.196084ms","start":"2026-04-02T17:46:57.157114Z","end":"2026-04-02T17:46:57.49131Z","steps":["trace[781334027] 'process raft request' (duration: 233.789167ms)","trace[781334027] 'compare' (duration: 99.967737ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T17:46:57.491506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:46:57.157083Z","time spent":"334.347418ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T17:47:00.618347Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8620625600670938832,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-02T17:47:00.641256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"598.447602ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-04-02T17:47:00.736644Z","caller":"traceutil/trace.go:171","msg":"trace[624358840] linearizableReadLoop","detail":"{readStateIndex:603; appliedIndex:602; }","duration":"619.121666ms","start":"2026-04-02T17:47:00.117498Z","end":"2026-04-02T17:47:00.73662Z","steps":["trace[624358840] 'read index received' (duration: 618.387399ms)","trace[624358840] 'applied index is now lower than readState.Index' (duration: 733.347µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T17:47:00.736759Z","caller":"traceutil/trace.go:171","msg":"trace[20840916] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"703.640523ms","start":"2026-04-02T17:47:00.033108Z","end":"2026-04-02T17:47:00.736749Z","steps":["trace[20840916] 'process raft request' (duration: 703.031169ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:00.73691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:00.033076Z","time spent":"703.756215ms","remote":"127.0.0.1:55996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036257,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T17:47:00.73696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"594.299266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-04-02T17:47:00.736985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.566995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T17:47:00.737029Z","caller":"traceutil/trace.go:171","msg":"trace[992211983] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:577; }","duration":"594.427419ms","start":"2026-04-02T17:47:00.142583Z","end":"2026-04-02T17:47:00.73701Z","steps":["trace[992211983] 'agreement among raft nodes before linearized reading' (duration: 594.221254ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:00.737051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"575.297072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-04-02T17:47:00.737069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:00.142572Z","time spent":"594.48951ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-02T17:47:00.737073Z","caller":"traceutil/trace.go:171","msg":"trace[571342924] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:577; }","duration":"305.710678ms","start":"2026-04-02T17:47:00.431317Z","end":"2026-04-02T17:47:00.737028Z","steps":["trace[571342924] 'agreement among raft nodes before linearized reading' (duration: 305.512154ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:47:00.737105Z","caller":"traceutil/trace.go:171","msg":"trace[1433088366] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:577; }","duration":"575.370703ms","start":"2026-04-02T17:47:00.161717Z","end":"2026-04-02T17:47:00.737088Z","steps":["trace[1433088366] 'agreement among raft nodes before linearized reading' (duration: 575.204009ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:00.737112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:00.431292Z","time spent":"305.809921ms","remote":"127.0.0.1:55894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-02T17:47:00.737139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:00.161709Z","time spent":"575.422364ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-02T17:47:00.737206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"619.68332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-02T17:47:00.737298Z","caller":"traceutil/trace.go:171","msg":"trace[1498461593] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:577; }","duration":"619.816872ms","start":"2026-04-02T17:47:00.117455Z","end":"2026-04-02T17:47:00.737272Z","steps":["trace[1498461593] 'agreement among raft nodes before linearized reading' (duration: 619.515995ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:00.737343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"576.9614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-04-02T17:47:00.737356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:00.117437Z","time spent":"619.910155ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-02T17:47:00.737403Z","caller":"traceutil/trace.go:171","msg":"trace[17144609] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:577; }","duration":"577.040122ms","start":"2026-04-02T17:47:00.160348Z","end":"2026-04-02T17:47:00.737388Z","steps":["trace[17144609] 'agreement among raft nodes before linearized reading' (duration: 576.873448ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:00.737448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:00.160313Z","time spent":"577.124344ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-02T17:47:00.73721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.171546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-fcn7m\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-04-02T17:47:00.737618Z","caller":"traceutil/trace.go:171","msg":"trace[1464531755] range","detail":"{range_begin:/registry/pods/kube-system/cilium-fcn7m; range_end:; response_count:1; response_revision:577; }","duration":"107.532615ms","start":"2026-04-02T17:47:00.62997Z","end":"2026-04-02T17:47:00.737502Z","steps":["trace[1464531755] 'agreement among raft nodes before linearized reading' (duration: 107.025143ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:01.205338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.290993ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T17:47:01.205567Z","caller":"traceutil/trace.go:171","msg":"trace[757930827] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"462.890344ms","start":"2026-04-02T17:47:00.742657Z","end":"2026-04-02T17:47:01.205547Z","steps":["trace[757930827] 'process raft request' (duration: 26.279944ms)","trace[757930827] 'compare' (duration: 436.1887ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T17:47:01.205641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:00.74263Z","time spent":"462.980087ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T17:47:01.299122Z","caller":"traceutil/trace.go:171","msg":"trace[1191313116] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"554.542668ms","start":"2026-04-02T17:47:00.744551Z","end":"2026-04-02T17:47:01.299094Z","steps":["trace[1191313116] 'process raft request' (duration: 554.453506ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:01.299468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:00.744538Z","time spent":"554.699221ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T17:47:01.299529Z","caller":"traceutil/trace.go:171","msg":"trace[587068109] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"552.560621ms","start":"2026-04-02T17:47:00.746947Z","end":"2026-04-02T17:47:01.299508Z","steps":["trace[587068109] 'process raft request' (duration: 552.094411ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:01.299684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:00.746938Z","time spent":"552.663064ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T17:47:01.299719Z","caller":"traceutil/trace.go:171","msg":"trace[790114293] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"545.042655ms","start":"2026-04-02T17:47:00.754604Z","end":"2026-04-02T17:47:01.299646Z","steps":["trace[790114293] 'process raft request' (duration: 544.768708ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:47:01.299839Z","caller":"traceutil/trace.go:171","msg":"trace[1905799885] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"555.726385ms","start":"2026-04-02T17:47:00.743537Z","end":"2026-04-02T17:47:01.299264Z","steps":["trace[1905799885] 'process raft request' (duration: 555.287774ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:01.300104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:00.743517Z","time spent":"556.502683ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T17:47:01.300128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:00.754584Z","time spent":"545.345232ms","remote":"127.0.0.1:33126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T17:47:01.410998Z","caller":"traceutil/trace.go:171","msg":"trace[235690443] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"609.302668ms","start":"2026-04-02T17:47:00.801668Z","end":"2026-04-02T17:47:01.410971Z","steps":["trace[235690443] 'process raft request' (duration: 609.118113ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:01.41113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:00.801643Z","time spent":"609.42613ms","remote":"127.0.0.1:33266","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T17:47:01.411148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.932883ms","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-04-02T17:47:01.411201Z","caller":"traceutil/trace.go:171","msg":"trace[1730949537] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:583; }","duration":"483.062046ms","start":"2026-04-02T17:47:00.928127Z","end":"2026-04-02T17:47:01.411189Z","steps":["trace[1730949537] 'agreement among raft nodes before linearized reading' (duration: 482.920542ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:47:01.410993Z","caller":"traceutil/trace.go:171","msg":"trace[179107587] linearizableReadLoop","detail":"{readStateIndex:609; appliedIndex:604; }","duration":"482.769399ms","start":"2026-04-02T17:47:00.928181Z","end":"2026-04-02T17:47:01.410951Z","steps":["trace[179107587] 'read index received' (duration: 370.059784ms)","trace[179107587] 'applied index is now lower than readState.Index' (duration: 112.708185ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T17:47:01.411462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:00.928107Z","time spent":"483.336822ms","remote":"127.0.0.1:41422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 "} {"level":"warn","ts":"2026-04-02T17:47:01.411686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.406733ms","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":"warn","ts":"2026-04-02T17:47:01.41174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.22795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T17:47:01.411759Z","caller":"traceutil/trace.go:171","msg":"trace[451707768] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:583; }","duration":"483.547077ms","start":"2026-04-02T17:47:00.928194Z","end":"2026-04-02T17:47:01.411741Z","steps":["trace[451707768] 'agreement among raft nodes before linearized reading' (duration: 483.407093ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:47:01.411783Z","caller":"traceutil/trace.go:171","msg":"trace[153902266] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:583; }","duration":"285.288611ms","start":"2026-04-02T17:47:01.126482Z","end":"2026-04-02T17:47:01.411771Z","steps":["trace[153902266] 'agreement among raft nodes before linearized reading' (duration: 285.200759ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:01.411821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:00.928165Z","time spent":"483.645299ms","remote":"127.0.0.1:41422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "} {"level":"warn","ts":"2026-04-02T17:47:01.411955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.01798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T17:47:01.412049Z","caller":"traceutil/trace.go:171","msg":"trace[995887791] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:583; }","duration":"387.172623ms","start":"2026-04-02T17:47:01.024854Z","end":"2026-04-02T17:47:01.412027Z","steps":["trace[995887791] 'agreement among raft nodes before linearized reading' (duration: 386.986899ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:01.412061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.257855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T17:47:01.412091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:01.024828Z","time spent":"387.253726ms","remote":"127.0.0.1:41466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"info","ts":"2026-04-02T17:47:01.412094Z","caller":"traceutil/trace.go:171","msg":"trace[1860164032] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:583; }","duration":"387.313487ms","start":"2026-04-02T17:47:01.02477Z","end":"2026-04-02T17:47:01.412083Z","steps":["trace[1860164032] 'agreement among raft nodes before linearized reading' (duration: 387.263125ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:01.412114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.123331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T17:47:01.412144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:01.024761Z","time spent":"387.372328ms","remote":"127.0.0.1:41452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 "} {"level":"info","ts":"2026-04-02T17:47:01.412149Z","caller":"traceutil/trace.go:171","msg":"trace[1492413445] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:583; }","duration":"233.175532ms","start":"2026-04-02T17:47:01.178963Z","end":"2026-04-02T17:47:01.412139Z","steps":["trace[1492413445] 'agreement among raft nodes before linearized reading' (duration: 233.124251ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:01.412288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.437538ms","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":"warn","ts":"2026-04-02T17:47:01.412301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.019237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T17:47:01.412315Z","caller":"traceutil/trace.go:171","msg":"trace[448861698] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:583; }","duration":"233.50009ms","start":"2026-04-02T17:47:01.178806Z","end":"2026-04-02T17:47:01.412306Z","steps":["trace[448861698] 'agreement among raft nodes before linearized reading' (duration: 233.454859ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:01.412331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.591755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T17:47:01.412364Z","caller":"traceutil/trace.go:171","msg":"trace[1193135269] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:583; }","duration":"302.650987ms","start":"2026-04-02T17:47:01.109705Z","end":"2026-04-02T17:47:01.412356Z","steps":["trace[1193135269] 'agreement among raft nodes before linearized reading' (duration: 302.599316ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:01.412372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.164841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T17:47:01.412385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:01.109689Z","time spent":"302.690468ms","remote":"127.0.0.1:41472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 "} {"level":"info","ts":"2026-04-02T17:47:01.412401Z","caller":"traceutil/trace.go:171","msg":"trace[945107320] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:583; }","duration":"416.194802ms","start":"2026-04-02T17:47:00.996198Z","end":"2026-04-02T17:47:01.412393Z","steps":["trace[945107320] 'agreement among raft nodes before linearized reading' (duration: 416.152491ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:01.41251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:00.996127Z","time spent":"416.296845ms","remote":"127.0.0.1:41452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-02T17:47:01.412574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.527398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T17:47:01.412606Z","caller":"traceutil/trace.go:171","msg":"trace[1394417983] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:583; }","duration":"303.575249ms","start":"2026-04-02T17:47:01.109021Z","end":"2026-04-02T17:47:01.412596Z","steps":["trace[1394417983] 'agreement among raft nodes before linearized reading' (duration: 303.510247ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:01.412633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:01.108948Z","time spent":"303.677411ms","remote":"127.0.0.1:41486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-04-02T17:47:01.412651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.332121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T17:47:01.412682Z","caller":"traceutil/trace.go:171","msg":"trace[951040086] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:583; }","duration":"447.371031ms","start":"2026-04-02T17:47:00.9653Z","end":"2026-04-02T17:47:01.412671Z","steps":["trace[951040086] 'agreement among raft nodes before linearized reading' (duration: 447.32192ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:01.412719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:00.965297Z","time spent":"447.413492ms","remote":"127.0.0.1:41436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"warn","ts":"2026-04-02T17:47:01.412829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.810314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T17:47:01.412854Z","caller":"traceutil/trace.go:171","msg":"trace[1404720200] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:583; }","duration":"303.865645ms","start":"2026-04-02T17:47:01.10898Z","end":"2026-04-02T17:47:01.412846Z","steps":["trace[1404720200] 'agreement among raft nodes before linearized reading' (duration: 303.799954ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:01.412874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:01.108908Z","time spent":"303.960348ms","remote":"127.0.0.1:41486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"warn","ts":"2026-04-02T17:47:01.41298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.046218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T17:47:01.413006Z","caller":"traceutil/trace.go:171","msg":"trace[1581594060] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:583; }","duration":"342.093269ms","start":"2026-04-02T17:47:01.070905Z","end":"2026-04-02T17:47:01.412999Z","steps":["trace[1581594060] 'agreement among raft nodes before linearized reading' (duration: 342.054728ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:01.413029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:01.070897Z","time spent":"342.12614ms","remote":"127.0.0.1:41472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-04-02T17:47:01.413123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.484478ms","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":"warn","ts":"2026-04-02T17:47:01.413122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.813412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T17:47:01.413153Z","caller":"traceutil/trace.go:171","msg":"trace[1998006467] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:583; }","duration":"342.559ms","start":"2026-04-02T17:47:01.070584Z","end":"2026-04-02T17:47:01.413143Z","steps":["trace[1998006467] 'agreement among raft nodes before linearized reading' (duration: 342.513269ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:47:01.413165Z","caller":"traceutil/trace.go:171","msg":"trace[2143826335] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:583; }","duration":"447.867493ms","start":"2026-04-02T17:47:00.965283Z","end":"2026-04-02T17:47:01.413151Z","steps":["trace[2143826335] 'agreement among raft nodes before linearized reading' (duration: 447.76513ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:01.413224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.30113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T17:47:01.413251Z","caller":"traceutil/trace.go:171","msg":"trace[1808720962] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:583; }","duration":"388.393592ms","start":"2026-04-02T17:47:01.024851Z","end":"2026-04-02T17:47:01.413245Z","steps":["trace[1808720962] 'agreement among raft nodes before linearized reading' (duration: 388.344771ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:01.413243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:00.965277Z","time spent":"447.954034ms","remote":"127.0.0.1:41436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 "} {"level":"warn","ts":"2026-04-02T17:47:01.413895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.194076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T17:47:01.413893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.128018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T17:47:01.413936Z","caller":"traceutil/trace.go:171","msg":"trace[977680036] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:583; }","duration":"287.247697ms","start":"2026-04-02T17:47:01.126677Z","end":"2026-04-02T17:47:01.413925Z","steps":["trace[977680036] 'agreement among raft nodes before linearized reading' (duration: 287.183695ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:01.413948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.805633ms","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-04-02T17:47:01.413996Z","caller":"traceutil/trace.go:171","msg":"trace[2092320570] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:583; }","duration":"285.871134ms","start":"2026-04-02T17:47:01.128113Z","end":"2026-04-02T17:47:01.413984Z","steps":["trace[2092320570] 'agreement among raft nodes before linearized reading' (duration: 285.791382ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:47:01.413955Z","caller":"traceutil/trace.go:171","msg":"trace[1586872042] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:583; }","duration":"235.2325ms","start":"2026-04-02T17:47:01.178703Z","end":"2026-04-02T17:47:01.413936Z","steps":["trace[1586872042] 'agreement among raft nodes before linearized reading' (duration: 235.135828ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:47:01.412332Z","caller":"traceutil/trace.go:171","msg":"trace[1180100874] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:583; }","duration":"416.084469ms","start":"2026-04-02T17:47:00.996237Z","end":"2026-04-02T17:47:01.412321Z","steps":["trace[1180100874] 'agreement among raft nodes before linearized reading' (duration: 416.037018ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:01.41422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:00.996213Z","time spent":"417.990144ms","remote":"127.0.0.1:41452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-02T17:47:01.414323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.044701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T17:47:01.414382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"485.367859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T17:47:01.414429Z","caller":"traceutil/trace.go:171","msg":"trace[1450546102] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:583; }","duration":"485.439081ms","start":"2026-04-02T17:47:00.928975Z","end":"2026-04-02T17:47:01.414414Z","steps":["trace[1450546102] 'agreement among raft nodes before linearized reading' (duration: 485.37891ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:01.414465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:00.928959Z","time spent":"485.497212ms","remote":"127.0.0.1:41422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 "} {"level":"info","ts":"2026-04-02T17:47:01.414374Z","caller":"traceutil/trace.go:171","msg":"trace[2063792689] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:583; }","duration":"449.101342ms","start":"2026-04-02T17:47:00.965261Z","end":"2026-04-02T17:47:01.414362Z","steps":["trace[2063792689] 'agreement among raft nodes before linearized reading' (duration: 448.965969ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:01.41318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:01.070563Z","time spent":"342.609871ms","remote":"127.0.0.1:41472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"warn","ts":"2026-04-02T17:47:01.413292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:01.024775Z","time spent":"388.511295ms","remote":"127.0.0.1:41466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-02T17:47:01.416303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:00.965211Z","time spent":"449.329777ms","remote":"127.0.0.1:41436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 "} {"level":"warn","ts":"2026-04-02T17:47:02.391236Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8620625600670938857,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-02T17:47:02.756197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"958.134915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T17:47:02.75631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.199050049s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T17:47:02.756358Z","caller":"traceutil/trace.go:171","msg":"trace[1754490792] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:583; }","duration":"958.373351ms","start":"2026-04-02T17:47:01.797935Z","end":"2026-04-02T17:47:02.756308Z","steps":["trace[1754490792] 'count revisions from in-memory index tree' (duration: 957.94559ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:02.756425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:01.797913Z","time spent":"958.498443ms","remote":"127.0.0.1:41558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-02T17:47:02.75649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.199294055s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T17:47:02.756535Z","caller":"traceutil/trace.go:171","msg":"trace[1113008776] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:583; }","duration":"1.199379126s","start":"2026-04-02T17:47:01.557144Z","end":"2026-04-02T17:47:02.756523Z","steps":["trace[1113008776] 'count revisions from in-memory index tree' (duration: 1.19914198s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:02.75659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:01.557122Z","time spent":"1.199451738s","remote":"127.0.0.1:41528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-02T17:47:02.756768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"990.607574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T17:47:02.756866Z","caller":"traceutil/trace.go:171","msg":"trace[744574994] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:583; }","duration":"990.721116ms","start":"2026-04-02T17:47:01.766129Z","end":"2026-04-02T17:47:02.75685Z","steps":["trace[744574994] 'range keys from in-memory index tree' (duration: 990.550182ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:02.756898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:01.766118Z","time spent":"990.770227ms","remote":"127.0.0.1:41548","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-02T17:47:02.756938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.047847943s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T17:47:02.756994Z","caller":"traceutil/trace.go:171","msg":"trace[944606407] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:583; }","duration":"1.047934424s","start":"2026-04-02T17:47:01.709044Z","end":"2026-04-02T17:47:02.756978Z","steps":["trace[944606407] 'count revisions from in-memory index tree' (duration: 1.047786691s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:02.756956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.376531ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T17:47:02.757027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.047799441s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T17:47:02.757072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:01.709026Z","time spent":"1.048028167s","remote":"127.0.0.1:41532","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"info","ts":"2026-04-02T17:47:02.757081Z","caller":"traceutil/trace.go:171","msg":"trace[834067512] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:583; }","duration":"518.516494ms","start":"2026-04-02T17:47:02.238543Z","end":"2026-04-02T17:47:02.757059Z","steps":["trace[834067512] 'range keys from in-memory index tree' (duration: 518.356471ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:02.75708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"990.86015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T17:47:02.757091Z","caller":"traceutil/trace.go:171","msg":"trace[2104590534] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:583; }","duration":"1.047861794s","start":"2026-04-02T17:47:01.709206Z","end":"2026-04-02T17:47:02.757068Z","steps":["trace[2104590534] 'range keys from in-memory index tree' (duration: 1.047643858s)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:47:02.75712Z","caller":"traceutil/trace.go:171","msg":"trace[51812087] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:583; }","duration":"990.931702ms","start":"2026-04-02T17:47:01.766179Z","end":"2026-04-02T17:47:02.757111Z","steps":["trace[51812087] 'count revisions from in-memory index tree' (duration: 990.784248ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:02.757153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:01.766153Z","time spent":"990.991333ms","remote":"127.0.0.1:41548","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-02T17:47:02.75715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:01.709108Z","time spent":"1.048020587s","remote":"127.0.0.1:41532","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"info","ts":"2026-04-02T17:47:02.756418Z","caller":"traceutil/trace.go:171","msg":"trace[536778702] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:583; }","duration":"1.199147331s","start":"2026-04-02T17:47:01.557237Z","end":"2026-04-02T17:47:02.756384Z","steps":["trace[536778702] 'range keys from in-memory index tree' (duration: 1.198996147s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:02.757287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"990.531893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T17:47:02.757306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:01.557234Z","time spent":"1.200053102s","remote":"127.0.0.1:41528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"info","ts":"2026-04-02T17:47:02.757327Z","caller":"traceutil/trace.go:171","msg":"trace[979122134] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:583; }","duration":"990.589343ms","start":"2026-04-02T17:47:01.766729Z","end":"2026-04-02T17:47:02.757319Z","steps":["trace[979122134] 'range keys from in-memory index tree' (duration: 990.490151ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:02.757419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:01.766722Z","time spent":"990.687996ms","remote":"127.0.0.1:41548","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 "} {"level":"warn","ts":"2026-04-02T17:47:02.757437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"959.361593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T17:47:02.757469Z","caller":"traceutil/trace.go:171","msg":"trace[1181038942] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:583; }","duration":"959.408515ms","start":"2026-04-02T17:47:01.79805Z","end":"2026-04-02T17:47:02.757458Z","steps":["trace[1181038942] 'range keys from in-memory index tree' (duration: 959.318763ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:02.757501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:01.798041Z","time spent":"959.448475ms","remote":"127.0.0.1:41558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-02T17:47:02.756219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"957.271494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T17:47:02.757652Z","caller":"traceutil/trace.go:171","msg":"trace[2012138097] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:583; }","duration":"958.726999ms","start":"2026-04-02T17:47:01.79891Z","end":"2026-04-02T17:47:02.757637Z","steps":["trace[2012138097] 'range keys from in-memory index tree' (duration: 957.223024ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:02.757684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:01.798902Z","time spent":"958.77139ms","remote":"127.0.0.1:41558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-02T17:47:02.756219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.046340957s","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-04-02T17:47:02.757776Z","caller":"traceutil/trace.go:171","msg":"trace[930328868] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:583; }","duration":"1.047998886s","start":"2026-04-02T17:47:01.709768Z","end":"2026-04-02T17:47:02.757767Z","steps":["trace[930328868] 'range keys from in-memory index tree' (duration: 1.046213295s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:02.757805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:01.709736Z","time spent":"1.048059548s","remote":"127.0.0.1:41528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 "} {"level":"warn","ts":"2026-04-02T17:47:02.891901Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8620625600670938857,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-02T17:47:03.084469Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.2658448s","expected-duration":"1s"} {"level":"info","ts":"2026-04-02T17:47:03.085562Z","caller":"traceutil/trace.go:171","msg":"trace[835545778] linearizableReadLoop","detail":"{readStateIndex:610; appliedIndex:609; }","duration":"1.194612274s","start":"2026-04-02T17:47:01.890925Z","end":"2026-04-02T17:47:03.085537Z","steps":["trace[835545778] 'read index received' (duration: 1.193739824s)","trace[835545778] 'applied index is now lower than readState.Index' (duration: 871.47µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T17:47:03.085713Z","caller":"traceutil/trace.go:171","msg":"trace[835928844] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"1.268803799s","start":"2026-04-02T17:47:01.816873Z","end":"2026-04-02T17:47:03.085676Z","steps":["trace[835928844] 'process raft request' (duration: 1.268084363s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:03.085794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.19485701s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T17:47:03.085826Z","caller":"traceutil/trace.go:171","msg":"trace[1611518078] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:584; }","duration":"1.194888791s","start":"2026-04-02T17:47:01.890927Z","end":"2026-04-02T17:47:03.085815Z","steps":["trace[1611518078] 'agreement among raft nodes before linearized reading' (duration: 1.19484691s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:03.085868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:01.890909Z","time spent":"1.194947052s","remote":"127.0.0.1:41566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-02T17:47:03.08589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:01.816838Z","time spent":"1.268935902s","remote":"127.0.0.1:55996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T17:47:03.085946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.09737701s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T17:47:03.085734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.194783058s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T17:47:03.086023Z","caller":"traceutil/trace.go:171","msg":"trace[1656729323] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:584; }","duration":"1.097478133s","start":"2026-04-02T17:47:01.988521Z","end":"2026-04-02T17:47:03.085999Z","steps":["trace[1656729323] 'agreement among raft nodes before linearized reading' (duration: 1.097322669s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:03.086024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.151071185s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T17:47:03.086052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.078209302s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T17:47:03.086115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.151755731s","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":"warn","ts":"2026-04-02T17:47:03.086119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.078359896s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T17:47:03.086136Z","caller":"traceutil/trace.go:171","msg":"trace[1493313180] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:584; }","duration":"1.151201939s","start":"2026-04-02T17:47:01.934892Z","end":"2026-04-02T17:47:03.086094Z","steps":["trace[1493313180] 'agreement among raft nodes before linearized reading' (duration: 1.151011485s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:03.086142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.061683926s","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":"warn","ts":"2026-04-02T17:47:03.086334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"997.27574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T17:47:03.086354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.124532826s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T17:47:03.086384Z","caller":"traceutil/trace.go:171","msg":"trace[710483153] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:584; }","duration":"997.30958ms","start":"2026-04-02T17:47:02.089048Z","end":"2026-04-02T17:47:03.086357Z","steps":["trace[710483153] 'agreement among raft nodes before linearized reading' (duration: 997.260969ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:03.086418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.022122771s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T17:47:03.086414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.038069013s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T17:47:03.086336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.037422919s","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":"warn","ts":"2026-04-02T17:47:03.086444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"655.215821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T17:47:03.086459Z","caller":"traceutil/trace.go:171","msg":"trace[669387669] 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:584; }","duration":"1.022170661s","start":"2026-04-02T17:47:02.064277Z","end":"2026-04-02T17:47:03.086448Z","steps":["trace[669387669] 'agreement among raft nodes before linearized reading' (duration: 1.02212248s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:03.086474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.038099565s","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-04-02T17:47:03.086486Z","caller":"traceutil/trace.go:171","msg":"trace[1791490718] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:584; }","duration":"655.294403ms","start":"2026-04-02T17:47:02.431178Z","end":"2026-04-02T17:47:03.086473Z","steps":["trace[1791490718] 'agreement among raft nodes before linearized reading' (duration: 655.244952ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:03.086501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.062008023s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T17:47:03.086527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:02.431155Z","time spent":"655.367164ms","remote":"127.0.0.1:55882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-02T17:47:03.086548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"981.689395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T17:47:03.086574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"981.495901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T17:47:03.086596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"997.519526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T17:47:03.08659Z","caller":"traceutil/trace.go:171","msg":"trace[1280964179] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:584; }","duration":"981.759697ms","start":"2026-04-02T17:47:02.104813Z","end":"2026-04-02T17:47:03.086573Z","steps":["trace[1280964179] 'agreement among raft nodes before linearized reading' (duration: 981.690806ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:03.086578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.022307735s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T17:47:03.08661Z","caller":"traceutil/trace.go:171","msg":"trace[1462232114] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:584; }","duration":"1.062077735s","start":"2026-04-02T17:47:02.024466Z","end":"2026-04-02T17:47:03.086544Z","steps":["trace[1462232114] 'agreement among raft nodes before linearized reading' (duration: 1.061996213s)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:47:03.086623Z","caller":"traceutil/trace.go:171","msg":"trace[1321335697] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:584; }","duration":"981.588333ms","start":"2026-04-02T17:47:02.105026Z","end":"2026-04-02T17:47:03.086614Z","steps":["trace[1321335697] 'agreement among raft nodes before linearized reading' (duration: 981.472871ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:47:03.086629Z","caller":"traceutil/trace.go:171","msg":"trace[977474148] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:584; }","duration":"997.560756ms","start":"2026-04-02T17:47:02.089059Z","end":"2026-04-02T17:47:03.08662Z","steps":["trace[977474148] 'agreement among raft nodes before linearized reading' (duration: 997.505545ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:03.08664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:02.104779Z","time spent":"981.85245ms","remote":"127.0.0.1:49416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-04-02T17:47:03.086503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:02.064274Z","time spent":"1.022217592s","remote":"127.0.0.1:49410","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"warn","ts":"2026-04-02T17:47:03.086651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:02.02446Z","time spent":"1.062181008s","remote":"127.0.0.1:49384","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-02T17:47:03.086661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:02.105001Z","time spent":"981.650934ms","remote":"127.0.0.1:49416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-02T17:47:03.086663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:02.089056Z","time spent":"997.599357ms","remote":"127.0.0.1:49414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"info","ts":"2026-04-02T17:47:03.08642Z","caller":"traceutil/trace.go:171","msg":"trace[934246705] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:584; }","duration":"1.124647629s","start":"2026-04-02T17:47:01.96176Z","end":"2026-04-02T17:47:03.086407Z","steps":["trace[934246705] 'agreement among raft nodes before linearized reading' (duration: 1.124459994s)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:47:03.086644Z","caller":"traceutil/trace.go:171","msg":"trace[1121629433] 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:584; }","duration":"1.022385867s","start":"2026-04-02T17:47:02.064247Z","end":"2026-04-02T17:47:03.086633Z","steps":["trace[1121629433] 'agreement among raft nodes before linearized reading' (duration: 1.022292415s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:03.086843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:02.06424Z","time spent":"1.022591051s","remote":"127.0.0.1:49410","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 "} {"level":"warn","ts":"2026-04-02T17:47:03.086433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:02.08903Z","time spent":"997.393513ms","remote":"127.0.0.1:49414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-04-02T17:47:03.086376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"980.928938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T17:47:03.086954Z","caller":"traceutil/trace.go:171","msg":"trace[996667990] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:584; }","duration":"981.527602ms","start":"2026-04-02T17:47:02.105413Z","end":"2026-04-02T17:47:03.086941Z","steps":["trace[996667990] 'agreement among raft nodes before linearized reading' (duration: 980.935168ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:47:03.086477Z","caller":"traceutil/trace.go:171","msg":"trace[733553616] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:584; }","duration":"1.037585953s","start":"2026-04-02T17:47:02.048878Z","end":"2026-04-02T17:47:03.086464Z","steps":["trace[733553616] 'agreement among raft nodes before linearized reading' (duration: 1.037433749s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:03.086994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:02.105397Z","time spent":"981.586383ms","remote":"127.0.0.1:49414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 "} {"level":"warn","ts":"2026-04-02T17:47:03.087005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:02.048866Z","time spent":"1.038125355s","remote":"127.0.0.1:49398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 "} {"level":"info","ts":"2026-04-02T17:47:03.08615Z","caller":"traceutil/trace.go:171","msg":"trace[500041780] 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:584; }","duration":"1.078350576s","start":"2026-04-02T17:47:02.007776Z","end":"2026-04-02T17:47:03.086127Z","steps":["trace[500041780] 'agreement among raft nodes before linearized reading' (duration: 1.078173672s)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:47:03.086514Z","caller":"traceutil/trace.go:171","msg":"trace[428707266] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:584; }","duration":"1.038154166s","start":"2026-04-02T17:47:02.04835Z","end":"2026-04-02T17:47:03.086505Z","steps":["trace[428707266] 'agreement among raft nodes before linearized reading' (duration: 1.038094574s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:03.087129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:02.00777Z","time spent":"1.079342539s","remote":"127.0.0.1:49382","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-02T17:47:03.087165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:02.048345Z","time spent":"1.038803661s","remote":"127.0.0.1:49398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"info","ts":"2026-04-02T17:47:03.086163Z","caller":"traceutil/trace.go:171","msg":"trace[454382780] 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:584; }","duration":"1.078436347s","start":"2026-04-02T17:47:02.007711Z","end":"2026-04-02T17:47:03.086147Z","steps":["trace[454382780] 'agreement among raft nodes before linearized reading' (duration: 1.078381236s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:03.086195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.151959646s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T17:47:03.086217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.096971651s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T17:47:03.087299Z","caller":"traceutil/trace.go:171","msg":"trace[1223377654] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:584; }","duration":"1.153051502s","start":"2026-04-02T17:47:01.934227Z","end":"2026-04-02T17:47:03.087278Z","steps":["trace[1223377654] 'agreement among raft nodes before linearized reading' (duration: 1.151945256s)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:47:03.086629Z","caller":"traceutil/trace.go:171","msg":"trace[1859037760] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:584; }","duration":"1.061998003s","start":"2026-04-02T17:47:02.02436Z","end":"2026-04-02T17:47:03.086358Z","steps":["trace[1859037760] 'agreement among raft nodes before linearized reading' (duration: 1.06144044s)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:47:03.0873Z","caller":"traceutil/trace.go:171","msg":"trace[665968733] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:584; }","duration":"1.098058296s","start":"2026-04-02T17:47:01.989229Z","end":"2026-04-02T17:47:03.087288Z","steps":["trace[665968733] 'agreement among raft nodes before linearized reading' (duration: 1.096966181s)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:47:03.086152Z","caller":"traceutil/trace.go:171","msg":"trace[439429788] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:584; }","duration":"1.151791252s","start":"2026-04-02T17:47:01.934349Z","end":"2026-04-02T17:47:03.08614Z","steps":["trace[439429788] 'agreement among raft nodes before linearized reading' (duration: 1.151738301s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:03.087483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:01.934337Z","time spent":"1.153129194s","remote":"127.0.0.1:49362","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-02T17:47:03.087526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:02.024339Z","time spent":"1.06317068s","remote":"127.0.0.1:49384","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-02T17:47:03.087558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:01.989223Z","time spent":"1.09822366s","remote":"127.0.0.1:49376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 "} {"level":"warn","ts":"2026-04-02T17:47:03.086235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.194748367s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T17:47:03.087663Z","caller":"traceutil/trace.go:171","msg":"trace[1882210696] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:584; }","duration":"1.196194582s","start":"2026-04-02T17:47:01.891456Z","end":"2026-04-02T17:47:03.087651Z","steps":["trace[1882210696] 'agreement among raft nodes before linearized reading' (duration: 1.194758468s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:03.087707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:01.891448Z","time spent":"1.196246943s","remote":"127.0.0.1:41566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-02T17:47:03.086206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:01.934884Z","time spent":"1.151308561s","remote":"127.0.0.1:49362","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-02T17:47:03.08626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.097539864s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T17:47:03.086276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.124775701s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T17:47:03.08789Z","caller":"traceutil/trace.go:171","msg":"trace[428909172] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:584; }","duration":"1.126404789s","start":"2026-04-02T17:47:01.96147Z","end":"2026-04-02T17:47:03.087875Z","steps":["trace[428909172] 'agreement among raft nodes before linearized reading' (duration: 1.124776971s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:03.08794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:01.961427Z","time spent":"1.126498031s","remote":"127.0.0.1:49364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-02T17:47:03.086277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.07814419s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T17:47:03.088131Z","caller":"traceutil/trace.go:171","msg":"trace[922855529] 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:584; }","duration":"1.080015265s","start":"2026-04-02T17:47:02.008105Z","end":"2026-04-02T17:47:03.08812Z","steps":["trace[922855529] 'agreement among raft nodes before linearized reading' (duration: 1.078145491s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:03.088179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:02.008086Z","time spent":"1.080077396s","remote":"127.0.0.1:49382","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-02T17:47:03.086316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.124282229s","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-04-02T17:47:03.088226Z","caller":"traceutil/trace.go:171","msg":"trace[1579848395] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:584; }","duration":"1.126188734s","start":"2026-04-02T17:47:01.962025Z","end":"2026-04-02T17:47:03.088214Z","steps":["trace[1579848395] 'agreement among raft nodes before linearized reading' (duration: 1.124267129s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:03.088283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:01.961988Z","time spent":"1.126277676s","remote":"127.0.0.1:49364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 "} {"level":"warn","ts":"2026-04-02T17:47:03.086377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.021502017s","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-04-02T17:47:03.088457Z","caller":"traceutil/trace.go:171","msg":"trace[318745412] 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:584; }","duration":"1.023579085s","start":"2026-04-02T17:47:02.064857Z","end":"2026-04-02T17:47:03.088436Z","steps":["trace[318745412] 'agreement among raft nodes before linearized reading' (duration: 1.021498966s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:03.088664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:02.064853Z","time spent":"1.023707848s","remote":"127.0.0.1:49410","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 "} {"level":"info","ts":"2026-04-02T17:47:03.086478Z","caller":"traceutil/trace.go:171","msg":"trace[372402116] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:584; }","duration":"1.038149966s","start":"2026-04-02T17:47:02.048309Z","end":"2026-04-02T17:47:03.086459Z","steps":["trace[372402116] 'agreement among raft nodes before linearized reading' (duration: 1.038045483s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:03.089354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:02.048298Z","time spent":"1.040955381s","remote":"127.0.0.1:49398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-02T17:47:03.086785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:01.961734Z","time spent":"1.125038467s","remote":"127.0.0.1:49364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-02T17:47:03.08725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:02.0077Z","time spent":"1.079534393s","remote":"127.0.0.1:49382","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-02T17:47:03.086219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.061885211s","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-04-02T17:47:03.090372Z","caller":"traceutil/trace.go:171","msg":"trace[865177052] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:584; }","duration":"1.066057008s","start":"2026-04-02T17:47:02.024302Z","end":"2026-04-02T17:47:03.090359Z","steps":["trace[865177052] 'agreement among raft nodes before linearized reading' (duration: 1.06188557s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:03.090594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:02.024288Z","time spent":"1.06610873s","remote":"127.0.0.1:49384","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 "} {"level":"info","ts":"2026-04-02T17:47:03.086113Z","caller":"traceutil/trace.go:171","msg":"trace[1565552200] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:584; }","duration":"1.195149217s","start":"2026-04-02T17:47:01.890896Z","end":"2026-04-02T17:47:03.086045Z","steps":["trace[1565552200] 'agreement among raft nodes before linearized reading' (duration: 1.194771438s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:03.090706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:01.890883Z","time spent":"1.199814036s","remote":"127.0.0.1:41566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-02T17:47:03.087352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:01.934217Z","time spent":"1.153121064s","remote":"127.0.0.1:49362","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"info","ts":"2026-04-02T17:47:03.087842Z","caller":"traceutil/trace.go:171","msg":"trace[693497541] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:584; }","duration":"1.099134432s","start":"2026-04-02T17:47:01.988697Z","end":"2026-04-02T17:47:03.087831Z","steps":["trace[693497541] 'agreement among raft nodes before linearized reading' (duration: 1.097541255s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:03.09089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:01.988691Z","time spent":"1.102188973s","remote":"127.0.0.1:49376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "} {"level":"warn","ts":"2026-04-02T17:47:03.086067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:01.98851Z","time spent":"1.097547644s","remote":"127.0.0.1:49376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 "} {"level":"warn","ts":"2026-04-02T17:47:04.69827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.317951ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-02T17:47:04.698516Z","caller":"traceutil/trace.go:171","msg":"trace[1029938253] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"237.76043ms","start":"2026-04-02T17:47:04.460711Z","end":"2026-04-02T17:47:04.698471Z","steps":["trace[1029938253] 'process raft request' (duration: 94.167152ms)","trace[1029938253] 'compare' (duration: 143.187728ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T17:47:04.698716Z","caller":"traceutil/trace.go:171","msg":"trace[1322865395] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"203.070269ms","start":"2026-04-02T17:47:04.495627Z","end":"2026-04-02T17:47:04.698697Z","steps":["trace[1322865395] 'process raft request' (duration: 202.986377ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:47:04.698722Z","caller":"traceutil/trace.go:171","msg":"trace[1652088832] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"203.487118ms","start":"2026-04-02T17:47:04.495209Z","end":"2026-04-02T17:47:04.698696Z","steps":["trace[1652088832] 'process raft request' (duration: 203.268213ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:47:04.698827Z","caller":"traceutil/trace.go:171","msg":"trace[1588452876] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"204.477722ms","start":"2026-04-02T17:47:04.494333Z","end":"2026-04-02T17:47:04.69881Z","steps":["trace[1588452876] 'process raft request' (duration: 204.055502ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:47:04.763825Z","caller":"traceutil/trace.go:171","msg":"trace[1377013298] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"110.082021ms","start":"2026-04-02T17:47:04.653713Z","end":"2026-04-02T17:47:04.763795Z","steps":["trace[1377013298] 'process raft request' (duration: 109.815905ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:04.764254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.769414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-fcn7m\" ","response":"range_response_count:1 size:17243"} {"level":"info","ts":"2026-04-02T17:47:04.764416Z","caller":"traceutil/trace.go:171","msg":"trace[1875787050] range","detail":"{range_begin:/registry/pods/kube-system/cilium-fcn7m; range_end:; response_count:1; response_revision:617; }","duration":"118.975529ms","start":"2026-04-02T17:47:04.645421Z","end":"2026-04-02T17:47:04.764396Z","steps":["trace[1875787050] 'agreement among raft nodes before linearized reading' (duration: 118.682272ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:05.170023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.867496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T17:47:05.17015Z","caller":"traceutil/trace.go:171","msg":"trace[511319408] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:0; response_revision:631; }","duration":"118.02227ms","start":"2026-04-02T17:47:05.052071Z","end":"2026-04-02T17:47:05.170093Z","steps":["trace[511319408] 'range keys from in-memory index tree' (duration: 117.791205ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:47:08.049269Z","caller":"traceutil/trace.go:171","msg":"trace[852725187] transaction","detail":"{read_only:false; response_revision:667; number_of_response:1; }","duration":"173.667987ms","start":"2026-04-02T17:47:07.875575Z","end":"2026-04-02T17:47:08.049243Z","steps":["trace[852725187] 'process raft request' (duration: 173.34622ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:47:08.101058Z","caller":"traceutil/trace.go:171","msg":"trace[53684193] transaction","detail":"{read_only:false; response_revision:669; number_of_response:1; }","duration":"220.304866ms","start":"2026-04-02T17:47:07.880719Z","end":"2026-04-02T17:47:08.101024Z","steps":["trace[53684193] 'process raft request' (duration: 220.015849ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:47:08.101066Z","caller":"traceutil/trace.go:171","msg":"trace[782331221] transaction","detail":"{read_only:false; response_revision:668; number_of_response:1; }","duration":"221.211567ms","start":"2026-04-02T17:47:07.87977Z","end":"2026-04-02T17:47:08.100982Z","steps":["trace[782331221] 'process raft request' (duration: 220.818488ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:47:16.856753Z","caller":"traceutil/trace.go:171","msg":"trace[1625088828] transaction","detail":"{read_only:false; response_revision:726; number_of_response:1; }","duration":"132.787462ms","start":"2026-04-02T17:47:16.72394Z","end":"2026-04-02T17:47:16.856727Z","steps":["trace[1625088828] 'process raft request' (duration: 132.605788ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:47:16.975979Z","caller":"traceutil/trace.go:171","msg":"trace[588488554] transaction","detail":"{read_only:false; response_revision:728; number_of_response:1; }","duration":"112.00185ms","start":"2026-04-02T17:47:16.863951Z","end":"2026-04-02T17:47:16.975953Z","steps":["trace[588488554] 'process raft request' (duration: 111.790206ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:47:16.976222Z","caller":"traceutil/trace.go:171","msg":"trace[1771314835] transaction","detail":"{read_only:false; response_revision:729; number_of_response:1; }","duration":"107.946057ms","start":"2026-04-02T17:47:16.868248Z","end":"2026-04-02T17:47:16.976194Z","steps":["trace[1771314835] 'process raft request' (duration: 107.64938ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:47:22.690331Z","caller":"traceutil/trace.go:171","msg":"trace[1801653206] transaction","detail":"{read_only:false; response_revision:761; number_of_response:1; }","duration":"115.640275ms","start":"2026-04-02T17:47:22.574663Z","end":"2026-04-02T17:47:22.690304Z","steps":["trace[1801653206] 'process raft request' (duration: 115.479871ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:47:23.303516Z","caller":"traceutil/trace.go:171","msg":"trace[1323221045] linearizableReadLoop","detail":"{readStateIndex:793; appliedIndex:792; }","duration":"253.077314ms","start":"2026-04-02T17:47:23.05042Z","end":"2026-04-02T17:47:23.303497Z","steps":["trace[1323221045] 'read index received' (duration: 252.860319ms)","trace[1323221045] 'applied index is now lower than readState.Index' (duration: 216.075µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T17:47:23.303548Z","caller":"traceutil/trace.go:171","msg":"trace[2087958978] transaction","detail":"{read_only:false; response_revision:762; number_of_response:1; }","duration":"549.395758ms","start":"2026-04-02T17:47:22.754124Z","end":"2026-04-02T17:47:23.30352Z","steps":["trace[2087958978] 'process raft request' (duration: 549.213264ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:23.303665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.237907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-02T17:47:23.303756Z","caller":"traceutil/trace.go:171","msg":"trace[608008180] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:762; }","duration":"253.37851ms","start":"2026-04-02T17:47:23.050343Z","end":"2026-04-02T17:47:23.303722Z","steps":["trace[608008180] 'agreement among raft nodes before linearized reading' (duration: 253.238957ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:47:23.303814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:22.754103Z","time spent":"549.515491ms","remote":"127.0.0.1:33186","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T17:47:37.943079Z","caller":"traceutil/trace.go:171","msg":"trace[1482284680] transaction","detail":"{read_only:false; response_revision:908; number_of_response:1; }","duration":"119.611837ms","start":"2026-04-02T17:47:37.82345Z","end":"2026-04-02T17:47:37.943062Z","steps":["trace[1482284680] 'process raft request' (duration: 119.508904ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:47:38.027335Z","caller":"traceutil/trace.go:171","msg":"trace[630538151] transaction","detail":"{read_only:false; response_revision:909; number_of_response:1; }","duration":"127.98705ms","start":"2026-04-02T17:47:37.899326Z","end":"2026-04-02T17:47:38.027313Z","steps":["trace[630538151] 'process raft request' (duration: 127.854287ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:47:49.326314Z","caller":"traceutil/trace.go:171","msg":"trace[2038101360] transaction","detail":"{read_only:false; response_revision:945; number_of_response:1; }","duration":"103.630477ms","start":"2026-04-02T17:47:49.222661Z","end":"2026-04-02T17:47:49.326291Z","steps":["trace[2038101360] 'process raft request' (duration: 103.502364ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:47:55.966806Z","caller":"traceutil/trace.go:171","msg":"trace[2035469805] transaction","detail":"{read_only:false; response_revision:967; number_of_response:1; }","duration":"129.24494ms","start":"2026-04-02T17:47:55.83754Z","end":"2026-04-02T17:47:55.966785Z","steps":["trace[2035469805] 'process raft request' (duration: 129.094306ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:47:55.977094Z","caller":"traceutil/trace.go:171","msg":"trace[1763212783] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"136.268823ms","start":"2026-04-02T17:47:55.840807Z","end":"2026-04-02T17:47:55.977076Z","steps":["trace[1763212783] 'process raft request' (duration: 136.182431ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:48:04.477168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.413351ms","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-04-02T17:48:04.47727Z","caller":"traceutil/trace.go:171","msg":"trace[1991535246] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:994; }","duration":"454.559154ms","start":"2026-04-02T17:48:04.022688Z","end":"2026-04-02T17:48:04.477247Z","steps":["trace[1991535246] 'range keys from in-memory index tree' (duration: 454.228377ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:48:04.477272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.541524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-02T17:48:04.477311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:48:04.022679Z","time spent":"454.623336ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-02T17:48:04.477375Z","caller":"traceutil/trace.go:171","msg":"trace[144289420] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:994; }","duration":"355.664797ms","start":"2026-04-02T17:48:04.121692Z","end":"2026-04-02T17:48:04.477356Z","steps":["trace[144289420] 'count revisions from in-memory index tree' (duration: 355.469473ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:48:04.477378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"801.856698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-02T17:48:04.477419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:48:04.121675Z","time spent":"355.732429ms","remote":"127.0.0.1:56084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":3,"response size":31,"request content":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true "} {"level":"warn","ts":"2026-04-02T17:48:04.477447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.906509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-02T17:48:04.47747Z","caller":"traceutil/trace.go:171","msg":"trace[1831155246] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:994; }","duration":"801.978001ms","start":"2026-04-02T17:48:03.675467Z","end":"2026-04-02T17:48:04.477445Z","steps":["trace[1831155246] 'range keys from in-memory index tree' (duration: 801.153311ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:48:04.477524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:48:03.675452Z","time spent":"802.062013ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-02T17:48:04.477525Z","caller":"traceutil/trace.go:171","msg":"trace[942613854] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:994; }","duration":"473.008241ms","start":"2026-04-02T17:48:04.004496Z","end":"2026-04-02T17:48:04.477504Z","steps":["trace[942613854] 'range keys from in-memory index tree' (duration: 472.754596ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:48:04.477589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:48:04.004489Z","time spent":"473.091254ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-02T17:48:04.477784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.611187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-02T17:48:04.477838Z","caller":"traceutil/trace.go:171","msg":"trace[2108752060] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:994; }","duration":"483.700799ms","start":"2026-04-02T17:48:03.994126Z","end":"2026-04-02T17:48:04.477827Z","steps":["trace[2108752060] 'range keys from in-memory index tree' (duration: 482.529812ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:48:04.477869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:48:03.994106Z","time spent":"483.755251ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-02T17:48:04.509256Z","caller":"traceutil/trace.go:171","msg":"trace[856564652] linearizableReadLoop","detail":"{readStateIndex:1036; appliedIndex:1035; }","duration":"119.189707ms","start":"2026-04-02T17:48:04.390047Z","end":"2026-04-02T17:48:04.509237Z","steps":["trace[856564652] 'read index received' (duration: 119.107115ms)","trace[856564652] 'applied index is now lower than readState.Index' (duration: 81.612µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T17:48:04.509374Z","caller":"traceutil/trace.go:171","msg":"trace[1333614140] transaction","detail":"{read_only:false; response_revision:995; number_of_response:1; }","duration":"350.224291ms","start":"2026-04-02T17:48:04.159125Z","end":"2026-04-02T17:48:04.509349Z","steps":["trace[1333614140] 'process raft request' (duration: 349.903923ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:48:04.509404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.350621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T17:48:04.509457Z","caller":"traceutil/trace.go:171","msg":"trace[6537973] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:995; }","duration":"119.443513ms","start":"2026-04-02T17:48:04.390003Z","end":"2026-04-02T17:48:04.509446Z","steps":["trace[6537973] 'agreement among raft nodes before linearized reading' (duration: 119.32792ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:48:04.509514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:48:04.159113Z","time spent":"350.330924ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T17:48:05.010395Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8620625600670939733,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-02T17:48:05.257303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.268586ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T17:48:05.257483Z","caller":"traceutil/trace.go:171","msg":"trace[1817123686] transaction","detail":"{read_only:false; response_revision:996; number_of_response:1; }","duration":"775.536259ms","start":"2026-04-02T17:48:04.481922Z","end":"2026-04-02T17:48:05.257458Z","steps":["trace[1817123686] 'process raft request' (duration: 558.034277ms)","trace[1817123686] 'compare' (duration: 217.080742ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T17:48:05.257521Z","caller":"traceutil/trace.go:171","msg":"trace[1331605159] transaction","detail":"{read_only:false; response_revision:997; number_of_response:1; }","duration":"775.58361ms","start":"2026-04-02T17:48:04.481922Z","end":"2026-04-02T17:48:05.257505Z","steps":["trace[1331605159] 'process raft request' (duration: 775.471227ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:48:05.25759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:48:04.481899Z","time spent":"775.629311ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T17:48:05.257587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:48:04.481899Z","time spent":"775.655431ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T17:48:05.257793Z","caller":"traceutil/trace.go:171","msg":"trace[501765458] linearizableReadLoop","detail":"{readStateIndex:1040; appliedIndex:1036; }","duration":"748.464532ms","start":"2026-04-02T17:48:04.509301Z","end":"2026-04-02T17:48:05.257766Z","steps":["trace[501765458] 'read index received' (duration: 530.632843ms)","trace[501765458] 'applied index is now lower than readState.Index' (duration: 217.830799ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T17:48:05.257867Z","caller":"traceutil/trace.go:171","msg":"trace[450684368] transaction","detail":"{read_only:false; response_revision:999; number_of_response:1; }","duration":"775.638191ms","start":"2026-04-02T17:48:04.482219Z","end":"2026-04-02T17:48:05.257857Z","steps":["trace[450684368] 'process raft request' (duration: 775.466957ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:48:05.257891Z","caller":"traceutil/trace.go:171","msg":"trace[2040100003] transaction","detail":"{read_only:false; response_revision:998; number_of_response:1; }","duration":"775.964789ms","start":"2026-04-02T17:48:04.481918Z","end":"2026-04-02T17:48:05.257883Z","steps":["trace[2040100003] 'process raft request' (duration: 775.554979ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:48:05.257916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"828.862952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T17:48:05.257921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:48:04.482209Z","time spent":"775.685042ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T17:48:05.257932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:48:04.48189Z","time spent":"776.020679ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T17:48:05.25795Z","caller":"traceutil/trace.go:171","msg":"trace[1173021737] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:999; }","duration":"828.921033ms","start":"2026-04-02T17:48:04.429018Z","end":"2026-04-02T17:48:05.257939Z","steps":["trace[1173021737] 'agreement among raft nodes before linearized reading' (duration: 828.856932ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:48:05.257984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:48:04.429012Z","time spent":"828.964415ms","remote":"127.0.0.1:55894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-02T17:48:05.258014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"841.874963ms","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-04-02T17:48:05.25804Z","caller":"traceutil/trace.go:171","msg":"trace[1726673823] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:999; }","duration":"841.914754ms","start":"2026-04-02T17:48:04.416116Z","end":"2026-04-02T17:48:05.258031Z","steps":["trace[1726673823] 'agreement among raft nodes before linearized reading' (duration: 841.874043ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:48:05.258058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:48:04.416109Z","time spent":"841.945165ms","remote":"127.0.0.1:41518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"info","ts":"2026-04-02T17:48:05.274184Z","caller":"traceutil/trace.go:171","msg":"trace[259620216] transaction","detail":"{read_only:false; response_revision:1000; number_of_response:1; }","duration":"113.923765ms","start":"2026-04-02T17:48:05.160247Z","end":"2026-04-02T17:48:05.27417Z","steps":["trace[259620216] 'process raft request' (duration: 113.788732ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:48:05.27421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"655.520583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.65\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-02T17:48:05.274263Z","caller":"traceutil/trace.go:171","msg":"trace[1522728729] range","detail":"{range_begin:/registry/masterleases/199.204.45.65; range_end:; response_count:1; response_revision:1000; }","duration":"655.622335ms","start":"2026-04-02T17:48:04.618631Z","end":"2026-04-02T17:48:05.274253Z","steps":["trace[1522728729] 'agreement among raft nodes before linearized reading' (duration: 655.486152ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:48:05.274287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:48:04.618613Z","time spent":"655.669516ms","remote":"127.0.0.1:55938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.65\" "} {"level":"warn","ts":"2026-04-02T17:48:05.274482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.414579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-02T17:48:05.274512Z","caller":"traceutil/trace.go:171","msg":"trace[1347667335] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1000; }","duration":"297.493451ms","start":"2026-04-02T17:48:04.977009Z","end":"2026-04-02T17:48:05.274503Z","steps":["trace[1347667335] 'agreement among raft nodes before linearized reading' (duration: 297.387929ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:48:23.908843Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8620625600670939882,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-02T17:48:24.051155Z","caller":"traceutil/trace.go:171","msg":"trace[960363816] linearizableReadLoop","detail":"{readStateIndex:1101; appliedIndex:1100; }","duration":"643.292804ms","start":"2026-04-02T17:48:23.407838Z","end":"2026-04-02T17:48:24.051131Z","steps":["trace[960363816] 'read index received' (duration: 643.079699ms)","trace[960363816] 'applied index is now lower than readState.Index' (duration: 212.155µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T17:48:24.051443Z","caller":"traceutil/trace.go:171","msg":"trace[514639295] transaction","detail":"{read_only:false; response_revision:1056; number_of_response:1; }","duration":"665.360492ms","start":"2026-04-02T17:48:23.38604Z","end":"2026-04-02T17:48:24.051401Z","steps":["trace[514639295] 'process raft request' (duration: 664.942602ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:48:24.051595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:48:23.386025Z","time spent":"665.482224ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T17:48:24.051614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"643.747196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-02T17:48:24.05169Z","caller":"traceutil/trace.go:171","msg":"trace[1395276056] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1056; }","duration":"643.878758ms","start":"2026-04-02T17:48:23.407794Z","end":"2026-04-02T17:48:24.051673Z","steps":["trace[1395276056] 'agreement among raft nodes before linearized reading' (duration: 643.588881ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:48:24.051738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:48:23.407774Z","time spent":"643.9555ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-02T17:48:24.051782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.644105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T17:48:24.051756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"641.176175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-02T17:48:24.051863Z","caller":"traceutil/trace.go:171","msg":"trace[797563067] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1056; }","duration":"641.322208ms","start":"2026-04-02T17:48:23.410527Z","end":"2026-04-02T17:48:24.05185Z","steps":["trace[797563067] 'agreement among raft nodes before linearized reading' (duration: 641.043522ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:48:24.051883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"639.576848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-02T17:48:24.051905Z","caller":"traceutil/trace.go:171","msg":"trace[286122889] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1056; }","duration":"639.617308ms","start":"2026-04-02T17:48:23.412281Z","end":"2026-04-02T17:48:24.051899Z","steps":["trace[286122889] 'agreement among raft nodes before linearized reading' (duration: 639.555657ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:48:24.051927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:48:23.412271Z","time spent":"639.6504ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-02T17:48:24.051958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:48:23.41051Z","time spent":"641.422771ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-02T17:48:24.051813Z","caller":"traceutil/trace.go:171","msg":"trace[83394712] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1056; }","duration":"228.667366ms","start":"2026-04-02T17:48:23.823131Z","end":"2026-04-02T17:48:24.051799Z","steps":["trace[83394712] 'agreement among raft nodes before linearized reading' (duration: 228.626525ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:48:24.051981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"639.188789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-02T17:48:24.052099Z","caller":"traceutil/trace.go:171","msg":"trace[1186013942] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1056; }","duration":"639.363023ms","start":"2026-04-02T17:48:23.412718Z","end":"2026-04-02T17:48:24.052081Z","steps":["trace[1186013942] 'agreement among raft nodes before linearized reading' (duration: 639.095576ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:48:24.051742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"621.135787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T17:48:24.052149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:48:23.412702Z","time spent":"639.438715ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-02T17:48:24.052207Z","caller":"traceutil/trace.go:171","msg":"trace[1213828217] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1056; }","duration":"621.588867ms","start":"2026-04-02T17:48:23.430578Z","end":"2026-04-02T17:48:24.052167Z","steps":["trace[1213828217] 'agreement among raft nodes before linearized reading' (duration: 621.136626ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:48:24.052235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:48:23.430566Z","time spent":"621.661379ms","remote":"127.0.0.1:55882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-02T17:48:24.685958Z","caller":"traceutil/trace.go:171","msg":"trace[419261752] transaction","detail":"{read_only:false; response_revision:1057; number_of_response:1; }","duration":"629.794537ms","start":"2026-04-02T17:48:24.056138Z","end":"2026-04-02T17:48:24.685933Z","steps":["trace[419261752] 'process raft request' (duration: 629.652584ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:48:24.686116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:48:24.056115Z","time spent":"629.926741ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T17:48:24.696194Z","caller":"traceutil/trace.go:171","msg":"trace[1903292362] linearizableReadLoop","detail":"{readStateIndex:1105; appliedIndex:1102; }","duration":"347.305693ms","start":"2026-04-02T17:48:24.348872Z","end":"2026-04-02T17:48:24.696178Z","steps":["trace[1903292362] 'read index received' (duration: 337.097704ms)","trace[1903292362] 'applied index is now lower than readState.Index' (duration: 10.206859ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T17:48:24.696192Z","caller":"traceutil/trace.go:171","msg":"trace[1916500345] transaction","detail":"{read_only:false; response_revision:1058; number_of_response:1; }","duration":"639.617347ms","start":"2026-04-02T17:48:24.056546Z","end":"2026-04-02T17:48:24.696164Z","steps":["trace[1916500345] 'process raft request' (duration: 639.463774ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:48:24.696285Z","caller":"traceutil/trace.go:171","msg":"trace[98562267] transaction","detail":"{read_only:false; response_revision:1059; number_of_response:1; }","duration":"639.677639ms","start":"2026-04-02T17:48:24.056597Z","end":"2026-04-02T17:48:24.696275Z","steps":["trace[98562267] 'process raft request' (duration: 639.484604ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:48:24.696354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:48:24.056576Z","time spent":"639.7361ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T17:48:24.696423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:48:24.056531Z","time spent":"639.75935ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T17:48:24.696532Z","caller":"traceutil/trace.go:171","msg":"trace[175388760] transaction","detail":"{read_only:false; response_revision:1060; number_of_response:1; }","duration":"639.913404ms","start":"2026-04-02T17:48:24.056608Z","end":"2026-04-02T17:48:24.696522Z","steps":["trace[175388760] 'process raft request' (duration: 639.504234ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:48:24.696593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:48:24.056587Z","time spent":"639.975776ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T17:48:24.696765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.896426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T17:48:24.69684Z","caller":"traceutil/trace.go:171","msg":"trace[535462552] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1061; }","duration":"348.004279ms","start":"2026-04-02T17:48:24.348826Z","end":"2026-04-02T17:48:24.69683Z","steps":["trace[535462552] 'agreement among raft nodes before linearized reading' (duration: 347.879726ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:48:24.696886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.496642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T17:48:24.696937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.64199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T17:48:24.696966Z","caller":"traceutil/trace.go:171","msg":"trace[191964078] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1061; }","duration":"265.690461ms","start":"2026-04-02T17:48:24.431267Z","end":"2026-04-02T17:48:24.696958Z","steps":["trace[191964078] 'agreement among raft nodes before linearized reading' (duration: 265.64371ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:48:24.696907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.860032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-02T17:48:24.69697Z","caller":"traceutil/trace.go:171","msg":"trace[2128192015] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1061; }","duration":"322.623025ms","start":"2026-04-02T17:48:24.374321Z","end":"2026-04-02T17:48:24.696944Z","steps":["trace[2128192015] 'agreement among raft nodes before linearized reading' (duration: 322.443651ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:48:24.697015Z","caller":"traceutil/trace.go:171","msg":"trace[1482636541] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:1061; }","duration":"235.975295ms","start":"2026-04-02T17:48:24.461025Z","end":"2026-04-02T17:48:24.697Z","steps":["trace[1482636541] 'agreement among raft nodes before linearized reading' (duration: 235.75363ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:48:24.697024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:48:24.374307Z","time spent":"322.705786ms","remote":"127.0.0.1:41466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-02T17:48:24.697259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:48:24.34881Z","time spent":"348.052871ms","remote":"127.0.0.1:56022","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":29,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "} {"level":"info","ts":"2026-04-02T17:48:26.208248Z","caller":"traceutil/trace.go:171","msg":"trace[2066161144] linearizableReadLoop","detail":"{readStateIndex:1109; appliedIndex:1108; }","duration":"151.630199ms","start":"2026-04-02T17:48:26.056596Z","end":"2026-04-02T17:48:26.208226Z","steps":["trace[2066161144] 'read index received' (duration: 151.413764ms)","trace[2066161144] 'applied index is now lower than readState.Index' (duration: 215.465µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T17:48:26.208302Z","caller":"traceutil/trace.go:171","msg":"trace[1314020382] transaction","detail":"{read_only:false; response_revision:1063; number_of_response:1; }","duration":"492.091292ms","start":"2026-04-02T17:48:25.716185Z","end":"2026-04-02T17:48:26.208276Z","steps":["trace[1314020382] 'process raft request' (duration: 491.897267ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:48:26.208432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:48:25.716162Z","time spent":"492.202255ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T17:48:26.208471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.855514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-02T17:48:26.208517Z","caller":"traceutil/trace.go:171","msg":"trace[1047621370] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1063; }","duration":"151.950476ms","start":"2026-04-02T17:48:26.056552Z","end":"2026-04-02T17:48:26.208503Z","steps":["trace[1047621370] 'agreement among raft nodes before linearized reading' (duration: 151.766872ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:48:26.853158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.369521ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T17:48:26.853417Z","caller":"traceutil/trace.go:171","msg":"trace[1618677414] transaction","detail":"{read_only:false; response_revision:1065; number_of_response:1; }","duration":"150.481743ms","start":"2026-04-02T17:48:26.702912Z","end":"2026-04-02T17:48:26.853394Z","steps":["trace[1618677414] 'process raft request' (duration: 150.381851ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:48:26.853418Z","caller":"traceutil/trace.go:171","msg":"trace[1952672175] transaction","detail":"{read_only:false; response_revision:1064; number_of_response:1; }","duration":"639.710817ms","start":"2026-04-02T17:48:26.213668Z","end":"2026-04-02T17:48:26.853379Z","steps":["trace[1952672175] 'process raft request' (duration: 439.021629ms)","trace[1952672175] 'compare' (duration: 200.235337ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T17:48:26.853736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.213351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-02T17:48:26.853793Z","caller":"traceutil/trace.go:171","msg":"trace[965588451] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1065; }","duration":"163.307943ms","start":"2026-04-02T17:48:26.690471Z","end":"2026-04-02T17:48:26.853779Z","steps":["trace[965588451] 'agreement among raft nodes before linearized reading' (duration: 163.134929ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:48:26.853579Z","caller":"traceutil/trace.go:171","msg":"trace[773170054] linearizableReadLoop","detail":"{readStateIndex:1110; appliedIndex:1109; }","duration":"163.051767ms","start":"2026-04-02T17:48:26.690513Z","end":"2026-04-02T17:48:26.853565Z","steps":["trace[773170054] 'read index received' (duration: 42.481µs)","trace[773170054] 'applied index is now lower than readState.Index' (duration: 163.007886ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T17:48:26.854127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:48:26.213646Z","time spent":"640.030124ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T17:48:26.854208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.246911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-02T17:48:26.85422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.980102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-02T17:48:26.854262Z","caller":"traceutil/trace.go:171","msg":"trace[1182760210] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1065; }","duration":"151.345283ms","start":"2026-04-02T17:48:26.702903Z","end":"2026-04-02T17:48:26.854249Z","steps":["trace[1182760210] 'agreement among raft nodes before linearized reading' (duration: 151.132248ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:48:26.854285Z","caller":"traceutil/trace.go:171","msg":"trace[775078683] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1065; }","duration":"153.111565ms","start":"2026-04-02T17:48:26.701151Z","end":"2026-04-02T17:48:26.854263Z","steps":["trace[775078683] 'agreement among raft nodes before linearized reading' (duration: 152.850349ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:48:26.854389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.521647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-02T17:48:26.854463Z","caller":"traceutil/trace.go:171","msg":"trace[1769548819] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1065; }","duration":"151.6273ms","start":"2026-04-02T17:48:26.70282Z","end":"2026-04-02T17:48:26.854447Z","steps":["trace[1769548819] 'agreement among raft nodes before linearized reading' (duration: 151.435086ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:48:27.04748Z","caller":"traceutil/trace.go:171","msg":"trace[617292760] transaction","detail":"{read_only:false; response_revision:1066; number_of_response:1; }","duration":"189.652692ms","start":"2026-04-02T17:48:26.857799Z","end":"2026-04-02T17:48:27.047452Z","steps":["trace[617292760] 'process raft request' (duration: 111.576823ms)","trace[617292760] 'compare' (duration: 77.969586ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T17:48:27.122373Z","caller":"traceutil/trace.go:171","msg":"trace[1889367710] linearizableReadLoop","detail":"{readStateIndex:1115; appliedIndex:1111; }","duration":"227.538718ms","start":"2026-04-02T17:48:26.894806Z","end":"2026-04-02T17:48:27.122345Z","steps":["trace[1889367710] 'read index received' (duration: 74.583537ms)","trace[1889367710] 'applied index is now lower than readState.Index' (duration: 152.954221ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T17:48:27.122406Z","caller":"traceutil/trace.go:171","msg":"trace[1398154979] transaction","detail":"{read_only:false; response_revision:1067; number_of_response:1; }","duration":"263.014929ms","start":"2026-04-02T17:48:26.859353Z","end":"2026-04-02T17:48:27.122368Z","steps":["trace[1398154979] 'process raft request' (duration: 262.790154ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:48:27.12247Z","caller":"traceutil/trace.go:171","msg":"trace[751015388] transaction","detail":"{read_only:false; response_revision:1068; number_of_response:1; }","duration":"263.025169ms","start":"2026-04-02T17:48:26.859405Z","end":"2026-04-02T17:48:27.12243Z","steps":["trace[751015388] 'process raft request' (duration: 262.873606ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:48:27.122581Z","caller":"traceutil/trace.go:171","msg":"trace[1372456013] transaction","detail":"{read_only:false; response_revision:1069; number_of_response:1; }","duration":"263.118482ms","start":"2026-04-02T17:48:26.859452Z","end":"2026-04-02T17:48:27.12257Z","steps":["trace[1372456013] 'process raft request' (duration: 262.860906ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:48:27.122538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.686411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T17:48:27.122721Z","caller":"traceutil/trace.go:171","msg":"trace[1856333849] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:1069; }","duration":"227.931948ms","start":"2026-04-02T17:48:26.894769Z","end":"2026-04-02T17:48:27.122701Z","steps":["trace[1856333849] 'agreement among raft nodes before linearized reading' (duration: 227.673502ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:48:28.961691Z","caller":"traceutil/trace.go:171","msg":"trace[247880399] transaction","detail":"{read_only:false; response_revision:1070; number_of_response:1; }","duration":"102.463029ms","start":"2026-04-02T17:48:28.859204Z","end":"2026-04-02T17:48:28.961667Z","steps":["trace[247880399] 'process raft request' (duration: 102.256904ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:48:29.125045Z","caller":"traceutil/trace.go:171","msg":"trace[413683609] transaction","detail":"{read_only:false; response_revision:1071; number_of_response:1; }","duration":"262.522136ms","start":"2026-04-02T17:48:28.862489Z","end":"2026-04-02T17:48:29.125011Z","steps":["trace[413683609] 'process raft request' (duration: 224.008894ms)","trace[413683609] 'compare' (duration: 38.376169ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T17:48:29.369095Z","caller":"traceutil/trace.go:171","msg":"trace[1545467879] transaction","detail":"{read_only:false; response_revision:1072; number_of_response:1; }","duration":"239.829366ms","start":"2026-04-02T17:48:29.129236Z","end":"2026-04-02T17:48:29.369066Z","steps":["trace[1545467879] 'process raft request' (duration: 157.97358ms)","trace[1545467879] 'compare' (duration: 81.631491ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T17:48:29.420968Z","caller":"traceutil/trace.go:171","msg":"trace[359841088] transaction","detail":"{read_only:false; response_revision:1075; number_of_response:1; }","duration":"289.282154ms","start":"2026-04-02T17:48:29.131664Z","end":"2026-04-02T17:48:29.420946Z","steps":["trace[359841088] 'process raft request' (duration: 289.242003ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:48:29.421129Z","caller":"traceutil/trace.go:171","msg":"trace[1406144697] transaction","detail":"{read_only:false; response_revision:1073; number_of_response:1; }","duration":"291.105317ms","start":"2026-04-02T17:48:29.13001Z","end":"2026-04-02T17:48:29.421115Z","steps":["trace[1406144697] 'process raft request' (duration: 290.713988ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:48:29.421246Z","caller":"traceutil/trace.go:171","msg":"trace[856618599] transaction","detail":"{read_only:false; response_revision:1074; number_of_response:1; }","duration":"289.95445ms","start":"2026-04-02T17:48:29.131278Z","end":"2026-04-02T17:48:29.421233Z","steps":["trace[856618599] 'process raft request' (duration: 289.581551ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:48:39.940647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.953508ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-04-02T17:48:40.833263Z","caller":"traceutil/trace.go:171","msg":"trace[1321814979] transaction","detail":"{read_only:false; response_revision:1161; number_of_response:1; }","duration":"380.775334ms","start":"2026-04-02T17:48:40.452464Z","end":"2026-04-02T17:48:40.833239Z","steps":["trace[1321814979] 'process raft request' (duration: 380.60772ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:48:40.833476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:48:40.452438Z","time spent":"380.933288ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T17:48:41.065898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.353141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-02T17:48:41.065955Z","caller":"traceutil/trace.go:171","msg":"trace[114136354] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:1161; }","duration":"121.458884ms","start":"2026-04-02T17:48:40.944483Z","end":"2026-04-02T17:48:41.065942Z","steps":["trace[114136354] 'count revisions from in-memory index tree' (duration: 121.265539ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:48:43.68291Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8620625600670940132,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-02T17:48:43.898741Z","caller":"traceutil/trace.go:171","msg":"trace[1498416179] linearizableReadLoop","detail":"{readStateIndex:1219; appliedIndex:1218; }","duration":"716.067186ms","start":"2026-04-02T17:48:43.182651Z","end":"2026-04-02T17:48:43.898718Z","steps":["trace[1498416179] 'read index received' (duration: 715.865081ms)","trace[1498416179] 'applied index is now lower than readState.Index' (duration: 201.235µs)"],"step_count":2} {"level":"warn","ts":"2026-04-02T17:48:43.898921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"565.662984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-02T17:48:43.89896Z","caller":"traceutil/trace.go:171","msg":"trace[711861494] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:1168; }","duration":"565.743216ms","start":"2026-04-02T17:48:43.333208Z","end":"2026-04-02T17:48:43.898951Z","steps":["trace[711861494] 'agreement among raft nodes before linearized reading' (duration: 565.661985ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:48:43.898956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.552651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T17:48:43.898994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:48:43.333192Z","time spent":"565.793497ms","remote":"127.0.0.1:33398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":4,"response size":31,"request content":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true "} {"level":"info","ts":"2026-04-02T17:48:43.899008Z","caller":"traceutil/trace.go:171","msg":"trace[754201754] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1168; }","duration":"468.633232ms","start":"2026-04-02T17:48:43.430359Z","end":"2026-04-02T17:48:43.898992Z","steps":["trace[754201754] 'agreement among raft nodes before linearized reading' (duration: 468.557441ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:48:43.899041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:48:43.430343Z","time spent":"468.691904ms","remote":"127.0.0.1:55882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-02T17:48:43.899081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.09018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-02T17:48:43.899134Z","caller":"traceutil/trace.go:171","msg":"trace[2058038108] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1168; }","duration":"474.182812ms","start":"2026-04-02T17:48:43.424937Z","end":"2026-04-02T17:48:43.89912Z","steps":["trace[2058038108] 'agreement among raft nodes before linearized reading' (duration: 474.035809ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:48:43.899117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.58708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-04-02T17:48:43.899156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.520364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-02T17:48:43.899176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:48:43.424907Z","time spent":"474.261035ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-02T17:48:43.899165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.588444ms","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-04-02T17:48:43.899194Z","caller":"traceutil/trace.go:171","msg":"trace[703687440] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1168; }","duration":"399.586306ms","start":"2026-04-02T17:48:43.499596Z","end":"2026-04-02T17:48:43.899183Z","steps":["trace[703687440] 'agreement among raft nodes before linearized reading' (duration: 399.468803ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:48:43.8992Z","caller":"traceutil/trace.go:171","msg":"trace[326717646] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1168; }","duration":"406.731844ms","start":"2026-04-02T17:48:43.492448Z","end":"2026-04-02T17:48:43.89918Z","steps":["trace[326717646] 'agreement among raft nodes before linearized reading' (duration: 406.452127ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:48:43.899224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:48:43.499583Z","time spent":"399.636117ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-02T17:48:43.89892Z","caller":"traceutil/trace.go:171","msg":"trace[2018343897] transaction","detail":"{read_only:false; response_revision:1168; number_of_response:1; }","duration":"825.027838ms","start":"2026-04-02T17:48:43.073759Z","end":"2026-04-02T17:48:43.898787Z","steps":["trace[2018343897] 'process raft request' (duration: 824.819763ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:48:43.899317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.985433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-02T17:48:43.89923Z","caller":"traceutil/trace.go:171","msg":"trace[1422475305] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1168; }","duration":"208.713117ms","start":"2026-04-02T17:48:43.690501Z","end":"2026-04-02T17:48:43.899214Z","steps":["trace[1422475305] 'agreement among raft nodes before linearized reading' (duration: 208.548883ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:48:43.899359Z","caller":"traceutil/trace.go:171","msg":"trace[1102869603] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1168; }","duration":"414.052025ms","start":"2026-04-02T17:48:43.485295Z","end":"2026-04-02T17:48:43.899347Z","steps":["trace[1102869603] 'agreement among raft nodes before linearized reading' (duration: 413.932362ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:48:43.899391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:48:43.485279Z","time spent":"414.106646ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-02T17:48:43.899265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:48:43.492426Z","time spent":"406.829686ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-02T17:48:43.89952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"716.865484ms","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-04-02T17:48:43.899553Z","caller":"traceutil/trace.go:171","msg":"trace[1013865610] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1168; }","duration":"716.942366ms","start":"2026-04-02T17:48:43.182602Z","end":"2026-04-02T17:48:43.899545Z","steps":["trace[1013865610] 'agreement among raft nodes before linearized reading' (duration: 716.202809ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:48:43.899595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:48:43.182581Z","time spent":"716.996288ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-02T17:48:43.899609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:48:43.073741Z","time spent":"825.636491ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T17:48:58.227284Z","caller":"traceutil/trace.go:171","msg":"trace[1741288956] transaction","detail":"{read_only:false; response_revision:1235; number_of_response:1; }","duration":"229.651997ms","start":"2026-04-02T17:48:57.997607Z","end":"2026-04-02T17:48:58.227259Z","steps":["trace[1741288956] 'process raft request' (duration: 148.569589ms)","trace[1741288956] 'compare' (duration: 80.878143ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T17:48:58.252397Z","caller":"traceutil/trace.go:171","msg":"trace[1111132444] transaction","detail":"{read_only:false; response_revision:1236; number_of_response:1; }","duration":"253.801422ms","start":"2026-04-02T17:48:57.998572Z","end":"2026-04-02T17:48:58.252373Z","steps":["trace[1111132444] 'process raft request' (duration: 253.648858ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:48:58.252375Z","caller":"traceutil/trace.go:171","msg":"trace[520775588] linearizableReadLoop","detail":"{readStateIndex:1290; appliedIndex:1288; }","duration":"179.37816ms","start":"2026-04-02T17:48:58.07297Z","end":"2026-04-02T17:48:58.252348Z","steps":["trace[520775588] 'read index received' (duration: 73.334128ms)","trace[520775588] 'applied index is now lower than readState.Index' (duration: 106.042952ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T17:48:58.252584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.593835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-5tfhb\" ","response":"range_response_count:1 size:11057"} {"level":"info","ts":"2026-04-02T17:48:58.252643Z","caller":"traceutil/trace.go:171","msg":"trace[457330403] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-5tfhb; range_end:; response_count:1; response_revision:1236; }","duration":"179.765199ms","start":"2026-04-02T17:48:58.072864Z","end":"2026-04-02T17:48:58.252629Z","steps":["trace[457330403] 'agreement among raft nodes before linearized reading' (duration: 179.567134ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:48:58.887763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.934074ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T17:48:58.887865Z","caller":"traceutil/trace.go:171","msg":"trace[1149844938] transaction","detail":"{read_only:false; response_revision:1238; number_of_response:1; }","duration":"602.769662ms","start":"2026-04-02T17:48:58.285078Z","end":"2026-04-02T17:48:58.887847Z","steps":["trace[1149844938] 'process raft request' (duration: 325.675444ms)","trace[1149844938] 'compare' (duration: 276.647678ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T17:48:58.887923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:48:58.285058Z","time spent":"602.838284ms","remote":"127.0.0.1:56084","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":914,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T17:48:58.889662Z","caller":"traceutil/trace.go:171","msg":"trace[415166449] linearizableReadLoop","detail":"{readStateIndex:1294; appliedIndex:1291; }","duration":"400.971809ms","start":"2026-04-02T17:48:58.488675Z","end":"2026-04-02T17:48:58.889647Z","steps":["trace[415166449] 'read index received' (duration: 122.054158ms)","trace[415166449] 'applied index is now lower than readState.Index' (duration: 278.916951ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T17:48:58.889768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.084411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T17:48:58.889819Z","caller":"traceutil/trace.go:171","msg":"trace[608139550] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1240; }","duration":"401.177433ms","start":"2026-04-02T17:48:58.488625Z","end":"2026-04-02T17:48:58.889802Z","steps":["trace[608139550] 'agreement among raft nodes before linearized reading' (duration: 401.085031ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:48:58.88987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:48:58.488606Z","time spent":"401.251205ms","remote":"127.0.0.1:33170","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":29,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"info","ts":"2026-04-02T17:48:58.890164Z","caller":"traceutil/trace.go:171","msg":"trace[234028672] transaction","detail":"{read_only:false; response_revision:1239; number_of_response:1; }","duration":"603.938469ms","start":"2026-04-02T17:48:58.286214Z","end":"2026-04-02T17:48:58.890153Z","steps":["trace[234028672] 'process raft request' (duration: 603.283674ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:48:58.89024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:48:58.286206Z","time spent":"603.996672ms","remote":"127.0.0.1:33202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1507,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T17:48:58.890603Z","caller":"traceutil/trace.go:171","msg":"trace[1204960969] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"599.946906ms","start":"2026-04-02T17:48:58.290639Z","end":"2026-04-02T17:48:58.890586Z","steps":["trace[1204960969] 'process raft request' (duration: 598.931463ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:48:58.890703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:48:58.290612Z","time spent":"600.043329ms","remote":"127.0.0.1:33420","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9375,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T17:48:59.753088Z","caller":"traceutil/trace.go:171","msg":"trace[1653432323] transaction","detail":"{read_only:false; response_revision:1241; number_of_response:1; }","duration":"264.711108ms","start":"2026-04-02T17:48:59.488339Z","end":"2026-04-02T17:48:59.75305Z","steps":["trace[1653432323] 'process raft request' (duration: 264.125805ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:49:00.015409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.891545ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-04-02T17:49:00.089256Z","caller":"traceutil/trace.go:171","msg":"trace[649706023] linearizableReadLoop","detail":"{readStateIndex:1297; appliedIndex:1296; }","duration":"112.346411ms","start":"2026-04-02T17:48:59.976889Z","end":"2026-04-02T17:49:00.089235Z","steps":["trace[649706023] 'read index received' (duration: 112.199547ms)","trace[649706023] 'applied index is now lower than readState.Index' (duration: 146.104µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T17:49:00.089368Z","caller":"traceutil/trace.go:171","msg":"trace[1915515042] transaction","detail":"{read_only:false; response_revision:1242; number_of_response:1; }","duration":"145.18639ms","start":"2026-04-02T17:48:59.944173Z","end":"2026-04-02T17:49:00.08936Z","steps":["trace[1915515042] 'process raft request' (duration: 144.931984ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:49:00.089615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.890836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-02T17:49:00.089676Z","caller":"traceutil/trace.go:171","msg":"trace[317673349] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1242; }","duration":"101.976578ms","start":"2026-04-02T17:48:59.987683Z","end":"2026-04-02T17:49:00.08966Z","steps":["trace[317673349] 'agreement among raft nodes before linearized reading' (duration: 101.804084ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:49:00.089797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.893254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-02T17:49:00.089822Z","caller":"traceutil/trace.go:171","msg":"trace[1766727180] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1242; }","duration":"112.960555ms","start":"2026-04-02T17:48:59.976855Z","end":"2026-04-02T17:49:00.089815Z","steps":["trace[1766727180] 'agreement among raft nodes before linearized reading' (duration: 112.850903ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:49:00.445714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.388894ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T17:49:00.445829Z","caller":"traceutil/trace.go:171","msg":"trace[1878782183] transaction","detail":"{read_only:false; response_revision:1243; number_of_response:1; }","duration":"352.282749ms","start":"2026-04-02T17:49:00.093527Z","end":"2026-04-02T17:49:00.44581Z","steps":["trace[1878782183] 'process raft request' (duration: 51.715451ms)","trace[1878782183] 'compare' (duration: 300.267021ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T17:49:00.445892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:49:00.093512Z","time spent":"352.35045ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T17:49:00.465573Z","caller":"traceutil/trace.go:171","msg":"trace[1384658369] linearizableReadLoop","detail":"{readStateIndex:1300; appliedIndex:1298; }","duration":"233.762663ms","start":"2026-04-02T17:49:00.231786Z","end":"2026-04-02T17:49:00.465549Z","steps":["trace[1384658369] 'read index received' (duration: 233.528838ms)","trace[1384658369] 'applied index is now lower than readState.Index' (duration: 232.965µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T17:49:00.465656Z","caller":"traceutil/trace.go:171","msg":"trace[1704931676] transaction","detail":"{read_only:false; response_revision:1245; number_of_response:1; }","duration":"371.95794ms","start":"2026-04-02T17:49:00.093664Z","end":"2026-04-02T17:49:00.465621Z","steps":["trace[1704931676] 'process raft request' (duration: 371.840987ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:49:00.465812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:49:00.093643Z","time spent":"372.083062ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T17:49:00.465826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.667357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-02T17:49:00.465863Z","caller":"traceutil/trace.go:171","msg":"trace[457826902] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1245; }","duration":"208.771388ms","start":"2026-04-02T17:49:00.257081Z","end":"2026-04-02T17:49:00.465852Z","steps":["trace[457826902] 'agreement among raft nodes before linearized reading' (duration: 208.592234ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:49:00.465892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.089911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-02T17:49:00.46598Z","caller":"traceutil/trace.go:171","msg":"trace[1223380319] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1245; }","duration":"234.242665ms","start":"2026-04-02T17:49:00.231719Z","end":"2026-04-02T17:49:00.465962Z","steps":["trace[1223380319] 'agreement among raft nodes before linearized reading' (duration: 233.951458ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:49:00.466087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.073727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T17:49:00.466242Z","caller":"traceutil/trace.go:171","msg":"trace[1343986936] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:1245; }","duration":"142.334243ms","start":"2026-04-02T17:49:00.323887Z","end":"2026-04-02T17:49:00.466221Z","steps":["trace[1343986936] 'agreement among raft nodes before linearized reading' (duration: 141.888623ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:49:00.466544Z","caller":"traceutil/trace.go:171","msg":"trace[1455109550] transaction","detail":"{read_only:false; response_revision:1244; number_of_response:1; }","duration":"371.99977ms","start":"2026-04-02T17:49:00.093587Z","end":"2026-04-02T17:49:00.465587Z","steps":["trace[1455109550] 'process raft request' (duration: 371.790805ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:49:00.466792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:49:00.093566Z","time spent":"373.119537ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T17:49:01.28119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.93218ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T17:49:01.28133Z","caller":"traceutil/trace.go:171","msg":"trace[1780020927] transaction","detail":"{read_only:false; response_revision:1247; number_of_response:1; }","duration":"811.153463ms","start":"2026-04-02T17:49:00.470161Z","end":"2026-04-02T17:49:01.281315Z","steps":["trace[1780020927] 'process raft request' (duration: 811.103962ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:49:01.28138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:49:00.470139Z","time spent":"811.219134ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T17:49:01.281551Z","caller":"traceutil/trace.go:171","msg":"trace[579520189] transaction","detail":"{read_only:false; response_revision:1246; number_of_response:1; }","duration":"811.375487ms","start":"2026-04-02T17:49:00.470141Z","end":"2026-04-02T17:49:01.281516Z","steps":["trace[579520189] 'process raft request' (duration: 471.027578ms)","trace[579520189] 'compare' (duration: 339.564771ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T17:49:01.28171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:49:00.470118Z","time spent":"811.499641ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T17:49:01.495641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.545475ms","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-04-02T17:49:01.495762Z","caller":"traceutil/trace.go:171","msg":"trace[1573678941] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:1248; }","duration":"109.699198ms","start":"2026-04-02T17:49:01.38601Z","end":"2026-04-02T17:49:01.495709Z","steps":["trace[1573678941] 'count revisions from in-memory index tree' (duration: 109.433152ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:49:02.563848Z","caller":"traceutil/trace.go:171","msg":"trace[441097678] transaction","detail":"{read_only:false; response_revision:1250; number_of_response:1; }","duration":"469.555474ms","start":"2026-04-02T17:49:02.094272Z","end":"2026-04-02T17:49:02.563827Z","steps":["trace[441097678] 'process raft request' (duration: 469.40425ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:49:02.563975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:49:02.094247Z","time spent":"469.657967ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T17:49:02.563996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.858687ms","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-04-02T17:49:02.56408Z","caller":"traceutil/trace.go:171","msg":"trace[620103199] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:1250; }","duration":"257.99346ms","start":"2026-04-02T17:49:02.306071Z","end":"2026-04-02T17:49:02.564064Z","steps":["trace[620103199] 'agreement among raft nodes before linearized reading' (duration: 257.857217ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:49:02.564111Z","caller":"traceutil/trace.go:171","msg":"trace[711059072] linearizableReadLoop","detail":"{readStateIndex:1305; appliedIndex:1304; }","duration":"257.682233ms","start":"2026-04-02T17:49:02.306113Z","end":"2026-04-02T17:49:02.563795Z","steps":["trace[711059072] 'read index received' (duration: 257.514609ms)","trace[711059072] 'applied index is now lower than readState.Index' (duration: 167.044µs)"],"step_count":2} {"level":"warn","ts":"2026-04-02T17:49:02.564396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.725896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-02T17:49:02.564419Z","caller":"traceutil/trace.go:171","msg":"trace[1763783785] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1250; }","duration":"114.785588ms","start":"2026-04-02T17:49:02.449627Z","end":"2026-04-02T17:49:02.564413Z","steps":["trace[1763783785] 'agreement among raft nodes before linearized reading' (duration: 114.713736ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:49:02.564633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.283878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T17:49:02.564735Z","caller":"traceutil/trace.go:171","msg":"trace[610482105] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1250; }","duration":"132.845881ms","start":"2026-04-02T17:49:02.431881Z","end":"2026-04-02T17:49:02.564727Z","steps":["trace[610482105] 'agreement among raft nodes before linearized reading' (duration: 132.302798ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:49:02.833381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.734457ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T17:49:02.83351Z","caller":"traceutil/trace.go:171","msg":"trace[2096628449] transaction","detail":"{read_only:false; response_revision:1253; number_of_response:1; }","duration":"265.670591ms","start":"2026-04-02T17:49:02.567827Z","end":"2026-04-02T17:49:02.833497Z","steps":["trace[2096628449] 'process raft request' (duration: 265.63086ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:49:02.83372Z","caller":"traceutil/trace.go:171","msg":"trace[621229082] transaction","detail":"{read_only:false; response_revision:1252; number_of_response:1; }","duration":"266.170902ms","start":"2026-04-02T17:49:02.567538Z","end":"2026-04-02T17:49:02.833709Z","steps":["trace[621229082] 'process raft request' (duration: 63.020005ms)","trace[621229082] 'compare' (duration: 202.625695ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T17:49:03.552583Z","caller":"traceutil/trace.go:171","msg":"trace[52869755] transaction","detail":"{read_only:false; response_revision:1255; number_of_response:1; }","duration":"263.660164ms","start":"2026-04-02T17:49:03.288891Z","end":"2026-04-02T17:49:03.552552Z","steps":["trace[52869755] 'process raft request' (duration: 263.447059ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:49:05.71977Z","caller":"traceutil/trace.go:171","msg":"trace[623056780] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"159.281499ms","start":"2026-04-02T17:49:05.560471Z","end":"2026-04-02T17:49:05.719753Z","steps":["trace[623056780] 'process raft request' (duration: 158.991572ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:49:13.112426Z","caller":"traceutil/trace.go:171","msg":"trace[423447655] linearizableReadLoop","detail":"{readStateIndex:1384; appliedIndex:1383; }","duration":"493.3061ms","start":"2026-04-02T17:49:12.619098Z","end":"2026-04-02T17:49:13.112404Z","steps":["trace[423447655] 'read index received' (duration: 493.118375ms)","trace[423447655] 'applied index is now lower than readState.Index' (duration: 186.734µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T17:49:13.112573Z","caller":"traceutil/trace.go:171","msg":"trace[1467862931] transaction","detail":"{read_only:false; response_revision:1327; number_of_response:1; }","duration":"511.207609ms","start":"2026-04-02T17:49:12.601332Z","end":"2026-04-02T17:49:13.112539Z","steps":["trace[1467862931] 'process raft request' (duration: 510.951863ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:49:13.112654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.544855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-04-02T17:49:13.1127Z","caller":"traceutil/trace.go:171","msg":"trace[1757359085] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1327; }","duration":"493.641977ms","start":"2026-04-02T17:49:12.619043Z","end":"2026-04-02T17:49:13.112685Z","steps":["trace[1757359085] 'agreement among raft nodes before linearized reading' (duration: 493.488363ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:49:13.112733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:49:12.619025Z","time spent":"493.699119ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":550,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-04-02T17:49:13.112732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:49:12.601315Z","time spent":"511.335251ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T17:49:13.112817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.152573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-02T17:49:13.112893Z","caller":"traceutil/trace.go:171","msg":"trace[1098870157] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1327; }","duration":"466.299007ms","start":"2026-04-02T17:49:12.646575Z","end":"2026-04-02T17:49:13.112874Z","steps":["trace[1098870157] 'agreement among raft nodes before linearized reading' (duration: 466.060861ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:49:13.112932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:49:12.646555Z","time spent":"466.368989ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-02T17:49:13.112936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.996286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-02T17:49:13.11301Z","caller":"traceutil/trace.go:171","msg":"trace[138422209] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1327; }","duration":"242.107158ms","start":"2026-04-02T17:49:12.870884Z","end":"2026-04-02T17:49:13.112991Z","steps":["trace[138422209] 'agreement among raft nodes before linearized reading' (duration: 241.944044ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:49:13.113018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.74043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-02T17:49:13.113052Z","caller":"traceutil/trace.go:171","msg":"trace[1362995293] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1327; }","duration":"244.799971ms","start":"2026-04-02T17:49:12.868243Z","end":"2026-04-02T17:49:13.113043Z","steps":["trace[1362995293] 'agreement among raft nodes before linearized reading' (duration: 244.650998ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:49:13.905377Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8620625600670940461,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-02T17:49:14.246582Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.129968737s","expected-duration":"1s"} {"level":"info","ts":"2026-04-02T17:49:14.297211Z","caller":"traceutil/trace.go:171","msg":"trace[803668175] transaction","detail":"{read_only:false; response_revision:1328; number_of_response:1; }","duration":"1.180671574s","start":"2026-04-02T17:49:13.11651Z","end":"2026-04-02T17:49:14.297182Z","steps":["trace[803668175] 'process raft request' (duration: 1.130222463s)","trace[803668175] 'compare' (duration: 50.142054ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T17:49:14.297351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:49:13.116486Z","time spent":"1.180795938s","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T17:49:14.631853Z","caller":"traceutil/trace.go:171","msg":"trace[281750671] transaction","detail":"{read_only:false; response_revision:1329; number_of_response:1; }","duration":"1.515186827s","start":"2026-04-02T17:49:13.116642Z","end":"2026-04-02T17:49:14.631829Z","steps":["trace[281750671] 'process raft request' (duration: 1.514428949s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:49:14.632013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:49:13.116624Z","time spent":"1.515308389s","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T17:49:14.632274Z","caller":"traceutil/trace.go:171","msg":"trace[340761950] transaction","detail":"{read_only:false; response_revision:1330; number_of_response:1; }","duration":"1.515258299s","start":"2026-04-02T17:49:13.116992Z","end":"2026-04-02T17:49:14.63225Z","steps":["trace[340761950] 'process raft request' (duration: 1.514734646s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:49:14.632416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:49:13.116972Z","time spent":"1.515391751s","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":511,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T17:49:14.632524Z","caller":"traceutil/trace.go:171","msg":"trace[1471783718] linearizableReadLoop","detail":"{readStateIndex:1388; appliedIndex:1384; }","duration":"1.227981022s","start":"2026-04-02T17:49:13.404518Z","end":"2026-04-02T17:49:14.632499Z","steps":["trace[1471783718] 'read index received' (duration: 842.287802ms)","trace[1471783718] 'applied index is now lower than readState.Index' (duration: 385.69148ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T17:49:14.632667Z","caller":"traceutil/trace.go:171","msg":"trace[985262994] transaction","detail":"{read_only:false; response_revision:1331; number_of_response:1; }","duration":"1.514986242s","start":"2026-04-02T17:49:13.117643Z","end":"2026-04-02T17:49:14.632629Z","steps":["trace[985262994] 'process raft request' (duration: 1.51446988s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:49:14.632742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.228214348s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-02T17:49:14.63278Z","caller":"traceutil/trace.go:171","msg":"trace[87595852] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1331; }","duration":"1.22830316s","start":"2026-04-02T17:49:13.404467Z","end":"2026-04-02T17:49:14.632771Z","steps":["trace[87595852] 'agreement among raft nodes before linearized reading' (duration: 1.228157896s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:49:14.63287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:49:13.404446Z","time spent":"1.228414242s","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-02T17:49:14.632867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:49:13.117634Z","time spent":"1.515118355s","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T17:49:14.633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"963.684164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-04-02T17:49:14.633104Z","caller":"traceutil/trace.go:171","msg":"trace[753254029] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1331; }","duration":"963.859128ms","start":"2026-04-02T17:49:13.669221Z","end":"2026-04-02T17:49:14.63308Z","steps":["trace[753254029] 'agreement among raft nodes before linearized reading' (duration: 963.476239ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:49:14.633168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:49:13.669197Z","time spent":"963.960601ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":498,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-04-02T17:49:14.63328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.746264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:530"} {"level":"warn","ts":"2026-04-02T17:49:14.633314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"774.564706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-02T17:49:14.633358Z","caller":"traceutil/trace.go:171","msg":"trace[1237757665] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1331; }","duration":"415.875327ms","start":"2026-04-02T17:49:14.217463Z","end":"2026-04-02T17:49:14.633338Z","steps":["trace[1237757665] 'agreement among raft nodes before linearized reading' (duration: 415.599871ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:49:14.633374Z","caller":"traceutil/trace.go:171","msg":"trace[1855119369] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1331; }","duration":"774.659658ms","start":"2026-04-02T17:49:13.858702Z","end":"2026-04-02T17:49:14.633362Z","steps":["trace[1855119369] 'agreement among raft nodes before linearized reading' (duration: 774.479873ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:49:14.633401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:49:14.217441Z","time spent":"415.951939ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":554,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-04-02T17:49:14.633406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:49:13.858682Z","time spent":"774.713899ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-02T17:49:14.634014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.083771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T17:49:14.634154Z","caller":"traceutil/trace.go:171","msg":"trace[36297033] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1331; }","duration":"203.366501ms","start":"2026-04-02T17:49:14.430702Z","end":"2026-04-02T17:49:14.634068Z","steps":["trace[36297033] 'agreement among raft nodes before linearized reading' (duration: 202.04337ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:49:24.788579Z","caller":"traceutil/trace.go:171","msg":"trace[575707547] transaction","detail":"{read_only:false; response_revision:1377; number_of_response:1; }","duration":"105.774185ms","start":"2026-04-02T17:49:24.682765Z","end":"2026-04-02T17:49:24.788539Z","steps":["trace[575707547] 'process raft request' (duration: 105.683203ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:49:24.788708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.525796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-02T17:49:24.789283Z","caller":"traceutil/trace.go:171","msg":"trace[1030516681] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1377; }","duration":"105.13287ms","start":"2026-04-02T17:49:24.684135Z","end":"2026-04-02T17:49:24.789268Z","steps":["trace[1030516681] 'agreement among raft nodes before linearized reading' (duration: 104.403483ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:49:24.788765Z","caller":"traceutil/trace.go:171","msg":"trace[2073559404] transaction","detail":"{read_only:false; response_revision:1376; number_of_response:1; }","duration":"106.052121ms","start":"2026-04-02T17:49:24.682686Z","end":"2026-04-02T17:49:24.788738Z","steps":["trace[2073559404] 'process raft request' (duration: 105.5863ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:52:16.106846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.264143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T17:52:16.10693Z","caller":"traceutil/trace.go:171","msg":"trace[1601851323] 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:2189; }","duration":"149.399197ms","start":"2026-04-02T17:52:15.957509Z","end":"2026-04-02T17:52:16.106908Z","steps":["trace[1601851323] 'count revisions from in-memory index tree' (duration: 149.209022ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:52:16.107165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.611649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-02T17:52:16.107238Z","caller":"traceutil/trace.go:171","msg":"trace[2113014690] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2189; }","duration":"154.722651ms","start":"2026-04-02T17:52:15.952497Z","end":"2026-04-02T17:52:16.107219Z","steps":["trace[2113014690] 'range keys from in-memory index tree' (duration: 154.461175ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:52:16.107919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.617949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"} {"level":"info","ts":"2026-04-02T17:52:16.108107Z","caller":"traceutil/trace.go:171","msg":"trace[342863445] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2189; }","duration":"157.840504ms","start":"2026-04-02T17:52:15.950234Z","end":"2026-04-02T17:52:16.108075Z","steps":["trace[342863445] 'range keys from in-memory index tree' (duration: 156.663527ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:52:24.571686Z","caller":"traceutil/trace.go:171","msg":"trace[962274040] linearizableReadLoop","detail":"{readStateIndex:2326; appliedIndex:2325; }","duration":"314.549293ms","start":"2026-04-02T17:52:24.257122Z","end":"2026-04-02T17:52:24.571672Z","steps":["trace[962274040] 'read index received' (duration: 314.41893ms)","trace[962274040] 'applied index is now lower than readState.Index' (duration: 129.483µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T17:52:24.571759Z","caller":"traceutil/trace.go:171","msg":"trace[2088363170] transaction","detail":"{read_only:false; response_revision:2230; number_of_response:1; }","duration":"340.715167ms","start":"2026-04-02T17:52:24.231038Z","end":"2026-04-02T17:52:24.571754Z","steps":["trace[2088363170] 'process raft request' (duration: 340.537293ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:52:24.571829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:52:24.23102Z","time spent":"340.754118ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T17:52:24.571902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.419837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T17:52:24.571979Z","caller":"traceutil/trace.go:171","msg":"trace[673593349] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:2230; }","duration":"313.53354ms","start":"2026-04-02T17:52:24.258427Z","end":"2026-04-02T17:52:24.571961Z","steps":["trace[673593349] 'agreement among raft nodes before linearized reading' (duration: 313.414207ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:52:24.572026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:52:24.258417Z","time spent":"313.597781ms","remote":"127.0.0.1:41566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-02T17:52:24.572079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.963233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-02T17:52:24.572101Z","caller":"traceutil/trace.go:171","msg":"trace[2140799719] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2230; }","duration":"315.008144ms","start":"2026-04-02T17:52:24.257087Z","end":"2026-04-02T17:52:24.572095Z","steps":["trace[2140799719] 'agreement among raft nodes before linearized reading' (duration: 314.933332ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:52:24.572119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:52:24.257059Z","time spent":"315.057115ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-02T17:52:24.572219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.199898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T17:52:24.572257Z","caller":"traceutil/trace.go:171","msg":"trace[1683450835] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:2230; }","duration":"289.27494ms","start":"2026-04-02T17:52:24.282972Z","end":"2026-04-02T17:52:24.572246Z","steps":["trace[1683450835] 'agreement among raft nodes before linearized reading' (duration: 289.218728ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:52:25.121027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.088563ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T17:52:25.121173Z","caller":"traceutil/trace.go:171","msg":"trace[1011991850] linearizableReadLoop","detail":"{readStateIndex:2327; appliedIndex:2326; }","duration":"488.983668ms","start":"2026-04-02T17:52:24.632174Z","end":"2026-04-02T17:52:25.121158Z","steps":["trace[1011991850] 'read index received' (duration: 32.831µs)","trace[1011991850] 'applied index is now lower than readState.Index' (duration: 488.949857ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T17:52:25.121373Z","caller":"traceutil/trace.go:171","msg":"trace[1542093139] transaction","detail":"{read_only:false; response_revision:2232; number_of_response:1; }","duration":"204.06644ms","start":"2026-04-02T17:52:24.917268Z","end":"2026-04-02T17:52:25.121334Z","steps":["trace[1542093139] 'process raft request' (duration: 203.849805ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:52:25.121409Z","caller":"traceutil/trace.go:171","msg":"trace[471811426] transaction","detail":"{read_only:false; response_revision:2231; number_of_response:1; }","duration":"544.999962ms","start":"2026-04-02T17:52:24.576334Z","end":"2026-04-02T17:52:25.121334Z","steps":["trace[471811426] 'process raft request' (duration: 14.523061ms)","trace[471811426] 'compare' (duration: 529.847487ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T17:52:25.121547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.369137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.65\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-04-02T17:52:25.121645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:52:24.576313Z","time spent":"545.247699ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T17:52:25.121689Z","caller":"traceutil/trace.go:171","msg":"trace[192990920] range","detail":"{range_begin:/registry/masterleases/199.204.45.65; range_end:; response_count:1; response_revision:2232; }","duration":"489.542481ms","start":"2026-04-02T17:52:24.632133Z","end":"2026-04-02T17:52:25.121675Z","steps":["trace[192990920] 'agreement among raft nodes before linearized reading' (duration: 489.290765ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:52:25.121729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:52:24.632117Z","time spent":"489.599112ms","remote":"127.0.0.1:55938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.65\" "} {"level":"warn","ts":"2026-04-02T17:52:25.362125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.452084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"} {"level":"info","ts":"2026-04-02T17:52:25.362206Z","caller":"traceutil/trace.go:171","msg":"trace[1229303598] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:2233; }","duration":"139.584966ms","start":"2026-04-02T17:52:25.222603Z","end":"2026-04-02T17:52:25.362188Z","steps":["trace[1229303598] 'range keys from in-memory index tree' (duration: 139.302669ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:52:25.362492Z","caller":"traceutil/trace.go:171","msg":"trace[946100166] linearizableReadLoop","detail":"{readStateIndex:2331; appliedIndex:2330; }","duration":"104.208686ms","start":"2026-04-02T17:52:25.258271Z","end":"2026-04-02T17:52:25.36248Z","steps":["trace[946100166] 'read index received' (duration: 59.385004ms)","trace[946100166] 'applied index is now lower than readState.Index' (duration: 44.822662ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T17:52:25.362766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.472972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:525"} {"level":"info","ts":"2026-04-02T17:52:25.362844Z","caller":"traceutil/trace.go:171","msg":"trace[196319355] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2234; }","duration":"104.592645ms","start":"2026-04-02T17:52:25.258233Z","end":"2026-04-02T17:52:25.362825Z","steps":["trace[196319355] 'agreement among raft nodes before linearized reading' (duration: 104.38034ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:52:25.362966Z","caller":"traceutil/trace.go:171","msg":"trace[1697077792] transaction","detail":"{read_only:false; response_revision:2234; number_of_response:1; }","duration":"138.857129ms","start":"2026-04-02T17:52:25.224097Z","end":"2026-04-02T17:52:25.362954Z","steps":["trace[1697077792] 'process raft request' (duration: 93.553946ms)","trace[1697077792] 'compare' (duration: 44.357771ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T17:52:25.554569Z","caller":"traceutil/trace.go:171","msg":"trace[1887224388] linearizableReadLoop","detail":"{readStateIndex:2333; appliedIndex:2332; }","duration":"123.506929ms","start":"2026-04-02T17:52:25.431026Z","end":"2026-04-02T17:52:25.554533Z","steps":["trace[1887224388] 'read index received' (duration: 101.324048ms)","trace[1887224388] 'applied index is now lower than readState.Index' (duration: 22.181541ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T17:52:25.554657Z","caller":"traceutil/trace.go:171","msg":"trace[940819951] transaction","detail":"{read_only:false; response_revision:2236; number_of_response:1; }","duration":"187.621414ms","start":"2026-04-02T17:52:25.367004Z","end":"2026-04-02T17:52:25.554626Z","steps":["trace[940819951] 'process raft request' (duration: 165.409633ms)","trace[940819951] 'compare' (duration: 21.948415ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T17:52:25.554794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.723294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T17:52:25.555086Z","caller":"traceutil/trace.go:171","msg":"trace[1258867054] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2236; }","duration":"124.071212ms","start":"2026-04-02T17:52:25.430994Z","end":"2026-04-02T17:52:25.555066Z","steps":["trace[1258867054] 'agreement among raft nodes before linearized reading' (duration: 123.710284ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:52:25.77393Z","caller":"traceutil/trace.go:171","msg":"trace[1057723975] transaction","detail":"{read_only:false; response_revision:2237; number_of_response:1; }","duration":"166.085858ms","start":"2026-04-02T17:52:25.607819Z","end":"2026-04-02T17:52:25.773904Z","steps":["trace[1057723975] 'process raft request' (duration: 134.113728ms)","trace[1057723975] 'compare' (duration: 31.870108ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T17:52:26.074364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.548818ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T17:52:26.074462Z","caller":"traceutil/trace.go:171","msg":"trace[2065441735] linearizableReadLoop","detail":"{readStateIndex:2337; appliedIndex:2336; }","duration":"150.904761ms","start":"2026-04-02T17:52:25.923541Z","end":"2026-04-02T17:52:26.074446Z","steps":["trace[2065441735] 'read index received' (duration: 39.188509ms)","trace[2065441735] 'applied index is now lower than readState.Index' (duration: 111.715312ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T17:52:26.07466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.125877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-02T17:52:26.074617Z","caller":"traceutil/trace.go:171","msg":"trace[934286779] transaction","detail":"{read_only:false; response_revision:2240; number_of_response:1; }","duration":"200.446264ms","start":"2026-04-02T17:52:25.87412Z","end":"2026-04-02T17:52:26.074567Z","steps":["trace[934286779] 'process raft request' (duration: 88.61122ms)","trace[934286779] 'compare' (duration: 111.406924ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T17:52:26.074696Z","caller":"traceutil/trace.go:171","msg":"trace[482638960] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2240; }","duration":"151.201818ms","start":"2026-04-02T17:52:25.923483Z","end":"2026-04-02T17:52:26.074685Z","steps":["trace[482638960] 'agreement among raft nodes before linearized reading' (duration: 151.080426ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T17:52:26.379188Z","caller":"traceutil/trace.go:171","msg":"trace[797640841] transaction","detail":"{read_only:false; response_revision:2241; number_of_response:1; }","duration":"300.386371ms","start":"2026-04-02T17:52:26.078775Z","end":"2026-04-02T17:52:26.379161Z","steps":["trace[797640841] 'process raft request' (duration: 300.229178ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T17:52:26.379375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:52:26.07874Z","time spent":"300.522015ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"}