This job view page is being replaced by Spyglass soon. Check out the new job view.
PRCecileRobertMichon: make virtual machine reconcile async
ResultFAILURE
Tests 0 failed / 224 succeeded
Started2021-10-18 20:07
Elapsed2m48s
Revision796953fe4ac9b3ba2a045f2acdb45813f24b8ba7
Refs 1697

No Test Failures!


Show 224 Passed Tests

Error lines from build-log.txt

... skipping 1335 lines ...
=== RUN   TestMachinePoolScope_SetBootstrapConditions
=== RUN   TestMachinePoolScope_SetBootstrapConditions/should_set_bootstrap_succeeded_condition_if_provisioning_state_succeeded
=== RUN   TestMachinePoolScope_SetBootstrapConditions/should_set_bootstrap_succeeded_false_condition_with_reason_if_provisioning_state_creating
    machinepool_test.go:122: 
        Expected
            <azure.ReconcileError>: {
                error: <*errors.fundamental | 0xc000283e60>{
                    msg: "extension is still in provisioning state. This likely means that bootstrapping has not yet completed on the VM",
                    stack: [0x1782103, 0x179864b, 0x521f6f, 0x4738c1],
                },
                errorType: "Transient",
                requestAfter: 30000000000,
            }
        to match error
            <string>: transient reconcile error occurred: extension is still in provisioning state. This likely means that bootstrapping has not yet completed on the VM. Object will be requeued after 30s
=== RUN   TestMachinePoolScope_SetBootstrapConditions/should_set_bootstrap_succeeded_false_condition_with_reason_if_provisioning_state_failed
--- FAIL: TestMachinePoolScope_SetBootstrapConditions (0.00s)
    --- PASS: TestMachinePoolScope_SetBootstrapConditions/should_set_bootstrap_succeeded_condition_if_provisioning_state_succeeded (0.00s)
    --- FAIL: TestMachinePoolScope_SetBootstrapConditions/should_set_bootstrap_succeeded_false_condition_with_reason_if_provisioning_state_creating (0.00s)
    --- PASS: TestMachinePoolScope_SetBootstrapConditions/should_set_bootstrap_succeeded_false_condition_with_reason_if_provisioning_state_failed (0.00s)
=== RUN   TestMachinePoolScope_MaxSurge
=== RUN   TestMachinePoolScope_MaxSurge/default_surge_should_be_1_if_no_deployment_strategy_is_set
=== RUN   TestMachinePoolScope_MaxSurge/default_surge_should_be_1_regardless_of_replica_count_with_no_surger
=== RUN   TestMachinePoolScope_MaxSurge/default_surge_should_be_2_as_specified_by_the_surger
=== RUN   TestMachinePoolScope_MaxSurge/default_surge_should_be_2_(50%)_of_the_desired_replicas
... skipping 79 lines ...
=== RUN   TestMachinePoolMachineScope_CordonAndDrain/should_skip_cordon_and_drain_if_the_node_does_not_exist_with_node_reference
=== RUN   TestMachinePoolMachineScope_CordonAndDrain/if_GetNodeByProviderID_fails_with_an_error,_an_error_will_be_returned
--- PASS: TestMachinePoolMachineScope_CordonAndDrain (0.00s)
    --- PASS: TestMachinePoolMachineScope_CordonAndDrain/should_skip_cordon_and_drain_if_the_node_does_not_exist_with_provider_ID (0.00s)
    --- PASS: TestMachinePoolMachineScope_CordonAndDrain/should_skip_cordon_and_drain_if_the_node_does_not_exist_with_node_reference (0.00s)
    --- PASS: TestMachinePoolMachineScope_CordonAndDrain/if_GetNodeByProviderID_fails_with_an_error,_an_error_will_be_returned (0.00s)
