{"level":"warn","ts":"2026-04-29T14:54:22.473445Z","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-29T14:54:22.473539Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.210: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.210:2380","--initial-cluster=instance=https://199.204.45.210:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.210:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.210: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-29T14:54:22.473608Z","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-29T14:54:22.47362Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.210:2380"]} {"level":"info","ts":"2026-04-29T14:54:22.473643Z","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-29T14:54:22.474269Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"]} {"level":"info","ts":"2026-04-29T14:54:22.474342Z","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.210:2380"],"listen-peer-urls":["https://199.204.45.210:2380"],"advertise-client-urls":["https://199.204.45.210:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.210: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-29T14:54:22.47808Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.540484ms"} {"level":"info","ts":"2026-04-29T14:54:22.485749Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1cac722af8b2b8a6","cluster-id":"ba0a336ca61ee41d"} {"level":"info","ts":"2026-04-29T14:54:22.485816Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=()"} {"level":"info","ts":"2026-04-29T14:54:22.485833Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became follower at term 0"} {"level":"info","ts":"2026-04-29T14:54:22.485843Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1cac722af8b2b8a6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-29T14:54:22.485851Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became follower at term 1"} {"level":"info","ts":"2026-04-29T14:54:22.48588Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=(2066151857942870182)"} {"level":"warn","ts":"2026-04-29T14:54:22.493355Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-29T14:54:22.495437Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-29T14:54:22.496545Z","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-29T14:54:22.498472Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1cac722af8b2b8a6","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-29T14:54:22.498621Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1cac722af8b2b8a6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-29T14:54:22.498784Z","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-29T14:54:22.500077Z","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-29T14:54:22.500089Z","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-29T14:54:22.506827Z","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-29T14:54:22.50701Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1cac722af8b2b8a6","initial-advertise-peer-urls":["https://199.204.45.210:2380"],"listen-peer-urls":["https://199.204.45.210:2380"],"advertise-client-urls":["https://199.204.45.210:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-29T14:54:22.507033Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-29T14:54:22.507092Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.210:2380"} {"level":"info","ts":"2026-04-29T14:54:22.507115Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.210:2380"} {"level":"info","ts":"2026-04-29T14:54:22.50722Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=(2066151857942870182)"} {"level":"info","ts":"2026-04-29T14:54:22.50734Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ba0a336ca61ee41d","local-member-id":"1cac722af8b2b8a6","added-peer-id":"1cac722af8b2b8a6","added-peer-peer-urls":["https://199.204.45.210:2380"]} {"level":"info","ts":"2026-04-29T14:54:22.786021Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 is starting a new election at term 1"} {"level":"info","ts":"2026-04-29T14:54:22.786092Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-29T14:54:22.786128Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 received MsgPreVoteResp from 1cac722af8b2b8a6 at term 1"} {"level":"info","ts":"2026-04-29T14:54:22.786149Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became candidate at term 2"} {"level":"info","ts":"2026-04-29T14:54:22.786161Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 received MsgVoteResp from 1cac722af8b2b8a6 at term 2"} {"level":"info","ts":"2026-04-29T14:54:22.786203Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became leader at term 2"} {"level":"info","ts":"2026-04-29T14:54:22.786222Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1cac722af8b2b8a6 elected leader 1cac722af8b2b8a6 at term 2"} {"level":"info","ts":"2026-04-29T14:54:22.787095Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-29T14:54:22.787982Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-29T14:54:22.787978Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1cac722af8b2b8a6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.210:2379]}","request-path":"/0/members/1cac722af8b2b8a6/attributes","cluster-id":"ba0a336ca61ee41d","publish-timeout":"7s"} {"level":"info","ts":"2026-04-29T14:54:22.788034Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-29T14:54:22.788313Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ba0a336ca61ee41d","local-member-id":"1cac722af8b2b8a6","cluster-version":"3.5"} {"level":"info","ts":"2026-04-29T14:54:22.788445Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-29T14:54:22.788432Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-29T14:54:22.788526Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-29T14:54:22.78854Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-29T14:54:22.791447Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-29T14:54:22.79172Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.210:2379"} {"level":"info","ts":"2026-04-29T14:54:33.886219Z","caller":"traceutil/trace.go:171","msg":"trace[1048327855] transaction","detail":"{read_only:false; response_revision:388; number_of_response:1; }","duration":"274.263191ms","start":"2026-04-29T14:54:33.611933Z","end":"2026-04-29T14:54:33.886196Z","steps":["trace[1048327855] 'process raft request' (duration: 273.983843ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T14:54:34.119342Z","caller":"traceutil/trace.go:171","msg":"trace[1783899989] transaction","detail":"{read_only:false; response_revision:390; number_of_response:1; }","duration":"171.384597ms","start":"2026-04-29T14:54:33.947932Z","end":"2026-04-29T14:54:34.119317Z","steps":["trace[1783899989] 'process raft request' (duration: 164.975714ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T14:54:34.445428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.738742ms","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-29T14:54:34.445566Z","caller":"traceutil/trace.go:171","msg":"trace[1437670948] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:390; }","duration":"128.937507ms","start":"2026-04-29T14:54:34.316603Z","end":"2026-04-29T14:54:34.44554Z","steps":["trace[1437670948] 'range keys from in-memory index tree' (duration: 128.587908ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T14:54:34.822213Z","caller":"traceutil/trace.go:171","msg":"trace[739696095] transaction","detail":"{read_only:false; response_revision:391; number_of_response:1; }","duration":"371.427732ms","start":"2026-04-29T14:54:34.45075Z","end":"2026-04-29T14:54:34.822177Z","steps":["trace[739696095] 'process raft request' (duration: 371.210426ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T14:54:34.823046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T14:54:34.450711Z","time spent":"371.611028ms","remote":"127.0.0.1:42216","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-29T14:54:35.854717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"605.604235ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-29T14:54:35.854822Z","caller":"traceutil/trace.go:171","msg":"trace[613271012] linearizableReadLoop","detail":"{readStateIndex:404; appliedIndex:402; }","duration":"1.046854718s","start":"2026-04-29T14:54:34.807952Z","end":"2026-04-29T14:54:35.854807Z","steps":["trace[613271012] 'read index received' (duration: 14.0033ms)","trace[613271012] 'applied index is now lower than readState.Index' (duration: 1.032850368s)"],"step_count":2} {"level":"info","ts":"2026-04-29T14:54:35.854947Z","caller":"traceutil/trace.go:171","msg":"trace[1328427673] transaction","detail":"{read_only:false; response_revision:392; number_of_response:1; }","duration":"1.177213367s","start":"2026-04-29T14:54:34.677686Z","end":"2026-04-29T14:54:35.854899Z","steps":["trace[1328427673] 'process raft request' (duration: 571.174129ms)","trace[1328427673] 'compare' (duration: 605.484772ms)"],"step_count":2} {"level":"warn","ts":"2026-04-29T14:54:35.855008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T14:54:34.67766Z","time spent":"1.17731669s","remote":"127.0.0.1:42216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-29T14:54:35.855003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"697.108147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-29T14:54:35.855081Z","caller":"traceutil/trace.go:171","msg":"trace[1400896309] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:392; }","duration":"697.268051ms","start":"2026-04-29T14:54:35.157793Z","end":"2026-04-29T14:54:35.855061Z","steps":["trace[1400896309] 'agreement among raft nodes before linearized reading' (duration: 697.133777ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T14:54:35.855166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T14:54:35.157742Z","time spent":"697.412746ms","remote":"127.0.0.1:42216","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-04-29T14:54:35.855337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.047391835s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-29T14:54:35.85537Z","caller":"traceutil/trace.go:171","msg":"trace[1347730157] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:392; }","duration":"1.047486817s","start":"2026-04-29T14:54:34.807874Z","end":"2026-04-29T14:54:35.85536Z","steps":["trace[1347730157] 'agreement among raft nodes before linearized reading' (duration: 1.047422045s)"],"step_count":1} {"level":"warn","ts":"2026-04-29T14:54:35.855389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.264912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6965"} {"level":"warn","ts":"2026-04-29T14:54:35.855402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T14:54:34.807853Z","time spent":"1.047543129s","remote":"127.0.0.1:42216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-29T14:54:35.855427Z","caller":"traceutil/trace.go:171","msg":"trace[758091506] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:392; }","duration":"362.340314ms","start":"2026-04-29T14:54:35.493075Z","end":"2026-04-29T14:54:35.855415Z","steps":["trace[758091506] 'agreement among raft nodes before linearized reading' (duration: 362.274702ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T14:54:35.855464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T14:54:35.493052Z","time spent":"362.403226ms","remote":"127.0.0.1:42128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":6988,"request content":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" "} {"level":"info","ts":"2026-04-29T14:54:52.139278Z","caller":"traceutil/trace.go:171","msg":"trace[1096041402] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"199.944266ms","start":"2026-04-29T14:54:51.939306Z","end":"2026-04-29T14:54:52.13925Z","steps":["trace[1096041402] 'process raft request' (duration: 199.748492ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T14:54:52.301241Z","caller":"traceutil/trace.go:171","msg":"trace[1747139744] linearizableReadLoop","detail":"{readStateIndex:521; appliedIndex:519; }","duration":"342.932123ms","start":"2026-04-29T14:54:51.958285Z","end":"2026-04-29T14:54:52.301217Z","steps":["trace[1747139744] 'read index received' (duration: 180.746746ms)","trace[1747139744] 'applied index is now lower than readState.Index' (duration: 162.184347ms)"],"step_count":2} {"level":"warn","ts":"2026-04-29T14:54:52.301534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.22882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-29T14:54:52.301578Z","caller":"traceutil/trace.go:171","msg":"trace[2096526499] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"360.872862ms","start":"2026-04-29T14:54:51.940672Z","end":"2026-04-29T14:54:52.301545Z","steps":["trace[2096526499] 'process raft request' (duration: 357.90704ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T14:54:52.301618Z","caller":"traceutil/trace.go:171","msg":"trace[189208851] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:504; }","duration":"343.366253ms","start":"2026-04-29T14:54:51.958232Z","end":"2026-04-29T14:54:52.301598Z","steps":["trace[189208851] 'agreement among raft nodes before linearized reading' (duration: 343.175309ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T14:54:52.301668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T14:54:51.958212Z","time spent":"343.446886ms","remote":"127.0.0.1:42216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-29T14:54:52.301824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T14:54:51.940657Z","time spent":"361.006855ms","remote":"127.0.0.1:42216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-29T14:54:52.301989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.242023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-29T14:54:52.302077Z","caller":"traceutil/trace.go:171","msg":"trace[974578816] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:504; }","duration":"310.719615ms","start":"2026-04-29T14:54:51.991309Z","end":"2026-04-29T14:54:52.302028Z","steps":["trace[974578816] 'agreement among raft nodes before linearized reading' (duration: 310.181552ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T14:54:52.302125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T14:54:51.991289Z","time spent":"310.823498ms","remote":"127.0.0.1:42036","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" "} {"level":"warn","ts":"2026-04-29T14:54:58.494372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.719893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-29T14:54:58.494444Z","caller":"traceutil/trace.go:171","msg":"trace[632187496] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:608; }","duration":"288.808555ms","start":"2026-04-29T14:54:58.205622Z","end":"2026-04-29T14:54:58.494431Z","steps":["trace[632187496] 'range keys from in-memory index tree' (duration: 288.663901ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T14:54:58.494434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.344972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-29T14:54:58.494512Z","caller":"traceutil/trace.go:171","msg":"trace[556881410] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:608; }","duration":"336.455865ms","start":"2026-04-29T14:54:58.158035Z","end":"2026-04-29T14:54:58.494491Z","steps":["trace[556881410] 'range keys from in-memory index tree' (duration: 336.25663ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T14:54:58.494549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T14:54:58.158019Z","time spent":"336.521846ms","remote":"127.0.0.1:42216","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-04-29T14:54:58.494569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.650476ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-29T14:54:58.49461Z","caller":"traceutil/trace.go:171","msg":"trace[2024059959] linearizableReadLoop","detail":"{readStateIndex:632; appliedIndex:631; }","duration":"161.303124ms","start":"2026-04-29T14:54:58.333298Z","end":"2026-04-29T14:54:58.494601Z","steps":["trace[2024059959] 'read index received' (duration: 25.041µs)","trace[2024059959] 'applied index is now lower than readState.Index' (duration: 161.276403ms)"],"step_count":2} {"level":"info","ts":"2026-04-29T14:54:58.494682Z","caller":"traceutil/trace.go:171","msg":"trace[730176227] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"258.317471ms","start":"2026-04-29T14:54:58.236359Z","end":"2026-04-29T14:54:58.494677Z","steps":["trace[730176227] 'process raft request' (duration: 91.514952ms)","trace[730176227] 'compare' (duration: 166.576844ms)"],"step_count":2} {"level":"warn","ts":"2026-04-29T14:54:58.494745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.443107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-29T14:54:58.494763Z","caller":"traceutil/trace.go:171","msg":"trace[708838142] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:609; }","duration":"161.490907ms","start":"2026-04-29T14:54:58.333267Z","end":"2026-04-29T14:54:58.494757Z","steps":["trace[708838142] 'agreement among raft nodes before linearized reading' (duration: 161.426596ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T14:54:58.805238Z","caller":"traceutil/trace.go:171","msg":"trace[757101924] linearizableReadLoop","detail":"{readStateIndex:633; appliedIndex:632; }","duration":"310.592098ms","start":"2026-04-29T14:54:58.494622Z","end":"2026-04-29T14:54:58.805214Z","steps":["trace[757101924] 'read index received' (duration: 309.79186ms)","trace[757101924] 'applied index is now lower than readState.Index' (duration: 799.138µs)"],"step_count":2} {"level":"info","ts":"2026-04-29T14:54:58.805305Z","caller":"traceutil/trace.go:171","msg":"trace[97971408] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"327.783224ms","start":"2026-04-29T14:54:58.477495Z","end":"2026-04-29T14:54:58.805278Z","steps":["trace[97971408] 'process raft request' (duration: 327.13962ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T14:54:58.805443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T14:54:58.477477Z","time spent":"327.889807ms","remote":"127.0.0.1:42036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-29T14:54:58.805474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.132353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-29T14:54:58.805515Z","caller":"traceutil/trace.go:171","msg":"trace[475370516] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:610; }","duration":"471.211134ms","start":"2026-04-29T14:54:58.334292Z","end":"2026-04-29T14:54:58.805503Z","steps":["trace[475370516] 'agreement among raft nodes before linearized reading' (duration: 471.02951ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T14:54:58.805557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T14:54:58.334284Z","time spent":"471.263496ms","remote":"127.0.0.1:42216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-29T14:54:59.423666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.990372ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-29T14:54:59.423972Z","caller":"traceutil/trace.go:171","msg":"trace[1760766376] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"926.516404ms","start":"2026-04-29T14:54:58.497427Z","end":"2026-04-29T14:54:59.423943Z","steps":["trace[1760766376] 'process raft request' (duration: 455.128333ms)","trace[1760766376] 'compare' (duration: 470.696975ms)"],"step_count":2} {"level":"info","ts":"2026-04-29T14:54:59.424094Z","caller":"traceutil/trace.go:171","msg":"trace[132821541] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"614.610647ms","start":"2026-04-29T14:54:58.809459Z","end":"2026-04-29T14:54:59.424069Z","steps":["trace[132821541] 'process raft request' (duration: 614.467924ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T14:54:59.424131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T14:54:58.497419Z","time spent":"926.640667ms","remote":"127.0.0.1:42216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-29T14:54:59.424207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T14:54:58.809434Z","time spent":"614.724689ms","remote":"127.0.0.1:42216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-29T14:54:59.424243Z","caller":"traceutil/trace.go:171","msg":"trace[468817919] linearizableReadLoop","detail":"{readStateIndex:635; appliedIndex:633; }","duration":"618.933215ms","start":"2026-04-29T14:54:58.8053Z","end":"2026-04-29T14:54:59.424233Z","steps":["trace[468817919] 'read index received' (duration: 147.31683ms)","trace[468817919] 'applied index is now lower than readState.Index' (duration: 471.615415ms)"],"step_count":2} {"level":"info","ts":"2026-04-29T14:54:59.424251Z","caller":"traceutil/trace.go:171","msg":"trace[718239953] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"925.954691ms","start":"2026-04-29T14:54:58.498266Z","end":"2026-04-29T14:54:59.424221Z","steps":["trace[718239953] 'process raft request' (duration: 925.526391ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T14:54:59.424346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T14:54:58.498261Z","time spent":"926.039233ms","remote":"127.0.0.1:42216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-29T14:54:59.424574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"928.9233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-29T14:54:59.424628Z","caller":"traceutil/trace.go:171","msg":"trace[530950959] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:613; }","duration":"929.013702ms","start":"2026-04-29T14:54:58.495602Z","end":"2026-04-29T14:54:59.424615Z","steps":["trace[530950959] 'agreement among raft nodes before linearized reading' (duration: 928.704305ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T14:54:59.424662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T14:54:58.495592Z","time spent":"929.062543ms","remote":"127.0.0.1:41950","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-29T14:54:59.42472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"578.342698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-w27fx\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-29T14:54:59.424782Z","caller":"traceutil/trace.go:171","msg":"trace[1136498032] range","detail":"{range_begin:/registry/pods/kube-system/cilium-w27fx; range_end:; response_count:1; response_revision:614; }","duration":"578.443091ms","start":"2026-04-29T14:54:58.846327Z","end":"2026-04-29T14:54:59.42477Z","steps":["trace[1136498032] 'agreement among raft nodes before linearized reading' (duration: 578.265697ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T14:54:59.424814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T14:54:58.846309Z","time spent":"578.498201ms","remote":"127.0.0.1:42128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-w27fx\" "} {"level":"info","ts":"2026-04-29T14:54:59.42485Z","caller":"traceutil/trace.go:171","msg":"trace[465900031] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"557.281602ms","start":"2026-04-29T14:54:58.867481Z","end":"2026-04-29T14:54:59.424762Z","steps":["trace[465900031] 'process raft request' (duration: 556.548286ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T14:54:59.424952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.794245ms","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-29T14:54:59.424992Z","caller":"traceutil/trace.go:171","msg":"trace[1678219961] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:614; }","duration":"460.869427ms","start":"2026-04-29T14:54:58.964114Z","end":"2026-04-29T14:54:59.424983Z","steps":["trace[1678219961] 'agreement among raft nodes before linearized reading' (duration: 460.767365ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T14:54:59.425024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T14:54:58.964098Z","time spent":"460.920078ms","remote":"127.0.0.1:42216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-29T14:54:59.425139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T14:54:58.867447Z","time spent":"557.578389ms","remote":"127.0.0.1:42450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-29T14:54:59.960077Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305495707598395906,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-29T14:55:00.460296Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305495707598395906,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-29T14:55:00.961182Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305495707598395906,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-29T14:55:01.42935Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.969612825s","expected-duration":"1s"} {"level":"info","ts":"2026-04-29T14:55:01.429782Z","caller":"traceutil/trace.go:171","msg":"trace[690089978] linearizableReadLoop","detail":"{readStateIndex:639; appliedIndex:638; }","duration":"1.969953312s","start":"2026-04-29T14:54:59.45981Z","end":"2026-04-29T14:55:01.429763Z","steps":["trace[690089978] 'read index received' (duration: 1.969757958s)","trace[690089978] 'applied index is now lower than readState.Index' (duration: 194.454µs)"],"step_count":2} {"level":"info","ts":"2026-04-29T14:55:01.429818Z","caller":"traceutil/trace.go:171","msg":"trace[310658598] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"1.991534146s","start":"2026-04-29T14:54:59.438269Z","end":"2026-04-29T14:55:01.429803Z","steps":["trace[310658598] 'process raft request' (duration: 1.991329862s)"],"step_count":1} {"level":"warn","ts":"2026-04-29T14:55:01.429903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.993442251s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-29T14:55:01.429952Z","caller":"traceutil/trace.go:171","msg":"trace[680633465] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:616; }","duration":"1.993508372s","start":"2026-04-29T14:54:59.436424Z","end":"2026-04-29T14:55:01.429933Z","steps":["trace[680633465] 'agreement among raft nodes before linearized reading' (duration: 1.99343847s)"],"step_count":1} {"level":"warn","ts":"2026-04-29T14:55:01.430019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T14:54:59.436417Z","time spent":"1.993586654s","remote":"127.0.0.1:42192","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-04-29T14:55:01.430027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T14:54:59.438253Z","time spent":"1.99167169s","remote":"127.0.0.1:42128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-29T14:55:01.439929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.234125982s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-29T14:55:01.439981Z","caller":"traceutil/trace.go:171","msg":"trace[954066825] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:616; }","duration":"1.234227884s","start":"2026-04-29T14:55:00.205739Z","end":"2026-04-29T14:55:01.439967Z","steps":["trace[954066825] 'agreement among raft nodes before linearized reading' (duration: 1.234141143s)"],"step_count":1} {"level":"warn","ts":"2026-04-29T14:55:01.440047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T14:55:00.205718Z","time spent":"1.234321166s","remote":"127.0.0.1:41950","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-29T14:55:01.440113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"611.834072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-29T14:55:01.440187Z","caller":"traceutil/trace.go:171","msg":"trace[99030108] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:616; }","duration":"611.946036ms","start":"2026-04-29T14:55:00.828225Z","end":"2026-04-29T14:55:01.440171Z","steps":["trace[99030108] 'agreement among raft nodes before linearized reading' (duration: 611.856683ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T14:55:01.440221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T14:55:00.828205Z","time spent":"612.008337ms","remote":"127.0.0.1:41964","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-29T14:55:03.227803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.776874ms","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-29T14:55:03.227832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.05052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-29T14:55:03.227903Z","caller":"traceutil/trace.go:171","msg":"trace[880486167] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:650; }","duration":"169.964518ms","start":"2026-04-29T14:55:03.057916Z","end":"2026-04-29T14:55:03.227881Z","steps":["trace[880486167] 'count revisions from in-memory index tree' (duration: 169.670602ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T14:55:03.227902Z","caller":"traceutil/trace.go:171","msg":"trace[1466930166] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:650; }","duration":"170.169583ms","start":"2026-04-29T14:55:03.057717Z","end":"2026-04-29T14:55:03.227887Z","steps":["trace[1466930166] 'range keys from in-memory index tree' (duration: 169.939668ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T14:55:03.231321Z","caller":"traceutil/trace.go:171","msg":"trace[665506832] linearizableReadLoop","detail":"{readStateIndex:675; appliedIndex:674; }","duration":"141.372214ms","start":"2026-04-29T14:55:03.089929Z","end":"2026-04-29T14:55:03.231301Z","steps":["trace[665506832] 'read index received' (duration: 141.229411ms)","trace[665506832] 'applied index is now lower than readState.Index' (duration: 141.163µs)"],"step_count":2} {"level":"info","ts":"2026-04-29T14:55:03.231371Z","caller":"traceutil/trace.go:171","msg":"trace[586551049] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"151.285514ms","start":"2026-04-29T14:55:03.080056Z","end":"2026-04-29T14:55:03.231341Z","steps":["trace[586551049] 'process raft request' (duration: 151.11128ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T14:55:03.231532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.586649ms","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-29T14:55:03.231608Z","caller":"traceutil/trace.go:171","msg":"trace[425608647] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:651; }","duration":"141.688502ms","start":"2026-04-29T14:55:03.089901Z","end":"2026-04-29T14:55:03.23159Z","steps":["trace[425608647] 'agreement among raft nodes before linearized reading' (duration: 141.496058ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T14:55:03.235361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.315721ms","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":"info","ts":"2026-04-29T14:55:03.235491Z","caller":"traceutil/trace.go:171","msg":"trace[750440622] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:652; }","duration":"145.509255ms","start":"2026-04-29T14:55:03.089964Z","end":"2026-04-29T14:55:03.235473Z","steps":["trace[750440622] 'agreement among raft nodes before linearized reading' (duration: 145.289161ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T14:55:03.235862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.918375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-29T14:55:03.2359Z","caller":"traceutil/trace.go:171","msg":"trace[1034843659] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:652; }","duration":"122.996346ms","start":"2026-04-29T14:55:03.112894Z","end":"2026-04-29T14:55:03.23589Z","steps":["trace[1034843659] 'agreement among raft nodes before linearized reading' (duration: 122.942005ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T14:55:03.236114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.283824ms","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-29T14:55:03.236158Z","caller":"traceutil/trace.go:171","msg":"trace[54839557] 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:652; }","duration":"100.327805ms","start":"2026-04-29T14:55:03.135817Z","end":"2026-04-29T14:55:03.236145Z","steps":["trace[54839557] 'agreement among raft nodes before linearized reading' (duration: 100.269984ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T14:55:03.236195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.819733ms","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-29T14:55:03.236271Z","caller":"traceutil/trace.go:171","msg":"trace[534579312] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:652; }","duration":"145.936785ms","start":"2026-04-29T14:55:03.090314Z","end":"2026-04-29T14:55:03.236251Z","steps":["trace[534579312] 'agreement among raft nodes before linearized reading' (duration: 145.832403ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T14:55:03.236316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.502628ms","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":"info","ts":"2026-04-29T14:55:03.236357Z","caller":"traceutil/trace.go:171","msg":"trace[2045517948] 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:652; }","duration":"100.549969ms","start":"2026-04-29T14:55:03.135798Z","end":"2026-04-29T14:55:03.236348Z","steps":["trace[2045517948] 'agreement among raft nodes before linearized reading' (duration: 100.485328ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T14:55:03.236464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.48039ms","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-29T14:55:03.236489Z","caller":"traceutil/trace.go:171","msg":"trace[432512861] 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:652; }","duration":"101.5215ms","start":"2026-04-29T14:55:03.134961Z","end":"2026-04-29T14:55:03.236483Z","steps":["trace[432512861] 'agreement among raft nodes before linearized reading' (duration: 101.482119ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T14:55:03.23672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.734195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-29T14:55:03.236796Z","caller":"traceutil/trace.go:171","msg":"trace[1490331799] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:652; }","duration":"124.816707ms","start":"2026-04-29T14:55:03.11195Z","end":"2026-04-29T14:55:03.236767Z","steps":["trace[1490331799] 'agreement among raft nodes before linearized reading' (duration: 124.715725ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T14:55:03.23945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.881287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-29T14:55:03.239492Z","caller":"traceutil/trace.go:171","msg":"trace[446268841] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:652; }","duration":"127.500916ms","start":"2026-04-29T14:55:03.111978Z","end":"2026-04-29T14:55:03.239479Z","steps":["trace[446268841] 'agreement among raft nodes before linearized reading' (duration: 123.875957ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T14:55:06.183762Z","caller":"traceutil/trace.go:171","msg":"trace[53602819] linearizableReadLoop","detail":"{readStateIndex:719; appliedIndex:718; }","duration":"105.26132ms","start":"2026-04-29T14:55:06.078476Z","end":"2026-04-29T14:55:06.183737Z","steps":["trace[53602819] 'read index received' (duration: 105.145298ms)","trace[53602819] 'applied index is now lower than readState.Index' (duration: 114.932µs)"],"step_count":2} {"level":"warn","ts":"2026-04-29T14:55:06.183978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.487665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:1 size:24244"} {"level":"info","ts":"2026-04-29T14:55:06.184066Z","caller":"traceutil/trace.go:171","msg":"trace[2006455783] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:1; response_revision:694; }","duration":"105.622658ms","start":"2026-04-29T14:55:06.078423Z","end":"2026-04-29T14:55:06.184046Z","steps":["trace[2006455783] 'agreement among raft nodes before linearized reading' (duration: 105.398973ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T14:55:16.914103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"886.279463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.210\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-29T14:55:16.914186Z","caller":"traceutil/trace.go:171","msg":"trace[317990845] range","detail":"{range_begin:/registry/masterleases/199.204.45.210; range_end:; response_count:1; response_revision:777; }","duration":"886.416345ms","start":"2026-04-29T14:55:16.027752Z","end":"2026-04-29T14:55:16.914168Z","steps":["trace[317990845] 'range keys from in-memory index tree' (duration: 886.11948ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T14:55:16.914204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"971.932715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-97t42\" ","response":"range_response_count:1 size:3965"} {"level":"warn","ts":"2026-04-29T14:55:16.9141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"707.795793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-29T14:55:16.914272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T14:55:16.027729Z","time spent":"886.490236ms","remote":"127.0.0.1:41982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.210\" "} {"level":"info","ts":"2026-04-29T14:55:16.914296Z","caller":"traceutil/trace.go:171","msg":"trace[489761764] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-97t42; range_end:; response_count:1; response_revision:777; }","duration":"972.055697ms","start":"2026-04-29T14:55:15.942219Z","end":"2026-04-29T14:55:16.914275Z","steps":["trace[489761764] 'range keys from in-memory index tree' (duration: 971.771811ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T14:55:16.914301Z","caller":"traceutil/trace.go:171","msg":"trace[38208374] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:777; }","duration":"708.045348ms","start":"2026-04-29T14:55:16.20624Z","end":"2026-04-29T14:55:16.914285Z","steps":["trace[38208374] 'range keys from in-memory index tree' (duration: 707.711621ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T14:55:16.914345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T14:55:15.942197Z","time spent":"972.137339ms","remote":"127.0.0.1:42128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3988,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-97t42\" "} {"level":"warn","ts":"2026-04-29T14:55:16.914417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T14:55:16.206224Z","time spent":"708.1802ms","remote":"127.0.0.1:41964","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-29T14:55:17.16516Z","caller":"traceutil/trace.go:171","msg":"trace[1975699782] transaction","detail":"{read_only:false; response_revision:778; number_of_response:1; }","duration":"424.202668ms","start":"2026-04-29T14:55:16.740923Z","end":"2026-04-29T14:55:17.165126Z","steps":["trace[1975699782] 'process raft request' (duration: 424.027784ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T14:55:17.165351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.076765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-29T14:55:17.165412Z","caller":"traceutil/trace.go:171","msg":"trace[1047657664] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:778; }","duration":"424.186647ms","start":"2026-04-29T14:55:16.741213Z","end":"2026-04-29T14:55:17.165399Z","steps":["trace[1047657664] 'agreement among raft nodes before linearized reading' (duration: 423.979183ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T14:55:17.16545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T14:55:16.741191Z","time spent":"424.251469ms","remote":"127.0.0.1:42216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-29T14:55:17.165143Z","caller":"traceutil/trace.go:171","msg":"trace[1302576419] linearizableReadLoop","detail":"{readStateIndex:805; appliedIndex:804; }","duration":"423.83059ms","start":"2026-04-29T14:55:16.74126Z","end":"2026-04-29T14:55:17.165091Z","steps":["trace[1302576419] 'read index received' (duration: 423.81172ms)","trace[1302576419] 'applied index is now lower than readState.Index' (duration: 17.97µs)"],"step_count":2} {"level":"warn","ts":"2026-04-29T14:55:17.16593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T14:55:16.740899Z","time spent":"424.338061ms","remote":"127.0.0.1:42216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-29T14:55:17.226702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T14:55:16.915174Z","time spent":"311.521403ms","remote":"127.0.0.1:41982","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-29T14:55:17.226866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.621896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-29T14:55:17.226912Z","caller":"traceutil/trace.go:171","msg":"trace[435258966] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:779; }","duration":"311.695897ms","start":"2026-04-29T14:55:16.915206Z","end":"2026-04-29T14:55:17.226902Z","steps":["trace[435258966] 'agreement among raft nodes before linearized reading' (duration: 311.482682ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T14:55:17.226945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T14:55:16.915191Z","time spent":"311.746597ms","remote":"127.0.0.1:41950","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-29T14:55:17.226769Z","caller":"traceutil/trace.go:171","msg":"trace[1108043823] transaction","detail":"{read_only:false; response_revision:779; number_of_response:1; }","duration":"303.756857ms","start":"2026-04-29T14:55:16.922991Z","end":"2026-04-29T14:55:17.226748Z","steps":["trace[1108043823] 'process raft request' (duration: 303.590264ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T14:55:17.22733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T14:55:16.922971Z","time spent":"304.083595ms","remote":"127.0.0.1:42128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4025,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-29T14:57:11.495585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.553354ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-29T14:57:11.495754Z","caller":"traceutil/trace.go:171","msg":"trace[127665664] linearizableReadLoop","detail":"{readStateIndex:1385; appliedIndex:1384; }","duration":"289.273306ms","start":"2026-04-29T14:57:11.206459Z","end":"2026-04-29T14:57:11.495732Z","steps":["trace[127665664] 'read index received' (duration: 159.52805ms)","trace[127665664] 'applied index is now lower than readState.Index' (duration: 129.743296ms)"],"step_count":2} {"level":"warn","ts":"2026-04-29T14:57:11.495914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.438519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-29T14:57:11.495998Z","caller":"traceutil/trace.go:171","msg":"trace[937177110] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1330; }","duration":"289.58054ms","start":"2026-04-29T14:57:11.2064Z","end":"2026-04-29T14:57:11.495981Z","steps":["trace[937177110] 'agreement among raft nodes before linearized reading' (duration: 289.427088ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T14:57:11.735923Z","caller":"traceutil/trace.go:171","msg":"trace[626674938] linearizableReadLoop","detail":"{readStateIndex:1386; appliedIndex:1385; }","duration":"240.123889ms","start":"2026-04-29T14:57:11.495782Z","end":"2026-04-29T14:57:11.735906Z","steps":["trace[626674938] 'read index received' (duration: 239.963417ms)","trace[626674938] 'applied index is now lower than readState.Index' (duration: 159.672µs)"],"step_count":2} {"level":"warn","ts":"2026-04-29T14:57:11.736043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.403899ms","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-29T14:57:11.73607Z","caller":"traceutil/trace.go:171","msg":"trace[1296483263] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:1331; }","duration":"250.503649ms","start":"2026-04-29T14:57:11.485559Z","end":"2026-04-29T14:57:11.736062Z","steps":["trace[1296483263] 'agreement among raft nodes before linearized reading' (duration: 250.422158ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T14:57:11.736098Z","caller":"traceutil/trace.go:171","msg":"trace[62104101] transaction","detail":"{read_only:false; response_revision:1331; number_of_response:1; }","duration":"503.132776ms","start":"2026-04-29T14:57:11.232951Z","end":"2026-04-29T14:57:11.736084Z","steps":["trace[62104101] 'process raft request' (duration: 502.838132ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T14:57:11.73623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T14:57:11.232918Z","time spent":"503.261938ms","remote":"127.0.0.1:42216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"}