Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Improve recorded test logging #1571

Merged
merged 4 commits into from
Jun 21, 2021
Merged

Conversation

matthchr
Copy link
Member

Closes #1431

What this PR does / why we need it:

  • Only see logs for tests that fail.
  • When tests do fail, you get much more verbose logs including HTTP responses, which should help to diagnose issues
  • Test logs are no longer interleaved between tests (each tests logs are cleanly separated)

@matthchr
Copy link
Member Author

Here's an example of an output with 2 failing tests:

vscode ➜ /go/src (feature/test-logs ✗) $ task controller:test-integration-envtest
task: Task "generator:build" is up to date
task: Task "controller:generate-types" is up to date
task: Task "controller:generate-crds" is up to date
task: go test -run '.*' ./...
[controller:test-integration-envtest] ?   	github.com/Azure/azure-service-operator/hack/generated	[no test files]
[controller:test-integration-envtest] 2021/06/16 23:11:14 Running test setup
[controller:test-integration-envtest] 2021/06/16 23:11:14 Done with test setup
[controller:test-integration-envtest] 2021/06/16 23:11:21 http: TLS handshake error from 127.0.0.1:56334: EOF
[controller:test-integration-envtest] 2021/06/16 23:11:22 http: TLS handshake error from 127.0.0.1:41378: EOF
[controller:test-integration-envtest] 2021/06/16 23:11:23 http: TLS handshake error from 127.0.0.1:41282: EOF
[controller:test-integration-envtest] 2021/06/16 23:11:24 http: TLS handshake error from 127.0.0.1:50280: EOF
[controller:test-integration-envtest] 2021/06/16 23:11:24 http: TLS handshake error from 127.0.0.1:46886: EOF
[controller:test-integration-envtest] 2021/06/16 23:11:25 http: TLS handshake error from 127.0.0.1:55064: EOF
[controller:test-integration-envtest] 2021/06/16 23:11:39 http: TLS handshake error from 127.0.0.1:40278: EOF
[controller:test-integration-envtest] E0616 23:11:41.333556   14344 event.go:269] Unable to write event: 'Post "http://127.0.0.1:41053/api/v1/namespaces/aso-test-ns/events": dial tcp 127.0.0.1:41053: connect: connection refused' (may retry after sleeping)
[controller:test-integration-envtest] 2021/06/16 23:11:42 http: TLS handshake error from 127.0.0.1:38592: EOF
[controller:test-integration-envtest] E0616 23:11:43.179084   14344 event.go:269] Unable to write event: 'Post "http://127.0.0.1:41053/api/v1/namespaces/aso-test-ns/events": dial tcp 127.0.0.1:41053: connect: connection refused' (may retry after sleeping)
[controller:test-integration-envtest] E0616 23:11:46.720814   14344 event.go:269] Unable to write event: 'Post "http://127.0.0.1:37905/api/v1/namespaces/aso-test-ns/events": dial tcp 127.0.0.1:37905: connect: connection refused' (may retry after sleeping)
[controller:test-integration-envtest] --- FAIL: Test_CosmosDB_CRUD (32.48s)
[controller:test-integration-envtest]     kube_test_context_envtest.go:27: Creating envtest test: Test_CosmosDB_CRUD
[controller:test-integration-envtest]     kube_test_context_envtest.go:41: Starting envtest
[controller:test-integration-envtest]     kube_test_context_envtest.go:55: Creating & starting controller-runtime manager
[controller:test-integration-envtest]     kube_test_context_envtest.go:69: Minimizing requeue delay
[controller:test-integration-envtest]     generic_controller.go:125: I2021-06-16T23:11:24Z] "msg"="Registering" GVK="microsoft.batch.infra.azure.com/v1alpha1api20210101, Kind=BatchAccount"
[controller:test-integration-envtest]     generic_controller.go:125: I2021-06-16T23:11:24Z] "msg"="Registering" GVK="microsoft.documentdb.infra.azure.com/v1alpha1api20210515, Kind=DatabaseAccount"
[controller:test-integration-envtest]     generic_controller.go:125: I2021-06-16T23:11:24Z] "msg"="Registering" GVK="microsoft.network.infra.azure.com/v1alpha1api20201101, Kind=LoadBalancer"
[controller:test-integration-envtest]     generic_controller.go:125: I2021-06-16T23:11:24Z] "msg"="Registering" GVK="microsoft.network.infra.azure.com/v1alpha1api20201101, Kind=PublicIPAddresses"
[controller:test-integration-envtest]     generic_controller.go:125: I2021-06-16T23:11:24Z] "msg"="Registering" GVK="microsoft.network.infra.azure.com/v1alpha1api20201101, Kind=VirtualNetwork"
[controller:test-integration-envtest]     generic_controller.go:125: I2021-06-16T23:11:24Z] "msg"="Registering" GVK="microsoft.network.infra.azure.com/v1alpha1api20201101, Kind=VirtualNetworkGateway"
[controller:test-integration-envtest]     generic_controller.go:125: I2021-06-16T23:11:24Z] "msg"="Registering" GVK="microsoft.network.infra.azure.com/v1alpha1api20201101, Kind=VirtualNetworkTap"
[controller:test-integration-envtest]     generic_controller.go:125: I2021-06-16T23:11:24Z] "msg"="Registering" GVK="microsoft.network.infra.azure.com/v1alpha1api20201101, Kind=VirtualNetworksSubnet"
[controller:test-integration-envtest]     generic_controller.go:125: I2021-06-16T23:11:24Z] "msg"="Registering" GVK="microsoft.network.infra.azure.com/v1alpha1api20201101, Kind=VirtualNetworksVirtualNetworkPeering"
[controller:test-integration-envtest]     generic_controller.go:125: I2021-06-16T23:11:24Z] "msg"="Registering" GVK="microsoft.servicebus.infra.azure.com/v1alpha1api20180101preview, Kind=NamespacesQueue"
[controller:test-integration-envtest]     generic_controller.go:125: I2021-06-16T23:11:24Z] "msg"="Registering" GVK="microsoft.servicebus.infra.azure.com/v1alpha1api20180101preview, Kind=NamespacesTopic"
[controller:test-integration-envtest]     generic_controller.go:125: I2021-06-16T23:11:24Z] "msg"="Registering" GVK="microsoft.servicebus.infra.azure.com/v1alpha1api20210101preview, Kind=Namespace"
[controller:test-integration-envtest]     generic_controller.go:125: I2021-06-16T23:11:24Z] "msg"="Registering" GVK="microsoft.storage.infra.azure.com/v1alpha1api20210401, Kind=StorageAccount"
[controller:test-integration-envtest]     generic_controller.go:125: I2021-06-16T23:11:24Z] "msg"="Registering" GVK="microsoft.storage.infra.azure.com/v1alpha1api20210401, Kind=StorageAccountsBlobService"
[controller:test-integration-envtest]     generic_controller.go:125: I2021-06-16T23:11:24Z] "msg"="Registering" GVK="microsoft.storage.infra.azure.com/v1alpha1api20210401, Kind=StorageAccountsBlobServicesContainer"
[controller:test-integration-envtest]     generic_controller.go:125: I2021-06-16T23:11:24Z] "msg"="Registering" GVK="microsoft.resources.infra.azure.com/v1alpha1api20200601, Kind=ResourceGroup"
[controller:test-integration-envtest]     kube_test_context_envtest.go:127: Checking for webhooks at: 127.0.0.1:34269
[controller:test-integration-envtest]     kube_test_context_envtest.go:136: Webhooks available at: 127.0.0.1:34269
[controller:test-integration-envtest]     kube_test_context_envtest.go:115: Webhook server running at: :34269
[controller:test-integration-envtest]     kube_per_test_context.go:168: Creating test resource group "asotest-rg-dnhfns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:456: I2021-06-16T23:11:26Z] ResourceGroupController "msg"="Starting new deployment to Azure" name="asotest-rg-dnhfns" namespace="aso-test-ns" action="BeginDeployment"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:474: I2021-06-16T23:11:26Z] ResourceGroupController "msg"="Created deployment in Azure" name="asotest-rg-dnhfns" namespace="aso-test-ns" id="/subscriptions/00000000-0000-0000-0000-000000000000/providers/Microsoft.Resources/deployments/k8s_c632b53e-9769-5df6-8d16-acec3730fb8a"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:321: I2021-06-16T23:11:26Z] ResourceGroupController "msg"="Have existing deployment ID, will monitor it" name="asotest-rg-dnhfns" namespace="aso-test-ns" deploymentID="/subscriptions/00000000-0000-0000-0000-000000000000/providers/Microsoft.Resources/deployments/k8s_c632b53e-9769-5df6-8d16-acec3730fb8a"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:552: I2021-06-16T23:11:26Z] ResourceGroupController "msg"="Monitoring deployment" name="asotest-rg-dnhfns" namespace="aso-test-ns" action="MonitorDeployment" id="/subscriptions/00000000-0000-0000-0000-000000000000/providers/Microsoft.Resources/deployments/k8s_c632b53e-9769-5df6-8d16-acec3730fb8a" state="Accepted"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:590: I2021-06-16T23:11:26Z] ResourceGroupController "msg"="Deployment still running" name="asotest-rg-dnhfns" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:321: I2021-06-16T23:11:26Z] ResourceGroupController "msg"="Have existing deployment ID, will monitor it" name="asotest-rg-dnhfns" namespace="aso-test-ns" deploymentID="/subscriptions/00000000-0000-0000-0000-000000000000/providers/Microsoft.Resources/deployments/k8s_c632b53e-9769-5df6-8d16-acec3730fb8a"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:667: I2021-06-16T23:11:26Z] ResourceGroupController "msg"="Got ARM status" name="asotest-rg-dnhfns" namespace="aso-test-ns" status="{\"id\":\"/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-dnhfns\",\"name\":\"asotest-rg-dnhfns\",\"location\":\"westus\",\"tags\":{\"CreatedAt\":\"2001-02-03T04:05:06Z\"},\"properties\":{\"provisioningState\":\"Succeeded\"}}"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:552: I2021-06-16T23:11:26Z] ResourceGroupController "msg"="Monitoring deployment" name="asotest-rg-dnhfns" namespace="aso-test-ns" action="MonitorDeployment" id="/subscriptions/00000000-0000-0000-0000-000000000000/providers/Microsoft.Resources/deployments/k8s_c632b53e-9769-5df6-8d16-acec3730fb8a" state="Succeeded"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:560: I2021-06-16T23:11:26Z] ResourceGroupController "msg"="Deleting deployment" name="asotest-rg-dnhfns" namespace="aso-test-ns" ID="/subscriptions/00000000-0000-0000-0000-000000000000/providers/Microsoft.Resources/deployments/k8s_c632b53e-9769-5df6-8d16-acec3730fb8a"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:312: I2021-06-16T23:11:26Z] ResourceGroupController "msg"="resource spec has not changed and resource is in terminal state: "Succeeded"" name="asotest-rg-dnhfns" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:595: I2021-06-16T23:11:31Z] DatabaseAccountController "msg"="applying ownership" name="asotestdbhmayhx" namespace="aso-test-ns" action="ManageOwnership"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:819: I2021-06-16T23:11:31Z] DatabaseAccountController "msg"="Set owner reference" name="asotestdbhmayhx" namespace="aso-test-ns" ownerGvk="microsoft.resources.infra.azure.com/v1alpha1api20200601, Kind=ResourceGroup" ownerName="asotest-rg-dnhfns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:456: I2021-06-16T23:11:31Z] DatabaseAccountController "msg"="Starting new deployment to Azure" name="asotestdbhmayhx" namespace="aso-test-ns" action="BeginDeployment"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:474: I2021-06-16T23:11:31Z] DatabaseAccountController "msg"="Created deployment in Azure" name="asotestdbhmayhx" namespace="aso-test-ns" id="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-dnhfns/providers/Microsoft.Resources/deployments/k8s_f9f7e648-5320-5c32-8775-febefed1fa3a"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:321: I2021-06-16T23:11:31Z] DatabaseAccountController "msg"="Have existing deployment ID, will monitor it" name="asotestdbhmayhx" namespace="aso-test-ns" deploymentID="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-dnhfns/providers/Microsoft.Resources/deployments/k8s_f9f7e648-5320-5c32-8775-febefed1fa3a"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:552: I2021-06-16T23:11:31Z] DatabaseAccountController "msg"="Monitoring deployment" name="asotestdbhmayhx" namespace="aso-test-ns" action="MonitorDeployment" id="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-dnhfns/providers/Microsoft.Resources/deployments/k8s_f9f7e648-5320-5c32-8775-febefed1fa3a" state="Accepted"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:590: I2021-06-16T23:11:31Z] DatabaseAccountController "msg"="Deployment still running" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:321: I2021-06-16T23:11:31Z] DatabaseAccountController "msg"="Have existing deployment ID, will monitor it" name="asotestdbhmayhx" namespace="aso-test-ns" deploymentID="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-dnhfns/providers/Microsoft.Resources/deployments/k8s_f9f7e648-5320-5c32-8775-febefed1fa3a"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:552: I2021-06-16T23:11:31Z] DatabaseAccountController "msg"="Monitoring deployment" name="asotestdbhmayhx" namespace="aso-test-ns" action="MonitorDeployment" id="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-dnhfns/providers/Microsoft.Resources/deployments/k8s_f9f7e648-5320-5c32-8775-febefed1fa3a" state="Running"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:590: I2021-06-16T23:11:31Z] DatabaseAccountController "msg"="Deployment still running" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:321: I2021-06-16T23:11:31Z] DatabaseAccountController "msg"="Have existing deployment ID, will monitor it" name="asotestdbhmayhx" namespace="aso-test-ns" deploymentID="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-dnhfns/providers/Microsoft.Resources/deployments/k8s_f9f7e648-5320-5c32-8775-febefed1fa3a"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:552: I2021-06-16T23:11:31Z] DatabaseAccountController "msg"="Monitoring deployment" name="asotestdbhmayhx" namespace="aso-test-ns" action="MonitorDeployment" id="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-dnhfns/providers/Microsoft.Resources/deployments/k8s_f9f7e648-5320-5c32-8775-febefed1fa3a" state="Running"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:590: I2021-06-16T23:11:31Z] DatabaseAccountController "msg"="Deployment still running" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:321: I2021-06-16T23:11:31Z] DatabaseAccountController "msg"="Have existing deployment ID, will monitor it" name="asotestdbhmayhx" namespace="aso-test-ns" deploymentID="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-dnhfns/providers/Microsoft.Resources/deployments/k8s_f9f7e648-5320-5c32-8775-febefed1fa3a"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:552: I2021-06-16T23:11:31Z] DatabaseAccountController "msg"="Monitoring deployment" name="asotestdbhmayhx" namespace="aso-test-ns" action="MonitorDeployment" id="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-dnhfns/providers/Microsoft.Resources/deployments/k8s_f9f7e648-5320-5c32-8775-febefed1fa3a" state="Running"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:590: I2021-06-16T23:11:31Z] DatabaseAccountController "msg"="Deployment still running" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:321: I2021-06-16T23:11:31Z] DatabaseAccountController "msg"="Have existing deployment ID, will monitor it" name="asotestdbhmayhx" namespace="aso-test-ns" deploymentID="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-dnhfns/providers/Microsoft.Resources/deployments/k8s_f9f7e648-5320-5c32-8775-febefed1fa3a"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:552: I2021-06-16T23:11:31Z] DatabaseAccountController "msg"="Monitoring deployment" name="asotestdbhmayhx" namespace="aso-test-ns" action="MonitorDeployment" id="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-dnhfns/providers/Microsoft.Resources/deployments/k8s_f9f7e648-5320-5c32-8775-febefed1fa3a" state="Running"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:590: I2021-06-16T23:11:31Z] DatabaseAccountController "msg"="Deployment still running" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:321: I2021-06-16T23:11:32Z] DatabaseAccountController "msg"="Have existing deployment ID, will monitor it" name="asotestdbhmayhx" namespace="aso-test-ns" deploymentID="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-dnhfns/providers/Microsoft.Resources/deployments/k8s_f9f7e648-5320-5c32-8775-febefed1fa3a"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:552: I2021-06-16T23:11:32Z] DatabaseAccountController "msg"="Monitoring deployment" name="asotestdbhmayhx" namespace="aso-test-ns" action="MonitorDeployment" id="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-dnhfns/providers/Microsoft.Resources/deployments/k8s_f9f7e648-5320-5c32-8775-febefed1fa3a" state="Running"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:590: I2021-06-16T23:11:32Z] DatabaseAccountController "msg"="Deployment still running" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:321: I2021-06-16T23:11:32Z] DatabaseAccountController "msg"="Have existing deployment ID, will monitor it" name="asotestdbhmayhx" namespace="aso-test-ns" deploymentID="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-dnhfns/providers/Microsoft.Resources/deployments/k8s_f9f7e648-5320-5c32-8775-febefed1fa3a"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:552: I2021-06-16T23:11:32Z] DatabaseAccountController "msg"="Monitoring deployment" name="asotestdbhmayhx" namespace="aso-test-ns" action="MonitorDeployment" id="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-dnhfns/providers/Microsoft.Resources/deployments/k8s_f9f7e648-5320-5c32-8775-febefed1fa3a" state="Running"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:590: I2021-06-16T23:11:32Z] DatabaseAccountController "msg"="Deployment still running" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:321: I2021-06-16T23:11:32Z] DatabaseAccountController "msg"="Have existing deployment ID, will monitor it" name="asotestdbhmayhx" namespace="aso-test-ns" deploymentID="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-dnhfns/providers/Microsoft.Resources/deployments/k8s_f9f7e648-5320-5c32-8775-febefed1fa3a"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:552: I2021-06-16T23:11:32Z] DatabaseAccountController "msg"="Monitoring deployment" name="asotestdbhmayhx" namespace="aso-test-ns" action="MonitorDeployment" id="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-dnhfns/providers/Microsoft.Resources/deployments/k8s_f9f7e648-5320-5c32-8775-febefed1fa3a" state="Running"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:590: I2021-06-16T23:11:32Z] DatabaseAccountController "msg"="Deployment still running" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:321: I2021-06-16T23:11:32Z] DatabaseAccountController "msg"="Have existing deployment ID, will monitor it" name="asotestdbhmayhx" namespace="aso-test-ns" deploymentID="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-dnhfns/providers/Microsoft.Resources/deployments/k8s_f9f7e648-5320-5c32-8775-febefed1fa3a"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:552: I2021-06-16T23:11:32Z] DatabaseAccountController "msg"="Monitoring deployment" name="asotestdbhmayhx" namespace="aso-test-ns" action="MonitorDeployment" id="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-dnhfns/providers/Microsoft.Resources/deployments/k8s_f9f7e648-5320-5c32-8775-febefed1fa3a" state="Running"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:590: I2021-06-16T23:11:32Z] DatabaseAccountController "msg"="Deployment still running" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:321: I2021-06-16T23:11:32Z] DatabaseAccountController "msg"="Have existing deployment ID, will monitor it" name="asotestdbhmayhx" namespace="aso-test-ns" deploymentID="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-dnhfns/providers/Microsoft.Resources/deployments/k8s_f9f7e648-5320-5c32-8775-febefed1fa3a"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:552: I2021-06-16T23:11:32Z] DatabaseAccountController "msg"="Monitoring deployment" name="asotestdbhmayhx" namespace="aso-test-ns" action="MonitorDeployment" id="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-dnhfns/providers/Microsoft.Resources/deployments/k8s_f9f7e648-5320-5c32-8775-febefed1fa3a" state="Running"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:590: I2021-06-16T23:11:32Z] DatabaseAccountController "msg"="Deployment still running" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:321: I2021-06-16T23:11:32Z] DatabaseAccountController "msg"="Have existing deployment ID, will monitor it" name="asotestdbhmayhx" namespace="aso-test-ns" deploymentID="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-dnhfns/providers/Microsoft.Resources/deployments/k8s_f9f7e648-5320-5c32-8775-febefed1fa3a"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:552: I2021-06-16T23:11:32Z] DatabaseAccountController "msg"="Monitoring deployment" name="asotestdbhmayhx" namespace="aso-test-ns" action="MonitorDeployment" id="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-dnhfns/providers/Microsoft.Resources/deployments/k8s_f9f7e648-5320-5c32-8775-febefed1fa3a" state="Running"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:590: I2021-06-16T23:11:32Z] DatabaseAccountController "msg"="Deployment still running" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:321: I2021-06-16T23:11:32Z] DatabaseAccountController "msg"="Have existing deployment ID, will monitor it" name="asotestdbhmayhx" namespace="aso-test-ns" deploymentID="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-dnhfns/providers/Microsoft.Resources/deployments/k8s_f9f7e648-5320-5c32-8775-febefed1fa3a"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:552: I2021-06-16T23:11:32Z] DatabaseAccountController "msg"="Monitoring deployment" name="asotestdbhmayhx" namespace="aso-test-ns" action="MonitorDeployment" id="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-dnhfns/providers/Microsoft.Resources/deployments/k8s_f9f7e648-5320-5c32-8775-febefed1fa3a" state="Running"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:590: I2021-06-16T23:11:32Z] DatabaseAccountController "msg"="Deployment still running" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:321: I2021-06-16T23:11:32Z] DatabaseAccountController "msg"="Have existing deployment ID, will monitor it" name="asotestdbhmayhx" namespace="aso-test-ns" deploymentID="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-dnhfns/providers/Microsoft.Resources/deployments/k8s_f9f7e648-5320-5c32-8775-febefed1fa3a"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:552: I2021-06-16T23:11:32Z] DatabaseAccountController "msg"="Monitoring deployment" name="asotestdbhmayhx" namespace="aso-test-ns" action="MonitorDeployment" id="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-dnhfns/providers/Microsoft.Resources/deployments/k8s_f9f7e648-5320-5c32-8775-febefed1fa3a" state="Running"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:590: I2021-06-16T23:11:32Z] DatabaseAccountController "msg"="Deployment still running" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:321: I2021-06-16T23:11:32Z] DatabaseAccountController "msg"="Have existing deployment ID, will monitor it" name="asotestdbhmayhx" namespace="aso-test-ns" deploymentID="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-dnhfns/providers/Microsoft.Resources/deployments/k8s_f9f7e648-5320-5c32-8775-febefed1fa3a"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:552: I2021-06-16T23:11:32Z] DatabaseAccountController "msg"="Monitoring deployment" name="asotestdbhmayhx" namespace="aso-test-ns" action="MonitorDeployment" id="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-dnhfns/providers/Microsoft.Resources/deployments/k8s_f9f7e648-5320-5c32-8775-febefed1fa3a" state="Running"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:590: I2021-06-16T23:11:32Z] DatabaseAccountController "msg"="Deployment still running" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:321: I2021-06-16T23:11:32Z] DatabaseAccountController "msg"="Have existing deployment ID, will monitor it" name="asotestdbhmayhx" namespace="aso-test-ns" deploymentID="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-dnhfns/providers/Microsoft.Resources/deployments/k8s_f9f7e648-5320-5c32-8775-febefed1fa3a"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:552: I2021-06-16T23:11:32Z] DatabaseAccountController "msg"="Monitoring deployment" name="asotestdbhmayhx" namespace="aso-test-ns" action="MonitorDeployment" id="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-dnhfns/providers/Microsoft.Resources/deployments/k8s_f9f7e648-5320-5c32-8775-febefed1fa3a" state="Running"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:590: I2021-06-16T23:11:32Z] DatabaseAccountController "msg"="Deployment still running" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:321: I2021-06-16T23:11:33Z] DatabaseAccountController "msg"="Have existing deployment ID, will monitor it" name="asotestdbhmayhx" namespace="aso-test-ns" deploymentID="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-dnhfns/providers/Microsoft.Resources/deployments/k8s_f9f7e648-5320-5c32-8775-febefed1fa3a"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:552: I2021-06-16T23:11:33Z] DatabaseAccountController "msg"="Monitoring deployment" name="asotestdbhmayhx" namespace="aso-test-ns" action="MonitorDeployment" id="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-dnhfns/providers/Microsoft.Resources/deployments/k8s_f9f7e648-5320-5c32-8775-febefed1fa3a" state="Running"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:590: I2021-06-16T23:11:33Z] DatabaseAccountController "msg"="Deployment still running" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:321: I2021-06-16T23:11:33Z] DatabaseAccountController "msg"="Have existing deployment ID, will monitor it" name="asotestdbhmayhx" namespace="aso-test-ns" deploymentID="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-dnhfns/providers/Microsoft.Resources/deployments/k8s_f9f7e648-5320-5c32-8775-febefed1fa3a"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:667: I2021-06-16T23:11:33Z] DatabaseAccountController "msg"="Got ARM status" name="asotestdbhmayhx" namespace="aso-test-ns" status="{\"id\":\"/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-dnhfns/providers/Microsoft.DocumentDB/databaseAccounts/asotestdbhmayhx\",\"identity\":{\"type\":\"None\"},\"kind\":\"GlobalDocumentDB\",\"location\":\"West US\",\"name\":\"asotestdbhmayhx\",\"properties\":{\"analyticalStorageConfiguration\":{},\"backupPolicy\":{\"type\":\"Periodic\"},\"consistencyPolicy\":{\"defaultConsistencyLevel\":\"Session\",\"maxIntervalInSeconds\":5,\"maxStalenessPrefix\":100},\"databaseAccountOfferType\":\"Standard\",\"defaultIdentity\":\"FirstPartyIdentity\",\"disableKeyBasedMetadataWriteAccess\":false,\"documentEndpoint\":\"https://asotestdbhmayhx.documents.azure.com:443/\",\"enableAnalyticalStorage\":false,\"enableAutomaticFailover\":false,\"enableFreeTier\":false,\"enableMultipleWriteLocations\":false,\"failoverPolicies\":[{\"failoverPriority\":0,\"id\":\"asotestdbhmayhx-westus\",\"locationName\":\"West US\"}],\"isVirtualNetworkFilterEnabled\":false,\"locations\":[{\"documentEndpoint\":\"https://asotestdbhmayhx-westus.documents.azure.com:443/\",\"failoverPriority\":0,\"id\":\"asotestdbhmayhx-westus\",\"isZoneRedundant\":false,\"locationName\":\"West US\",\"provisioningState\":\"Succeeded\"}],\"networkAclBypass\":\"None\",\"provisioningState\":\"Succeeded\",\"publicNetworkAccess\":\"Enabled\",\"readLocations\":[{\"documentEndpoint\":\"https://asotestdbhmayhx-westus.documents.azure.com:443/\",\"failoverPriority\":0,\"id\":\"asotestdbhmayhx-westus\",\"isZoneRedundant\":false,\"locationName\":\"West US\",\"provisioningState\":\"Succeeded\"}],\"writeLocations\":[{\"documentEndpoint\":\"https://asotestdbhmayhx-westus.documents.azure.com:443/\",\"failoverPriority\":0,\"id\":\"asotestdbhmayhx-westus\",\"isZoneRedundant\":false,\"locationName\":\"West US\",\"provisioningState\":\"Succeeded\"}]},\"type\":\"Microsoft.DocumentDB/databaseAccounts\"}"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:552: I2021-06-16T23:11:33Z] DatabaseAccountController "msg"="Monitoring deployment" name="asotestdbhmayhx" namespace="aso-test-ns" action="MonitorDeployment" id="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-dnhfns/providers/Microsoft.Resources/deployments/k8s_f9f7e648-5320-5c32-8775-febefed1fa3a" state="Succeeded"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:560: I2021-06-16T23:11:33Z] DatabaseAccountController "msg"="Deleting deployment" name="asotestdbhmayhx" namespace="aso-test-ns" ID="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-dnhfns/providers/Microsoft.Resources/deployments/k8s_f9f7e648-5320-5c32-8775-febefed1fa3a"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:312: I2021-06-16T23:11:33Z] DatabaseAccountController "msg"="resource spec has not changed and resource is in terminal state: "Succeeded"" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:355: I2021-06-16T23:11:36Z] DatabaseAccountController "msg"="Starting delete of resource" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:407: I2021-06-16T23:11:36Z] DatabaseAccountController "msg"="Resource deletion started" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:36Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:36Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:36Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:36Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:36Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:36Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:36Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:36Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:37Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:37Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:37Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:37Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:37Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:37Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:37Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:37Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:37Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:37Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:37Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:37Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:37Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:37Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:37Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:37Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:37Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:37Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:37Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:37Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:38Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:38Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:38Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:38Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:38Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:38Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:38Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:38Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:38Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:38Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:38Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:38Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:38Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:38Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:38Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:38Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:38Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:38Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:38Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:38Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:39Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:39Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:39Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:39Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:39Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:39Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:39Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:39Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:39Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:39Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:39Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:39Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:39Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:39Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:39Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:39Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:39Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:39Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:39Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:39Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:40Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:40Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:40Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:40Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:40Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:40Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:40Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:40Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:40Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:40Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:40Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:40Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:40Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:40Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:40Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:40Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:40Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:40Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:41Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:41Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:41Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:41Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:41Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:41Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:41Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:41Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:41Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:41Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:41Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:41Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:41Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:41Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:41Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:41Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:41Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:41Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:41Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:41Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:42Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:42Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:42Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:42Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:42Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:42Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:42Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:42Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:42Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:42Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:42Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:42Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:42Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:42Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:42Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:42Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:42Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:42Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:42Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:42Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:43Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:43Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:43Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:43Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:43Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:43Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:43Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:43Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:43Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:43Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:43Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:43Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:43Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:43Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:43Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:43Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:43Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:43Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:43Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:43Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:44Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:44Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:44Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:44Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:44Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:44Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:44Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:44Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:44Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:44Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:44Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:44Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:44Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:44Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:44Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:44Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:44Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:44Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:44Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:44Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:45Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:45Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:45Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:45Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:45Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:45Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:45Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:45Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:45Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:45Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:45Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:45Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:45Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:45Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:45Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:45Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:45Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:45Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:45Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:45Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:46Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:46Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:46Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:46Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:46Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:46Z] DatabaseAccountController "msg"="Found resource: continuing to wait for deletion..." name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:46Z] DatabaseAccountController "msg"="Continue monitoring deletion" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:838: I2021-06-16T23:11:46Z] DatabaseAccountController "msg"="Deleted resource" name="asotestdbhmayhx" namespace="aso-test-ns"
[controller:test-integration-envtest]     error_translating_roundtripper.go:79: 
[controller:test-integration-envtest]         *** Cannot find go-vcr recording for request (no responses recorded for this method/URL): GET https://management.azure.com/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-dnhfns/providers/Microsoft.DocumentDB/databaseAccounts/asotestdbhmayhx?api-version=2021-01-01 (attempt: 0)
[controller:test-integration-envtest]         
[controller:test-integration-envtest]     crd_cosmosdb_test.go:65: 
[controller:test-integration-envtest]         Unexpected error:
[controller:test-integration-envtest]             <*url.Error | 0xc00438c7e0>: {
[controller:test-integration-envtest]                 Op: "Get",
[controller:test-integration-envtest]                 URL: "https://management.azure.com/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-dnhfns/providers/Microsoft.DocumentDB/databaseAccounts/asotestdbhmayhx?api-version=2021-01-01",
[controller:test-integration-envtest]                 Err: {
[controller:test-integration-envtest]                     s: "Requested interaction not found",
[controller:test-integration-envtest]                 },
[controller:test-integration-envtest]             }
[controller:test-integration-envtest]             Get "https://management.azure.com/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-dnhfns/providers/Microsoft.DocumentDB/databaseAccounts/asotestdbhmayhx?api-version=2021-01-01": Requested interaction not found
[controller:test-integration-envtest]         occurred
[controller:test-integration-envtest]     kube_per_test_context.go:179: Deleting test resource group "asotest-rg-dnhfns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:355: I2021-06-16T23:11:46Z] ResourceGroupController "msg"="Starting delete of resource" name="asotest-rg-dnhfns" namespace="aso-test-ns"
[controller:test-integration-envtest]     kube_test_context_envtest.go:108: Stopping controller-runtime manager
[controller:test-integration-envtest]     kube_test_context_envtest.go:48: Stopping envtest
[controller:test-integration-envtest]     error_translating_roundtripper.go:79: 
[controller:test-integration-envtest]         *** Cannot find go-vcr recording for request (no responses recorded for this method/URL): DELETE https://management.azure.com/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-dnhfns?api-version=2020-06-01 (attempt: 0)
[controller:test-integration-envtest]         
[controller:test-integration-envtest]     test_logger.go:111: I2021-06-16T23:11:46Z] ResourceGroupController "msg"="Error during Delete" "err"="deleting resource "Microsoft.Resources/resourceGroups": failed deleting /subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-dnhfns: Delete "https://management.azure.com/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-dnhfns?api-version=2020-06-01": Requested interaction not found" name="asotest-rg-dnhfns" namespace="aso-test-ns" action="BeginDelete"
[controller:test-integration-envtest] E0616 23:11:48.806788   14344 event.go:269] Unable to write event: 'Post "http://127.0.0.1:37905/api/v1/namespaces/aso-test-ns/events": dial tcp 127.0.0.1:37905: connect: connection refused' (may retry after sleeping)
[controller:test-integration-envtest] E0616 23:11:53.180190   14344 event.go:269] Unable to write event: 'Post "http://127.0.0.1:41053/api/v1/namespaces/aso-test-ns/events": dial tcp 127.0.0.1:41053: connect: connection refused' (may retry after sleeping)
[controller:test-integration-envtest] E0616 23:11:57.396249   14344 event.go:269] Unable to write event: 'Post "http://127.0.0.1:38575/api/v1/namespaces/aso-test-ns/events": dial tcp 127.0.0.1:38575: connect: connection refused' (may retry after sleeping)
[controller:test-integration-envtest] E0616 23:11:58.808231   14344 event.go:269] Unable to write event: 'Post "http://127.0.0.1:37905/api/v1/namespaces/aso-test-ns/events": dial tcp 127.0.0.1:37905: connect: connection refused' (may retry after sleeping)
[controller:test-integration-envtest] E0616 23:12:00.023432   14344 event.go:269] Unable to write event: 'Post "http://127.0.0.1:46363/api/v1/namespaces/aso-test-ns/events": dial tcp 127.0.0.1:46363: connect: connection refused' (may retry after sleeping)
[controller:test-integration-envtest] --- FAIL: Test_PublicIP_CRUD (26.12s)
[controller:test-integration-envtest]     kube_test_context_envtest.go:27: Creating envtest test: Test_PublicIP_CRUD
[controller:test-integration-envtest]     kube_test_context_envtest.go:41: Starting envtest
[controller:test-integration-envtest]     kube_test_context_envtest.go:55: Creating & starting controller-runtime manager
[controller:test-integration-envtest]     kube_test_context_envtest.go:69: Minimizing requeue delay
[controller:test-integration-envtest]     generic_controller.go:125: I2021-06-16T23:11:39Z] "msg"="Registering" GVK="microsoft.batch.infra.azure.com/v1alpha1api20210101, Kind=BatchAccount"
[controller:test-integration-envtest]     generic_controller.go:125: I2021-06-16T23:11:39Z] "msg"="Registering" GVK="microsoft.documentdb.infra.azure.com/v1alpha1api20210515, Kind=DatabaseAccount"
[controller:test-integration-envtest]     generic_controller.go:125: I2021-06-16T23:11:39Z] "msg"="Registering" GVK="microsoft.network.infra.azure.com/v1alpha1api20201101, Kind=LoadBalancer"
[controller:test-integration-envtest]     generic_controller.go:125: I2021-06-16T23:11:39Z] "msg"="Registering" GVK="microsoft.network.infra.azure.com/v1alpha1api20201101, Kind=PublicIPAddresses"
[controller:test-integration-envtest]     generic_controller.go:125: I2021-06-16T23:11:39Z] "msg"="Registering" GVK="microsoft.network.infra.azure.com/v1alpha1api20201101, Kind=VirtualNetwork"
[controller:test-integration-envtest]     generic_controller.go:125: I2021-06-16T23:11:39Z] "msg"="Registering" GVK="microsoft.network.infra.azure.com/v1alpha1api20201101, Kind=VirtualNetworkGateway"
[controller:test-integration-envtest]     generic_controller.go:125: I2021-06-16T23:11:39Z] "msg"="Registering" GVK="microsoft.network.infra.azure.com/v1alpha1api20201101, Kind=VirtualNetworkTap"
[controller:test-integration-envtest]     generic_controller.go:125: I2021-06-16T23:11:39Z] "msg"="Registering" GVK="microsoft.network.infra.azure.com/v1alpha1api20201101, Kind=VirtualNetworksSubnet"
[controller:test-integration-envtest]     generic_controller.go:125: I2021-06-16T23:11:39Z] "msg"="Registering" GVK="microsoft.network.infra.azure.com/v1alpha1api20201101, Kind=VirtualNetworksVirtualNetworkPeering"
[controller:test-integration-envtest]     generic_controller.go:125: I2021-06-16T23:11:39Z] "msg"="Registering" GVK="microsoft.servicebus.infra.azure.com/v1alpha1api20180101preview, Kind=NamespacesQueue"
[controller:test-integration-envtest]     generic_controller.go:125: I2021-06-16T23:11:39Z] "msg"="Registering" GVK="microsoft.servicebus.infra.azure.com/v1alpha1api20180101preview, Kind=NamespacesTopic"
[controller:test-integration-envtest]     generic_controller.go:125: I2021-06-16T23:11:39Z] "msg"="Registering" GVK="microsoft.servicebus.infra.azure.com/v1alpha1api20210101preview, Kind=Namespace"
[controller:test-integration-envtest]     generic_controller.go:125: I2021-06-16T23:11:39Z] "msg"="Registering" GVK="microsoft.storage.infra.azure.com/v1alpha1api20210401, Kind=StorageAccount"
[controller:test-integration-envtest]     generic_controller.go:125: I2021-06-16T23:11:39Z] "msg"="Registering" GVK="microsoft.storage.infra.azure.com/v1alpha1api20210401, Kind=StorageAccountsBlobService"
[controller:test-integration-envtest]     generic_controller.go:125: I2021-06-16T23:11:39Z] "msg"="Registering" GVK="microsoft.storage.infra.azure.com/v1alpha1api20210401, Kind=StorageAccountsBlobServicesContainer"
[controller:test-integration-envtest]     generic_controller.go:125: I2021-06-16T23:11:39Z] "msg"="Registering" GVK="microsoft.resources.infra.azure.com/v1alpha1api20200601, Kind=ResourceGroup"
[controller:test-integration-envtest]     kube_test_context_envtest.go:127: Checking for webhooks at: 127.0.0.1:41869
[controller:test-integration-envtest]     kube_test_context_envtest.go:136: Webhooks available at: 127.0.0.1:41869
[controller:test-integration-envtest]     kube_test_context_envtest.go:115: Webhook server running at: :41869
[controller:test-integration-envtest]     kube_per_test_context.go:168: Creating test resource group "asotest-rg-efubcd"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:456: I2021-06-16T23:11:39Z] ResourceGroupController "msg"="Starting new deployment to Azure" name="asotest-rg-efubcd" namespace="aso-test-ns" action="BeginDeployment"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:474: I2021-06-16T23:11:39Z] ResourceGroupController "msg"="Created deployment in Azure" name="asotest-rg-efubcd" namespace="aso-test-ns" id="/subscriptions/00000000-0000-0000-0000-000000000000/providers/Microsoft.Resources/deployments/k8s_bfc1ef04-0b37-5023-a99d-356aaae0d4ac"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:321: I2021-06-16T23:11:39Z] ResourceGroupController "msg"="Have existing deployment ID, will monitor it" name="asotest-rg-efubcd" namespace="aso-test-ns" deploymentID="/subscriptions/00000000-0000-0000-0000-000000000000/providers/Microsoft.Resources/deployments/k8s_bfc1ef04-0b37-5023-a99d-356aaae0d4ac"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:552: I2021-06-16T23:11:39Z] ResourceGroupController "msg"="Monitoring deployment" name="asotest-rg-efubcd" namespace="aso-test-ns" action="MonitorDeployment" id="/subscriptions/00000000-0000-0000-0000-000000000000/providers/Microsoft.Resources/deployments/k8s_bfc1ef04-0b37-5023-a99d-356aaae0d4ac" state="Accepted"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:590: I2021-06-16T23:11:39Z] ResourceGroupController "msg"="Deployment still running" name="asotest-rg-efubcd" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:321: I2021-06-16T23:11:40Z] ResourceGroupController "msg"="Have existing deployment ID, will monitor it" name="asotest-rg-efubcd" namespace="aso-test-ns" deploymentID="/subscriptions/00000000-0000-0000-0000-000000000000/providers/Microsoft.Resources/deployments/k8s_bfc1ef04-0b37-5023-a99d-356aaae0d4ac"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:667: I2021-06-16T23:11:40Z] ResourceGroupController "msg"="Got ARM status" name="asotest-rg-efubcd" namespace="aso-test-ns" status="{\"id\":\"/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-efubcd\",\"name\":\"asotest-rg-efubcd\",\"location\":\"westus\",\"tags\":{\"CreatedAt\":\"2001-02-03T04:05:06Z\"},\"properties\":{\"provisioningState\":\"Succeeded\"}}"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:552: I2021-06-16T23:11:40Z] ResourceGroupController "msg"="Monitoring deployment" name="asotest-rg-efubcd" namespace="aso-test-ns" action="MonitorDeployment" id="/subscriptions/00000000-0000-0000-0000-000000000000/providers/Microsoft.Resources/deployments/k8s_bfc1ef04-0b37-5023-a99d-356aaae0d4ac" state="Succeeded"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:560: I2021-06-16T23:11:40Z] ResourceGroupController "msg"="Deleting deployment" name="asotest-rg-efubcd" namespace="aso-test-ns" ID="/subscriptions/00000000-0000-0000-0000-000000000000/providers/Microsoft.Resources/deployments/k8s_bfc1ef04-0b37-5023-a99d-356aaae0d4ac"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:312: I2021-06-16T23:11:40Z] ResourceGroupController "msg"="resource spec has not changed and resource is in terminal state: "Succeeded"" name="asotest-rg-efubcd" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:595: I2021-06-16T23:11:44Z] PublicIPAddressesController "msg"="applying ownership" name="asotest-publicip-gtnmfz" namespace="aso-test-ns" action="ManageOwnership"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:819: I2021-06-16T23:11:44Z] PublicIPAddressesController "msg"="Set owner reference" name="asotest-publicip-gtnmfz" namespace="aso-test-ns" ownerGvk="microsoft.resources.infra.azure.com/v1alpha1api20200601, Kind=ResourceGroup" ownerName="asotest-rg-efubcd"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:456: I2021-06-16T23:11:44Z] PublicIPAddressesController "msg"="Starting new deployment to Azure" name="asotest-publicip-gtnmfz" namespace="aso-test-ns" action="BeginDeployment"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:474: I2021-06-16T23:11:44Z] PublicIPAddressesController "msg"="Created deployment in Azure" name="asotest-publicip-gtnmfz" namespace="aso-test-ns" id="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-efubcd/providers/Microsoft.Resources/deployments/k8s_cc1f6e9a-b293-5185-9bf2-aed5e7236aa7"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:321: I2021-06-16T23:11:45Z] PublicIPAddressesController "msg"="Have existing deployment ID, will monitor it" name="asotest-publicip-gtnmfz" namespace="aso-test-ns" deploymentID="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-efubcd/providers/Microsoft.Resources/deployments/k8s_cc1f6e9a-b293-5185-9bf2-aed5e7236aa7"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:552: I2021-06-16T23:11:45Z] PublicIPAddressesController "msg"="Monitoring deployment" name="asotest-publicip-gtnmfz" namespace="aso-test-ns" action="MonitorDeployment" id="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-efubcd/providers/Microsoft.Resources/deployments/k8s_cc1f6e9a-b293-5185-9bf2-aed5e7236aa7" state="Accepted"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:590: I2021-06-16T23:11:45Z] PublicIPAddressesController "msg"="Deployment still running" name="asotest-publicip-gtnmfz" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:321: I2021-06-16T23:11:45Z] PublicIPAddressesController "msg"="Have existing deployment ID, will monitor it" name="asotest-publicip-gtnmfz" namespace="aso-test-ns" deploymentID="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-efubcd/providers/Microsoft.Resources/deployments/k8s_cc1f6e9a-b293-5185-9bf2-aed5e7236aa7"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:552: I2021-06-16T23:11:45Z] PublicIPAddressesController "msg"="Monitoring deployment" name="asotest-publicip-gtnmfz" namespace="aso-test-ns" action="MonitorDeployment" id="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-efubcd/providers/Microsoft.Resources/deployments/k8s_cc1f6e9a-b293-5185-9bf2-aed5e7236aa7" state="Running"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:590: I2021-06-16T23:11:45Z] PublicIPAddressesController "msg"="Deployment still running" name="asotest-publicip-gtnmfz" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:321: I2021-06-16T23:11:45Z] PublicIPAddressesController "msg"="Have existing deployment ID, will monitor it" name="asotest-publicip-gtnmfz" namespace="aso-test-ns" deploymentID="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-efubcd/providers/Microsoft.Resources/deployments/k8s_cc1f6e9a-b293-5185-9bf2-aed5e7236aa7"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:552: I2021-06-16T23:11:45Z] PublicIPAddressesController "msg"="Monitoring deployment" name="asotest-publicip-gtnmfz" namespace="aso-test-ns" action="MonitorDeployment" id="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-efubcd/providers/Microsoft.Resources/deployments/k8s_cc1f6e9a-b293-5185-9bf2-aed5e7236aa7" state="Running"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:590: I2021-06-16T23:11:45Z] PublicIPAddressesController "msg"="Deployment still running" name="asotest-publicip-gtnmfz" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:321: I2021-06-16T23:11:45Z] PublicIPAddressesController "msg"="Have existing deployment ID, will monitor it" name="asotest-publicip-gtnmfz" namespace="aso-test-ns" deploymentID="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-efubcd/providers/Microsoft.Resources/deployments/k8s_cc1f6e9a-b293-5185-9bf2-aed5e7236aa7"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:552: I2021-06-16T23:11:45Z] PublicIPAddressesController "msg"="Monitoring deployment" name="asotest-publicip-gtnmfz" namespace="aso-test-ns" action="MonitorDeployment" id="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-efubcd/providers/Microsoft.Resources/deployments/k8s_cc1f6e9a-b293-5185-9bf2-aed5e7236aa7" state="Running"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:590: I2021-06-16T23:11:45Z] PublicIPAddressesController "msg"="Deployment still running" name="asotest-publicip-gtnmfz" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:321: I2021-06-16T23:11:45Z] PublicIPAddressesController "msg"="Have existing deployment ID, will monitor it" name="asotest-publicip-gtnmfz" namespace="aso-test-ns" deploymentID="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-efubcd/providers/Microsoft.Resources/deployments/k8s_cc1f6e9a-b293-5185-9bf2-aed5e7236aa7"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:667: I2021-06-16T23:11:45Z] PublicIPAddressesController "msg"="Got ARM status" name="asotest-publicip-gtnmfz" namespace="aso-test-ns" status="{\"etag\":\"W/\\\"6a2d7c1e-e3ee-40f1-ae54-7f2fa266332e\\\"\",\"id\":\"/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-efubcd/providers/Microsoft.Network/publicIPAddresses/asotest-publicip-gtnmfz\",\"location\":\"westus\",\"name\":\"asotest-publicip-gtnmfz\",\"properties\":{\"idleTimeoutInMinutes\":4,\"ipAddress\":\"104.45.221.23\",\"provisioningState\":\"Succeeded\",\"publicIPAddressVersion\":\"IPv4\",\"publicIPAllocationMethod\":\"Static\",\"resourceGuid\":\"13f4a3dc-9566-4b36-a5d6-622dcf8e18cc\"},\"sku\":{\"name\":\"Standard\",\"tier\":\"Regional\"},\"type\":\"Microsoft.Network/publicIPAddresses\"}"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:552: I2021-06-16T23:11:45Z] PublicIPAddressesController "msg"="Monitoring deployment" name="asotest-publicip-gtnmfz" namespace="aso-test-ns" action="MonitorDeployment" id="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-efubcd/providers/Microsoft.Resources/deployments/k8s_cc1f6e9a-b293-5185-9bf2-aed5e7236aa7" state="Succeeded"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:560: I2021-06-16T23:11:45Z] PublicIPAddressesController "msg"="Deleting deployment" name="asotest-publicip-gtnmfz" namespace="aso-test-ns" ID="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-efubcd/providers/Microsoft.Resources/deployments/k8s_cc1f6e9a-b293-5185-9bf2-aed5e7236aa7"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:312: I2021-06-16T23:11:45Z] PublicIPAddressesController "msg"="resource spec has not changed and resource is in terminal state: "Succeeded"" name="asotest-publicip-gtnmfz" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:456: I2021-06-16T23:11:49Z] PublicIPAddressesController "msg"="Starting new deployment to Azure" name="asotest-publicip-gtnmfz" namespace="aso-test-ns" action="BeginDeployment"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:474: I2021-06-16T23:11:49Z] PublicIPAddressesController "msg"="Created deployment in Azure" name="asotest-publicip-gtnmfz" namespace="aso-test-ns" id="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-efubcd/providers/Microsoft.Resources/deployments/k8s_cc1f6e9a-b293-5185-9bf2-aed5e7236aa7"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:321: I2021-06-16T23:11:50Z] PublicIPAddressesController "msg"="Have existing deployment ID, will monitor it" name="asotest-publicip-gtnmfz" namespace="aso-test-ns" deploymentID="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-efubcd/providers/Microsoft.Resources/deployments/k8s_cc1f6e9a-b293-5185-9bf2-aed5e7236aa7"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:552: I2021-06-16T23:11:50Z] PublicIPAddressesController "msg"="Monitoring deployment" name="asotest-publicip-gtnmfz" namespace="aso-test-ns" action="MonitorDeployment" id="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-efubcd/providers/Microsoft.Resources/deployments/k8s_cc1f6e9a-b293-5185-9bf2-aed5e7236aa7" state="Accepted"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:590: I2021-06-16T23:11:50Z] PublicIPAddressesController "msg"="Deployment still running" name="asotest-publicip-gtnmfz" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:321: I2021-06-16T23:11:50Z] PublicIPAddressesController "msg"="Have existing deployment ID, will monitor it" name="asotest-publicip-gtnmfz" namespace="aso-test-ns" deploymentID="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-efubcd/providers/Microsoft.Resources/deployments/k8s_cc1f6e9a-b293-5185-9bf2-aed5e7236aa7"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:552: I2021-06-16T23:11:50Z] PublicIPAddressesController "msg"="Monitoring deployment" name="asotest-publicip-gtnmfz" namespace="aso-test-ns" action="MonitorDeployment" id="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-efubcd/providers/Microsoft.Resources/deployments/k8s_cc1f6e9a-b293-5185-9bf2-aed5e7236aa7" state="Accepted"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:590: I2021-06-16T23:11:50Z] PublicIPAddressesController "msg"="Deployment still running" name="asotest-publicip-gtnmfz" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:321: I2021-06-16T23:11:50Z] PublicIPAddressesController "msg"="Have existing deployment ID, will monitor it" name="asotest-publicip-gtnmfz" namespace="aso-test-ns" deploymentID="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-efubcd/providers/Microsoft.Resources/deployments/k8s_cc1f6e9a-b293-5185-9bf2-aed5e7236aa7"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:552: I2021-06-16T23:11:50Z] PublicIPAddressesController "msg"="Monitoring deployment" name="asotest-publicip-gtnmfz" namespace="aso-test-ns" action="MonitorDeployment" id="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-efubcd/providers/Microsoft.Resources/deployments/k8s_cc1f6e9a-b293-5185-9bf2-aed5e7236aa7" state="Running"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:590: I2021-06-16T23:11:50Z] PublicIPAddressesController "msg"="Deployment still running" name="asotest-publicip-gtnmfz" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:321: I2021-06-16T23:11:50Z] PublicIPAddressesController "msg"="Have existing deployment ID, will monitor it" name="asotest-publicip-gtnmfz" namespace="aso-test-ns" deploymentID="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-efubcd/providers/Microsoft.Resources/deployments/k8s_cc1f6e9a-b293-5185-9bf2-aed5e7236aa7"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:552: I2021-06-16T23:11:50Z] PublicIPAddressesController "msg"="Monitoring deployment" name="asotest-publicip-gtnmfz" namespace="aso-test-ns" action="MonitorDeployment" id="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-efubcd/providers/Microsoft.Resources/deployments/k8s_cc1f6e9a-b293-5185-9bf2-aed5e7236aa7" state="Running"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:590: I2021-06-16T23:11:50Z] PublicIPAddressesController "msg"="Deployment still running" name="asotest-publicip-gtnmfz" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:321: I2021-06-16T23:11:50Z] PublicIPAddressesController "msg"="Have existing deployment ID, will monitor it" name="asotest-publicip-gtnmfz" namespace="aso-test-ns" deploymentID="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-efubcd/providers/Microsoft.Resources/deployments/k8s_cc1f6e9a-b293-5185-9bf2-aed5e7236aa7"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:667: I2021-06-16T23:11:50Z] PublicIPAddressesController "msg"="Got ARM status" name="asotest-publicip-gtnmfz" namespace="aso-test-ns" status="{\"etag\":\"W/\\\"c86d8e48-a161-4e8b-88d5-4486f85eb75c\\\"\",\"id\":\"/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-efubcd/providers/Microsoft.Network/publicIPAddresses/asotest-publicip-gtnmfz\",\"location\":\"westus\",\"name\":\"asotest-publicip-gtnmfz\",\"properties\":{\"idleTimeoutInMinutes\":7,\"ipAddress\":\"104.45.221.23\",\"provisioningState\":\"Succeeded\",\"publicIPAddressVersion\":\"IPv4\",\"publicIPAllocationMethod\":\"Static\",\"resourceGuid\":\"13f4a3dc-9566-4b36-a5d6-622dcf8e18cc\"},\"sku\":{\"name\":\"Standard\",\"tier\":\"Regional\"},\"type\":\"Microsoft.Network/publicIPAddresses\"}"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:552: I2021-06-16T23:11:50Z] PublicIPAddressesController "msg"="Monitoring deployment" name="asotest-publicip-gtnmfz" namespace="aso-test-ns" action="MonitorDeployment" id="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-efubcd/providers/Microsoft.Resources/deployments/k8s_cc1f6e9a-b293-5185-9bf2-aed5e7236aa7" state="Succeeded"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:560: I2021-06-16T23:11:50Z] PublicIPAddressesController "msg"="Deleting deployment" name="asotest-publicip-gtnmfz" namespace="aso-test-ns" ID="/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-efubcd/providers/Microsoft.Resources/deployments/k8s_cc1f6e9a-b293-5185-9bf2-aed5e7236aa7"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:312: I2021-06-16T23:11:50Z] PublicIPAddressesController "msg"="resource spec has not changed and resource is in terminal state: "Succeeded"" name="asotest-publicip-gtnmfz" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:355: I2021-06-16T23:11:55Z] PublicIPAddressesController "msg"="Starting delete of resource" name="asotest-publicip-gtnmfz" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:407: I2021-06-16T23:11:55Z] PublicIPAddressesController "msg"="Resource deletion started" name="asotest-publicip-gtnmfz" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:55Z] PublicIPAddressesController "msg"="Continue monitoring deletion" name="asotest-publicip-gtnmfz" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:55Z] PublicIPAddressesController "msg"="Found resource: continuing to wait for deletion..." name="asotest-publicip-gtnmfz" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:55Z] PublicIPAddressesController "msg"="Continue monitoring deletion" name="asotest-publicip-gtnmfz" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:438: I2021-06-16T23:11:55Z] PublicIPAddressesController "msg"="Found resource: continuing to wait for deletion..." name="asotest-publicip-gtnmfz" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:418: I2021-06-16T23:11:55Z] PublicIPAddressesController "msg"="Continue monitoring deletion" name="asotest-publicip-gtnmfz" namespace="aso-test-ns"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:838: I2021-06-16T23:11:55Z] PublicIPAddressesController "msg"="Deleted resource" name="asotest-publicip-gtnmfz" namespace="aso-test-ns"
[controller:test-integration-envtest]     error_translating_roundtripper.go:79: 
[controller:test-integration-envtest]         *** Cannot find go-vcr recording for request (no responses recorded for this method/URL): GET https://management.azure.com/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-efubcd/providers/Microsoft.Network/publicIPAddresses/asotest-publicip-gtnmfz?api-version=2019-11-01 (attempt: 0)
[controller:test-integration-envtest]         
[controller:test-integration-envtest]     crd_networking_publicip_test.go:69: 
[controller:test-integration-envtest]         Unexpected error:
[controller:test-integration-envtest]             <*url.Error | 0xc002ecf080>: {
[controller:test-integration-envtest]                 Op: "Get",
[controller:test-integration-envtest]                 URL: "https://management.azure.com/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-efubcd/providers/Microsoft.Network/publicIPAddresses/asotest-publicip-gtnmfz?api-version=2019-11-01",
[controller:test-integration-envtest]                 Err: {
[controller:test-integration-envtest]                     s: "Requested interaction not found",
[controller:test-integration-envtest]                 },
[controller:test-integration-envtest]             }
[controller:test-integration-envtest]             Get "https://management.azure.com/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-efubcd/providers/Microsoft.Network/publicIPAddresses/asotest-publicip-gtnmfz?api-version=2019-11-01": Requested interaction not found
[controller:test-integration-envtest]         occurred
[controller:test-integration-envtest]     kube_per_test_context.go:179: Deleting test resource group "asotest-rg-efubcd"
[controller:test-integration-envtest]     azure_deployment_reconciler.go:355: I2021-06-16T23:12:00Z] ResourceGroupController "msg"="Starting delete of resource" name="asotest-rg-efubcd" namespace="aso-test-ns"
[controller:test-integration-envtest]     kube_test_context_envtest.go:108: Stopping controller-runtime manager
[controller:test-integration-envtest]     kube_test_context_envtest.go:48: Stopping envtest
[controller:test-integration-envtest]     error_translating_roundtripper.go:79: 
[controller:test-integration-envtest]         *** Cannot find go-vcr recording for request (no responses recorded for this method/URL): DELETE https://management.azure.com/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-efubcd?api-version=2020-06-01 (attempt: 0)
[controller:test-integration-envtest]         
[controller:test-integration-envtest]     test_logger.go:111: I2021-06-16T23:12:00Z] ResourceGroupController "msg"="Error during Delete" "err"="deleting resource "Microsoft.Resources/resourceGroups": failed deleting /subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-efubcd: Delete "https://management.azure.com/subscriptions/00000000-0000-0000-0000-000000000000/resourceGroups/asotest-rg-efubcd?api-version=2020-06-01": Requested interaction not found" name="asotest-rg-efubcd" namespace="aso-test-ns" action="BeginDelete"
[controller:test-integration-envtest] E0616 23:12:01.789778   14344 event.go:269] Unable to write event: 'Post "http://127.0.0.1:46363/api/v1/namespaces/aso-test-ns/events": dial tcp 127.0.0.1:46363: connect: connection refused' (may retry after sleeping)
[controller:test-integration-envtest] E0616 23:12:01.804390   14344 event.go:269] Unable to write event: 'Post "http://127.0.0.1:36263/api/v1/namespaces/aso-test-ns/events": dial tcp 127.0.0.1:36263: connect: connection refused' (may retry after sleeping)
[controller:test-integration-envtest] E0616 23:12:02.305514   14344 event.go:269] Unable to write event: 'Post "http://127.0.0.1:38575/api/v1/namespaces/aso-test-ns/events": dial tcp 127.0.0.1:38575: connect: connection refused' (may retry after sleeping)
[controller:test-integration-envtest] FAIL
[controller:test-integration-envtest] FAIL	github.com/Azure/azure-service-operator/hack/generated/controllers	48.796s
[controller:test-integration-envtest] ok  	github.com/Azure/azure-service-operator/hack/generated/pkg/armclient	40.056s
[controller:test-integration-envtest] ok  	github.com/Azure/azure-service-operator/hack/generated/pkg/duration	(cached)
[controller:test-integration-envtest] ok  	github.com/Azure/azure-service-operator/hack/generated/pkg/genruntime	(cached)
[controller:test-integration-envtest] ?   	github.com/Azure/azure-service-operator/hack/generated/pkg/ownerutil	[no test files]
[controller:test-integration-envtest] ?   	github.com/Azure/azure-service-operator/hack/generated/pkg/reconcilers	[no test files]
[controller:test-integration-envtest] ok  	github.com/Azure/azure-service-operator/hack/generated/pkg/reflecthelpers	(cached)
[controller:test-integration-envtest] ?   	github.com/Azure/azure-service-operator/hack/generated/pkg/testcommon	[no test files]
[controller:test-integration-envtest] ?   	github.com/Azure/azure-service-operator/hack/generated/pkg/util/kubeclient	[no test files]
[controller:test-integration-envtest] ok  	github.com/Azure/azure-service-operator/hack/generated/pkg/util/patch	(cached)
[controller:test-integration-envtest] ?   	github.com/Azure/azure-service-operator/hack/generated/pkg/version	[no test files]
[controller:test-integration-envtest] FAIL
task: Failed to run task "controller:test-integration-envtest": exit status 1
vscode ➜ /go/src (feature/test-logs ✗) $ 