FAIL
coverage: 25.5% of statements
FAIL	sigs.k8s.io/cluster-api-provider-azure/azure/scope	0.185s
?   	sigs.k8s.io/cluster-api-provider-azure/azure/scope/mocks	[no test files]
=== RUN   TestMachinePoolRollingUpdateStrategy_Type
--- PASS: TestMachinePoolRollingUpdateStrategy_Type (0.00s)
=== RUN   TestMachinePoolRollingUpdateStrategy_Surge
=== RUN   TestMachinePoolRollingUpdateStrategy_Surge/Strategy_is_empty
=== RUN   TestMachinePoolRollingUpdateStrategy_Surge/MaxSurge_is_set_to_2
... skipping 47 lines ...
=== PAUSE TestReconcile/agentpool_in_terminal_provisioning_state
=== CONT  TestReconcile
    agentpools_test.go:83: Testing agentpool provision state: Succeeded
=== RUN   TestReconcile/agentpool_in_terminal_provisioning_state#01
=== PAUSE TestReconcile/agentpool_in_terminal_provisioning_state#01
=== CONT  TestReconcile
    agentpools_test.go:83: Testing agentpool provision state: Failed
=== RUN   TestReconcile/agentpool_in_terminal_provisioning_state#02
=== PAUSE TestReconcile/agentpool_in_terminal_provisioning_state#02
=== CONT  TestReconcile
    agentpools_test.go:83: Testing agentpool provision state: Deleting
=== RUN   TestReconcile/agentpool_in_nonterminal_provisioning_state
=== PAUSE TestReconcile/agentpool_in_nonterminal_provisioning_state
... skipping 7 lines ...
=== PAUSE TestReconcile/agentpool_in_nonterminal_provisioning_state#02
=== CONT  TestReconcile
    agentpools_test.go:254: Testing no agentpool exists
=== RUN   TestReconcile/no_agentpool_exists
=== PAUSE TestReconcile/no_agentpool_exists
=== CONT  TestReconcile
    agentpools_test.go:254: Testing fail to get existing agent pool
=== RUN   TestReconcile/fail_to_get_existing_agent_pool
=== PAUSE TestReconcile/fail_to_get_existing_agent_pool
=== CONT  TestReconcile
    agentpools_test.go:254: Testing can create an Agent Pool
=== RUN   TestReconcile/can_create_an_Agent_Pool
=== PAUSE TestReconcile/can_create_an_Agent_Pool
=== CONT  TestReconcile
    agentpools_test.go:254: Testing fail to create an Agent Pool
=== RUN   TestReconcile/fail_to_create_an_Agent_Pool
=== PAUSE TestReconcile/fail_to_create_an_Agent_Pool
=== CONT  TestReconcile
    agentpools_test.go:254: Testing fail to update an Agent Pool
=== RUN   TestReconcile/fail_to_update_an_Agent_Pool
=== PAUSE TestReconcile/fail_to_update_an_Agent_Pool
=== CONT  TestReconcile
    agentpools_test.go:254: Testing no update needed on Agent Pool
=== RUN   TestReconcile/no_update_needed_on_Agent_Pool
=== PAUSE TestReconcile/no_update_needed_on_Agent_Pool
... skipping 77 lines ...
=== CONT  TestCreateResource/create_operation_is_already_in_progress
I1018 20:09:18.404434   12414 async.go:58]  "msg"="long running operation is still ongoing"  "resource"="test-resource" "service"="test-service"
    async_test.go:241: 
        Expected
            <string>: operation type PUT on Azure resource test-group/test-resource is not done. Object will be requeued after 15s
        to contain substring
            <string>: transient reconcile error occurred: operation type PUT on Azure resource test-group/test-resource is not done. Object will be requeued after 15s
=== CONT  TestCreateResource/create_async_exits_before_completing
=== CONT  TestCreateResource/error_occurs_while_running_async_create
I1018 20:09:18.404775   12414 async.go:86]  "msg"="creating resource"  "resource"="test-resource" "resourceGroup"="test-group" "service"="test-service"
=== CONT  TestCreateResource/create_async_returns_success
=== CONT  TestCreateResource/create_async_exits_before_completing
    async_test.go:241: 
        Expected
            <string>: operation type PUT on Azure resource test-group/test-resource is not done. Object will be requeued after 15s
        to contain substring
            <string>: transient reconcile error occurred: operation type PUT on Azure resource test-group/test-resource is not done. Object will be requeued after 15s
