W0422 19:20:34.213123 1 feature_gate.go:354] Setting GA feature gate ClusterResourceSet=true. It will be removed in a future release. I0422 19:20:34.213464 1 envvar.go:172] "Feature gate default state" feature="ClientsAllowCBOR" enabled=false I0422 19:20:34.213483 1 envvar.go:172] "Feature gate default state" feature="ClientsPreferCBOR" enabled=false I0422 19:20:34.213488 1 envvar.go:172] "Feature gate default state" feature="InformerResourceVersion" enabled=false I0422 19:20:34.213492 1 envvar.go:172] "Feature gate default state" feature="WatchListClient" enabled=false I0422 19:20:34.238257 1 cluster_cache.go:288] "Found controller Pod metadata, the ClusterCache will try to access the cluster it is running on directly if possible" controller="clustercache" I0422 19:20:34.239315 1 webhook.go:188] "Registering a mutating webhook" logger="controller-runtime.builder" GVK="cluster.x-k8s.io/v1beta1, Kind=ClusterClass" path="/mutate-cluster-x-k8s-io-v1beta1-clusterclass" I0422 19:20:34.239520 1 server.go:183] "Registering webhook" logger="controller-runtime.webhook" path="/mutate-cluster-x-k8s-io-v1beta1-clusterclass" I0422 19:20:34.239611 1 webhook.go:226] "Registering a validating webhook" logger="controller-runtime.builder" GVK="cluster.x-k8s.io/v1beta1, Kind=ClusterClass" path="/validate-cluster-x-k8s-io-v1beta1-clusterclass" I0422 19:20:34.239753 1 server.go:183] "Registering webhook" logger="controller-runtime.webhook" path="/validate-cluster-x-k8s-io-v1beta1-clusterclass" I0422 19:20:34.240027 1 server.go:183] "Registering webhook" logger="controller-runtime.webhook" path="/convert" I0422 19:20:34.240047 1 webhook.go:257] "Conversion webhook enabled" logger="controller-runtime.builder" GVK="cluster.x-k8s.io/v1beta1, Kind=ClusterClass" I0422 19:20:34.240135 1 webhook.go:188] "Registering a mutating webhook" logger="controller-runtime.builder" GVK="cluster.x-k8s.io/v1beta1, Kind=Cluster" path="/mutate-cluster-x-k8s-io-v1beta1-cluster" I0422 19:20:34.240257 1 server.go:183] "Registering webhook" logger="controller-runtime.webhook" path="/mutate-cluster-x-k8s-io-v1beta1-cluster" I0422 19:20:34.240332 1 webhook.go:226] "Registering a validating webhook" logger="controller-runtime.builder" GVK="cluster.x-k8s.io/v1beta1, Kind=Cluster" path="/validate-cluster-x-k8s-io-v1beta1-cluster" I0422 19:20:34.240482 1 server.go:183] "Registering webhook" logger="controller-runtime.webhook" path="/validate-cluster-x-k8s-io-v1beta1-cluster" I0422 19:20:34.240580 1 webhook.go:257] "Conversion webhook enabled" logger="controller-runtime.builder" GVK="cluster.x-k8s.io/v1beta1, Kind=Cluster" I0422 19:20:34.240678 1 webhook.go:188] "Registering a mutating webhook" logger="controller-runtime.builder" GVK="cluster.x-k8s.io/v1beta1, Kind=Machine" path="/mutate-cluster-x-k8s-io-v1beta1-machine" I0422 19:20:34.240800 1 server.go:183] "Registering webhook" logger="controller-runtime.webhook" path="/mutate-cluster-x-k8s-io-v1beta1-machine" I0422 19:20:34.240885 1 webhook.go:226] "Registering a validating webhook" logger="controller-runtime.builder" GVK="cluster.x-k8s.io/v1beta1, Kind=Machine" path="/validate-cluster-x-k8s-io-v1beta1-machine" I0422 19:20:34.241024 1 server.go:183] "Registering webhook" logger="controller-runtime.webhook" path="/validate-cluster-x-k8s-io-v1beta1-machine" I0422 19:20:34.241128 1 webhook.go:257] "Conversion webhook enabled" logger="controller-runtime.builder" GVK="cluster.x-k8s.io/v1beta1, Kind=Machine" I0422 19:20:34.241268 1 webhook.go:188] "Registering a mutating webhook" logger="controller-runtime.builder" GVK="cluster.x-k8s.io/v1beta1, Kind=MachineSet" path="/mutate-cluster-x-k8s-io-v1beta1-machineset" I0422 19:20:34.241409 1 server.go:183] "Registering webhook" logger="controller-runtime.webhook" path="/mutate-cluster-x-k8s-io-v1beta1-machineset" I0422 19:20:34.241483 1 webhook.go:226] "Registering a validating webhook" logger="controller-runtime.builder" GVK="cluster.x-k8s.io/v1beta1, Kind=MachineSet" path="/validate-cluster-x-k8s-io-v1beta1-machineset" I0422 19:20:34.241644 1 server.go:183] "Registering webhook" logger="controller-runtime.webhook" path="/validate-cluster-x-k8s-io-v1beta1-machineset" I0422 19:20:34.241751 1 webhook.go:257] "Conversion webhook enabled" logger="controller-runtime.builder" GVK="cluster.x-k8s.io/v1beta1, Kind=MachineSet" I0422 19:20:34.241872 1 webhook.go:188] "Registering a mutating webhook" logger="controller-runtime.builder" GVK="cluster.x-k8s.io/v1beta1, Kind=MachineDeployment" path="/mutate-cluster-x-k8s-io-v1beta1-machinedeployment" I0422 19:20:34.242056 1 server.go:183] "Registering webhook" logger="controller-runtime.webhook" path="/mutate-cluster-x-k8s-io-v1beta1-machinedeployment" I0422 19:20:34.242160 1 webhook.go:226] "Registering a validating webhook" logger="controller-runtime.builder" GVK="cluster.x-k8s.io/v1beta1, Kind=MachineDeployment" path="/validate-cluster-x-k8s-io-v1beta1-machinedeployment" I0422 19:20:34.242279 1 server.go:183] "Registering webhook" logger="controller-runtime.webhook" path="/validate-cluster-x-k8s-io-v1beta1-machinedeployment" I0422 19:20:34.242393 1 webhook.go:257] "Conversion webhook enabled" logger="controller-runtime.builder" GVK="cluster.x-k8s.io/v1beta1, Kind=MachineDeployment" I0422 19:20:34.242474 1 webhook.go:226] "Registering a validating webhook" logger="controller-runtime.builder" GVK="cluster.x-k8s.io/v1beta1, Kind=MachineDrainRule" path="/validate-cluster-x-k8s-io-v1beta1-machinedrainrule" I0422 19:20:34.242588 1 server.go:183] "Registering webhook" logger="controller-runtime.webhook" path="/validate-cluster-x-k8s-io-v1beta1-machinedrainrule" I0422 19:20:34.242779 1 webhook.go:188] "Registering a mutating webhook" logger="controller-runtime.builder" GVK="cluster.x-k8s.io/v1beta1, Kind=MachinePool" path="/mutate-cluster-x-k8s-io-v1beta1-machinepool" I0422 19:20:34.242930 1 server.go:183] "Registering webhook" logger="controller-runtime.webhook" path="/mutate-cluster-x-k8s-io-v1beta1-machinepool" I0422 19:20:34.243012 1 webhook.go:226] "Registering a validating webhook" logger="controller-runtime.builder" GVK="cluster.x-k8s.io/v1beta1, Kind=MachinePool" path="/validate-cluster-x-k8s-io-v1beta1-machinepool" I0422 19:20:34.243147 1 server.go:183] "Registering webhook" logger="controller-runtime.webhook" path="/validate-cluster-x-k8s-io-v1beta1-machinepool" I0422 19:20:34.243263 1 webhook.go:257] "Conversion webhook enabled" logger="controller-runtime.builder" GVK="cluster.x-k8s.io/v1beta1, Kind=MachinePool" I0422 19:20:34.243387 1 webhook.go:188] "Registering a mutating webhook" logger="controller-runtime.builder" GVK="addons.cluster.x-k8s.io/v1beta1, Kind=ClusterResourceSet" path="/mutate-addons-cluster-x-k8s-io-v1beta1-clusterresourceset" I0422 19:20:34.243957 1 server.go:183] "Registering webhook" logger="controller-runtime.webhook" path="/mutate-addons-cluster-x-k8s-io-v1beta1-clusterresourceset" I0422 19:20:34.244022 1 webhook.go:226] "Registering a validating webhook" logger="controller-runtime.builder" GVK="addons.cluster.x-k8s.io/v1beta1, Kind=ClusterResourceSet" path="/validate-addons-cluster-x-k8s-io-v1beta1-clusterresourceset" I0422 19:20:34.244131 1 server.go:183] "Registering webhook" logger="controller-runtime.webhook" path="/validate-addons-cluster-x-k8s-io-v1beta1-clusterresourceset" I0422 19:20:34.244227 1 webhook.go:257] "Conversion webhook enabled" logger="controller-runtime.builder" GVK="addons.cluster.x-k8s.io/v1beta1, Kind=ClusterResourceSet" I0422 19:20:34.244283 1 webhook.go:226] "Registering a validating webhook" logger="controller-runtime.builder" GVK="addons.cluster.x-k8s.io/v1beta1, Kind=ClusterResourceSetBinding" path="/validate-addons-cluster-x-k8s-io-v1beta1-clusterresourcesetbinding" I0422 19:20:34.244353 1 server.go:183] "Registering webhook" logger="controller-runtime.webhook" path="/validate-addons-cluster-x-k8s-io-v1beta1-clusterresourcesetbinding" I0422 19:20:34.244402 1 webhook.go:257] "Conversion webhook enabled" logger="controller-runtime.builder" GVK="addons.cluster.x-k8s.io/v1beta1, Kind=ClusterResourceSetBinding" I0422 19:20:34.244445 1 webhook.go:188] "Registering a mutating webhook" logger="controller-runtime.builder" GVK="cluster.x-k8s.io/v1beta1, Kind=MachineHealthCheck" path="/mutate-cluster-x-k8s-io-v1beta1-machinehealthcheck" I0422 19:20:34.244545 1 server.go:183] "Registering webhook" logger="controller-runtime.webhook" path="/mutate-cluster-x-k8s-io-v1beta1-machinehealthcheck" I0422 19:20:34.244583 1 webhook.go:226] "Registering a validating webhook" logger="controller-runtime.builder" GVK="cluster.x-k8s.io/v1beta1, Kind=MachineHealthCheck" path="/validate-cluster-x-k8s-io-v1beta1-machinehealthcheck" I0422 19:20:34.244656 1 server.go:183] "Registering webhook" logger="controller-runtime.webhook" path="/validate-cluster-x-k8s-io-v1beta1-machinehealthcheck" I0422 19:20:34.244712 1 webhook.go:257] "Conversion webhook enabled" logger="controller-runtime.builder" GVK="cluster.x-k8s.io/v1beta1, Kind=MachineHealthCheck" I0422 19:20:34.244757 1 webhook.go:188] "Registering a mutating webhook" logger="controller-runtime.builder" GVK="runtime.cluster.x-k8s.io/v1alpha1, Kind=ExtensionConfig" path="/mutate-runtime-cluster-x-k8s-io-v1alpha1-extensionconfig" I0422 19:20:34.244834 1 server.go:183] "Registering webhook" logger="controller-runtime.webhook" path="/mutate-runtime-cluster-x-k8s-io-v1alpha1-extensionconfig" I0422 19:20:34.244886 1 webhook.go:226] "Registering a validating webhook" logger="controller-runtime.builder" GVK="runtime.cluster.x-k8s.io/v1alpha1, Kind=ExtensionConfig" path="/validate-runtime-cluster-x-k8s-io-v1alpha1-extensionconfig" I0422 19:20:34.244957 1 server.go:183] "Registering webhook" logger="controller-runtime.webhook" path="/validate-runtime-cluster-x-k8s-io-v1alpha1-extensionconfig" I0422 19:20:34.245034 1 webhook.go:226] "Registering a validating webhook" logger="controller-runtime.builder" GVK="ipam.cluster.x-k8s.io/v1beta1, Kind=IPAddress" path="/validate-ipam-cluster-x-k8s-io-v1beta1-ipaddress" I0422 19:20:34.245115 1 server.go:183] "Registering webhook" logger="controller-runtime.webhook" path="/validate-ipam-cluster-x-k8s-io-v1beta1-ipaddress" I0422 19:20:34.245201 1 webhook.go:226] "Registering a validating webhook" logger="controller-runtime.builder" GVK="ipam.cluster.x-k8s.io/v1beta1, Kind=IPAddressClaim" path="/validate-ipam-cluster-x-k8s-io-v1beta1-ipaddressclaim" I0422 19:20:34.245274 1 server.go:183] "Registering webhook" logger="controller-runtime.webhook" path="/validate-ipam-cluster-x-k8s-io-v1beta1-ipaddressclaim" I0422 19:20:34.245326 1 main.go:431] "Starting manager" logger="setup" version="v1.10.5" I0422 19:20:34.245435 1 server.go:208] "Starting metrics server" logger="controller-runtime.metrics" I0422 19:20:34.245507 1 server.go:83] "starting server" name="health probe" addr="[::]:9440" I0422 19:20:34.245735 1 server.go:191] "Starting webhook server" logger="controller-runtime.webhook" I0422 19:20:34.249120 1 certwatcher.go:211] "Updated current TLS certificate" logger="controller-runtime.certwatcher" I0422 19:20:34.249306 1 server.go:242] "Serving webhook server" logger="controller-runtime.webhook" host="" port=9443 I0422 19:20:34.249466 1 certwatcher.go:133] "Starting certificate poll+watcher" logger="controller-runtime.certwatcher" interval="10s" I0422 19:20:34.251839 1 reflector.go:376] Caches populated for *v1beta1.MachinePool from k8s.io/client-go@v0.32.3/tools/cache/reflector.go:251 I0422 19:20:34.251909 1 reflector.go:376] Caches populated for *v1beta1.Cluster from k8s.io/client-go@v0.32.3/tools/cache/reflector.go:251 I0422 19:20:34.252178 1 reflector.go:376] Caches populated for *v1beta1.Machine from k8s.io/client-go@v0.32.3/tools/cache/reflector.go:251 I0422 19:20:34.349590 1 leaderelection.go:257] attempting to acquire leader lease capi-system/controller-leader-election-capi... I0422 19:20:34.698772 1 server.go:247] "Serving metrics server" logger="controller-runtime.metrics" bindAddress=":8443" secure=true I0422 19:21:03.416646 1 leaderelection.go:271] successfully acquired lease capi-system/controller-leader-election-capi I0422 19:21:03.416733 1 recorder.go:104] "capi-controller-manager-bc4cf8c95-zhtgc_c369a321-c2bc-4431-bdbd-2599fe1d0182 became leader" logger="events" type="Normal" object={"kind":"Lease","namespace":"capi-system","name":"controller-leader-election-capi","uid":"0ea748cd-aeb6-43e0-8f86-d44fe0a3232b","apiVersion":"coordination.k8s.io/v1","resourceVersion":"24746"} reason="LeaderElection" I0422 19:21:03.417448 1 controller.go:204] "Starting EventSource" controller="machinehealthcheck" controllerGroup="cluster.x-k8s.io" controllerKind="MachineHealthCheck" source="channel source: 0xc00019a4d0" I0422 19:21:03.417576 1 controller.go:204] "Starting EventSource" controller="machinehealthcheck" controllerGroup="cluster.x-k8s.io" controllerKind="MachineHealthCheck" source="kind source: *v1beta1.Cluster" I0422 19:21:03.417484 1 controller.go:204] "Starting EventSource" controller="clusterresourceset" controllerGroup="addons.cluster.x-k8s.io" controllerKind="ClusterResourceSet" source="kind source: *v1beta1.ClusterResourceSet" I0422 19:21:03.417627 1 controller.go:204] "Starting EventSource" controller="clusterresourceset" controllerGroup="addons.cluster.x-k8s.io" controllerKind="ClusterResourceSet" source="kind source: *v1beta1.Cluster" I0422 19:21:03.418208 1 controller.go:204] "Starting EventSource" controller="clusterresourceset" controllerGroup="addons.cluster.x-k8s.io" controllerKind="ClusterResourceSet" source="kind source: *v1.PartialObjectMetadata" I0422 19:21:03.417430 1 controller.go:204] "Starting EventSource" controller="clustercache" controllerGroup="cluster.x-k8s.io" controllerKind="Cluster" source="kind source: *v1beta1.Cluster" I0422 19:21:03.419275 1 controller.go:204] "Starting EventSource" controller="clusterresourceset" controllerGroup="addons.cluster.x-k8s.io" controllerKind="ClusterResourceSet" source="channel source: 0xc000033ea0" I0422 19:21:03.419370 1 controller.go:204] "Starting EventSource" controller="topology/cluster" controllerGroup="cluster.x-k8s.io" controllerKind="Cluster" source="channel source: 0xc000032bd0" I0422 19:21:03.419410 1 controller.go:204] "Starting EventSource" controller="machinehealthcheck" controllerGroup="cluster.x-k8s.io" controllerKind="MachineHealthCheck" source="kind source: *v1beta1.MachineHealthCheck" I0422 19:21:03.419518 1 controller.go:204] "Starting EventSource" controller="clusterresourceset" controllerGroup="addons.cluster.x-k8s.io" controllerKind="ClusterResourceSet" source="kind source: *v1.PartialObjectMetadata" I0422 19:21:03.419529 1 controller.go:204] "Starting EventSource" controller="topology/cluster" controllerGroup="cluster.x-k8s.io" controllerKind="Cluster" source="kind source: *v1beta1.ClusterClass" I0422 19:21:03.419634 1 controller.go:204] "Starting EventSource" controller="machinedeployment" controllerGroup="cluster.x-k8s.io" controllerKind="MachineDeployment" source="kind source: *v1beta1.Cluster" I0422 19:21:03.419416 1 controller.go:204] "Starting EventSource" controller="topology/cluster" controllerGroup="cluster.x-k8s.io" controllerKind="Cluster" source="kind source: *v1beta1.Cluster" I0422 19:21:03.419854 1 controller.go:204] "Starting EventSource" controller="crdmigrator" controllerGroup="apiextensions.k8s.io" controllerKind="CustomResourceDefinition" source="kind source: *v1.PartialObjectMetadata" I0422 19:21:03.419995 1 controller.go:204] "Starting EventSource" controller="topology/cluster" controllerGroup="cluster.x-k8s.io" controllerKind="Cluster" source="kind source: *v1beta1.MachineDeployment" I0422 19:21:03.420162 1 controller.go:204] "Starting EventSource" controller="topology/cluster" controllerGroup="cluster.x-k8s.io" controllerKind="Cluster" source="kind source: *v1beta1.MachinePool" I0422 19:21:03.420359 1 controller.go:204] "Starting EventSource" controller="machinedeployment" controllerGroup="cluster.x-k8s.io" controllerKind="MachineDeployment" source="kind source: *v1beta1.MachineSet" I0422 19:21:03.420369 1 controller.go:204] "Starting EventSource" controller="machinedeployment" controllerGroup="cluster.x-k8s.io" controllerKind="MachineDeployment" source="kind source: *v1beta1.MachineDeployment" I0422 19:21:03.421800 1 controller.go:204] "Starting EventSource" controller="topology/machinedeployment" controllerGroup="cluster.x-k8s.io" controllerKind="MachineDeployment" source="kind source: *v1beta1.Cluster" I0422 19:21:03.421846 1 controller.go:204] "Starting EventSource" controller="clusterclass" controllerGroup="cluster.x-k8s.io" controllerKind="ClusterClass" source="kind source: *v1beta1.ClusterClass" I0422 19:21:03.421853 1 controller.go:204] "Starting EventSource" controller="topology/machineset" controllerGroup="cluster.x-k8s.io" controllerKind="MachineSet" source="kind source: *v1beta1.Cluster" I0422 19:21:03.421885 1 controller.go:204] "Starting EventSource" controller="machinedeployment" controllerGroup="cluster.x-k8s.io" controllerKind="MachineDeployment" source="kind source: *v1beta1.MachineSet" I0422 19:21:03.421898 1 controller.go:204] "Starting EventSource" controller="machinepool" controllerGroup="cluster.x-k8s.io" controllerKind="MachinePool" source="channel source: 0xc000033e30" I0422 19:21:03.421922 1 controller.go:204] "Starting EventSource" controller="topology/machineset" controllerGroup="cluster.x-k8s.io" controllerKind="MachineSet" source="kind source: *v1beta1.MachineSet" I0422 19:21:03.421948 1 controller.go:204] "Starting EventSource" controller="clusterclass" controllerGroup="cluster.x-k8s.io" controllerKind="ClusterClass" source="kind source: *v1alpha1.ExtensionConfig" I0422 19:21:03.421962 1 controller.go:204] "Starting EventSource" controller="machinehealthcheck" controllerGroup="cluster.x-k8s.io" controllerKind="MachineHealthCheck" source="kind source: *v1beta1.Machine" I0422 19:21:03.421976 1 controller.go:204] "Starting EventSource" controller="cluster" controllerGroup="cluster.x-k8s.io" controllerKind="Cluster" source="kind source: *v1beta1.Cluster" I0422 19:21:03.421938 1 controller.go:204] "Starting EventSource" controller="machinepool" controllerGroup="cluster.x-k8s.io" controllerKind="MachinePool" source="kind source: *v1beta1.Cluster" I0422 19:21:03.422025 1 controller.go:204] "Starting EventSource" controller="cluster" controllerGroup="cluster.x-k8s.io" controllerKind="Cluster" source="kind source: *v1beta1.Machine" I0422 19:21:03.422042 1 controller.go:204] "Starting EventSource" controller="cluster" controllerGroup="cluster.x-k8s.io" controllerKind="Cluster" source="channel source: 0xc000033030" I0422 19:21:03.421885 1 controller.go:204] "Starting EventSource" controller="machinepool" controllerGroup="cluster.x-k8s.io" controllerKind="MachinePool" source="kind source: *v1beta1.MachinePool" I0422 19:21:03.422113 1 controller.go:204] "Starting EventSource" controller="machine" controllerGroup="cluster.x-k8s.io" controllerKind="Machine" source="kind source: *v1beta1.Cluster" I0422 19:21:03.422070 1 controller.go:204] "Starting EventSource" controller="clusterresourcesetbinding" controllerGroup="addons.cluster.x-k8s.io" controllerKind="ClusterResourceSetBinding" source="kind source: *v1beta1.Cluster" I0422 19:21:03.422081 1 controller.go:204] "Starting EventSource" controller="topology/machinedeployment" controllerGroup="cluster.x-k8s.io" controllerKind="MachineDeployment" source="kind source: *v1beta1.MachineDeployment" I0422 19:21:03.422093 1 controller.go:204] "Starting EventSource" controller="cluster" controllerGroup="cluster.x-k8s.io" controllerKind="Cluster" source="kind source: *v1beta1.MachineDeployment" I0422 19:21:03.422174 1 controller.go:204] "Starting EventSource" controller="machine" controllerGroup="cluster.x-k8s.io" controllerKind="Machine" source="kind source: *v1beta1.MachineSet" I0422 19:21:03.422093 1 controller.go:204] "Starting EventSource" controller="machine" controllerGroup="cluster.x-k8s.io" controllerKind="Machine" source="channel source: 0xc000033730" I0422 19:21:03.422107 1 controller.go:204] "Starting EventSource" controller="machine" controllerGroup="cluster.x-k8s.io" controllerKind="Machine" source="kind source: *v1beta1.Machine" I0422 19:21:03.422111 1 controller.go:204] "Starting EventSource" controller="machine" controllerGroup="cluster.x-k8s.io" controllerKind="Machine" source="kind source: *v1beta1.MachineDeployment" I0422 19:21:03.422109 1 controller.go:204] "Starting EventSource" controller="clusterresourcesetbinding" controllerGroup="addons.cluster.x-k8s.io" controllerKind="ClusterResourceSetBinding" source="kind source: *v1beta1.ClusterResourceSetBinding" I0422 19:21:03.422072 1 controller.go:204] "Starting EventSource" controller="cluster" controllerGroup="cluster.x-k8s.io" controllerKind="Cluster" source="kind source: *v1beta1.MachinePool" I0422 19:21:03.423361 1 controller.go:204] "Starting EventSource" controller="machineset" controllerGroup="cluster.x-k8s.io" controllerKind="MachineSet" source="channel source: 0xc000033ab0" I0422 19:21:03.423399 1 controller.go:204] "Starting EventSource" controller="machineset" controllerGroup="cluster.x-k8s.io" controllerKind="MachineSet" source="kind source: *v1beta1.Machine" I0422 19:21:03.423409 1 controller.go:204] "Starting EventSource" controller="machineset" controllerGroup="cluster.x-k8s.io" controllerKind="MachineSet" source="kind source: *v1beta1.Machine" I0422 19:21:03.423446 1 controller.go:204] "Starting EventSource" controller="machineset" controllerGroup="cluster.x-k8s.io" controllerKind="MachineSet" source="kind source: *v1beta1.MachineDeployment" I0422 19:21:03.423455 1 controller.go:204] "Starting EventSource" controller="machineset" controllerGroup="cluster.x-k8s.io" controllerKind="MachineSet" source="kind source: *v1beta1.MachineSet" I0422 19:21:03.423500 1 controller.go:204] "Starting EventSource" controller="machineset" controllerGroup="cluster.x-k8s.io" controllerKind="MachineSet" source="kind source: *v1beta1.Cluster" I0422 19:21:03.424596 1 reflector.go:376] Caches populated for *v1beta1.MachineDeployment from k8s.io/client-go@v0.32.3/tools/cache/reflector.go:251 I0422 19:21:03.424877 1 reflector.go:376] Caches populated for *v1.PartialObjectMetadata from k8s.io/client-go@v0.32.3/tools/cache/reflector.go:251 I0422 19:21:03.425122 1 reflector.go:376] Caches populated for *v1beta1.MachineSet from k8s.io/client-go@v0.32.3/tools/cache/reflector.go:251 I0422 19:21:03.429368 1 reflector.go:376] Caches populated for *v1beta1.ClusterResourceSetBinding from k8s.io/client-go@v0.32.3/tools/cache/reflector.go:251 I0422 19:21:03.429793 1 reflector.go:376] Caches populated for *v1beta1.ClusterResourceSet from k8s.io/client-go@v0.32.3/tools/cache/reflector.go:251 I0422 19:21:03.430181 1 reflector.go:376] Caches populated for *v1beta1.ClusterClass from k8s.io/client-go@v0.32.3/tools/cache/reflector.go:251 I0422 19:21:03.430193 1 reflector.go:376] Caches populated for *v1alpha1.ExtensionConfig from k8s.io/client-go@v0.32.3/tools/cache/reflector.go:251 I0422 19:21:03.430992 1 reflector.go:376] Caches populated for *v1beta1.MachineHealthCheck from k8s.io/client-go@v0.32.3/tools/cache/reflector.go:251 I0422 19:21:03.431643 1 reflector.go:376] Caches populated for *v1.PartialObjectMetadata from k8s.io/client-go@v0.32.3/tools/cache/reflector.go:251 I0422 19:21:03.432277 1 reflector.go:376] Caches populated for *v1.PartialObjectMetadata from k8s.io/client-go@v0.32.3/tools/cache/reflector.go:251 I0422 19:21:03.520248 1 controller.go:239] "Starting Controller" controller="clustercache" controllerGroup="cluster.x-k8s.io" controllerKind="Cluster" I0422 19:21:03.520303 1 controller.go:248] "Starting workers" controller="clustercache" controllerGroup="cluster.x-k8s.io" controllerKind="Cluster" worker count=100 I0422 19:21:03.522327 1 controller.go:239] "Starting Controller" controller="topology/cluster" controllerGroup="cluster.x-k8s.io" controllerKind="Cluster" I0422 19:21:03.522361 1 controller.go:248] "Starting workers" controller="topology/cluster" controllerGroup="cluster.x-k8s.io" controllerKind="Cluster" worker count=10 I0422 19:21:03.522607 1 controller.go:239] "Starting Controller" controller="machinehealthcheck" controllerGroup="cluster.x-k8s.io" controllerKind="MachineHealthCheck" I0422 19:21:03.522639 1 controller.go:248] "Starting workers" controller="machinehealthcheck" controllerGroup="cluster.x-k8s.io" controllerKind="MachineHealthCheck" worker count=10 I0422 19:21:03.522785 1 controller.go:239] "Starting Controller" controller="topology/machinedeployment" controllerGroup="cluster.x-k8s.io" controllerKind="MachineDeployment" I0422 19:21:03.522813 1 controller.go:248] "Starting workers" controller="topology/machinedeployment" controllerGroup="cluster.x-k8s.io" controllerKind="MachineDeployment" worker count=1 I0422 19:21:03.522930 1 controller.go:239] "Starting Controller" controller="machine" controllerGroup="cluster.x-k8s.io" controllerKind="Machine" I0422 19:21:03.522996 1 controller.go:239] "Starting Controller" controller="machinepool" controllerGroup="cluster.x-k8s.io" controllerKind="MachinePool" I0422 19:21:03.523013 1 controller.go:248] "Starting workers" controller="machinepool" controllerGroup="cluster.x-k8s.io" controllerKind="MachinePool" worker count=10 I0422 19:21:03.523008 1 controller.go:248] "Starting workers" controller="machine" controllerGroup="cluster.x-k8s.io" controllerKind="Machine" worker count=10 I0422 19:21:03.522961 1 controller.go:239] "Starting Controller" controller="topology/machineset" controllerGroup="cluster.x-k8s.io" controllerKind="MachineSet" I0422 19:21:03.523173 1 controller.go:248] "Starting workers" controller="topology/machineset" controllerGroup="cluster.x-k8s.io" controllerKind="MachineSet" worker count=1 I0422 19:21:03.523171 1 controller.go:239] "Starting Controller" controller="clusterresourcesetbinding" controllerGroup="addons.cluster.x-k8s.io" controllerKind="ClusterResourceSetBinding" I0422 19:21:03.523218 1 controller.go:239] "Starting Controller" controller="cluster" controllerGroup="cluster.x-k8s.io" controllerKind="Cluster" I0422 19:21:03.523221 1 controller.go:248] "Starting workers" controller="clusterresourcesetbinding" controllerGroup="addons.cluster.x-k8s.io" controllerKind="ClusterResourceSetBinding" worker count=10 I0422 19:21:03.523230 1 controller.go:248] "Starting workers" controller="cluster" controllerGroup="cluster.x-k8s.io" controllerKind="Cluster" worker count=10 I0422 19:21:03.523440 1 controller.go:239] "Starting Controller" controller="machinedeployment" controllerGroup="cluster.x-k8s.io" controllerKind="MachineDeployment" I0422 19:21:03.523489 1 controller.go:248] "Starting workers" controller="machinedeployment" controllerGroup="cluster.x-k8s.io" controllerKind="MachineDeployment" worker count=10 I0422 19:21:03.523693 1 controller.go:239] "Starting Controller" controller="crdmigrator" controllerGroup="apiextensions.k8s.io" controllerKind="CustomResourceDefinition" I0422 19:21:03.523712 1 controller.go:248] "Starting workers" controller="crdmigrator" controllerGroup="apiextensions.k8s.io" controllerKind="CustomResourceDefinition" worker count=1 I0422 19:21:03.523752 1 controller.go:239] "Starting Controller" controller="clusterclass" controllerGroup="cluster.x-k8s.io" controllerKind="ClusterClass" I0422 19:21:03.523805 1 controller.go:239] "Starting Controller" controller="clusterresourceset" controllerGroup="addons.cluster.x-k8s.io" controllerKind="ClusterResourceSet" I0422 19:21:03.523837 1 controller.go:248] "Starting workers" controller="clusterresourceset" controllerGroup="addons.cluster.x-k8s.io" controllerKind="ClusterResourceSet" worker count=10 I0422 19:21:03.523805 1 controller.go:248] "Starting workers" controller="clusterclass" controllerGroup="cluster.x-k8s.io" controllerKind="ClusterClass" worker count=10 I0422 19:21:03.524042 1 controller.go:239] "Starting Controller" controller="machineset" controllerGroup="cluster.x-k8s.io" controllerKind="MachineSet" I0422 19:21:03.524081 1 controller.go:248] "Starting workers" controller="machineset" controllerGroup="cluster.x-k8s.io" controllerKind="MachineSet" worker count=10 E0422 19:24:21.372887 1 leaderelection.go:429] Failed to update lock optimistically: Put "https://10.96.0.1:443/apis/coordination.k8s.io/v1/namespaces/capi-system/leases/controller-leader-election-capi?timeout=5s": context deadline exceeded, falling back to slow path E0422 19:24:26.372965 1 leaderelection.go:472] Failed to update lock: Put "https://10.96.0.1:443/apis/coordination.k8s.io/v1/namespaces/capi-system/leases/controller-leader-election-capi?timeout=5s": context deadline exceeded I0422 19:24:26.373046 1 leaderelection.go:297] failed to renew lease capi-system/controller-leader-election-capi: context deadline exceeded E0422 19:24:26.373129 1 main.go:433] "Problem running manager" err="leader election lost" logger="setup"