{"level":"warn","ts":"2026-04-02T22:27:20.321242Z","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:27:20.321326Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.23: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.23:2380","--initial-cluster=instance=https://199.204.45.23:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.23:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.23: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:27:20.321403Z","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:27:20.32142Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.23:2380"]} {"level":"info","ts":"2026-04-02T22:27:20.321442Z","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:27:20.322204Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.23:2379"]} {"level":"info","ts":"2026-04-02T22:27:20.322293Z","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.23:2380"],"listen-peer-urls":["https://199.204.45.23:2380"],"advertise-client-urls":["https://199.204.45.23:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.23:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.23: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:27:20.503582Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"181.056483ms"} {"level":"info","ts":"2026-04-02T22:27:20.980354Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"51a5c416a4d98c86","cluster-id":"ade2045974c19907"} {"level":"info","ts":"2026-04-02T22:27:20.980527Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 switched to configuration voters=()"} {"level":"info","ts":"2026-04-02T22:27:20.980565Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became follower at term 0"} {"level":"info","ts":"2026-04-02T22:27:20.980643Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 51a5c416a4d98c86 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-02T22:27:20.980698Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became follower at term 1"} {"level":"info","ts":"2026-04-02T22:27:20.980787Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 switched to configuration voters=(5883324089763466374)"} {"level":"warn","ts":"2026-04-02T22:27:21.264191Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-02T22:27:21.322476Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-02T22:27:21.370583Z","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:27:21.527658Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"51a5c416a4d98c86","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-02T22:27:21.527933Z","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:27:21.528627Z","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:27:21.528652Z","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:27:21.52787Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"51a5c416a4d98c86","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-02T22:27:21.53361Z","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:27:21.533666Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.23:2380"} {"level":"info","ts":"2026-04-02T22:27:21.533729Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.23:2380"} {"level":"info","ts":"2026-04-02T22:27:21.534191Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"51a5c416a4d98c86","initial-advertise-peer-urls":["https://199.204.45.23:2380"],"listen-peer-urls":["https://199.204.45.23:2380"],"advertise-client-urls":["https://199.204.45.23:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.23:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-02T22:27:21.534273Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-02T22:27:21.62085Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 switched to configuration voters=(5883324089763466374)"} {"level":"info","ts":"2026-04-02T22:27:21.620959Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ade2045974c19907","local-member-id":"51a5c416a4d98c86","added-peer-id":"51a5c416a4d98c86","added-peer-peer-urls":["https://199.204.45.23:2380"]} {"level":"info","ts":"2026-04-02T22:27:22.433799Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 is starting a new election at term 1"} {"level":"info","ts":"2026-04-02T22:27:22.433863Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-02T22:27:22.433904Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 received MsgPreVoteResp from 51a5c416a4d98c86 at term 1"} {"level":"info","ts":"2026-04-02T22:27:22.433923Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became candidate at term 2"} {"level":"info","ts":"2026-04-02T22:27:22.433934Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 received MsgVoteResp from 51a5c416a4d98c86 at term 2"} {"level":"info","ts":"2026-04-02T22:27:22.433958Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became leader at term 2"} {"level":"info","ts":"2026-04-02T22:27:22.433971Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 51a5c416a4d98c86 elected leader 51a5c416a4d98c86 at term 2"} {"level":"info","ts":"2026-04-02T22:27:22.674928Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T22:27:22.740445Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"51a5c416a4d98c86","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.23:2379]}","request-path":"/0/members/51a5c416a4d98c86/attributes","cluster-id":"ade2045974c19907","publish-timeout":"7s"} {"level":"info","ts":"2026-04-02T22:27:22.740483Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-02T22:27:22.740511Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-02T22:27:22.740877Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-02T22:27:22.740929Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-02T22:27:22.744884Z","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:27:22.745232Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.23:2379"} {"level":"info","ts":"2026-04-02T22:27:22.749614Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ade2045974c19907","local-member-id":"51a5c416a4d98c86","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T22:27:22.749731Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T22:27:22.74976Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T22:27:25.211935Z","caller":"traceutil/trace.go:171","msg":"trace[1003583231] transaction","detail":"{read_only:false; response_revision:70; number_of_response:1; }","duration":"135.552187ms","start":"2026-04-02T22:27:25.076353Z","end":"2026-04-02T22:27:25.211905Z","steps":["trace[1003583231] 'process raft request' (duration: 54.265495ms)","trace[1003583231] 'compare' (duration: 80.999836ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:27:34.432776Z","caller":"traceutil/trace.go:171","msg":"trace[198703681] linearizableReadLoop","detail":"{readStateIndex:406; appliedIndex:405; }","duration":"103.659326ms","start":"2026-04-02T22:27:34.329091Z","end":"2026-04-02T22:27:34.43275Z","steps":["trace[198703681] 'read index received' (duration: 103.496743ms)","trace[198703681] 'applied index is now lower than readState.Index' (duration: 161.363µs)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:27:34.433045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.894851ms","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:34.433162Z","caller":"traceutil/trace.go:171","msg":"trace[842970855] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:395; }","duration":"104.083604ms","start":"2026-04-02T22:27:34.329064Z","end":"2026-04-02T22:27:34.433147Z","steps":["trace[842970855] 'agreement among raft nodes before linearized reading' (duration: 103.88282ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:27:34.433063Z","caller":"traceutil/trace.go:171","msg":"trace[331672337] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"105.32237ms","start":"2026-04-02T22:27:34.327717Z","end":"2026-04-02T22:27:34.43304Z","steps":["trace[331672337] 'process raft request' (duration: 104.888501ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:40.238968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.528632ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-02T22:27:40.239125Z","caller":"traceutil/trace.go:171","msg":"trace[10376427] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"147.373211ms","start":"2026-04-02T22:27:40.091691Z","end":"2026-04-02T22:27:40.239064Z","steps":["trace[10376427] 'compare' (duration: 137.343068ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:27:40.239723Z","caller":"traceutil/trace.go:171","msg":"trace[1987033430] transaction","detail":"{read_only:false; response_revision:415; number_of_response:1; }","duration":"147.941823ms","start":"2026-04-02T22:27:40.091755Z","end":"2026-04-02T22:27:40.239697Z","steps":["trace[1987033430] 'process raft request' (duration: 147.668878ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:27:40.241711Z","caller":"traceutil/trace.go:171","msg":"trace[1619005599] transaction","detail":"{read_only:false; response_revision:416; number_of_response:1; }","duration":"149.695181ms","start":"2026-04-02T22:27:40.091945Z","end":"2026-04-02T22:27:40.24164Z","steps":["trace[1619005599] 'process raft request' (duration: 147.617527ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:40.883903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.015353ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T22:27:40.884084Z","caller":"traceutil/trace.go:171","msg":"trace[2054009176] linearizableReadLoop","detail":"{readStateIndex:441; appliedIndex:437; }","duration":"363.931137ms","start":"2026-04-02T22:27:40.520141Z","end":"2026-04-02T22:27:40.884072Z","steps":["trace[2054009176] 'read index received' (duration: 358.38137ms)","trace[2054009176] 'applied index is now lower than readState.Index' (duration: 5.549167ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:27:40.884179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.048149ms","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:40.884164Z","caller":"traceutil/trace.go:171","msg":"trace[1792643675] transaction","detail":"{read_only:false; response_revision:425; number_of_response:1; }","duration":"618.488758ms","start":"2026-04-02T22:27:40.265634Z","end":"2026-04-02T22:27:40.884123Z","steps":["trace[1792643675] 'process raft request' (duration: 80.054736ms)","trace[1792643675] 'compare' (duration: 537.915281ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:27:40.884199Z","caller":"traceutil/trace.go:171","msg":"trace[1870642273] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:427; }","duration":"364.126301ms","start":"2026-04-02T22:27:40.520065Z","end":"2026-04-02T22:27:40.884191Z","steps":["trace[1870642273] 'agreement among raft nodes before linearized reading' (duration: 364.073869ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:27:40.884174Z","caller":"traceutil/trace.go:171","msg":"trace[1563852877] transaction","detail":"{read_only:false; number_of_response:1; response_revision:427; }","duration":"614.35596ms","start":"2026-04-02T22:27:40.269788Z","end":"2026-04-02T22:27:40.884144Z","steps":["trace[1563852877] 'process raft request' (duration: 614.264788ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:40.88422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:40.520044Z","time spent":"364.171082ms","remote":"127.0.0.1:43016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-02T22:27:40.884234Z","caller":"traceutil/trace.go:171","msg":"trace[1291844721] transaction","detail":"{read_only:false; number_of_response:1; response_revision:427; }","duration":"616.803232ms","start":"2026-04-02T22:27:40.267388Z","end":"2026-04-02T22:27:40.884191Z","steps":["trace[1291844721] 'process raft request' (duration: 616.636788ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:40.884266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:40.265627Z","time spent":"618.58373ms","remote":"127.0.0.1:43240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3795,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T22:27:40.884304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.271183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:27:40.884335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:40.269778Z","time spent":"614.469282ms","remote":"127.0.0.1:43240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":56,"response count":0,"response size":3844,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T22:27:40.884372Z","caller":"traceutil/trace.go:171","msg":"trace[1899372578] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:427; }","duration":"185.345555ms","start":"2026-04-02T22:27:40.699006Z","end":"2026-04-02T22:27:40.884351Z","steps":["trace[1899372578] 'agreement among raft nodes before linearized reading' (duration: 185.242733ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:40.884424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:40.267379Z","time spent":"616.917144ms","remote":"127.0.0.1:42934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":55,"response count":0,"response size":41,"request content":"compare: success: > failure: >"} {"level":"info","ts":"2026-04-02T22:27:40.884484Z","caller":"traceutil/trace.go:171","msg":"trace[552932068] transaction","detail":"{read_only:false; response_revision:426; number_of_response:1; }","duration":"617.084977ms","start":"2026-04-02T22:27:40.267363Z","end":"2026-04-02T22:27:40.884448Z","steps":["trace[552932068] 'process raft request' (duration: 616.623957ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:40.884613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:40.267355Z","time spent":"617.19547ms","remote":"127.0.0.1:42828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":721,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T22:27:46.11768Z","caller":"traceutil/trace.go:171","msg":"trace[328860347] linearizableReadLoop","detail":"{readStateIndex:467; appliedIndex:466; }","duration":"196.828833ms","start":"2026-04-02T22:27:45.920828Z","end":"2026-04-02T22:27:46.117657Z","steps":["trace[328860347] 'read index received' (duration: 196.615608ms)","trace[328860347] 'applied index is now lower than readState.Index' (duration: 212.235µs)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:27:46.117871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.023517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.23\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-02T22:27:46.117904Z","caller":"traceutil/trace.go:171","msg":"trace[1425953585] range","detail":"{range_begin:/registry/masterleases/199.204.45.23; range_end:; response_count:1; response_revision:452; }","duration":"197.120009ms","start":"2026-04-02T22:27:45.920774Z","end":"2026-04-02T22:27:46.117894Z","steps":["trace[1425953585] 'agreement among raft nodes before linearized reading' (duration: 197.037777ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:27:46.117804Z","caller":"traceutil/trace.go:171","msg":"trace[1525180254] transaction","detail":"{read_only:false; response_revision:452; number_of_response:1; }","duration":"390.557559ms","start":"2026-04-02T22:27:45.727207Z","end":"2026-04-02T22:27:46.117764Z","steps":["trace[1525180254] 'process raft request' (duration: 390.317644ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:46.118048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:45.727178Z","time spent":"390.772193ms","remote":"127.0.0.1:43016","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:53.169092Z","caller":"traceutil/trace.go:171","msg":"trace[398293115] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"219.426013ms","start":"2026-04-02T22:27:52.949647Z","end":"2026-04-02T22:27:53.169073Z","steps":["trace[398293115] 'process raft request' (duration: 219.314061ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:54.199442Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10125953780435733616,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-02T22:27:54.700552Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10125953780435733616,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-02T22:27:54.984023Z","caller":"traceutil/trace.go:171","msg":"trace[1045991943] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"1.42093608s","start":"2026-04-02T22:27:53.563062Z","end":"2026-04-02T22:27:54.983998Z","steps":["trace[1045991943] 'process raft request' (duration: 1.420681714s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:54.984157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:53.563043Z","time spent":"1.421053143s","remote":"127.0.0.1:42794","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:54.995052Z","caller":"traceutil/trace.go:171","msg":"trace[702614568] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"1.428357858s","start":"2026-04-02T22:27:53.566673Z","end":"2026-04-02T22:27:54.995031Z","steps":["trace[702614568] 'process raft request' (duration: 1.428210935s)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:27:54.99511Z","caller":"traceutil/trace.go:171","msg":"trace[2119550766] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"1.405091822s","start":"2026-04-02T22:27:53.589993Z","end":"2026-04-02T22:27:54.995084Z","steps":["trace[2119550766] 'process raft request' (duration: 1.4049954s)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:27:54.995273Z","caller":"traceutil/trace.go:171","msg":"trace[1847784388] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"1.402865535s","start":"2026-04-02T22:27:53.59237Z","end":"2026-04-02T22:27:54.995236Z","steps":["trace[1847784388] 'process raft request' (duration: 1.40264317s)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:27:54.995353Z","caller":"traceutil/trace.go:171","msg":"trace[196256997] linearizableReadLoop","detail":"{readStateIndex:532; appliedIndex:520; }","duration":"1.296001093s","start":"2026-04-02T22:27:53.69934Z","end":"2026-04-02T22:27:54.995341Z","steps":["trace[196256997] 'read index received' (duration: 1.284493917s)","trace[196256997] 'applied index is now lower than readState.Index' (duration: 11.506566ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:27:54.995397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:53.592362Z","time spent":"1.402976457s","remote":"127.0.0.1:42794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T22:27:54.995416Z","caller":"traceutil/trace.go:171","msg":"trace[499363050] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"1.383790157s","start":"2026-04-02T22:27:53.611618Z","end":"2026-04-02T22:27:54.995408Z","steps":["trace[499363050] 'process raft request' (duration: 1.383550662s)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:27:54.995415Z","caller":"traceutil/trace.go:171","msg":"trace[543692927] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"1.400156497s","start":"2026-04-02T22:27:53.595241Z","end":"2026-04-02T22:27:54.995398Z","steps":["trace[543692927] 'process raft request' (duration: 1.39982449s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:54.99549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:53.611603Z","time spent":"1.383832438s","remote":"127.0.0.1:42794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T22:27:54.995487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:53.595224Z","time spent":"1.400230498s","remote":"127.0.0.1:42794","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:54.995197Z","caller":"traceutil/trace.go:171","msg":"trace[189929167] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"1.402768283s","start":"2026-04-02T22:27:53.592406Z","end":"2026-04-02T22:27:54.995175Z","steps":["trace[189929167] 'process raft request' (duration: 1.402635841s)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:27:54.995529Z","caller":"traceutil/trace.go:171","msg":"trace[1384015428] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"1.400169278s","start":"2026-04-02T22:27:53.595348Z","end":"2026-04-02T22:27:54.995517Z","steps":["trace[1384015428] 'process raft request' (duration: 1.399746639s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:54.995579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:53.595343Z","time spent":"1.400217429s","remote":"127.0.0.1:42794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T22:27:54.995605Z","caller":"traceutil/trace.go:171","msg":"trace[1549560810] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"1.240608991s","start":"2026-04-02T22:27:53.754991Z","end":"2026-04-02T22:27:54.9956Z","steps":["trace[1549560810] 'process raft request' (duration: 1.240266094s)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:27:54.995585Z","caller":"traceutil/trace.go:171","msg":"trace[1365926799] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"1.352955589s","start":"2026-04-02T22:27:53.642623Z","end":"2026-04-02T22:27:54.995579Z","steps":["trace[1365926799] 'process raft request' (duration: 1.352584861s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:54.995634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:53.754968Z","time spent":"1.240652612s","remote":"127.0.0.1:42794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T22:27:54.995651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:53.642596Z","time spent":"1.353035501s","remote":"127.0.0.1:42794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T22:27:54.995146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:53.566653Z","time spent":"1.428445961s","remote":"127.0.0.1:42794","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:54.99572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.296384051s","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:54.995754Z","caller":"traceutil/trace.go:171","msg":"trace[1760998823] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:516; }","duration":"1.296447252s","start":"2026-04-02T22:27:53.699299Z","end":"2026-04-02T22:27:54.995746Z","steps":["trace[1760998823] 'agreement among raft nodes before linearized reading' (duration: 1.296384691s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:54.995351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:53.589966Z","time spent":"1.405325087s","remote":"127.0.0.1:42794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T22:27:54.995782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:53.699281Z","time spent":"1.296496823s","remote":"127.0.0.1:42758","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:54.995642Z","caller":"traceutil/trace.go:171","msg":"trace[1564232383] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"1.392468323s","start":"2026-04-02T22:27:53.602854Z","end":"2026-04-02T22:27:54.995322Z","steps":["trace[1564232383] 'process raft request' (duration: 1.392276289s)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:27:54.995096Z","caller":"traceutil/trace.go:171","msg":"trace[1686255250] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"1.411138682s","start":"2026-04-02T22:27:53.583908Z","end":"2026-04-02T22:27:54.995047Z","steps":["trace[1686255250] 'process raft request' (duration: 1.41104993s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:54.995985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:53.583893Z","time spent":"1.412064161s","remote":"127.0.0.1:42794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T22:27:54.995927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:53.602846Z","time spent":"1.393036964s","remote":"127.0.0.1:42794","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:54.99648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:53.592403Z","time spent":"1.403167012s","remote":"127.0.0.1:42794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T22:27:55.008635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"603.268594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-02T22:27:55.008695Z","caller":"traceutil/trace.go:171","msg":"trace[1778615650] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:518; }","duration":"603.365346ms","start":"2026-04-02T22:27:54.405312Z","end":"2026-04-02T22:27:55.008677Z","steps":["trace[1778615650] 'agreement among raft nodes before linearized reading' (duration: 603.283174ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:55.008722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:54.40529Z","time spent":"603.426347ms","remote":"127.0.0.1:43016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-02T22:27:55.010161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"854.844556ms","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:55.010194Z","caller":"traceutil/trace.go:171","msg":"trace[362309677] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:518; }","duration":"854.910609ms","start":"2026-04-02T22:27:54.155276Z","end":"2026-04-02T22:27:55.010186Z","steps":["trace[362309677] 'agreement among raft nodes before linearized reading' (duration: 854.858887ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:55.010213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:54.155259Z","time spent":"854.949209ms","remote":"127.0.0.1:43016","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:55.010351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"855.931931ms","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:55.010437Z","caller":"traceutil/trace.go:171","msg":"trace[663488258] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:518; }","duration":"856.057792ms","start":"2026-04-02T22:27:54.154347Z","end":"2026-04-02T22:27:55.010405Z","steps":["trace[663488258] 'agreement among raft nodes before linearized reading' (duration: 855.882569ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:55.010473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:54.154329Z","time spent":"856.137005ms","remote":"127.0.0.1:43016","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:56.009814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.483329ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T22:27:56.010006Z","caller":"traceutil/trace.go:171","msg":"trace[1396008071] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"462.515253ms","start":"2026-04-02T22:27:55.54746Z","end":"2026-04-02T22:27:56.009976Z","steps":["trace[1396008071] 'process raft request' (duration: 38.799869ms)","trace[1396008071] 'compare' (duration: 422.926057ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:27:56.010056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:55.547441Z","time spent":"462.591174ms","remote":"127.0.0.1:42794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18041,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T22:27:56.052349Z","caller":"traceutil/trace.go:171","msg":"trace[378862018] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"502.08672ms","start":"2026-04-02T22:27:55.550227Z","end":"2026-04-02T22:27:56.052314Z","steps":["trace[378862018] 'process raft request' (duration: 501.846474ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:56.052515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:55.550203Z","time spent":"502.226663ms","remote":"127.0.0.1:42794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":74745,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T22:27:56.968556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"822.301533ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:27:56.968695Z","caller":"traceutil/trace.go:171","msg":"trace[488998346] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:569; }","duration":"822.461736ms","start":"2026-04-02T22:27:56.146212Z","end":"2026-04-02T22:27:56.968674Z","steps":["trace[488998346] 'range keys from in-memory index tree' (duration: 822.274502ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:56.968838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.734476ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-02T22:27:56.969037Z","caller":"traceutil/trace.go:171","msg":"trace[2019358792] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"1.30607117s","start":"2026-04-02T22:27:55.662948Z","end":"2026-04-02T22:27:56.969019Z","steps":["trace[2019358792] 'process raft request' (duration: 1.204087539s)","trace[2019358792] 'compare' (duration: 101.43262ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:27:56.969139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:55.662924Z","time spent":"1.306154682s","remote":"127.0.0.1:42794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":569094,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T22:27:56.969164Z","caller":"traceutil/trace.go:171","msg":"trace[1109023877] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"880.747182ms","start":"2026-04-02T22:27:56.088399Z","end":"2026-04-02T22:27:56.969146Z","steps":["trace[1109023877] 'process raft request' (duration: 880.699371ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:56.969263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:56.088375Z","time spent":"880.841954ms","remote":"127.0.0.1:42794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20842,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T22:27:56.969282Z","caller":"traceutil/trace.go:171","msg":"trace[1645033642] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"931.351324ms","start":"2026-04-02T22:27:56.037903Z","end":"2026-04-02T22:27:56.969255Z","steps":["trace[1645033642] 'process raft request' (duration: 931.074788ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:27:56.969355Z","caller":"traceutil/trace.go:171","msg":"trace[891214252] linearizableReadLoop","detail":"{readStateIndex:592; appliedIndex:590; }","duration":"1.0476949s","start":"2026-04-02T22:27:55.921648Z","end":"2026-04-02T22:27:56.969343Z","steps":["trace[891214252] 'read index received' (duration: 130.428267ms)","trace[891214252] 'applied index is now lower than readState.Index' (duration: 917.265663ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:27:56.969412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:56.037875Z","time spent":"931.467387ms","remote":"127.0.0.1:42794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":98698,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T22:27:56.969481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.047828663s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.23\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-02T22:27:56.969516Z","caller":"traceutil/trace.go:171","msg":"trace[1719996736] range","detail":"{range_begin:/registry/masterleases/199.204.45.23; range_end:; response_count:1; response_revision:572; }","duration":"1.047895694s","start":"2026-04-02T22:27:55.921612Z","end":"2026-04-02T22:27:56.969508Z","steps":["trace[1719996736] 'agreement among raft nodes before linearized reading' (duration: 1.047810793s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:56.969544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:27:55.921592Z","time spent":"1.047945785s","remote":"127.0.0.1:42784","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.23\" "} {"level":"warn","ts":"2026-04-02T22:27:56.969597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.219979ms","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:56.969625Z","caller":"traceutil/trace.go:171","msg":"trace[12935410] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:572; }","duration":"271.28111ms","start":"2026-04-02T22:27:56.698337Z","end":"2026-04-02T22:27:56.969618Z","steps":["trace[12935410] 'agreement among raft nodes before linearized reading' (duration: 271.239489ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:28:02.074104Z","caller":"traceutil/trace.go:171","msg":"trace[1409059242] linearizableReadLoop","detail":"{readStateIndex:628; appliedIndex:627; }","duration":"375.15364ms","start":"2026-04-02T22:28:01.698923Z","end":"2026-04-02T22:28:02.074076Z","steps":["trace[1409059242] 'read index received' (duration: 374.071087ms)","trace[1409059242] 'applied index is now lower than readState.Index' (duration: 1.081683ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:28:02.074202Z","caller":"traceutil/trace.go:171","msg":"trace[1917409539] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"535.067218ms","start":"2026-04-02T22:28:01.539099Z","end":"2026-04-02T22:28:02.074166Z","steps":["trace[1917409539] 'process raft request' (duration: 534.24742ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:02.074343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:01.539075Z","time spent":"535.181979ms","remote":"127.0.0.1:42836","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T22:28:02.074368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.441936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:28:02.074552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.983328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-zwfc6\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-04-02T22:28:02.074711Z","caller":"traceutil/trace.go:171","msg":"trace[2126024948] range","detail":"{range_begin:/registry/pods/kube-system/cilium-zwfc6; range_end:; response_count:1; response_revision:604; }","duration":"131.199983ms","start":"2026-04-02T22:28:01.943489Z","end":"2026-04-02T22:28:02.074689Z","steps":["trace[2126024948] 'agreement among raft nodes before linearized reading' (duration: 130.888436ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:28:02.074661Z","caller":"traceutil/trace.go:171","msg":"trace[1065966648] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:604; }","duration":"375.699652ms","start":"2026-04-02T22:28:01.698869Z","end":"2026-04-02T22:28:02.074569Z","steps":["trace[1065966648] 'agreement among raft nodes before linearized reading' (duration: 375.355855ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:02.075067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:01.698843Z","time spent":"376.202472ms","remote":"127.0.0.1:42750","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:28:02.635945Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10125953780435733810,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-02T22:28:02.945515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.693886ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T22:28:02.945821Z","caller":"traceutil/trace.go:171","msg":"trace[746730448] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"849.515285ms","start":"2026-04-02T22:28:02.096283Z","end":"2026-04-02T22:28:02.945798Z","steps":["trace[746730448] 'process raft request' (duration: 619.441461ms)","trace[746730448] 'compare' (duration: 229.500122ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:28:02.945996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:02.096264Z","time spent":"849.666618ms","remote":"127.0.0.1:42934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T22:28:02.94601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"810.761164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:28:02.946254Z","caller":"traceutil/trace.go:171","msg":"trace[558362047] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:605; }","duration":"811.07472ms","start":"2026-04-02T22:28:02.135125Z","end":"2026-04-02T22:28:02.9462Z","steps":["trace[558362047] 'agreement among raft nodes before linearized reading' (duration: 810.767044ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:02.946335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:02.135106Z","time spent":"811.215874ms","remote":"127.0.0.1:42956","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"info","ts":"2026-04-02T22:28:02.946958Z","caller":"traceutil/trace.go:171","msg":"trace[2099175118] linearizableReadLoop","detail":"{readStateIndex:629; appliedIndex:628; }","duration":"810.539079ms","start":"2026-04-02T22:28:02.135196Z","end":"2026-04-02T22:28:02.945735Z","steps":["trace[2099175118] 'read index received' (duration: 580.381904ms)","trace[2099175118] 'applied index is now lower than readState.Index' (duration: 230.155135ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:28:02.947291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.292005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:28:02.947395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.006187ms","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:28:02.947436Z","caller":"traceutil/trace.go:171","msg":"trace[1407671693] 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:605; }","duration":"109.057599ms","start":"2026-04-02T22:28:02.838363Z","end":"2026-04-02T22:28:02.947421Z","steps":["trace[1407671693] 'agreement among raft nodes before linearized reading' (duration: 108.986368ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:28:02.947458Z","caller":"traceutil/trace.go:171","msg":"trace[962287164] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:605; }","duration":"221.435268ms","start":"2026-04-02T22:28:02.725956Z","end":"2026-04-02T22:28:02.947391Z","steps":["trace[962287164] 'agreement among raft nodes before linearized reading' (duration: 221.291845ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:02.947683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.328394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:28:02.947704Z","caller":"traceutil/trace.go:171","msg":"trace[1725646128] 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:605; }","duration":"109.350465ms","start":"2026-04-02T22:28:02.838348Z","end":"2026-04-02T22:28:02.947699Z","steps":["trace[1725646128] 'agreement among raft nodes before linearized reading' (duration: 109.312934ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:02.947754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.980274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:28:02.947773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.353217ms","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:28:02.947812Z","caller":"traceutil/trace.go:171","msg":"trace[1891994603] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:605; }","duration":"246.089617ms","start":"2026-04-02T22:28:02.701702Z","end":"2026-04-02T22:28:02.947792Z","steps":["trace[1891994603] 'agreement among raft nodes before linearized reading' (duration: 245.971544ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:28:02.947872Z","caller":"traceutil/trace.go:171","msg":"trace[1959840289] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:605; }","duration":"131.5131ms","start":"2026-04-02T22:28:02.816338Z","end":"2026-04-02T22:28:02.947851Z","steps":["trace[1959840289] 'agreement among raft nodes before linearized reading' (duration: 131.326796ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:02.948142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.374737ms","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:28:02.94818Z","caller":"traceutil/trace.go:171","msg":"trace[369065234] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:605; }","duration":"131.455319ms","start":"2026-04-02T22:28:02.816714Z","end":"2026-04-02T22:28:02.948169Z","steps":["trace[369065234] 'agreement among raft nodes before linearized reading' (duration: 131.389967ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:02.94823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.397588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:28:02.948256Z","caller":"traceutil/trace.go:171","msg":"trace[490788513] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:605; }","duration":"221.445368ms","start":"2026-04-02T22:28:02.726803Z","end":"2026-04-02T22:28:02.948248Z","steps":["trace[490788513] 'agreement among raft nodes before linearized reading' (duration: 221.404238ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:02.94783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.562062ms","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:28:02.948318Z","caller":"traceutil/trace.go:171","msg":"trace[257677079] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:605; }","duration":"132.060962ms","start":"2026-04-02T22:28:02.816248Z","end":"2026-04-02T22:28:02.948309Z","steps":["trace[257677079] 'agreement among raft nodes before linearized reading' (duration: 131.534461ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:02.948334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.099483ms","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:28:02.948353Z","caller":"traceutil/trace.go:171","msg":"trace[168948779] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:605; }","duration":"195.172765ms","start":"2026-04-02T22:28:02.753174Z","end":"2026-04-02T22:28:02.948347Z","steps":["trace[168948779] 'agreement among raft nodes before linearized reading' (duration: 195.137094ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:02.948361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.413561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:28:02.948385Z","caller":"traceutil/trace.go:171","msg":"trace[275142534] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:605; }","duration":"195.438611ms","start":"2026-04-02T22:28:02.75294Z","end":"2026-04-02T22:28:02.948379Z","steps":["trace[275142534] 'agreement among raft nodes before linearized reading' (duration: 195.40249ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:02.947306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.337296ms","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:28:02.948545Z","caller":"traceutil/trace.go:171","msg":"trace[1871886959] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:605; }","duration":"194.627144ms","start":"2026-04-02T22:28:02.753908Z","end":"2026-04-02T22:28:02.948535Z","steps":["trace[1871886959] 'agreement among raft nodes before linearized reading' (duration: 193.301176ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:02.948724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.259802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:28:02.948743Z","caller":"traceutil/trace.go:171","msg":"trace[1040235022] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:605; }","duration":"248.307504ms","start":"2026-04-02T22:28:02.70043Z","end":"2026-04-02T22:28:02.948737Z","steps":["trace[1040235022] 'agreement among raft nodes before linearized reading' (duration: 248.277743ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:02.948797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.870329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:28:02.94887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.774836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:28:02.948872Z","caller":"traceutil/trace.go:171","msg":"trace[1448231406] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:605; }","duration":"291.94611ms","start":"2026-04-02T22:28:02.65689Z","end":"2026-04-02T22:28:02.948836Z","steps":["trace[1448231406] 'agreement among raft nodes before linearized reading' (duration: 291.853658ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:28:02.948897Z","caller":"traceutil/trace.go:171","msg":"trace[647473881] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:605; }","duration":"222.839858ms","start":"2026-04-02T22:28:02.726049Z","end":"2026-04-02T22:28:02.948889Z","steps":["trace[647473881] 'agreement among raft nodes before linearized reading' (duration: 222.792937ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:02.949275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.821345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:28:02.949338Z","caller":"traceutil/trace.go:171","msg":"trace[3148623] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:605; }","duration":"247.904746ms","start":"2026-04-02T22:28:02.701417Z","end":"2026-04-02T22:28:02.949322Z","steps":["trace[3148623] 'agreement among raft nodes before linearized reading' (duration: 247.801273ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:02.94979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.937772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:28:02.949163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.449526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:28:02.949976Z","caller":"traceutil/trace.go:171","msg":"trace[1809067549] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:605; }","duration":"248.279055ms","start":"2026-04-02T22:28:02.701678Z","end":"2026-04-02T22:28:02.949957Z","steps":["trace[1809067549] 'agreement among raft nodes before linearized reading' (duration: 247.275182ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:02.950311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.666254ms","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:28:02.95036Z","caller":"traceutil/trace.go:171","msg":"trace[557496837] 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:605; }","duration":"110.777156ms","start":"2026-04-02T22:28:02.839568Z","end":"2026-04-02T22:28:02.950346Z","steps":["trace[557496837] 'agreement among raft nodes before linearized reading' (duration: 107.778611ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:28:02.951991Z","caller":"traceutil/trace.go:171","msg":"trace[134296989] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:605; }","duration":"293.140836ms","start":"2026-04-02T22:28:02.656802Z","end":"2026-04-02T22:28:02.949942Z","steps":["trace[134296989] 'agreement among raft nodes before linearized reading' (duration: 290.382997ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:03.830789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"525.80818ms","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:28:03.830872Z","caller":"traceutil/trace.go:171","msg":"trace[1442731116] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:605; }","duration":"525.912913ms","start":"2026-04-02T22:28:03.30494Z","end":"2026-04-02T22:28:03.830853Z","steps":["trace[1442731116] 'range keys from in-memory index tree' (duration: 525.77507ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:03.830949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.304934Z","time spent":"526.002585ms","remote":"127.0.0.1:59844","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:28:03.831215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"589.117467ms","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:28:03.831242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"695.103411ms","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:28:03.831409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.489284ms","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:28:03.831437Z","caller":"traceutil/trace.go:171","msg":"trace[956615949] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:605; }","duration":"695.292676ms","start":"2026-04-02T22:28:03.13608Z","end":"2026-04-02T22:28:03.831373Z","steps":["trace[956615949] 'range keys from in-memory index tree' (duration: 694.811296ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:28:03.831461Z","caller":"traceutil/trace.go:171","msg":"trace[1205587345] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:605; }","duration":"526.568466ms","start":"2026-04-02T22:28:03.304881Z","end":"2026-04-02T22:28:03.83145Z","steps":["trace[1205587345] 'count revisions from in-memory index tree' (duration: 526.394443ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:03.831489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"687.396236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-04-02T22:28:03.831499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.304872Z","time spent":"526.618047ms","remote":"127.0.0.1:59844","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":"info","ts":"2026-04-02T22:28:03.831526Z","caller":"traceutil/trace.go:171","msg":"trace[421719532] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:605; }","duration":"687.480258ms","start":"2026-04-02T22:28:03.144036Z","end":"2026-04-02T22:28:03.831516Z","steps":["trace[421719532] 'range keys from in-memory index tree' (duration: 687.250403ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:03.831559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.14401Z","time spent":"687.542719ms","remote":"127.0.0.1:43016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-02T22:28:03.831562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.136065Z","time spent":"695.465159ms","remote":"127.0.0.1:43016","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:28:03.831665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"561.678439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:28:03.831755Z","caller":"traceutil/trace.go:171","msg":"trace[1659195404] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:605; }","duration":"561.955965ms","start":"2026-04-02T22:28:03.269784Z","end":"2026-04-02T22:28:03.831739Z","steps":["trace[1659195404] 'count revisions from in-memory index tree' (duration: 561.553876ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:03.831934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.269672Z","time spent":"562.241122ms","remote":"127.0.0.1:59830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"warn","ts":"2026-04-02T22:28:03.831997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.327113ms","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:28:03.832024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"561.983696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:28:03.83211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.14202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:28:03.832107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.878345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:28:03.832155Z","caller":"traceutil/trace.go:171","msg":"trace[2082563384] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:605; }","duration":"473.206102ms","start":"2026-04-02T22:28:03.358938Z","end":"2026-04-02T22:28:03.832144Z","steps":["trace[2082563384] 'count revisions from in-memory index tree' (duration: 473.098969ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:28:03.832153Z","caller":"traceutil/trace.go:171","msg":"trace[1810645033] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:605; }","duration":"562.14002ms","start":"2026-04-02T22:28:03.269994Z","end":"2026-04-02T22:28:03.832134Z","steps":["trace[1810645033] 'range keys from in-memory index tree' (duration: 561.895515ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:03.832157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"562.459446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:28:03.832168Z","caller":"traceutil/trace.go:171","msg":"trace[1410255992] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:605; }","duration":"438.982807ms","start":"2026-04-02T22:28:03.393169Z","end":"2026-04-02T22:28:03.832152Z","steps":["trace[1410255992] 'count revisions from in-memory index tree' (duration: 438.803594ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:03.832192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.358925Z","time spent":"473.257163ms","remote":"127.0.0.1:59854","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:28:03.832206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.393164Z","time spent":"439.032098ms","remote":"127.0.0.1:59866","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/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-02T22:28:03.832231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"590.065699ms","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:28:03.832241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.892536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:28:03.832258Z","caller":"traceutil/trace.go:171","msg":"trace[2103947371] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:605; }","duration":"590.12144ms","start":"2026-04-02T22:28:03.242129Z","end":"2026-04-02T22:28:03.83225Z","steps":["trace[2103947371] 'count revisions from in-memory index tree' (duration: 590.008038ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:28:03.832272Z","caller":"traceutil/trace.go:171","msg":"trace[32013725] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:605; }","duration":"438.947047ms","start":"2026-04-02T22:28:03.393315Z","end":"2026-04-02T22:28:03.832262Z","steps":["trace[32013725] 'range keys from in-memory index tree' (duration: 438.804744ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:03.832299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.393302Z","time spent":"438.989687ms","remote":"127.0.0.1:59866","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/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-02T22:28:03.832318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.291053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:28:03.831418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"694.10521ms","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:28:03.832381Z","caller":"traceutil/trace.go:171","msg":"trace[358791882] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:605; }","duration":"473.390426ms","start":"2026-04-02T22:28:03.35898Z","end":"2026-04-02T22:28:03.832371Z","steps":["trace[358791882] 'range keys from in-memory index tree' (duration: 473.236452ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:28:03.832405Z","caller":"traceutil/trace.go:171","msg":"trace[2004814331] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:605; }","duration":"695.098981ms","start":"2026-04-02T22:28:03.137296Z","end":"2026-04-02T22:28:03.832395Z","steps":["trace[2004814331] 'range keys from in-memory index tree' (duration: 694.011577ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:03.832409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.358969Z","time spent":"473.431966ms","remote":"127.0.0.1:59854","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:28:03.832442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.137291Z","time spent":"695.142562ms","remote":"127.0.0.1:43016","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:28:03.831305Z","caller":"traceutil/trace.go:171","msg":"trace[1680373847] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:605; }","duration":"589.240671ms","start":"2026-04-02T22:28:03.24204Z","end":"2026-04-02T22:28:03.83128Z","steps":["trace[1680373847] 'range keys from in-memory index tree' (duration: 589.073997ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:03.832555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.242033Z","time spent":"590.507798ms","remote":"127.0.0.1:59826","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:28:03.8323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.242113Z","time spent":"590.177871ms","remote":"127.0.0.1:59826","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":"info","ts":"2026-04-02T22:28:03.832198Z","caller":"traceutil/trace.go:171","msg":"trace[1336549169] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:605; }","duration":"562.550508ms","start":"2026-04-02T22:28:03.269637Z","end":"2026-04-02T22:28:03.832187Z","steps":["trace[1336549169] 'range keys from in-memory index tree' (duration: 562.372015ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:03.832723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.269626Z","time spent":"563.07564ms","remote":"127.0.0.1:59830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 "} {"level":"warn","ts":"2026-04-02T22:28:03.831883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"606.694385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-02T22:28:03.832845Z","caller":"traceutil/trace.go:171","msg":"trace[621484290] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:605; }","duration":"607.648955ms","start":"2026-04-02T22:28:03.22518Z","end":"2026-04-02T22:28:03.832829Z","steps":["trace[621484290] 'range keys from in-memory index tree' (duration: 606.553963ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:03.832901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.225111Z","time spent":"607.776129ms","remote":"127.0.0.1:43016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-02T22:28:03.832067Z","caller":"traceutil/trace.go:171","msg":"trace[24963713] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:605; }","duration":"472.424565ms","start":"2026-04-02T22:28:03.359625Z","end":"2026-04-02T22:28:03.83205Z","steps":["trace[24963713] 'range keys from in-memory index tree' (duration: 472.283932ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:03.83298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.359607Z","time spent":"473.353924ms","remote":"127.0.0.1:59854","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":"warn","ts":"2026-04-02T22:28:03.8322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.269985Z","time spent":"562.202061ms","remote":"127.0.0.1:59830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 "} {"level":"warn","ts":"2026-04-02T22:28:03.833346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.215372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:28:03.833631Z","caller":"traceutil/trace.go:171","msg":"trace[847964004] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:605; }","duration":"439.421647ms","start":"2026-04-02T22:28:03.394044Z","end":"2026-04-02T22:28:03.833466Z","steps":["trace[847964004] 'range keys from in-memory index tree' (duration: 437.318681ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:03.834031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.394032Z","time spent":"439.977508ms","remote":"127.0.0.1:59866","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/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 "} {"level":"info","ts":"2026-04-02T22:28:03.941058Z","caller":"traceutil/trace.go:171","msg":"trace[1412072826] linearizableReadLoop","detail":"{readStateIndex:630; appliedIndex:629; }","duration":"417.022306ms","start":"2026-04-02T22:28:03.524013Z","end":"2026-04-02T22:28:03.941036Z","steps":["trace[1412072826] 'read index received' (duration: 416.184327ms)","trace[1412072826] 'applied index is now lower than readState.Index' (duration: 836.859µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:28:03.941171Z","caller":"traceutil/trace.go:171","msg":"trace[208208674] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"536.064171ms","start":"2026-04-02T22:28:03.405096Z","end":"2026-04-02T22:28:03.94116Z","steps":["trace[208208674] 'process raft request' (duration: 535.304594ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:03.941289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.405076Z","time spent":"536.121522ms","remote":"127.0.0.1:42836","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036105,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T22:28:03.941647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.311772ms","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":"info","ts":"2026-04-02T22:28:03.941799Z","caller":"traceutil/trace.go:171","msg":"trace[1743899944] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:606; }","duration":"417.767782ms","start":"2026-04-02T22:28:03.523971Z","end":"2026-04-02T22:28:03.941739Z","steps":["trace[1743899944] 'agreement among raft nodes before linearized reading' (duration: 417.234711ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:03.941896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.523952Z","time spent":"417.930115ms","remote":"127.0.0.1:59868","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:28:06.40206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.167713ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:28:06.402195Z","caller":"traceutil/trace.go:171","msg":"trace[1818293648] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:606; }","duration":"256.311606ms","start":"2026-04-02T22:28:06.145864Z","end":"2026-04-02T22:28:06.402175Z","steps":["trace[1818293648] 'range keys from in-memory index tree' (duration: 256.152783ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:06.402196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.299727497s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T22:28:06.402489Z","caller":"traceutil/trace.go:171","msg":"trace[1032871815] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"2.564908697s","start":"2026-04-02T22:28:03.837553Z","end":"2026-04-02T22:28:06.402462Z","steps":["trace[1032871815] 'process raft request' (duration: 264.840853ms)","trace[1032871815] 'compare' (duration: 2.298603363s)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:28:06.402643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.837526Z","time spent":"2.565028809s","remote":"127.0.0.1:43016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T22:28:06.402838Z","caller":"traceutil/trace.go:171","msg":"trace[924155523] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"2.564965208s","start":"2026-04-02T22:28:03.837831Z","end":"2026-04-02T22:28:06.402796Z","steps":["trace[924155523] 'process raft request' (duration: 2.56455163s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:06.402966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.837818Z","time spent":"2.56506314s","remote":"127.0.0.1:43016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T22:28:06.403034Z","caller":"traceutil/trace.go:171","msg":"trace[605081922] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"2.564900057s","start":"2026-04-02T22:28:03.83812Z","end":"2026-04-02T22:28:06.40302Z","steps":["trace[605081922] 'process raft request' (duration: 2.564333055s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:06.40318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.838113Z","time spent":"2.564983489s","remote":"127.0.0.1:43016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T22:28:06.403218Z","caller":"traceutil/trace.go:171","msg":"trace[1539399661] linearizableReadLoop","detail":"{readStateIndex:634; appliedIndex:630; }","duration":"2.46204222s","start":"2026-04-02T22:28:03.941124Z","end":"2026-04-02T22:28:06.403166Z","steps":["trace[1539399661] 'read index received' (duration: 161.360923ms)","trace[1539399661] 'applied index is now lower than readState.Index' (duration: 2.300679687s)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:28:06.403346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.619583461s","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:28:06.403377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.619963889s","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:28:06.403414Z","caller":"traceutil/trace.go:171","msg":"trace[1035497276] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:611; }","duration":"2.619686043s","start":"2026-04-02T22:28:03.783709Z","end":"2026-04-02T22:28:06.403395Z","steps":["trace[1035497276] 'agreement among raft nodes before linearized reading' (duration: 2.61958113s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:06.403474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.783686Z","time spent":"2.619766615s","remote":"127.0.0.1:59906","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":"info","ts":"2026-04-02T22:28:06.40347Z","caller":"traceutil/trace.go:171","msg":"trace[2096642658] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:611; }","duration":"2.62000849s","start":"2026-04-02T22:28:03.783396Z","end":"2026-04-02T22:28:06.403405Z","steps":["trace[2096642658] 'agreement among raft nodes before linearized reading' (duration: 2.619909667s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:06.403564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.634780537s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:28:06.403621Z","caller":"traceutil/trace.go:171","msg":"trace[278224452] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:611; }","duration":"2.634864668s","start":"2026-04-02T22:28:03.768738Z","end":"2026-04-02T22:28:06.403603Z","steps":["trace[278224452] 'agreement among raft nodes before linearized reading' (duration: 2.634781217s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:06.403634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.634155534s","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":"warn","ts":"2026-04-02T22:28:06.403729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.634833558s","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":"warn","ts":"2026-04-02T22:28:06.403764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.748040757s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:28:06.403609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.783376Z","time spent":"2.620213344s","remote":"127.0.0.1:59906","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":"warn","ts":"2026-04-02T22:28:06.403864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.48432014s","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:28:06.403879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.582992696s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:28:06.403924Z","caller":"traceutil/trace.go:171","msg":"trace[1707668044] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:611; }","duration":"2.583047417s","start":"2026-04-02T22:28:03.820863Z","end":"2026-04-02T22:28:06.40391Z","steps":["trace[1707668044] 'agreement among raft nodes before linearized reading' (duration: 2.582937865s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:06.403902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.619423517s","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:28:06.403965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.820856Z","time spent":"2.583095598s","remote":"127.0.0.1:59910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-02T22:28:06.403985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.520000135s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:28:06.404037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.879614619s","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":"info","ts":"2026-04-02T22:28:06.404098Z","caller":"traceutil/trace.go:171","msg":"trace[993795559] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:611; }","duration":"2.879689861s","start":"2026-04-02T22:28:03.524393Z","end":"2026-04-02T22:28:06.404083Z","steps":["trace[993795559] 'agreement among raft nodes before linearized reading' (duration: 2.879602929s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:06.404111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.501176091s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:28:06.404147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.524386Z","time spent":"2.879746642s","remote":"127.0.0.1:59868","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:28:06.404189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.521076027s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:28:06.404211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.501373665s","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:28:06.404248Z","caller":"traceutil/trace.go:171","msg":"trace[1962049748] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:611; }","duration":"2.501442946s","start":"2026-04-02T22:28:03.902794Z","end":"2026-04-02T22:28:06.404237Z","steps":["trace[1962049748] 'agreement among raft nodes before linearized reading' (duration: 2.501381135s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:06.404033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.747535376s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:28:06.404555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.584063279s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:28:06.404703Z","caller":"traceutil/trace.go:171","msg":"trace[661479344] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:611; }","duration":"2.748662079s","start":"2026-04-02T22:28:03.655962Z","end":"2026-04-02T22:28:06.404624Z","steps":["trace[661479344] 'agreement among raft nodes before linearized reading' (duration: 2.747390482s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:06.404788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.655929Z","time spent":"2.748843223s","remote":"127.0.0.1:59896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"info","ts":"2026-04-02T22:28:06.404153Z","caller":"traceutil/trace.go:171","msg":"trace[360616971] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:611; }","duration":"2.501265933s","start":"2026-04-02T22:28:03.902874Z","end":"2026-04-02T22:28:06.40414Z","steps":["trace[360616971] 'agreement among raft nodes before linearized reading' (duration: 2.501200031s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:06.405392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.902844Z","time spent":"2.502529129s","remote":"127.0.0.1:59928","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":"info","ts":"2026-04-02T22:28:06.404042Z","caller":"traceutil/trace.go:171","msg":"trace[659943546] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:611; }","duration":"2.520080016s","start":"2026-04-02T22:28:03.883945Z","end":"2026-04-02T22:28:06.404025Z","steps":["trace[659943546] 'agreement among raft nodes before linearized reading' (duration: 2.519973754s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:06.405666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.88394Z","time spent":"2.521709231s","remote":"127.0.0.1:59916","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":"info","ts":"2026-04-02T22:28:06.402972Z","caller":"traceutil/trace.go:171","msg":"trace[1808814934] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"2.564830246s","start":"2026-04-02T22:28:03.838113Z","end":"2026-04-02T22:28:06.402943Z","steps":["trace[1808814934] 'process raft request' (duration: 2.564374836s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:06.405904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.838092Z","time spent":"2.567745308s","remote":"127.0.0.1:43016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T22:28:06.404301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.902777Z","time spent":"2.501509638s","remote":"127.0.0.1:59928","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":"info","ts":"2026-04-02T22:28:06.403922Z","caller":"traceutil/trace.go:171","msg":"trace[1393410506] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:611; }","duration":"2.484391141s","start":"2026-04-02T22:28:03.91951Z","end":"2026-04-02T22:28:06.403901Z","steps":["trace[1393410506] 'agreement among raft nodes before linearized reading' (duration: 2.484287509s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:06.406127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.919497Z","time spent":"2.486610257s","remote":"127.0.0.1:59928","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:28:06.402624Z","caller":"traceutil/trace.go:171","msg":"trace[1592664851] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"2.399535009s","start":"2026-04-02T22:28:04.003071Z","end":"2026-04-02T22:28:06.402606Z","steps":["trace[1592664851] 'process raft request' (duration: 2.399454548s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:06.406266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:04.003051Z","time spent":"2.403181098s","remote":"127.0.0.1:42956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":818,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T22:28:06.403674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.768722Z","time spent":"2.634939671s","remote":"127.0.0.1:59904","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":"info","ts":"2026-04-02T22:28:06.403774Z","caller":"traceutil/trace.go:171","msg":"trace[1818195317] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:611; }","duration":"2.634878519s","start":"2026-04-02T22:28:03.768883Z","end":"2026-04-02T22:28:06.403762Z","steps":["trace[1818195317] 'agreement among raft nodes before linearized reading' (duration: 2.634815997s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:06.406651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.768847Z","time spent":"2.637785701s","remote":"127.0.0.1:59904","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":"info","ts":"2026-04-02T22:28:06.40374Z","caller":"traceutil/trace.go:171","msg":"trace[274702769] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:611; }","duration":"2.634274106s","start":"2026-04-02T22:28:03.769444Z","end":"2026-04-02T22:28:06.403718Z","steps":["trace[274702769] 'agreement among raft nodes before linearized reading' (duration: 2.634092452s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:06.40692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.769439Z","time spent":"2.637455515s","remote":"127.0.0.1:59904","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":"info","ts":"2026-04-02T22:28:06.403997Z","caller":"traceutil/trace.go:171","msg":"trace[42488484] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:611; }","duration":"2.619546379s","start":"2026-04-02T22:28:03.784435Z","end":"2026-04-02T22:28:06.403981Z","steps":["trace[42488484] 'agreement among raft nodes before linearized reading' (duration: 2.619376086s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:06.407276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.784423Z","time spent":"2.62283383s","remote":"127.0.0.1:59906","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:28:06.404342Z","caller":"traceutil/trace.go:171","msg":"trace[1924706348] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:611; }","duration":"2.521151489s","start":"2026-04-02T22:28:03.883076Z","end":"2026-04-02T22:28:06.404228Z","steps":["trace[1924706348] 'agreement among raft nodes before linearized reading' (duration: 2.521076207s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:06.404382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.791481989s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:28:06.404389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.521297962s","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":"warn","ts":"2026-04-02T22:28:06.404174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.583353223s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:28:06.404436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.792327597s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:28:06.404425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.880297923s","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:28:06.404482Z","caller":"traceutil/trace.go:171","msg":"trace[1467279152] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:611; }","duration":"2.748786542s","start":"2026-04-02T22:28:03.655681Z","end":"2026-04-02T22:28:06.404467Z","steps":["trace[1467279152] 'agreement among raft nodes before linearized reading' (duration: 2.748012235s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:06.404485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.79247694s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:28:06.40447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.733432863s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:28:06.404491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.732927863s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:28:06.404558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.73379263s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:28:06.407711Z","caller":"traceutil/trace.go:171","msg":"trace[645469280] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:611; }","duration":"2.586981291s","start":"2026-04-02T22:28:03.820714Z","end":"2026-04-02T22:28:06.407695Z","steps":["trace[645469280] 'agreement among raft nodes before linearized reading' (duration: 2.583358273s)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:28:06.407868Z","caller":"traceutil/trace.go:171","msg":"trace[338153606] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:611; }","duration":"2.795800761s","start":"2026-04-02T22:28:03.612059Z","end":"2026-04-02T22:28:06.407859Z","steps":["trace[338153606] 'agreement among raft nodes before linearized reading' (duration: 2.792354358s)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:28:06.407882Z","caller":"traceutil/trace.go:171","msg":"trace[183095748] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:611; }","duration":"2.795890133s","start":"2026-04-02T22:28:03.611981Z","end":"2026-04-02T22:28:06.407871Z","steps":["trace[183095748] 'agreement among raft nodes before linearized reading' (duration: 2.792476799s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:06.407909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.61203Z","time spent":"2.795868422s","remote":"127.0.0.1:59884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"info","ts":"2026-04-02T22:28:06.4079Z","caller":"traceutil/trace.go:171","msg":"trace[1416428017] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:611; }","duration":"2.736872237s","start":"2026-04-02T22:28:03.670999Z","end":"2026-04-02T22:28:06.407871Z","steps":["trace[1416428017] 'agreement among raft nodes before linearized reading' (duration: 2.733429093s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:06.407929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.611968Z","time spent":"2.795943204s","remote":"127.0.0.1:59884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-02T22:28:06.407975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.67098Z","time spent":"2.736967029s","remote":"127.0.0.1:59902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"info","ts":"2026-04-02T22:28:06.40801Z","caller":"traceutil/trace.go:171","msg":"trace[1037619209] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:611; }","duration":"2.736468158s","start":"2026-04-02T22:28:03.671533Z","end":"2026-04-02T22:28:06.408001Z","steps":["trace[1037619209] 'agreement among raft nodes before linearized reading' (duration: 2.732905672s)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:28:06.407727Z","caller":"traceutil/trace.go:171","msg":"trace[2052458544] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:611; }","duration":"2.794839681s","start":"2026-04-02T22:28:03.61287Z","end":"2026-04-02T22:28:06.407709Z","steps":["trace[2052458544] 'agreement among raft nodes before linearized reading' (duration: 2.791467139s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:06.408101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.612864Z","time spent":"2.795223319s","remote":"127.0.0.1:59884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-02T22:28:06.407981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.820689Z","time spent":"2.587199956s","remote":"127.0.0.1:59910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-04-02T22:28:06.407756Z","caller":"traceutil/trace.go:171","msg":"trace[59391277] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:611; }","duration":"2.524692815s","start":"2026-04-02T22:28:03.88305Z","end":"2026-04-02T22:28:06.407743Z","steps":["trace[59391277] 'agreement among raft nodes before linearized reading' (duration: 2.521307092s)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:28:06.408175Z","caller":"traceutil/trace.go:171","msg":"trace[1278654638] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:611; }","duration":"2.737414059s","start":"2026-04-02T22:28:03.670744Z","end":"2026-04-02T22:28:06.408158Z","steps":["trace[1278654638] 'agreement among raft nodes before linearized reading' (duration: 2.733792261s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:06.408212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.883025Z","time spent":"2.525173914s","remote":"127.0.0.1:59916","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:28:06.408234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.670734Z","time spent":"2.73748118s","remote":"127.0.0.1:59902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-02T22:28:06.407776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.883064Z","time spent":"2.524695935s","remote":"127.0.0.1:59916","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:28:06.408044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.671526Z","time spent":"2.736508869s","remote":"127.0.0.1:59896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 "} {"level":"info","ts":"2026-04-02T22:28:06.408196Z","caller":"traceutil/trace.go:171","msg":"trace[1491467379] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:611; }","duration":"2.884182486s","start":"2026-04-02T22:28:03.523989Z","end":"2026-04-02T22:28:06.408172Z","steps":["trace[1491467379] 'agreement among raft nodes before linearized reading' (duration: 2.880221851s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:06.40781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.655662Z","time spent":"2.752139304s","remote":"127.0.0.1:59896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"info","ts":"2026-04-02T22:28:06.40466Z","caller":"traceutil/trace.go:171","msg":"trace[1394551062] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:611; }","duration":"2.584186892s","start":"2026-04-02T22:28:03.820454Z","end":"2026-04-02T22:28:06.40464Z","steps":["trace[1394551062] 'agreement among raft nodes before linearized reading' (duration: 2.583975568s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:06.408966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.820441Z","time spent":"2.588490734s","remote":"127.0.0.1:59910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-02T22:28:06.408751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.523965Z","time spent":"2.884468992s","remote":"127.0.0.1:59868","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:28:06.697636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000689835s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-02T22:28:06.697715Z","caller":"traceutil/trace.go:171","msg":"trace[1767848516] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000810688s","start":"2026-04-02T22:28:04.696887Z","end":"2026-04-02T22:28:06.697698Z","steps":["trace[1767848516] 'agreement among raft nodes before linearized reading' (duration: 2.000709996s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:06.69777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:04.69687Z","time spent":"2.00088484s","remote":"127.0.0.1:42758","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/02 22:28:06 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-02T22:28:06.903576Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10125953780435733842,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-02T22:28:06.914146Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.724109981s","expected-duration":"1s"} {"level":"info","ts":"2026-04-02T22:28:06.915915Z","caller":"traceutil/trace.go:171","msg":"trace[466910782] linearizableReadLoop","detail":"{readStateIndex:636; appliedIndex:635; }","duration":"512.621922ms","start":"2026-04-02T22:28:06.403266Z","end":"2026-04-02T22:28:06.915888Z","steps":["trace[466910782] 'read index received' (duration: 511.042919ms)","trace[466910782] 'applied index is now lower than readState.Index' (duration: 1.577933ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:28:06.916075Z","caller":"traceutil/trace.go:171","msg":"trace[1389521198] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"1.726122665s","start":"2026-04-02T22:28:05.189936Z","end":"2026-04-02T22:28:06.916059Z","steps":["trace[1389521198] 'process raft request' (duration: 1.724441318s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:06.916199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.936754571s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:28:06.91623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:05.189911Z","time spent":"1.726218707s","remote":"127.0.0.1:43016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T22:28:06.916252Z","caller":"traceutil/trace.go:171","msg":"trace[1003050595] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:612; }","duration":"2.936823252s","start":"2026-04-02T22:28:03.979416Z","end":"2026-04-02T22:28:06.916239Z","steps":["trace[1003050595] 'agreement among raft nodes before linearized reading' (duration: 2.93672596s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:06.916288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.979411Z","time spent":"2.936868073s","remote":"127.0.0.1:59948","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:28:06.9163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.97450713s","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:28:06.916208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.949539094s","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:28:06.916404Z","caller":"traceutil/trace.go:171","msg":"trace[1237197321] 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:612; }","duration":"2.974707044s","start":"2026-04-02T22:28:03.941678Z","end":"2026-04-02T22:28:06.916385Z","steps":["trace[1237197321] 'agreement among raft nodes before linearized reading' (duration: 2.97450201s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:06.916487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.94982075s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:28:06.916534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.941662Z","time spent":"2.974822207s","remote":"127.0.0.1:59930","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:28:06.916552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.661074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:28:06.916578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.544745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:28:06.916581Z","caller":"traceutil/trace.go:171","msg":"trace[1941154363] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:612; }","duration":"2.949992974s","start":"2026-04-02T22:28:03.966572Z","end":"2026-04-02T22:28:06.916565Z","steps":["trace[1941154363] 'agreement among raft nodes before linearized reading' (duration: 2.94983486s)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:28:06.916456Z","caller":"traceutil/trace.go:171","msg":"trace[359923476] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:612; }","duration":"2.949787379s","start":"2026-04-02T22:28:03.966648Z","end":"2026-04-02T22:28:06.916435Z","steps":["trace[359923476] 'agreement among raft nodes before linearized reading' (duration: 2.949443472s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:06.916767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.966629Z","time spent":"2.950111416s","remote":"127.0.0.1:59946","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:28:06.916338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.974002529s","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:28:06.916898Z","caller":"traceutil/trace.go:171","msg":"trace[196696781] 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:612; }","duration":"2.974595381s","start":"2026-04-02T22:28:03.942286Z","end":"2026-04-02T22:28:06.916882Z","steps":["trace[196696781] 'agreement among raft nodes before linearized reading' (duration: 2.973950278s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:06.917007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.942272Z","time spent":"2.974714955s","remote":"127.0.0.1:59930","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":"warn","ts":"2026-04-02T22:28:06.916689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.966549Z","time spent":"2.950119197s","remote":"127.0.0.1:59946","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:28:06.916013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.936679558s","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:28:06.917337Z","caller":"traceutil/trace.go:171","msg":"trace[1206435526] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:612; }","duration":"2.938006477s","start":"2026-04-02T22:28:03.979276Z","end":"2026-04-02T22:28:06.917282Z","steps":["trace[1206435526] 'agreement among raft nodes before linearized reading' (duration: 2.936640237s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:06.917408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.979264Z","time spent":"2.938122469s","remote":"127.0.0.1:59948","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":"info","ts":"2026-04-02T22:28:06.9166Z","caller":"traceutil/trace.go:171","msg":"trace[1154144684] range","detail":"{range_begin:/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:612; }","duration":"499.708495ms","start":"2026-04-02T22:28:06.416877Z","end":"2026-04-02T22:28:06.916585Z","steps":["trace[1154144684] 'agreement among raft nodes before linearized reading' (duration: 499.632494ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:06.917574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:06.416849Z","time spent":"500.711857ms","remote":"127.0.0.1:43076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":0,"response size":28,"request content":"key:\"/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-04-02T22:28:06.916374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"994.170837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.23\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-02T22:28:06.917673Z","caller":"traceutil/trace.go:171","msg":"trace[1298485820] range","detail":"{range_begin:/registry/masterleases/199.204.45.23; range_end:; response_count:1; response_revision:612; }","duration":"995.506056ms","start":"2026-04-02T22:28:05.922149Z","end":"2026-04-02T22:28:06.917655Z","steps":["trace[1298485820] 'agreement among raft nodes before linearized reading' (duration: 994.138477ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:06.917778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:05.922127Z","time spent":"995.631908ms","remote":"127.0.0.1:42784","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.23\" "} {"level":"warn","ts":"2026-04-02T22:28:06.916449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.974180383s","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:28:06.916609Z","caller":"traceutil/trace.go:171","msg":"trace[543935989] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:612; }","duration":"218.622286ms","start":"2026-04-02T22:28:06.697977Z","end":"2026-04-02T22:28:06.916599Z","steps":["trace[543935989] 'agreement among raft nodes before linearized reading' (duration: 218.577585ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:06.916696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.936904883s","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:28:06.917917Z","caller":"traceutil/trace.go:171","msg":"trace[485799200] 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:612; }","duration":"2.975652714s","start":"2026-04-02T22:28:03.942249Z","end":"2026-04-02T22:28:06.917902Z","steps":["trace[485799200] 'agreement among raft nodes before linearized reading' (duration: 2.974178913s)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:28:06.917884Z","caller":"traceutil/trace.go:171","msg":"trace[1961179970] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:612; }","duration":"2.938113919s","start":"2026-04-02T22:28:03.979754Z","end":"2026-04-02T22:28:06.917868Z","steps":["trace[1961179970] 'agreement among raft nodes before linearized reading' (duration: 2.936910974s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:06.917966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.942204Z","time spent":"2.975749476s","remote":"127.0.0.1:59930","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:28:06.918022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:03.97971Z","time spent":"2.938255222s","remote":"127.0.0.1:59946","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":"info","ts":"2026-04-02T22:28:07.538405Z","caller":"traceutil/trace.go:171","msg":"trace[1040697349] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"159.169451ms","start":"2026-04-02T22:28:07.379212Z","end":"2026-04-02T22:28:07.538381Z","steps":["trace[1040697349] 'process raft request' (duration: 159.038178ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:08.745612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.978226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-04-02T22:28:08.745722Z","caller":"traceutil/trace.go:171","msg":"trace[1331618072] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:626; }","duration":"337.11794ms","start":"2026-04-02T22:28:08.408581Z","end":"2026-04-02T22:28:08.745699Z","steps":["trace[1331618072] 'range keys from in-memory index tree' (duration: 336.819933ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:08.745776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:08.408569Z","time spent":"337.192791ms","remote":"127.0.0.1:43016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-02T22:28:08.745852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.181907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-02T22:28:08.745944Z","caller":"traceutil/trace.go:171","msg":"trace[1669704103] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:626; }","duration":"334.282738ms","start":"2026-04-02T22:28:08.411626Z","end":"2026-04-02T22:28:08.745909Z","steps":["trace[1669704103] 'range keys from in-memory index tree' (duration: 334.058904ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:08.745989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:08.411619Z","time spent":"334.36157ms","remote":"127.0.0.1:43016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-02T22:28:08.746007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.388465ms","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:28:08.74609Z","caller":"traceutil/trace.go:171","msg":"trace[962676165] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:626; }","duration":"337.509928ms","start":"2026-04-02T22:28:08.408559Z","end":"2026-04-02T22:28:08.746069Z","steps":["trace[962676165] 'range keys from in-memory index tree' (duration: 337.199952ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:08.746108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.610674ms","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:28:08.746136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:08.40854Z","time spent":"337.586569ms","remote":"127.0.0.1:43016","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:28:08.746623Z","caller":"traceutil/trace.go:171","msg":"trace[2000778589] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:626; }","duration":"333.758086ms","start":"2026-04-02T22:28:08.412431Z","end":"2026-04-02T22:28:08.746189Z","steps":["trace[2000778589] 'range keys from in-memory index tree' (duration: 333.259466ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:08.746704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:08.412422Z","time spent":"334.266257ms","remote":"127.0.0.1:43016","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:28:08.752749Z","caller":"traceutil/trace.go:171","msg":"trace[1761930061] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"309.914954ms","start":"2026-04-02T22:28:08.442806Z","end":"2026-04-02T22:28:08.752721Z","steps":["trace[1761930061] 'process raft request' (duration: 309.353802ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:08.752853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:08.442787Z","time spent":"310.009705ms","remote":"127.0.0.1:42836","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036229,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T22:28:11.879025Z","caller":"traceutil/trace.go:171","msg":"trace[1997500437] transaction","detail":"{read_only:false; response_revision:696; number_of_response:1; }","duration":"157.771727ms","start":"2026-04-02T22:28:11.721211Z","end":"2026-04-02T22:28:11.878982Z","steps":["trace[1997500437] 'process raft request' (duration: 154.1886ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:28:12.086854Z","caller":"traceutil/trace.go:171","msg":"trace[458417387] transaction","detail":"{read_only:false; response_revision:697; number_of_response:1; }","duration":"192.78582ms","start":"2026-04-02T22:28:11.894034Z","end":"2026-04-02T22:28:12.08682Z","steps":["trace[458417387] 'process raft request' (duration: 137.719885ms)","trace[458417387] 'compare' (duration: 54.865501ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:28:12.361407Z","caller":"traceutil/trace.go:171","msg":"trace[205928951] transaction","detail":"{read_only:false; response_revision:699; number_of_response:1; }","duration":"259.659441ms","start":"2026-04-02T22:28:12.101704Z","end":"2026-04-02T22:28:12.361363Z","steps":["trace[205928951] 'process raft request' (duration: 259.016927ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:28:12.536512Z","caller":"traceutil/trace.go:171","msg":"trace[26674903] transaction","detail":"{read_only:false; response_revision:700; number_of_response:1; }","duration":"305.525399ms","start":"2026-04-02T22:28:12.230962Z","end":"2026-04-02T22:28:12.536487Z","steps":["trace[26674903] 'process raft request' (duration: 295.787889ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:12.536671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:12.230936Z","time spent":"305.672012ms","remote":"127.0.0.1:42794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23277,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T22:28:12.669395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.062156ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-02T22:28:12.740109Z","caller":"traceutil/trace.go:171","msg":"trace[1906300194] transaction","detail":"{read_only:false; response_revision:701; number_of_response:1; }","duration":"284.810423ms","start":"2026-04-02T22:28:12.455273Z","end":"2026-04-02T22:28:12.740084Z","steps":["trace[1906300194] 'process raft request' (duration: 284.528576ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:28:12.838391Z","caller":"traceutil/trace.go:171","msg":"trace[916874652] linearizableReadLoop","detail":"{readStateIndex:728; appliedIndex:726; }","duration":"213.413357ms","start":"2026-04-02T22:28:12.624952Z","end":"2026-04-02T22:28:12.838365Z","steps":["trace[916874652] 'read index received' (duration: 114.901324ms)","trace[916874652] 'applied index is now lower than readState.Index' (duration: 98.510833ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:28:12.838535Z","caller":"traceutil/trace.go:171","msg":"trace[2038481698] transaction","detail":"{read_only:false; response_revision:702; number_of_response:1; }","duration":"286.598633ms","start":"2026-04-02T22:28:12.551877Z","end":"2026-04-02T22:28:12.838476Z","steps":["trace[2038481698] 'process raft request' (duration: 285.956618ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:12.838688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.695733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:1 size:9320"} {"level":"info","ts":"2026-04-02T22:28:12.838745Z","caller":"traceutil/trace.go:171","msg":"trace[1942668742] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:1; response_revision:702; }","duration":"213.799605ms","start":"2026-04-02T22:28:12.624932Z","end":"2026-04-02T22:28:12.838732Z","steps":["trace[1942668742] 'agreement among raft nodes before linearized reading' (duration: 213.582161ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:28:13.149129Z","caller":"traceutil/trace.go:171","msg":"trace[1688843902] transaction","detail":"{read_only:false; response_revision:704; number_of_response:1; }","duration":"305.821738ms","start":"2026-04-02T22:28:12.843283Z","end":"2026-04-02T22:28:13.149105Z","steps":["trace[1688843902] 'process raft request' (duration: 305.553281ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:13.14934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:12.843252Z","time spent":"305.952741ms","remote":"127.0.0.1:43016","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:28:13.149502Z","caller":"traceutil/trace.go:171","msg":"trace[772060992] transaction","detail":"{read_only:false; response_revision:705; number_of_response:1; }","duration":"305.056591ms","start":"2026-04-02T22:28:12.844421Z","end":"2026-04-02T22:28:13.149478Z","steps":["trace[772060992] 'process raft request' (duration: 304.58738ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:13.149654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:12.844413Z","time spent":"305.153464ms","remote":"127.0.0.1:43016","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:28:13.150306Z","caller":"traceutil/trace.go:171","msg":"trace[297839053] transaction","detail":"{read_only:false; response_revision:706; number_of_response:1; }","duration":"305.822287ms","start":"2026-04-02T22:28:12.844471Z","end":"2026-04-02T22:28:13.150293Z","steps":["trace[297839053] 'process raft request' (duration: 304.893987ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:13.150394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:12.844464Z","time spent":"305.885548ms","remote":"127.0.0.1:43016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T22:28:13.150869Z","caller":"traceutil/trace.go:171","msg":"trace[1983875419] transaction","detail":"{read_only:false; response_revision:708; number_of_response:1; }","duration":"280.3954ms","start":"2026-04-02T22:28:12.870463Z","end":"2026-04-02T22:28:13.150858Z","steps":["trace[1983875419] 'process raft request' (duration: 280.219086ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:28:13.151122Z","caller":"traceutil/trace.go:171","msg":"trace[1484006611] transaction","detail":"{read_only:false; response_revision:707; number_of_response:1; }","duration":"288.097045ms","start":"2026-04-02T22:28:12.863013Z","end":"2026-04-02T22:28:13.15111Z","steps":["trace[1484006611] 'process raft request' (duration: 287.189156ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:28:13.190364Z","caller":"traceutil/trace.go:171","msg":"trace[832217109] transaction","detail":"{read_only:false; response_revision:709; number_of_response:1; }","duration":"298.789765ms","start":"2026-04-02T22:28:12.89154Z","end":"2026-04-02T22:28:13.19033Z","steps":["trace[832217109] 'process raft request' (duration: 298.53462ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:28:13.190937Z","caller":"traceutil/trace.go:171","msg":"trace[429791641] linearizableReadLoop","detail":"{readStateIndex:736; appliedIndex:729; }","duration":"166.146389ms","start":"2026-04-02T22:28:13.024767Z","end":"2026-04-02T22:28:13.190913Z","steps":["trace[429791641] 'read index received' (duration: 123.719035ms)","trace[429791641] 'applied index is now lower than readState.Index' (duration: 42.426254ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:28:13.191239Z","caller":"traceutil/trace.go:171","msg":"trace[984714713] transaction","detail":"{read_only:false; response_revision:710; number_of_response:1; }","duration":"275.137398ms","start":"2026-04-02T22:28:12.916087Z","end":"2026-04-02T22:28:13.191225Z","steps":["trace[984714713] 'process raft request' (duration: 274.29084ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:13.191605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.827855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:1 size:13229"} {"level":"info","ts":"2026-04-02T22:28:13.191732Z","caller":"traceutil/trace.go:171","msg":"trace[1207744902] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:1; response_revision:710; }","duration":"167.003458ms","start":"2026-04-02T22:28:13.024712Z","end":"2026-04-02T22:28:13.191715Z","steps":["trace[1207744902] 'agreement among raft nodes before linearized reading' (duration: 166.62565ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:13.191961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.806212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-04-02T22:28:13.192067Z","caller":"traceutil/trace.go:171","msg":"trace[1118786679] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:710; }","duration":"152.946415ms","start":"2026-04-02T22:28:13.039066Z","end":"2026-04-02T22:28:13.192012Z","steps":["trace[1118786679] 'agreement among raft nodes before linearized reading' (duration: 152.629968ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:28:25.128539Z","caller":"traceutil/trace.go:171","msg":"trace[243903451] linearizableReadLoop","detail":"{readStateIndex:821; appliedIndex:820; }","duration":"466.263046ms","start":"2026-04-02T22:28:24.662256Z","end":"2026-04-02T22:28:25.128519Z","steps":["trace[243903451] 'read index received' (duration: 466.028781ms)","trace[243903451] 'applied index is now lower than readState.Index' (duration: 233.575µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:28:25.128577Z","caller":"traceutil/trace.go:171","msg":"trace[1439939548] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"957.38851ms","start":"2026-04-02T22:28:24.171157Z","end":"2026-04-02T22:28:25.128545Z","steps":["trace[1439939548] 'process raft request' (duration: 957.172975ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:25.128721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.449921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:28:25.128738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:24.17113Z","time spent":"957.529973ms","remote":"127.0.0.1:42996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T22:28:25.128798Z","caller":"traceutil/trace.go:171","msg":"trace[77234778] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:792; }","duration":"466.579183ms","start":"2026-04-02T22:28:24.662201Z","end":"2026-04-02T22:28:25.12878Z","steps":["trace[77234778] 'agreement among raft nodes before linearized reading' (duration: 466.429509ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:25.128839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.891723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-02T22:28:25.128866Z","caller":"traceutil/trace.go:171","msg":"trace[152723802] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:792; }","duration":"149.946374ms","start":"2026-04-02T22:28:24.97891Z","end":"2026-04-02T22:28:25.128857Z","steps":["trace[152723802] 'agreement among raft nodes before linearized reading' (duration: 149.860382ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:25.128855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:28:24.662178Z","time spent":"466.661575ms","remote":"127.0.0.1:43216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":28,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "} {"level":"warn","ts":"2026-04-02T22:28:25.128742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.532448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:28:25.128957Z","caller":"traceutil/trace.go:171","msg":"trace[1306743548] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:792; }","duration":"163.817385ms","start":"2026-04-02T22:28:24.965098Z","end":"2026-04-02T22:28:25.128915Z","steps":["trace[1306743548] 'agreement among raft nodes before linearized reading' (duration: 163.539769ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:28:35.418545Z","caller":"traceutil/trace.go:171","msg":"trace[2068527921] linearizableReadLoop","detail":"{readStateIndex:971; appliedIndex:969; }","duration":"105.197693ms","start":"2026-04-02T22:28:35.313332Z","end":"2026-04-02T22:28:35.41853Z","steps":["trace[2068527921] 'read index received' (duration: 41.679405ms)","trace[2068527921] 'applied index is now lower than readState.Index' (duration: 63.517598ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:28:35.418669Z","caller":"traceutil/trace.go:171","msg":"trace[518219202] transaction","detail":"{read_only:false; response_revision:939; number_of_response:1; }","duration":"106.232926ms","start":"2026-04-02T22:28:35.3124Z","end":"2026-04-02T22:28:35.418633Z","steps":["trace[518219202] 'process raft request' (duration: 56.68069ms)","trace[518219202] 'compare' (duration: 49.388462ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:28:35.418738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.222794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-02T22:28:35.418789Z","caller":"traceutil/trace.go:171","msg":"trace[49802184] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:939; }","duration":"105.286675ms","start":"2026-04-02T22:28:35.313491Z","end":"2026-04-02T22:28:35.418778Z","steps":["trace[49802184] 'agreement among raft nodes before linearized reading' (duration: 105.179342ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:35.418917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.376117ms","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:28:35.418966Z","caller":"traceutil/trace.go:171","msg":"trace[1691654707] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:939; }","duration":"105.636593ms","start":"2026-04-02T22:28:35.313317Z","end":"2026-04-02T22:28:35.418953Z","steps":["trace[1691654707] 'agreement among raft nodes before linearized reading' (duration: 105.311847ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:28:35.596273Z","caller":"traceutil/trace.go:171","msg":"trace[1593229191] transaction","detail":"{read_only:false; response_revision:941; number_of_response:1; }","duration":"173.553927ms","start":"2026-04-02T22:28:35.42268Z","end":"2026-04-02T22:28:35.596234Z","steps":["trace[1593229191] 'process raft request' (duration: 167.685649ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:28:35.801185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.640717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:28:35.801268Z","caller":"traceutil/trace.go:171","msg":"trace[514125130] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:941; }","duration":"101.809ms","start":"2026-04-02T22:28:35.699441Z","end":"2026-04-02T22:28:35.80125Z","steps":["trace[514125130] 'range keys from in-memory index tree' (duration: 101.526454ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:29:07.710534Z","caller":"traceutil/trace.go:171","msg":"trace[578596311] transaction","detail":"{read_only:false; response_revision:1067; number_of_response:1; }","duration":"121.487625ms","start":"2026-04-02T22:29:07.589013Z","end":"2026-04-02T22:29:07.710501Z","steps":["trace[578596311] 'process raft request' (duration: 114.925412ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:29:30.128709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.004552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-02T22:29:30.128731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.875151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-02T22:29:30.128796Z","caller":"traceutil/trace.go:171","msg":"trace[1063201254] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1139; }","duration":"162.131665ms","start":"2026-04-02T22:29:29.966646Z","end":"2026-04-02T22:29:30.128777Z","steps":["trace[1063201254] 'range keys from in-memory index tree' (duration: 161.812697ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:29:30.128824Z","caller":"traceutil/trace.go:171","msg":"trace[1089766405] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1139; }","duration":"116.013454ms","start":"2026-04-02T22:29:30.01279Z","end":"2026-04-02T22:29:30.128804Z","steps":["trace[1089766405] 'range keys from in-memory index tree' (duration: 115.692257ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:29:30.23864Z","caller":"traceutil/trace.go:171","msg":"trace[1904340379] transaction","detail":"{read_only:false; response_revision:1140; number_of_response:1; }","duration":"105.844611ms","start":"2026-04-02T22:29:30.132776Z","end":"2026-04-02T22:29:30.23862Z","steps":["trace[1904340379] 'process raft request' (duration: 105.724929ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:29:30.479384Z","caller":"traceutil/trace.go:171","msg":"trace[1068070704] linearizableReadLoop","detail":"{readStateIndex:1185; appliedIndex:1184; }","duration":"310.11932ms","start":"2026-04-02T22:29:30.169238Z","end":"2026-04-02T22:29:30.479357Z","steps":["trace[1068070704] 'read index received' (duration: 69.507204ms)","trace[1068070704] 'applied index is now lower than readState.Index' (duration: 240.611006ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:29:30.479475Z","caller":"traceutil/trace.go:171","msg":"trace[1363855166] transaction","detail":"{read_only:false; response_revision:1141; number_of_response:1; }","duration":"345.654788ms","start":"2026-04-02T22:29:30.133751Z","end":"2026-04-02T22:29:30.479406Z","steps":["trace[1363855166] 'process raft request' (duration: 285.814036ms)","trace[1363855166] 'compare' (duration: 59.565366ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:29:30.479645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:29:30.133728Z","time spent":"345.818452ms","remote":"127.0.0.1:43016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T22:29:30.479645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.385615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-02T22:29:30.479725Z","caller":"traceutil/trace.go:171","msg":"trace[1233679695] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1141; }","duration":"310.515098ms","start":"2026-04-02T22:29:30.169187Z","end":"2026-04-02T22:29:30.479702Z","steps":["trace[1233679695] 'agreement among raft nodes before linearized reading' (duration: 310.264363ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:29:30.479765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:29:30.169167Z","time spent":"310.589499ms","remote":"127.0.0.1:43016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-02T22:29:51.445362Z","caller":"traceutil/trace.go:171","msg":"trace[535563705] transaction","detail":"{read_only:false; response_revision:1210; number_of_response:1; }","duration":"102.223196ms","start":"2026-04-02T22:29:51.343113Z","end":"2026-04-02T22:29:51.445336Z","steps":["trace[535563705] 'process raft request' (duration: 102.014501ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:29:53.562247Z","caller":"traceutil/trace.go:171","msg":"trace[1383262826] transaction","detail":"{read_only:false; response_revision:1216; number_of_response:1; }","duration":"110.339335ms","start":"2026-04-02T22:29:53.451881Z","end":"2026-04-02T22:29:53.56222Z","steps":["trace[1383262826] 'process raft request' (duration: 110.168352ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:29:54.886107Z","caller":"traceutil/trace.go:171","msg":"trace[745335058] transaction","detail":"{read_only:false; response_revision:1221; number_of_response:1; }","duration":"126.576941ms","start":"2026-04-02T22:29:54.759507Z","end":"2026-04-02T22:29:54.886084Z","steps":["trace[745335058] 'process raft request' (duration: 28.285021ms)","trace[745335058] 'compare' (duration: 98.186958ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:29:57.288434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.785905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/default/\" range_end:\"/registry/limitranges/default0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:29:57.288524Z","caller":"traceutil/trace.go:171","msg":"trace[1684023439] range","detail":"{range_begin:/registry/limitranges/default/; range_end:/registry/limitranges/default0; response_count:0; response_revision:1228; }","duration":"251.920777ms","start":"2026-04-02T22:29:57.036579Z","end":"2026-04-02T22:29:57.2885Z","steps":["trace[1684023439] 'range keys from in-memory index tree' (duration: 251.678432ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:30:07.136492Z","caller":"traceutil/trace.go:171","msg":"trace[210251429] linearizableReadLoop","detail":"{readStateIndex:1345; appliedIndex:1344; }","duration":"129.923867ms","start":"2026-04-02T22:30:07.006544Z","end":"2026-04-02T22:30:07.136468Z","steps":["trace[210251429] 'read index received' (duration: 129.725712ms)","trace[210251429] 'applied index is now lower than readState.Index' (duration: 197.305µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:30:07.136764Z","caller":"traceutil/trace.go:171","msg":"trace[749238883] transaction","detail":"{read_only:false; response_revision:1292; number_of_response:1; }","duration":"395.760384ms","start":"2026-04-02T22:30:06.740988Z","end":"2026-04-02T22:30:07.136749Z","steps":["trace[749238883] 'process raft request' (duration: 395.340245ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:30:07.136832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.273316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-02T22:30:07.136863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:30:06.740976Z","time spent":"395.832656ms","remote":"127.0.0.1:43016","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:30:07.136891Z","caller":"traceutil/trace.go:171","msg":"trace[970543307] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1292; }","duration":"130.388828ms","start":"2026-04-02T22:30:07.00648Z","end":"2026-04-02T22:30:07.136869Z","steps":["trace[970543307] 'agreement among raft nodes before linearized reading' (duration: 130.210944ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:30:07.137077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.138454ms","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:7"} {"level":"info","ts":"2026-04-02T22:30:07.137209Z","caller":"traceutil/trace.go:171","msg":"trace[1543706547] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1292; }","duration":"126.344939ms","start":"2026-04-02T22:30:07.010838Z","end":"2026-04-02T22:30:07.137183Z","steps":["trace[1543706547] 'agreement among raft nodes before linearized reading' (duration: 126.069713ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:30:07.381973Z","caller":"traceutil/trace.go:171","msg":"trace[591792133] transaction","detail":"{read_only:false; response_revision:1293; number_of_response:1; }","duration":"241.89334ms","start":"2026-04-02T22:30:07.140047Z","end":"2026-04-02T22:30:07.381941Z","steps":["trace[591792133] 'process raft request' (duration: 239.686742ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:30:11.947256Z","caller":"traceutil/trace.go:171","msg":"trace[228933874] transaction","detail":"{read_only:false; response_revision:1312; number_of_response:1; }","duration":"127.000895ms","start":"2026-04-02T22:30:11.820223Z","end":"2026-04-02T22:30:11.947223Z","steps":["trace[228933874] 'process raft request' (duration: 92.907574ms)","trace[228933874] 'compare' (duration: 33.949998ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:30:14.415066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.379835ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T22:30:14.415146Z","caller":"traceutil/trace.go:171","msg":"trace[332837356] linearizableReadLoop","detail":"{readStateIndex:1374; appliedIndex:1373; }","duration":"109.274895ms","start":"2026-04-02T22:30:14.305857Z","end":"2026-04-02T22:30:14.415132Z","steps":["trace[332837356] 'read index received' (duration: 40.011µs)","trace[332837356] 'applied index is now lower than readState.Index' (duration: 109.233954ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:30:14.415328Z","caller":"traceutil/trace.go:171","msg":"trace[1214107409] transaction","detail":"{read_only:false; response_revision:1320; number_of_response:1; }","duration":"461.887994ms","start":"2026-04-02T22:30:13.953431Z","end":"2026-04-02T22:30:14.415319Z","steps":["trace[1214107409] 'process raft request' (duration: 44.167182ms)","trace[1214107409] 'compare' (duration: 417.296413ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:30:14.415375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:30:13.953403Z","time spent":"461.946036ms","remote":"127.0.0.1:43016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T22:30:14.415553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.683614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-04-02T22:30:14.415595Z","caller":"traceutil/trace.go:171","msg":"trace[1516961973] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1320; }","duration":"109.769196ms","start":"2026-04-02T22:30:14.305813Z","end":"2026-04-02T22:30:14.415582Z","steps":["trace[1516961973] 'agreement among raft nodes before linearized reading' (duration: 109.609022ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:30:15.313282Z","caller":"traceutil/trace.go:171","msg":"trace[2030335174] linearizableReadLoop","detail":"{readStateIndex:1376; appliedIndex:1375; }","duration":"569.165724ms","start":"2026-04-02T22:30:14.743617Z","end":"2026-04-02T22:30:15.312783Z","steps":["trace[2030335174] 'read index received' (duration: 496.431494ms)","trace[2030335174] 'applied index is now lower than readState.Index' (duration: 72.73313ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:30:15.313953Z","caller":"traceutil/trace.go:171","msg":"trace[291717729] transaction","detail":"{read_only:false; response_revision:1322; number_of_response:1; }","duration":"894.656497ms","start":"2026-04-02T22:30:14.419258Z","end":"2026-04-02T22:30:15.313915Z","steps":["trace[291717729] 'process raft request' (duration: 820.874644ms)","trace[291717729] 'compare' (duration: 72.553176ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:30:15.314214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.606825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:30:15.31433Z","caller":"traceutil/trace.go:171","msg":"trace[1453554383] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1322; }","duration":"389.762338ms","start":"2026-04-02T22:30:14.924541Z","end":"2026-04-02T22:30:15.314304Z","steps":["trace[1453554383] 'agreement among raft nodes before linearized reading' (duration: 389.592415ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:30:15.31442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:30:14.924523Z","time spent":"389.883791ms","remote":"127.0.0.1:42896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":0,"response size":28,"request content":"key:\"/registry/persistentvolumes/test-pv\" "} {"level":"warn","ts":"2026-04-02T22:30:15.314441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"570.673408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-02T22:30:15.314619Z","caller":"traceutil/trace.go:171","msg":"trace[1893139063] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1322; }","duration":"571.032276ms","start":"2026-04-02T22:30:14.74357Z","end":"2026-04-02T22:30:15.314602Z","steps":["trace[1893139063] 'agreement among raft nodes before linearized reading' (duration: 570.448763ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:30:15.314125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:30:14.41925Z","time spent":"894.788391ms","remote":"127.0.0.1:43016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T22:30:15.314804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:30:14.743551Z","time spent":"571.18265ms","remote":"127.0.0.1:43016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-02T22:30:15.77923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.694254ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T22:30:15.779637Z","caller":"traceutil/trace.go:171","msg":"trace[1661492077] linearizableReadLoop","detail":"{readStateIndex:1378; appliedIndex:1376; }","duration":"459.518142ms","start":"2026-04-02T22:30:15.320101Z","end":"2026-04-02T22:30:15.77962Z","steps":["trace[1661492077] 'read index received' (duration: 240.314797ms)","trace[1661492077] 'applied index is now lower than readState.Index' (duration: 219.202405ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:30:15.779626Z","caller":"traceutil/trace.go:171","msg":"trace[34847803] transaction","detail":"{read_only:false; response_revision:1323; number_of_response:1; }","duration":"461.494336ms","start":"2026-04-02T22:30:15.318103Z","end":"2026-04-02T22:30:15.779597Z","steps":["trace[34847803] 'process raft request' (duration: 242.326182ms)","trace[34847803] 'compare' (duration: 218.556929ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:30:15.780041Z","caller":"traceutil/trace.go:171","msg":"trace[842237635] transaction","detail":"{read_only:false; response_revision:1324; number_of_response:1; }","duration":"461.093647ms","start":"2026-04-02T22:30:15.318935Z","end":"2026-04-02T22:30:15.780029Z","steps":["trace[842237635] 'process raft request' (duration: 460.564396ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:30:15.780128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:30:15.318917Z","time spent":"461.168119ms","remote":"127.0.0.1:43016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T22:30:15.780325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.194357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:30:15.780411Z","caller":"traceutil/trace.go:171","msg":"trace[166622469] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1324; }","duration":"460.32458ms","start":"2026-04-02T22:30:15.320065Z","end":"2026-04-02T22:30:15.780389Z","steps":["trace[166622469] 'agreement among raft nodes before linearized reading' (duration: 460.148976ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:30:15.780362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.831166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-02T22:30:15.780468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:30:15.320048Z","time spent":"460.410871ms","remote":"127.0.0.1:42896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":0,"response size":28,"request content":"key:\"/registry/persistentvolumes/test-pv\" "} {"level":"info","ts":"2026-04-02T22:30:15.780512Z","caller":"traceutil/trace.go:171","msg":"trace[59795134] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1324; }","duration":"333.972629ms","start":"2026-04-02T22:30:15.446518Z","end":"2026-04-02T22:30:15.780491Z","steps":["trace[59795134] 'agreement among raft nodes before linearized reading' (duration: 333.744094ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:30:15.780587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:30:15.446496Z","time spent":"334.072292ms","remote":"127.0.0.1:43016","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:30:15.780153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:30:15.318084Z","time spent":"461.901055ms","remote":"127.0.0.1:43016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T22:30:15.780744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.363393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-02T22:30:15.780802Z","caller":"traceutil/trace.go:171","msg":"trace[2140311026] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1324; }","duration":"352.119779ms","start":"2026-04-02T22:30:15.428665Z","end":"2026-04-02T22:30:15.780785Z","steps":["trace[2140311026] 'agreement among raft nodes before linearized reading' (duration: 351.362703ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:30:15.780851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:30:15.428648Z","time spent":"352.186321ms","remote":"127.0.0.1:42896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":30,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "} {"level":"warn","ts":"2026-04-02T22:30:16.102828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.897248ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T22:30:16.102962Z","caller":"traceutil/trace.go:171","msg":"trace[951229110] linearizableReadLoop","detail":"{readStateIndex:1379; appliedIndex:1378; }","duration":"173.648012ms","start":"2026-04-02T22:30:15.929296Z","end":"2026-04-02T22:30:16.102944Z","steps":["trace[951229110] 'read index received' (duration: 40.601µs)","trace[951229110] 'applied index is now lower than readState.Index' (duration: 173.606311ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:30:16.103151Z","caller":"traceutil/trace.go:171","msg":"trace[683569159] transaction","detail":"{read_only:false; response_revision:1325; number_of_response:1; }","duration":"318.50298ms","start":"2026-04-02T22:30:15.784607Z","end":"2026-04-02T22:30:16.10311Z","steps":["trace[683569159] 'process raft request' (duration: 134.262635ms)","trace[683569159] 'compare' (duration: 183.803606ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:30:16.103262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.961838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.23\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-02T22:30:16.103287Z","caller":"traceutil/trace.go:171","msg":"trace[781602397] range","detail":"{range_begin:/registry/masterleases/199.204.45.23; range_end:; response_count:1; response_revision:1325; }","duration":"174.0138ms","start":"2026-04-02T22:30:15.929266Z","end":"2026-04-02T22:30:16.10328Z","steps":["trace[781602397] 'agreement among raft nodes before linearized reading' (duration: 173.898747ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:30:16.103427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:30:15.784564Z","time spent":"318.733095ms","remote":"127.0.0.1:43016","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:30:16.676833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.766584ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"warn","ts":"2026-04-02T22:30:16.677098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:30:16.104253Z","time spent":"572.842346ms","remote":"127.0.0.1:42784","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-04-02T22:30:16.6772Z","caller":"traceutil/trace.go:171","msg":"trace[909600157] linearizableReadLoop","detail":"{readStateIndex:1381; appliedIndex:1379; }","duration":"226.796591ms","start":"2026-04-02T22:30:16.450389Z","end":"2026-04-02T22:30:16.677186Z","steps":["trace[909600157] 'read index received' (duration: 117.267531ms)","trace[909600157] 'applied index is now lower than readState.Index' (duration: 109.52782ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:30:16.67753Z","caller":"traceutil/trace.go:171","msg":"trace[1431981756] transaction","detail":"{read_only:false; response_revision:1326; number_of_response:1; }","duration":"257.348003ms","start":"2026-04-02T22:30:16.420173Z","end":"2026-04-02T22:30:16.677521Z","steps":["trace[1431981756] 'process raft request' (duration: 256.73057ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:30:16.677616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.005706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-02T22:30:16.677637Z","caller":"traceutil/trace.go:171","msg":"trace[308075741] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1326; }","duration":"227.302722ms","start":"2026-04-02T22:30:16.450329Z","end":"2026-04-02T22:30:16.677631Z","steps":["trace[308075741] 'agreement among raft nodes before linearized reading' (duration: 226.891783ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:30:17.400079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.58811ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T22:30:17.400158Z","caller":"traceutil/trace.go:171","msg":"trace[1619179986] transaction","detail":"{read_only:false; response_revision:1327; number_of_response:1; }","duration":"720.980527ms","start":"2026-04-02T22:30:16.679164Z","end":"2026-04-02T22:30:17.400145Z","steps":["trace[1619179986] 'process raft request' (duration: 512.250744ms)","trace[1619179986] 'compare' (duration: 208.146181ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:30:17.400194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:30:16.679145Z","time spent":"721.034008ms","remote":"127.0.0.1:42784","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T22:30:17.900729Z","caller":"traceutil/trace.go:171","msg":"trace[1440600174] linearizableReadLoop","detail":"{readStateIndex:1383; appliedIndex:1381; }","duration":"1.20228649s","start":"2026-04-02T22:30:16.698408Z","end":"2026-04-02T22:30:17.900695Z","steps":["trace[1440600174] 'read index received' (duration: 492.977259ms)","trace[1440600174] 'applied index is now lower than readState.Index' (duration: 709.307901ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:30:17.900827Z","caller":"traceutil/trace.go:171","msg":"trace[1541222466] transaction","detail":"{read_only:false; response_revision:1328; number_of_response:1; }","duration":"1.219281934s","start":"2026-04-02T22:30:16.681501Z","end":"2026-04-02T22:30:17.900783Z","steps":["trace[1541222466] 'process raft request' (duration: 1.219006658s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:30:17.900915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.202479155s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:30:17.900976Z","caller":"traceutil/trace.go:171","msg":"trace[2122249370] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1328; }","duration":"1.202602277s","start":"2026-04-02T22:30:16.698357Z","end":"2026-04-02T22:30:17.90096Z","steps":["trace[2122249370] 'agreement among raft nodes before linearized reading' (duration: 1.202488174s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:30:17.901031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:30:16.698343Z","time spent":"1.202674319s","remote":"127.0.0.1:42758","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:30:17.901034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:30:16.68148Z","time spent":"1.219431937s","remote":"127.0.0.1:43016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T22:30:17.901268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"498.790668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"} {"level":"info","ts":"2026-04-02T22:30:17.901477Z","caller":"traceutil/trace.go:171","msg":"trace[1031442177] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:1328; }","duration":"499.075904ms","start":"2026-04-02T22:30:17.402364Z","end":"2026-04-02T22:30:17.90144Z","steps":["trace[1031442177] 'agreement among raft nodes before linearized reading' (duration: 498.742657ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:30:17.901593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:30:17.402326Z","time spent":"499.248218ms","remote":"127.0.0.1:42912","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":444,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"warn","ts":"2026-04-02T22:30:17.901301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.32569ms","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:30:17.901722Z","caller":"traceutil/trace.go:171","msg":"trace[1922418145] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1328; }","duration":"116.78561ms","start":"2026-04-02T22:30:17.784912Z","end":"2026-04-02T22:30:17.901698Z","steps":["trace[1922418145] 'agreement among raft nodes before linearized reading' (duration: 116.246568ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:30:17.901779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.383469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-02T22:30:17.901872Z","caller":"traceutil/trace.go:171","msg":"trace[835782308] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1328; }","duration":"115.560293ms","start":"2026-04-02T22:30:17.786292Z","end":"2026-04-02T22:30:17.901852Z","steps":["trace[835782308] 'agreement among raft nodes before linearized reading' (duration: 114.892078ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:30:17.901042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.765546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-02T22:30:17.90235Z","caller":"traceutil/trace.go:171","msg":"trace[885437300] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1328; }","duration":"584.098044ms","start":"2026-04-02T22:30:17.318236Z","end":"2026-04-02T22:30:17.902334Z","steps":["trace[885437300] 'agreement among raft nodes before linearized reading' (duration: 582.670573ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:30:17.902393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:30:17.318214Z","time spent":"584.165546ms","remote":"127.0.0.1:43016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-02T22:30:18.290539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.743951ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T22:30:18.290714Z","caller":"traceutil/trace.go:171","msg":"trace[1830298183] linearizableReadLoop","detail":"{readStateIndex:1386; appliedIndex:1383; }","duration":"378.93556ms","start":"2026-04-02T22:30:17.911762Z","end":"2026-04-02T22:30:18.290698Z","steps":["trace[1830298183] 'read index received' (duration: 32.301181ms)","trace[1830298183] 'applied index is now lower than readState.Index' (duration: 346.633539ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:30:18.290816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.046082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:30:18.290852Z","caller":"traceutil/trace.go:171","msg":"trace[1562146453] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1331; }","duration":"379.084183ms","start":"2026-04-02T22:30:17.911758Z","end":"2026-04-02T22:30:18.290842Z","steps":["trace[1562146453] 'agreement among raft nodes before linearized reading' (duration: 379.027482ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:30:18.290886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:30:17.911724Z","time spent":"379.154664ms","remote":"127.0.0.1:42758","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:30:18.290867Z","caller":"traceutil/trace.go:171","msg":"trace[902949245] transaction","detail":"{read_only:false; response_revision:1330; number_of_response:1; }","duration":"383.633983ms","start":"2026-04-02T22:30:17.9072Z","end":"2026-04-02T22:30:18.290834Z","steps":["trace[902949245] 'process raft request' (duration: 141.513524ms)","trace[902949245] 'compare' (duration: 241.585817ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:30:18.290864Z","caller":"traceutil/trace.go:171","msg":"trace[1056936482] transaction","detail":"{read_only:false; response_revision:1331; number_of_response:1; }","duration":"382.873016ms","start":"2026-04-02T22:30:17.907921Z","end":"2026-04-02T22:30:18.290794Z","steps":["trace[1056936482] 'process raft request' (duration: 382.718243ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:30:18.290989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:30:17.907188Z","time spent":"383.738655ms","remote":"127.0.0.1:43016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T22:30:18.291104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.138693ms","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:30:18.291161Z","caller":"traceutil/trace.go:171","msg":"trace[1413039628] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1331; }","duration":"184.249606ms","start":"2026-04-02T22:30:18.106898Z","end":"2026-04-02T22:30:18.291148Z","steps":["trace[1413039628] 'agreement among raft nodes before linearized reading' (duration: 184.068542ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:30:18.291141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:30:17.907039Z","time spent":"383.972971ms","remote":"127.0.0.1:43016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T22:30:18.799787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.2432ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T22:30:18.800061Z","caller":"traceutil/trace.go:171","msg":"trace[1628594549] transaction","detail":"{read_only:false; response_revision:1333; number_of_response:1; }","duration":"117.590028ms","start":"2026-04-02T22:30:18.682453Z","end":"2026-04-02T22:30:18.800043Z","steps":["trace[1628594549] 'process raft request' (duration: 117.497276ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:30:18.800279Z","caller":"traceutil/trace.go:171","msg":"trace[211531384] transaction","detail":"{read_only:false; response_revision:1332; number_of_response:1; }","duration":"505.350752ms","start":"2026-04-02T22:30:18.294847Z","end":"2026-04-02T22:30:18.800198Z","steps":["trace[211531384] 'process raft request' (duration: 114.600511ms)","trace[211531384] 'compare' (duration: 390.017705ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:30:18.800689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:30:18.294831Z","time spent":"505.67097ms","remote":"127.0.0.1:43016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T22:30:19.699976Z","caller":"traceutil/trace.go:171","msg":"trace[2014193371] transaction","detail":"{read_only:false; response_revision:1335; number_of_response:1; }","duration":"203.963179ms","start":"2026-04-02T22:30:19.495977Z","end":"2026-04-02T22:30:19.69994Z","steps":["trace[2014193371] 'process raft request' (duration: 138.022829ms)","trace[2014193371] 'compare' (duration: 65.501591ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:30:19.707248Z","caller":"traceutil/trace.go:171","msg":"trace[577864266] transaction","detail":"{read_only:false; response_revision:1336; number_of_response:1; }","duration":"172.655891ms","start":"2026-04-02T22:30:19.534566Z","end":"2026-04-02T22:30:19.707222Z","steps":["trace[577864266] 'process raft request' (duration: 172.414776ms)"],"step_count":1}