W0922 02:44:35.943179       1 feature_gate.go:410] Setting GA feature gate MachineWaitForVolumeDetachConsiderVolumeAttachments=true. It will be removed in a future release.
I0922 02:44:35.943485       1 main.go:308] FLAG: --additional-sync-machine-annotations="[]"
I0922 02:44:35.943561       1 main.go:308] FLAG: --additional-sync-machine-labels="[]"
I0922 02:44:35.943592       1 main.go:308] FLAG: --cluster-concurrency="50"
I0922 02:44:35.943620       1 main.go:308] FLAG: --clustercache-client-burst="30"
I0922 02:44:35.943647       1 main.go:308] FLAG: --clustercache-client-qps="20"
I0922 02:44:35.943684       1 main.go:308] FLAG: --clustercache-concurrency="100"
I0922 02:44:35.943710       1 main.go:308] FLAG: --clusterclass-concurrency="10"
I0922 02:44:35.943733       1 main.go:308] FLAG: --clusterresourceset-concurrency="10"
I0922 02:44:35.943757       1 main.go:308] FLAG: --clustertopology-concurrency="50"
I0922 02:44:35.943790       1 main.go:308] FLAG: --contention-profiling="false"
I0922 02:44:35.943824       1 main.go:308] FLAG: --diagnostics-address=":8443"
I0922 02:44:35.943852       1 main.go:308] FLAG: --extensionconfig-concurrency="10"
I0922 02:44:35.943890       1 main.go:308] FLAG: --feature-gates="ClusterTopology=true,InPlaceUpdates=false,MachinePool=true,MachineSetPreflightChecks=true,MachineTaintPropagation=false,MachineWaitForVolumeDetachConsiderVolumeAttachments=true,PriorityQueue=true,ReconcilerRateLimiting=true,RuntimeSDK=false"
I0922 02:44:35.943951       1 main.go:308] FLAG: --health-addr=":9440"
I0922 02:44:35.943985       1 main.go:308] FLAG: --insecure-diagnostics="false"
I0922 02:44:35.944016       1 main.go:308] FLAG: --kube-api-burst="200"
I0922 02:44:35.944048       1 main.go:308] FLAG: --kube-api-qps="100"
I0922 02:44:35.944073       1 main.go:308] FLAG: --kubeconfig=""
I0922 02:44:35.944107       1 main.go:308] FLAG: --leader-elect="true"
I0922 02:44:35.944132       1 main.go:308] FLAG: --leader-elect-lease-duration="15s"
I0922 02:44:35.944163       1 main.go:308] FLAG: --leader-elect-renew-deadline="10s"
I0922 02:44:35.944211       1 main.go:308] FLAG: --leader-elect-retry-period="2s"
I0922 02:44:35.944246       1 main.go:308] FLAG: --log-flush-frequency="5s"
I0922 02:44:35.944272       1 main.go:308] FLAG: --log-json-info-buffer-size="0"
I0922 02:44:35.944335       1 main.go:308] FLAG: --log-json-split-stream="false"
I0922 02:44:35.944375       1 main.go:308] FLAG: --log-text-info-buffer-size="0"
I0922 02:44:35.944406       1 main.go:308] FLAG: --log-text-split-stream="false"
I0922 02:44:35.944431       1 main.go:308] FLAG: --logging-format="text"
I0922 02:44:35.944455       1 main.go:308] FLAG: --machine-concurrency="100"
I0922 02:44:35.944493       1 main.go:308] FLAG: --machinedeployment-concurrency="50"
I0922 02:44:35.944518       1 main.go:308] FLAG: --machinehealthcheck-concurrency="50"
I0922 02:44:35.944544       1 main.go:308] FLAG: --machinepool-concurrency="50"
I0922 02:44:35.944567       1 main.go:308] FLAG: --machineset-concurrency="50"
I0922 02:44:35.944593       1 main.go:308] FLAG: --machineset-preflight-checks="[All]"
I0922 02:44:35.944636       1 main.go:308] FLAG: --namespace=""
I0922 02:44:35.944660       1 main.go:308] FLAG: --profiler-address=""
I0922 02:44:35.944691       1 main.go:308] FLAG: --remote-conditions-grace-period="5m0s"
I0922 02:44:35.944716       1 main.go:308] FLAG: --remote-connection-grace-period="50s"
I0922 02:44:35.944750       1 main.go:308] FLAG: --runtime-extension-client-cert-file=""
I0922 02:44:35.944773       1 main.go:308] FLAG: --runtime-extension-client-key-file=""
I0922 02:44:35.944798       1 main.go:308] FLAG: --skip-crd-migration-phases="[]"
I0922 02:44:35.944843       1 main.go:308] FLAG: --sync-period="10m0s"
I0922 02:44:35.944878       1 main.go:308] FLAG: --tls-cipher-suites="[]"
I0922 02:44:35.944910       1 main.go:308] FLAG: --tls-min-version="VersionTLS12"
I0922 02:44:35.944946       1 main.go:308] FLAG: --v="2"
I0922 02:44:35.944982       1 main.go:308] FLAG: --vmodule=""
I0922 02:44:35.945008       1 main.go:308] FLAG: --watch-filter=""
I0922 02:44:35.945042       1 main.go:308] FLAG: --webhook-cert-dir="/tmp/k8s-webhook-server/serving-certs/"
I0922 02:44:35.945073       1 main.go:308] FLAG: --webhook-cert-name="tls.crt"
I0922 02:44:35.945105       1 main.go:308] FLAG: --webhook-key-name="tls.key"
I0922 02:44:35.945131       1 main.go:308] FLAG: --webhook-port="9443"
I0922 02:44:35.945207       1 main.go:315] "Version: v1.13.2 (git commit: ebd807c66351f3ad96ca99b68d2219305d794640)" logger="setup"
I0922 02:44:35.945663       1 envvar.go:172] "Feature gate default state" feature="WatchListClient" enabled=true
I0922 02:44:35.945735       1 envvar.go:172] "Feature gate default state" feature="ClientsAllowCBOR" enabled=false
I0922 02:44:35.945774       1 envvar.go:172] "Feature gate default state" feature="ClientsPreferCBOR" enabled=false
I0922 02:44:35.945826       1 envvar.go:172] "Feature gate default state" feature="InOrderInformers" enabled=true
I0922 02:44:35.945863       1 envvar.go:172] "Feature gate default state" feature="InOrderInformersBatchProcess" enabled=true
I0922 02:44:35.945899       1 envvar.go:172] "Feature gate default state" feature="InformerResourceVersion" enabled=true
I0922 02:44:35.977540       1 cluster_cache.go:310] "Found controller Pod metadata, the ClusterCache will try to access the cluster it is running on directly if possible" controller="clustercache"
I0922 02:44:35.980102       1 webhook.go:293] "Registering a validating webhook" logger="controller-runtime.builder" GVK="cluster.x-k8s.io/v1beta2, Kind=ClusterClass" path="/validate-cluster-x-k8s-io-v1beta2-clusterclass"
I0922 02:44:35.980402       1 server.go:183] "Registering webhook" logger="controller-runtime.webhook" path="/validate-cluster-x-k8s-io-v1beta2-clusterclass"
I0922 02:44:35.980661       1 server.go:183] "Registering webhook" logger="controller-runtime.webhook" path="/convert"
I0922 02:44:35.980680       1 webhook.go:344] "Conversion webhook enabled" logger="controller-runtime.builder" GVK="cluster.x-k8s.io/v1beta2, Kind=ClusterClass"
I0922 02:44:35.980845       1 webhook.go:246] "Registering a mutating webhook" logger="controller-runtime.builder" GVK="cluster.x-k8s.io/v1beta2, Kind=Cluster" path="/mutate-cluster-x-k8s-io-v1beta2-cluster"
I0922 02:44:35.981053       1 server.go:183] "Registering webhook" logger="controller-runtime.webhook" path="/mutate-cluster-x-k8s-io-v1beta2-cluster"
I0922 02:44:35.981206       1 webhook.go:293] "Registering a validating webhook" logger="controller-runtime.builder" GVK="cluster.x-k8s.io/v1beta2, Kind=Cluster" path="/validate-cluster-x-k8s-io-v1beta2-cluster"
I0922 02:44:35.981399       1 server.go:183] "Registering webhook" logger="controller-runtime.webhook" path="/validate-cluster-x-k8s-io-v1beta2-cluster"
I0922 02:44:35.981562       1 webhook.go:344] "Conversion webhook enabled" logger="controller-runtime.builder" GVK="cluster.x-k8s.io/v1beta2, Kind=Cluster"
I0922 02:44:35.981697       1 webhook.go:246] "Registering a mutating webhook" logger="controller-runtime.builder" GVK="cluster.x-k8s.io/v1beta2, Kind=Machine" path="/mutate-cluster-x-k8s-io-v1beta2-machine"
I0922 02:44:35.981877       1 server.go:183] "Registering webhook" logger="controller-runtime.webhook" path="/mutate-cluster-x-k8s-io-v1beta2-machine"
I0922 02:44:35.981933       1 webhook.go:293] "Registering a validating webhook" logger="controller-runtime.builder" GVK="cluster.x-k8s.io/v1beta2, Kind=Machine" path="/validate-cluster-x-k8s-io-v1beta2-machine"
I0922 02:44:35.982240       1 server.go:183] "Registering webhook" logger="controller-runtime.webhook" path="/validate-cluster-x-k8s-io-v1beta2-machine"
I0922 02:44:35.982306       1 webhook.go:344] "Conversion webhook enabled" logger="controller-runtime.builder" GVK="cluster.x-k8s.io/v1beta2, Kind=Machine"
I0922 02:44:35.982414       1 webhook.go:246] "Registering a mutating webhook" logger="controller-runtime.builder" GVK="cluster.x-k8s.io/v1beta2, Kind=MachineSet" path="/mutate-cluster-x-k8s-io-v1beta2-machineset"
I0922 02:44:35.982570       1 server.go:183] "Registering webhook" logger="controller-runtime.webhook" path="/mutate-cluster-x-k8s-io-v1beta2-machineset"
I0922 02:44:35.982623       1 webhook.go:293] "Registering a validating webhook" logger="controller-runtime.builder" GVK="cluster.x-k8s.io/v1beta2, Kind=MachineSet" path="/validate-cluster-x-k8s-io-v1beta2-machineset"
I0922 02:44:35.982707       1 server.go:183] "Registering webhook" logger="controller-runtime.webhook" path="/validate-cluster-x-k8s-io-v1beta2-machineset"
I0922 02:44:35.982776       1 webhook.go:344] "Conversion webhook enabled" logger="controller-runtime.builder" GVK="cluster.x-k8s.io/v1beta2, Kind=MachineSet"
I0922 02:44:35.982885       1 webhook.go:246] "Registering a mutating webhook" logger="controller-runtime.builder" GVK="cluster.x-k8s.io/v1beta2, Kind=MachineDeployment" path="/mutate-cluster-x-k8s-io-v1beta2-machinedeployment"
I0922 02:44:35.982981       1 server.go:183] "Registering webhook" logger="controller-runtime.webhook" path="/mutate-cluster-x-k8s-io-v1beta2-machinedeployment"
I0922 02:44:35.983035       1 webhook.go:293] "Registering a validating webhook" logger="controller-runtime.builder" GVK="cluster.x-k8s.io/v1beta2, Kind=MachineDeployment" path="/validate-cluster-x-k8s-io-v1beta2-machinedeployment"
I0922 02:44:35.983267       1 server.go:183] "Registering webhook" logger="controller-runtime.webhook" path="/validate-cluster-x-k8s-io-v1beta2-machinedeployment"
I0922 02:44:35.983343       1 webhook.go:344] "Conversion webhook enabled" logger="controller-runtime.builder" GVK="cluster.x-k8s.io/v1beta2, Kind=MachineDeployment"
I0922 02:44:35.983437       1 webhook.go:293] "Registering a validating webhook" logger="controller-runtime.builder" GVK="cluster.x-k8s.io/v1beta2, Kind=MachineDrainRule" path="/validate-cluster-x-k8s-io-v1beta2-machinedrainrule"
I0922 02:44:35.983551       1 server.go:183] "Registering webhook" logger="controller-runtime.webhook" path="/validate-cluster-x-k8s-io-v1beta2-machinedrainrule"
I0922 02:44:35.983615       1 webhook.go:344] "Conversion webhook enabled" logger="controller-runtime.builder" GVK="cluster.x-k8s.io/v1beta2, Kind=MachineDrainRule"
I0922 02:44:35.983736       1 webhook.go:246] "Registering a mutating webhook" logger="controller-runtime.builder" GVK="cluster.x-k8s.io/v1beta2, Kind=MachinePool" path="/mutate-cluster-x-k8s-io-v1beta2-machinepool"
I0922 02:44:35.983877       1 server.go:183] "Registering webhook" logger="controller-runtime.webhook" path="/mutate-cluster-x-k8s-io-v1beta2-machinepool"
I0922 02:44:35.983942       1 webhook.go:293] "Registering a validating webhook" logger="controller-runtime.builder" GVK="cluster.x-k8s.io/v1beta2, Kind=MachinePool" path="/validate-cluster-x-k8s-io-v1beta2-machinepool"
I0922 02:44:35.984020       1 server.go:183] "Registering webhook" logger="controller-runtime.webhook" path="/validate-cluster-x-k8s-io-v1beta2-machinepool"
I0922 02:44:35.984085       1 webhook.go:344] "Conversion webhook enabled" logger="controller-runtime.builder" GVK="cluster.x-k8s.io/v1beta2, Kind=MachinePool"
I0922 02:44:35.984140       1 webhook.go:246] "Registering a mutating webhook" logger="controller-runtime.builder" GVK="addons.cluster.x-k8s.io/v1beta2, Kind=ClusterResourceSet" path="/mutate-addons-cluster-x-k8s-io-v1beta2-clusterresourceset"
I0922 02:44:35.984273       1 server.go:183] "Registering webhook" logger="controller-runtime.webhook" path="/mutate-addons-cluster-x-k8s-io-v1beta2-clusterresourceset"
I0922 02:44:35.984405       1 webhook.go:293] "Registering a validating webhook" logger="controller-runtime.builder" GVK="addons.cluster.x-k8s.io/v1beta2, Kind=ClusterResourceSet" path="/validate-addons-cluster-x-k8s-io-v1beta2-clusterresourceset"
I0922 02:44:35.984575       1 server.go:183] "Registering webhook" logger="controller-runtime.webhook" path="/validate-addons-cluster-x-k8s-io-v1beta2-clusterresourceset"
I0922 02:44:35.984642       1 webhook.go:344] "Conversion webhook enabled" logger="controller-runtime.builder" GVK="addons.cluster.x-k8s.io/v1beta2, Kind=ClusterResourceSet"
I0922 02:44:35.984707       1 webhook.go:293] "Registering a validating webhook" logger="controller-runtime.builder" GVK="addons.cluster.x-k8s.io/v1beta2, Kind=ClusterResourceSetBinding" path="/validate-addons-cluster-x-k8s-io-v1beta2-clusterresourcesetbinding"
I0922 02:44:35.984787       1 server.go:183] "Registering webhook" logger="controller-runtime.webhook" path="/validate-addons-cluster-x-k8s-io-v1beta2-clusterresourcesetbinding"
I0922 02:44:35.984856       1 webhook.go:344] "Conversion webhook enabled" logger="controller-runtime.builder" GVK="addons.cluster.x-k8s.io/v1beta2, Kind=ClusterResourceSetBinding"
I0922 02:44:35.984979       1 webhook.go:246] "Registering a mutating webhook" logger="controller-runtime.builder" GVK="cluster.x-k8s.io/v1beta2, Kind=MachineHealthCheck" path="/mutate-cluster-x-k8s-io-v1beta2-machinehealthcheck"
I0922 02:44:35.985069       1 server.go:183] "Registering webhook" logger="controller-runtime.webhook" path="/mutate-cluster-x-k8s-io-v1beta2-machinehealthcheck"
I0922 02:44:35.985129       1 webhook.go:293] "Registering a validating webhook" logger="controller-runtime.builder" GVK="cluster.x-k8s.io/v1beta2, Kind=MachineHealthCheck" path="/validate-cluster-x-k8s-io-v1beta2-machinehealthcheck"
I0922 02:44:35.985246       1 server.go:183] "Registering webhook" logger="controller-runtime.webhook" path="/validate-cluster-x-k8s-io-v1beta2-machinehealthcheck"
I0922 02:44:35.985302       1 webhook.go:344] "Conversion webhook enabled" logger="controller-runtime.builder" GVK="cluster.x-k8s.io/v1beta2, Kind=MachineHealthCheck"
I0922 02:44:35.985375       1 webhook.go:246] "Registering a mutating webhook" logger="controller-runtime.builder" GVK="runtime.cluster.x-k8s.io/v1beta2, Kind=ExtensionConfig" path="/mutate-runtime-cluster-x-k8s-io-v1beta2-extensionconfig"
I0922 02:44:35.985487       1 server.go:183] "Registering webhook" logger="controller-runtime.webhook" path="/mutate-runtime-cluster-x-k8s-io-v1beta2-extensionconfig"
I0922 02:44:35.985538       1 webhook.go:293] "Registering a validating webhook" logger="controller-runtime.builder" GVK="runtime.cluster.x-k8s.io/v1beta2, Kind=ExtensionConfig" path="/validate-runtime-cluster-x-k8s-io-v1beta2-extensionconfig"
I0922 02:44:35.985650       1 server.go:183] "Registering webhook" logger="controller-runtime.webhook" path="/validate-runtime-cluster-x-k8s-io-v1beta2-extensionconfig"
I0922 02:44:35.985706       1 webhook.go:344] "Conversion webhook enabled" logger="controller-runtime.builder" GVK="runtime.cluster.x-k8s.io/v1beta2, Kind=ExtensionConfig"
I0922 02:44:35.985759       1 webhook.go:293] "Registering a validating webhook" logger="controller-runtime.builder" GVK="ipam.cluster.x-k8s.io/v1beta2, Kind=IPAddress" path="/validate-ipam-cluster-x-k8s-io-v1beta2-ipaddress"
I0922 02:44:35.985852       1 server.go:183] "Registering webhook" logger="controller-runtime.webhook" path="/validate-ipam-cluster-x-k8s-io-v1beta2-ipaddress"
I0922 02:44:35.985912       1 webhook.go:344] "Conversion webhook enabled" logger="controller-runtime.builder" GVK="ipam.cluster.x-k8s.io/v1beta2, Kind=IPAddress"
I0922 02:44:35.985966       1 webhook.go:293] "Registering a validating webhook" logger="controller-runtime.builder" GVK="ipam.cluster.x-k8s.io/v1beta2, Kind=IPAddressClaim" path="/validate-ipam-cluster-x-k8s-io-v1beta2-ipaddressclaim"
I0922 02:44:35.986041       1 server.go:183] "Registering webhook" logger="controller-runtime.webhook" path="/validate-ipam-cluster-x-k8s-io-v1beta2-ipaddressclaim"
I0922 02:44:35.986106       1 webhook.go:344] "Conversion webhook enabled" logger="controller-runtime.builder" GVK="ipam.cluster.x-k8s.io/v1beta2, Kind=IPAddressClaim"
I0922 02:44:35.986134       1 main.go:400] "Starting manager" logger="setup" version="v1.13.2"
I0922 02:44:35.986246       1 server.go:208] "Starting metrics server" logger="controller-runtime.metrics"
I0922 02:44:35.986751       1 server.go:83] "starting server" name="health probe" addr="[::]:9440"
I0922 02:44:35.986976       1 server.go:191] "Starting webhook server" logger="controller-runtime.webhook"
I0922 02:44:35.988822       1 certwatcher.go:214] "Updated current TLS certificate" logger="controller-runtime.certwatcher" cert="/tmp/k8s-webhook-server/serving-certs/tls.crt" key="/tmp/k8s-webhook-server/serving-certs/tls.key"
I0922 02:44:35.989161       1 server.go:242] "Serving webhook server" logger="controller-runtime.webhook" host="" port=9443
I0922 02:44:35.989283       1 certwatcher.go:136] "Starting certificate poll+watcher" logger="controller-runtime.certwatcher" cert="/tmp/k8s-webhook-server/serving-certs/tls.crt" key="/tmp/k8s-webhook-server/serving-certs/tls.key" interval="10s"
I0922 02:44:35.993009       1 reflector.go:446] "Caches populated" logger="controller-runtime.cache" type="*v1beta2.MachinePool" reflector="k8s.io/client-go@v0.35.4/tools/cache/reflector.go:289"
I0922 02:44:35.993635       1 reflector.go:446] "Caches populated" logger="controller-runtime.cache" type="*v1beta2.Cluster" reflector="k8s.io/client-go@v0.35.4/tools/cache/reflector.go:289"
I0922 02:44:35.994275       1 reflector.go:446] "Caches populated" logger="controller-runtime.cache" type="*v1beta2.Machine" reflector="k8s.io/client-go@v0.35.4/tools/cache/reflector.go:289"
I0922 02:44:36.089057       1 leaderelection.go:258] "Attempting to acquire leader lease..." lock="capi-system/controller-leader-election-capi"
I0922 02:44:36.119551       1 server.go:247] "Serving metrics server" logger="controller-runtime.metrics" bindAddress=":8443" secure=true
I0922 02:45:03.823105       1 leaderelection.go:272] "Successfully acquired lease" lock="capi-system/controller-leader-election-capi"
I0922 02:45:03.823455       1 recorder.go:116] "capi-controller-manager-5647546676-vnft6_5987068e-2dda-4294-a579-fd8e39d64fa7 became leader" logger="events" type="Normal" object={"kind":"Lease","namespace":"capi-system","name":"controller-leader-election-capi","uid":"2df7b83d-d28a-4ca4-9c41-cccc224e7995","apiVersion":"coordination.k8s.io/v1","resourceVersion":"26953"} reason="LeaderElection"
I0922 02:45:03.823720       1 controller.go:370] "Starting EventSource" controller="clustercache" controllerGroup="cluster.x-k8s.io" controllerKind="Cluster" source="kind source: *v1beta2.Cluster"
I0922 02:45:03.823801       1 controller.go:303] "Starting Controller" controller="clustercache" controllerGroup="cluster.x-k8s.io" controllerKind="Cluster"
I0922 02:45:03.823817       1 controller.go:306] "Starting workers" controller="clustercache" controllerGroup="cluster.x-k8s.io" controllerKind="Cluster" worker count=100
I0922 02:45:03.824600       1 controller.go:370] "Starting EventSource" controller="clusterclass" controllerGroup="cluster.x-k8s.io" controllerKind="ClusterClass" source="kind source: *v1beta2.ExtensionConfig"
I0922 02:45:03.825520       1 controller.go:370] "Starting EventSource" controller="crdmigrator" controllerGroup="apiextensions.k8s.io" controllerKind="CustomResourceDefinition" source="kind source: *v1.PartialObjectMetadata"
I0922 02:45:03.825775       1 controller.go:370] "Starting EventSource" controller="topology/machinedeployment" controllerGroup="cluster.x-k8s.io" controllerKind="MachineDeployment" source="kind source: *v1beta2.Cluster"
I0922 02:45:03.825891       1 controller.go:370] "Starting EventSource" controller="clusterclass" controllerGroup="cluster.x-k8s.io" controllerKind="ClusterClass" source="kind source: *v1beta2.ClusterClass"
I0922 02:45:03.826721       1 controller.go:370] "Starting EventSource" controller="topology/cluster" controllerGroup="cluster.x-k8s.io" controllerKind="Cluster" source="channel source: 0xc0003a4000"
I0922 02:45:03.826862       1 controller.go:370] "Starting EventSource" controller="cluster" controllerGroup="cluster.x-k8s.io" controllerKind="Cluster" source="channel source: 0xc0003a4540"
I0922 02:45:03.826905       1 controller.go:370] "Starting EventSource" controller="topology/machinedeployment" controllerGroup="cluster.x-k8s.io" controllerKind="MachineDeployment" source="kind source: *v1beta2.MachineDeployment"
I0922 02:45:03.827349       1 controller.go:370] "Starting EventSource" controller="topology/cluster" controllerGroup="cluster.x-k8s.io" controllerKind="Cluster" source="kind source: *v1beta2.Cluster"
I0922 02:45:03.827457       1 controller.go:370] "Starting EventSource" controller="topology/cluster" controllerGroup="cluster.x-k8s.io" controllerKind="Cluster" source="kind source: *v1beta2.ClusterClass"
I0922 02:45:03.827509       1 controller.go:370] "Starting EventSource" controller="topology/cluster" controllerGroup="cluster.x-k8s.io" controllerKind="Cluster" source="kind source: *v1beta2.MachineDeployment"
I0922 02:45:03.827577       1 controller.go:370] "Starting EventSource" controller="topology/cluster" controllerGroup="cluster.x-k8s.io" controllerKind="Cluster" source="kind source: *v1beta2.MachinePool"
I0922 02:45:03.827700       1 controller.go:370] "Starting EventSource" controller="topology/machineset" controllerGroup="cluster.x-k8s.io" controllerKind="MachineSet" source="kind source: *v1beta2.Cluster"
I0922 02:45:03.827861       1 controller.go:370] "Starting EventSource" controller="machineset" controllerGroup="cluster.x-k8s.io" controllerKind="MachineSet" source="channel source: 0xc0003ea7e0"
I0922 02:45:03.827911       1 controller.go:370] "Starting EventSource" controller="cluster" controllerGroup="cluster.x-k8s.io" controllerKind="Cluster" source="kind source: *v1beta2.Cluster"
I0922 02:45:03.827986       1 controller.go:370] "Starting EventSource" controller="cluster" controllerGroup="cluster.x-k8s.io" controllerKind="Cluster" source="kind source: *v1beta2.Machine"
I0922 02:45:03.828062       1 controller.go:370] "Starting EventSource" controller="cluster" controllerGroup="cluster.x-k8s.io" controllerKind="Cluster" source="kind source: *v1beta2.MachineDeployment"
I0922 02:45:03.828112       1 controller.go:370] "Starting EventSource" controller="cluster" controllerGroup="cluster.x-k8s.io" controllerKind="Cluster" source="kind source: *v1beta2.MachinePool"
I0922 02:45:03.828469       1 controller.go:370] "Starting EventSource" controller="topology/machineset" controllerGroup="cluster.x-k8s.io" controllerKind="MachineSet" source="kind source: *v1beta2.MachineSet"
I0922 02:45:03.828742       1 controller.go:370] "Starting EventSource" controller="machine" controllerGroup="cluster.x-k8s.io" controllerKind="Machine" source="channel source: 0xc0003ea000"
I0922 02:45:03.828852       1 controller.go:370] "Starting EventSource" controller="machinepool" controllerGroup="cluster.x-k8s.io" controllerKind="MachinePool" source="channel source: 0xc0003eb110"
I0922 02:45:03.828897       1 controller.go:370] "Starting EventSource" controller="machineset" controllerGroup="cluster.x-k8s.io" controllerKind="MachineSet" source="kind source: *v1beta2.MachineSet"
I0922 02:45:03.828929       1 controller.go:370] "Starting EventSource" controller="machineset" controllerGroup="cluster.x-k8s.io" controllerKind="MachineSet" source="kind source: *v1beta2.Machine"
I0922 02:45:03.829022       1 controller.go:370] "Starting EventSource" controller="machineset" controllerGroup="cluster.x-k8s.io" controllerKind="MachineSet" source="kind source: *v1beta2.Machine"
I0922 02:45:03.829088       1 controller.go:370] "Starting EventSource" controller="machineset" controllerGroup="cluster.x-k8s.io" controllerKind="MachineSet" source="kind source: *v1beta2.MachineDeployment"
I0922 02:45:03.829131       1 controller.go:370] "Starting EventSource" controller="machineset" controllerGroup="cluster.x-k8s.io" controllerKind="MachineSet" source="kind source: *v1beta2.Cluster"
I0922 02:45:03.829507       1 controller.go:370] "Starting EventSource" controller="machine" controllerGroup="cluster.x-k8s.io" controllerKind="Machine" source="kind source: *v1beta2.Machine"
I0922 02:45:03.829577       1 controller.go:370] "Starting EventSource" controller="machine" controllerGroup="cluster.x-k8s.io" controllerKind="Machine" source="kind source: *v1beta2.Cluster"
I0922 02:45:03.829621       1 controller.go:370] "Starting EventSource" controller="machine" controllerGroup="cluster.x-k8s.io" controllerKind="Machine" source="kind source: *v1beta2.MachineSet"
I0922 02:45:03.829677       1 controller.go:370] "Starting EventSource" controller="machine" controllerGroup="cluster.x-k8s.io" controllerKind="Machine" source="kind source: *v1beta2.MachineDeployment"
I0922 02:45:03.830261       1 controller.go:370] "Starting EventSource" controller="clusterresourcesetbinding" controllerGroup="addons.cluster.x-k8s.io" controllerKind="ClusterResourceSetBinding" source="kind source: *v1beta2.Cluster"
I0922 02:45:03.830497       1 controller.go:370] "Starting EventSource" controller="machinepool" controllerGroup="cluster.x-k8s.io" controllerKind="MachinePool" source="kind source: *v1beta2.MachinePool"
I0922 02:45:03.830657       1 controller.go:370] "Starting EventSource" controller="machinepool" controllerGroup="cluster.x-k8s.io" controllerKind="MachinePool" source="kind source: *v1beta2.Cluster"
I0922 02:45:03.831086       1 controller.go:370] "Starting EventSource" controller="clusterresourceset" controllerGroup="addons.cluster.x-k8s.io" controllerKind="ClusterResourceSet" source="kind source: *v1.PartialObjectMetadata"
I0922 02:45:03.831117       1 controller.go:370] "Starting EventSource" controller="machinehealthcheck" controllerGroup="cluster.x-k8s.io" controllerKind="MachineHealthCheck" source="channel source: 0xc0003eb500"
I0922 02:45:03.831198       1 controller.go:370] "Starting EventSource" controller="machinehealthcheck" controllerGroup="cluster.x-k8s.io" controllerKind="MachineHealthCheck" source="kind source: *v1beta2.MachineHealthCheck"
I0922 02:45:03.831218       1 controller.go:370] "Starting EventSource" controller="machinehealthcheck" controllerGroup="cluster.x-k8s.io" controllerKind="MachineHealthCheck" source="kind source: *v1beta2.Cluster"
I0922 02:45:03.831261       1 controller.go:370] "Starting EventSource" controller="machinehealthcheck" controllerGroup="cluster.x-k8s.io" controllerKind="MachineHealthCheck" source="kind source: *v1beta2.Machine"
I0922 02:45:03.831348       1 controller.go:370] "Starting EventSource" controller="machinedeployment" controllerGroup="cluster.x-k8s.io" controllerKind="MachineDeployment" source="kind source: *v1beta2.MachineDeployment"
I0922 02:45:03.831473       1 controller.go:370] "Starting EventSource" controller="clusterresourcesetbinding" controllerGroup="addons.cluster.x-k8s.io" controllerKind="ClusterResourceSetBinding" source="kind source: *v1beta2.ClusterResourceSetBinding"
I0922 02:45:03.831682       1 controller.go:370] "Starting EventSource" controller="clusterresourceset" controllerGroup="addons.cluster.x-k8s.io" controllerKind="ClusterResourceSet" source="kind source: *v1beta2.ClusterResourceSet"
I0922 02:45:03.831763       1 controller.go:370] "Starting EventSource" controller="machinedeployment" controllerGroup="cluster.x-k8s.io" controllerKind="MachineDeployment" source="kind source: *v1beta2.MachineSet"
I0922 02:45:03.831822       1 controller.go:370] "Starting EventSource" controller="clusterresourceset" controllerGroup="addons.cluster.x-k8s.io" controllerKind="ClusterResourceSet" source="kind source: *v1beta2.Cluster"
I0922 02:45:03.832109       1 controller.go:370] "Starting EventSource" controller="clusterresourceset" controllerGroup="addons.cluster.x-k8s.io" controllerKind="ClusterResourceSet" source="kind source: *v1.PartialObjectMetadata"
I0922 02:45:03.832164       1 controller.go:370] "Starting EventSource" controller="clusterresourceset" controllerGroup="addons.cluster.x-k8s.io" controllerKind="ClusterResourceSet" source="channel source: 0xc0003eb1f0"
I0922 02:45:03.835682       1 reflector.go:446] "Caches populated" logger="controller-runtime.cache" type="*v1beta2.MachineDeployment" reflector="k8s.io/client-go@v0.35.4/tools/cache/reflector.go:289"
I0922 02:45:03.835874       1 controller.go:370] "Starting EventSource" controller="machinedeployment" controllerGroup="cluster.x-k8s.io" controllerKind="MachineDeployment" source="kind source: *v1beta2.Cluster"
I0922 02:45:03.831833       1 controller.go:370] "Starting EventSource" controller="machinedeployment" controllerGroup="cluster.x-k8s.io" controllerKind="MachineDeployment" source="kind source: *v1beta2.MachineSet"
I0922 02:45:03.838281       1 reflector.go:446] "Caches populated" logger="controller-runtime.cache" type="*v1beta2.ClusterClass" reflector="k8s.io/client-go@v0.35.4/tools/cache/reflector.go:289"
I0922 02:45:03.839115       1 reflector.go:446] "Caches populated" logger="controller-runtime.cache" type="*v1beta2.ExtensionConfig" reflector="k8s.io/client-go@v0.35.4/tools/cache/reflector.go:289"
I0922 02:45:03.839192       1 reflector.go:446] "Caches populated" logger="controller-runtime.cache" type="*v1beta2.MachineSet" reflector="k8s.io/client-go@v0.35.4/tools/cache/reflector.go:289"
I0922 02:45:03.842013       1 reflector.go:446] "Caches populated" logger="controller-runtime.cache" type="*v1beta2.MachineHealthCheck" reflector="k8s.io/client-go@v0.35.4/tools/cache/reflector.go:289"
I0922 02:45:03.843418       1 reflector.go:446] "Caches populated" logger="controller-runtime.cache" type="*v1.PartialObjectMetadata" reflector="k8s.io/client-go@v0.35.4/tools/cache/reflector.go:289"
I0922 02:45:03.843948       1 reflector.go:446] "Caches populated" logger="controller-runtime.cache" type="*v1beta2.ClusterResourceSetBinding" reflector="k8s.io/client-go@v0.35.4/tools/cache/reflector.go:289"
I0922 02:45:03.844178       1 reflector.go:446] "Caches populated" logger="controller-runtime.cache" type="*v1.PartialObjectMetadata" reflector="k8s.io/client-go@v0.35.4/tools/cache/reflector.go:289"
I0922 02:45:03.850248       1 reflector.go:446] "Caches populated" logger="controller-runtime.cache" type="*v1.PartialObjectMetadata" reflector="k8s.io/client-go@v0.35.4/tools/cache/reflector.go:289"
I0922 02:45:03.854597       1 reflector.go:446] "Caches populated" logger="controller-runtime.cache" type="*v1beta2.ClusterResourceSet" reflector="k8s.io/client-go@v0.35.4/tools/cache/reflector.go:289"
I0922 02:45:03.926819       1 controller.go:303] "Starting Controller" controller="clusterclass" controllerGroup="cluster.x-k8s.io" controllerKind="ClusterClass"
I0922 02:45:03.926856       1 controller.go:306] "Starting workers" controller="clusterclass" controllerGroup="cluster.x-k8s.io" controllerKind="ClusterClass" worker count=10
I0922 02:45:03.927163       1 controller.go:303] "Starting Controller" controller="topology/machinedeployment" controllerGroup="cluster.x-k8s.io" controllerKind="MachineDeployment"
I0922 02:45:03.927205       1 controller.go:306] "Starting workers" controller="topology/machinedeployment" controllerGroup="cluster.x-k8s.io" controllerKind="MachineDeployment" worker count=1
I0922 02:45:03.928056       1 controller.go:303] "Starting Controller" controller="topology/cluster" controllerGroup="cluster.x-k8s.io" controllerKind="Cluster"
I0922 02:45:03.928087       1 controller.go:306] "Starting workers" controller="topology/cluster" controllerGroup="cluster.x-k8s.io" controllerKind="Cluster" worker count=50
I0922 02:45:03.928246       1 controller.go:303] "Starting Controller" controller="cluster" controllerGroup="cluster.x-k8s.io" controllerKind="Cluster"
I0922 02:45:03.928314       1 controller.go:306] "Starting workers" controller="cluster" controllerGroup="cluster.x-k8s.io" controllerKind="Cluster" worker count=50
I0922 02:45:03.928691       1 controller.go:303] "Starting Controller" controller="topology/machineset" controllerGroup="cluster.x-k8s.io" controllerKind="MachineSet"
I0922 02:45:03.928766       1 controller.go:306] "Starting workers" controller="topology/machineset" controllerGroup="cluster.x-k8s.io" controllerKind="MachineSet" worker count=1
I0922 02:45:03.929293       1 controller.go:303] "Starting Controller" controller="machineset" controllerGroup="cluster.x-k8s.io" controllerKind="MachineSet"
I0922 02:45:03.929334       1 controller.go:306] "Starting workers" controller="machineset" controllerGroup="cluster.x-k8s.io" controllerKind="MachineSet" worker count=50
I0922 02:45:03.929953       1 controller.go:303] "Starting Controller" controller="machine" controllerGroup="cluster.x-k8s.io" controllerKind="Machine"
I0922 02:45:03.930006       1 controller.go:306] "Starting workers" controller="machine" controllerGroup="cluster.x-k8s.io" controllerKind="Machine" worker count=100
I0922 02:45:03.931071       1 controller.go:303] "Starting Controller" controller="machinepool" controllerGroup="cluster.x-k8s.io" controllerKind="MachinePool"
I0922 02:45:03.931104       1 controller.go:306] "Starting workers" controller="machinepool" controllerGroup="cluster.x-k8s.io" controllerKind="MachinePool" worker count=50
I0922 02:45:03.931893       1 controller.go:303] "Starting Controller" controller="clusterresourcesetbinding" controllerGroup="addons.cluster.x-k8s.io" controllerKind="ClusterResourceSetBinding"
I0922 02:45:03.932004       1 controller.go:306] "Starting workers" controller="clusterresourcesetbinding" controllerGroup="addons.cluster.x-k8s.io" controllerKind="ClusterResourceSetBinding" worker count=10
I0922 02:45:03.932229       1 controller.go:303] "Starting Controller" controller="machinehealthcheck" controllerGroup="cluster.x-k8s.io" controllerKind="MachineHealthCheck"
I0922 02:45:03.932303       1 controller.go:306] "Starting workers" controller="machinehealthcheck" controllerGroup="cluster.x-k8s.io" controllerKind="MachineHealthCheck" worker count=50
I0922 02:45:03.938371       1 controller.go:303] "Starting Controller" controller="machinedeployment" controllerGroup="cluster.x-k8s.io" controllerKind="MachineDeployment"
I0922 02:45:03.938394       1 controller.go:306] "Starting workers" controller="machinedeployment" controllerGroup="cluster.x-k8s.io" controllerKind="MachineDeployment" worker count=50
I0922 02:45:04.027637       1 controller.go:303] "Starting Controller" controller="crdmigrator" controllerGroup="apiextensions.k8s.io" controllerKind="CustomResourceDefinition"
I0922 02:45:04.027699       1 controller.go:306] "Starting workers" controller="crdmigrator" controllerGroup="apiextensions.k8s.io" controllerKind="CustomResourceDefinition" worker count=1
I0922 02:45:04.033966       1 controller.go:303] "Starting Controller" controller="clusterresourceset" controllerGroup="addons.cluster.x-k8s.io" controllerKind="ClusterResourceSet"
I0922 02:45:04.033992       1 controller.go:306] "Starting workers" controller="clusterresourceset" controllerGroup="addons.cluster.x-k8s.io" controllerKind="ClusterResourceSet" worker count=10
E0922 02:48:40.530358       1 request.go:1196] "Unexpected error when reading response body" err="context deadline exceeded"
E0922 02:48:40.530423       1 leaderelection.go:445] "Failed to update lease optimistically, falling back to slow path" err="unexpected error when reading response body. Please retry. Original error: context deadline exceeded" lock="capi-system/controller-leader-election-capi"
E0922 02:48:45.529770       1 leaderelection.go:488] "Failed to update lease" err="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" lock="capi-system/controller-leader-election-capi"
I0922 02:48:45.529855       1 leaderelection.go:299] "Failed to renew lease" lock="capi-system/controller-leader-election-capi" err="context deadline exceeded"
E0922 02:48:45.530009       1 main.go:402] "Problem running manager" err="leader election lost" logger="setup"