Skip to content

Instantly share code, notes, and snippets.

@MaxRink

MaxRink/crash.log

Created June 29, 2020 18:59
Show Gist options
  • Star 0 You must be signed in to star a gist
  • Fork 0 You must be signed in to fork a gist
  • Save MaxRink/239e4fde6894ff102913d550647a3c93 to your computer and use it in GitHub Desktop.
Save MaxRink/239e4fde6894ff102913d550647a3c93 to your computer and use it in GitHub Desktop.
Download ZIP
CAPV crashlog
Raw
crash.log
I0629 18:48:18.690990 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
I0629 18:48:18.691433 1 haproxyloadbalancer_controller.go:287] capv-controller-manager/haproxyloadbalancer-controller "msg"="Generating certificates" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo"
I0629 18:48:19.150117 1 haproxyloadbalancer_controller.go:311] capv-controller-manager/haproxyloadbalancer-controller "msg"="HAProxy LoadBalancer not ready, reconciling network" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "vm-name"="demo-ref-1-lb"
I0629 18:48:19.150163 1 haproxyloadbalancer_controller.go:605] capv-controller-manager/haproxyloadbalancer-controller "msg"="waiting on vm for ip address" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "old-ip-address"="" "vm-api-version"="infrastructure.cluster.x-k8s.io/v1alpha3" "vm-kind"="VSphereVM" "vm-name"="demo-ref-1-lb"
I0629 18:48:19.150186 1 haproxyloadbalancer_controller.go:318] capv-controller-manager/haproxyloadbalancer-controller "msg"="Network is not reconciled, requeing in 10 seconds" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "old-ip-address"="" "vm-api-version"="infrastructure.cluster.x-k8s.io/v1alpha3" "vm-kind"="VSphereVM" "vm-name"="demo-ref-1-lb"
I0629 18:48:28.127194 1 vspherecluster_controller.go:243] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="Reconciling VSphereCluster"
I0629 18:48:28.127302 1 vspherecluster_controller.go:390] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="status.ready not found for load balancer" "load-balancer-gvk"="infrastructure.cluster.x-k8s.io/v1alpha3, Kind=HAProxyLoadBalancer" "load-balancer-name"="demo-ref-1" "load-balancer-namespace"="demo"
I0629 18:48:28.127320 1 vspherecluster_controller.go:254] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="load balancer is not reconciled"
I0629 18:48:29.150758 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
I0629 18:48:29.151176 1 haproxyloadbalancer_controller.go:287] capv-controller-manager/haproxyloadbalancer-controller "msg"="Generating certificates" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo"
I0629 18:48:29.660529 1 haproxyloadbalancer_controller.go:311] capv-controller-manager/haproxyloadbalancer-controller "msg"="HAProxy LoadBalancer not ready, reconciling network" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "vm-name"="demo-ref-1-lb"
I0629 18:48:29.660579 1 haproxyloadbalancer_controller.go:605] capv-controller-manager/haproxyloadbalancer-controller "msg"="waiting on vm for ip address" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "old-ip-address"="" "vm-api-version"="infrastructure.cluster.x-k8s.io/v1alpha3" "vm-kind"="VSphereVM" "vm-name"="demo-ref-1-lb"
I0629 18:48:29.660601 1 haproxyloadbalancer_controller.go:318] capv-controller-manager/haproxyloadbalancer-controller "msg"="Network is not reconciled, requeing in 10 seconds" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "old-ip-address"="" "vm-api-version"="infrastructure.cluster.x-k8s.io/v1alpha3" "vm-kind"="VSphereVM" "vm-name"="demo-ref-1-lb"
I0629 18:48:38.128039 1 vspherecluster_controller.go:243] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="Reconciling VSphereCluster"
I0629 18:48:38.128137 1 vspherecluster_controller.go:390] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="status.ready not found for load balancer" "load-balancer-gvk"="infrastructure.cluster.x-k8s.io/v1alpha3, Kind=HAProxyLoadBalancer" "load-balancer-name"="demo-ref-1" "load-balancer-namespace"="demo"
I0629 18:48:38.128150 1 vspherecluster_controller.go:254] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="load balancer is not reconciled"
I0629 18:48:39.661097 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
I0629 18:48:39.661586 1 haproxyloadbalancer_controller.go:287] capv-controller-manager/haproxyloadbalancer-controller "msg"="Generating certificates" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo"
I0629 18:48:39.857350 1 haproxyloadbalancer_controller.go:311] capv-controller-manager/haproxyloadbalancer-controller "msg"="HAProxy LoadBalancer not ready, reconciling network" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "vm-name"="demo-ref-1-lb"
I0629 18:48:39.857395 1 haproxyloadbalancer_controller.go:605] capv-controller-manager/haproxyloadbalancer-controller "msg"="waiting on vm for ip address" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "old-ip-address"="" "vm-api-version"="infrastructure.cluster.x-k8s.io/v1alpha3" "vm-kind"="VSphereVM" "vm-name"="demo-ref-1-lb"
I0629 18:48:39.857417 1 haproxyloadbalancer_controller.go:318] capv-controller-manager/haproxyloadbalancer-controller "msg"="Network is not reconciled, requeing in 10 seconds" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "old-ip-address"="" "vm-api-version"="infrastructure.cluster.x-k8s.io/v1alpha3" "vm-kind"="VSphereVM" "vm-name"="demo-ref-1-lb"
I0629 18:48:40.797735 1 util.go:461] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="discovered IP address" "addressType"="dhcp4" "addressValue"="10.27.50.137"
I0629 18:48:40.797799 1 util.go:426] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="ignoring IP address" "reason"="failed to validate ip addr=fe80::250:56ff:fea1:ffe2: link-local-unicast"
I0629 18:48:40.797811 1 util.go:531] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="the VM has all of the requested IP addresses"
I0629 18:48:40.797915 1 util.go:289] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="triggering GenericEvent" "ipAddress"="10.27.50.137" "reason"="network"
I0629 18:48:40.990703 1 util.go:65] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="vm found by bios uuid" "vmref"={"Type":"VirtualMachine","Value":"vm-632188"}
I0629 18:48:41.003064 1 service.go:255] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="powered on"
I0629 18:48:41.003095 1 vspherevm_controller.go:326] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="vm bios-uuid" "biosuuid"="42177a99-891d-d1da-0376-4587547699ce"
I0629 18:48:41.003316 1 vspherevm_controller.go:347] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="VSphereVM is ready"
I0629 18:48:41.014301 1 vspherevm_controller.go:249] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="resource is not patched" "local-resource-version"="39580035" "remote-resource-version"="39580035"
I0629 18:48:41.014411 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
I0629 18:48:41.014758 1 haproxyloadbalancer_controller.go:287] capv-controller-manager/haproxyloadbalancer-controller "msg"="Generating certificates" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo"
I0629 18:48:41.158262 1 haproxyloadbalancer_controller.go:311] capv-controller-manager/haproxyloadbalancer-controller "msg"="HAProxy LoadBalancer not ready, reconciling network" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "vm-name"="demo-ref-1-lb"
I0629 18:48:41.158314 1 haproxyloadbalancer_controller.go:614] capv-controller-manager/haproxyloadbalancer-controller "msg"="Discovered IP address from VM" "api-version"="v1alpha3" "ip-address"="10.27.50.137" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "old-ip-address"="" "vm-api-version"="infrastructure.cluster.x-k8s.io/v1alpha3" "vm-kind"="VSphereVM" "vm-name"="demo-ref-1-lb"
I0629 18:48:41.158338 1 haproxyloadbalancer_controller.go:624] capv-controller-manager/haproxyloadbalancer-controller "msg"="Initialized IP address" "api-version"="v1alpha3" "ip-address"="10.27.50.137" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "old-ip-address"="" "vm-api-version"="infrastructure.cluster.x-k8s.io/v1alpha3" "vm-kind"="VSphereVM" "vm-name"="demo-ref-1-lb"
I0629 18:48:41.664446 1 haproxyloadbalancer_controller.go:332] capv-controller-manager/haproxyloadbalancer-controller "msg"="HAProxyLoadBalancer is ready" "api-version"="v1alpha3" "ip-address"="10.27.50.137" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "old-ip-address"="" "vm-api-version"="infrastructure.cluster.x-k8s.io/v1alpha3" "vm-kind"="VSphereVM" "vm-name"="demo-ref-1-lb"
E0629 18:48:41.664518 1 haproxyloadbalancer_controller.go:337] capv-controller-manager/haproxyloadbalancer-controller "msg"="Requeing after 10 seconds" "error"="Failed to get HAproxy dataplane config secret: Secret \"demo-ref-1-haproxy-config\" not found" "api-version"="v1alpha3" "ip-address"="10.27.50.137" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "old-ip-address"="" "vm-api-version"="infrastructure.cluster.x-k8s.io/v1alpha3" "vm-kind"="VSphereVM" "vm-name"="demo-ref-1-lb"
E0629 18:48:41.677946 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="Failed to get HAproxy dataplane config secret: Secret \"demo-ref-1-haproxy-config\" not found" "controller"="haproxyloadbalancer" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:48:41.678456 1 vspherecluster_controller.go:243] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="Reconciling VSphereCluster"
I0629 18:48:41.678534 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
I0629 18:48:41.678575 1 vspherecluster_controller.go:436] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="ControlPlaneEndpoint discovered via load balancer" "controlPlaneEndpoint"="10.27.50.137:6443"
I0629 18:48:41.678611 1 vspherecluster_controller.go:460] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="skipping control plane endpoint reconciliation" "controlPlaneEndpoint"="10.27.50.137:6443" "reason"="ControlPlaneEndpoint already set on VSphereCluster"
I0629 18:48:41.678780 1 vspherecluster_controller.go:545] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="start polling API server for online check"
E0629 18:48:41.699260 1 haproxyloadbalancer_controller.go:337] capv-controller-manager/haproxyloadbalancer-controller "msg"="Requeing after 10 seconds" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.137:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "vm-name"="demo-ref-1-lb"
E0629 18:48:41.699517 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.137:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "controller"="haproxyloadbalancer" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:48:41.699589 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
I0629 18:48:41.702119 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherecluster" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:48:41.702295 1 vspherecluster_controller.go:243] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="Reconciling VSphereCluster"
I0629 18:48:41.702336 1 vspherecluster_controller.go:316] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="skipping load balancer reconciliation" "controlPlaneEndpoint"="10.27.50.137:6443" "reason"="VSphereCluster.Spec.ControlPlaneEndpoint is already set"
I0629 18:48:41.702355 1 vspherecluster_controller.go:460] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="skipping control plane endpoint reconciliation" "controlPlaneEndpoint"="10.27.50.137:6443" "reason"="ControlPlaneEndpoint already set on VSphereCluster"
I0629 18:48:41.702373 1 vspherecluster_controller.go:538] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="skipping reconcile when API server is online" "reason"="alreadyPolling"
I0629 18:48:41.702595 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherecluster" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:48:41.702752 1 vspherecluster_controller.go:243] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="Reconciling VSphereCluster"
I0629 18:48:41.702787 1 vspherecluster_controller.go:316] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="skipping load balancer reconciliation" "controlPlaneEndpoint"="10.27.50.137:6443" "reason"="VSphereCluster.Spec.ControlPlaneEndpoint is already set"
I0629 18:48:41.702805 1 vspherecluster_controller.go:460] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="skipping control plane endpoint reconciliation" "controlPlaneEndpoint"="10.27.50.137:6443" "reason"="ControlPlaneEndpoint already set on VSphereCluster"
I0629 18:48:41.702820 1 vspherecluster_controller.go:538] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="skipping reconcile when API server is online" "reason"="alreadyPolling"
I0629 18:48:41.703006 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherecluster" "request"={"Namespace":"demo","Name":"demo-ref-1"}
E0629 18:48:41.707335 1 haproxyloadbalancer_controller.go:337] capv-controller-manager/haproxyloadbalancer-controller "msg"="Requeing after 10 seconds" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.137:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "vm-name"="demo-ref-1-lb"
E0629 18:48:41.707555 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.137:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "controller"="haproxyloadbalancer" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:48:41.709638 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
E0629 18:48:41.716960 1 haproxyloadbalancer_controller.go:337] capv-controller-manager/haproxyloadbalancer-controller "msg"="Requeing after 10 seconds" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.137:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "vm-name"="demo-ref-1-lb"
E0629 18:48:41.717466 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.137:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "controller"="haproxyloadbalancer" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:48:41.727474 1 vspherecluster_controller.go:243] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="Reconciling VSphereCluster"
I0629 18:48:41.727529 1 vspherecluster_controller.go:309] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="skipping load balancer reconciliation" "controlPlaneEndpoint"="10.27.50.137:6443" "reason"="Cluster.Spec.ControlPlaneEndpoint is already set"
I0629 18:48:41.727551 1 vspherecluster_controller.go:453] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="skipping control plane endpoint reconciliation" "controlPlaneEndpoint"="10.27.50.137:6443" "reason"="ControlPlaneEndpoint already set on Cluster"
I0629 18:48:41.727563 1 vspherecluster_controller.go:538] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="skipping reconcile when API server is online" "reason"="alreadyPolling"
I0629 18:48:41.727781 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherecluster" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:48:41.737717 1 vspherecluster_controller.go:243] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="Reconciling VSphereCluster"
I0629 18:48:41.737823 1 vspherecluster_controller.go:309] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="skipping load balancer reconciliation" "controlPlaneEndpoint"="10.27.50.137:6443" "reason"="Cluster.Spec.ControlPlaneEndpoint is already set"
I0629 18:48:41.737886 1 vspherecluster_controller.go:453] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="skipping control plane endpoint reconciliation" "controlPlaneEndpoint"="10.27.50.137:6443" "reason"="ControlPlaneEndpoint already set on Cluster"
I0629 18:48:41.737919 1 vspherecluster_controller.go:538] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="skipping reconcile when API server is online" "reason"="alreadyPolling"
I0629 18:48:41.738226 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherecluster" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:48:41.757415 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
E0629 18:48:41.765336 1 haproxyloadbalancer_controller.go:337] capv-controller-manager/haproxyloadbalancer-controller "msg"="Requeing after 10 seconds" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.137:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "vm-name"="demo-ref-1-lb"
E0629 18:48:41.765566 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.137:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "controller"="haproxyloadbalancer" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:48:41.845718 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
E0629 18:48:41.853214 1 haproxyloadbalancer_controller.go:337] capv-controller-manager/haproxyloadbalancer-controller "msg"="Requeing after 10 seconds" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.137:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "vm-name"="demo-ref-1-lb"
E0629 18:48:41.853477 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.137:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "controller"="haproxyloadbalancer" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:48:42.013637 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
I0629 18:48:42.014480 1 vspherevm_controller.go:229] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="resource is patched" "local-resource-version"="39580035" "remote-resource-version"="39580374"
I0629 18:48:42.014518 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-lb"}
E0629 18:48:42.021068 1 haproxyloadbalancer_controller.go:337] capv-controller-manager/haproxyloadbalancer-controller "msg"="Requeing after 10 seconds" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.137:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "vm-name"="demo-ref-1-lb"
E0629 18:48:42.021387 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.137:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "controller"="haproxyloadbalancer" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:48:42.146898 1 util.go:65] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="vm found by bios uuid" "vmref"={"Type":"VirtualMachine","Value":"vm-632188"}
I0629 18:48:42.163026 1 service.go:255] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="powered on"
I0629 18:48:42.163051 1 vspherevm_controller.go:326] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="vm bios-uuid" "biosuuid"="42177a99-891d-d1da-0376-4587547699ce"
I0629 18:48:42.163259 1 vspherevm_controller.go:347] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="VSphereVM is ready"
I0629 18:48:42.163574 1 vspherevm_controller.go:240] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="resource patch was not required" "local-resource-version"="39580374" "remote-resource-version"="39580374"
I0629 18:48:42.163600 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-lb"}
I0629 18:48:42.341513 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
E0629 18:48:42.349399 1 haproxyloadbalancer_controller.go:337] capv-controller-manager/haproxyloadbalancer-controller "msg"="Requeing after 10 seconds" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.137:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "vm-name"="demo-ref-1-lb"
E0629 18:48:42.349635 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.137:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "controller"="haproxyloadbalancer" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:48:42.989809 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
E0629 18:48:42.997549 1 haproxyloadbalancer_controller.go:337] capv-controller-manager/haproxyloadbalancer-controller "msg"="Requeing after 10 seconds" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.137:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "vm-name"="demo-ref-1-lb"
E0629 18:48:42.997784 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.137:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "controller"="haproxyloadbalancer" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:48:43.171033 1 vspheremachine_controller.go:160] capv-controller-manager/vspheremachine-controller "msg"="Waiting for Machine Controller to set OwnerRef on VSphereMachine"
I0629 18:48:43.171068 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-cp-v1-rmf4j"}
I0629 18:48:43.196016 1 vspheremachine_controller.go:160] capv-controller-manager/vspheremachine-controller "msg"="Waiting for Machine Controller to set OwnerRef on VSphereMachine"
I0629 18:48:43.196049 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-cp-v1-rmf4j"}
I0629 18:48:43.256759 1 vspheremachine_controller.go:314] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-rmf4j "msg"="Waiting for bootstrap data to be available"
I0629 18:48:43.301405 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-cp-v1-rmf4j"}
I0629 18:48:43.301679 1 vspheremachine_controller.go:314] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-rmf4j "msg"="Waiting for bootstrap data to be available"
I0629 18:48:43.301877 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-cp-v1-rmf4j"}
I0629 18:48:43.302321 1 vspheremachine_controller.go:314] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-rmf4j "msg"="Waiting for bootstrap data to be available"
I0629 18:48:43.302485 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-cp-v1-rmf4j"}
I0629 18:48:43.327530 1 vspheremachine_controller.go:314] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-rmf4j "msg"="Waiting for bootstrap data to be available"
I0629 18:48:43.327731 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-cp-v1-rmf4j"}
I0629 18:48:43.378598 1 vspheremachine_controller.go:521] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-rmf4j "msg"="spec.biosUUID not found" "vmGVK"="/, Kind=" "vmName"="demo-ref-1-wftft" "vmNamespace"="demo"
I0629 18:48:43.378625 1 vspheremachine_controller.go:345] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-rmf4j "msg"="provider ID is not reconciled"
I0629 18:48:43.378794 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-cp-v1-rmf4j"}
I0629 18:48:43.379196 1 vspheremachine_controller.go:521] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-rmf4j "msg"="spec.biosUUID not found" "vmGVK"="infrastructure.cluster.x-k8s.io/v1alpha3, Kind=VSphereVM" "vmName"="demo-ref-1-wftft" "vmNamespace"="demo"
I0629 18:48:43.379217 1 vspheremachine_controller.go:345] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-rmf4j "msg"="provider ID is not reconciled"
I0629 18:48:43.379361 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-cp-v1-rmf4j"}
I0629 18:48:43.521266 1 util.go:81] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="using inventory path to find vm" "path"="/Bremen/vm/TDCN/DCI_SCHIFF/demo-ref-1-wftft"
I0629 18:48:43.536953 1 clone.go:46] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft/vcenter "msg"="starting clone process"
I0629 18:48:43.536978 1 clone.go:50] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft/vcenter "msg"="applied bootstrap data to VM clone spec"
I0629 18:48:44.277932 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
E0629 18:48:44.286183 1 haproxyloadbalancer_controller.go:337] capv-controller-manager/haproxyloadbalancer-controller "msg"="Requeing after 10 seconds" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.137:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "vm-name"="demo-ref-1-lb"
E0629 18:48:44.286451 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.137:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "controller"="haproxyloadbalancer" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:48:44.322128 1 clone.go:177] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft/vcenter "msg"="cloning machine" "cloneType"="fullClone" "name"="demo-ref-1-wftft" "namespace"="demo"
I0629 18:48:44.334953 1 util.go:210] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="enqueuing reconcile request on task completion" "task-description-id"="VirtualMachine.clone" "task-entity-name"="ubuntu-1804-200428T1533-kube-v1.18.2" "task-name"="CloneVM_Task" "task-ref"={"Type":"Task","Value":"task-16023319"}
I0629 18:48:44.334993 1 vspherevm_controller.go:318] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="VM state is not reconciled" "actual-vm-state"="pending" "expected-vm-state"="ready"
I0629 18:48:44.344381 1 vspheremachine_controller.go:521] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-rmf4j "msg"="spec.biosUUID not found" "vmGVK"="infrastructure.cluster.x-k8s.io/v1alpha3, Kind=VSphereVM" "vmName"="demo-ref-1-wftft" "vmNamespace"="demo"
I0629 18:48:44.344404 1 vspheremachine_controller.go:345] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-rmf4j "msg"="provider ID is not reconciled"
I0629 18:48:44.344553 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-cp-v1-rmf4j"}
I0629 18:48:44.353880 1 vspherevm_controller.go:229] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="resource is patched" "local-resource-version"="39580427" "remote-resource-version"="39580436"
I0629 18:48:44.353908 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-wftft"}
I0629 18:48:44.354369 1 vspheremachine_controller.go:521] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-rmf4j "msg"="spec.biosUUID not found" "vmGVK"="infrastructure.cluster.x-k8s.io/v1alpha3, Kind=VSphereVM" "vmName"="demo-ref-1-wftft" "vmNamespace"="demo"
I0629 18:48:44.354387 1 vspheremachine_controller.go:345] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-rmf4j "msg"="provider ID is not reconciled"
I0629 18:48:44.354536 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-cp-v1-rmf4j"}
I0629 18:48:44.506963 1 util.go:124] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft/task-16023319 "msg"="task found" "description-id"="VirtualMachine.clone" "state"="running"
I0629 18:48:44.506987 1 util.go:130] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft/task-16023319 "msg"="task is still running" "description-id"="VirtualMachine.clone"
I0629 18:48:44.506999 1 vspherevm_controller.go:318] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="VM state is not reconciled" "actual-vm-state"="pending" "expected-vm-state"="ready"
I0629 18:48:44.507254 1 vspherevm_controller.go:240] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="resource patch was not required" "local-resource-version"="39580436" "remote-resource-version"="39580436"
I0629 18:48:44.507277 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-wftft"}
I0629 18:48:46.846700 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
E0629 18:48:46.854729 1 haproxyloadbalancer_controller.go:337] capv-controller-manager/haproxyloadbalancer-controller "msg"="Requeing after 10 seconds" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.137:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "vm-name"="demo-ref-1-lb"
E0629 18:48:46.855020 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.137:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "controller"="haproxyloadbalancer" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:48:48.128908 1 vspherecluster_controller.go:243] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="Reconciling VSphereCluster"
I0629 18:48:48.128970 1 vspherecluster_controller.go:309] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="skipping load balancer reconciliation" "controlPlaneEndpoint"="10.27.50.137:6443" "reason"="Cluster.Spec.ControlPlaneEndpoint is already set"
I0629 18:48:48.128997 1 vspherecluster_controller.go:453] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="skipping control plane endpoint reconciliation" "controlPlaneEndpoint"="10.27.50.137:6443" "reason"="ControlPlaneEndpoint already set on Cluster"
I0629 18:48:48.129010 1 vspherecluster_controller.go:538] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="skipping reconcile when API server is online" "reason"="alreadyPolling"
I0629 18:48:48.130915 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherecluster" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:48:51.975277 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
E0629 18:48:51.983501 1 haproxyloadbalancer_controller.go:337] capv-controller-manager/haproxyloadbalancer-controller "msg"="Requeing after 10 seconds" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.137:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "vm-name"="demo-ref-1-lb"
E0629 18:48:51.983751 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.137:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "controller"="haproxyloadbalancer" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:49:02.223936 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
E0629 18:49:02.232565 1 haproxyloadbalancer_controller.go:337] capv-controller-manager/haproxyloadbalancer-controller "msg"="Requeing after 10 seconds" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.137:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "vm-name"="demo-ref-1-lb"
E0629 18:49:02.232881 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.137:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "controller"="haproxyloadbalancer" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:49:07.102276 1 util.go:255] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="triggering GenericEvent" "reason"="task" "task-description-id"="VirtualMachine.clone" "task-entity-name"="ubuntu-1804-200428T1533-kube-v1.18.2" "task-name"="CloneVM_Task" "task-ref"={"Type":"Task","Value":"task-16023319"} "task-state"="success"
I0629 18:49:07.230483 1 util.go:124] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft/task-16023319 "msg"="task found" "description-id"="VirtualMachine.clone" "state"="success"
I0629 18:49:07.230509 1 util.go:133] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft/task-16023319 "msg"="task is a success" "description-id"="VirtualMachine.clone"
I0629 18:49:07.233160 1 util.go:92] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="vm found by instance uuid" "vmref"={"Type":"VirtualMachine","Value":"vm-632189"}
I0629 18:49:07.245059 1 service.go:221] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="updating metadata"
I0629 18:49:07.253129 1 service.go:228] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="wait for VM metadata to be updated"
I0629 18:49:07.254946 1 util.go:210] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="enqueuing reconcile request on task completion" "task-description-id"="VirtualMachine.reconfigure" "task-entity-name"="demo-ref-1-wftft" "task-name"="ReconfigVM_Task" "task-ref"={"Type":"Task","Value":"task-16023320"}
I0629 18:49:07.254986 1 vspherevm_controller.go:318] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="VM state is not reconciled" "actual-vm-state"="pending" "expected-vm-state"="ready"
I0629 18:49:07.264180 1 vspherevm_controller.go:249] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="resource is not patched" "local-resource-version"="39580436" "remote-resource-version"="39580436"
I0629 18:49:07.264736 1 vspheremachine_controller.go:521] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-rmf4j "msg"="spec.biosUUID not found" "vmGVK"="infrastructure.cluster.x-k8s.io/v1alpha3, Kind=VSphereVM" "vmName"="demo-ref-1-wftft" "vmNamespace"="demo"
I0629 18:49:07.264763 1 vspheremachine_controller.go:345] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-rmf4j "msg"="provider ID is not reconciled"
I0629 18:49:07.264941 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-cp-v1-rmf4j"}
I0629 18:49:07.543994 1 util.go:255] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="triggering GenericEvent" "reason"="task" "task-description-id"="VirtualMachine.reconfigure" "task-entity-name"="demo-ref-1-wftft" "task-name"="ReconfigVM_Task" "task-ref"={"Type":"Task","Value":"task-16023320"} "task-state"="success"
I0629 18:49:08.264433 1 vspherevm_controller.go:229] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="resource is patched" "local-resource-version"="39580436" "remote-resource-version"="39580616"
I0629 18:49:08.264489 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-wftft"}
I0629 18:49:08.398107 1 util.go:124] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft/task-16023320 "msg"="task found" "description-id"="VirtualMachine.reconfigure" "state"="success"
I0629 18:49:08.398133 1 util.go:133] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft/task-16023320 "msg"="task is a success" "description-id"="VirtualMachine.reconfigure"
I0629 18:49:08.401213 1 util.go:92] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="vm found by instance uuid" "vmref"={"Type":"VirtualMachine","Value":"vm-632189"}
I0629 18:49:08.413946 1 service.go:239] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="powering on"
I0629 18:49:08.422323 1 service.go:252] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="wait for VM to be powered on"
I0629 18:49:08.424392 1 util.go:210] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="enqueuing reconcile request on task completion" "task-description-id"="VirtualMachine.powerOn" "task-entity-name"="demo-ref-1-wftft" "task-name"="PowerOnVM_Task" "task-ref"={"Type":"Task","Value":"task-16023321"}
I0629 18:49:08.424485 1 vspherevm_controller.go:318] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="VM state is not reconciled" "actual-vm-state"="pending" "expected-vm-state"="ready"
I0629 18:49:08.433761 1 vspherevm_controller.go:249] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="resource is not patched" "local-resource-version"="39580616" "remote-resource-version"="39580616"
I0629 18:49:08.434409 1 vspheremachine_controller.go:521] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-rmf4j "msg"="spec.biosUUID not found" "vmGVK"="infrastructure.cluster.x-k8s.io/v1alpha3, Kind=VSphereVM" "vmName"="demo-ref-1-wftft" "vmNamespace"="demo"
I0629 18:49:08.434436 1 vspheremachine_controller.go:345] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-rmf4j "msg"="provider ID is not reconciled"
I0629 18:49:08.434601 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-cp-v1-rmf4j"}
I0629 18:49:09.147942 1 util.go:255] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="triggering GenericEvent" "reason"="task" "task-description-id"="VirtualMachine.powerOn" "task-entity-name"="demo-ref-1-wftft" "task-name"="PowerOnVM_Task" "task-ref"={"Type":"Task","Value":"task-16023321"} "task-state"="success"
I0629 18:49:09.166367 1 util.go:502] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="the VM is missing the requested IP address" "addressType"="dhcp4"
I0629 18:49:09.433974 1 vspherevm_controller.go:229] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="resource is patched" "local-resource-version"="39580616" "remote-resource-version"="39580625"
I0629 18:49:09.434023 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-wftft"}
I0629 18:49:09.566394 1 util.go:124] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft/task-16023321 "msg"="task found" "description-id"="VirtualMachine.powerOn" "state"="success"
I0629 18:49:09.566418 1 util.go:133] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft/task-16023321 "msg"="task is a success" "description-id"="VirtualMachine.powerOn"
I0629 18:49:09.568752 1 util.go:92] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="vm found by instance uuid" "vmref"={"Type":"VirtualMachine","Value":"vm-632189"}
I0629 18:49:09.586660 1 service.go:255] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="powered on"
I0629 18:49:09.586683 1 vspherevm_controller.go:326] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="vm bios-uuid" "biosuuid"="4217785f-9fcd-c302-d801-d62695c5ef81"
I0629 18:49:09.597715 1 vspheremachine_controller.go:546] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-rmf4j "msg"="updated provider ID" "provider-id"="vsphere://4217785f-9fcd-c302-d801-d62695c5ef81"
I0629 18:49:09.597738 1 vspheremachine_controller.go:503] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-rmf4j "msg"="waiting on IP addresses"
I0629 18:49:09.597748 1 vspheremachine_controller.go:355] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-rmf4j "msg"="network is not reconciled"
I0629 18:49:09.620452 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-cp-v1-rmf4j"}
I0629 18:49:09.620498 1 vspherevm_controller.go:347] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="VSphereVM is ready"
I0629 18:49:09.620905 1 vspheremachine_controller.go:503] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-rmf4j "msg"="waiting on IP addresses"
I0629 18:49:09.620927 1 vspheremachine_controller.go:355] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-rmf4j "msg"="network is not reconciled"
I0629 18:49:09.621083 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-cp-v1-rmf4j"}
I0629 18:49:09.630790 1 vspheremachine_controller.go:503] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-rmf4j "msg"="waiting on IP addresses"
I0629 18:49:09.630814 1 vspheremachine_controller.go:355] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-rmf4j "msg"="network is not reconciled"
I0629 18:49:09.630971 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-cp-v1-rmf4j"}
I0629 18:49:09.639556 1 vspherevm_controller.go:229] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="resource is patched" "local-resource-version"="39580625" "remote-resource-version"="39580639"
I0629 18:49:09.639587 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-wftft"}
I0629 18:49:09.640281 1 vspheremachine_controller.go:503] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-rmf4j "msg"="waiting on IP addresses"
I0629 18:49:09.640305 1 vspheremachine_controller.go:355] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-rmf4j "msg"="network is not reconciled"
I0629 18:49:09.649648 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-cp-v1-rmf4j"}
I0629 18:49:09.650404 1 vspheremachine_controller.go:503] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-rmf4j "msg"="waiting on IP addresses"
I0629 18:49:09.650427 1 vspheremachine_controller.go:355] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-rmf4j "msg"="network is not reconciled"
I0629 18:49:09.650587 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-cp-v1-rmf4j"}
I0629 18:49:09.788690 1 util.go:65] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="vm found by bios uuid" "vmref"={"Type":"VirtualMachine","Value":"vm-632189"}
I0629 18:49:09.802235 1 service.go:255] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="powered on"
I0629 18:49:09.802258 1 vspherevm_controller.go:326] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="vm bios-uuid" "biosuuid"="4217785f-9fcd-c302-d801-d62695c5ef81"
I0629 18:49:09.802429 1 vspherevm_controller.go:347] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="VSphereVM is ready"
I0629 18:49:09.808329 1 vspherevm_controller.go:229] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="resource is patched" "local-resource-version"="39580639" "remote-resource-version"="39580640"
I0629 18:49:09.808361 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-wftft"}
I0629 18:49:09.945435 1 util.go:65] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="vm found by bios uuid" "vmref"={"Type":"VirtualMachine","Value":"vm-632189"}
I0629 18:49:09.958661 1 service.go:255] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="powered on"
I0629 18:49:09.958682 1 vspherevm_controller.go:326] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="vm bios-uuid" "biosuuid"="4217785f-9fcd-c302-d801-d62695c5ef81"
I0629 18:49:09.958875 1 vspherevm_controller.go:347] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="VSphereVM is ready"
I0629 18:49:09.959161 1 vspherevm_controller.go:240] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="resource patch was not required" "local-resource-version"="39580640" "remote-resource-version"="39580640"
I0629 18:49:09.959189 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-wftft"}
I0629 18:49:22.713161 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
E0629 18:49:22.721731 1 haproxyloadbalancer_controller.go:337] capv-controller-manager/haproxyloadbalancer-controller "msg"="Requeing after 10 seconds" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.137:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "vm-name"="demo-ref-1-lb"
E0629 18:49:22.722075 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.137:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "controller"="haproxyloadbalancer" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:49:56.431804 1 util.go:461] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="discovered IP address" "addressType"="dhcp4" "addressValue"="10.27.50.147"
I0629 18:49:56.431870 1 util.go:426] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="ignoring IP address" "reason"="failed to validate ip addr=fe80::250:56ff:fe97:8d97: link-local-unicast"
I0629 18:49:56.431881 1 util.go:531] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="the VM has all of the requested IP addresses"
I0629 18:49:56.431979 1 util.go:289] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="triggering GenericEvent" "ipAddress"="10.27.50.147" "reason"="network"
I0629 18:49:56.574849 1 util.go:65] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="vm found by bios uuid" "vmref"={"Type":"VirtualMachine","Value":"vm-632189"}
I0629 18:49:56.588669 1 service.go:255] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="powered on"
I0629 18:49:56.588693 1 vspherevm_controller.go:326] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="vm bios-uuid" "biosuuid"="4217785f-9fcd-c302-d801-d62695c5ef81"
I0629 18:49:56.588878 1 vspherevm_controller.go:347] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="VSphereVM is ready"
I0629 18:49:56.599757 1 vspherevm_controller.go:249] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="resource is not patched" "local-resource-version"="39580640" "remote-resource-version"="39580640"
I0629 18:49:56.613033 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-cp-v1-rmf4j"}
I0629 18:49:56.613692 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-cp-v1-rmf4j"}
I0629 18:49:56.636190 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-cp-v1-rmf4j"}
I0629 18:49:56.652009 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-cp-v1-rmf4j"}
I0629 18:49:56.752037 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
E0629 18:49:56.759703 1 haproxyloadbalancer_controller.go:337] capv-controller-manager/haproxyloadbalancer-controller "msg"="Requeing after 10 seconds" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.137:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "vm-name"="demo-ref-1-lb"
E0629 18:49:56.760036 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.137:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "controller"="haproxyloadbalancer" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:49:57.600020 1 vspherevm_controller.go:229] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="resource is patched" "local-resource-version"="39580640" "remote-resource-version"="39581006"
I0629 18:49:57.600114 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-wftft"}
I0629 18:49:57.733737 1 util.go:65] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="vm found by bios uuid" "vmref"={"Type":"VirtualMachine","Value":"vm-632189"}
I0629 18:49:57.748860 1 service.go:255] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="powered on"
I0629 18:49:57.748892 1 vspherevm_controller.go:326] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="vm bios-uuid" "biosuuid"="4217785f-9fcd-c302-d801-d62695c5ef81"
I0629 18:49:57.749129 1 vspherevm_controller.go:347] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="VSphereVM is ready"
I0629 18:49:57.749506 1 vspherevm_controller.go:240] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="resource patch was not required" "local-resource-version"="39581006" "remote-resource-version"="39581006"
I0629 18:49:57.749541 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-wftft"}
I0629 18:50:03.682243 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
E0629 18:50:03.690395 1 haproxyloadbalancer_controller.go:337] capv-controller-manager/haproxyloadbalancer-controller "msg"="Requeing after 10 seconds" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.137:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "vm-name"="demo-ref-1-lb"
E0629 18:50:03.690671 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.137:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "controller"="haproxyloadbalancer" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:52:47.530923 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
E0629 18:52:47.539289 1 haproxyloadbalancer_controller.go:337] capv-controller-manager/haproxyloadbalancer-controller "msg"="Requeing after 10 seconds" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.137:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "vm-name"="demo-ref-1-lb"
E0629 18:52:47.539543 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.137:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "controller"="haproxyloadbalancer" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:53:52.164810 1 vspherecluster_controller.go:243] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="Reconciling VSphereCluster"
I0629 18:53:52.164873 1 vspherecluster_controller.go:309] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="skipping load balancer reconciliation" "controlPlaneEndpoint"="10.27.50.137:6443" "reason"="Cluster.Spec.ControlPlaneEndpoint is already set"
I0629 18:53:52.164900 1 vspherecluster_controller.go:453] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="skipping control plane endpoint reconciliation" "controlPlaneEndpoint"="10.27.50.137:6443" "reason"="ControlPlaneEndpoint already set on Cluster"
I0629 18:53:52.164913 1 vspherecluster_controller.go:538] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="skipping reconcile when API server is online" "reason"="alreadyPolling"
I0629 18:53:52.166281 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
I0629 18:53:52.166579 1 haproxyloadbalancer_controller.go:218] capv-controller-manager/haproxyloadbalancer-controller "msg"="Handling deleted HAProxyLoadBalancer" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo"
I0629 18:53:52.167293 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherecluster" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:53:52.167510 1 vspherecluster_controller.go:243] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="Reconciling VSphereCluster"
I0629 18:53:52.167560 1 vspherecluster_controller.go:309] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="skipping load balancer reconciliation" "controlPlaneEndpoint"="10.27.50.137:6443" "reason"="Cluster.Spec.ControlPlaneEndpoint is already set"
I0629 18:53:52.167582 1 vspherecluster_controller.go:453] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="skipping control plane endpoint reconciliation" "controlPlaneEndpoint"="10.27.50.137:6443" "reason"="ControlPlaneEndpoint already set on Cluster"
I0629 18:53:52.167601 1 vspherecluster_controller.go:538] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="skipping reconcile when API server is online" "reason"="alreadyPolling"
I0629 18:53:52.169344 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherecluster" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:53:52.210651 1 haproxyloadbalancer_controller.go:233] capv-controller-manager/haproxyloadbalancer-controller "msg"="Waiting for VSphereVM to be deleted" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo"
I0629 18:53:52.211092 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
I0629 18:53:52.212008 1 haproxyloadbalancer_controller.go:218] capv-controller-manager/haproxyloadbalancer-controller "msg"="Handling deleted HAProxyLoadBalancer" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo"
I0629 18:53:52.212070 1 haproxyloadbalancer_controller.go:233] capv-controller-manager/haproxyloadbalancer-controller "msg"="Waiting for VSphereVM to be deleted" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo"
I0629 18:53:52.222481 1 vspherecluster_controller.go:243] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="Reconciling VSphereCluster"
I0629 18:53:52.222545 1 vspherecluster_controller.go:309] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="skipping load balancer reconciliation" "controlPlaneEndpoint"="10.27.50.137:6443" "reason"="Cluster.Spec.ControlPlaneEndpoint is already set"
I0629 18:53:52.222582 1 vspherecluster_controller.go:453] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="skipping control plane endpoint reconciliation" "controlPlaneEndpoint"="10.27.50.137:6443" "reason"="ControlPlaneEndpoint already set on Cluster"
I0629 18:53:52.222600 1 vspherecluster_controller.go:538] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="skipping reconcile when API server is online" "reason"="alreadyPolling"
I0629 18:53:52.225282 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherecluster" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:53:52.240238 1 vspherecluster_controller.go:202] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="Reconciling VSphereCluster delete"
I0629 18:53:52.255646 1 vspherecluster_controller.go:227] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="Waiting for HAProxyLoadBalancer to be deleted" "count"=1
I0629 18:53:52.255941 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
I0629 18:53:52.256158 1 haproxyloadbalancer_controller.go:218] capv-controller-manager/haproxyloadbalancer-controller "msg"="Handling deleted HAProxyLoadBalancer" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo"
I0629 18:53:52.256198 1 haproxyloadbalancer_controller.go:233] capv-controller-manager/haproxyloadbalancer-controller "msg"="Waiting for VSphereVM to be deleted" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo"
I0629 18:53:52.256255 1 vspherecluster_controller.go:202] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="Reconciling VSphereCluster delete"
I0629 18:53:52.272037 1 vspherecluster_controller.go:227] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="Waiting for HAProxyLoadBalancer to be deleted" "count"=1
I0629 18:53:52.413725 1 vspherevm_controller.go:276] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="Handling deleted VSphereVM"
I0629 18:53:52.416902 1 util.go:65] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="vm found by bios uuid" "vmref"={"Type":"VirtualMachine","Value":"vm-632188"}
I0629 18:53:52.427601 1 service.go:180] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="wait for VM to be powered off"
I0629 18:53:52.429852 1 util.go:210] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="enqueuing reconcile request on task completion" "task-description-id"="VirtualMachine.powerOff" "task-entity-name"="demo-ref-1-lb" "task-name"="PowerOffVM_Task" "task-ref"={"Type":"Task","Value":"task-16023324"}
I0629 18:53:52.429900 1 vspherevm_controller.go:288] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="vm state is not reconciled" "actual-vm-state"="pending" "expected-vm-state"="notfound"
I0629 18:53:52.439525 1 vspherevm_controller.go:249] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="resource is not patched" "local-resource-version"="39582770" "remote-resource-version"="39582770"
I0629 18:53:52.439690 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
I0629 18:53:52.440030 1 haproxyloadbalancer_controller.go:218] capv-controller-manager/haproxyloadbalancer-controller "msg"="Handling deleted HAProxyLoadBalancer" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo"
I0629 18:53:52.440075 1 haproxyloadbalancer_controller.go:233] capv-controller-manager/haproxyloadbalancer-controller "msg"="Waiting for VSphereVM to be deleted" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo"
I0629 18:53:53.009930 1 util.go:255] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="triggering GenericEvent" "reason"="task" "task-description-id"="VirtualMachine.powerOff" "task-entity-name"="demo-ref-1-lb" "task-name"="PowerOffVM_Task" "task-ref"={"Type":"Task","Value":"task-16023324"} "task-state"="success"
I0629 18:53:53.221089 1 vspheremachine_controller.go:314] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-md-v1-qjdlk "msg"="Waiting for bootstrap data to be available"
I0629 18:53:53.221291 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-md-v1-qjdlk"}
I0629 18:53:53.229842 1 vspheremachine_controller.go:314] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-md-v1-dtjcg "msg"="Waiting for bootstrap data to be available"
I0629 18:53:53.230074 1 vspheremachine_controller.go:314] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-md-v1-wzgbg "msg"="Waiting for bootstrap data to be available"
I0629 18:53:53.230104 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-md-v1-dtjcg"}
I0629 18:53:53.230246 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-md-v1-wzgbg"}
I0629 18:53:53.272125 1 vspheremachine_controller.go:231] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-md-v1-qjdlk "msg"="Handling deleted VSphereMachine"
I0629 18:53:53.272727 1 vspheremachine_controller.go:231] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-md-v1-dtjcg "msg"="Handling deleted VSphereMachine"
I0629 18:53:53.278835 1 vspheremachine_controller.go:231] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-md-v1-wzgbg "msg"="Handling deleted VSphereMachine"
I0629 18:53:53.325776 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-md-v1-qjdlk"}
I0629 18:53:53.325859 1 vspheremachine_controller.go:148] capv-controller-manager/vspheremachine-controller "msg"="VSphereMachine not found, won't reconcile" "key"={"Namespace":"demo","Name":"demo-ref-1-md-v1-qjdlk"}
I0629 18:53:53.325880 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-md-v1-qjdlk"}
I0629 18:53:53.329278 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-md-v1-wzgbg"}
I0629 18:53:53.329328 1 vspheremachine_controller.go:148] capv-controller-manager/vspheremachine-controller "msg"="VSphereMachine not found, won't reconcile" "key"={"Namespace":"demo","Name":"demo-ref-1-md-v1-wzgbg"}
I0629 18:53:53.329342 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-md-v1-wzgbg"}
I0629 18:53:53.335951 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-md-v1-dtjcg"}
I0629 18:53:53.336018 1 vspheremachine_controller.go:148] capv-controller-manager/vspheremachine-controller "msg"="VSphereMachine not found, won't reconcile" "key"={"Namespace":"demo","Name":"demo-ref-1-md-v1-dtjcg"}
I0629 18:53:53.336048 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-md-v1-dtjcg"}
I0629 18:53:53.350098 1 vspheremachine_controller.go:148] capv-controller-manager/vspheremachine-controller "msg"="VSphereMachine not found, won't reconcile" "key"={"Namespace":"demo","Name":"demo-ref-1-md-v1-qjdlk"}
I0629 18:53:53.350127 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-md-v1-qjdlk"}
I0629 18:53:53.358004 1 vspheremachine_controller.go:148] capv-controller-manager/vspheremachine-controller "msg"="VSphereMachine not found, won't reconcile" "key"={"Namespace":"demo","Name":"demo-ref-1-md-v1-wzgbg"}
I0629 18:53:53.358043 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-md-v1-wzgbg"}
I0629 18:53:53.359323 1 vspheremachine_controller.go:148] capv-controller-manager/vspheremachine-controller "msg"="VSphereMachine not found, won't reconcile" "key"={"Namespace":"demo","Name":"demo-ref-1-md-v1-dtjcg"}
I0629 18:53:53.359350 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-md-v1-dtjcg"}
I0629 18:53:53.439767 1 vspherevm_controller.go:229] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="resource is patched" "local-resource-version"="39582770" "remote-resource-version"="39582779"
I0629 18:53:53.439836 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-lb"}
I0629 18:53:53.562640 1 vspherevm_controller.go:276] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="Handling deleted VSphereVM"
I0629 18:53:53.564610 1 util.go:124] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb/task-16023324 "msg"="task found" "description-id"="VirtualMachine.powerOff" "state"="success"
I0629 18:53:53.564635 1 util.go:133] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb/task-16023324 "msg"="task is a success" "description-id"="VirtualMachine.powerOff"
I0629 18:53:53.567113 1 util.go:65] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="vm found by bios uuid" "vmref"={"Type":"VirtualMachine","Value":"vm-632188"}
I0629 18:53:53.569328 1 service.go:186] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="destroying vm"
I0629 18:53:53.576216 1 service.go:192] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="wait for VM to be destroyed"
I0629 18:53:53.578113 1 util.go:210] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="enqueuing reconcile request on task completion" "task-description-id"="VirtualMachine.destroy" "task-entity-name"="demo-ref-1-lb" "task-name"="Destroy_Task" "task-ref"={"Type":"Task","Value":"task-16023325"}
I0629 18:53:53.578149 1 vspherevm_controller.go:288] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="vm state is not reconciled" "actual-vm-state"="pending" "expected-vm-state"="notfound"
I0629 18:53:53.589364 1 vspherevm_controller.go:249] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="resource is not patched" "local-resource-version"="39582779" "remote-resource-version"="39582779"
I0629 18:53:53.589390 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
I0629 18:53:53.589632 1 haproxyloadbalancer_controller.go:218] capv-controller-manager/haproxyloadbalancer-controller "msg"="Handling deleted HAProxyLoadBalancer" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo"
I0629 18:53:53.589672 1 haproxyloadbalancer_controller.go:233] capv-controller-manager/haproxyloadbalancer-controller "msg"="Waiting for VSphereVM to be deleted" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo"
I0629 18:53:53.986883 1 util.go:255] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="triggering GenericEvent" "reason"="task" "task-description-id"="VirtualMachine.destroy" "task-entity-name"="demo-ref-1-lb" "task-name"="Destroy_Task" "task-ref"={"Type":"Task","Value":"task-16023325"} "task-state"="success"
I0629 18:53:54.589706 1 vspherevm_controller.go:229] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="resource is patched" "local-resource-version"="39582779" "remote-resource-version"="39582811"
I0629 18:53:54.589800 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-lb"}
E0629 18:53:54.604500 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="failed to create vSphere session: error setting up new vSphere SOAP client: Post https://vcenter1.sce-dcn.net/sdk: dial tcp: lookup vcenter1.sce-dcn.net on 10.96.0.10:53: no such host" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-lb"}
I0629 18:53:54.744379 1 vspherevm_controller.go:276] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="Handling deleted VSphereVM"
I0629 18:53:54.746397 1 util.go:124] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb/task-16023325 "msg"="task found" "description-id"="VirtualMachine.destroy" "state"="success"
I0629 18:53:54.746422 1 util.go:133] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb/task-16023325 "msg"="task is a success" "description-id"="VirtualMachine.destroy"
I0629 18:53:54.749073 1 util.go:62] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="vm not found by bios uuid" "biosuuid"="42177a99-891d-d1da-0376-4587547699ce"
I0629 18:53:54.765005 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
I0629 18:53:54.765246 1 haproxyloadbalancer_controller.go:218] capv-controller-manager/haproxyloadbalancer-controller "msg"="Handling deleted HAProxyLoadBalancer" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo"
E0629 18:53:54.772670 1 vspherevm_controller.go:184] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="patch failed" "error"="vspherevms.infrastructure.cluster.x-k8s.io \"demo-ref-1-lb\" not found" "vm"="infrastructure.cluster.x-k8s.io/v1alpha3, Kind=VSphereVM demo/demo-ref-1-lb"
E0629 18:53:54.772733 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="vspherevms.infrastructure.cluster.x-k8s.io \"demo-ref-1-lb\" not found" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-lb"}
I0629 18:53:54.772806 1 vspherevm_controller.go:132] capv-controller-manager/vspherevm-controller "msg"="VSphereVM not found, won't reconcile" "key"={"Namespace":"demo","Name":"demo-ref-1-lb"}
I0629 18:53:54.772825 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-lb"}
I0629 18:53:54.782930 1 vspherevm_controller.go:132] capv-controller-manager/vspherevm-controller "msg"="VSphereVM not found, won't reconcile" "key"={"Namespace":"demo","Name":"demo-ref-1-lb"}
I0629 18:53:54.782978 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-lb"}
E0629 18:53:54.821166 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="VSphereVM.infrastructure.cluster.x-k8s.io \"demo-ref-1-lb\" not found" "controller"="haproxyloadbalancer" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:53:54.821531 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
E0629 18:53:54.821574 1 haproxyloadbalancer_controller.go:162] capv-controller-manager/haproxyloadbalancer-controller "msg"="Won't reconcile" "error"="HAProxyLoadBalancer.infrastructure.cluster.x-k8s.io \"demo-ref-1\" not found" "name"="demo-ref-1" "namespace"="demo"
I0629 18:53:54.821590 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="haproxyloadbalancer" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:53:54.821680 1 vspherecluster_controller.go:202] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="Reconciling VSphereCluster delete"
I0629 18:53:54.821753 1 vspherecluster_controller.go:232] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="Waiting for VSphereMachines to be deleted" "count"=1
I0629 18:53:54.826294 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
E0629 18:53:54.826324 1 haproxyloadbalancer_controller.go:162] capv-controller-manager/haproxyloadbalancer-controller "msg"="Won't reconcile" "error"="HAProxyLoadBalancer.infrastructure.cluster.x-k8s.io \"demo-ref-1\" not found" "name"="demo-ref-1" "namespace"="demo"
I0629 18:53:54.826340 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="haproxyloadbalancer" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:53:57.266231 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
E0629 18:53:57.266330 1 haproxyloadbalancer_controller.go:162] capv-controller-manager/haproxyloadbalancer-controller "msg"="Won't reconcile" "error"="HAProxyLoadBalancer.infrastructure.cluster.x-k8s.io \"demo-ref-1\" not found" "name"="demo-ref-1" "namespace"="demo"
I0629 18:53:57.266358 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="haproxyloadbalancer" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:53:57.266419 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
E0629 18:53:57.266450 1 haproxyloadbalancer_controller.go:162] capv-controller-manager/haproxyloadbalancer-controller "msg"="Won't reconcile" "error"="HAProxyLoadBalancer.infrastructure.cluster.x-k8s.io \"demo-ref-1\" not found" "name"="demo-ref-1" "namespace"="demo"
I0629 18:53:57.266465 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="haproxyloadbalancer" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:53:57.266920 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-cp-v1-rmf4j"}
I0629 18:53:57.284717 1 vspheremachine_controller.go:231] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-rmf4j "msg"="Handling deleted VSphereMachine"
I0629 18:53:57.309650 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
E0629 18:53:57.309704 1 haproxyloadbalancer_controller.go:162] capv-controller-manager/haproxyloadbalancer-controller "msg"="Won't reconcile" "error"="HAProxyLoadBalancer.infrastructure.cluster.x-k8s.io \"demo-ref-1\" not found" "name"="demo-ref-1" "namespace"="demo"
I0629 18:53:57.309728 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="haproxyloadbalancer" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:53:57.309971 1 vspheremachine_controller.go:241] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-rmf4j "msg"="Waiting for VSphereVM to be deleted"
I0629 18:53:57.310482 1 vspheremachine_controller.go:231] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-rmf4j "msg"="Handling deleted VSphereMachine"
I0629 18:53:57.310524 1 vspheremachine_controller.go:241] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-rmf4j "msg"="Waiting for VSphereVM to be deleted"
E0629 18:53:57.328499 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="failed to create vSphere session: error setting up new vSphere SOAP client: Post https://vcenter1.sce-dcn.net/sdk: dial tcp: lookup vcenter1.sce-dcn.net on 10.96.0.10:53: no such host" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-wftft"}
E0629 18:53:57.339169 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="failed to create vSphere session: error setting up new vSphere SOAP client: Post https://vcenter1.sce-dcn.net/sdk: dial tcp: lookup vcenter1.sce-dcn.net on 10.96.0.10:53: no such host" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-wftft"}
E0629 18:53:57.354784 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="failed to create vSphere session: error setting up new vSphere SOAP client: Post https://vcenter1.sce-dcn.net/sdk: dial tcp: lookup vcenter1.sce-dcn.net on 10.96.0.10:53: no such host" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-wftft"}
E0629 18:53:57.379711 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="failed to create vSphere session: error setting up new vSphere SOAP client: Post https://vcenter1.sce-dcn.net/sdk: dial tcp: lookup vcenter1.sce-dcn.net on 10.96.0.10:53: no such host" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-wftft"}
E0629 18:53:57.424887 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="failed to create vSphere session: error setting up new vSphere SOAP client: Post https://vcenter1.sce-dcn.net/sdk: dial tcp: lookup vcenter1.sce-dcn.net on 10.96.0.10:53: no such host" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-wftft"}
E0629 18:53:57.509824 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="failed to create vSphere session: error setting up new vSphere SOAP client: Post https://vcenter1.sce-dcn.net/sdk: dial tcp: lookup vcenter1.sce-dcn.net on 10.96.0.10:53: no such host" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-wftft"}
E0629 18:53:57.674546 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="failed to create vSphere session: error setting up new vSphere SOAP client: Post https://vcenter1.sce-dcn.net/sdk: dial tcp: lookup vcenter1.sce-dcn.net on 10.96.0.10:53: no such host" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-wftft"}
E0629 18:53:57.999685 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="failed to create vSphere session: error setting up new vSphere SOAP client: Post https://vcenter1.sce-dcn.net/sdk: dial tcp: lookup vcenter1.sce-dcn.net on 10.96.0.10:53: no such host" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-wftft"}
E0629 18:53:58.644462 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="failed to create vSphere session: error setting up new vSphere SOAP client: Post https://vcenter1.sce-dcn.net/sdk: dial tcp: lookup vcenter1.sce-dcn.net on 10.96.0.10:53: no such host" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-wftft"}
E0629 18:53:59.930364 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="failed to create vSphere session: error setting up new vSphere SOAP client: Post https://vcenter1.sce-dcn.net/sdk: dial tcp: lookup vcenter1.sce-dcn.net on 10.96.0.10:53: no such host" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-wftft"}
I0629 18:54:02.256636 1 vspherecluster_controller.go:202] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="Reconciling VSphereCluster delete"
I0629 18:54:02.256814 1 vspherecluster_controller.go:232] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="Waiting for VSphereMachines to be deleted" "count"=1
E0629 18:54:02.495624 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="failed to create vSphere session: error setting up new vSphere SOAP client: Post https://vcenter1.sce-dcn.net/sdk: dial tcp: lookup vcenter1.sce-dcn.net on 10.96.0.10:53: no such host" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-wftft"}
I0629 18:54:07.310922 1 vspheremachine_controller.go:231] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-rmf4j "msg"="Handling deleted VSphereMachine"
I0629 18:54:07.310984 1 vspheremachine_controller.go:241] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-rmf4j "msg"="Waiting for VSphereVM to be deleted"
E0629 18:54:07.620975 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="failed to create vSphere session: error setting up new vSphere SOAP client: Post https://vcenter1.sce-dcn.net/sdk: dial tcp: lookup vcenter1.sce-dcn.net on 10.96.0.10:53: no such host" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-wftft"}
I0629 18:54:12.257993 1 vspherecluster_controller.go:202] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="Reconciling VSphereCluster delete"
I0629 18:54:12.258151 1 vspherecluster_controller.go:232] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="Waiting for VSphereMachines to be deleted" "count"=1
I0629 18:54:17.311909 1 vspheremachine_controller.go:231] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-rmf4j "msg"="Handling deleted VSphereMachine"
I0629 18:54:17.311966 1 vspheremachine_controller.go:241] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-rmf4j "msg"="Waiting for VSphereVM to be deleted"
E0629 18:54:17.865710 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="failed to create vSphere session: error setting up new vSphere SOAP client: Post https://vcenter1.sce-dcn.net/sdk: dial tcp: lookup vcenter1.sce-dcn.net on 10.96.0.10:53: no such host" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-wftft"}
I0629 18:54:22.259049 1 vspherecluster_controller.go:202] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="Reconciling VSphereCluster delete"
I0629 18:54:22.259143 1 vspherecluster_controller.go:232] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="Waiting for VSphereMachines to be deleted" "count"=1
I0629 18:54:27.312758 1 vspheremachine_controller.go:231] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-rmf4j "msg"="Handling deleted VSphereMachine"
I0629 18:54:27.312811 1 vspheremachine_controller.go:241] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-rmf4j "msg"="Waiting for VSphereVM to be deleted"
I0629 18:54:32.260144 1 vspherecluster_controller.go:202] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="Reconciling VSphereCluster delete"
I0629 18:54:32.260264 1 vspherecluster_controller.go:232] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="Waiting for VSphereMachines to be deleted" "count"=1
I0629 18:54:37.313793 1 vspheremachine_controller.go:231] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-rmf4j "msg"="Handling deleted VSphereMachine"
I0629 18:54:37.313850 1 vspheremachine_controller.go:241] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-rmf4j "msg"="Waiting for VSphereVM to be deleted"
I0629 18:54:38.475130 1 vspherevm_controller.go:276] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="Handling deleted VSphereVM"
I0629 18:54:38.478461 1 util.go:65] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="vm found by bios uuid" "vmref"={"Type":"VirtualMachine","Value":"vm-632189"}
I0629 18:54:38.488535 1 service.go:180] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="wait for VM to be powered off"
I0629 18:54:38.496921 1 util.go:210] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="enqueuing reconcile request on task completion" "task-description-id"="VirtualMachine.powerOff" "task-entity-name"="demo-ref-1-wftft" "task-name"="PowerOffVM_Task" "task-ref"={"Type":"Task","Value":"task-16023327"}
I0629 18:54:38.496964 1 vspherevm_controller.go:288] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="vm state is not reconciled" "actual-vm-state"="pending" "expected-vm-state"="notfound"
I0629 18:54:38.506956 1 vspherevm_controller.go:249] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="resource is not patched" "local-resource-version"="39582847" "remote-resource-version"="39582847"
I0629 18:54:38.507393 1 vspheremachine_controller.go:231] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-rmf4j "msg"="Handling deleted VSphereMachine"
I0629 18:54:38.507427 1 vspheremachine_controller.go:241] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-rmf4j "msg"="Waiting for VSphereVM to be deleted"
I0629 18:54:39.257250 1 util.go:255] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="triggering GenericEvent" "reason"="task" "task-description-id"="VirtualMachine.powerOff" "task-entity-name"="demo-ref-1-wftft" "task-name"="PowerOffVM_Task" "task-ref"={"Type":"Task","Value":"task-16023327"} "task-state"="success"
I0629 18:54:39.507257 1 vspherevm_controller.go:229] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="resource is patched" "local-resource-version"="39582847" "remote-resource-version"="39583159"
I0629 18:54:39.507364 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-wftft"}
I0629 18:54:39.637864 1 vspherevm_controller.go:276] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="Handling deleted VSphereVM"
I0629 18:54:39.640236 1 util.go:124] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft/task-16023327 "msg"="task found" "description-id"="VirtualMachine.powerOff" "state"="success"
I0629 18:54:39.640264 1 util.go:133] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft/task-16023327 "msg"="task is a success" "description-id"="VirtualMachine.powerOff"
I0629 18:54:39.643384 1 util.go:65] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="vm found by bios uuid" "vmref"={"Type":"VirtualMachine","Value":"vm-632189"}
I0629 18:54:39.645531 1 service.go:186] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="destroying vm"
I0629 18:54:39.653288 1 service.go:192] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="wait for VM to be destroyed"
I0629 18:54:39.655561 1 util.go:210] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="enqueuing reconcile request on task completion" "task-description-id"="VirtualMachine.destroy" "task-entity-name"="demo-ref-1-wftft" "task-name"="Destroy_Task" "task-ref"={"Type":"Task","Value":"task-16023328"}
I0629 18:54:39.655608 1 vspherevm_controller.go:288] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="vm state is not reconciled" "actual-vm-state"="pending" "expected-vm-state"="notfound"
I0629 18:54:39.666059 1 vspherevm_controller.go:229] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="resource is patched" "local-resource-version"="39583159" "remote-resource-version"="39583168"
I0629 18:54:39.666109 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-wftft"}
I0629 18:54:39.666359 1 vspheremachine_controller.go:231] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-rmf4j "msg"="Handling deleted VSphereMachine"
I0629 18:54:39.666405 1 vspheremachine_controller.go:241] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-rmf4j "msg"="Waiting for VSphereVM to be deleted"
I0629 18:54:39.818156 1 vspherevm_controller.go:276] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="Handling deleted VSphereVM"
I0629 18:54:39.820212 1 util.go:124] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft/task-16023328 "msg"="task found" "description-id"="VirtualMachine.destroy" "state"="running"
I0629 18:54:39.820240 1 util.go:130] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft/task-16023328 "msg"="task is still running" "description-id"="VirtualMachine.destroy"
I0629 18:54:39.820254 1 vspherevm_controller.go:288] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="vm state is not reconciled" "actual-vm-state"="pending" "expected-vm-state"="notfound"
I0629 18:54:39.820757 1 vspherevm_controller.go:240] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="resource patch was not required" "local-resource-version"="39583168" "remote-resource-version"="39583168"
I0629 18:54:39.820802 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-wftft"}
I0629 18:54:39.994232 1 util.go:255] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="triggering GenericEvent" "reason"="task" "task-description-id"="VirtualMachine.destroy" "task-entity-name"="demo-ref-1-wftft" "task-name"="Destroy_Task" "task-ref"={"Type":"Task","Value":"task-16023328"} "task-state"="success"
I0629 18:54:40.119209 1 vspherevm_controller.go:276] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="Handling deleted VSphereVM"
I0629 18:54:40.121287 1 util.go:124] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft/task-16023328 "msg"="task found" "description-id"="VirtualMachine.destroy" "state"="success"
I0629 18:54:40.121310 1 util.go:133] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft/task-16023328 "msg"="task is a success" "description-id"="VirtualMachine.destroy"
I0629 18:54:40.123746 1 util.go:62] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="vm not found by bios uuid" "biosuuid"="4217785f-9fcd-c302-d801-d62695c5ef81"
I0629 18:54:40.136831 1 vspheremachine_controller.go:231] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-rmf4j "msg"="Handling deleted VSphereMachine"
E0629 18:54:40.138808 1 vspherevm_controller.go:184] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-wftft "msg"="patch failed" "error"="vspherevms.infrastructure.cluster.x-k8s.io \"demo-ref-1-wftft\" not found" "vm"="infrastructure.cluster.x-k8s.io/v1alpha3, Kind=VSphereVM demo/demo-ref-1-wftft"
E0629 18:54:40.138869 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="vspherevms.infrastructure.cluster.x-k8s.io \"demo-ref-1-wftft\" not found" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-wftft"}
I0629 18:54:40.138924 1 vspherevm_controller.go:132] capv-controller-manager/vspherevm-controller "msg"="VSphereVM not found, won't reconcile" "key"={"Namespace":"demo","Name":"demo-ref-1-wftft"}
I0629 18:54:40.138947 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-wftft"}
I0629 18:54:40.143991 1 vspherevm_controller.go:132] capv-controller-manager/vspherevm-controller "msg"="VSphereVM not found, won't reconcile" "key"={"Namespace":"demo","Name":"demo-ref-1-wftft"}
I0629 18:54:40.144020 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-wftft"}
I0629 18:54:40.149145 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-cp-v1-rmf4j"}
I0629 18:54:40.149237 1 vspheremachine_controller.go:148] capv-controller-manager/vspheremachine-controller "msg"="VSphereMachine not found, won't reconcile" "key"={"Namespace":"demo","Name":"demo-ref-1-cp-v1-rmf4j"}
I0629 18:54:40.149262 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-cp-v1-rmf4j"}
I0629 18:54:40.166547 1 vspheremachine_controller.go:148] capv-controller-manager/vspheremachine-controller "msg"="VSphereMachine not found, won't reconcile" "key"={"Namespace":"demo","Name":"demo-ref-1-cp-v1-rmf4j"}
I0629 18:54:40.166579 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-cp-v1-rmf4j"}
I0629 18:54:40.166736 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
E0629 18:54:40.166773 1 haproxyloadbalancer_controller.go:162] capv-controller-manager/haproxyloadbalancer-controller "msg"="Won't reconcile" "error"="HAProxyLoadBalancer.infrastructure.cluster.x-k8s.io \"demo-ref-1\" not found" "name"="demo-ref-1" "namespace"="demo"
I0629 18:54:40.166797 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="haproxyloadbalancer" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:54:42.261345 1 vspherecluster_controller.go:202] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="Reconciling VSphereCluster delete"
I0629 18:54:42.276206 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherecluster" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:54:42.276279 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherecluster" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:54:42.293358 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherecluster" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:54:47.314370 1 vspheremachine_controller.go:148] capv-controller-manager/vspheremachine-controller "msg"="VSphereMachine not found, won't reconcile" "key"={"Namespace":"demo","Name":"demo-ref-1-cp-v1-rmf4j"}
I0629 18:54:47.314423 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-cp-v1-rmf4j"}
I0629 18:56:50.314177 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherecluster" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:56:50.337913 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherecluster" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:56:50.337933 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
I0629 18:56:50.338178 1 haproxyloadbalancer_controller.go:287] capv-controller-manager/haproxyloadbalancer-controller "msg"="Generating certificates" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo"
I0629 18:56:50.361868 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherecluster" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:56:50.460124 1 vspherecluster_controller.go:152] capv-controller-manager/vspherecluster-controller "msg"="Waiting for Cluster Controller to set OwnerRef on VSphereCluster"
I0629 18:56:50.460161 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherecluster" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:56:50.546574 1 haproxyloadbalancer_controller.go:311] capv-controller-manager/haproxyloadbalancer-controller "msg"="HAProxy LoadBalancer not ready, reconciling network" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "vm-name"="demo-ref-1-lb"
I0629 18:56:50.546624 1 haproxyloadbalancer_controller.go:605] capv-controller-manager/haproxyloadbalancer-controller "msg"="waiting on vm for ip address" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "old-ip-address"="" "vm-api-version"="" "vm-kind"="" "vm-name"="demo-ref-1-lb"
I0629 18:56:50.546646 1 haproxyloadbalancer_controller.go:318] capv-controller-manager/haproxyloadbalancer-controller "msg"="Network is not reconciled, requeing in 10 seconds" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "old-ip-address"="" "vm-api-version"="" "vm-kind"="" "vm-name"="demo-ref-1-lb"
E0629 18:56:50.561076 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="failed to create vSphere session: error setting up new vSphere SOAP client: Post https://vcenter1.sce-dcn.net/sdk: dial tcp: lookup vcenter1.sce-dcn.net on 10.96.0.10:53: no such host" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-lb"}
I0629 18:56:50.574613 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
I0629 18:56:50.574760 1 haproxyloadbalancer_controller.go:287] capv-controller-manager/haproxyloadbalancer-controller "msg"="Generating certificates" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo"
E0629 18:56:50.578925 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="failed to create vSphere session: error setting up new vSphere SOAP client: Post https://vcenter1.sce-dcn.net/sdk: dial tcp: lookup vcenter1.sce-dcn.net on 10.96.0.10:53: no such host" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-lb"}
I0629 18:56:50.595946 1 vspheremachine_controller.go:160] capv-controller-manager/vspheremachine-controller "msg"="Waiting for Machine Controller to set OwnerRef on VSphereMachine"
I0629 18:56:50.595973 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-md-v1-75gj8"}
I0629 18:56:50.611047 1 vspheremachine_controller.go:160] capv-controller-manager/vspheremachine-controller "msg"="Waiting for Machine Controller to set OwnerRef on VSphereMachine"
I0629 18:56:50.611072 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-md-v1-75gj8"}
I0629 18:56:50.687284 1 vspheremachine_controller.go:160] capv-controller-manager/vspheremachine-controller "msg"="Waiting for Machine Controller to set OwnerRef on VSphereMachine"
I0629 18:56:50.687321 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-md-v1-6bfmf"}
I0629 18:56:50.690607 1 vspheremachine_controller.go:308] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-md-v1-75gj8 "msg"="Cluster infrastructure is not ready yet"
I0629 18:56:50.713801 1 vspheremachine_controller.go:160] capv-controller-manager/vspheremachine-controller "msg"="Waiting for Machine Controller to set OwnerRef on VSphereMachine"
I0629 18:56:50.713832 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-md-v1-6bfmf"}
I0629 18:56:50.724702 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-md-v1-75gj8"}
I0629 18:56:50.724887 1 vspheremachine_controller.go:308] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-md-v1-75gj8 "msg"="Cluster infrastructure is not ready yet"
I0629 18:56:50.725034 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-md-v1-75gj8"}
I0629 18:56:50.725752 1 vspheremachine_controller.go:308] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-md-v1-75gj8 "msg"="Cluster infrastructure is not ready yet"
I0629 18:56:50.725903 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-md-v1-75gj8"}
I0629 18:56:50.727149 1 util.go:81] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="using inventory path to find vm" "path"="/Bremen/vm/TDCN/DCI_SCHIFF/demo-ref-1-lb"
I0629 18:56:50.735525 1 haproxyloadbalancer_controller.go:311] capv-controller-manager/haproxyloadbalancer-controller "msg"="HAProxy LoadBalancer not ready, reconciling network" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "vm-name"="demo-ref-1-lb"
I0629 18:56:50.735569 1 haproxyloadbalancer_controller.go:605] capv-controller-manager/haproxyloadbalancer-controller "msg"="waiting on vm for ip address" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "old-ip-address"="" "vm-api-version"="infrastructure.cluster.x-k8s.io/v1alpha3" "vm-kind"="VSphereVM" "vm-name"="demo-ref-1-lb"
I0629 18:56:50.735594 1 haproxyloadbalancer_controller.go:318] capv-controller-manager/haproxyloadbalancer-controller "msg"="Network is not reconciled, requeing in 10 seconds" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "old-ip-address"="" "vm-api-version"="infrastructure.cluster.x-k8s.io/v1alpha3" "vm-kind"="VSphereVM" "vm-name"="demo-ref-1-lb"
I0629 18:56:50.743149 1 clone.go:46] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb/vcenter "msg"="starting clone process"
I0629 18:56:50.743177 1 clone.go:50] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb/vcenter "msg"="applied bootstrap data to VM clone spec"
I0629 18:56:50.745341 1 vspherecluster_controller.go:152] capv-controller-manager/vspherecluster-controller "msg"="Waiting for Cluster Controller to set OwnerRef on VSphereCluster"
I0629 18:56:50.745372 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherecluster" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:56:50.755067 1 vspheremachine_controller.go:308] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-md-v1-75gj8 "msg"="Cluster infrastructure is not ready yet"
I0629 18:56:50.757096 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-md-v1-75gj8"}
I0629 18:56:50.775364 1 vspheremachine_controller.go:160] capv-controller-manager/vspheremachine-controller "msg"="Waiting for Machine Controller to set OwnerRef on VSphereMachine"
I0629 18:56:50.775398 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-md-v1-xg2fq"}
I0629 18:56:50.786696 1 vspherecluster_controller.go:243] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="Reconciling VSphereCluster"
I0629 18:56:50.787931 1 vspheremachine_controller.go:308] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-md-v1-6bfmf "msg"="Cluster infrastructure is not ready yet"
I0629 18:56:50.797351 1 vspheremachine_controller.go:160] capv-controller-manager/vspheremachine-controller "msg"="Waiting for Machine Controller to set OwnerRef on VSphereMachine"
I0629 18:56:50.797379 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-md-v1-xg2fq"}
I0629 18:56:50.815633 1 vspherecluster_controller.go:372] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="the load balancer is now owned by the cluster" "load-balancer-gvk"="infrastructure.cluster.x-k8s.io/v1alpha3, Kind=HAProxyLoadBalancer" "load-balancer-name"="demo-ref-1" "load-balancer-namespace"="demo" "vspherecluster-gvk"="infrastructure.cluster.x-k8s.io/v1alpha3, Kind=VSphereCluster" "vspherecluster-name"="demo-ref-1" "vspherecluster-namespace"="demo"
I0629 18:56:50.815672 1 vspherecluster_controller.go:390] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="status.ready not found for load balancer" "load-balancer-gvk"="infrastructure.cluster.x-k8s.io/v1alpha3, Kind=HAProxyLoadBalancer" "load-balancer-name"="demo-ref-1" "load-balancer-namespace"="demo"
I0629 18:56:50.815682 1 vspherecluster_controller.go:254] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="load balancer is not reconciled"
I0629 18:56:50.816912 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-md-v1-6bfmf"}
I0629 18:56:50.817100 1 vspheremachine_controller.go:308] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-md-v1-6bfmf "msg"="Cluster infrastructure is not ready yet"
I0629 18:56:50.817283 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-md-v1-6bfmf"}
I0629 18:56:50.817412 1 vspheremachine_controller.go:308] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-md-v1-6bfmf "msg"="Cluster infrastructure is not ready yet"
I0629 18:56:50.817542 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-md-v1-6bfmf"}
I0629 18:56:50.818557 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
I0629 18:56:50.818847 1 haproxyloadbalancer_controller.go:287] capv-controller-manager/haproxyloadbalancer-controller "msg"="Generating certificates" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo"
I0629 18:56:50.848242 1 vspherecluster_controller.go:243] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="Reconciling VSphereCluster"
I0629 18:56:50.848320 1 vspherecluster_controller.go:390] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="status.ready not found for load balancer" "load-balancer-gvk"="infrastructure.cluster.x-k8s.io/v1alpha3, Kind=HAProxyLoadBalancer" "load-balancer-name"="demo-ref-1" "load-balancer-namespace"="demo"
I0629 18:56:50.848334 1 vspherecluster_controller.go:254] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="load balancer is not reconciled"
I0629 18:56:50.849546 1 vspheremachine_controller.go:308] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-md-v1-6bfmf "msg"="Cluster infrastructure is not ready yet"
I0629 18:56:50.849729 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-md-v1-6bfmf"}
I0629 18:56:50.872745 1 vspheremachine_controller.go:308] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-md-v1-xg2fq "msg"="Cluster infrastructure is not ready yet"
I0629 18:56:50.896991 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-md-v1-xg2fq"}
I0629 18:56:50.897194 1 vspheremachine_controller.go:308] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-md-v1-xg2fq "msg"="Cluster infrastructure is not ready yet"
I0629 18:56:50.897428 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-md-v1-xg2fq"}
I0629 18:56:50.897750 1 vspheremachine_controller.go:308] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-md-v1-xg2fq "msg"="Cluster infrastructure is not ready yet"
I0629 18:56:50.897907 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-md-v1-xg2fq"}
I0629 18:56:50.923792 1 vspheremachine_controller.go:308] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-md-v1-xg2fq "msg"="Cluster infrastructure is not ready yet"
I0629 18:56:50.924004 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-md-v1-xg2fq"}
I0629 18:56:50.935930 1 vspherecluster_controller.go:243] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="Reconciling VSphereCluster"
I0629 18:56:50.936037 1 vspherecluster_controller.go:390] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="status.ready not found for load balancer" "load-balancer-gvk"="infrastructure.cluster.x-k8s.io/v1alpha3, Kind=HAProxyLoadBalancer" "load-balancer-name"="demo-ref-1" "load-balancer-namespace"="demo"
I0629 18:56:50.936057 1 vspherecluster_controller.go:254] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="load balancer is not reconciled"
I0629 18:56:51.038516 1 vspherecluster_controller.go:243] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="Reconciling VSphereCluster"
I0629 18:56:51.038607 1 vspherecluster_controller.go:390] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="status.ready not found for load balancer" "load-balancer-gvk"="infrastructure.cluster.x-k8s.io/v1alpha3, Kind=HAProxyLoadBalancer" "load-balancer-name"="demo-ref-1" "load-balancer-namespace"="demo"
I0629 18:56:51.038624 1 vspherecluster_controller.go:254] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="load balancer is not reconciled"
I0629 18:56:51.278415 1 haproxyloadbalancer_controller.go:311] capv-controller-manager/haproxyloadbalancer-controller "msg"="HAProxy LoadBalancer not ready, reconciling network" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "vm-name"="demo-ref-1-lb"
I0629 18:56:51.278462 1 haproxyloadbalancer_controller.go:605] capv-controller-manager/haproxyloadbalancer-controller "msg"="waiting on vm for ip address" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "old-ip-address"="" "vm-api-version"="infrastructure.cluster.x-k8s.io/v1alpha3" "vm-kind"="VSphereVM" "vm-name"="demo-ref-1-lb"
I0629 18:56:51.278482 1 haproxyloadbalancer_controller.go:318] capv-controller-manager/haproxyloadbalancer-controller "msg"="Network is not reconciled, requeing in 10 seconds" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "old-ip-address"="" "vm-api-version"="infrastructure.cluster.x-k8s.io/v1alpha3" "vm-kind"="VSphereVM" "vm-name"="demo-ref-1-lb"
I0629 18:56:51.278685 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
I0629 18:56:51.278834 1 haproxyloadbalancer_controller.go:287] capv-controller-manager/haproxyloadbalancer-controller "msg"="Generating certificates" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo"
I0629 18:56:51.473371 1 clone.go:177] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb/vcenter "msg"="cloning machine" "cloneType"="fullClone" "name"="demo-ref-1-lb" "namespace"="demo"
I0629 18:56:51.483908 1 util.go:210] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="enqueuing reconcile request on task completion" "task-description-id"="VirtualMachine.clone" "task-entity-name"="capv-haproxy-v0.6.3" "task-name"="CloneVM_Task" "task-ref"={"Type":"Task","Value":"task-16023330"}
I0629 18:56:51.483957 1 vspherevm_controller.go:318] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="VM state is not reconciled" "actual-vm-state"="pending" "expected-vm-state"="ready"
I0629 18:56:51.500833 1 vspherevm_controller.go:229] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="resource is patched" "local-resource-version"="39584170" "remote-resource-version"="39584251"
I0629 18:56:51.500869 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-lb"}
E0629 18:56:51.505969 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="failed to create vSphere session: error setting up new vSphere SOAP client: Post https://vcenter1.sce-dcn.net/sdk: dial tcp: lookup vcenter1.sce-dcn.net on 10.96.0.10:53: no such host" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-lb"}
E0629 18:56:51.517927 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="failed to create vSphere session: error setting up new vSphere SOAP client: Post https://vcenter1.sce-dcn.net/sdk: dial tcp: lookup vcenter1.sce-dcn.net on 10.96.0.10:53: no such host" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-lb"}
E0629 18:56:51.522436 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="failed to create vSphere session: error setting up new vSphere SOAP client: Post https://vcenter1.sce-dcn.net/sdk: dial tcp: lookup vcenter1.sce-dcn.net on 10.96.0.10:53: no such host" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-lb"}
E0629 18:56:51.531404 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="failed to create vSphere session: error setting up new vSphere SOAP client: Post https://vcenter1.sce-dcn.net/sdk: dial tcp: lookup vcenter1.sce-dcn.net on 10.96.0.10:53: no such host" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-lb"}
I0629 18:56:51.577052 1 haproxyloadbalancer_controller.go:311] capv-controller-manager/haproxyloadbalancer-controller "msg"="HAProxy LoadBalancer not ready, reconciling network" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "vm-name"="demo-ref-1-lb"
I0629 18:56:51.577094 1 haproxyloadbalancer_controller.go:605] capv-controller-manager/haproxyloadbalancer-controller "msg"="waiting on vm for ip address" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "old-ip-address"="" "vm-api-version"="infrastructure.cluster.x-k8s.io/v1alpha3" "vm-kind"="VSphereVM" "vm-name"="demo-ref-1-lb"
I0629 18:56:51.577114 1 haproxyloadbalancer_controller.go:318] capv-controller-manager/haproxyloadbalancer-controller "msg"="Network is not reconciled, requeing in 10 seconds" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "old-ip-address"="" "vm-api-version"="infrastructure.cluster.x-k8s.io/v1alpha3" "vm-kind"="VSphereVM" "vm-name"="demo-ref-1-lb"
I0629 18:56:51.577382 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
I0629 18:56:51.577553 1 haproxyloadbalancer_controller.go:287] capv-controller-manager/haproxyloadbalancer-controller "msg"="Generating certificates" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo"
I0629 18:56:51.697164 1 haproxyloadbalancer_controller.go:311] capv-controller-manager/haproxyloadbalancer-controller "msg"="HAProxy LoadBalancer not ready, reconciling network" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "vm-name"="demo-ref-1-lb"
I0629 18:56:51.697290 1 haproxyloadbalancer_controller.go:605] capv-controller-manager/haproxyloadbalancer-controller "msg"="waiting on vm for ip address" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "old-ip-address"="" "vm-api-version"="infrastructure.cluster.x-k8s.io/v1alpha3" "vm-kind"="VSphereVM" "vm-name"="demo-ref-1-lb"
I0629 18:56:51.697369 1 haproxyloadbalancer_controller.go:318] capv-controller-manager/haproxyloadbalancer-controller "msg"="Network is not reconciled, requeing in 10 seconds" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "old-ip-address"="" "vm-api-version"="infrastructure.cluster.x-k8s.io/v1alpha3" "vm-kind"="VSphereVM" "vm-name"="demo-ref-1-lb"
I0629 18:56:51.698612 1 util.go:124] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb/task-16023330 "msg"="task found" "description-id"="VirtualMachine.clone" "state"="running"
I0629 18:56:51.698635 1 util.go:130] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb/task-16023330 "msg"="task is still running" "description-id"="VirtualMachine.clone"
I0629 18:56:51.698648 1 vspherevm_controller.go:318] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="VM state is not reconciled" "actual-vm-state"="pending" "expected-vm-state"="ready"
I0629 18:56:51.698909 1 vspherevm_controller.go:240] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="resource patch was not required" "local-resource-version"="39584252" "remote-resource-version"="39584252"
I0629 18:56:51.698935 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-lb"}
I0629 18:56:57.871363 1 util.go:255] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="triggering GenericEvent" "reason"="task" "task-description-id"="VirtualMachine.clone" "task-entity-name"="capv-haproxy-v0.6.3" "task-name"="CloneVM_Task" "task-ref"={"Type":"Task","Value":"task-16023330"} "task-state"="success"
I0629 18:56:57.995154 1 util.go:124] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb/task-16023330 "msg"="task found" "description-id"="VirtualMachine.clone" "state"="success"
I0629 18:56:57.995180 1 util.go:133] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb/task-16023330 "msg"="task is a success" "description-id"="VirtualMachine.clone"
I0629 18:56:57.997333 1 util.go:92] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="vm found by instance uuid" "vmref"={"Type":"VirtualMachine","Value":"vm-632190"}
I0629 18:56:58.005379 1 service.go:221] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="updating metadata"
I0629 18:56:58.012861 1 service.go:228] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="wait for VM metadata to be updated"
I0629 18:56:58.014762 1 util.go:210] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="enqueuing reconcile request on task completion" "task-description-id"="VirtualMachine.reconfigure" "task-entity-name"="demo-ref-1-lb" "task-name"="ReconfigVM_Task" "task-ref"={"Type":"Task","Value":"task-16023331"}
I0629 18:56:58.014799 1 vspherevm_controller.go:318] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="VM state is not reconciled" "actual-vm-state"="pending" "expected-vm-state"="ready"
I0629 18:56:58.023608 1 vspherevm_controller.go:249] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="resource is not patched" "local-resource-version"="39584252" "remote-resource-version"="39584252"
I0629 18:56:58.023713 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
I0629 18:56:58.023960 1 haproxyloadbalancer_controller.go:287] capv-controller-manager/haproxyloadbalancer-controller "msg"="Generating certificates" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo"
I0629 18:56:58.228402 1 util.go:255] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="triggering GenericEvent" "reason"="task" "task-description-id"="VirtualMachine.reconfigure" "task-entity-name"="demo-ref-1-lb" "task-name"="ReconfigVM_Task" "task-ref"={"Type":"Task","Value":"task-16023331"} "task-state"="success"
I0629 18:56:58.362890 1 haproxyloadbalancer_controller.go:311] capv-controller-manager/haproxyloadbalancer-controller "msg"="HAProxy LoadBalancer not ready, reconciling network" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "vm-name"="demo-ref-1-lb"
I0629 18:56:58.362938 1 haproxyloadbalancer_controller.go:605] capv-controller-manager/haproxyloadbalancer-controller "msg"="waiting on vm for ip address" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "old-ip-address"="" "vm-api-version"="infrastructure.cluster.x-k8s.io/v1alpha3" "vm-kind"="VSphereVM" "vm-name"="demo-ref-1-lb"
I0629 18:56:58.362962 1 haproxyloadbalancer_controller.go:318] capv-controller-manager/haproxyloadbalancer-controller "msg"="Network is not reconciled, requeing in 10 seconds" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "old-ip-address"="" "vm-api-version"="infrastructure.cluster.x-k8s.io/v1alpha3" "vm-kind"="VSphereVM" "vm-name"="demo-ref-1-lb"
I0629 18:56:59.023954 1 vspherevm_controller.go:229] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="resource is patched" "local-resource-version"="39584252" "remote-resource-version"="39584299"
I0629 18:56:59.024022 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-lb"}
E0629 18:56:59.028330 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="failed to create vSphere session: error setting up new vSphere SOAP client: Post https://vcenter1.sce-dcn.net/sdk: dial tcp: lookup vcenter1.sce-dcn.net on 10.96.0.10:53: no such host" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-lb"}
E0629 18:56:59.037575 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="failed to create vSphere session: error setting up new vSphere SOAP client: Post https://vcenter1.sce-dcn.net/sdk: dial tcp: lookup vcenter1.sce-dcn.net on 10.96.0.10:53: no such host" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-lb"}
E0629 18:56:59.061645 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="failed to create vSphere session: error setting up new vSphere SOAP client: Post https://vcenter1.sce-dcn.net/sdk: dial tcp: lookup vcenter1.sce-dcn.net on 10.96.0.10:53: no such host" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-lb"}
E0629 18:56:59.085937 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="failed to create vSphere session: error setting up new vSphere SOAP client: Post https://vcenter1.sce-dcn.net/sdk: dial tcp: lookup vcenter1.sce-dcn.net on 10.96.0.10:53: no such host" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-lb"}
I0629 18:56:59.250823 1 util.go:124] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb/task-16023331 "msg"="task found" "description-id"="VirtualMachine.reconfigure" "state"="success"
I0629 18:56:59.250853 1 util.go:133] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb/task-16023331 "msg"="task is a success" "description-id"="VirtualMachine.reconfigure"
I0629 18:56:59.253839 1 util.go:92] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="vm found by instance uuid" "vmref"={"Type":"VirtualMachine","Value":"vm-632190"}
I0629 18:56:59.264951 1 service.go:239] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="powering on"
I0629 18:56:59.271990 1 service.go:252] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="wait for VM to be powered on"
I0629 18:56:59.273779 1 util.go:210] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="enqueuing reconcile request on task completion" "task-description-id"="VirtualMachine.powerOn" "task-entity-name"="demo-ref-1-lb" "task-name"="PowerOnVM_Task" "task-ref"={"Type":"Task","Value":"task-16023332"}
I0629 18:56:59.273813 1 vspherevm_controller.go:318] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="VM state is not reconciled" "actual-vm-state"="pending" "expected-vm-state"="ready"
E0629 18:56:59.274371 1 util.go:248] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="failed to wait on func" "error"="Post https://vcenter1.sce-dcn.net/sdk: dial tcp: lookup vcenter1.sce-dcn.net on 10.96.0.10:53: no such host"
I0629 18:56:59.285788 1 vspherevm_controller.go:249] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="resource is not patched" "local-resource-version"="39584299" "remote-resource-version"="39584299"
I0629 18:56:59.285868 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
I0629 18:56:59.286134 1 haproxyloadbalancer_controller.go:287] capv-controller-manager/haproxyloadbalancer-controller "msg"="Generating certificates" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo"
I0629 18:56:59.503577 1 haproxyloadbalancer_controller.go:311] capv-controller-manager/haproxyloadbalancer-controller "msg"="HAProxy LoadBalancer not ready, reconciling network" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "vm-name"="demo-ref-1-lb"
I0629 18:56:59.503623 1 haproxyloadbalancer_controller.go:605] capv-controller-manager/haproxyloadbalancer-controller "msg"="waiting on vm for ip address" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "old-ip-address"="" "vm-api-version"="infrastructure.cluster.x-k8s.io/v1alpha3" "vm-kind"="VSphereVM" "vm-name"="demo-ref-1-lb"
I0629 18:56:59.503646 1 haproxyloadbalancer_controller.go:318] capv-controller-manager/haproxyloadbalancer-controller "msg"="Network is not reconciled, requeing in 10 seconds" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "old-ip-address"="" "vm-api-version"="infrastructure.cluster.x-k8s.io/v1alpha3" "vm-kind"="VSphereVM" "vm-name"="demo-ref-1-lb"
I0629 18:56:59.933767 1 util.go:502] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="the VM is missing the requested IP address" "addressType"="dhcp4"
I0629 18:57:00.286121 1 vspherevm_controller.go:229] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="resource is patched" "local-resource-version"="39584299" "remote-resource-version"="39584316"
I0629 18:57:00.286178 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-lb"}
E0629 18:57:00.290252 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="failed to create vSphere session: error setting up new vSphere SOAP client: Post https://vcenter1.sce-dcn.net/sdk: dial tcp: lookup vcenter1.sce-dcn.net on 10.96.0.10:53: no such host" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-lb"}
I0629 18:57:00.439900 1 util.go:124] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb/task-16023332 "msg"="task found" "description-id"="VirtualMachine.powerOn" "state"="success"
I0629 18:57:00.439927 1 util.go:133] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb/task-16023332 "msg"="task is a success" "description-id"="VirtualMachine.powerOn"
I0629 18:57:00.442912 1 util.go:92] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="vm found by instance uuid" "vmref"={"Type":"VirtualMachine","Value":"vm-632190"}
I0629 18:57:00.456014 1 service.go:255] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="powered on"
I0629 18:57:00.456038 1 vspherevm_controller.go:326] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="vm bios-uuid" "biosuuid"="42177359-1f23-a216-ed1c-2988e3422912"
I0629 18:57:00.466430 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
I0629 18:57:00.466666 1 haproxyloadbalancer_controller.go:287] capv-controller-manager/haproxyloadbalancer-controller "msg"="Generating certificates" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo"
I0629 18:57:00.477249 1 vspherevm_controller.go:347] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="VSphereVM is ready"
I0629 18:57:00.495757 1 vspherevm_controller.go:229] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="resource is patched" "local-resource-version"="39584316" "remote-resource-version"="39584323"
I0629 18:57:00.495793 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-lb"}
I0629 18:57:00.648790 1 util.go:65] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="vm found by bios uuid" "vmref"={"Type":"VirtualMachine","Value":"vm-632190"}
I0629 18:57:00.663151 1 service.go:255] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="powered on"
I0629 18:57:00.663175 1 vspherevm_controller.go:326] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="vm bios-uuid" "biosuuid"="42177359-1f23-a216-ed1c-2988e3422912"
I0629 18:57:00.663342 1 vspherevm_controller.go:347] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="VSphereVM is ready"
I0629 18:57:00.670067 1 vspherevm_controller.go:229] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="resource is patched" "local-resource-version"="39584323" "remote-resource-version"="39584324"
I0629 18:57:00.670098 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-lb"}
I0629 18:57:00.736076 1 haproxyloadbalancer_controller.go:311] capv-controller-manager/haproxyloadbalancer-controller "msg"="HAProxy LoadBalancer not ready, reconciling network" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "vm-name"="demo-ref-1-lb"
I0629 18:57:00.736120 1 haproxyloadbalancer_controller.go:605] capv-controller-manager/haproxyloadbalancer-controller "msg"="waiting on vm for ip address" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "old-ip-address"="" "vm-api-version"="infrastructure.cluster.x-k8s.io/v1alpha3" "vm-kind"="VSphereVM" "vm-name"="demo-ref-1-lb"
I0629 18:57:00.736142 1 haproxyloadbalancer_controller.go:318] capv-controller-manager/haproxyloadbalancer-controller "msg"="Network is not reconciled, requeing in 10 seconds" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "old-ip-address"="" "vm-api-version"="infrastructure.cluster.x-k8s.io/v1alpha3" "vm-kind"="VSphereVM" "vm-name"="demo-ref-1-lb"
I0629 18:57:00.736344 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
I0629 18:57:00.736496 1 haproxyloadbalancer_controller.go:287] capv-controller-manager/haproxyloadbalancer-controller "msg"="Generating certificates" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo"
I0629 18:57:00.813250 1 util.go:65] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="vm found by bios uuid" "vmref"={"Type":"VirtualMachine","Value":"vm-632190"}
I0629 18:57:00.823992 1 service.go:255] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="powered on"
I0629 18:57:00.824017 1 vspherevm_controller.go:326] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="vm bios-uuid" "biosuuid"="42177359-1f23-a216-ed1c-2988e3422912"
I0629 18:57:00.824216 1 vspherevm_controller.go:347] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="VSphereVM is ready"
I0629 18:57:00.824525 1 vspherevm_controller.go:240] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="resource patch was not required" "local-resource-version"="39584324" "remote-resource-version"="39584324"
I0629 18:57:00.824554 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-lb"}
I0629 18:57:00.848359 1 vspherecluster_controller.go:243] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="Reconciling VSphereCluster"
I0629 18:57:00.848450 1 vspherecluster_controller.go:390] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="status.ready not found for load balancer" "load-balancer-gvk"="infrastructure.cluster.x-k8s.io/v1alpha3, Kind=HAProxyLoadBalancer" "load-balancer-name"="demo-ref-1" "load-balancer-namespace"="demo"
I0629 18:57:00.848464 1 vspherecluster_controller.go:254] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="load balancer is not reconciled"
I0629 18:57:01.022745 1 haproxyloadbalancer_controller.go:311] capv-controller-manager/haproxyloadbalancer-controller "msg"="HAProxy LoadBalancer not ready, reconciling network" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "vm-name"="demo-ref-1-lb"
I0629 18:57:01.022791 1 haproxyloadbalancer_controller.go:605] capv-controller-manager/haproxyloadbalancer-controller "msg"="waiting on vm for ip address" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "old-ip-address"="" "vm-api-version"="infrastructure.cluster.x-k8s.io/v1alpha3" "vm-kind"="VSphereVM" "vm-name"="demo-ref-1-lb"
I0629 18:57:01.022813 1 haproxyloadbalancer_controller.go:318] capv-controller-manager/haproxyloadbalancer-controller "msg"="Network is not reconciled, requeing in 10 seconds" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "old-ip-address"="" "vm-api-version"="infrastructure.cluster.x-k8s.io/v1alpha3" "vm-kind"="VSphereVM" "vm-name"="demo-ref-1-lb"
I0629 18:57:10.736643 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
I0629 18:57:10.737071 1 haproxyloadbalancer_controller.go:287] capv-controller-manager/haproxyloadbalancer-controller "msg"="Generating certificates" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo"
I0629 18:57:10.849160 1 vspherecluster_controller.go:243] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="Reconciling VSphereCluster"
I0629 18:57:10.849274 1 vspherecluster_controller.go:390] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="status.ready not found for load balancer" "load-balancer-gvk"="infrastructure.cluster.x-k8s.io/v1alpha3, Kind=HAProxyLoadBalancer" "load-balancer-name"="demo-ref-1" "load-balancer-namespace"="demo"
I0629 18:57:10.849284 1 vspherecluster_controller.go:254] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="load balancer is not reconciled"
I0629 18:57:11.186266 1 haproxyloadbalancer_controller.go:311] capv-controller-manager/haproxyloadbalancer-controller "msg"="HAProxy LoadBalancer not ready, reconciling network" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "vm-name"="demo-ref-1-lb"
I0629 18:57:11.186314 1 haproxyloadbalancer_controller.go:605] capv-controller-manager/haproxyloadbalancer-controller "msg"="waiting on vm for ip address" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "old-ip-address"="" "vm-api-version"="infrastructure.cluster.x-k8s.io/v1alpha3" "vm-kind"="VSphereVM" "vm-name"="demo-ref-1-lb"
I0629 18:57:11.186336 1 haproxyloadbalancer_controller.go:318] capv-controller-manager/haproxyloadbalancer-controller "msg"="Network is not reconciled, requeing in 10 seconds" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "old-ip-address"="" "vm-api-version"="infrastructure.cluster.x-k8s.io/v1alpha3" "vm-kind"="VSphereVM" "vm-name"="demo-ref-1-lb"
I0629 18:57:20.850245 1 vspherecluster_controller.go:243] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="Reconciling VSphereCluster"
I0629 18:57:20.850383 1 vspherecluster_controller.go:390] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="status.ready not found for load balancer" "load-balancer-gvk"="infrastructure.cluster.x-k8s.io/v1alpha3, Kind=HAProxyLoadBalancer" "load-balancer-name"="demo-ref-1" "load-balancer-namespace"="demo"
I0629 18:57:20.850405 1 vspherecluster_controller.go:254] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="load balancer is not reconciled"
I0629 18:57:21.186840 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
I0629 18:57:21.187234 1 haproxyloadbalancer_controller.go:287] capv-controller-manager/haproxyloadbalancer-controller "msg"="Generating certificates" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo"
I0629 18:57:21.294883 1 haproxyloadbalancer_controller.go:311] capv-controller-manager/haproxyloadbalancer-controller "msg"="HAProxy LoadBalancer not ready, reconciling network" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "vm-name"="demo-ref-1-lb"
I0629 18:57:21.294930 1 haproxyloadbalancer_controller.go:605] capv-controller-manager/haproxyloadbalancer-controller "msg"="waiting on vm for ip address" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "old-ip-address"="" "vm-api-version"="infrastructure.cluster.x-k8s.io/v1alpha3" "vm-kind"="VSphereVM" "vm-name"="demo-ref-1-lb"
I0629 18:57:21.294953 1 haproxyloadbalancer_controller.go:318] capv-controller-manager/haproxyloadbalancer-controller "msg"="Network is not reconciled, requeing in 10 seconds" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "old-ip-address"="" "vm-api-version"="infrastructure.cluster.x-k8s.io/v1alpha3" "vm-kind"="VSphereVM" "vm-name"="demo-ref-1-lb"
I0629 18:57:30.851326 1 vspherecluster_controller.go:243] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="Reconciling VSphereCluster"
I0629 18:57:30.851466 1 vspherecluster_controller.go:390] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="status.ready not found for load balancer" "load-balancer-gvk"="infrastructure.cluster.x-k8s.io/v1alpha3, Kind=HAProxyLoadBalancer" "load-balancer-name"="demo-ref-1" "load-balancer-namespace"="demo"
I0629 18:57:30.851488 1 vspherecluster_controller.go:254] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="load balancer is not reconciled"
I0629 18:57:31.295393 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
I0629 18:57:31.295751 1 haproxyloadbalancer_controller.go:287] capv-controller-manager/haproxyloadbalancer-controller "msg"="Generating certificates" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo"
I0629 18:57:31.405293 1 haproxyloadbalancer_controller.go:311] capv-controller-manager/haproxyloadbalancer-controller "msg"="HAProxy LoadBalancer not ready, reconciling network" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "vm-name"="demo-ref-1-lb"
I0629 18:57:31.405347 1 haproxyloadbalancer_controller.go:605] capv-controller-manager/haproxyloadbalancer-controller "msg"="waiting on vm for ip address" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "old-ip-address"="" "vm-api-version"="infrastructure.cluster.x-k8s.io/v1alpha3" "vm-kind"="VSphereVM" "vm-name"="demo-ref-1-lb"
I0629 18:57:31.405381 1 haproxyloadbalancer_controller.go:318] capv-controller-manager/haproxyloadbalancer-controller "msg"="Network is not reconciled, requeing in 10 seconds" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "old-ip-address"="" "vm-api-version"="infrastructure.cluster.x-k8s.io/v1alpha3" "vm-kind"="VSphereVM" "vm-name"="demo-ref-1-lb"
I0629 18:57:40.852456 1 vspherecluster_controller.go:243] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="Reconciling VSphereCluster"
I0629 18:57:40.852583 1 vspherecluster_controller.go:390] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="status.ready not found for load balancer" "load-balancer-gvk"="infrastructure.cluster.x-k8s.io/v1alpha3, Kind=HAProxyLoadBalancer" "load-balancer-name"="demo-ref-1" "load-balancer-namespace"="demo"
I0629 18:57:40.852596 1 vspherecluster_controller.go:254] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="load balancer is not reconciled"
I0629 18:57:41.234426 1 util.go:461] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="discovered IP address" "addressType"="dhcp4" "addressValue"="10.27.50.146"
I0629 18:57:41.234507 1 util.go:426] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="ignoring IP address" "reason"="failed to validate ip addr=fe80::250:56ff:fea1:ffe2: link-local-unicast"
I0629 18:57:41.234527 1 util.go:531] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="the VM has all of the requested IP addresses"
I0629 18:57:41.234617 1 util.go:289] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="triggering GenericEvent" "ipAddress"="10.27.50.146" "reason"="network"
I0629 18:57:41.373320 1 util.go:65] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="vm found by bios uuid" "vmref"={"Type":"VirtualMachine","Value":"vm-632190"}
I0629 18:57:41.387131 1 service.go:255] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="powered on"
I0629 18:57:41.387157 1 vspherevm_controller.go:326] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="vm bios-uuid" "biosuuid"="42177359-1f23-a216-ed1c-2988e3422912"
I0629 18:57:41.387345 1 vspherevm_controller.go:347] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="VSphereVM is ready"
I0629 18:57:41.400521 1 vspherevm_controller.go:249] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="resource is not patched" "local-resource-version"="39584324" "remote-resource-version"="39584324"
I0629 18:57:41.400570 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
I0629 18:57:41.400860 1 haproxyloadbalancer_controller.go:287] capv-controller-manager/haproxyloadbalancer-controller "msg"="Generating certificates" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo"
I0629 18:57:41.739140 1 haproxyloadbalancer_controller.go:311] capv-controller-manager/haproxyloadbalancer-controller "msg"="HAProxy LoadBalancer not ready, reconciling network" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "vm-name"="demo-ref-1-lb"
I0629 18:57:41.739189 1 haproxyloadbalancer_controller.go:614] capv-controller-manager/haproxyloadbalancer-controller "msg"="Discovered IP address from VM" "api-version"="v1alpha3" "ip-address"="10.27.50.146" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "old-ip-address"="" "vm-api-version"="infrastructure.cluster.x-k8s.io/v1alpha3" "vm-kind"="VSphereVM" "vm-name"="demo-ref-1-lb"
I0629 18:57:41.739229 1 haproxyloadbalancer_controller.go:624] capv-controller-manager/haproxyloadbalancer-controller "msg"="Initialized IP address" "api-version"="v1alpha3" "ip-address"="10.27.50.146" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "old-ip-address"="" "vm-api-version"="infrastructure.cluster.x-k8s.io/v1alpha3" "vm-kind"="VSphereVM" "vm-name"="demo-ref-1-lb"
I0629 18:57:41.882886 1 haproxyloadbalancer_controller.go:332] capv-controller-manager/haproxyloadbalancer-controller "msg"="HAProxyLoadBalancer is ready" "api-version"="v1alpha3" "ip-address"="10.27.50.146" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "old-ip-address"="" "vm-api-version"="infrastructure.cluster.x-k8s.io/v1alpha3" "vm-kind"="VSphereVM" "vm-name"="demo-ref-1-lb"
E0629 18:57:41.901729 1 haproxyloadbalancer_controller.go:337] capv-controller-manager/haproxyloadbalancer-controller "msg"="Requeing after 10 seconds" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.146:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "api-version"="v1alpha3" "ip-address"="10.27.50.146" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "old-ip-address"="" "vm-api-version"="infrastructure.cluster.x-k8s.io/v1alpha3" "vm-kind"="VSphereVM" "vm-name"="demo-ref-1-lb"
E0629 18:57:41.914369 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.146:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "controller"="haproxyloadbalancer" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:57:41.914422 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
I0629 18:57:41.914525 1 vspherecluster_controller.go:243] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="Reconciling VSphereCluster"
I0629 18:57:41.914591 1 vspherecluster_controller.go:436] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="ControlPlaneEndpoint discovered via load balancer" "controlPlaneEndpoint"="10.27.50.146:6443"
I0629 18:57:41.914614 1 vspherecluster_controller.go:460] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="skipping control plane endpoint reconciliation" "controlPlaneEndpoint"="10.27.50.146:6443" "reason"="ControlPlaneEndpoint already set on VSphereCluster"
I0629 18:57:41.914703 1 vspherecluster_controller.go:545] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="start polling API server for online check"
E0629 18:57:41.922488 1 haproxyloadbalancer_controller.go:337] capv-controller-manager/haproxyloadbalancer-controller "msg"="Requeing after 10 seconds" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.146:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "vm-name"="demo-ref-1-lb"
E0629 18:57:41.922722 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.146:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "controller"="haproxyloadbalancer" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:57:41.922766 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
E0629 18:57:41.930178 1 haproxyloadbalancer_controller.go:337] capv-controller-manager/haproxyloadbalancer-controller "msg"="Requeing after 10 seconds" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.146:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "vm-name"="demo-ref-1-lb"
E0629 18:57:41.930428 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.146:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "controller"="haproxyloadbalancer" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:57:41.932909 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
E0629 18:57:41.940454 1 haproxyloadbalancer_controller.go:337] capv-controller-manager/haproxyloadbalancer-controller "msg"="Requeing after 10 seconds" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.146:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "vm-name"="demo-ref-1-lb"
E0629 18:57:41.940713 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.146:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "controller"="haproxyloadbalancer" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:57:41.941059 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherecluster" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:57:41.941258 1 vspherecluster_controller.go:243] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="Reconciling VSphereCluster"
I0629 18:57:41.941315 1 vspherecluster_controller.go:316] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="skipping load balancer reconciliation" "controlPlaneEndpoint"="10.27.50.146:6443" "reason"="VSphereCluster.Spec.ControlPlaneEndpoint is already set"
I0629 18:57:41.941334 1 vspherecluster_controller.go:460] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="skipping control plane endpoint reconciliation" "controlPlaneEndpoint"="10.27.50.146:6443" "reason"="ControlPlaneEndpoint already set on VSphereCluster"
I0629 18:57:41.941351 1 vspherecluster_controller.go:538] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="skipping reconcile when API server is online" "reason"="alreadyPolling"
I0629 18:57:41.941632 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherecluster" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:57:41.956478 1 vspherecluster_controller.go:243] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="Reconciling VSphereCluster"
I0629 18:57:41.956530 1 vspherecluster_controller.go:309] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="skipping load balancer reconciliation" "controlPlaneEndpoint"="10.27.50.146:6443" "reason"="Cluster.Spec.ControlPlaneEndpoint is already set"
I0629 18:57:41.956549 1 vspherecluster_controller.go:453] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="skipping control plane endpoint reconciliation" "controlPlaneEndpoint"="10.27.50.146:6443" "reason"="ControlPlaneEndpoint already set on Cluster"
I0629 18:57:41.956565 1 vspherecluster_controller.go:538] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="skipping reconcile when API server is online" "reason"="alreadyPolling"
I0629 18:57:41.958316 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherecluster" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:57:41.973277 1 vspherecluster_controller.go:243] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="Reconciling VSphereCluster"
I0629 18:57:41.973333 1 vspherecluster_controller.go:309] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="skipping load balancer reconciliation" "controlPlaneEndpoint"="10.27.50.146:6443" "reason"="Cluster.Spec.ControlPlaneEndpoint is already set"
I0629 18:57:41.973352 1 vspherecluster_controller.go:453] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="skipping control plane endpoint reconciliation" "controlPlaneEndpoint"="10.27.50.146:6443" "reason"="ControlPlaneEndpoint already set on Cluster"
I0629 18:57:41.973368 1 vspherecluster_controller.go:538] capv-controller-manager/vspherecluster-controller/demo/demo-ref-1 "msg"="skipping reconcile when API server is online" "reason"="alreadyPolling"
I0629 18:57:41.973590 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherecluster" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:57:41.980933 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
E0629 18:57:41.989090 1 haproxyloadbalancer_controller.go:337] capv-controller-manager/haproxyloadbalancer-controller "msg"="Requeing after 10 seconds" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.146:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "vm-name"="demo-ref-1-lb"
E0629 18:57:41.989368 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.146:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "controller"="haproxyloadbalancer" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:57:42.069514 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
E0629 18:57:42.077193 1 haproxyloadbalancer_controller.go:337] capv-controller-manager/haproxyloadbalancer-controller "msg"="Requeing after 10 seconds" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.146:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "vm-name"="demo-ref-1-lb"
E0629 18:57:42.077457 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.146:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "controller"="haproxyloadbalancer" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:57:42.237620 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
E0629 18:57:42.245270 1 haproxyloadbalancer_controller.go:337] capv-controller-manager/haproxyloadbalancer-controller "msg"="Requeing after 10 seconds" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.146:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "vm-name"="demo-ref-1-lb"
E0629 18:57:42.245525 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.146:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "controller"="haproxyloadbalancer" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:57:42.400697 1 vspherevm_controller.go:229] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="resource is patched" "local-resource-version"="39584324" "remote-resource-version"="39584640"
I0629 18:57:42.400739 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-lb"}
I0629 18:57:42.524547 1 util.go:65] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="vm found by bios uuid" "vmref"={"Type":"VirtualMachine","Value":"vm-632190"}
I0629 18:57:42.535713 1 service.go:255] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="powered on"
I0629 18:57:42.535739 1 vspherevm_controller.go:326] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="vm bios-uuid" "biosuuid"="42177359-1f23-a216-ed1c-2988e3422912"
I0629 18:57:42.535959 1 vspherevm_controller.go:347] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="VSphereVM is ready"
I0629 18:57:42.536301 1 vspherevm_controller.go:240] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-lb "msg"="resource patch was not required" "local-resource-version"="39584640" "remote-resource-version"="39584640"
I0629 18:57:42.536326 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-lb"}
I0629 18:57:42.565631 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
E0629 18:57:42.573074 1 haproxyloadbalancer_controller.go:337] capv-controller-manager/haproxyloadbalancer-controller "msg"="Requeing after 10 seconds" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.146:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "vm-name"="demo-ref-1-lb"
E0629 18:57:42.573400 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.146:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "controller"="haproxyloadbalancer" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:57:43.140413 1 vspheremachine_controller.go:160] capv-controller-manager/vspheremachine-controller "msg"="Waiting for Machine Controller to set OwnerRef on VSphereMachine"
I0629 18:57:43.140448 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-cp-v1-z5f2v"}
I0629 18:57:43.163415 1 vspheremachine_controller.go:160] capv-controller-manager/vspheremachine-controller "msg"="Waiting for Machine Controller to set OwnerRef on VSphereMachine"
I0629 18:57:43.163452 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-cp-v1-z5f2v"}
I0629 18:57:43.194194 1 vspheremachine_controller.go:314] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-z5f2v "msg"="Waiting for bootstrap data to be available"
I0629 18:57:43.213503 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
E0629 18:57:43.221520 1 haproxyloadbalancer_controller.go:337] capv-controller-manager/haproxyloadbalancer-controller "msg"="Requeing after 10 seconds" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.146:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "vm-name"="demo-ref-1-lb"
E0629 18:57:43.221839 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.146:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "controller"="haproxyloadbalancer" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:57:43.229684 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-cp-v1-z5f2v"}
I0629 18:57:43.232847 1 vspheremachine_controller.go:314] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-z5f2v "msg"="Waiting for bootstrap data to be available"
I0629 18:57:43.288278 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-cp-v1-z5f2v"}
I0629 18:57:43.288526 1 vspheremachine_controller.go:314] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-z5f2v "msg"="Waiting for bootstrap data to be available"
I0629 18:57:43.288679 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-cp-v1-z5f2v"}
I0629 18:57:43.346997 1 vspheremachine_controller.go:521] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-z5f2v "msg"="spec.biosUUID not found" "vmGVK"="/, Kind=" "vmName"="demo-ref-1-d6bgd" "vmNamespace"="demo"
I0629 18:57:43.347035 1 vspheremachine_controller.go:345] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-z5f2v "msg"="provider ID is not reconciled"
I0629 18:57:43.347360 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-cp-v1-z5f2v"}
I0629 18:57:43.347947 1 vspheremachine_controller.go:521] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-z5f2v "msg"="spec.biosUUID not found" "vmGVK"="infrastructure.cluster.x-k8s.io/v1alpha3, Kind=VSphereVM" "vmName"="demo-ref-1-d6bgd" "vmNamespace"="demo"
I0629 18:57:43.347970 1 vspheremachine_controller.go:345] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-z5f2v "msg"="provider ID is not reconciled"
I0629 18:57:43.348119 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-cp-v1-z5f2v"}
I0629 18:57:43.495491 1 util.go:81] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-d6bgd "msg"="using inventory path to find vm" "path"="/Bremen/vm/TDCN/DCI_SCHIFF/demo-ref-1-d6bgd"
I0629 18:57:43.511675 1 clone.go:46] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-d6bgd/vcenter "msg"="starting clone process"
I0629 18:57:43.511701 1 clone.go:50] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-d6bgd/vcenter "msg"="applied bootstrap data to VM clone spec"
I0629 18:57:44.284093 1 clone.go:177] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-d6bgd/vcenter "msg"="cloning machine" "cloneType"="fullClone" "name"="demo-ref-1-d6bgd" "namespace"="demo"
I0629 18:57:44.299227 1 util.go:210] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-d6bgd "msg"="enqueuing reconcile request on task completion" "task-description-id"="VirtualMachine.clone" "task-entity-name"="ubuntu-1804-200428T1533-kube-v1.18.2" "task-name"="CloneVM_Task" "task-ref"={"Type":"Task","Value":"task-16023334"}
I0629 18:57:44.299271 1 vspherevm_controller.go:318] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-d6bgd "msg"="VM state is not reconciled" "actual-vm-state"="pending" "expected-vm-state"="ready"
I0629 18:57:44.309447 1 vspheremachine_controller.go:521] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-z5f2v "msg"="spec.biosUUID not found" "vmGVK"="infrastructure.cluster.x-k8s.io/v1alpha3, Kind=VSphereVM" "vmName"="demo-ref-1-d6bgd" "vmNamespace"="demo"
I0629 18:57:44.309469 1 vspheremachine_controller.go:345] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-z5f2v "msg"="provider ID is not reconciled"
I0629 18:57:44.309641 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-cp-v1-z5f2v"}
I0629 18:57:44.320580 1 vspherevm_controller.go:229] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-d6bgd "msg"="resource is patched" "local-resource-version"="39584689" "remote-resource-version"="39584701"
I0629 18:57:44.320606 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspherevm" "request"={"Namespace":"demo","Name":"demo-ref-1-d6bgd"}
I0629 18:57:44.322634 1 vspheremachine_controller.go:521] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-z5f2v "msg"="spec.biosUUID not found" "vmGVK"="infrastructure.cluster.x-k8s.io/v1alpha3, Kind=VSphereVM" "vmName"="demo-ref-1-d6bgd" "vmNamespace"="demo"
I0629 18:57:44.322662 1 vspheremachine_controller.go:345] capv-controller-manager/vspheremachine-controller/demo/demo-ref-1-cp-v1-z5f2v "msg"="provider ID is not reconciled"
I0629 18:57:44.322811 1 controller.go:282] controller-runtime/controller "msg"="Successfully Reconciled" "controller"="vspheremachine" "request"={"Namespace":"demo","Name":"demo-ref-1-cp-v1-z5f2v"}
I0629 18:57:44.502106 1 haproxyloadbalancer_controller.go:156] capv-controller-manager/haproxyloadbalancer-controller "msg"="Starting reconciliation" "name"="demo-ref-1" "namespace"="demo"
E0629 18:57:44.510201 1 haproxyloadbalancer_controller.go:337] capv-controller-manager/haproxyloadbalancer-controller "msg"="Requeing after 10 seconds" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.146:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "api-version"="v1alpha3" "kind"="HAProxyLoadBalancer" "name"="demo-ref-1" "namespace"="demo" "vm-name"="demo-ref-1-lb"
E0629 18:57:44.510443 1 controller.go:258] controller-runtime/controller "msg"="Reconciler error" "error"="Failed to get HAProxy dataplane global config: Get https://10.27.50.146:5556/v1/services/haproxy/configuration/global: remote error: tls: bad certificate" "controller"="haproxyloadbalancer" "request"={"Namespace":"demo","Name":"demo-ref-1"}
I0629 18:57:44.520570 1 util.go:81] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-d6bgd "msg"="using inventory path to find vm" "path"="/Bremen/vm/TDCN/DCI_SCHIFF/demo-ref-1-d6bgd"
I0629 18:57:44.537163 1 util.go:89] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-d6bgd "msg"="vm found by name" "vmref"={"Type":"VirtualMachine","Value":"vm-632191"}
I0629 18:57:44.539231 1 vspherevm_controller.go:229] capv-controller-manager/vspherevm-controller/demo/demo-ref-1-d6bgd "msg"="resource is patched" "local-resource-version"="39584701" "remote-resource-version"="39584702"
E0629 18:57:44.539318 1 runtime.go:78] Observed a panic: "invalid memory address or nil pointer dereference" (runtime error: invalid memory address or nil pointer dereference)
goroutine 453 [running]:
k8s.io/apimachinery/pkg/util/runtime.logPanic(0x1bfa2a0, 0x331b230)
/go/pkg/mod/k8s.io/apimachinery@v0.17.2/pkg/util/runtime/runtime.go:74 +0xa3
k8s.io/apimachinery/pkg/util/runtime.HandleCrash(0x0, 0x0, 0x0)
/go/pkg/mod/k8s.io/apimachinery@v0.17.2/pkg/util/runtime/runtime.go:48 +0x82
panic(0x1bfa2a0, 0x331b230)
/usr/local/go/src/runtime/panic.go:679 +0x1b2
github.com/vmware/govmomi/object.VirtualMachine.UUID(0x0, 0x0, 0xc00048c2c0, 0xc000b5cf60, 0xe, 0xc000b5cf83, 0x9, 0x228e5a0, 0xc000ce42a0, 0x10, ...)
/go/pkg/mod/github.com/vmware/govmomi@v0.23.0/object/virtual_machine.go:859 +0x1f7
sigs.k8s.io/cluster-api-provider-vsphere/pkg/services/govmomi.(*VMService).reconcileUUID(...)
/workspace/pkg/services/govmomi/service.go:263
sigs.k8s.io/cluster-api-provider-vsphere/pkg/services/govmomi.(*VMService).ReconcileVM(0x336ff10, 0xc0007b14d0, 0x1fa7320, 0x29, 0xa, 0x2260da0, 0xc000da1980, 0x0, 0x0, 0xc000da1980, ...)
/workspace/pkg/services/govmomi/service.go:107 +0x7fb
sigs.k8s.io/cluster-api-provider-vsphere/controllers.vmReconciler.reconcileNormal(0xc000123080, 0xc0007b14d0, 0xc0003b1180, 0xc0005c3300, 0xc0010100a0, 0x10)
/workspace/controllers/vspherevm_controller.go:311 +0x20c
sigs.k8s.io/cluster-api-provider-vsphere/controllers.vmReconciler.Reconcile(0xc000123080, 0xc00102cd7c, 0x4, 0xc00102cd60, 0x10, 0xc000c55c00, 0x0, 0x0, 0x0)
/workspace/controllers/vspherevm_controller.go:272 +0x76b
sigs.k8s.io/controller-runtime/pkg/internal/controller.(*Controller).reconcileHandler(0xc000728900, 0x1cee160, 0xc00082a160, 0x0)
/go/pkg/mod/sigs.k8s.io/controller-runtime@v0.5.2/pkg/internal/controller/controller.go:256 +0x162
sigs.k8s.io/controller-runtime/pkg/internal/controller.(*Controller).processNextWorkItem(0xc000728900, 0xc000f0e400)
/go/pkg/mod/sigs.k8s.io/controller-runtime@v0.5.2/pkg/internal/controller/controller.go:232 +0xcb
sigs.k8s.io/controller-runtime/pkg/internal/controller.(*Controller).worker(0xc000728900)
/go/pkg/mod/sigs.k8s.io/controller-runtime@v0.5.2/pkg/internal/controller/controller.go:211 +0x2b
k8s.io/apimachinery/pkg/util/wait.JitterUntil.func1(0xc000464460)
/go/pkg/mod/k8s.io/apimachinery@v0.17.2/pkg/util/wait/wait.go:152 +0x5e
k8s.io/apimachinery/pkg/util/wait.JitterUntil(0xc000464460, 0x3b9aca00, 0x0, 0xc0004a0f01, 0xc0005597a0)
/go/pkg/mod/k8s.io/apimachinery@v0.17.2/pkg/util/wait/wait.go:153 +0xf8
k8s.io/apimachinery/pkg/util/wait.Until(0xc000464460, 0x3b9aca00, 0xc0005597a0)
/go/pkg/mod/k8s.io/apimachinery@v0.17.2/pkg/util/wait/wait.go:88 +0x4d
created by sigs.k8s.io/controller-runtime/pkg/internal/controller.(*Controller).Start.func1
/go/pkg/mod/sigs.k8s.io/controller-runtime@v0.5.2/pkg/internal/controller/controller.go:193 +0x328
panic: runtime error: invalid memory address or nil pointer dereference [recovered]
panic: runtime error: invalid memory address or nil pointer dereference
[signal SIGSEGV: segmentation violation code=0x1 addr=0x58 pc=0x18f1357]
goroutine 453 [running]:
k8s.io/apimachinery/pkg/util/runtime.HandleCrash(0x0, 0x0, 0x0)
/go/pkg/mod/k8s.io/apimachinery@v0.17.2/pkg/util/runtime/runtime.go:55 +0x105
panic(0x1bfa2a0, 0x331b230)
/usr/local/go/src/runtime/panic.go:679 +0x1b2
github.com/vmware/govmomi/object.VirtualMachine.UUID(0x0, 0x0, 0xc00048c2c0, 0xc000b5cf60, 0xe, 0xc000b5cf83, 0x9, 0x228e5a0, 0xc000ce42a0, 0x10, ...)
/go/pkg/mod/github.com/vmware/govmomi@v0.23.0/object/virtual_machine.go:859 +0x1f7
sigs.k8s.io/cluster-api-provider-vsphere/pkg/services/govmomi.(*VMService).reconcileUUID(...)
/workspace/pkg/services/govmomi/service.go:263
sigs.k8s.io/cluster-api-provider-vsphere/pkg/services/govmomi.(*VMService).ReconcileVM(0x336ff10, 0xc0007b14d0, 0x1fa7320, 0x29, 0xa, 0x2260da0, 0xc000da1980, 0x0, 0x0, 0xc000da1980, ...)
/workspace/pkg/services/govmomi/service.go:107 +0x7fb
sigs.k8s.io/cluster-api-provider-vsphere/controllers.vmReconciler.reconcileNormal(0xc000123080, 0xc0007b14d0, 0xc0003b1180, 0xc0005c3300, 0xc0010100a0, 0x10)
/workspace/controllers/vspherevm_controller.go:311 +0x20c
sigs.k8s.io/cluster-api-provider-vsphere/controllers.vmReconciler.Reconcile(0xc000123080, 0xc00102cd7c, 0x4, 0xc00102cd60, 0x10, 0xc000c55c00, 0x0, 0x0, 0x0)
/workspace/controllers/vspherevm_controller.go:272 +0x76b
sigs.k8s.io/controller-runtime/pkg/internal/controller.(*Controller).reconcileHandler(0xc000728900, 0x1cee160, 0xc00082a160, 0x0)
/go/pkg/mod/sigs.k8s.io/controller-runtime@v0.5.2/pkg/internal/controller/controller.go:256 +0x162
sigs.k8s.io/controller-runtime/pkg/internal/controller.(*Controller).processNextWorkItem(0xc000728900, 0xc000f0e400)
/go/pkg/mod/sigs.k8s.io/controller-runtime@v0.5.2/pkg/internal/controller/controller.go:232 +0xcb
sigs.k8s.io/controller-runtime/pkg/internal/controller.(*Controller).worker(0xc000728900)
/go/pkg/mod/sigs.k8s.io/controller-runtime@v0.5.2/pkg/internal/controller/controller.go:211 +0x2b
k8s.io/apimachinery/pkg/util/wait.JitterUntil.func1(0xc000464460)
/go/pkg/mod/k8s.io/apimachinery@v0.17.2/pkg/util/wait/wait.go:152 +0x5e
k8s.io/apimachinery/pkg/util/wait.JitterUntil(0xc000464460, 0x3b9aca00, 0x0, 0xc0004a0f01, 0xc0005597a0)
/go/pkg/mod/k8s.io/apimachinery@v0.17.2/pkg/util/wait/wait.go:153 +0xf8
k8s.io/apimachinery/pkg/util/wait.Until(0xc000464460, 0x3b9aca00, 0xc0005597a0)
/go/pkg/mod/k8s.io/apimachinery@v0.17.2/pkg/util/wait/wait.go:88 +0x4d
created by sigs.k8s.io/controller-runtime/pkg/internal/controller.(*Controller).Start.func1
/go/pkg/mod/sigs.k8s.io/controller-runtime@v0.5.2/pkg/internal/controller/controller.go:193 +0x328
[a92615428@jos-2011 ~]$
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment