{"level":"warn","ts":"2026-04-21T17:39:56.437855Z","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-21T17:39:56.437967Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.156: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.156:2380","--initial-cluster=instance=https://199.19.213.156:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.156:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.156: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-21T17:39:56.438043Z","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-21T17:39:56.438051Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.156:2380"]} {"level":"info","ts":"2026-04-21T17:39:56.438068Z","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-21T17:39:56.438952Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.156:2379"]} {"level":"info","ts":"2026-04-21T17:39:56.439035Z","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.156:2380"],"listen-peer-urls":["https://199.19.213.156:2380"],"advertise-client-urls":["https://199.19.213.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.156: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-21T17:39:56.445001Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.75473ms"} {"level":"info","ts":"2026-04-21T17:39:56.456607Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"163ef968c92247ab","cluster-id":"59d11c119c278888"} {"level":"info","ts":"2026-04-21T17:39:56.456744Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"163ef968c92247ab switched to configuration voters=()"} {"level":"info","ts":"2026-04-21T17:39:56.456787Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"163ef968c92247ab became follower at term 0"} {"level":"info","ts":"2026-04-21T17:39:56.45681Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 163ef968c92247ab [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-21T17:39:56.456821Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"163ef968c92247ab became follower at term 1"} {"level":"info","ts":"2026-04-21T17:39:56.456878Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"163ef968c92247ab switched to configuration voters=(1602992745836857259)"} {"level":"warn","ts":"2026-04-21T17:39:56.467697Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-21T17:39:56.470132Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-21T17:39:56.47251Z","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-21T17:39:56.475245Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"163ef968c92247ab","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-21T17:39:56.476202Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"163ef968c92247ab","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-21T17:39:56.47814Z","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-21T17:39:56.478256Z","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-21T17:39:56.478275Z","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-21T17:39:56.47839Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"163ef968c92247ab switched to configuration voters=(1602992745836857259)"} {"level":"info","ts":"2026-04-21T17:39:56.480678Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"59d11c119c278888","local-member-id":"163ef968c92247ab","added-peer-id":"163ef968c92247ab","added-peer-peer-urls":["https://199.19.213.156:2380"]} {"level":"info","ts":"2026-04-21T17:39:56.481528Z","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-21T17:39:56.481733Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.156:2380"} {"level":"info","ts":"2026-04-21T17:39:56.481806Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.156:2380"} {"level":"info","ts":"2026-04-21T17:39:56.482004Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"163ef968c92247ab","initial-advertise-peer-urls":["https://199.19.213.156:2380"],"listen-peer-urls":["https://199.19.213.156:2380"],"advertise-client-urls":["https://199.19.213.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-21T17:39:56.482056Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-21T17:39:57.357311Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"163ef968c92247ab is starting a new election at term 1"} {"level":"info","ts":"2026-04-21T17:39:57.357372Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"163ef968c92247ab became pre-candidate at term 1"} {"level":"info","ts":"2026-04-21T17:39:57.357396Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"163ef968c92247ab received MsgPreVoteResp from 163ef968c92247ab at term 1"} {"level":"info","ts":"2026-04-21T17:39:57.357416Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"163ef968c92247ab became candidate at term 2"} {"level":"info","ts":"2026-04-21T17:39:57.357427Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"163ef968c92247ab received MsgVoteResp from 163ef968c92247ab at term 2"} {"level":"info","ts":"2026-04-21T17:39:57.357442Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"163ef968c92247ab became leader at term 2"} {"level":"info","ts":"2026-04-21T17:39:57.357456Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 163ef968c92247ab elected leader 163ef968c92247ab at term 2"} {"level":"info","ts":"2026-04-21T17:39:57.359131Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"163ef968c92247ab","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.156:2379]}","request-path":"/0/members/163ef968c92247ab/attributes","cluster-id":"59d11c119c278888","publish-timeout":"7s"} {"level":"info","ts":"2026-04-21T17:39:57.359144Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T17:39:57.359186Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-21T17:39:57.359148Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-21T17:39:57.359495Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-21T17:39:57.359534Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-21T17:39:57.360226Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"59d11c119c278888","local-member-id":"163ef968c92247ab","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T17:39:57.3604Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T17:39:57.360449Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T17:39:57.363174Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-21T17:39:57.363424Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.156:2379"} {"level":"warn","ts":"2026-04-21T17:39:59.521614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.989462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-21T17:39:59.521732Z","caller":"traceutil/trace.go:171","msg":"trace[1321802810] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:69; }","duration":"528.202486ms","start":"2026-04-21T17:39:58.993503Z","end":"2026-04-21T17:39:59.521705Z","steps":["trace[1321802810] 'range keys from in-memory index tree' (duration: 527.895639ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:39:59.52179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:39:58.99348Z","time spent":"528.299247ms","remote":"127.0.0.1:59738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":26,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"info","ts":"2026-04-21T17:39:59.712048Z","caller":"traceutil/trace.go:171","msg":"trace[1016632786] transaction","detail":"{read_only:false; response_revision:70; number_of_response:1; }","duration":"183.222913ms","start":"2026-04-21T17:39:59.528795Z","end":"2026-04-21T17:39:59.712018Z","steps":["trace[1016632786] 'process raft request' (duration: 183.017539ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:40:34.815394Z","caller":"traceutil/trace.go:171","msg":"trace[529835162] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"212.334182ms","start":"2026-04-21T17:40:34.603022Z","end":"2026-04-21T17:40:34.815357Z","steps":["trace[529835162] 'process raft request' (duration: 211.433922ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:40:34.815532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.955545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-nc22s\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-21T17:40:34.815629Z","caller":"traceutil/trace.go:171","msg":"trace[75548643] range","detail":"{range_begin:/registry/pods/kube-system/cilium-nc22s; range_end:; response_count:1; response_revision:579; }","duration":"129.103549ms","start":"2026-04-21T17:40:34.686495Z","end":"2026-04-21T17:40:34.815598Z","steps":["trace[75548643] 'agreement among raft nodes before linearized reading' (duration: 128.904874ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:40:34.815792Z","caller":"traceutil/trace.go:171","msg":"trace[1861622268] linearizableReadLoop","detail":"{readStateIndex:601; appliedIndex:600; }","duration":"128.611578ms","start":"2026-04-21T17:40:34.686562Z","end":"2026-04-21T17:40:34.815173Z","steps":["trace[1861622268] 'read index received' (duration: 127.521494ms)","trace[1861622268] 'applied index is now lower than readState.Index' (duration: 1.088964ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:40:35.063702Z","caller":"traceutil/trace.go:171","msg":"trace[787294521] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"231.473945ms","start":"2026-04-21T17:40:34.832161Z","end":"2026-04-21T17:40:35.063635Z","steps":["trace[787294521] 'process raft request' (duration: 198.258553ms)","trace[787294521] 'compare' (duration: 32.940536ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:40:35.080209Z","caller":"traceutil/trace.go:171","msg":"trace[1246931910] linearizableReadLoop","detail":"{readStateIndex:603; appliedIndex:601; }","duration":"157.242275ms","start":"2026-04-21T17:40:34.922947Z","end":"2026-04-21T17:40:35.080189Z","steps":["trace[1246931910] 'read index received' (duration: 107.49061ms)","trace[1246931910] 'applied index is now lower than readState.Index' (duration: 49.750695ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:40:35.080414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.45892ms","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-21T17:40:35.080502Z","caller":"traceutil/trace.go:171","msg":"trace[964666308] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:581; }","duration":"157.579083ms","start":"2026-04-21T17:40:34.922895Z","end":"2026-04-21T17:40:35.080474Z","steps":["trace[964666308] 'agreement among raft nodes before linearized reading' (duration: 157.43862ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:40:35.080527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.450555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-21T17:40:35.080587Z","caller":"traceutil/trace.go:171","msg":"trace[542042021] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:581; }","duration":"151.580837ms","start":"2026-04-21T17:40:34.928993Z","end":"2026-04-21T17:40:35.080574Z","steps":["trace[542042021] 'agreement among raft nodes before linearized reading' (duration: 151.420174ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:40:35.080438Z","caller":"traceutil/trace.go:171","msg":"trace[1292814161] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"205.886836ms","start":"2026-04-21T17:40:34.874522Z","end":"2026-04-21T17:40:35.080409Z","steps":["trace[1292814161] 'process raft request' (duration: 205.533347ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:40:35.080723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.186044ms","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-21T17:40:35.080895Z","caller":"traceutil/trace.go:171","msg":"trace[1285836705] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:581; }","duration":"157.375499ms","start":"2026-04-21T17:40:34.923507Z","end":"2026-04-21T17:40:35.080882Z","steps":["trace[1285836705] 'agreement among raft nodes before linearized reading' (duration: 156.850207ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:40:35.711047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.161724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:40:35.711217Z","caller":"traceutil/trace.go:171","msg":"trace[517589428] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:584; }","duration":"505.369169ms","start":"2026-04-21T17:40:35.205828Z","end":"2026-04-21T17:40:35.711197Z","steps":["trace[517589428] 'range keys from in-memory index tree' (duration: 504.99679ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:40:35.710974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.245791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T17:40:35.711177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.9536ms","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":"warn","ts":"2026-04-21T17:40:35.711291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:40:35.205814Z","time spent":"505.469631ms","remote":"127.0.0.1:59324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-21T17:40:35.711457Z","caller":"traceutil/trace.go:171","msg":"trace[1808794449] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:584; }","duration":"436.296157ms","start":"2026-04-21T17:40:35.275084Z","end":"2026-04-21T17:40:35.71138Z","steps":["trace[1808794449] 'count revisions from in-memory index tree' (duration: 435.790776ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:40:35.711317Z","caller":"traceutil/trace.go:171","msg":"trace[1645561497] 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":"308.671871ms","start":"2026-04-21T17:40:35.402632Z","end":"2026-04-21T17:40:35.711303Z","steps":["trace[1645561497] 'range keys from in-memory index tree' (duration: 308.153729ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:40:35.711528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:40:35.402606Z","time spent":"308.907487ms","remote":"127.0.0.1:42986","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-04-21T17:40:35.711556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:40:35.275055Z","time spent":"436.461281ms","remote":"127.0.0.1:42984","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/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-21T17:40:35.711127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.059791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:40:35.711698Z","caller":"traceutil/trace.go:171","msg":"trace[982186108] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:584; }","duration":"436.665286ms","start":"2026-04-21T17:40:35.275021Z","end":"2026-04-21T17:40:35.711686Z","steps":["trace[982186108] 'range keys from in-memory index tree' (duration: 435.980921ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:40:35.711732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:40:35.275003Z","time spent":"436.718697ms","remote":"127.0.0.1:42984","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/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-21T17:40:35.711003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.779031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:40:35.711866Z","caller":"traceutil/trace.go:171","msg":"trace[1995034432] 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":"308.721443ms","start":"2026-04-21T17:40:35.403135Z","end":"2026-04-21T17:40:35.711857Z","steps":["trace[1995034432] 'count revisions from in-memory index tree' (duration: 307.700389ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:40:35.711903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:40:35.403127Z","time spent":"308.761682ms","remote":"127.0.0.1:42986","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-04-21T17:40:35.711279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.027182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:40:35.712115Z","caller":"traceutil/trace.go:171","msg":"trace[1861309785] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:584; }","duration":"436.924161ms","start":"2026-04-21T17:40:35.27518Z","end":"2026-04-21T17:40:35.712104Z","steps":["trace[1861309785] 'range keys from in-memory index tree' (duration: 435.818546ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:40:35.712149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:40:35.27517Z","time spent":"436.969113ms","remote":"127.0.0.1:42984","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/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 "} {"level":"warn","ts":"2026-04-21T17:40:35.714872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.376821ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-04-21T17:40:35.71558Z","caller":"traceutil/trace.go:171","msg":"trace[1352045570] linearizableReadLoop","detail":"{readStateIndex:608; appliedIndex:606; }","duration":"177.166967ms","start":"2026-04-21T17:40:35.538398Z","end":"2026-04-21T17:40:35.715565Z","steps":["trace[1352045570] 'read index received' (duration: 10.979938ms)","trace[1352045570] 'applied index is now lower than readState.Index' (duration: 166.186179ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:40:35.715715Z","caller":"traceutil/trace.go:171","msg":"trace[572430605] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"178.956267ms","start":"2026-04-21T17:40:35.536745Z","end":"2026-04-21T17:40:35.715701Z","steps":["trace[572430605] 'process raft request' (duration: 178.375364ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:40:35.715785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.384772ms","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-21T17:40:35.715816Z","caller":"traceutil/trace.go:171","msg":"trace[1458561818] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:585; }","duration":"177.439284ms","start":"2026-04-21T17:40:35.538365Z","end":"2026-04-21T17:40:35.715805Z","steps":["trace[1458561818] 'agreement among raft nodes before linearized reading' (duration: 177.305411ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:40:35.715825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.767107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:40:35.715885Z","caller":"traceutil/trace.go:171","msg":"trace[1334320809] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:585; }","duration":"160.819038ms","start":"2026-04-21T17:40:35.555043Z","end":"2026-04-21T17:40:35.715862Z","steps":["trace[1334320809] 'agreement among raft nodes before linearized reading' (duration: 160.741866ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:40:35.715923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.803048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:40:35.71598Z","caller":"traceutil/trace.go:171","msg":"trace[909034849] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:585; }","duration":"126.869489ms","start":"2026-04-21T17:40:35.589086Z","end":"2026-04-21T17:40:35.715955Z","steps":["trace[909034849] 'agreement among raft nodes before linearized reading' (duration: 126.782947ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:40:35.716077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.111544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:40:35.716111Z","caller":"traceutil/trace.go:171","msg":"trace[1513327812] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:585; }","duration":"127.144275ms","start":"2026-04-21T17:40:35.588955Z","end":"2026-04-21T17:40:35.716099Z","steps":["trace[1513327812] 'agreement among raft nodes before linearized reading' (duration: 127.093284ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:40:35.716146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.407014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:40:35.716174Z","caller":"traceutil/trace.go:171","msg":"trace[2102311944] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:585; }","duration":"101.456704ms","start":"2026-04-21T17:40:35.61471Z","end":"2026-04-21T17:40:35.716166Z","steps":["trace[2102311944] 'agreement among raft nodes before linearized reading' (duration: 101.408943ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:40:35.716235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.529381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:40:35.716264Z","caller":"traceutil/trace.go:171","msg":"trace[541945378] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:585; }","duration":"160.559631ms","start":"2026-04-21T17:40:35.555696Z","end":"2026-04-21T17:40:35.716256Z","steps":["trace[541945378] 'agreement among raft nodes before linearized reading' (duration: 160.51291ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:40:35.71635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.380535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:40:35.716381Z","caller":"traceutil/trace.go:171","msg":"trace[192552075] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:585; }","duration":"102.452417ms","start":"2026-04-21T17:40:35.613918Z","end":"2026-04-21T17:40:35.716371Z","steps":["trace[192552075] 'agreement among raft nodes before linearized reading' (duration: 102.374985ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:40:35.716389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.190695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:40:35.716426Z","caller":"traceutil/trace.go:171","msg":"trace[1028789705] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:585; }","duration":"161.259677ms","start":"2026-04-21T17:40:35.555158Z","end":"2026-04-21T17:40:35.716417Z","steps":["trace[1028789705] 'agreement among raft nodes before linearized reading' (duration: 161.207666ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:40:35.716549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.616111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:40:35.716626Z","caller":"traceutil/trace.go:171","msg":"trace[665732434] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:585; }","duration":"102.687433ms","start":"2026-04-21T17:40:35.613916Z","end":"2026-04-21T17:40:35.716603Z","steps":["trace[665732434] 'agreement among raft nodes before linearized reading' (duration: 102.59411ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:41:27.167183Z","caller":"traceutil/trace.go:171","msg":"trace[148762060] transaction","detail":"{read_only:false; response_revision:963; number_of_response:1; }","duration":"110.949492ms","start":"2026-04-21T17:41:27.056191Z","end":"2026-04-21T17:41:27.167141Z","steps":["trace[148762060] 'process raft request' (duration: 110.696737ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:41:58.011602Z","caller":"traceutil/trace.go:171","msg":"trace[1053366629] linearizableReadLoop","detail":"{readStateIndex:1106; appliedIndex:1105; }","duration":"424.678136ms","start":"2026-04-21T17:41:57.58689Z","end":"2026-04-21T17:41:58.011568Z","steps":["trace[1053366629] 'read index received' (duration: 424.315758ms)","trace[1053366629] 'applied index is now lower than readState.Index' (duration: 361.128µs)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:41:58.012107Z","caller":"traceutil/trace.go:171","msg":"trace[2003171158] transaction","detail":"{read_only:false; response_revision:1063; number_of_response:1; }","duration":"473.405449ms","start":"2026-04-21T17:41:57.538687Z","end":"2026-04-21T17:41:58.012093Z","steps":["trace[2003171158] 'process raft request' (duration: 472.658403ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:41:58.012445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.517635ms","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-21T17:41:58.012605Z","caller":"traceutil/trace.go:171","msg":"trace[1210856566] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1063; }","duration":"425.72513ms","start":"2026-04-21T17:41:57.586847Z","end":"2026-04-21T17:41:58.012572Z","steps":["trace[1210856566] 'agreement among raft nodes before linearized reading' (duration: 425.280489ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:41:58.01247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.879601ms","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-04-21T17:41:58.012705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:41:57.586822Z","time spent":"425.846223ms","remote":"127.0.0.1:59612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-21T17:41:58.012545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.25097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-21T17:41:58.013006Z","caller":"traceutil/trace.go:171","msg":"trace[1767253244] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1063; }","duration":"376.71259ms","start":"2026-04-21T17:41:57.636243Z","end":"2026-04-21T17:41:58.012955Z","steps":["trace[1767253244] 'agreement among raft nodes before linearized reading' (duration: 375.898892ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:41:58.013033Z","caller":"traceutil/trace.go:171","msg":"trace[1212396900] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1063; }","duration":"421.287619ms","start":"2026-04-21T17:41:57.591501Z","end":"2026-04-21T17:41:58.012788Z","steps":["trace[1212396900] 'agreement among raft nodes before linearized reading' (duration: 420.629134ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:41:58.013113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:41:57.636194Z","time spent":"376.902234ms","remote":"127.0.0.1:59612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-21T17:41:58.01287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:41:57.538646Z","time spent":"473.578984ms","remote":"127.0.0.1:59612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T17:41:58.013871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:41:57.591487Z","time spent":"421.706088ms","remote":"127.0.0.1:59612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-21T17:41:58.322386Z","caller":"traceutil/trace.go:171","msg":"trace[105947743] transaction","detail":"{read_only:false; response_revision:1067; number_of_response:1; }","duration":"108.595209ms","start":"2026-04-21T17:41:58.213753Z","end":"2026-04-21T17:41:58.322348Z","steps":["trace[105947743] 'process raft request' (duration: 108.421344ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:42:10.29581Z","caller":"traceutil/trace.go:171","msg":"trace[1711492606] transaction","detail":"{read_only:false; response_revision:1155; number_of_response:1; }","duration":"147.20637ms","start":"2026-04-21T17:42:10.148563Z","end":"2026-04-21T17:42:10.295769Z","steps":["trace[1711492606] 'process raft request' (duration: 145.45903ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:42:10.301338Z","caller":"traceutil/trace.go:171","msg":"trace[1870831043] transaction","detail":"{read_only:false; response_revision:1156; number_of_response:1; }","duration":"151.853928ms","start":"2026-04-21T17:42:10.149456Z","end":"2026-04-21T17:42:10.30131Z","steps":["trace[1870831043] 'process raft request' (duration: 151.51901ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:42:12.209014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.665328ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T17:42:12.209155Z","caller":"traceutil/trace.go:171","msg":"trace[1891489200] transaction","detail":"{read_only:false; response_revision:1160; number_of_response:1; }","duration":"447.662161ms","start":"2026-04-21T17:42:11.761463Z","end":"2026-04-21T17:42:12.209126Z","steps":["trace[1891489200] 'process raft request' (duration: 118.730157ms)","trace[1891489200] 'compare' (duration: 328.521775ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:42:12.209272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:42:11.76143Z","time spent":"447.782073ms","remote":"127.0.0.1:59612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:42:30.146591Z","caller":"traceutil/trace.go:171","msg":"trace[836414552] transaction","detail":"{read_only:false; response_revision:1231; number_of_response:1; }","duration":"320.19382ms","start":"2026-04-21T17:42:29.82637Z","end":"2026-04-21T17:42:30.146564Z","steps":["trace[836414552] 'process raft request' (duration: 320.030956ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:42:30.146829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:42:29.826349Z","time spent":"320.398375ms","remote":"127.0.0.1:59530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5457,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:42:31.435304Z","caller":"traceutil/trace.go:171","msg":"trace[1228936500] linearizableReadLoop","detail":"{readStateIndex:1293; appliedIndex:1292; }","duration":"171.353393ms","start":"2026-04-21T17:42:31.263913Z","end":"2026-04-21T17:42:31.435266Z","steps":["trace[1228936500] 'read index received' (duration: 171.164409ms)","trace[1228936500] 'applied index is now lower than readState.Index' (duration: 187.714µs)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:42:31.435533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.591088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:42:31.435587Z","caller":"traceutil/trace.go:171","msg":"trace[1119007555] 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:1241; }","duration":"171.67239ms","start":"2026-04-21T17:42:31.263896Z","end":"2026-04-21T17:42:31.435569Z","steps":["trace[1119007555] 'agreement among raft nodes before linearized reading' (duration: 171.512767ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:42:31.436012Z","caller":"traceutil/trace.go:171","msg":"trace[1827040107] transaction","detail":"{read_only:false; response_revision:1241; number_of_response:1; }","duration":"226.573419ms","start":"2026-04-21T17:42:31.209422Z","end":"2026-04-21T17:42:31.435996Z","steps":["trace[1827040107] 'process raft request' (duration: 225.643517ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:42:31.645159Z","caller":"traceutil/trace.go:171","msg":"trace[1277578147] transaction","detail":"{read_only:false; response_revision:1244; number_of_response:1; }","duration":"195.340882ms","start":"2026-04-21T17:42:31.449788Z","end":"2026-04-21T17:42:31.645129Z","steps":["trace[1277578147] 'process raft request' (duration: 195.283301ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:42:31.645183Z","caller":"traceutil/trace.go:171","msg":"trace[1443431291] transaction","detail":"{read_only:false; response_revision:1243; number_of_response:1; }","duration":"195.843463ms","start":"2026-04-21T17:42:31.449304Z","end":"2026-04-21T17:42:31.645147Z","steps":["trace[1443431291] 'process raft request' (duration: 195.597897ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:42:31.658442Z","caller":"traceutil/trace.go:171","msg":"trace[667276015] transaction","detail":"{read_only:false; response_revision:1245; number_of_response:1; }","duration":"128.582747ms","start":"2026-04-21T17:42:31.529831Z","end":"2026-04-21T17:42:31.658414Z","steps":["trace[667276015] 'process raft request' (duration: 128.397243ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:42:46.511754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.26007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-21T17:42:46.511864Z","caller":"traceutil/trace.go:171","msg":"trace[1423719779] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1343; }","duration":"265.437515ms","start":"2026-04-21T17:42:46.246403Z","end":"2026-04-21T17:42:46.511841Z","steps":["trace[1423719779] 'count revisions from in-memory index tree' (duration: 265.096027ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:42:46.939501Z","caller":"traceutil/trace.go:171","msg":"trace[396484384] transaction","detail":"{read_only:false; response_revision:1344; number_of_response:1; }","duration":"422.566876ms","start":"2026-04-21T17:42:46.516901Z","end":"2026-04-21T17:42:46.939468Z","steps":["trace[396484384] 'process raft request' (duration: 422.401513ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:42:46.939723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:42:46.516875Z","time spent":"422.735031ms","remote":"127.0.0.1:59612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:42:46.961012Z","caller":"traceutil/trace.go:171","msg":"trace[878637295] transaction","detail":"{read_only:false; response_revision:1345; number_of_response:1; }","duration":"443.929623ms","start":"2026-04-21T17:42:46.517052Z","end":"2026-04-21T17:42:46.960982Z","steps":["trace[878637295] 'process raft request' (duration: 443.677228ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:42:46.960947Z","caller":"traceutil/trace.go:171","msg":"trace[881446388] linearizableReadLoop","detail":"{readStateIndex:1400; appliedIndex:1399; }","duration":"376.684407ms","start":"2026-04-21T17:42:46.584235Z","end":"2026-04-21T17:42:46.960919Z","steps":["trace[881446388] 'read index received' (duration: 355.392212ms)","trace[881446388] 'applied index is now lower than readState.Index' (duration: 21.290585ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:42:46.961135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:42:46.517021Z","time spent":"444.051496ms","remote":"127.0.0.1:59612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:42:46.961314Z","caller":"traceutil/trace.go:171","msg":"trace[901581829] transaction","detail":"{read_only:false; response_revision:1346; number_of_response:1; }","duration":"205.115639ms","start":"2026-04-21T17:42:46.756183Z","end":"2026-04-21T17:42:46.961299Z","steps":["trace[901581829] 'process raft request' (duration: 204.683849ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:42:46.961646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.49469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-04-21T17:42:46.961711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.799898ms","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-21T17:42:46.961755Z","caller":"traceutil/trace.go:171","msg":"trace[1161466949] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1346; }","duration":"300.88906ms","start":"2026-04-21T17:42:46.660853Z","end":"2026-04-21T17:42:46.961742Z","steps":["trace[1161466949] 'agreement among raft nodes before linearized reading' (duration: 300.710156ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:42:46.961797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:42:46.660824Z","time spent":"300.965583ms","remote":"127.0.0.1:59612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-21T17:42:46.961794Z","caller":"traceutil/trace.go:171","msg":"trace[1784998151] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1346; }","duration":"324.645384ms","start":"2026-04-21T17:42:46.637082Z","end":"2026-04-21T17:42:46.961727Z","steps":["trace[1784998151] 'agreement among raft nodes before linearized reading' (duration: 324.339167ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:42:46.962063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:42:46.637069Z","time spent":"324.91768ms","remote":"127.0.0.1:59612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-21T17:42:46.962084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.802913ms","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-21T17:42:46.962359Z","caller":"traceutil/trace.go:171","msg":"trace[355400971] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1346; }","duration":"378.150731ms","start":"2026-04-21T17:42:46.584173Z","end":"2026-04-21T17:42:46.962323Z","steps":["trace[355400971] 'agreement among raft nodes before linearized reading' (duration: 377.330642ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:42:46.962869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:42:46.584158Z","time spent":"378.294505ms","remote":"127.0.0.1:59612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-21T17:42:47.070937Z","caller":"traceutil/trace.go:171","msg":"trace[2037824086] transaction","detail":"{read_only:false; response_revision:1347; number_of_response:1; }","duration":"104.557086ms","start":"2026-04-21T17:42:46.966326Z","end":"2026-04-21T17:42:47.070883Z","steps":["trace[2037824086] 'process raft request' (duration: 103.914291ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:42:47.072001Z","caller":"traceutil/trace.go:171","msg":"trace[1342598928] transaction","detail":"{read_only:false; response_revision:1349; number_of_response:1; }","duration":"104.035184ms","start":"2026-04-21T17:42:46.967954Z","end":"2026-04-21T17:42:47.071989Z","steps":["trace[1342598928] 'process raft request' (duration: 103.998853ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:42:47.072192Z","caller":"traceutil/trace.go:171","msg":"trace[1469758441] transaction","detail":"{read_only:false; response_revision:1348; number_of_response:1; }","duration":"105.332954ms","start":"2026-04-21T17:42:46.966836Z","end":"2026-04-21T17:42:47.072169Z","steps":["trace[1469758441] 'process raft request' (duration: 105.039787ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:46:18.906698Z","caller":"traceutil/trace.go:171","msg":"trace[829625841] transaction","detail":"{read_only:false; response_revision:2350; number_of_response:1; }","duration":"224.075871ms","start":"2026-04-21T17:46:18.682483Z","end":"2026-04-21T17:46:18.906559Z","steps":["trace[829625841] 'process raft request' (duration: 221.18513ms)"],"step_count":1}