@codecov-commenter
Copy link

codecov-commenter commented Jun 17, 2021

Codecov Report

Merging #1571 (881bb91) into master (f60f783) will increase coverage by 0.15%.
The diff coverage is 87.65%.

❗ Current head 881bb91 differs from pull request most recent head a9faf44. Consider uploading reports for the commit a9faf44 to get more accurate results
Impacted file tree graph

@@            Coverage Diff             @@
##           master    #1571      +/-   ##
==========================================
+ Coverage   63.41%   63.57%   +0.15%     
==========================================
  Files         181      182       +1     
  Lines       11797    11856      +59     
==========================================
+ Hits         7481     7537      +56     
- Misses       3648     3650       +2     
- Partials      668      669       +1     
Impacted Files Coverage Δ
...d/pkg/testcommon/error_translating_roundtripper.go 53.12% <66.66%> (ø)
hack/generated/pkg/testcommon/test_context.go 57.89% <66.66%> (+0.28%) ⬆️
...erated/pkg/testcommon/kube_test_context_envtest.go 82.66% <78.57%> (-1.34%) ⬇️
hack/generated/pkg/testcommon/test_logger.go 92.85% <92.85%> (ø)
...ted/pkg/reconcilers/azure_deployment_reconciler.go 57.73% <100.00%> (+0.82%) ⬆️