I1018 20:09:18.404940   12414 async.go:86]  "msg"="creating resource"  "resource"="test-resource" "resourceGroup"="test-group" "service"="test-service"
I1018 20:09:18.405027   12414 async.go:86]  "msg"="creating resource"  "resource"="test-resource" "resourceGroup"="test-group" "service"="test-service"
I1018 20:09:18.405081   12414 async.go:101]  "msg"="successfully created resource"  "resource"="test-resource" "resourceGroup"="test-group" "service"="test-service"
--- FAIL: TestCreateResource (0.00s)
    --- FAIL: TestCreateResource/create_operation_is_already_in_progress (0.00s)
    --- FAIL: TestCreateResource/create_async_exits_before_completing (0.00s)
    --- PASS: TestCreateResource/error_occurs_while_running_async_create (0.00s)
    --- PASS: TestCreateResource/create_async_returns_success (0.00s)
=== RUN   TestDeleteResource
=== RUN   TestDeleteResource/delete_operation_is_already_in_progress
=== PAUSE TestDeleteResource/delete_operation_is_already_in_progress
=== RUN   TestDeleteResource/delete_async_returns_success
... skipping 11 lines ...
I1018 20:09:18.405947   12414 async.go:139]  "msg"="successfully deleted resource"  "resource"="test-resource" "resourceGroup"="test-group" "service"="test-service"
=== CONT  TestDeleteResource/delete_async_exits_before_completing
    async_test.go:326: 
        Expected
            <string>: operation type DELETE on Azure resource test-group/test-resource is not done. Object will be requeued after 15s
        to contain substring
            <string>: transient reconcile error occurred: operation type DELETE on Azure resource test-group/test-resource is not done. Object will be requeued after 15s
I1018 20:09:18.405998   12414 async.go:58]  "msg"="long running operation is still ongoing"  "resource"="test-resource" "service"="test-service"
I1018 20:09:18.406052   12414 async.go:121]  "msg"="deleting resource"  "resource"="test-resource" "resourceGroup"="test-group" "service"="test-service"
=== CONT  TestDeleteResource/delete_operation_is_already_in_progress
    async_test.go:326: 
        Expected
            <string>: operation type DELETE on Azure resource test-group/test-resource is not done. Object will be requeued after 15s
        to contain substring
            <string>: transient reconcile error occurred: operation type DELETE on Azure resource test-group/test-resource is not done. Object will be requeued after 15s
--- FAIL: TestDeleteResource (0.00s)
    --- PASS: TestDeleteResource/delete_async_returns_success (0.00s)
    --- FAIL: TestDeleteResource/delete_async_exits_before_completing (0.00s)
    --- PASS: TestDeleteResource/error_occurs_while_running_async_delete (0.00s)
    --- FAIL: TestDeleteResource/delete_operation_is_already_in_progress (0.00s)
