{"level":"warn","ts":"2026-04-02T22:26:31.639341Z","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-02T22:26:31.639427Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.144: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.144:2380","--initial-cluster=instance=https://199.204.45.144:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.144:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.144: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-02T22:26:31.639489Z","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-02T22:26:31.639502Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.144:2380"]} {"level":"info","ts":"2026-04-02T22:26:31.63952Z","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-02T22:26:31.640265Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.144:2379"]} {"level":"info","ts":"2026-04-02T22:26:31.640342Z","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.144:2380"],"listen-peer-urls":["https://199.204.45.144:2380"],"advertise-client-urls":["https://199.204.45.144:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.144:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.144: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-02T22:26:31.723243Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"82.637833ms"} {"level":"info","ts":"2026-04-02T22:26:31.742155Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4594e5f716bad646","cluster-id":"ff2e51b364668606"} {"level":"info","ts":"2026-04-02T22:26:31.742262Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 switched to configuration voters=()"} {"level":"info","ts":"2026-04-02T22:26:31.742291Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became follower at term 0"} {"level":"info","ts":"2026-04-02T22:26:31.742304Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4594e5f716bad646 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-02T22:26:31.742332Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became follower at term 1"} {"level":"info","ts":"2026-04-02T22:26:31.742376Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 switched to configuration voters=(5013885134571230790)"} {"level":"warn","ts":"2026-04-02T22:26:31.751887Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-02T22:26:31.754866Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-02T22:26:31.75624Z","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-02T22:26:31.75857Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4594e5f716bad646","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-02T22:26:31.758697Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4594e5f716bad646","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-02T22:26:31.761464Z","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-02T22:26:31.761668Z","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-02T22:26:31.761752Z","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-02T22:26:31.761905Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 switched to configuration voters=(5013885134571230790)"} {"level":"info","ts":"2026-04-02T22:26:31.76209Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ff2e51b364668606","local-member-id":"4594e5f716bad646","added-peer-id":"4594e5f716bad646","added-peer-peer-urls":["https://199.204.45.144:2380"]} {"level":"info","ts":"2026-04-02T22:26:31.764395Z","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-02T22:26:31.764471Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.144:2380"} {"level":"info","ts":"2026-04-02T22:26:31.764498Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.144:2380"} {"level":"info","ts":"2026-04-02T22:26:31.764652Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4594e5f716bad646","initial-advertise-peer-urls":["https://199.204.45.144:2380"],"listen-peer-urls":["https://199.204.45.144:2380"],"advertise-client-urls":["https://199.204.45.144:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.144:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-02T22:26:31.764672Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-02T22:26:31.943317Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 is starting a new election at term 1"} {"level":"info","ts":"2026-04-02T22:26:31.943414Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-02T22:26:31.943449Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 received MsgPreVoteResp from 4594e5f716bad646 at term 1"} {"level":"info","ts":"2026-04-02T22:26:31.943469Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became candidate at term 2"} {"level":"info","ts":"2026-04-02T22:26:31.94348Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 received MsgVoteResp from 4594e5f716bad646 at term 2"} {"level":"info","ts":"2026-04-02T22:26:31.943496Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became leader at term 2"} {"level":"info","ts":"2026-04-02T22:26:31.943524Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4594e5f716bad646 elected leader 4594e5f716bad646 at term 2"} {"level":"info","ts":"2026-04-02T22:26:32.047628Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T22:26:32.051664Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4594e5f716bad646","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.144:2379]}","request-path":"/0/members/4594e5f716bad646/attributes","cluster-id":"ff2e51b364668606","publish-timeout":"7s"} {"level":"info","ts":"2026-04-02T22:26:32.051985Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-02T22:26:32.052058Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-02T22:26:32.052218Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ff2e51b364668606","local-member-id":"4594e5f716bad646","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T22:26:32.052332Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T22:26:32.052365Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T22:26:32.052452Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-02T22:26:32.052467Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-02T22:26:32.055494Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-02T22:26:32.057746Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.144:2379"} {"level":"info","ts":"2026-04-02T22:26:35.189063Z","caller":"traceutil/trace.go:171","msg":"trace[342100347] transaction","detail":"{read_only:false; number_of_response:0; response_revision:93; }","duration":"104.585863ms","start":"2026-04-02T22:26:35.084259Z","end":"2026-04-02T22:26:35.188845Z","steps":["trace[342100347] 'process raft request' (duration: 104.539479ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:26:35.189251Z","caller":"traceutil/trace.go:171","msg":"trace[821487939] transaction","detail":"{read_only:false; response_revision:92; number_of_response:1; }","duration":"105.27479ms","start":"2026-04-02T22:26:35.083957Z","end":"2026-04-02T22:26:35.189232Z","steps":["trace[821487939] 'process raft request' (duration: 104.75325ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:26:35.189366Z","caller":"traceutil/trace.go:171","msg":"trace[1545364194] transaction","detail":"{read_only:false; response_revision:93; number_of_response:1; }","duration":"105.218125ms","start":"2026-04-02T22:26:35.083992Z","end":"2026-04-02T22:26:35.18921Z","steps":["trace[1545364194] 'process raft request' (duration: 104.75766ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:26:35.188853Z","caller":"traceutil/trace.go:171","msg":"trace[110803925] transaction","detail":"{read_only:false; response_revision:91; number_of_response:1; }","duration":"105.090732ms","start":"2026-04-02T22:26:35.083722Z","end":"2026-04-02T22:26:35.188813Z","steps":["trace[110803925] 'process raft request' (duration: 104.782543ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:26:36.152733Z","caller":"traceutil/trace.go:171","msg":"trace[104214701] linearizableReadLoop","detail":"{readStateIndex:163; appliedIndex:162; }","duration":"161.280734ms","start":"2026-04-02T22:26:35.99142Z","end":"2026-04-02T22:26:36.152701Z","steps":["trace[104214701] 'read index received' (duration: 161.036781ms)","trace[104214701] 'applied index is now lower than readState.Index' (duration: 242.833µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:26:36.152879Z","caller":"traceutil/trace.go:171","msg":"trace[763668058] transaction","detail":"{read_only:false; response_revision:158; number_of_response:1; }","duration":"186.034501ms","start":"2026-04-02T22:26:35.966832Z","end":"2026-04-02T22:26:36.152866Z","steps":["trace[763668058] 'process raft request' (duration: 185.689007ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:26:36.153133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.614697ms","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-02T22:26:36.153257Z","caller":"traceutil/trace.go:171","msg":"trace[2120133076] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:158; }","duration":"161.774913ms","start":"2026-04-02T22:26:35.991465Z","end":"2026-04-02T22:26:36.15324Z","steps":["trace[2120133076] 'agreement among raft nodes before linearized reading' (duration: 161.548501ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:26:36.153275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.650048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:26:36.153369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.812675ms","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-02T22:26:36.153433Z","caller":"traceutil/trace.go:171","msg":"trace[755714115] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:158; }","duration":"127.862999ms","start":"2026-04-02T22:26:36.025534Z","end":"2026-04-02T22:26:36.153397Z","steps":["trace[755714115] 'agreement among raft nodes before linearized reading' (duration: 127.653579ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:26:36.153597Z","caller":"traceutil/trace.go:171","msg":"trace[259154068] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:158; }","duration":"162.195922ms","start":"2026-04-02T22:26:35.991382Z","end":"2026-04-02T22:26:36.153578Z","steps":["trace[259154068] 'agreement among raft nodes before linearized reading' (duration: 161.710185ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:26:37.350098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.851278ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-02T22:26:37.350236Z","caller":"traceutil/trace.go:171","msg":"trace[1962323824] transaction","detail":"{read_only:false; response_revision:211; number_of_response:1; }","duration":"170.688521ms","start":"2026-04-02T22:26:37.179534Z","end":"2026-04-02T22:26:37.350223Z","steps":["trace[1962323824] 'process raft request' (duration: 170.648858ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:26:37.350325Z","caller":"traceutil/trace.go:171","msg":"trace[1490905058] transaction","detail":"{read_only:false; response_revision:210; number_of_response:1; }","duration":"170.799032ms","start":"2026-04-02T22:26:37.179492Z","end":"2026-04-02T22:26:37.350291Z","steps":["trace[1490905058] 'process raft request' (duration: 45.171689ms)","trace[1490905058] 'compare' (duration: 124.727797ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:26:49.440963Z","caller":"traceutil/trace.go:171","msg":"trace[1716729434] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"240.87091ms","start":"2026-04-02T22:26:49.20007Z","end":"2026-04-02T22:26:49.440941Z","steps":["trace[1716729434] 'process raft request' (duration: 240.71816ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:26:55.048363Z","caller":"traceutil/trace.go:171","msg":"trace[842297262] linearizableReadLoop","detail":"{readStateIndex:435; appliedIndex:434; }","duration":"309.052182ms","start":"2026-04-02T22:26:54.739288Z","end":"2026-04-02T22:26:55.048341Z","steps":["trace[842297262] 'read index received' (duration: 308.839072ms)","trace[842297262] 'applied index is now lower than readState.Index' (duration: 212.23µs)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:26:55.048504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.192155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-02T22:26:55.048539Z","caller":"traceutil/trace.go:171","msg":"trace[202036771] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:417; }","duration":"309.28143ms","start":"2026-04-02T22:26:54.739246Z","end":"2026-04-02T22:26:55.048527Z","steps":["trace[202036771] 'agreement among raft nodes before linearized reading' (duration: 309.196674ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:26:55.048574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:26:54.739226Z","time spent":"309.339587ms","remote":"127.0.0.1:48684","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-02T22:26:55.048662Z","caller":"traceutil/trace.go:171","msg":"trace[1353279690] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"541.769777ms","start":"2026-04-02T22:26:54.506862Z","end":"2026-04-02T22:26:55.048631Z","steps":["trace[1353279690] 'process raft request' (duration: 541.339609ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:26:55.048994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:26:54.50683Z","time spent":"541.90945ms","remote":"127.0.0.1:48684","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T22:27:03.458302Z","caller":"traceutil/trace.go:171","msg":"trace[940747269] linearizableReadLoop","detail":"{readStateIndex:456; appliedIndex:455; }","duration":"332.515845ms","start":"2026-04-02T22:27:03.125769Z","end":"2026-04-02T22:27:03.458284Z","steps":["trace[940747269] 'read index received' (duration: 332.429128ms)","trace[940747269] 'applied index is now lower than readState.Index' (duration: 86.227µs)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:27:03.458441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.66279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:27:03.458465Z","caller":"traceutil/trace.go:171","msg":"trace[877181681] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:436; }","duration":"332.737788ms","start":"2026-04-02T22:27:03.12572Z","end":"2026-04-02T22:27:03.458457Z","steps":["trace[877181681] 'agreement among raft nodes before linearized reading' (duration: 332.637071ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:03.458487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:03.125696Z","time spent":"332.786136ms","remote":"127.0.0.1:48398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-02T22:27:03.458689Z","caller":"traceutil/trace.go:171","msg":"trace[380653106] transaction","detail":"{read_only:false; response_revision:436; number_of_response:1; }","duration":"369.047656ms","start":"2026-04-02T22:27:03.089581Z","end":"2026-04-02T22:27:03.458628Z","steps":["trace[380653106] 'process raft request' (duration: 368.602402ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:03.458896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:03.089567Z","time spent":"369.203841ms","remote":"127.0.0.1:48684","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T22:27:05.965984Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440201340720300587,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-02T22:27:06.193167Z","caller":"traceutil/trace.go:171","msg":"trace[2026258792] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"877.454291ms","start":"2026-04-02T22:27:05.315687Z","end":"2026-04-02T22:27:06.193141Z","steps":["trace[2026258792] 'process raft request' (duration: 877.286066ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:06.193308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:05.315665Z","time spent":"877.577826ms","remote":"127.0.0.1:48434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T22:27:06.201943Z","caller":"traceutil/trace.go:171","msg":"trace[19264579] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"881.183928ms","start":"2026-04-02T22:27:05.32074Z","end":"2026-04-02T22:27:06.201924Z","steps":["trace[19264579] 'process raft request' (duration: 881.046252ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:27:06.202008Z","caller":"traceutil/trace.go:171","msg":"trace[425097016] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"871.563831ms","start":"2026-04-02T22:27:05.330425Z","end":"2026-04-02T22:27:06.201989Z","steps":["trace[425097016] 'process raft request' (duration: 871.448374ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:06.202101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:05.330407Z","time spent":"871.64216ms","remote":"127.0.0.1:48434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T22:27:06.202102Z","caller":"traceutil/trace.go:171","msg":"trace[1842519948] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"865.645138ms","start":"2026-04-02T22:27:05.336431Z","end":"2026-04-02T22:27:06.202076Z","steps":["trace[1842519948] 'process raft request' (duration: 865.490042ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:06.20211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:05.32072Z","time spent":"881.300896ms","remote":"127.0.0.1:48434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T22:27:06.202167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:05.336398Z","time spent":"865.740865ms","remote":"127.0.0.1:48434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T22:27:06.202417Z","caller":"traceutil/trace.go:171","msg":"trace[1985095948] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"865.779784ms","start":"2026-04-02T22:27:05.336629Z","end":"2026-04-02T22:27:06.202409Z","steps":["trace[1985095948] 'process raft request' (duration: 865.366696ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:27:06.202464Z","caller":"traceutil/trace.go:171","msg":"trace[502692215] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"865.698827ms","start":"2026-04-02T22:27:05.336754Z","end":"2026-04-02T22:27:06.202453Z","steps":["trace[502692215] 'process raft request' (duration: 865.565921ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:06.20247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:05.33662Z","time spent":"865.824012ms","remote":"127.0.0.1:48434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T22:27:06.202515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:05.336745Z","time spent":"865.740465ms","remote":"127.0.0.1:48434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T22:27:06.202698Z","caller":"traceutil/trace.go:171","msg":"trace[1578886510] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"865.800324ms","start":"2026-04-02T22:27:05.336857Z","end":"2026-04-02T22:27:06.202657Z","steps":["trace[1578886510] 'process raft request' (duration: 865.516252ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:06.202766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:05.336845Z","time spent":"865.8864ms","remote":"127.0.0.1:48434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T22:27:06.202888Z","caller":"traceutil/trace.go:171","msg":"trace[1185313648] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"859.770513ms","start":"2026-04-02T22:27:05.343103Z","end":"2026-04-02T22:27:06.202873Z","steps":["trace[1185313648] 'process raft request' (duration: 859.522851ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:06.202991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:05.343083Z","time spent":"859.88834ms","remote":"127.0.0.1:48434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T22:27:06.20302Z","caller":"traceutil/trace.go:171","msg":"trace[216369563] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"840.368383ms","start":"2026-04-02T22:27:05.362643Z","end":"2026-04-02T22:27:06.203011Z","steps":["trace[216369563] 'process raft request' (duration: 840.13329ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:06.203072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:05.36262Z","time spent":"840.430831ms","remote":"127.0.0.1:48434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T22:27:06.203086Z","caller":"traceutil/trace.go:171","msg":"trace[347349672] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"809.559571ms","start":"2026-04-02T22:27:05.393514Z","end":"2026-04-02T22:27:06.203074Z","steps":["trace[347349672] 'process raft request' (duration: 809.343588ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:27:06.203095Z","caller":"traceutil/trace.go:171","msg":"trace[1461510641] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"866.007688ms","start":"2026-04-02T22:27:05.33708Z","end":"2026-04-02T22:27:06.203088Z","steps":["trace[1461510641] 'process raft request' (duration: 865.424425ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:06.203127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:05.337071Z","time spent":"866.041087ms","remote":"127.0.0.1:48434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T22:27:06.203148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:05.393488Z","time spent":"809.62352ms","remote":"127.0.0.1:48684","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T22:27:06.203087Z","caller":"traceutil/trace.go:171","msg":"trace[907260032] linearizableReadLoop","detail":"{readStateIndex:506; appliedIndex:493; }","duration":"738.04507ms","start":"2026-04-02T22:27:05.46499Z","end":"2026-04-02T22:27:06.203036Z","steps":["trace[907260032] 'read index received' (duration: 728.105585ms)","trace[907260032] 'applied index is now lower than readState.Index' (duration: 9.938255ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:27:06.203227Z","caller":"traceutil/trace.go:171","msg":"trace[882049578] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"699.695525ms","start":"2026-04-02T22:27:05.503525Z","end":"2026-04-02T22:27:06.203221Z","steps":["trace[882049578] 'process raft request' (duration: 699.389204ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:06.203263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:05.503496Z","time spent":"699.753223ms","remote":"127.0.0.1:48434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T22:27:06.203192Z","caller":"traceutil/trace.go:171","msg":"trace[1570882591] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"852.718895ms","start":"2026-04-02T22:27:05.350464Z","end":"2026-04-02T22:27:06.203183Z","steps":["trace[1570882591] 'process raft request' (duration: 852.23036ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:06.203362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:05.350434Z","time spent":"852.90709ms","remote":"127.0.0.1:48434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T22:27:06.203461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"738.456797ms","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-02T22:27:06.203511Z","caller":"traceutil/trace.go:171","msg":"trace[333510251] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:486; }","duration":"738.559104ms","start":"2026-04-02T22:27:05.464943Z","end":"2026-04-02T22:27:06.203502Z","steps":["trace[333510251] 'agreement among raft nodes before linearized reading' (duration: 738.333011ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:06.203551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:05.464922Z","time spent":"738.620592ms","remote":"127.0.0.1:48684","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-02T22:27:06.207813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.976176ms","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-02T22:27:06.207963Z","caller":"traceutil/trace.go:171","msg":"trace[2131033093] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:488; }","duration":"433.168511ms","start":"2026-04-02T22:27:05.774784Z","end":"2026-04-02T22:27:06.207952Z","steps":["trace[2131033093] 'agreement among raft nodes before linearized reading' (duration: 432.795611ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:06.208175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:05.774757Z","time spent":"433.403183ms","remote":"127.0.0.1:48684","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-02T22:27:12.827487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.541701ms","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-02T22:27:12.827593Z","caller":"traceutil/trace.go:171","msg":"trace[875795825] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:584; }","duration":"212.685168ms","start":"2026-04-02T22:27:12.61489Z","end":"2026-04-02T22:27:12.827575Z","steps":["trace[875795825] 'range keys from in-memory index tree' (duration: 212.435353ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:12.827532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.972087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:27:12.827667Z","caller":"traceutil/trace.go:171","msg":"trace[1365258271] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:584; }","duration":"367.137754ms","start":"2026-04-02T22:27:12.460505Z","end":"2026-04-02T22:27:12.827643Z","steps":["trace[1365258271] 'range keys from in-memory index tree' (duration: 366.928747ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:12.827753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:12.460501Z","time spent":"367.231102ms","remote":"127.0.0.1:59444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-02T22:27:12.8278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.33731ms","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-02T22:27:12.827829Z","caller":"traceutil/trace.go:171","msg":"trace[1072562587] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:584; }","duration":"367.364799ms","start":"2026-04-02T22:27:12.460455Z","end":"2026-04-02T22:27:12.82782Z","steps":["trace[1072562587] 'range keys from in-memory index tree' (duration: 367.198352ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:12.827855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:12.460392Z","time spent":"367.456007ms","remote":"127.0.0.1:59444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-02T22:27:12.827876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.338677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:27:12.82794Z","caller":"traceutil/trace.go:171","msg":"trace[689245698] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:584; }","duration":"429.441345ms","start":"2026-04-02T22:27:12.398483Z","end":"2026-04-02T22:27:12.827924Z","steps":["trace[689245698] 'range keys from in-memory index tree' (duration: 429.19062ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:12.827996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:12.398473Z","time spent":"429.505944ms","remote":"127.0.0.1:59428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-02T22:27:12.827742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.168239ms","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":"warn","ts":"2026-04-02T22:27:12.828072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.487847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:27:12.828082Z","caller":"traceutil/trace.go:171","msg":"trace[52528438] 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":"351.518452ms","start":"2026-04-02T22:27:12.476531Z","end":"2026-04-02T22:27:12.828049Z","steps":["trace[52528438] 'range keys from in-memory index tree' (duration: 351.10238ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:12.828151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:12.476513Z","time spent":"351.61544ms","remote":"127.0.0.1:59452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":28,"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-02T22:27:12.828231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.65591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:27:12.828262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.479573ms","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-02T22:27:12.828286Z","caller":"traceutil/trace.go:171","msg":"trace[717266121] 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":"351.560211ms","start":"2026-04-02T22:27:12.476719Z","end":"2026-04-02T22:27:12.828279Z","steps":["trace[717266121] 'count revisions from in-memory index tree' (duration: 351.375534ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:12.828246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.887354ms","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-02T22:27:12.82829Z","caller":"traceutil/trace.go:171","msg":"trace[349100837] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:584; }","duration":"429.727209ms","start":"2026-04-02T22:27:12.398549Z","end":"2026-04-02T22:27:12.828276Z","steps":["trace[349100837] 'range keys from in-memory index tree' (duration: 429.623822ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:12.828311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:12.476676Z","time spent":"351.62778ms","remote":"127.0.0.1:59452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-04-02T22:27:12.8281Z","caller":"traceutil/trace.go:171","msg":"trace[1260419541] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:584; }","duration":"367.527416ms","start":"2026-04-02T22:27:12.460565Z","end":"2026-04-02T22:27:12.828092Z","steps":["trace[1260419541] 'count revisions from in-memory index tree' (duration: 367.437698ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:27:12.828329Z","caller":"traceutil/trace.go:171","msg":"trace[1823329238] 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":"351.139589ms","start":"2026-04-02T22:27:12.477172Z","end":"2026-04-02T22:27:12.828311Z","steps":["trace[1823329238] 'range keys from in-memory index tree' (duration: 350.761116ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:12.828367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:12.460561Z","time spent":"367.786811ms","remote":"127.0.0.1:59444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-02T22:27:12.82824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.223457ms","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-02T22:27:12.828533Z","caller":"traceutil/trace.go:171","msg":"trace[1586713745] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:584; }","duration":"213.55035ms","start":"2026-04-02T22:27:12.614968Z","end":"2026-04-02T22:27:12.828518Z","steps":["trace[1586713745] 'count revisions from in-memory index tree' (duration: 213.194038ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:12.827942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.310938ms","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-02T22:27:12.828689Z","caller":"traceutil/trace.go:171","msg":"trace[794105824] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:584; }","duration":"430.065632ms","start":"2026-04-02T22:27:12.398607Z","end":"2026-04-02T22:27:12.828672Z","steps":["trace[794105824] 'count revisions from in-memory index tree' (duration: 429.270678ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:12.828708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.36209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-02T22:27:12.828761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:12.398602Z","time spent":"430.138831ms","remote":"127.0.0.1:59428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-02T22:27:12.828336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:12.398544Z","time spent":"429.777358ms","remote":"127.0.0.1:59428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 "} {"level":"info","ts":"2026-04-02T22:27:12.828837Z","caller":"traceutil/trace.go:171","msg":"trace[1111243921] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:584; }","duration":"405.513557ms","start":"2026-04-02T22:27:12.423267Z","end":"2026-04-02T22:27:12.828781Z","steps":["trace[1111243921] 'range keys from in-memory index tree' (duration: 404.589766ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:12.828486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:12.477163Z","time spent":"351.238937ms","remote":"127.0.0.1:59452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":28,"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-02T22:27:12.828995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:12.423237Z","time spent":"405.741293ms","remote":"127.0.0.1:48684","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-02T22:27:12.829351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.656494ms","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-02T22:27:12.829418Z","caller":"traceutil/trace.go:171","msg":"trace[1410295860] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:584; }","duration":"441.779582ms","start":"2026-04-02T22:27:12.387628Z","end":"2026-04-02T22:27:12.829407Z","steps":["trace[1410295860] 'range keys from in-memory index tree' (duration: 440.279782ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:12.82945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:12.387603Z","time spent":"441.83982ms","remote":"127.0.0.1:48684","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-02T22:27:13.258577Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440201340720300814,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-02T22:27:13.400846Z","caller":"traceutil/trace.go:171","msg":"trace[975505199] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"654.656295ms","start":"2026-04-02T22:27:12.746143Z","end":"2026-04-02T22:27:13.400799Z","steps":["trace[975505199] 'process raft request' (duration: 652.78469ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:13.401031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:12.746122Z","time spent":"654.813693ms","remote":"127.0.0.1:48494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T22:27:13.842719Z","caller":"traceutil/trace.go:171","msg":"trace[2018267948] linearizableReadLoop","detail":"{readStateIndex:613; appliedIndex:610; }","duration":"1.084590497s","start":"2026-04-02T22:27:12.758023Z","end":"2026-04-02T22:27:13.842613Z","steps":["trace[2018267948] 'read index received' (duration: 640.663359ms)","trace[2018267948] 'applied index is now lower than readState.Index' (duration: 443.925228ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:27:13.842946Z","caller":"traceutil/trace.go:171","msg":"trace[1769552340] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"1.009731693s","start":"2026-04-02T22:27:12.833197Z","end":"2026-04-02T22:27:13.842929Z","steps":["trace[1769552340] 'process raft request' (duration: 1.009051985s)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:27:13.842963Z","caller":"traceutil/trace.go:171","msg":"trace[780253953] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"1.008957578s","start":"2026-04-02T22:27:12.833974Z","end":"2026-04-02T22:27:13.842932Z","steps":["trace[780253953] 'process raft request' (duration: 1.008561555s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:13.843143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.085085318s","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-02T22:27:13.843186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:12.833949Z","time spent":"1.009098946s","remote":"127.0.0.1:48684","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T22:27:13.843219Z","caller":"traceutil/trace.go:171","msg":"trace[1366502568] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:587; }","duration":"1.085211315s","start":"2026-04-02T22:27:12.757987Z","end":"2026-04-02T22:27:13.843199Z","steps":["trace[1366502568] 'agreement among raft nodes before linearized reading' (duration: 1.085037638s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:13.843262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:12.757938Z","time spent":"1.085315033s","remote":"127.0.0.1:59464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-02T22:27:13.843282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:12.83318Z","time spent":"1.00982497s","remote":"127.0.0.1:48684","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T22:27:14.269376Z","caller":"traceutil/trace.go:171","msg":"trace[232080760] linearizableReadLoop","detail":"{readStateIndex:614; appliedIndex:613; }","duration":"426.468991ms","start":"2026-04-02T22:27:13.842865Z","end":"2026-04-02T22:27:14.269334Z","steps":["trace[232080760] 'read index received' (duration: 355.218404ms)","trace[232080760] 'applied index is now lower than readState.Index' (duration: 71.248327ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:27:14.269596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.216250385s","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":"warn","ts":"2026-04-02T22:27:14.269635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.152292626s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:27:14.269702Z","caller":"traceutil/trace.go:171","msg":"trace[1209163406] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:588; }","duration":"1.216505602s","start":"2026-04-02T22:27:13.053173Z","end":"2026-04-02T22:27:14.269679Z","steps":["trace[1209163406] 'agreement among raft nodes before linearized reading' (duration: 1.216213496s)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:27:14.269802Z","caller":"traceutil/trace.go:171","msg":"trace[177482658] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"803.001232ms","start":"2026-04-02T22:27:13.466787Z","end":"2026-04-02T22:27:14.269788Z","steps":["trace[177482658] 'process raft request' (duration: 731.283802ms)","trace[177482658] 'compare' (duration: 70.989492ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:27:14.269886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:13.46677Z","time spent":"803.070151ms","remote":"127.0.0.1:48652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T22:27:14.269945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.216710978s","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-02T22:27:14.270034Z","caller":"traceutil/trace.go:171","msg":"trace[285026337] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:588; }","duration":"1.216884576s","start":"2026-04-02T22:27:13.05313Z","end":"2026-04-02T22:27:14.270014Z","steps":["trace[285026337] 'agreement among raft nodes before linearized reading' (duration: 1.216701629s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:14.270059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.136043292s","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-02T22:27:14.270096Z","caller":"traceutil/trace.go:171","msg":"trace[220879130] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:588; }","duration":"1.136088271s","start":"2026-04-02T22:27:13.133998Z","end":"2026-04-02T22:27:14.270086Z","steps":["trace[220879130] 'agreement among raft nodes before linearized reading' (duration: 1.136033192s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:14.270135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:13.133993Z","time spent":"1.136132761s","remote":"127.0.0.1:59540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 "} {"level":"warn","ts":"2026-04-02T22:27:14.270196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.304477344s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:27:14.270318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.152941306s","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-02T22:27:14.270361Z","caller":"traceutil/trace.go:171","msg":"trace[610336576] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:588; }","duration":"1.153024305s","start":"2026-04-02T22:27:13.117328Z","end":"2026-04-02T22:27:14.270352Z","steps":["trace[610336576] 'agreement among raft nodes before linearized reading' (duration: 1.152961136s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:14.270399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:13.117305Z","time spent":"1.153085573s","remote":"127.0.0.1:59540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"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-02T22:27:14.270426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.305394506s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:27:14.270415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.196930968s","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-02T22:27:14.270094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:13.05312Z","time spent":"1.216959714s","remote":"127.0.0.1:59508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-02T22:27:14.27059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.471340595s","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-02T22:27:14.26962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.51148146s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:27:14.27065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.471433814s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:27:14.270274Z","caller":"traceutil/trace.go:171","msg":"trace[1483260513] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:588; }","duration":"1.304560462s","start":"2026-04-02T22:27:12.965698Z","end":"2026-04-02T22:27:14.270259Z","steps":["trace[1483260513] 'agreement among raft nodes before linearized reading' (duration: 1.304457674s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:14.270721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.177297224s","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-02T22:27:14.270476Z","caller":"traceutil/trace.go:171","msg":"trace[1785342510] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:588; }","duration":"1.305444435s","start":"2026-04-02T22:27:12.965016Z","end":"2026-04-02T22:27:14.270461Z","steps":["trace[1785342510] 'agreement among raft nodes before linearized reading' (duration: 1.305372256s)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:27:14.270774Z","caller":"traceutil/trace.go:171","msg":"trace[750538633] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:588; }","duration":"1.471496972s","start":"2026-04-02T22:27:12.799188Z","end":"2026-04-02T22:27:14.270685Z","steps":["trace[750538633] 'agreement among raft nodes before linearized reading' (duration: 1.471433973s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:14.270808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:12.965002Z","time spent":"1.305794729s","remote":"127.0.0.1:59492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 "} {"level":"warn","ts":"2026-04-02T22:27:14.270817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:12.799173Z","time spent":"1.47163539s","remote":"127.0.0.1:59472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "} {"level":"warn","ts":"2026-04-02T22:27:14.270817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.178025612s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:27:14.270856Z","caller":"traceutil/trace.go:171","msg":"trace[848427611] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:588; }","duration":"1.17810315s","start":"2026-04-02T22:27:13.092743Z","end":"2026-04-02T22:27:14.270846Z","steps":["trace[848427611] 'agreement among raft nodes before linearized reading' (duration: 1.178045401s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:14.270886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.308575534s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-wxzmd\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-04-02T22:27:14.270915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:13.092718Z","time spent":"1.178184828s","remote":"127.0.0.1:59526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"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-02T22:27:14.270968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.41789444s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:27:14.270648Z","caller":"traceutil/trace.go:171","msg":"trace[935616351] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:588; }","duration":"1.471419774s","start":"2026-04-02T22:27:12.799213Z","end":"2026-04-02T22:27:14.270633Z","steps":["trace[935616351] 'agreement among raft nodes before linearized reading' (duration: 1.471300586s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:14.269869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:13.053161Z","time spent":"1.21665479s","remote":"127.0.0.1:59508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-02T22:27:14.271018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:12.799198Z","time spent":"1.471808387s","remote":"127.0.0.1:59472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 "} {"level":"warn","ts":"2026-04-02T22:27:14.271041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.418732813s","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-02T22:27:14.271067Z","caller":"traceutil/trace.go:171","msg":"trace[99289968] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:588; }","duration":"1.418781172s","start":"2026-04-02T22:27:12.852277Z","end":"2026-04-02T22:27:14.271058Z","steps":["trace[99289968] 'agreement among raft nodes before linearized reading' (duration: 1.418743962s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:14.271102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:12.852262Z","time spent":"1.418831681s","remote":"127.0.0.1:59478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "} {"level":"info","ts":"2026-04-02T22:27:14.270654Z","caller":"traceutil/trace.go:171","msg":"trace[1967964743] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:588; }","duration":"1.512597612s","start":"2026-04-02T22:27:12.758044Z","end":"2026-04-02T22:27:14.270641Z","steps":["trace[1967964743] 'agreement among raft nodes before linearized reading' (duration: 1.511441171s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:14.27126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:12.757996Z","time spent":"1.513246271s","remote":"127.0.0.1:59464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"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-02T22:27:14.271332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.419023878s","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-02T22:27:14.271364Z","caller":"traceutil/trace.go:171","msg":"trace[1450219960] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:588; }","duration":"1.419082967s","start":"2026-04-02T22:27:12.852271Z","end":"2026-04-02T22:27:14.271354Z","steps":["trace[1450219960] 'agreement among raft nodes before linearized reading' (duration: 1.419033948s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:14.271379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.178659231s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:27:14.270452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.137360278s","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-02T22:27:14.271429Z","caller":"traceutil/trace.go:171","msg":"trace[805036952] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:588; }","duration":"1.17873031s","start":"2026-04-02T22:27:13.092686Z","end":"2026-04-02T22:27:14.271416Z","steps":["trace[805036952] 'agreement among raft nodes before linearized reading' (duration: 1.178658501s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:14.271443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.471372167s","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-02T22:27:14.271442Z","caller":"traceutil/trace.go:171","msg":"trace[1954341170] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:588; }","duration":"1.138383451s","start":"2026-04-02T22:27:13.133047Z","end":"2026-04-02T22:27:14.27143Z","steps":["trace[1954341170] 'agreement among raft nodes before linearized reading' (duration: 1.137338998s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:14.271464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:13.092675Z","time spent":"1.178779909s","remote":"127.0.0.1:59526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"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-02T22:27:14.27148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:13.133036Z","time spent":"1.13843175s","remote":"127.0.0.1:59546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"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-02T22:27:14.270592Z","caller":"traceutil/trace.go:171","msg":"trace[2128796650] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:588; }","duration":"1.197112795s","start":"2026-04-02T22:27:13.073407Z","end":"2026-04-02T22:27:14.270519Z","steps":["trace[2128796650] 'agreement among raft nodes before linearized reading' (duration: 1.19683472s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:14.271617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:13.073401Z","time spent":"1.198203027s","remote":"127.0.0.1:59518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 "} {"level":"info","ts":"2026-04-02T22:27:14.270765Z","caller":"traceutil/trace.go:171","msg":"trace[189515893] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:588; }","duration":"1.177360763s","start":"2026-04-02T22:27:13.093394Z","end":"2026-04-02T22:27:14.270755Z","steps":["trace[189515893] 'agreement among raft nodes before linearized reading' (duration: 1.177291654s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:14.271682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:13.093385Z","time spent":"1.178285647s","remote":"127.0.0.1:59526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"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-02T22:27:14.270925Z","caller":"traceutil/trace.go:171","msg":"trace[888770702] range","detail":"{range_begin:/registry/pods/kube-system/cilium-wxzmd; range_end:; response_count:1; response_revision:588; }","duration":"1.308642233s","start":"2026-04-02T22:27:12.962272Z","end":"2026-04-02T22:27:14.270914Z","steps":["trace[888770702] 'agreement among raft nodes before linearized reading' (duration: 1.308400607s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:14.271784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:12.962232Z","time spent":"1.309537408s","remote":"127.0.0.1:48598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-wxzmd\" "} {"level":"info","ts":"2026-04-02T22:27:14.27147Z","caller":"traceutil/trace.go:171","msg":"trace[1040994353] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:588; }","duration":"1.471406857s","start":"2026-04-02T22:27:12.800054Z","end":"2026-04-02T22:27:14.271461Z","steps":["trace[1040994353] 'agreement among raft nodes before linearized reading' (duration: 1.471367498s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:14.272033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:12.800049Z","time spent":"1.471968747s","remote":"127.0.0.1:59472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 "} {"level":"warn","ts":"2026-04-02T22:27:14.271403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:12.852253Z","time spent":"1.419142076s","remote":"127.0.0.1:59478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-02T22:27:14.272173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.513832732s","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-02T22:27:14.272217Z","caller":"traceutil/trace.go:171","msg":"trace[1184136088] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:588; }","duration":"1.513899501s","start":"2026-04-02T22:27:12.758308Z","end":"2026-04-02T22:27:14.272208Z","steps":["trace[1184136088] 'agreement among raft nodes before linearized reading' (duration: 1.513833553s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:14.272253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:12.758293Z","time spent":"1.51395174s","remote":"127.0.0.1:59456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 "} {"level":"warn","ts":"2026-04-02T22:27:14.272078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.500099462s","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-02T22:27:14.272348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.139291615s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:27:14.272399Z","caller":"traceutil/trace.go:171","msg":"trace[339578399] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:588; }","duration":"1.139355544s","start":"2026-04-02T22:27:13.133031Z","end":"2026-04-02T22:27:14.272386Z","steps":["trace[339578399] 'agreement among raft nodes before linearized reading' (duration: 1.139280226s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:14.272438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:13.133024Z","time spent":"1.139405935s","remote":"127.0.0.1:59546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-04-02T22:27:14.272401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.501105623s","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":"warn","ts":"2026-04-02T22:27:14.272445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.501177494s","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-02T22:27:14.27258Z","caller":"traceutil/trace.go:171","msg":"trace[1197115430] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:588; }","duration":"1.501293451s","start":"2026-04-02T22:27:12.771276Z","end":"2026-04-02T22:27:14.27257Z","steps":["trace[1197115430] 'agreement among raft nodes before linearized reading' (duration: 1.501100724s)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:27:14.272583Z","caller":"traceutil/trace.go:171","msg":"trace[61065541] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:588; }","duration":"1.50134386s","start":"2026-04-02T22:27:12.771229Z","end":"2026-04-02T22:27:14.272573Z","steps":["trace[61065541] 'agreement among raft nodes before linearized reading' (duration: 1.501192963s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:14.272614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:12.771268Z","time spent":"1.501335591s","remote":"127.0.0.1:59468","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"warn","ts":"2026-04-02T22:27:14.272619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:12.771215Z","time spent":"1.50139283s","remote":"127.0.0.1:59468","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 "} {"level":"info","ts":"2026-04-02T22:27:14.271003Z","caller":"traceutil/trace.go:171","msg":"trace[699850410] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:588; }","duration":"1.417962718s","start":"2026-04-02T22:27:12.853031Z","end":"2026-04-02T22:27:14.270994Z","steps":["trace[699850410] 'agreement among raft nodes before linearized reading' (duration: 1.417913199s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:14.272706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.199871878s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:27:14.272735Z","caller":"traceutil/trace.go:171","msg":"trace[800380755] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:588; }","duration":"1.199911038s","start":"2026-04-02T22:27:13.072814Z","end":"2026-04-02T22:27:14.272725Z","steps":["trace[800380755] 'agreement among raft nodes before linearized reading' (duration: 1.199865638s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:14.270725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:12.965694Z","time spent":"1.305016865s","remote":"127.0.0.1:59492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 "} {"level":"warn","ts":"2026-04-02T22:27:14.272775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:13.07281Z","time spent":"1.199957177s","remote":"127.0.0.1:59518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-02T22:27:14.272797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.200092545s","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-02T22:27:14.272842Z","caller":"traceutil/trace.go:171","msg":"trace[957366601] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:588; }","duration":"1.200141394s","start":"2026-04-02T22:27:13.072679Z","end":"2026-04-02T22:27:14.272821Z","steps":["trace[957366601] 'agreement among raft nodes before linearized reading' (duration: 1.200092305s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:14.27273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:12.852981Z","time spent":"1.419727879s","remote":"127.0.0.1:59478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 "} {"level":"warn","ts":"2026-04-02T22:27:14.270593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.305623252s","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-02T22:27:14.269748Z","caller":"traceutil/trace.go:171","msg":"trace[1024483737] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:588; }","duration":"1.152426235s","start":"2026-04-02T22:27:13.117288Z","end":"2026-04-02T22:27:14.269714Z","steps":["trace[1024483737] 'agreement among raft nodes before linearized reading' (duration: 1.152243477s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:14.273048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:13.117282Z","time spent":"1.15574594s","remote":"127.0.0.1:59540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-04-02T22:27:14.272724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.219050771s","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-02T22:27:14.272961Z","caller":"traceutil/trace.go:171","msg":"trace[1026312407] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:588; }","duration":"1.307998962s","start":"2026-04-02T22:27:12.964945Z","end":"2026-04-02T22:27:14.272944Z","steps":["trace[1026312407] 'agreement among raft nodes before linearized reading' (duration: 1.305567382s)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:27:14.273188Z","caller":"traceutil/trace.go:171","msg":"trace[734457271] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:588; }","duration":"1.219584272s","start":"2026-04-02T22:27:13.053592Z","end":"2026-04-02T22:27:14.273177Z","steps":["trace[734457271] 'agreement among raft nodes before linearized reading' (duration: 1.219056241s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:14.273223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:13.053586Z","time spent":"1.2196268s","remote":"127.0.0.1:59508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-02T22:27:14.272905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:13.07267Z","time spent":"1.200224623s","remote":"127.0.0.1:59518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-02T22:27:14.273452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:12.964939Z","time spent":"1.308489434s","remote":"127.0.0.1:59492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"warn","ts":"2026-04-02T22:27:14.273492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.146102384s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:27:14.273543Z","caller":"traceutil/trace.go:171","msg":"trace[288413873] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:588; }","duration":"1.146170923s","start":"2026-04-02T22:27:13.127357Z","end":"2026-04-02T22:27:14.273528Z","steps":["trace[288413873] 'agreement among raft nodes before linearized reading' (duration: 1.142858198s)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:27:14.272653Z","caller":"traceutil/trace.go:171","msg":"trace[259243271] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:588; }","duration":"1.500616783s","start":"2026-04-02T22:27:12.771737Z","end":"2026-04-02T22:27:14.272353Z","steps":["trace[259243271] 'agreement among raft nodes before linearized reading' (duration: 1.499701388s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:14.273576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:13.127329Z","time spent":"1.146239771s","remote":"127.0.0.1:48398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-02T22:27:14.273611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:12.771725Z","time spent":"1.501868183s","remote":"127.0.0.1:59468","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 "} {"level":"info","ts":"2026-04-02T22:27:14.489171Z","caller":"traceutil/trace.go:171","msg":"trace[1793960764] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"200.924487ms","start":"2026-04-02T22:27:14.288207Z","end":"2026-04-02T22:27:14.489131Z","steps":["trace[1793960764] 'process raft request' (duration: 172.766044ms)","trace[1793960764] 'compare' (duration: 27.954876ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:27:15.614514Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.153375687s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-02T22:27:16.349656Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440201340720300827,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-02T22:27:16.696999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.08185315s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T22:27:16.697274Z","caller":"traceutil/trace.go:171","msg":"trace[684881306] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"2.407358964s","start":"2026-04-02T22:27:14.289901Z","end":"2026-04-02T22:27:16.69726Z","steps":["trace[684881306] 'process raft request' (duration: 2.407319345s)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:27:16.697317Z","caller":"traceutil/trace.go:171","msg":"trace[134030208] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"2.40757761s","start":"2026-04-02T22:27:14.289717Z","end":"2026-04-02T22:27:16.697294Z","steps":["trace[134030208] 'process raft request' (duration: 2.407372193s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:16.697347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:14.289894Z","time spent":"2.407417113s","remote":"127.0.0.1:48684","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T22:27:16.697413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:14.289696Z","time spent":"2.407666849s","remote":"127.0.0.1:48598","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T22:27:16.697472Z","caller":"traceutil/trace.go:171","msg":"trace[766357384] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"2.409011658s","start":"2026-04-02T22:27:14.288433Z","end":"2026-04-02T22:27:16.697444Z","steps":["trace[766357384] 'process raft request' (duration: 1.326632315s)","trace[766357384] 'compare' (duration: 1.081215959s)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:27:16.697611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:14.288422Z","time spent":"2.409116065s","remote":"127.0.0.1:48684","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T22:27:16.766469Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.151544924s","expected-duration":"1s"} {"level":"info","ts":"2026-04-02T22:27:16.766977Z","caller":"traceutil/trace.go:171","msg":"trace[12692703] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"2.271594507s","start":"2026-04-02T22:27:14.49537Z","end":"2026-04-02T22:27:16.766965Z","steps":["trace[12692703] 'process raft request' (duration: 2.271349531s)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:27:16.766989Z","caller":"traceutil/trace.go:171","msg":"trace[1480455426] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"2.270981578s","start":"2026-04-02T22:27:14.495971Z","end":"2026-04-02T22:27:16.766953Z","steps":["trace[1480455426] 'process raft request' (duration: 2.270870329s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:16.767072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:14.495319Z","time spent":"2.271700576s","remote":"127.0.0.1:48472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":775,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T22:27:16.767138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:14.495951Z","time spent":"2.271111936s","remote":"127.0.0.1:48472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":905,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T22:27:16.767166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"918.136293ms","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-02T22:27:16.767196Z","caller":"traceutil/trace.go:171","msg":"trace[2000046219] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:596; }","duration":"918.214372ms","start":"2026-04-02T22:27:15.848973Z","end":"2026-04-02T22:27:16.767188Z","steps":["trace[2000046219] 'agreement among raft nodes before linearized reading' (duration: 918.026955ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:27:16.766969Z","caller":"traceutil/trace.go:171","msg":"trace[1532504262] linearizableReadLoop","detail":"{readStateIndex:622; appliedIndex:618; }","duration":"917.948846ms","start":"2026-04-02T22:27:15.849001Z","end":"2026-04-02T22:27:16.76695Z","steps":["trace[1532504262] 'read index received' (duration: 917.64312ms)","trace[1532504262] 'applied index is now lower than readState.Index' (duration: 305.016µs)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:27:16.767252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:15.848718Z","time spent":"918.522978ms","remote":"127.0.0.1:48684","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-02T22:27:16.767349Z","caller":"traceutil/trace.go:171","msg":"trace[732646571] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"2.27027559s","start":"2026-04-02T22:27:14.497065Z","end":"2026-04-02T22:27:16.76734Z","steps":["trace[732646571] 'process raft request' (duration: 2.269851276s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:16.767405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:14.497033Z","time spent":"2.270340239s","remote":"127.0.0.1:48652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T22:27:16.767529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"918.533848ms","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-02T22:27:16.767604Z","caller":"traceutil/trace.go:171","msg":"trace[862620620] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:596; }","duration":"918.841633ms","start":"2026-04-02T22:27:15.848744Z","end":"2026-04-02T22:27:16.767586Z","steps":["trace[862620620] 'agreement among raft nodes before linearized reading' (duration: 918.654995ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:16.767643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:15.848732Z","time spent":"918.903002ms","remote":"127.0.0.1:48684","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-02T22:27:16.767691Z","caller":"traceutil/trace.go:171","msg":"trace[1150405577] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"2.270993789s","start":"2026-04-02T22:27:14.496352Z","end":"2026-04-02T22:27:16.767346Z","steps":["trace[1150405577] 'process raft request' (duration: 2.270519656s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:16.768038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:14.496336Z","time spent":"2.271630909s","remote":"127.0.0.1:48598","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3209,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T22:27:16.821388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"695.335552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:27:16.821479Z","caller":"traceutil/trace.go:171","msg":"trace[777661762] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:597; }","duration":"695.550898ms","start":"2026-04-02T22:27:16.125907Z","end":"2026-04-02T22:27:16.821458Z","steps":["trace[777661762] 'agreement among raft nodes before linearized reading' (duration: 695.322102ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:16.821522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:16.125888Z","time spent":"695.625648ms","remote":"127.0.0.1:48398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-02T22:27:16.821753Z","caller":"traceutil/trace.go:171","msg":"trace[580588617] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"419.842672ms","start":"2026-04-02T22:27:16.401868Z","end":"2026-04-02T22:27:16.82171Z","steps":["trace[580588617] 'process raft request' (duration: 408.94881ms)","trace[580588617] 'compare' (duration: 10.286589ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:27:16.821943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:16.401818Z","time spent":"420.032209ms","remote":"127.0.0.1:48684","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T22:27:21.31994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.309177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:1 size:4083"} {"level":"info","ts":"2026-04-02T22:27:21.320024Z","caller":"traceutil/trace.go:171","msg":"trace[16553831] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:1; response_revision:668; }","duration":"106.417146ms","start":"2026-04-02T22:27:21.213581Z","end":"2026-04-02T22:27:21.319998Z","steps":["trace[16553831] 'range keys from in-memory index tree' (duration: 106.150909ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:32.625777Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440201340720301136,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-02T22:27:33.126839Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440201340720301136,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-02T22:27:33.229485Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.136559408s","expected-duration":"1s"} {"level":"info","ts":"2026-04-02T22:27:33.229873Z","caller":"traceutil/trace.go:171","msg":"trace[1819951210] transaction","detail":"{read_only:false; response_revision:751; number_of_response:1; }","duration":"1.137036142s","start":"2026-04-02T22:27:32.092809Z","end":"2026-04-02T22:27:33.229846Z","steps":["trace[1819951210] 'process raft request' (duration: 1.13688832s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:33.230095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:32.092784Z","time spent":"1.137179083s","remote":"127.0.0.1:48598","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4028,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T22:27:33.332202Z","caller":"traceutil/trace.go:171","msg":"trace[1576005095] linearizableReadLoop","detail":"{readStateIndex:783; appliedIndex:781; }","duration":"1.207476524s","start":"2026-04-02T22:27:32.124686Z","end":"2026-04-02T22:27:33.332163Z","steps":["trace[1576005095] 'read index received' (duration: 1.104995713s)","trace[1576005095] 'applied index is now lower than readState.Index' (duration: 102.479101ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:27:33.332355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.207698055s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:27:33.332508Z","caller":"traceutil/trace.go:171","msg":"trace[1939711736] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:751; }","duration":"1.207863037s","start":"2026-04-02T22:27:32.124587Z","end":"2026-04-02T22:27:33.33245Z","steps":["trace[1939711736] 'agreement among raft nodes before linearized reading' (duration: 1.207658705s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:33.332597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:32.12456Z","time spent":"1.207990259s","remote":"127.0.0.1:48400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-02T22:27:33.332693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"643.049058ms","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-02T22:27:33.332765Z","caller":"traceutil/trace.go:171","msg":"trace[1854935128] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:751; }","duration":"643.192779ms","start":"2026-04-02T22:27:32.689554Z","end":"2026-04-02T22:27:33.332747Z","steps":["trace[1854935128] 'agreement among raft nodes before linearized reading' (duration: 642.918657ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:33.332721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.307318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-02T22:27:33.332907Z","caller":"traceutil/trace.go:171","msg":"trace[1912243750] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:751; }","duration":"557.49813ms","start":"2026-04-02T22:27:32.775389Z","end":"2026-04-02T22:27:33.332887Z","steps":["trace[1912243750] 'agreement among raft nodes before linearized reading' (duration: 557.131157ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:33.333003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:32.775386Z","time spent":"557.598491ms","remote":"127.0.0.1:48684","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-02T22:27:33.332821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:32.689538Z","time spent":"643.26842ms","remote":"127.0.0.1:48684","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-02T22:27:33.333218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.940521ms","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-02T22:27:33.333274Z","caller":"traceutil/trace.go:171","msg":"trace[1053333853] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:751; }","duration":"410.054302ms","start":"2026-04-02T22:27:32.923204Z","end":"2026-04-02T22:27:33.333259Z","steps":["trace[1053333853] 'agreement among raft nodes before linearized reading' (duration: 409.310776ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:33.333311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:32.92319Z","time spent":"410.110852ms","remote":"127.0.0.1:48684","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-02T22:27:33.333702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.689749ms","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-02T22:27:33.333805Z","caller":"traceutil/trace.go:171","msg":"trace[568786660] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:751; }","duration":"401.79999ms","start":"2026-04-02T22:27:32.93198Z","end":"2026-04-02T22:27:33.33378Z","steps":["trace[568786660] 'agreement among raft nodes before linearized reading' (duration: 400.677101ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:33.333847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:32.931938Z","time spent":"401.898822ms","remote":"127.0.0.1:48684","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-02T22:27:33.334743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"559.551157ms","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-02T22:27:33.335757Z","caller":"traceutil/trace.go:171","msg":"trace[476625342] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:751; }","duration":"560.601187ms","start":"2026-04-02T22:27:32.775142Z","end":"2026-04-02T22:27:33.335744Z","steps":["trace[476625342] 'agreement among raft nodes before linearized reading' (duration: 557.46194ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:33.335831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:32.77513Z","time spent":"560.688747ms","remote":"127.0.0.1:48684","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\" "}