Continue to review full report at Codecov.

Legend - Click here to learn more
Δ = absolute <relative> (impact), ø = not affected, ? = missing data
Powered by Codecov. Last update f60f783...a9faf44. Read the comment docs.

kvListFormat(b, t.values...)
kvListFormat(b, keysAndValues...)

t.t.Log(fmt.Sprintf("%s \"msg\"=\"%s\" \"err\"=\"%s\"%s", header, msg, err, b))
Copy link
Member

@theunrepentantgeek theunrepentantgeek Jun 21, 2021

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

I'd like us to consider doing something smart with error logging - like breaking out messages across multiple lines so that it's possible to read errors without having to copy them out elsewhere and manually reformat them. #somethingforanothertime

Copy link
Member Author

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

Yeah my intent with this is just to mirror as close as possible the default klog logging format, so that looking at test logs and actual "prod" logs are the same. Unfortunately because of how klog + golang testing.T are written you can't actually just plug testing.T into klog (I tried, it almost worked...)

@matthchr matthchr merged commit 90631f0 into Azure:master Jun 21, 2021
@matthchr matthchr deleted the feature/test-logs branch June 21, 2021 15:43
@matthchr matthchr added this to the codegen-alpha-0 milestone Jun 21, 2021
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
None yet
Projects
None yet
Development

Successfully merging this pull request may close these issues.

Use logger abstraction instead of klog
3 participants