FAIL
coverage: 95.5% of statements
FAIL	sigs.k8s.io/cluster-api-provider-azure/azure/services/async	0.106s
?   	sigs.k8s.io/cluster-api-provider-azure/azure/services/async/mock_async	[no test files]
=== RUN   TestReconcileAvailabilitySets
=== RUN   TestReconcileAvailabilitySets/create_or_update_availability_set
=== PAUSE TestReconcileAvailabilitySets/create_or_update_availability_set
=== RUN   TestReconcileAvailabilitySets/noop_if_the_machine_does_not_need_to_be_assigned_an_availability_set_(machines_without_a_deployment)
=== PAUSE TestReconcileAvailabilitySets/noop_if_the_machine_does_not_need_to_be_assigned_an_availability_set_(machines_without_a_deployment)
... skipping 187 lines ...
I1018 20:09:24.832503   12918 groups.go:95]  "msg"="Should not delete resource group in unmanaged mode"  
=== CONT  TestDeleteGroups/long_running_delete_operation_is_not_done
=== CONT  TestDeleteGroups/context_deadline_exceeded_while_deleting_resource_group
    groups.go:100: Unexpected call to *mock_groups.MockGroupScope.UpdateDeleteStatus([ResourceGroupReady group operation type DELETE on Azure resource test-group/test-group is not done. Object will be requeued after 15s]) at /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/azure/services/groups/groups.go:100 because: 
        expected call at /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/azure/services/groups/groups_test.go:218 doesn't match the argument at index 2.
        Got: operation type DELETE on Azure resource test-group/test-group is not done. Object will be requeued after 15s (azure.ReconcileError)
        Want: error.Error() "transient reconcile error occurred: operation type DELETE on Azure resource test-group/test-group is not done. Object will be requeued after 15s", but got "operation type DELETE on Azure resource test-group/test-group is not done. Object will be requeued after 15s"
    controller.go:269: missing call(s) to *mock_groups.MockGroupScope.UpdateDeleteStatus(is equal to ResourceGroupReady (v1beta1.ConditionType), is equal to group (string), error.Error() "transient reconcile error occurred: operation type DELETE on Azure resource test-group/test-group is not done. Object will be requeued after 15s", but got "operation type DELETE on Azure resource test-group/test-group is not done. Object will be requeued after 15s") /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/azure/services/groups/groups_test.go:218
I1018 20:09:24.832731   12918 async.go:58]  "msg"="long running operation is still ongoing"  "resource"="test-group" "service"="group"
    controller.go:269: aborting test due to missing call(s)
=== CONT  TestDeleteGroups/error_occurs_when_deleting_resource_group
=== CONT  TestDeleteGroups/long_running_delete_operation_is_not_done
    groups.go:100: Unexpected call to *mock_groups.MockGroupScope.UpdateDeleteStatus([ResourceGroupReady group operation type DELETE on Azure resource test-group/test-group is not done. Object will be requeued after 15s]) at /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/azure/services/groups/groups.go:100 because: 
        expected call at /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/azure/services/groups/groups_test.go:161 doesn't match the argument at index 2.
        Got: operation type DELETE on Azure resource test-group/test-group is not done. Object will be requeued after 15s (azure.ReconcileError)
        Want: error.Error() "transient reconcile error occurred: operation type DELETE on Azure resource test-group/test-group is not done. Object will be requeued after 15s", but got "operation type DELETE on Azure resource test-group/test-group is not done. Object will be requeued after 15s"
    controller.go:269: missing call(s) to *mock_groups.MockGroupScope.UpdateDeleteStatus(is equal to ResourceGroupReady (v1beta1.ConditionType), is equal to group (string), error.Error() "transient reconcile error occurred: operation type DELETE on Azure resource test-group/test-group is not done. Object will be requeued after 15s", but got "operation type DELETE on Azure resource test-group/test-group is not done. Object will be requeued after 15s") /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/azure/services/groups/groups_test.go:161
    controller.go:269: aborting test due to missing call(s)
I1018 20:09:24.832962   12918 async.go:121]  "msg"="deleting resource"  "resource"="test-group" "resourceGroup"="test-group" "service"="group"
--- FAIL: TestDeleteGroups (0.00s)
    --- PASS: TestDeleteGroups/long_running_delete_operation_is_done (0.00s)
    --- PASS: TestDeleteGroups/resource_group_doesn't_exist (0.00s)
    --- PASS: TestDeleteGroups/delete_the_resource_group_successfully (0.00s)
    --- PASS: TestDeleteGroups/fail_to_check_if_resource_group_is_managed (0.00s)
    --- PASS: TestDeleteGroups/resource_group_is_not_managed_by_capz (0.00s)
    --- FAIL: TestDeleteGroups/context_deadline_exceeded_while_deleting_resource_group (0.00s)
    --- FAIL: TestDeleteGroups/long_running_delete_operation_is_not_done (0.00s)
    --- PASS: TestDeleteGroups/error_occurs_when_deleting_resource_group (0.00s)
