{"level":"warn","ts":"2026-06-25T22:17:08.552607Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-25T22:17:08.552722Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.185: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.19.213.185:2380","--initial-cluster=instance=https://199.19.213.185:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.185:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.185: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-06-25T22:17:08.5528Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-25T22:17:08.55282Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.185:2380"]} {"level":"info","ts":"2026-06-25T22:17:08.552843Z","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-06-25T22:17:08.554421Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.185:2379"]} {"level":"info","ts":"2026-06-25T22:17:08.554512Z","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.19.213.185:2380"],"listen-peer-urls":["https://199.19.213.185:2380"],"advertise-client-urls":["https://199.19.213.185:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.185:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.185: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-06-25T22:17:08.558129Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.376275ms"} {"level":"info","ts":"2026-06-25T22:17:08.565538Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"dcbda34f8b503a3","cluster-id":"2e806bc52dde46af"} {"level":"info","ts":"2026-06-25T22:17:08.565644Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcbda34f8b503a3 switched to configuration voters=()"} {"level":"info","ts":"2026-06-25T22:17:08.565686Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcbda34f8b503a3 became follower at term 0"} {"level":"info","ts":"2026-06-25T22:17:08.565716Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft dcbda34f8b503a3 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-25T22:17:08.56573Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcbda34f8b503a3 became follower at term 1"} {"level":"info","ts":"2026-06-25T22:17:08.565791Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcbda34f8b503a3 switched to configuration voters=(994128063811093411)"} {"level":"warn","ts":"2026-06-25T22:17:08.570108Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-25T22:17:08.57115Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-25T22:17:08.572072Z","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-06-25T22:17:08.574186Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"dcbda34f8b503a3","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-25T22:17:08.57522Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"dcbda34f8b503a3","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-25T22:17:08.576043Z","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-06-25T22:17:08.578725Z","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-06-25T22:17:08.578743Z","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-06-25T22:17:08.579591Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcbda34f8b503a3 switched to configuration voters=(994128063811093411)"} {"level":"info","ts":"2026-06-25T22:17:08.579689Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2e806bc52dde46af","local-member-id":"dcbda34f8b503a3","added-peer-id":"dcbda34f8b503a3","added-peer-peer-urls":["https://199.19.213.185:2380"]} {"level":"info","ts":"2026-06-25T22:17:08.580271Z","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-06-25T22:17:08.580392Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.185:2380"} {"level":"info","ts":"2026-06-25T22:17:08.58042Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.185:2380"} {"level":"info","ts":"2026-06-25T22:17:08.580522Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"dcbda34f8b503a3","initial-advertise-peer-urls":["https://199.19.213.185:2380"],"listen-peer-urls":["https://199.19.213.185:2380"],"advertise-client-urls":["https://199.19.213.185:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.185:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-25T22:17:08.580561Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-25T22:17:08.66675Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcbda34f8b503a3 is starting a new election at term 1"} {"level":"info","ts":"2026-06-25T22:17:08.666825Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcbda34f8b503a3 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-25T22:17:08.666846Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcbda34f8b503a3 received MsgPreVoteResp from dcbda34f8b503a3 at term 1"} {"level":"info","ts":"2026-06-25T22:17:08.666897Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcbda34f8b503a3 became candidate at term 2"} {"level":"info","ts":"2026-06-25T22:17:08.666913Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcbda34f8b503a3 received MsgVoteResp from dcbda34f8b503a3 at term 2"} {"level":"info","ts":"2026-06-25T22:17:08.666965Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcbda34f8b503a3 became leader at term 2"} {"level":"info","ts":"2026-06-25T22:17:08.666985Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: dcbda34f8b503a3 elected leader dcbda34f8b503a3 at term 2"} {"level":"info","ts":"2026-06-25T22:17:08.667799Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"dcbda34f8b503a3","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.185:2379]}","request-path":"/0/members/dcbda34f8b503a3/attributes","cluster-id":"2e806bc52dde46af","publish-timeout":"7s"} {"level":"info","ts":"2026-06-25T22:17:08.668011Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-25T22:17:08.668121Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-25T22:17:08.668207Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-25T22:17:08.668237Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-25T22:17:08.66816Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-25T22:17:08.668886Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2e806bc52dde46af","local-member-id":"dcbda34f8b503a3","cluster-version":"3.5"} {"level":"info","ts":"2026-06-25T22:17:08.669003Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-25T22:17:08.669033Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-25T22:17:08.671026Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.185:2379"} {"level":"info","ts":"2026-06-25T22:17:08.672481Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-25T22:17:43.601673Z","caller":"traceutil/trace.go:171","msg":"trace[590864608] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"107.360659ms","start":"2026-06-25T22:17:43.494298Z","end":"2026-06-25T22:17:43.601659Z","steps":["trace[590864608] 'process raft request' (duration: 26.152895ms)","trace[590864608] 'compare' (duration: 81.120362ms)"],"step_count":2} {"level":"info","ts":"2026-06-25T22:17:49.397215Z","caller":"traceutil/trace.go:171","msg":"trace[1067444109] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"148.712129ms","start":"2026-06-25T22:17:49.248452Z","end":"2026-06-25T22:17:49.397164Z","steps":["trace[1067444109] 'process raft request' (duration: 148.133798ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:17:50.179712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.083198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-25T22:17:50.179809Z","caller":"traceutil/trace.go:171","msg":"trace[970272254] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:584; }","duration":"323.234981ms","start":"2026-06-25T22:17:49.856561Z","end":"2026-06-25T22:17:50.179796Z","steps":["trace[970272254] 'count revisions from in-memory index tree' (duration: 323.045657ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:17:50.179745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.999414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-25T22:17:50.179891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.151709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-25T22:17:50.179914Z","caller":"traceutil/trace.go:171","msg":"trace[1700437748] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:584; }","duration":"339.19568ms","start":"2026-06-25T22:17:49.840712Z","end":"2026-06-25T22:17:50.179908Z","steps":["trace[1700437748] 'count revisions from in-memory index tree' (duration: 339.062967ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:17:50.179939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:17:49.840686Z","time spent":"339.243111ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-25T22:17:50.179953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.349894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-25T22:17:50.179961Z","caller":"traceutil/trace.go:171","msg":"trace[1733579444] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:584; }","duration":"404.255218ms","start":"2026-06-25T22:17:49.775685Z","end":"2026-06-25T22:17:50.17994Z","steps":["trace[1733579444] 'range keys from in-memory index tree' (duration: 403.946353ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:17:50.180059Z","caller":"traceutil/trace.go:171","msg":"trace[924218862] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:584; }","duration":"259.559669ms","start":"2026-06-25T22:17:49.920467Z","end":"2026-06-25T22:17:50.180026Z","steps":["trace[924218862] 'range keys from in-memory index tree' (duration: 259.295354ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:17:50.180109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:17:49.775672Z","time spent":"404.420702ms","remote":"127.0.0.1:58618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 "} {"level":"warn","ts":"2026-06-25T22:17:50.180169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.936769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-25T22:17:50.180225Z","caller":"traceutil/trace.go:171","msg":"trace[616879931] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:584; }","duration":"518.998322ms","start":"2026-06-25T22:17:49.661208Z","end":"2026-06-25T22:17:50.180206Z","steps":["trace[616879931] 'count revisions from in-memory index tree' (duration: 518.891198ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:17:50.180227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.74462ms","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-06-25T22:17:50.18029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:17:49.661169Z","time spent":"519.108894ms","remote":"127.0.0.1:58618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"info","ts":"2026-06-25T22:17:50.180311Z","caller":"traceutil/trace.go:171","msg":"trace[1952455776] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:584; }","duration":"338.915894ms","start":"2026-06-25T22:17:49.841366Z","end":"2026-06-25T22:17:50.180282Z","steps":["trace[1952455776] 'range keys from in-memory index tree' (duration: 338.662579ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:17:50.18035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:17:49.841348Z","time spent":"338.990976ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 "} {"level":"warn","ts":"2026-06-25T22:17:50.180366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.987137ms","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-06-25T22:17:50.180394Z","caller":"traceutil/trace.go:171","msg":"trace[1329167643] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:584; }","duration":"324.030977ms","start":"2026-06-25T22:17:49.856355Z","end":"2026-06-25T22:17:50.180386Z","steps":["trace[1329167643] 'range keys from in-memory index tree' (duration: 323.940195ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:17:50.180415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:17:49.856348Z","time spent":"324.061428ms","remote":"127.0.0.1:58658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 "} {"level":"warn","ts":"2026-06-25T22:17:50.180395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.439626ms","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-06-25T22:17:50.180362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.581731ms","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":"warn","ts":"2026-06-25T22:17:50.180414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.179388ms","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-06-25T22:17:50.180525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.423142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-4dtm7\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-06-25T22:17:50.180548Z","caller":"traceutil/trace.go:171","msg":"trace[150626131] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:584; }","duration":"405.336201ms","start":"2026-06-25T22:17:49.775205Z","end":"2026-06-25T22:17:50.180541Z","steps":["trace[150626131] 'count revisions from in-memory index tree' (duration: 405.134807ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:17:50.180555Z","caller":"traceutil/trace.go:171","msg":"trace[1195902376] range","detail":"{range_begin:/registry/pods/kube-system/cilium-4dtm7; range_end:; response_count:1; response_revision:584; }","duration":"417.466113ms","start":"2026-06-25T22:17:49.763079Z","end":"2026-06-25T22:17:50.180545Z","steps":["trace[1195902376] 'range keys from in-memory index tree' (duration: 417.282599ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:17:50.180577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:17:49.775197Z","time spent":"405.373072ms","remote":"127.0.0.1:58628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-06-25T22:17:50.180584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:17:49.763065Z","time spent":"417.512464ms","remote":"127.0.0.1:54070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-4dtm7\" "} {"level":"info","ts":"2026-06-25T22:17:50.180547Z","caller":"traceutil/trace.go:171","msg":"trace[986185275] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:584; }","duration":"229.897537ms","start":"2026-06-25T22:17:49.950628Z","end":"2026-06-25T22:17:50.180526Z","steps":["trace[986185275] 'range keys from in-memory index tree' (duration: 229.413906ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:17:50.180571Z","caller":"traceutil/trace.go:171","msg":"trace[1211220417] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:584; }","duration":"322.571548ms","start":"2026-06-25T22:17:49.857881Z","end":"2026-06-25T22:17:50.180452Z","steps":["trace[1211220417] 'range keys from in-memory index tree' (duration: 322.375745ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:17:50.179842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:17:49.856556Z","time spent":"323.277541ms","remote":"127.0.0.1:58658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"warn","ts":"2026-06-25T22:17:50.180689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:17:49.85787Z","time spent":"322.762613ms","remote":"127.0.0.1:58658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 "} {"level":"warn","ts":"2026-06-25T22:17:50.180752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.673927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-25T22:17:50.180789Z","caller":"traceutil/trace.go:171","msg":"trace[1298254459] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:584; }","duration":"405.736889ms","start":"2026-06-25T22:17:49.775043Z","end":"2026-06-25T22:17:50.18078Z","steps":["trace[1298254459] 'range keys from in-memory index tree' (duration: 405.625357ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:17:50.180819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:17:49.775028Z","time spent":"405.783529ms","remote":"127.0.0.1:58628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-06-25T22:17:50.179808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.042537ms","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-06-25T22:17:50.180866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.335865ms","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-06-25T22:17:50.180005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.703415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-25T22:17:50.180914Z","caller":"traceutil/trace.go:171","msg":"trace[1602058135] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:584; }","duration":"230.417517ms","start":"2026-06-25T22:17:49.950486Z","end":"2026-06-25T22:17:50.180904Z","steps":["trace[1602058135] 'count revisions from in-memory index tree' (duration: 230.231273ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:17:50.180938Z","caller":"traceutil/trace.go:171","msg":"trace[955864450] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:584; }","duration":"519.705475ms","start":"2026-06-25T22:17:49.661225Z","end":"2026-06-25T22:17:50.18093Z","steps":["trace[955864450] 'range keys from in-memory index tree' (duration: 518.635033ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:17:50.180973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:17:49.661209Z","time spent":"519.755626ms","remote":"127.0.0.1:58618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"info","ts":"2026-06-25T22:17:50.180997Z","caller":"traceutil/trace.go:171","msg":"trace[201896496] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:584; }","duration":"340.20325ms","start":"2026-06-25T22:17:49.84069Z","end":"2026-06-25T22:17:50.180893Z","steps":["trace[201896496] 'range keys from in-memory index tree' (duration: 338.919444ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:17:50.181082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:17:49.840677Z","time spent":"340.385174ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-06-25T22:17:50.181117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.405096ms","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-06-25T22:17:50.181146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.932368ms","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-06-25T22:17:50.181182Z","caller":"traceutil/trace.go:171","msg":"trace[290626852] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:584; }","duration":"230.0126ms","start":"2026-06-25T22:17:49.95116Z","end":"2026-06-25T22:17:50.181173Z","steps":["trace[290626852] 'range keys from in-memory index tree' (duration: 229.829586ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:17:50.181249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.290974ms","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-06-25T22:17:50.181272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.572179ms","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-06-25T22:17:50.181295Z","caller":"traceutil/trace.go:171","msg":"trace[380412933] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:584; }","duration":"287.61842ms","start":"2026-06-25T22:17:49.89367Z","end":"2026-06-25T22:17:50.181289Z","steps":["trace[380412933] 'count revisions from in-memory index tree' (duration: 287.487407ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:17:50.181297Z","caller":"traceutil/trace.go:171","msg":"trace[459827388] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:584; }","duration":"261.368675ms","start":"2026-06-25T22:17:49.919919Z","end":"2026-06-25T22:17:50.181287Z","steps":["trace[459827388] 'count revisions from in-memory index tree' (duration: 261.240993ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:17:50.181321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.268443ms","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-06-25T22:17:50.181358Z","caller":"traceutil/trace.go:171","msg":"trace[715458948] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:584; }","duration":"261.337275ms","start":"2026-06-25T22:17:49.920011Z","end":"2026-06-25T22:17:50.181348Z","steps":["trace[715458948] 'range keys from in-memory index tree' (duration: 261.177821ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:17:50.18118Z","caller":"traceutil/trace.go:171","msg":"trace[868447139] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:584; }","duration":"287.493067ms","start":"2026-06-25T22:17:49.893676Z","end":"2026-06-25T22:17:50.181169Z","steps":["trace[868447139] 'range keys from in-memory index tree' (duration: 287.343095ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:17:50.182201Z","caller":"traceutil/trace.go:171","msg":"trace[666825093] linearizableReadLoop","detail":"{readStateIndex:605; appliedIndex:604; }","duration":"212.041809ms","start":"2026-06-25T22:17:49.970147Z","end":"2026-06-25T22:17:50.182188Z","steps":["trace[666825093] 'read index received' (duration: 208.728624ms)","trace[666825093] 'applied index is now lower than readState.Index' (duration: 3.312305ms)"],"step_count":2} {"level":"info","ts":"2026-06-25T22:17:50.183227Z","caller":"traceutil/trace.go:171","msg":"trace[1487669543] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"217.03069ms","start":"2026-06-25T22:17:49.966187Z","end":"2026-06-25T22:17:50.183217Z","steps":["trace[1487669543] 'process raft request' (duration: 212.853457ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:17:50.183355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.195543ms","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-06-25T22:17:50.183375Z","caller":"traceutil/trace.go:171","msg":"trace[121984689] 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:585; }","duration":"213.244203ms","start":"2026-06-25T22:17:49.970124Z","end":"2026-06-25T22:17:50.183368Z","steps":["trace[121984689] 'agreement among raft nodes before linearized reading' (duration: 213.194942ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:17:50.18363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.442297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-25T22:17:50.183653Z","caller":"traceutil/trace.go:171","msg":"trace[142598736] 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:585; }","duration":"213.468368ms","start":"2026-06-25T22:17:49.97018Z","end":"2026-06-25T22:17:50.183648Z","steps":["trace[142598736] 'agreement among raft nodes before linearized reading' (duration: 213.424017ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:17:50.184041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.798736ms","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-06-25T22:17:50.18412Z","caller":"traceutil/trace.go:171","msg":"trace[187857929] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:585; }","duration":"176.880327ms","start":"2026-06-25T22:17:50.007215Z","end":"2026-06-25T22:17:50.184095Z","steps":["trace[187857929] 'agreement among raft nodes before linearized reading' (duration: 176.776215ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:17:50.184277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.688253ms","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-06-25T22:17:50.184307Z","caller":"traceutil/trace.go:171","msg":"trace[687237631] 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:585; }","duration":"213.722223ms","start":"2026-06-25T22:17:49.970578Z","end":"2026-06-25T22:17:50.1843Z","steps":["trace[687237631] 'agreement among raft nodes before linearized reading' (duration: 213.658472ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:17:50.184293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.352427ms","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-06-25T22:17:50.184339Z","caller":"traceutil/trace.go:171","msg":"trace[416481934] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:585; }","duration":"193.417128ms","start":"2026-06-25T22:17:49.99091Z","end":"2026-06-25T22:17:50.184327Z","steps":["trace[416481934] 'agreement among raft nodes before linearized reading' (duration: 193.268435ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:17:50.184477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.387799ms","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-06-25T22:17:50.184517Z","caller":"traceutil/trace.go:171","msg":"trace[1464368590] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:585; }","duration":"176.439979ms","start":"2026-06-25T22:17:50.008068Z","end":"2026-06-25T22:17:50.184508Z","steps":["trace[1464368590] 'agreement among raft nodes before linearized reading' (duration: 176.384848ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:17:50.184608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.384248ms","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-06-25T22:17:50.18465Z","caller":"traceutil/trace.go:171","msg":"trace[178701749] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:585; }","duration":"177.451009ms","start":"2026-06-25T22:17:50.007189Z","end":"2026-06-25T22:17:50.18464Z","steps":["trace[178701749] 'agreement among raft nodes before linearized reading' (duration: 177.354587ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:17:50.184796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.664523ms","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-06-25T22:17:50.184844Z","caller":"traceutil/trace.go:171","msg":"trace[1667326664] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:585; }","duration":"193.732754ms","start":"2026-06-25T22:17:49.991094Z","end":"2026-06-25T22:17:50.184827Z","steps":["trace[1667326664] 'agreement among raft nodes before linearized reading' (duration: 193.664392ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:18:04.952297Z","caller":"traceutil/trace.go:171","msg":"trace[62095716] transaction","detail":"{read_only:false; response_revision:743; number_of_response:1; }","duration":"146.432609ms","start":"2026-06-25T22:18:04.805848Z","end":"2026-06-25T22:18:04.952281Z","steps":["trace[62095716] 'process raft request' (duration: 146.331557ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:18:05.102191Z","caller":"traceutil/trace.go:171","msg":"trace[1716183326] linearizableReadLoop","detail":"{readStateIndex:768; appliedIndex:766; }","duration":"250.106372ms","start":"2026-06-25T22:18:04.852057Z","end":"2026-06-25T22:18:05.102163Z","steps":["trace[1716183326] 'read index received' (duration: 100.119001ms)","trace[1716183326] 'applied index is now lower than readState.Index' (duration: 149.986171ms)"],"step_count":2} {"level":"info","ts":"2026-06-25T22:18:05.102258Z","caller":"traceutil/trace.go:171","msg":"trace[981383042] transaction","detail":"{read_only:false; response_revision:744; number_of_response:1; }","duration":"296.238867ms","start":"2026-06-25T22:18:04.805978Z","end":"2026-06-25T22:18:05.102217Z","steps":["trace[981383042] 'process raft request' (duration: 279.090249ms)","trace[981383042] 'compare' (duration: 16.994026ms)"],"step_count":2} {"level":"warn","ts":"2026-06-25T22:18:05.10238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.300366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-d6v4g\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-06-25T22:18:05.102422Z","caller":"traceutil/trace.go:171","msg":"trace[783798706] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-d6v4g; range_end:; response_count:1; response_revision:744; }","duration":"250.385138ms","start":"2026-06-25T22:18:04.852025Z","end":"2026-06-25T22:18:05.10241Z","steps":["trace[783798706] 'agreement among raft nodes before linearized reading' (duration: 250.234435ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:18:40.07604Z","caller":"traceutil/trace.go:171","msg":"trace[1963485360] transaction","detail":"{read_only:false; response_revision:1167; number_of_response:1; }","duration":"140.504026ms","start":"2026-06-25T22:18:39.93551Z","end":"2026-06-25T22:18:40.076014Z","steps":["trace[1963485360] 'process raft request' (duration: 140.365874ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:19:25.652351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.269823ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-25T22:19:25.652518Z","caller":"traceutil/trace.go:171","msg":"trace[171914172] linearizableReadLoop","detail":"{readStateIndex:1866; appliedIndex:1865; }","duration":"336.746564ms","start":"2026-06-25T22:19:25.315745Z","end":"2026-06-25T22:19:25.652492Z","steps":["trace[171914172] 'read index received' (duration: 151.538759ms)","trace[171914172] 'applied index is now lower than readState.Index' (duration: 185.205365ms)"],"step_count":2} {"level":"info","ts":"2026-06-25T22:19:25.652585Z","caller":"traceutil/trace.go:171","msg":"trace[1826802149] transaction","detail":"{read_only:false; response_revision:1814; number_of_response:1; }","duration":"396.51667ms","start":"2026-06-25T22:19:25.256033Z","end":"2026-06-25T22:19:25.652549Z","steps":["trace[1826802149] 'process raft request' (duration: 211.176253ms)","trace[1826802149] 'compare' (duration: 183.866308ms)"],"step_count":2} {"level":"warn","ts":"2026-06-25T22:19:25.652759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:19:25.256011Z","time spent":"396.640691ms","remote":"127.0.0.1:54070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3729,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-25T22:19:25.652822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.715007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-25T22:19:25.652798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.047778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-25T22:19:25.652861Z","caller":"traceutil/trace.go:171","msg":"trace[881265389] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1814; }","duration":"140.815619ms","start":"2026-06-25T22:19:25.512033Z","end":"2026-06-25T22:19:25.652849Z","steps":["trace[881265389] 'agreement among raft nodes before linearized reading' (duration: 140.593166ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:19:25.652882Z","caller":"traceutil/trace.go:171","msg":"trace[1678463147] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1814; }","duration":"337.19673ms","start":"2026-06-25T22:19:25.315665Z","end":"2026-06-25T22:19:25.652862Z","steps":["trace[1678463147] 'agreement among raft nodes before linearized reading' (duration: 336.912616ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:19:25.652924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:19:25.315632Z","time spent":"337.28283ms","remote":"127.0.0.1:54148","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-06-25T22:19:25.884353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.471274ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-25T22:19:25.884574Z","caller":"traceutil/trace.go:171","msg":"trace[802267735] transaction","detail":"{read_only:false; response_revision:1816; number_of_response:1; }","duration":"226.256919ms","start":"2026-06-25T22:19:25.658237Z","end":"2026-06-25T22:19:25.884494Z","steps":["trace[802267735] 'process raft request' (duration: 92.556092ms)","trace[802267735] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/kube-system/kube-scheduler; req_size:461; } (duration: 133.361942ms)"],"step_count":2} {"level":"info","ts":"2026-06-25T22:19:40.485867Z","caller":"traceutil/trace.go:171","msg":"trace[1827516022] transaction","detail":"{read_only:false; response_revision:1960; number_of_response:1; }","duration":"138.590893ms","start":"2026-06-25T22:19:40.347252Z","end":"2026-06-25T22:19:40.485842Z","steps":["trace[1827516022] 'process raft request' (duration: 138.444241ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:19:40.519778Z","caller":"traceutil/trace.go:171","msg":"trace[141071252] transaction","detail":"{read_only:false; response_revision:1961; number_of_response:1; }","duration":"103.46179ms","start":"2026-06-25T22:19:40.416215Z","end":"2026-06-25T22:19:40.519677Z","steps":["trace[141071252] 'process raft request' (duration: 96.477252ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:19:57.764607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.824996ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-06-25T22:19:57.764931Z","caller":"traceutil/trace.go:171","msg":"trace[77817129] transaction","detail":"{read_only:false; response_revision:2083; number_of_response:1; }","duration":"355.770544ms","start":"2026-06-25T22:19:57.409137Z","end":"2026-06-25T22:19:57.764907Z","steps":["trace[77817129] 'process raft request' (duration: 355.603071ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:19:57.76508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:19:57.409105Z","time spent":"355.886326ms","remote":"127.0.0.1:54148","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-25T22:19:57.765248Z","caller":"traceutil/trace.go:171","msg":"trace[758906712] linearizableReadLoop","detail":"{readStateIndex:2148; appliedIndex:2147; }","duration":"401.29604ms","start":"2026-06-25T22:19:57.3639Z","end":"2026-06-25T22:19:57.765196Z","steps":["trace[758906712] 'read index received' (duration: 52.818815ms)","trace[758906712] 'applied index is now lower than readState.Index' (duration: 348.470235ms)"],"step_count":2} {"level":"warn","ts":"2026-06-25T22:19:57.765641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.716845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:524"} {"level":"warn","ts":"2026-06-25T22:19:57.765698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.528839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:4591"} {"level":"info","ts":"2026-06-25T22:19:57.765766Z","caller":"traceutil/trace.go:171","msg":"trace[1821824588] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2083; }","duration":"345.64006ms","start":"2026-06-25T22:19:57.420104Z","end":"2026-06-25T22:19:57.765744Z","steps":["trace[1821824588] 'agreement among raft nodes before linearized reading' (duration: 345.400408ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:19:57.765698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.245745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-25T22:19:57.765919Z","caller":"traceutil/trace.go:171","msg":"trace[1188549107] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2083; }","duration":"291.542749ms","start":"2026-06-25T22:19:57.47436Z","end":"2026-06-25T22:19:57.765903Z","steps":["trace[1188549107] 'agreement among raft nodes before linearized reading' (duration: 291.208395ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:19:57.765827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:19:57.420086Z","time spent":"345.725251ms","remote":"127.0.0.1:42646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":4613,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-06-25T22:19:57.765745Z","caller":"traceutil/trace.go:171","msg":"trace[1702909251] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:2083; }","duration":"401.884546ms","start":"2026-06-25T22:19:57.363839Z","end":"2026-06-25T22:19:57.765723Z","steps":["trace[1702909251] 'agreement among raft nodes before linearized reading' (duration: 401.506412ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:19:57.766607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:19:57.3638Z","time spent":"402.758987ms","remote":"127.0.0.1:54148","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":546,"request content":"key:\"/registry/leases/openstack/08db1feb.percona.com\" "} {"level":"info","ts":"2026-06-25T22:19:57.975831Z","caller":"traceutil/trace.go:171","msg":"trace[40367910] transaction","detail":"{read_only:false; response_revision:2086; number_of_response:1; }","duration":"111.186318ms","start":"2026-06-25T22:19:57.864617Z","end":"2026-06-25T22:19:57.975803Z","steps":["trace[40367910] 'process raft request' (duration: 111.022686ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:20:54.247028Z","caller":"traceutil/trace.go:171","msg":"trace[493903527] linearizableReadLoop","detail":"{readStateIndex:2662; appliedIndex:2661; }","duration":"212.790618ms","start":"2026-06-25T22:20:54.034218Z","end":"2026-06-25T22:20:54.247009Z","steps":["trace[493903527] 'read index received' (duration: 212.673557ms)","trace[493903527] 'applied index is now lower than readState.Index' (duration: 116.011µs)"],"step_count":2} {"level":"info","ts":"2026-06-25T22:20:54.2471Z","caller":"traceutil/trace.go:171","msg":"trace[1121417550] transaction","detail":"{read_only:false; response_revision:2570; number_of_response:1; }","duration":"221.274935ms","start":"2026-06-25T22:20:54.025772Z","end":"2026-06-25T22:20:54.247047Z","steps":["trace[1121417550] 'process raft request' (duration: 221.099503ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:20:54.247272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.02203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:523"} {"level":"info","ts":"2026-06-25T22:20:54.247355Z","caller":"traceutil/trace.go:171","msg":"trace[1169524733] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:2570; }","duration":"213.144362ms","start":"2026-06-25T22:20:54.034192Z","end":"2026-06-25T22:20:54.247337Z","steps":["trace[1169524733] 'agreement among raft nodes before linearized reading' (duration: 212.922859ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:21:21.696157Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":262228029353028777,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-25T22:21:21.897972Z","caller":"traceutil/trace.go:171","msg":"trace[2060550523] linearizableReadLoop","detail":"{readStateIndex:2863; appliedIndex:2862; }","duration":"702.68453ms","start":"2026-06-25T22:21:21.195265Z","end":"2026-06-25T22:21:21.89795Z","steps":["trace[2060550523] 'read index received' (duration: 702.501382ms)","trace[2060550523] 'applied index is now lower than readState.Index' (duration: 182.298µs)"],"step_count":2} {"level":"info","ts":"2026-06-25T22:21:21.898072Z","caller":"traceutil/trace.go:171","msg":"trace[432958775] transaction","detail":"{read_only:false; response_revision:2761; number_of_response:1; }","duration":"723.708608ms","start":"2026-06-25T22:21:21.174354Z","end":"2026-06-25T22:21:21.898063Z","steps":["trace[432958775] 'process raft request' (duration: 723.470208ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:21:21.898319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"703.051886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-25T22:21:21.898429Z","caller":"traceutil/trace.go:171","msg":"trace[990864962] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2761; }","duration":"703.161821ms","start":"2026-06-25T22:21:21.19525Z","end":"2026-06-25T22:21:21.898412Z","steps":["trace[990864962] 'agreement among raft nodes before linearized reading' (duration: 703.032085ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:21:21.89847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:21:21.195203Z","time spent":"703.257145ms","remote":"127.0.0.1:42602","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":29,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-06-25T22:21:21.898515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.099413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1296"} {"level":"warn","ts":"2026-06-25T22:21:21.898554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:21:21.174337Z","time spent":"723.764231ms","remote":"127.0.0.1:54148","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":551,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-25T22:21:21.898627Z","caller":"traceutil/trace.go:171","msg":"trace[2064075692] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2761; }","duration":"157.256499ms","start":"2026-06-25T22:21:21.741336Z","end":"2026-06-25T22:21:21.898593Z","steps":["trace[2064075692] 'agreement among raft nodes before linearized reading' (duration: 156.929985ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:21:21.898825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.640701ms","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-06-25T22:21:21.898875Z","caller":"traceutil/trace.go:171","msg":"trace[1774084514] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2761; }","duration":"309.327541ms","start":"2026-06-25T22:21:21.589535Z","end":"2026-06-25T22:21:21.898863Z","steps":["trace[1774084514] 'agreement among raft nodes before linearized reading' (duration: 308.590159ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:21:21.898909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:21:21.589515Z","time spent":"309.382964ms","remote":"127.0.0.1:54148","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-25T22:21:22.231786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.25453ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:39"} {"level":"warn","ts":"2026-06-25T22:21:22.231986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:21:21.900373Z","time spent":"331.592672ms","remote":"127.0.0.1:53894","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-25T22:21:22.232138Z","caller":"traceutil/trace.go:171","msg":"trace[1825673592] transaction","detail":"{read_only:false; response_revision:2762; number_of_response:1; }","duration":"327.677799ms","start":"2026-06-25T22:21:21.904412Z","end":"2026-06-25T22:21:22.232089Z","steps":["trace[1825673592] 'process raft request' (duration: 327.505841ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:21:22.232278Z","caller":"traceutil/trace.go:171","msg":"trace[955031178] linearizableReadLoop","detail":"{readStateIndex:2864; appliedIndex:2863; }","duration":"330.390528ms","start":"2026-06-25T22:21:21.901762Z","end":"2026-06-25T22:21:22.232152Z","steps":["trace[955031178] 'read index received' (duration: 60.755092ms)","trace[955031178] 'applied index is now lower than readState.Index' (duration: 269.629576ms)"],"step_count":2} {"level":"warn","ts":"2026-06-25T22:21:22.232355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:21:21.904398Z","time spent":"327.814475ms","remote":"127.0.0.1:54148","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-25T22:21:22.232497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.716632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:552"} {"level":"info","ts":"2026-06-25T22:21:22.232589Z","caller":"traceutil/trace.go:171","msg":"trace[438848591] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2762; }","duration":"330.829677ms","start":"2026-06-25T22:21:21.901736Z","end":"2026-06-25T22:21:22.232566Z","steps":["trace[438848591] 'agreement among raft nodes before linearized reading' (duration: 330.556065ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:21:22.232639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:21:21.901721Z","time spent":"330.908381ms","remote":"127.0.0.1:54148","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":574,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-06-25T22:21:22.23304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.361141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/bindings/\" range_end:\"/registry/rabbitmq.com/bindings0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-25T22:21:22.23309Z","caller":"traceutil/trace.go:171","msg":"trace[2103244602] range","detail":"{range_begin:/registry/rabbitmq.com/bindings/; range_end:/registry/rabbitmq.com/bindings0; response_count:0; response_revision:2762; }","duration":"199.453996ms","start":"2026-06-25T22:21:22.033624Z","end":"2026-06-25T22:21:22.233078Z","steps":["trace[2103244602] 'agreement among raft nodes before linearized reading' (duration: 199.374252ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:21:22.233193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.251566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18bc730f4a8b9285\" ","response":"range_response_count:1 size:781"} {"level":"info","ts":"2026-06-25T22:21:22.233281Z","caller":"traceutil/trace.go:171","msg":"trace[727488882] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18bc730f4a8b9285; range_end:; response_count:1; response_revision:2762; }","duration":"186.400203ms","start":"2026-06-25T22:21:22.046861Z","end":"2026-06-25T22:21:22.233261Z","steps":["trace[727488882] 'agreement among raft nodes before linearized reading' (duration: 186.143251ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:21:22.233246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.807006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-25T22:21:22.233347Z","caller":"traceutil/trace.go:171","msg":"trace[422825074] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:2762; }","duration":"164.941871ms","start":"2026-06-25T22:21:22.068383Z","end":"2026-06-25T22:21:22.233324Z","steps":["trace[422825074] 'agreement among raft nodes before linearized reading' (duration: 164.320414ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:21:22.233621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.235095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-metrics\" ","response":"range_response_count:1 size:1377"} {"level":"info","ts":"2026-06-25T22:21:22.233668Z","caller":"traceutil/trace.go:171","msg":"trace[1126252163] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-metrics; range_end:; response_count:1; response_revision:2762; }","duration":"331.327009ms","start":"2026-06-25T22:21:21.90233Z","end":"2026-06-25T22:21:22.233657Z","steps":["trace[1126252163] 'agreement among raft nodes before linearized reading' (duration: 330.259442ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:21:22.233705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:21:21.902312Z","time spent":"331.384582ms","remote":"127.0.0.1:54080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":1399,"request content":"key:\"/registry/services/specs/auth-system/keycloak-metrics\" "} {"level":"warn","ts":"2026-06-25T22:23:40.566699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.152499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ea352ecb-bcde-4c93-8866-82a58177d3c7\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-06-25T22:23:40.566758Z","caller":"traceutil/trace.go:171","msg":"trace[671477808] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ea352ecb-bcde-4c93-8866-82a58177d3c7; range_end:; response_count:1; response_revision:4448; }","duration":"107.256582ms","start":"2026-06-25T22:23:40.459488Z","end":"2026-06-25T22:23:40.566745Z","steps":["trace[671477808] 'range keys from in-memory index tree' (duration: 106.960235ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:23:40.599776Z","caller":"traceutil/trace.go:171","msg":"trace[916016176] linearizableReadLoop","detail":"{readStateIndex:4635; appliedIndex:4634; }","duration":"111.417676ms","start":"2026-06-25T22:23:40.488326Z","end":"2026-06-25T22:23:40.599743Z","steps":["trace[916016176] 'read index received' (duration: 111.342264ms)","trace[916016176] 'applied index is now lower than readState.Index' (duration: 74.002µs)"],"step_count":2} {"level":"warn","ts":"2026-06-25T22:23:40.59993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.574089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-25T22:23:40.600098Z","caller":"traceutil/trace.go:171","msg":"trace[1155706015] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:4449; }","duration":"111.771734ms","start":"2026-06-25T22:23:40.488313Z","end":"2026-06-25T22:23:40.600084Z","steps":["trace[1155706015] 'agreement among raft nodes before linearized reading' (duration: 111.519848ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:23:40.599793Z","caller":"traceutil/trace.go:171","msg":"trace[820096565] transaction","detail":"{read_only:false; response_revision:4449; number_of_response:1; }","duration":"135.946489ms","start":"2026-06-25T22:23:40.463825Z","end":"2026-06-25T22:23:40.599771Z","steps":["trace[820096565] 'process raft request' (duration: 135.752515ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:23:40.636246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.047752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ea352ecb-bcde-4c93-8866-82a58177d3c7\" ","response":"range_response_count:1 size:3763"} {"level":"info","ts":"2026-06-25T22:23:40.636363Z","caller":"traceutil/trace.go:171","msg":"trace[856389780] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ea352ecb-bcde-4c93-8866-82a58177d3c7; range_end:; response_count:1; response_revision:4450; }","duration":"121.209636ms","start":"2026-06-25T22:23:40.515135Z","end":"2026-06-25T22:23:40.636345Z","steps":["trace[856389780] 'agreement among raft nodes before linearized reading' (duration: 121.016822ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:23:52.046767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.568377ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:39"} {"level":"info","ts":"2026-06-25T22:27:08.967524Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3173} {"level":"info","ts":"2026-06-25T22:27:09.085184Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3173,"took":"115.802082ms","hash":446136787,"current-db-size-bytes":58306560,"current-db-size":"58 MB","current-db-size-in-use-bytes":31956992,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-25T22:27:09.085249Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":446136787,"revision":3173,"compact-revision":-1} {"level":"info","ts":"2026-06-25T22:27:38.061255Z","caller":"traceutil/trace.go:171","msg":"trace[509045366] transaction","detail":"{read_only:false; response_revision:6635; number_of_response:1; }","duration":"101.119979ms","start":"2026-06-25T22:27:37.960118Z","end":"2026-06-25T22:27:38.061238Z","steps":["trace[509045366] 'process raft request' (duration: 100.799423ms)"],"step_count":1}