FAIL
coverage: 37.5% of statements
FAIL	sigs.k8s.io/cluster-api-provider-azure/azure/services/groups	0.071s
?   	sigs.k8s.io/cluster-api-provider-azure/azure/services/groups/mock_groups	[no test files]
=== RUN   TestReconcileInboundNATRule
=== RUN   TestReconcileInboundNATRule/NAT_rule_successfully_created
=== PAUSE TestReconcileInboundNATRule/NAT_rule_successfully_created
=== RUN   TestReconcileInboundNATRule/fail_to_get_LB
=== PAUSE TestReconcileInboundNATRule/fail_to_get_LB
... skipping 158 lines ...
    managedclusters_test.go:86: Testing managedcluster provision state: Canceled
=== RUN   TestReconcile/managedcluster_in_terminal_provisioning_state
=== CONT  TestReconcile
    managedclusters_test.go:86: Testing managedcluster provision state: Succeeded
=== RUN   TestReconcile/managedcluster_in_terminal_provisioning_state#01
=== CONT  TestReconcile
    managedclusters_test.go:86: Testing managedcluster provision state: Failed
=== RUN   TestReconcile/managedcluster_in_terminal_provisioning_state#02
=== CONT  TestReconcile
    managedclusters_test.go:86: Testing managedcluster provision state: Deleting
=== RUN   TestReconcile/managedcluster_in_nonterminal_provisioning_state
=== CONT  TestReconcile
    managedclusters_test.go:86: Testing managedcluster provision state: InProgress
... skipping 498 lines ...
=== PAUSE TestGetExistingVMSS/scale_set_not_found
=== RUN   TestGetExistingVMSS/get_existing_vmss
=== PAUSE TestGetExistingVMSS/get_existing_vmss
=== RUN   TestGetExistingVMSS/list_instances_fails
=== PAUSE TestGetExistingVMSS/list_instances_fails
=== CONT  TestGetExistingVMSS/scale_set_not_found
    scalesets_test.go:215: failed to get existing vmss: #: Not found: StatusCode=404
=== CONT  TestGetExistingVMSS/list_instances_fails
    scalesets_test.go:215: failed to list instances: #: Not found: StatusCode=404
=== CONT  TestGetExistingVMSS/get_existing_vmss
--- PASS: TestGetExistingVMSS (0.00s)
    --- PASS: TestGetExistingVMSS/scale_set_not_found (0.00s)
    --- PASS: TestGetExistingVMSS/list_instances_fails (0.00s)
    --- PASS: TestGetExistingVMSS/get_existing_vmss (0.00s)
=== RUN   TestReconcileVMSS
... skipping 403 lines ...
I1018 20:09:39.468415   14109 async.go:58]  "msg"="long running operation is still ongoing"  "resource"="test-vm" "service"="virtualmachine"
=== CONT  TestDeleteVM/context_deadline_exceeded_while_deleting_vm
=== CONT  TestDeleteVM/long_running_delete_operation_is_not_done
    virtualmachines.go:125: Unexpected call to *mock_virtualmachines.MockVMScope.UpdateDeleteStatus([VMRunning virtualmachine operation type DELETE on Azure resource test-group/test-vm is not done. Object will be requeued after 15s]) at /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/azure/services/virtualmachines/virtualmachines.go:125 because: 
        expected call at /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/azure/services/virtualmachines/virtualmachines_test.go:210 doesn't match the argument at index 2.
        Got: operation type DELETE on Azure resource test-group/test-vm is not done. Object will be requeued after 15s (azure.ReconcileError)
        Want: error.Error() "transient reconcile error occurred: operation type DELETE on Azure resource test-group/test-vm is not done. Object will be requeued after 15s", but got "operation type DELETE on Azure resource test-group/test-vm is not done. Object will be requeued after 15s"
I1018 20:09:39.468586   14109 async.go:121]  "msg"="deleting resource"  "resource"="test-vm" "resourceGroup"="test-group" "service"="virtualmachine"
    controller.go:269: missing call(s) to *mock_virtualmachines.MockVMScope.UpdateDeleteStatus(is equal to VMRunning (v1beta1.ConditionType), is equal to virtualmachine (string), error.Error() "transient reconcile error occurred: operation type DELETE on Azure resource test-group/test-vm is not done. Object will be requeued after 15s", but got "operation type DELETE on Azure resource test-group/test-vm is not done. Object will be requeued after 15s") /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/azure/services/virtualmachines/virtualmachines_test.go:210
    controller.go:269: aborting test due to missing call(s)
=== CONT  TestDeleteVM/context_deadline_exceeded_while_deleting_vm
    virtualmachines.go:125: Unexpected call to *mock_virtualmachines.MockVMScope.UpdateDeleteStatus([VMRunning virtualmachine operation type DELETE on Azure resource test-group/test-vm is not done. Object will be requeued after 15s]) at /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/azure/services/virtualmachines/virtualmachines.go:125 because: 
        expected call at /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/azure/services/virtualmachines/virtualmachines_test.go:247 doesn't match the argument at index 2.
        Got: operation type DELETE on Azure resource test-group/test-vm is not done. Object will be requeued after 15s (azure.ReconcileError)
        Want: error.Error() "transient reconcile error occurred: operation type DELETE on Azure resource test-group/test-vm is not done. Object will be requeued after 15s", but got "operation type DELETE on Azure resource test-group/test-vm is not done. Object will be requeued after 15s"
    controller.go:269: missing call(s) to *mock_virtualmachines.MockVMScope.UpdateDeleteStatus(is equal to VMRunning (v1beta1.ConditionType), is equal to virtualmachine (string), error.Error() "transient reconcile error occurred: operation type DELETE on Azure resource test-group/test-vm is not done. Object will be requeued after 15s", but got "operation type DELETE on Azure resource test-group/test-vm is not done. Object will be requeued after 15s") /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/azure/services/virtualmachines/virtualmachines_test.go:247
    controller.go:269: aborting test due to missing call(s)
--- FAIL: TestDeleteVM (0.00s)
    --- PASS: TestDeleteVM/long_running_delete_operation_is_done (0.00s)
    --- PASS: TestDeleteVM/error_occurs_when_deleting_vm (0.00s)
    --- PASS: TestDeleteVM/vm_doesn't_exist (0.00s)
    --- PASS: TestDeleteVM/delete_the_vm_successfully (0.00s)
    --- FAIL: TestDeleteVM/long_running_delete_operation_is_not_done (0.00s)
    --- FAIL: TestDeleteVM/context_deadline_exceeded_while_deleting_vm (0.00s)
FAIL
coverage: 59.3% of statements
FAIL	sigs.k8s.io/cluster-api-provider-azure/azure/services/virtualmachines	0.129s
?   	sigs.k8s.io/cluster-api-provider-azure/azure/services/virtualmachines/mock_virtualmachines	[no test files]
=== RUN   TestReconcileVnet
=== RUN   TestReconcileVnet/managed_vnet_exists
=== PAUSE TestReconcileVnet/managed_vnet_exists
=== RUN   TestReconcileVnet/managed_ipv6_vnet_exists
=== PAUSE TestReconcileVnet/managed_ipv6_vnet_exists
... skipping 189 lines ...
I1018 20:09:42.619398   14708 vnetpeerings.go:95]  "msg"="deleting peering in vnets"  "and"="vnet2" "vnet1"="vnet1" "vnet2"=null
I1018 20:09:42.619440   14708 vnetpeerings.go:105]  "msg"="successfully deleted peering in vnet"  "peering"="vnet1-to-vnet2" "vnet"="vnet1"
I1018 20:09:42.619469   14708 vnetpeerings.go:95]  "msg"="deleting peering in vnets"  "and"="vnet2" "vnet1"=null
I1018 20:09:42.619504   14708 vnetpeerings.go:105]  "msg"="successfully deleted peering in vnet"  "peering"="vnet2-to-vnet1" "vnet"="vnet2"
I1018 20:09:42.619527   14708 vnetpeerings.go:95]  "msg"="deleting peering in vnets"  "and"="vnet2" "vnet1"="vnet1" "vnet3"=null

Expected error:	failed to delete peering vnet1-to-vnet3 in vnet vnet1 and resource group group1: #: Internal Server Error: StatusCode=500

Actual error:	failed to delete peering vnet1-to-vnet3 in vnet vnet1 and resource group group1: #: Internal Server Error: StatusCode=500
=== CONT  TestDeleteVnetPeerings/delete_multiple_peerings_on_one_vnet
I1018 20:09:42.619694   14708 vnetpeerings.go:95]  "msg"="deleting peering in vnets"  "and"="vnet2" "vnet1"="vnet1" "vnet2"=null
I1018 20:09:42.619719   14708 vnetpeerings.go:105]  "msg"="successfully deleted peering in vnet"  "peering"="vnet1-to-vnet2" "vnet"="vnet1"
I1018 20:09:42.619738   14708 vnetpeerings.go:95]  "msg"="deleting peering in vnets"  "and"="vnet2" "vnet1"=null
I1018 20:09:42.619759   14708 vnetpeerings.go:105]  "msg"="successfully deleted peering in vnet"  "peering"="vnet2-to-vnet1" "vnet"="vnet2"
I1018 20:09:42.619776   14708 vnetpeerings.go:95]  "msg"="deleting peering in vnets"  "and"="vnet2" "vnet1"="vnet1" "vnet3"=null
... skipping 80 lines ...
    --- PASS: TestAzureJSONTemplateReconciler/missing_azure_cluster_should_return_error (0.00s)
=== RUN   TestConditions
=== RUN   TestConditions/cluster_infrastructure_is_not_ready_yet
I1018 20:09:49.031071   15670 azuremachine_controller.go:264]  "msg"="Reconciling AzureMachine"  
=== CONT  TestConditions
    azuremachine_controller_test.go:186: 
        Unexpected error:
            <*errors.withStack | 0xc00000eed0>: {
                error: <*errors.withMessage | 0xc0006bfb40>{
                    cause: <*errors.withStack | 0xc00000ee70>{
                        error: <*errors.withMessage | 0xc0006bfb00>{
                            cause: <*errors.fundamental | 0xc00000ee40>{
                                msg: "a subnet name must be specified when no subnets are specified or more than 1 subnet of the same role exist",
                                stack: [0x196c21b, 0x1b54be5, 0x1b528d3, 0x1b64b4c, 0x524eaf, 0x474421],
                            },
                            msg: "failed defaulting subnet name",
                        },
                        stack: [0x1b551e7, 0x1b528d3, 0x1b64b4c, 0x524eaf, 0x474421],
                    },
                    msg: "failed to reconcile AzureMachine",
                },
                stack: [0x1b52e65, 0x1b64b4c, 0x524eaf, 0x474421],
            }
            failed to reconcile AzureMachine: failed defaulting subnet name: a subnet name must be specified when no subnets are specified or more than 1 subnet of the same role exist
        occurred
=== CONT  TestConditions/cluster_infrastructure_is_not_ready_yet
    testing.go:1103: test executed panic(nil) or runtime.Goexit: subtest may have called FailNow on a parent test
--- FAIL: TestConditions (0.03s)
    --- FAIL: TestConditions/cluster_infrastructure_is_not_ready_yet (0.03s)
=== RUN   TestAzureClusterToAzureMachinesMapper
--- PASS: TestAzureClusterToAzureMachinesMapper (0.01s)
=== RUN   TestGetCloudProviderConfig
=== RUN   TestGetCloudProviderConfig/serviceprincipal
=== RUN   TestGetCloudProviderConfig/system-assigned-identity
=== RUN   TestGetCloudProviderConfig/user-assigned-identity
... skipping 138 lines ...
2021-10-18T20:10:02.623Z	DEBUG	events	Normal	{"object": {"kind":"AzureCluster","apiVersion":"infrastructure.cluster.x-k8s.io/v1beta1"}, "reason": "AzureClusterObjectNotFound", "message": "AzureCluster.infrastructure.cluster.x-k8s.io \"foo-7j2jwzp9v7\" not found"}
•2021-10-18T20:10:02.667Z	DEBUG	events	Normal	{"object": {"kind":"AzureCluster","namespace":"default","name":"foo-hpbmskgfqn","uid":"1b74adb4-608b-4ba0-9bf5-bdad3ab1ccfa","apiVersion":"infrastructure.cluster.x-k8s.io/v1beta1","resourceVersion":"227"}, "reason": "OwnerRefNotSet", "message": "Cluster Controller has not yet set OwnerRef"}
•2021-10-18T20:10:02.681Z	DEBUG	events	Normal	{"object": {"kind":"AzureCluster","apiVersion":"infrastructure.cluster.x-k8s.io/v1beta1"}, "reason": "AzureClusterObjectNotFound", "message": "AzureCluster.infrastructure.cluster.x-k8s.io \"foo-hpbmskgfqn\" not found"}
•

Ran 4 of 4 Specs in 16.694 seconds
SUCCESS! -- 4 Passed | 0 Failed | 0 Pending | 0 Skipped

You're using deprecated Ginkgo functionality:
=============================================
Ginkgo 2.0 is under active development and will introduce several new features, improvements, and a small handful of breaking changes.
A release candidate for 2.0 is now available and 2.0 should GA in Fall 2021.  Please give the RC a try and send us feedback!
  - To learn more, view the migration guide at https://github.com/onsi/ginkgo/blob/ver2/docs/MIGRATING_TO_V2.md
... skipping 9 lines ...
    /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/controllers/suite_test.go:49

To silence deprecations that can be silenced set the following environment variable:
  ACK_GINKGO_DEPRECATIONS=1.16.5

--- PASS: TestAPIs (16.70s)
FAIL
coverage: 38.3% of statements
FAIL	sigs.k8s.io/cluster-api-provider-azure/controllers	16.948s
?   	sigs.k8s.io/cluster-api-provider-azure/exp	[no test files]
=== RUN   TestFuzzyConversion
=== RUN   TestFuzzyConversion/for_AzureMachinePool
=== RUN   TestFuzzyConversion/for_AzureMachinePool/spoke-hub-spoke
=== RUN   TestFuzzyConversion/for_AzureMachinePool/hub-spoke-hub
=== RUN   TestFuzzyConversion/for_AzureManagedCluster
... skipping 349 lines ...
Random Seed: 1634587789
Will run 2 of 2 specs

••

Ran 2 of 2 Specs in 15.925 seconds
SUCCESS! -- 2 Passed | 0 Failed | 0 Pending | 0 Skipped

You're using deprecated Ginkgo functionality:
=============================================
Ginkgo 2.0 is under active development and will introduce several new features, improvements, and a small handful of breaking changes.
A release candidate for 2.0 is now available and 2.0 should GA in Fall 2021.  Please give the RC a try and send us feedback!
  - To learn more, view the migration guide at https://github.com/onsi/ginkgo/blob/ver2/docs/MIGRATING_TO_V2.md
... skipping 144 lines ...
PASS
coverage: 100.0% of statements
ok  	sigs.k8s.io/cluster-api-provider-azure/util/system	0.014s	coverage: 100.0% of statements
?   	sigs.k8s.io/cluster-api-provider-azure/util/tele	[no test files]
?   	sigs.k8s.io/cluster-api-provider-azure/util/webhook	[no test files]
?   	sigs.k8s.io/cluster-api-provider-azure/version	[no test files]
FAIL
make: *** [Makefile:167: test-cover] Error 1
go: downloading github.com/spf13/cobra v1.2.1
go: downloading golang.org/x/tools v0.1.5
+ EXIT_VALUE=2
+ set +o xtrace