This job view page is being replaced by Spyglass soon. Check out the new job view.
PRdependabot[bot]: chore(deps): bump github.com/onsi/gomega from 1.20.1 to 1.20.2
Resultsuccess
Tests 0 failed / 49 succeeded
Started2022-09-04 12:53
Elapsed2h32m
Revision
Refs 2241
uploadercrier
uploadercrier

No Test Failures!


Show 49 Passed Tests

Show 25 Skipped Tests

Error lines from build-log.txt

... skipping 1073 lines ...
Sep  4 13:31:55.497: INFO: 4 pods in namespace e2e-tests-service-zvdmr are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
Sep  4 13:32:05.618: INFO: 0 pods in namespace e2e-tests-service-zvdmr are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
STEP: Create service 09/04/22 13:32:05.618
Sep  4 13:32:05.619: INFO: Creating service annotation-test in namespace e2e-tests-service-zvdmr [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:949]
Sep  4 13:32:05.728: INFO: Successfully created LoadBalancer service annotation-test in namespace e2e-tests-service-zvdmr [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:953]
Sep  4 13:32:05.728: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:956]
Sep  4 13:32:05.783: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 13:32:15.841: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 13:32:25.843: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 13:32:35.851: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 13:32:45.841: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 13:32:55.841: INFO: Exposure successfully, get external ip: 20.236.32.227 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
Sep  4 13:32:55.841: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-zvdmr to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
Sep  4 13:32:55.962: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
Sep  4 13:33:06.020: INFO: checking the connectivity of addr 20.236.32.227:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
Sep  4 13:33:06.020: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
Sep  4 13:33:06.020: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-service-zvdmr exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  20.236.32.227 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 25 lines ...
    Sep  4 13:31:55.497: INFO: 4 pods in namespace e2e-tests-service-zvdmr are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
    Sep  4 13:32:05.618: INFO: 0 pods in namespace e2e-tests-service-zvdmr are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
    STEP: Create service 09/04/22 13:32:05.618
    Sep  4 13:32:05.619: INFO: Creating service annotation-test in namespace e2e-tests-service-zvdmr [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:949]
    Sep  4 13:32:05.728: INFO: Successfully created LoadBalancer service annotation-test in namespace e2e-tests-service-zvdmr [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:953]
    Sep  4 13:32:05.728: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:956]
    Sep  4 13:32:05.783: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 13:32:15.841: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 13:32:25.843: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 13:32:35.851: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 13:32:45.841: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 13:32:55.841: INFO: Exposure successfully, get external ip: 20.236.32.227 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
    Sep  4 13:32:55.841: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-zvdmr to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
    Sep  4 13:32:55.962: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
    Sep  4 13:33:06.020: INFO: checking the connectivity of addr 20.236.32.227:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
    Sep  4 13:33:06.020: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
    Sep  4 13:33:06.020: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-service-zvdmr exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  20.236.32.227 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 21 lines ...
Sep  4 13:34:12.219: INFO: Waiting for backend pods to be ready [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:98]
Sep  4 13:34:12.291: INFO: 3 pods in namespace e2e-tests-service-gzz7b are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
Sep  4 13:34:22.403: INFO: 0 pods in namespace e2e-tests-service-gzz7b are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
Sep  4 13:34:22.403: INFO: Creating service annotation-test in namespace e2e-tests-service-gzz7b [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:949]
Sep  4 13:34:22.478: INFO: Successfully created LoadBalancer service annotation-test in namespace e2e-tests-service-gzz7b [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:953]
Sep  4 13:34:22.478: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:956]
Sep  4 13:34:22.534: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 13:34:32.591: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 13:34:42.591: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 13:34:52.592: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 13:35:02.600: INFO: Exposure successfully, get external ip: 10.240.0.8 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
Sep  4 13:35:02.600: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-gzz7b to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
Sep  4 13:35:02.721: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
Sep  4 13:35:12.788: INFO: checking the connectivity of addr 10.240.0.8:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
Sep  4 13:35:12.789: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
Sep  4 13:35:12.789: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-service-gzz7b exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  10.240.0.8 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 22 lines ...
    Sep  4 13:34:12.219: INFO: Waiting for backend pods to be ready [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:98]
    Sep  4 13:34:12.291: INFO: 3 pods in namespace e2e-tests-service-gzz7b are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
    Sep  4 13:34:22.403: INFO: 0 pods in namespace e2e-tests-service-gzz7b are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
    Sep  4 13:34:22.403: INFO: Creating service annotation-test in namespace e2e-tests-service-gzz7b [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:949]
    Sep  4 13:34:22.478: INFO: Successfully created LoadBalancer service annotation-test in namespace e2e-tests-service-gzz7b [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:953]
    Sep  4 13:34:22.478: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:956]
    Sep  4 13:34:22.534: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 13:34:32.591: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 13:34:42.591: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 13:34:52.592: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 13:35:02.600: INFO: Exposure successfully, get external ip: 10.240.0.8 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
    Sep  4 13:35:02.600: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-gzz7b to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
    Sep  4 13:35:02.721: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
    Sep  4 13:35:12.788: INFO: checking the connectivity of addr 10.240.0.8:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
    Sep  4 13:35:12.789: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
    Sep  4 13:35:12.789: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-service-gzz7b exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  10.240.0.8 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 23 lines ...
Sep  4 13:36:04.985: INFO: Getting virtual network list [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:37]
STEP: Test subnet doesn't exist. Creating a new one... 09/04/22 13:36:05.619
Sep  4 13:36:06.983: INFO: creating a new subnet a--------------------------------------------------z, 10.0.0.0/24 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:74]
Sep  4 13:36:07.318: INFO: Creating service annotation-test in namespace e2e-tests-service-29h27 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:949]
Sep  4 13:36:07.391: INFO: Successfully created LoadBalancer service annotation-test in namespace e2e-tests-service-29h27 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:953]
Sep  4 13:36:07.391: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:956]
Sep  4 13:36:07.448: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 13:36:17.513: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 13:36:27.513: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 13:36:37.514: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 13:36:47.514: INFO: Exposure successfully, get external ip: 10.0.0.4 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
Sep  4 13:36:47.514: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-29h27 to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
Sep  4 13:36:47.636: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
Sep  4 13:36:57.703: INFO: checking the connectivity of addr 10.0.0.4:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
Sep  4 13:36:57.703: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
Sep  4 13:36:57.703: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-service-29h27 exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  10.0.0.4 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 42 lines ...
    Sep  4 13:36:04.985: INFO: Getting virtual network list [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:37]
    STEP: Test subnet doesn't exist. Creating a new one... 09/04/22 13:36:05.619
    Sep  4 13:36:06.983: INFO: creating a new subnet a--------------------------------------------------z, 10.0.0.0/24 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:74]
    Sep  4 13:36:07.318: INFO: Creating service annotation-test in namespace e2e-tests-service-29h27 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:949]
    Sep  4 13:36:07.391: INFO: Successfully created LoadBalancer service annotation-test in namespace e2e-tests-service-29h27 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:953]
    Sep  4 13:36:07.391: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:956]
    Sep  4 13:36:07.448: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 13:36:17.513: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 13:36:27.513: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 13:36:37.514: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 13:36:47.514: INFO: Exposure successfully, get external ip: 10.0.0.4 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
    Sep  4 13:36:47.514: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-29h27 to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
    Sep  4 13:36:47.636: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
    Sep  4 13:36:57.703: INFO: checking the connectivity of addr 10.0.0.4:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
    Sep  4 13:36:57.703: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
    Sep  4 13:36:57.703: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-service-29h27 exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  10.0.0.4 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 35 lines ...
Sep  4 13:38:04.277: INFO: Waiting for backend pods to be ready [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:98]
Sep  4 13:38:04.335: INFO: 3 pods in namespace e2e-tests-service-8h5c4 are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
Sep  4 13:38:14.445: INFO: 0 pods in namespace e2e-tests-service-8h5c4 are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
Sep  4 13:38:14.445: INFO: Creating service annotation-test in namespace e2e-tests-service-8h5c4 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:949]
Sep  4 13:38:14.527: INFO: Successfully created LoadBalancer service annotation-test in namespace e2e-tests-service-8h5c4 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:953]
Sep  4 13:38:14.527: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:956]
Sep  4 13:38:14.583: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 13:38:24.650: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 13:38:34.640: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 13:38:44.641: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 13:38:54.649: INFO: Exposure successfully, get external ip: 20.80.180.105 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
Sep  4 13:38:54.650: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-8h5c4 to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
Sep  4 13:38:54.774: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
Sep  4 13:39:04.834: INFO: checking the connectivity of addr 20.80.180.105:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
Sep  4 13:39:04.834: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
Sep  4 13:39:04.834: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-service-8h5c4 exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  20.80.180.105 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 26 lines ...
    Sep  4 13:38:04.277: INFO: Waiting for backend pods to be ready [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:98]
    Sep  4 13:38:04.335: INFO: 3 pods in namespace e2e-tests-service-8h5c4 are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
    Sep  4 13:38:14.445: INFO: 0 pods in namespace e2e-tests-service-8h5c4 are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
    Sep  4 13:38:14.445: INFO: Creating service annotation-test in namespace e2e-tests-service-8h5c4 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:949]
    Sep  4 13:38:14.527: INFO: Successfully created LoadBalancer service annotation-test in namespace e2e-tests-service-8h5c4 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:953]
    Sep  4 13:38:14.527: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:956]
    Sep  4 13:38:14.583: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 13:38:24.650: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 13:38:34.640: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 13:38:44.641: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 13:38:54.649: INFO: Exposure successfully, get external ip: 20.80.180.105 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
    Sep  4 13:38:54.650: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-8h5c4 to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
    Sep  4 13:38:54.774: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
    Sep  4 13:39:04.834: INFO: checking the connectivity of addr 20.80.180.105:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
    Sep  4 13:39:04.834: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
    Sep  4 13:39:04.834: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-service-8h5c4 exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  20.80.180.105 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 27 lines ...
STEP: resource group e2e-fa08 created 09/04/22 13:40:10.355
STEP: creating test PIP in the test resource group 09/04/22 13:40:10.355
Sep  4 13:40:10.355: INFO: Creating public IP resource named testPIP-e423 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:196]
STEP: Creating service annotation-test in namespace e2e-tests-service-p9lwr 09/04/22 13:40:14.055
Sep  4 13:40:14.128: INFO: Successfully created LoadBalancer service annotation-test in namespace e2e-tests-service-p9lwr [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:286]
STEP: Waiting service to expose... 09/04/22 13:40:14.128
Sep  4 13:40:14.184: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 13:40:24.249: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 13:40:34.251: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 13:40:44.244: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 13:40:54.240: INFO: Exposure successfully, get external ip: 20.94.226.114 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
Sep  4 13:40:54.240: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-p9lwr to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
Sep  4 13:40:54.367: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
Sep  4 13:41:04.425: INFO: checking the connectivity of addr 20.94.226.114:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
Sep  4 13:41:04.425: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
Sep  4 13:41:04.425: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-service-p9lwr exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  20.94.226.114 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 35 lines ...
    STEP: resource group e2e-fa08 created 09/04/22 13:40:10.355
    STEP: creating test PIP in the test resource group 09/04/22 13:40:10.355
    Sep  4 13:40:10.355: INFO: Creating public IP resource named testPIP-e423 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:196]
    STEP: Creating service annotation-test in namespace e2e-tests-service-p9lwr 09/04/22 13:40:14.055
    Sep  4 13:40:14.128: INFO: Successfully created LoadBalancer service annotation-test in namespace e2e-tests-service-p9lwr [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:286]
    STEP: Waiting service to expose... 09/04/22 13:40:14.128
    Sep  4 13:40:14.184: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 13:40:24.249: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 13:40:34.251: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 13:40:44.244: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 13:40:54.240: INFO: Exposure successfully, get external ip: 20.94.226.114 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
    Sep  4 13:40:54.240: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-p9lwr to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
    Sep  4 13:40:54.367: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
    Sep  4 13:41:04.425: INFO: checking the connectivity of addr 20.94.226.114:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
    Sep  4 13:41:04.425: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
    Sep  4 13:41:04.425: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-service-p9lwr exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  20.94.226.114 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 29 lines ...
Sep  4 13:43:05.739: INFO: 3 pods in namespace e2e-tests-service-lxmc2 are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
Sep  4 13:43:15.849: INFO: 0 pods in namespace e2e-tests-service-lxmc2 are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
STEP: Exposing two services with shared security rule 09/04/22 13:43:15.849
Sep  4 13:43:15.849: INFO: Creating service annotation-test in namespace e2e-tests-service-lxmc2 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:949]
Sep  4 13:43:15.919: INFO: Successfully created LoadBalancer service annotation-test in namespace e2e-tests-service-lxmc2 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:953]
Sep  4 13:43:15.919: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:956]
Sep  4 13:43:15.977: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 13:43:26.034: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 13:43:36.033: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 13:43:46.043: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 13:43:56.045: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 13:44:06.034: INFO: Exposure successfully, get external ip: 20.112.107.131 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
Sep  4 13:44:06.034: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-lxmc2 to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
Sep  4 13:44:06.159: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
Sep  4 13:44:16.217: INFO: checking the connectivity of addr 20.112.107.131:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
Sep  4 13:44:16.217: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
Sep  4 13:44:16.217: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-service-lxmc2 exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  20.112.107.131 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
Sep  4 13:44:17.043: INFO: stderr: "+ nc -vz -w 4 20.112.107.131 80\nConnection to 20.112.107.131 80 port [tcp/http] succeeded!\n" [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:165]
Sep  4 13:44:17.043: INFO: stdout: "" [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:166]
Sep  4 13:44:17.043: INFO: Validation succeeded: Service addr 20.112.107.131:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:201]
Sep  4 13:44:17.113: INFO: Deleting pod exec-agnhost-pod in namespace e2e-tests-service-lxmc2 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:118]
Sep  4 13:44:17.168: INFO: Creating service annotation-test-share in namespace e2e-tests-service-lxmc2 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:949]
Sep  4 13:44:17.242: INFO: Successfully created LoadBalancer service annotation-test-share in namespace e2e-tests-service-lxmc2 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:953]
Sep  4 13:44:17.242: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:956]
Sep  4 13:44:17.300: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 13:44:27.365: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 13:44:37.358: INFO: Exposure successfully, get external ip: 20.69.123.171 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
Sep  4 13:44:37.358: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-lxmc2 to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
Sep  4 13:44:37.478: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
Sep  4 13:44:47.538: INFO: checking the connectivity of addr 20.69.123.171:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
Sep  4 13:44:47.538: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
Sep  4 13:44:47.538: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-service-lxmc2 exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  20.69.123.171 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 31 lines ...
    Sep  4 13:43:05.739: INFO: 3 pods in namespace e2e-tests-service-lxmc2 are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
    Sep  4 13:43:15.849: INFO: 0 pods in namespace e2e-tests-service-lxmc2 are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
    STEP: Exposing two services with shared security rule 09/04/22 13:43:15.849
    Sep  4 13:43:15.849: INFO: Creating service annotation-test in namespace e2e-tests-service-lxmc2 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:949]
    Sep  4 13:43:15.919: INFO: Successfully created LoadBalancer service annotation-test in namespace e2e-tests-service-lxmc2 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:953]
    Sep  4 13:43:15.919: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:956]
    Sep  4 13:43:15.977: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 13:43:26.034: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 13:43:36.033: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 13:43:46.043: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 13:43:56.045: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 13:44:06.034: INFO: Exposure successfully, get external ip: 20.112.107.131 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
    Sep  4 13:44:06.034: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-lxmc2 to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
    Sep  4 13:44:06.159: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
    Sep  4 13:44:16.217: INFO: checking the connectivity of addr 20.112.107.131:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
    Sep  4 13:44:16.217: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
    Sep  4 13:44:16.217: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-service-lxmc2 exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  20.112.107.131 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
    Sep  4 13:44:17.043: INFO: stderr: "+ nc -vz -w 4 20.112.107.131 80\nConnection to 20.112.107.131 80 port [tcp/http] succeeded!\n" [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:165]
    Sep  4 13:44:17.043: INFO: stdout: "" [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:166]
    Sep  4 13:44:17.043: INFO: Validation succeeded: Service addr 20.112.107.131:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:201]
    Sep  4 13:44:17.113: INFO: Deleting pod exec-agnhost-pod in namespace e2e-tests-service-lxmc2 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:118]
    Sep  4 13:44:17.168: INFO: Creating service annotation-test-share in namespace e2e-tests-service-lxmc2 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:949]
    Sep  4 13:44:17.242: INFO: Successfully created LoadBalancer service annotation-test-share in namespace e2e-tests-service-lxmc2 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:953]
    Sep  4 13:44:17.242: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:956]
    Sep  4 13:44:17.300: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 13:44:27.365: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 13:44:37.358: INFO: Exposure successfully, get external ip: 20.69.123.171 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
    Sep  4 13:44:37.358: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-lxmc2 to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
    Sep  4 13:44:37.478: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
    Sep  4 13:44:47.538: INFO: checking the connectivity of addr 20.69.123.171:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
    Sep  4 13:44:47.538: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
    Sep  4 13:44:47.538: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-service-lxmc2 exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  20.69.123.171 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 26 lines ...
Sep  4 13:46:52.065: INFO: Creating deployment annotation-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:93]
Sep  4 13:46:52.124: INFO: Waiting for backend pods to be ready [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:98]
Sep  4 13:46:52.217: INFO: 5 pods in namespace e2e-tests-service-cktl7 are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
Sep  4 13:47:02.332: INFO: 0 pods in namespace e2e-tests-service-cktl7 are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
STEP: Creating a service with custom tags 09/04/22 13:47:02.332
STEP: Waiting service to expose... 09/04/22 13:47:02.407
Sep  4 13:47:02.463: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 13:47:12.531: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 13:47:22.520: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 13:47:32.520: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 13:47:42.528: INFO: Exposure successfully, get external ip: 20.80.178.224 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
Sep  4 13:47:42.528: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-cktl7 to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
Sep  4 13:47:42.649: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
Sep  4 13:47:52.708: INFO: checking the connectivity of addr 20.80.178.224:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
Sep  4 13:47:52.708: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
Sep  4 13:47:52.708: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-service-cktl7 exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  20.80.178.224 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 29 lines ...
    Sep  4 13:46:52.065: INFO: Creating deployment annotation-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:93]
    Sep  4 13:46:52.124: INFO: Waiting for backend pods to be ready [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:98]
    Sep  4 13:46:52.217: INFO: 5 pods in namespace e2e-tests-service-cktl7 are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
    Sep  4 13:47:02.332: INFO: 0 pods in namespace e2e-tests-service-cktl7 are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
    STEP: Creating a service with custom tags 09/04/22 13:47:02.332
    STEP: Waiting service to expose... 09/04/22 13:47:02.407
    Sep  4 13:47:02.463: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 13:47:12.531: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 13:47:22.520: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 13:47:32.520: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 13:47:42.528: INFO: Exposure successfully, get external ip: 20.80.178.224 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
    Sep  4 13:47:42.528: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-cktl7 to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
    Sep  4 13:47:42.649: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
    Sep  4 13:47:52.708: INFO: checking the connectivity of addr 20.80.178.224:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
    Sep  4 13:47:52.708: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
    Sep  4 13:47:52.708: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-service-cktl7 exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  20.80.178.224 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 29 lines ...
Sep  4 13:49:08.271: INFO: 0 pods in namespace e2e-tests-service-v9ln2 are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
STEP: Creating two test pips 09/04/22 13:49:08.271
Sep  4 13:49:08.271: INFO: Creating public IP resource named pip1 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:196]
Sep  4 13:49:12.325: INFO: Creating public IP resource named pip2 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:196]
STEP: Creating a service referring to the first pip 09/04/22 13:49:16.055
STEP: Waiting for the service to expose 09/04/22 13:49:16.133
Sep  4 13:49:16.190: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 13:49:26.247: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 13:49:36.247: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 13:49:46.247: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 13:49:56.252: INFO: Exposure successfully, get external ip: 20.80.181.82 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
Sep  4 13:49:56.252: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-v9ln2 to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
Sep  4 13:49:56.378: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
Sep  4 13:50:06.436: INFO: checking the connectivity of addr 20.80.181.82:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
Sep  4 13:50:06.436: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
Sep  4 13:50:06.436: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-service-v9ln2 exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  20.80.181.82 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 44 lines ...
    Sep  4 13:49:08.271: INFO: 0 pods in namespace e2e-tests-service-v9ln2 are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
    STEP: Creating two test pips 09/04/22 13:49:08.271
    Sep  4 13:49:08.271: INFO: Creating public IP resource named pip1 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:196]
    Sep  4 13:49:12.325: INFO: Creating public IP resource named pip2 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:196]
    STEP: Creating a service referring to the first pip 09/04/22 13:49:16.055
    STEP: Waiting for the service to expose 09/04/22 13:49:16.133
    Sep  4 13:49:16.190: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 13:49:26.247: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 13:49:36.247: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 13:49:46.247: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 13:49:56.252: INFO: Exposure successfully, get external ip: 20.80.181.82 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
    Sep  4 13:49:56.252: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-v9ln2 to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
    Sep  4 13:49:56.378: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
    Sep  4 13:50:06.436: INFO: checking the connectivity of addr 20.80.181.82:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
    Sep  4 13:50:06.436: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
    Sep  4 13:50:06.436: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-service-v9ln2 exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  20.80.181.82 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 78 lines ...
Sep  4 13:52:31.746: INFO: 5 pods in namespace e2e-tests-service-svmzp are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
Sep  4 13:52:41.858: INFO: 0 pods in namespace e2e-tests-service-svmzp are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
STEP: Creating a service with health probe annotations 09/04/22 13:52:41.858
Sep  4 13:52:41.858: INFO: Creating service annotation-test in namespace e2e-tests-service-svmzp [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:949]
Sep  4 13:52:41.942: INFO: Successfully created LoadBalancer service annotation-test in namespace e2e-tests-service-svmzp [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:953]
Sep  4 13:52:41.942: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:956]
Sep  4 13:52:42.007: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 13:52:52.074: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 13:53:02.069: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 13:53:12.072: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 13:53:22.072: INFO: Exposure successfully, get external ip: 20.69.120.189 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
Sep  4 13:53:22.072: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-svmzp to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
Sep  4 13:53:22.191: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
Sep  4 13:53:32.252: INFO: checking the connectivity of addr 20.69.120.189:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
Sep  4 13:53:32.252: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
Sep  4 13:53:32.252: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-service-svmzp exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  20.69.120.189 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 35 lines ...
    Sep  4 13:52:31.746: INFO: 5 pods in namespace e2e-tests-service-svmzp are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
    Sep  4 13:52:41.858: INFO: 0 pods in namespace e2e-tests-service-svmzp are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
    STEP: Creating a service with health probe annotations 09/04/22 13:52:41.858
    Sep  4 13:52:41.858: INFO: Creating service annotation-test in namespace e2e-tests-service-svmzp [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:949]
    Sep  4 13:52:41.942: INFO: Successfully created LoadBalancer service annotation-test in namespace e2e-tests-service-svmzp [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:953]
    Sep  4 13:52:41.942: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:956]
    Sep  4 13:52:42.007: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 13:52:52.074: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 13:53:02.069: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 13:53:12.072: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 13:53:22.072: INFO: Exposure successfully, get external ip: 20.69.120.189 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
    Sep  4 13:53:22.072: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-svmzp to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
    Sep  4 13:53:22.191: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
    Sep  4 13:53:32.252: INFO: checking the connectivity of addr 20.69.120.189:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
    Sep  4 13:53:32.252: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
    Sep  4 13:53:32.252: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-service-svmzp exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  20.69.120.189 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 32 lines ...
Sep  4 13:54:39.405: INFO: 5 pods in namespace e2e-tests-service-stnpf are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
Sep  4 13:54:49.526: INFO: 0 pods in namespace e2e-tests-service-stnpf are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
STEP: Creating a service with health probe annotations 09/04/22 13:54:49.526
Sep  4 13:54:49.527: INFO: Creating service annotation-test in namespace e2e-tests-service-stnpf [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:949]
Sep  4 13:54:49.617: INFO: Successfully created LoadBalancer service annotation-test in namespace e2e-tests-service-stnpf [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:953]
Sep  4 13:54:49.617: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:956]
Sep  4 13:54:49.688: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 13:54:59.750: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 13:55:09.745: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 13:55:19.750: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 13:55:29.753: INFO: Exposure successfully, get external ip: 20.69.120.208 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
Sep  4 13:55:29.753: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-stnpf to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
Sep  4 13:55:29.873: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
Sep  4 13:55:39.938: INFO: checking the connectivity of addr 20.69.120.208:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
Sep  4 13:55:39.938: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
Sep  4 13:55:39.938: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-service-stnpf exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  20.69.120.208 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 8 lines ...
Sep  4 13:55:41.571: INFO: Getting public IP frontend configuration ID [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:910]
Sep  4 13:55:41.571: INFO: Successfully obtained PIP front config id: /subscriptions/0e46bd28-a80f-4d3a-8200-d9eb8d80cb2e/resourceGroups/kubetest-vnufys1h/providers/Microsoft.Network/loadBalancers/kubetest-vnufys1h/frontendIPConfigurations/a8fcf713a582c431a96ae26634dfc297 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:922]
Sep  4 13:55:41.571: INFO: Getting loadBalancer name from pipFrontendConfigurationID [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:930]
Sep  4 13:55:41.571: INFO: Got loadBalancerName "kubetest-vnufys1h" [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:935]
Sep  4 13:55:41.571: INFO: Getting loadBalancer [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:937]
STEP: Cleaning up service and public IP 09/04/22 13:55:41.845
E0904 13:55:41.844682  148908 runtime.go:79] Observed a panic: types.GinkgoError{Heading:"Your Test Panicked", Message:"When you, or your assertion library, calls Ginkgo's Fail(),\nGinkgo panics to prevent subsequent assertions from running.\n\nNormally Ginkgo rescues this panic so you shouldn't see it.\n\nHowever, if you make an assertion in a goroutine, Ginkgo can't capture the panic.\nTo circumvent this, you should call\n\n\tdefer GinkgoRecover()\n\nat the top of the goroutine that caused this panic.\n\nAlternatively, you may have made an assertion outside of a Ginkgo\nleaf node (e.g. in a container node or some out-of-band function) - please move your assertion to\nan appropriate Ginkgo node (e.g. a BeforeSuite, BeforeEach, It, etc...).", DocLink:"mental-model-how-ginkgo-handles-failure", CodeLocation:types.CodeLocation{FileName:"/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go", LineNumber:942, FullStackTrace:"sigs.k8s.io/cloud-provider-azure/tests/e2e/network.getAzureLoadBalancerFromPIP(0xc000346700, {0xc00074df90?, 0x0?}, {0xc00025d3cb?, 0x0?}, {0x0, 0x0})\n\t/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:942 +0x453\nsigs.k8s.io/cloud-provider-azure/tests/e2e/network.glob..func7.13.2()\n\t/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:580 +0x72\nk8s.io/apimachinery/pkg/util/wait.ConditionFunc.WithContext.func1({0x18, 0xc000100000})\n\t/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/vendor/k8s.io/apimachinery/pkg/util/wait/wait.go:222 +0x1b\nk8s.io/apimachinery/pkg/util/wait.runConditionWithCrashProtectionWithContext({0x1c58630?, 0xc000048088?}, 0xc00086bda8?)\n\t/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/vendor/k8s.io/apimachinery/pkg/util/wait/wait.go:235 +0x57\nk8s.io/apimachinery/pkg/util/wait.poll({0x1c58630, 0xc000048088}, 0xe8?, 0xd35d45?, 0x38?)\n\t/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/vendor/k8s.io/apimachinery/pkg/util/wait/wait.go:582 +0x38\nk8s.io/apimachinery/pkg/util/wait.PollImmediateWithContext({0x1c58630, 0xc000048088}, 0x1c4ca28?, 0xc00086be38?, 0x40fa47?)\n\t/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/vendor/k8s.io/apimachinery/pkg/util/wait/wait.go:528 +0x4a\nk8s.io/apimachinery/pkg/util/wait.PollImmediate(0xc000546a80?, 0x1c4ca28?, 0xc000222700?)\n\t/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/vendor/k8s.io/apimachinery/pkg/util/wait/wait.go:514 +0x50\nsigs.k8s.io/cloud-provider-azure/tests/e2e/network.glob..func7.13()\n\t/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:579 +0x485", CustomMessage:""}} (Your Test Panicked
Expect(err).NotTo(HaveOccurred())
/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:942
  When you, or your assertion library, calls Ginkgo's Fail(),
  Ginkgo panics to prevent subsequent assertions from running.

  Normally Ginkgo rescues this panic so you shouldn't see it.

  However, if you make an assertion in a goroutine, Ginkgo can't capture the
  panic.
... skipping 15 lines ...
k8s.io/apimachinery/pkg/util/runtime.logPanic({0x18a6f20?, 0xc0002f4a10})
	/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/vendor/k8s.io/apimachinery/pkg/util/runtime/runtime.go:75 +0x99
k8s.io/apimachinery/pkg/util/runtime.HandleCrash({0x0, 0x0, 0xc0002f4a10?})
	/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/vendor/k8s.io/apimachinery/pkg/util/runtime/runtime.go:49 +0x75
panic({0x18a6f20, 0xc0002f4a10})
	/usr/local/go/src/runtime/panic.go:884 +0x212
github.com/onsi/ginkgo/v2.Fail({0xc00096ec00, 0x1265}, {0xc0008caf50?, 0xc00096ec00?, 0x0?})
	/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/vendor/github.com/onsi/ginkgo/v2/core_dsl.go:335 +0x225
github.com/onsi/gomega/internal.(*Assertion).match(0xc0005dc300, {0x1c4ca58, 0x2987488}, 0x0, {0x0, 0x0, 0x0})
	/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/vendor/github.com/onsi/gomega/internal/assertion.go:105 +0x1f0
github.com/onsi/gomega/internal.(*Assertion).NotTo(0xc0005dc300, {0x1c4ca58, 0x2987488}, {0x0, 0x0, 0x0})
	/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/vendor/github.com/onsi/gomega/internal/assertion.go:73 +0xb2
sigs.k8s.io/cloud-provider-azure/tests/e2e/network.getAzureLoadBalancerFromPIP(0xc000346700, {0xc00074df90?, 0x0?}, {0xc00025d3cb?, 0x0?}, {0x0, 0x0})
... skipping 17 lines ...
created by github.com/onsi/ginkgo/v2/internal.(*Suite).runNode
	/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/vendor/github.com/onsi/ginkgo/v2/internal/suite.go:593 +0x60c
Sep  4 13:55:41.845: INFO: Deleting service annotation-test in namespace e2e-tests-service-stnpf [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:47]
Sep  4 13:56:18.017: INFO: Deleting public IP resource named 20.69.120.208 in resource group kubetest-vnufys1h [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:322]
Sep  4 13:56:18.470: INFO: Deleting namespace e2e-tests-service-stnpf [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:134]

Ginkgo: Attempt #1 Failed.  Retrying...
Sep  4 13:56:24.648: INFO: Creating a kubernetes client [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:55]
Sep  4 13:56:24.648: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:63]
Sep  4 13:56:24.709: INFO: Created a test namespace "e2e-tests-service-tlvlk" [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:109]
Sep  4 13:56:24.709: INFO: Creating Azure clients [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:89]
Sep  4 13:56:24.709: INFO: Creating a kubernetes client [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:55]
Sep  4 13:56:24.709: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:63]
... skipping 2 lines ...
Sep  4 13:56:25.013: INFO: 3 pods in namespace e2e-tests-service-tlvlk are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
Sep  4 13:56:35.134: INFO: 0 pods in namespace e2e-tests-service-tlvlk are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
STEP: Creating a service with health probe annotations 09/04/22 13:56:35.134
Sep  4 13:56:35.135: INFO: Creating service annotation-test in namespace e2e-tests-service-tlvlk [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:949]
Sep  4 13:56:35.211: INFO: Successfully created LoadBalancer service annotation-test in namespace e2e-tests-service-tlvlk [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:953]
Sep  4 13:56:35.211: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:956]
Sep  4 13:56:35.268: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 13:56:45.333: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 13:56:55.325: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 13:57:05.325: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 13:57:15.327: INFO: Exposure successfully, get external ip: 20.94.226.169 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
Sep  4 13:57:15.327: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-tlvlk to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
Sep  4 13:57:15.450: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
Sep  4 13:57:25.517: INFO: checking the connectivity of addr 20.94.226.169:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
Sep  4 13:57:25.517: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
Sep  4 13:57:25.518: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-service-tlvlk exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  20.94.226.169 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 36 lines ...
    Sep  4 13:54:39.405: INFO: 5 pods in namespace e2e-tests-service-stnpf are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
    Sep  4 13:54:49.526: INFO: 0 pods in namespace e2e-tests-service-stnpf are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
    STEP: Creating a service with health probe annotations 09/04/22 13:54:49.526
    Sep  4 13:54:49.527: INFO: Creating service annotation-test in namespace e2e-tests-service-stnpf [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:949]
    Sep  4 13:54:49.617: INFO: Successfully created LoadBalancer service annotation-test in namespace e2e-tests-service-stnpf [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:953]
    Sep  4 13:54:49.617: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:956]
    Sep  4 13:54:49.688: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 13:54:59.750: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 13:55:09.745: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 13:55:19.750: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 13:55:29.753: INFO: Exposure successfully, get external ip: 20.69.120.208 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
    Sep  4 13:55:29.753: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-stnpf to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
    Sep  4 13:55:29.873: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
    Sep  4 13:55:39.938: INFO: checking the connectivity of addr 20.69.120.208:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
    Sep  4 13:55:39.938: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
    Sep  4 13:55:39.938: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-service-stnpf exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  20.69.120.208 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 12 lines ...
    Sep  4 13:55:41.571: INFO: Getting loadBalancer [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:937]
    STEP: Cleaning up service and public IP 09/04/22 13:55:41.845
    Sep  4 13:55:41.845: INFO: Deleting service annotation-test in namespace e2e-tests-service-stnpf [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:47]
    Sep  4 13:56:18.017: INFO: Deleting public IP resource named 20.69.120.208 in resource group kubetest-vnufys1h [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:322]
    Sep  4 13:56:18.470: INFO: Deleting namespace e2e-tests-service-stnpf [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:134]

    Ginkgo: Attempt #1 Failed.  Retrying...
    Sep  4 13:56:24.648: INFO: Creating a kubernetes client [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:55]
    Sep  4 13:56:24.648: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:63]
    Sep  4 13:56:24.709: INFO: Created a test namespace "e2e-tests-service-tlvlk" [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:109]
    Sep  4 13:56:24.709: INFO: Creating Azure clients [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:89]
    Sep  4 13:56:24.709: INFO: Creating a kubernetes client [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:55]
    Sep  4 13:56:24.709: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:63]
... skipping 2 lines ...
    Sep  4 13:56:25.013: INFO: 3 pods in namespace e2e-tests-service-tlvlk are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
    Sep  4 13:56:35.134: INFO: 0 pods in namespace e2e-tests-service-tlvlk are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
    STEP: Creating a service with health probe annotations 09/04/22 13:56:35.134
    Sep  4 13:56:35.135: INFO: Creating service annotation-test in namespace e2e-tests-service-tlvlk [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:949]
    Sep  4 13:56:35.211: INFO: Successfully created LoadBalancer service annotation-test in namespace e2e-tests-service-tlvlk [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:953]
    Sep  4 13:56:35.211: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:956]
    Sep  4 13:56:35.268: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 13:56:45.333: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 13:56:55.325: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 13:57:05.325: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 13:57:15.327: INFO: Exposure successfully, get external ip: 20.94.226.169 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
    Sep  4 13:57:15.327: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-tlvlk to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
    Sep  4 13:57:15.450: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
    Sep  4 13:57:25.517: INFO: checking the connectivity of addr 20.94.226.169:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
    Sep  4 13:57:25.517: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
    Sep  4 13:57:25.518: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-service-tlvlk exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  20.94.226.169 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 463 lines ...
STEP: Getting agent nodes list 09/04/22 14:22:21.106
STEP: Get vmss names from node providerIDs 09/04/22 14:22:21.215
Sep  4 14:22:21.215: INFO: Got vmss names [k8s-agentpool1-41080019-vmss k8s-agentpool2-41080019-vmss] [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:672]
STEP: Creating service vmss-test-k8s-agentpool1-41080019-vmss in namespace e2e-tests-vmssservice-xgccg 09/04/22 14:22:21.215
Sep  4 14:22:21.296: INFO: Successfully created LoadBalancer service vmss-test-k8s-agentpool1-41080019-vmss in namespace e2e-tests-vmssservice-xgccg [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1029]
STEP: Waiting for service exposure 09/04/22 14:22:21.296
Sep  4 14:22:21.372: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:22:31.435: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:22:41.436: INFO: Exposure successfully, get external ip: 20.112.97.16 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
Sep  4 14:22:41.436: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-vmssservice-xgccg to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
Sep  4 14:22:41.545: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
Sep  4 14:22:51.606: INFO: checking the connectivity of addr 20.112.97.16:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
Sep  4 14:22:51.606: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
Sep  4 14:22:51.606: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-vmssservice-xgccg exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  20.112.97.16 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 8 lines ...
STEP: Getting loadBalancer 09/04/22 14:22:52.963
STEP: Getting loadBalancer backendPoolID 09/04/22 14:22:53.201
STEP: Validating loadBalancer backendPool 09/04/22 14:22:53.201
STEP: Creating service vmss-test-k8s-agentpool2-41080019-vmss in namespace e2e-tests-vmssservice-xgccg 09/04/22 14:22:53.201
Sep  4 14:22:53.275: INFO: Successfully created LoadBalancer service vmss-test-k8s-agentpool2-41080019-vmss in namespace e2e-tests-vmssservice-xgccg [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1029]
STEP: Waiting for service exposure 09/04/22 14:22:53.275
Sep  4 14:22:53.341: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:23:03.402: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:23:13.398: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:23:23.395: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:23:33.401: INFO: Exposure successfully, get external ip: 20.69.157.58 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
Sep  4 14:23:33.402: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-vmssservice-xgccg to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
Sep  4 14:23:33.515: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
Sep  4 14:23:43.578: INFO: checking the connectivity of addr 20.69.157.58:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
Sep  4 14:23:43.578: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
Sep  4 14:23:43.578: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-vmssservice-xgccg exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  20.69.157.58 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 27 lines ...
    STEP: Getting agent nodes list 09/04/22 14:22:21.106
    STEP: Get vmss names from node providerIDs 09/04/22 14:22:21.215
    Sep  4 14:22:21.215: INFO: Got vmss names [k8s-agentpool1-41080019-vmss k8s-agentpool2-41080019-vmss] [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:672]
    STEP: Creating service vmss-test-k8s-agentpool1-41080019-vmss in namespace e2e-tests-vmssservice-xgccg 09/04/22 14:22:21.215
    Sep  4 14:22:21.296: INFO: Successfully created LoadBalancer service vmss-test-k8s-agentpool1-41080019-vmss in namespace e2e-tests-vmssservice-xgccg [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1029]
    STEP: Waiting for service exposure 09/04/22 14:22:21.296
    Sep  4 14:22:21.372: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:22:31.435: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:22:41.436: INFO: Exposure successfully, get external ip: 20.112.97.16 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
    Sep  4 14:22:41.436: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-vmssservice-xgccg to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
    Sep  4 14:22:41.545: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
    Sep  4 14:22:51.606: INFO: checking the connectivity of addr 20.112.97.16:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
    Sep  4 14:22:51.606: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
    Sep  4 14:22:51.606: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-vmssservice-xgccg exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  20.112.97.16 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 8 lines ...
    STEP: Getting loadBalancer 09/04/22 14:22:52.963
    STEP: Getting loadBalancer backendPoolID 09/04/22 14:22:53.201
    STEP: Validating loadBalancer backendPool 09/04/22 14:22:53.201
    STEP: Creating service vmss-test-k8s-agentpool2-41080019-vmss in namespace e2e-tests-vmssservice-xgccg 09/04/22 14:22:53.201
    Sep  4 14:22:53.275: INFO: Successfully created LoadBalancer service vmss-test-k8s-agentpool2-41080019-vmss in namespace e2e-tests-vmssservice-xgccg [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1029]
    STEP: Waiting for service exposure 09/04/22 14:22:53.275
    Sep  4 14:22:53.341: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:23:03.402: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:23:13.398: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:23:23.395: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:23:33.401: INFO: Exposure successfully, get external ip: 20.69.157.58 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
    Sep  4 14:23:33.402: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-vmssservice-xgccg to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
    Sep  4 14:23:33.515: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
    Sep  4 14:23:43.578: INFO: checking the connectivity of addr 20.69.157.58:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
    Sep  4 14:23:43.578: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
    Sep  4 14:23:43.578: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-vmssservice-xgccg exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  20.69.157.58 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 96 lines ...
Sep  4 14:26:39.138: INFO: 3 pods in namespace e2e-tests-nsg-kx55q are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
Sep  4 14:26:49.251: INFO: 0 pods in namespace e2e-tests-nsg-kx55q are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
STEP: Creating a service and expose it 09/04/22 14:26:49.251
Sep  4 14:26:49.251: INFO: Creating service nsg-test in namespace e2e-tests-nsg-kx55q [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:949]
Sep  4 14:26:49.327: INFO: Successfully created LoadBalancer service nsg-test in namespace e2e-tests-nsg-kx55q [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:953]
Sep  4 14:26:49.327: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:956]
Sep  4 14:26:49.381: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:26:59.438: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:27:09.447: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:27:19.439: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:27:29.440: INFO: Exposure successfully, get external ip: 20.112.103.189 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
Sep  4 14:27:29.440: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-nsg-kx55q to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
Sep  4 14:27:29.563: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
Sep  4 14:27:39.624: INFO: checking the connectivity of addr 20.112.103.189:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
Sep  4 14:27:39.624: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
Sep  4 14:27:39.624: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-nsg-kx55q exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  20.112.103.189 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 39 lines ...
    Sep  4 14:26:39.138: INFO: 3 pods in namespace e2e-tests-nsg-kx55q are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
    Sep  4 14:26:49.251: INFO: 0 pods in namespace e2e-tests-nsg-kx55q are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
    STEP: Creating a service and expose it 09/04/22 14:26:49.251
    Sep  4 14:26:49.251: INFO: Creating service nsg-test in namespace e2e-tests-nsg-kx55q [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:949]
    Sep  4 14:26:49.327: INFO: Successfully created LoadBalancer service nsg-test in namespace e2e-tests-nsg-kx55q [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:953]
    Sep  4 14:26:49.327: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:956]
    Sep  4 14:26:49.381: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:26:59.438: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:27:09.447: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:27:19.439: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:27:29.440: INFO: Exposure successfully, get external ip: 20.112.103.189 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
    Sep  4 14:27:29.440: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-nsg-kx55q to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
    Sep  4 14:27:29.563: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
    Sep  4 14:27:39.624: INFO: checking the connectivity of addr 20.112.103.189:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
    Sep  4 14:27:39.624: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
    Sep  4 14:27:39.624: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-nsg-kx55q exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  20.112.103.189 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 36 lines ...
Sep  4 14:29:46.379: INFO: 3 pods in namespace e2e-tests-nsg-2vcd5 are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
Sep  4 14:29:56.495: INFO: 0 pods in namespace e2e-tests-nsg-2vcd5 are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
STEP: Creating service and wait it to expose 09/04/22 14:29:56.495
Sep  4 14:29:56.495: INFO: Creating service nsg-test in namespace e2e-tests-nsg-2vcd5 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/network_security_group.go:150]
Sep  4 14:29:56.595: INFO: Successfully created LoadBalancer service nsg-test in namespace e2e-tests-nsg-2vcd5 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/network_security_group.go:154]
STEP: Waiting for the service to be exposed 09/04/22 14:29:56.595
Sep  4 14:29:56.653: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:30:06.710: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:30:16.713: INFO: Exposure successfully, get external ip: 20.125.50.129 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
STEP: Validating if the corresponding IP prefix existing in nsg 09/04/22 14:30:16.713
Sep  4 14:30:16.713: INFO: Getting virtual network list [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:140]
Sep  4 14:30:17.045: INFO: got sg list, length = 1 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:165]
Sep  4 14:30:17.105: INFO: Deleting namespace e2e-tests-nsg-2vcd5 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:134]
------------------------------
... skipping 14 lines ...
    Sep  4 14:29:46.379: INFO: 3 pods in namespace e2e-tests-nsg-2vcd5 are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
    Sep  4 14:29:56.495: INFO: 0 pods in namespace e2e-tests-nsg-2vcd5 are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
    STEP: Creating service and wait it to expose 09/04/22 14:29:56.495
    Sep  4 14:29:56.495: INFO: Creating service nsg-test in namespace e2e-tests-nsg-2vcd5 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/network_security_group.go:150]
    Sep  4 14:29:56.595: INFO: Successfully created LoadBalancer service nsg-test in namespace e2e-tests-nsg-2vcd5 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/network_security_group.go:154]
    STEP: Waiting for the service to be exposed 09/04/22 14:29:56.595
    Sep  4 14:29:56.653: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:30:06.710: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:30:16.713: INFO: Exposure successfully, get external ip: 20.125.50.129 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
    STEP: Validating if the corresponding IP prefix existing in nsg 09/04/22 14:30:16.713
    Sep  4 14:30:16.713: INFO: Getting virtual network list [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:140]
    Sep  4 14:30:17.045: INFO: got sg list, length = 1 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:165]
    Sep  4 14:30:17.105: INFO: Deleting namespace e2e-tests-nsg-2vcd5 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:134]
  << End Captured GinkgoWriter Output
... skipping 9 lines ...
Sep  4 14:31:35.526: INFO: Creating deployment nsg-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/network_security_group.go:69]
Sep  4 14:31:35.587: INFO: Waiting for backend pods to be ready [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/network_security_group.go:74]
Sep  4 14:31:35.654: INFO: 3 pods in namespace e2e-tests-nsg-xvnqm are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
Sep  4 14:31:45.776: INFO: 0 pods in namespace e2e-tests-nsg-xvnqm are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
STEP: Creating a test service with the deny rule annotation but without `service.Spec.LoadBalancerSourceRanges` 09/04/22 14:31:45.776
STEP: Waiting for the service to expose 09/04/22 14:31:45.857
Sep  4 14:31:45.913: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:31:55.975: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:32:05.971: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:32:15.979: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:32:25.978: INFO: Exposure successfully, get external ip: 10.240.0.8 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
Sep  4 14:32:25.978: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-nsg-xvnqm to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
Sep  4 14:32:26.101: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
Sep  4 14:32:36.158: INFO: checking the connectivity of addr 10.240.0.8:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
Sep  4 14:32:36.159: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
Sep  4 14:32:36.159: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-nsg-xvnqm exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  10.240.0.8 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 9 lines ...
STEP: Deleting the service 09/04/22 14:32:37.658
Sep  4 14:32:37.659: INFO: Deleting service nsg-test in namespace e2e-tests-nsg-xvnqm [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:47]
STEP: Creating a test service with the deny rule annotation and `service.Spec.LoadBalancerSourceRanges` 09/04/22 14:33:11.835
Sep  4 14:33:11.835: INFO: Creating a hostNetwork Pod exec-agnhost-pod-deny-all-except-lb-range in namespace e2e-tests-nsg-xvnqm to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
Sep  4 14:33:11.954: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
STEP: Waiting for the service to expose 09/04/22 14:33:22.154
Sep  4 14:33:22.210: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:33:32.271: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:33:42.268: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:33:52.273: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:34:02.268: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:34:12.267: INFO: Exposure successfully, get external ip: 10.240.0.8 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
Sep  4 14:34:12.267: INFO: checking the connectivity of addr 10.240.0.8:80 with protocol  [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/network_security_group.go:230]
Sep  4 14:34:12.268: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
Sep  4 14:34:12.268: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-nsg-xvnqm exec exec-agnhost-pod-deny-all-except-lb-range -- /bin/sh -x -c nc -vz -w 4  10.240.0.8 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
Sep  4 14:34:13.106: INFO: stderr: "+ nc -vz -w 4 10.240.0.8 80\nConnection to 10.240.0.8 80 port [tcp/http] succeeded!\n" [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:165]
Sep  4 14:34:13.106: INFO: stdout: "" [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:166]
... skipping 27 lines ...
    Sep  4 14:31:35.526: INFO: Creating deployment nsg-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/network_security_group.go:69]
    Sep  4 14:31:35.587: INFO: Waiting for backend pods to be ready [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/network_security_group.go:74]
    Sep  4 14:31:35.654: INFO: 3 pods in namespace e2e-tests-nsg-xvnqm are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
    Sep  4 14:31:45.776: INFO: 0 pods in namespace e2e-tests-nsg-xvnqm are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
    STEP: Creating a test service with the deny rule annotation but without `service.Spec.LoadBalancerSourceRanges` 09/04/22 14:31:45.776
    STEP: Waiting for the service to expose 09/04/22 14:31:45.857
    Sep  4 14:31:45.913: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:31:55.975: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:32:05.971: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:32:15.979: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:32:25.978: INFO: Exposure successfully, get external ip: 10.240.0.8 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
    Sep  4 14:32:25.978: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-nsg-xvnqm to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
    Sep  4 14:32:26.101: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
    Sep  4 14:32:36.158: INFO: checking the connectivity of addr 10.240.0.8:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
    Sep  4 14:32:36.159: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
    Sep  4 14:32:36.159: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-nsg-xvnqm exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  10.240.0.8 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 9 lines ...
    STEP: Deleting the service 09/04/22 14:32:37.658
    Sep  4 14:32:37.659: INFO: Deleting service nsg-test in namespace e2e-tests-nsg-xvnqm [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:47]
    STEP: Creating a test service with the deny rule annotation and `service.Spec.LoadBalancerSourceRanges` 09/04/22 14:33:11.835
    Sep  4 14:33:11.835: INFO: Creating a hostNetwork Pod exec-agnhost-pod-deny-all-except-lb-range in namespace e2e-tests-nsg-xvnqm to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
    Sep  4 14:33:11.954: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
    STEP: Waiting for the service to expose 09/04/22 14:33:22.154
    Sep  4 14:33:22.210: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:33:32.271: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:33:42.268: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:33:52.273: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:34:02.268: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:34:12.267: INFO: Exposure successfully, get external ip: 10.240.0.8 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
    Sep  4 14:34:12.267: INFO: checking the connectivity of addr 10.240.0.8:80 with protocol  [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/network_security_group.go:230]
    Sep  4 14:34:12.268: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
    Sep  4 14:34:12.268: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-nsg-xvnqm exec exec-agnhost-pod-deny-all-except-lb-range -- /bin/sh -x -c nc -vz -w 4  10.240.0.8 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
    Sep  4 14:34:13.106: INFO: stderr: "+ nc -vz -w 4 10.240.0.8 80\nConnection to 10.240.0.8 80 port [tcp/http] succeeded!\n" [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:165]
    Sep  4 14:34:13.106: INFO: stdout: "" [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:166]
... skipping 26 lines ...
Sep  4 14:34:58.128: INFO: 3 pods in namespace e2e-tests-nsg-rxcgm are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
Sep  4 14:35:08.249: INFO: 0 pods in namespace e2e-tests-nsg-rxcgm are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
STEP: Creating a public IP with tags 09/04/22 14:35:08.249
Sep  4 14:35:08.249: INFO: Creating public IP resource named nsg-public-IP-disable-floating-ip [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:196]
Sep  4 14:35:12.522: INFO: created pip with address 20.112.102.0 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/network_security_group.go:253]
STEP: Creating a test load balancer service with floating IP disabled 09/04/22 14:35:12.522
Sep  4 14:35:12.650: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:35:22.707: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:35:32.707: INFO: Exposure successfully, get external ip: 20.112.102.0 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
Sep  4 14:35:32.707: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-nsg-rxcgm to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
Sep  4 14:35:32.827: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
Sep  4 14:35:42.885: INFO: checking the connectivity of addr 20.112.102.0:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
Sep  4 14:35:42.885: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
Sep  4 14:35:42.885: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-nsg-rxcgm exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  20.112.102.0 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 26 lines ...
    Sep  4 14:34:58.128: INFO: 3 pods in namespace e2e-tests-nsg-rxcgm are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
    Sep  4 14:35:08.249: INFO: 0 pods in namespace e2e-tests-nsg-rxcgm are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
    STEP: Creating a public IP with tags 09/04/22 14:35:08.249
    Sep  4 14:35:08.249: INFO: Creating public IP resource named nsg-public-IP-disable-floating-ip [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:196]
    Sep  4 14:35:12.522: INFO: created pip with address 20.112.102.0 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/network_security_group.go:253]
    STEP: Creating a test load balancer service with floating IP disabled 09/04/22 14:35:12.522
    Sep  4 14:35:12.650: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:35:22.707: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:35:32.707: INFO: Exposure successfully, get external ip: 20.112.102.0 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
    Sep  4 14:35:32.707: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-nsg-rxcgm to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
    Sep  4 14:35:32.827: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
    Sep  4 14:35:42.885: INFO: checking the connectivity of addr 20.112.102.0:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
    Sep  4 14:35:42.885: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
    Sep  4 14:35:42.885: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-nsg-rxcgm exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  20.112.102.0 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 18 lines ...
Sep  4 14:36:48.982: INFO: Created a test namespace "e2e-tests-service-lb-qxdfx" [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:109]
Sep  4 14:36:48.983: INFO: Creating a kubernetes client [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:55]
Sep  4 14:36:48.983: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:63]
Sep  4 14:36:49.149: INFO: Creating deployment deployment-lb-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:92]
Sep  4 14:36:49.209: INFO: Updating deployment deployment-lb-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:111]
STEP: creating a mixed protocol service 09/04/22 14:36:49.281
Sep  4 14:36:49.503: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:36:59.571: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:37:09.561: INFO: Exposure successfully, get external ip: 20.230.138.246 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
Sep  4 14:37:09.561: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-lb-qxdfx to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
Sep  4 14:37:09.682: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
Sep  4 14:37:19.748: INFO: checking the connectivity of addr 20.230.138.246:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
Sep  4 14:37:19.749: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
Sep  4 14:37:19.749: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-service-lb-qxdfx exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  20.230.138.246 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 28 lines ...
    Sep  4 14:36:48.982: INFO: Created a test namespace "e2e-tests-service-lb-qxdfx" [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:109]
    Sep  4 14:36:48.983: INFO: Creating a kubernetes client [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:55]
    Sep  4 14:36:48.983: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:63]
    Sep  4 14:36:49.149: INFO: Creating deployment deployment-lb-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:92]
    Sep  4 14:36:49.209: INFO: Updating deployment deployment-lb-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:111]
    STEP: creating a mixed protocol service 09/04/22 14:36:49.281
    Sep  4 14:36:49.503: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:36:59.571: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:37:09.561: INFO: Exposure successfully, get external ip: 20.230.138.246 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
    Sep  4 14:37:09.561: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-lb-qxdfx to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
    Sep  4 14:37:09.682: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
    Sep  4 14:37:19.748: INFO: checking the connectivity of addr 20.230.138.246:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
    Sep  4 14:37:19.749: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
    Sep  4 14:37:19.749: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-service-lb-qxdfx exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  20.230.138.246 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 27 lines ...
Sep  4 14:38:52.597: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:63]
Sep  4 14:38:52.767: INFO: Creating deployment deployment-lb-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:92]
STEP: creating a public IP with tags 09/04/22 14:38:52.829
Sep  4 14:38:52.830: INFO: Creating public IP resource named service-lb-public-IP6670 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:196]
Sep  4 14:38:54.561: INFO: created pip with address 20.230.140.106 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:170]
STEP: creating a service referencing the public IP 09/04/22 14:38:54.561
Sep  4 14:38:54.713: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:39:04.778: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:39:14.779: INFO: Exposure successfully, get external ip: 20.230.140.106 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
Sep  4 14:39:14.779: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-lb-rsgcg to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
Sep  4 14:39:14.895: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
Sep  4 14:39:24.953: INFO: checking the connectivity of addr 20.230.140.106:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
Sep  4 14:39:24.953: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
Sep  4 14:39:24.953: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-service-lb-rsgcg exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  20.230.140.106 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 23 lines ...
    Sep  4 14:38:52.597: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:63]
    Sep  4 14:38:52.767: INFO: Creating deployment deployment-lb-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:92]
    STEP: creating a public IP with tags 09/04/22 14:38:52.829
    Sep  4 14:38:52.830: INFO: Creating public IP resource named service-lb-public-IP6670 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:196]
    Sep  4 14:38:54.561: INFO: created pip with address 20.230.140.106 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:170]
    STEP: creating a service referencing the public IP 09/04/22 14:38:54.561
    Sep  4 14:38:54.713: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:39:04.778: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:39:14.779: INFO: Exposure successfully, get external ip: 20.230.140.106 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
    Sep  4 14:39:14.779: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-lb-rsgcg to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
    Sep  4 14:39:14.895: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
    Sep  4 14:39:24.953: INFO: checking the connectivity of addr 20.230.140.106:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
    Sep  4 14:39:24.953: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
    Sep  4 14:39:24.953: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-service-lb-rsgcg exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  20.230.140.106 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 20 lines ...
Sep  4 14:40:31.076: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:63]
Sep  4 14:40:31.242: INFO: Creating deployment deployment-lb-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:92]
Sep  4 14:40:31.443: INFO: Successfully created LoadBalancer service service-lb-test in namespace e2e-tests-service-lb-zz9j2 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:204]
Sep  4 14:40:31.443: INFO: Creating public IP resource named service-lb-public-none-IP3592 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:196]
Sep  4 14:40:35.132: INFO: PIP to 20.230.140.106 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:209]
STEP: Waiting for exposure of the original service without assigned lb IP 09/04/22 14:40:35.132
Sep  4 14:40:35.189: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:40:45.247: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:40:55.255: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:41:05.254: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:41:15.251: INFO: Exposure successfully, get external ip: 20.230.139.145 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
Sep  4 14:41:15.251: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-lb-zz9j2 to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
Sep  4 14:41:15.371: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
Sep  4 14:41:25.430: INFO: checking the connectivity of addr 20.230.139.145:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
Sep  4 14:41:25.430: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
Sep  4 14:41:25.430: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-service-lb-zz9j2 exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  20.230.139.145 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 38 lines ...
    Sep  4 14:40:31.076: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:63]
    Sep  4 14:40:31.242: INFO: Creating deployment deployment-lb-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:92]
    Sep  4 14:40:31.443: INFO: Successfully created LoadBalancer service service-lb-test in namespace e2e-tests-service-lb-zz9j2 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:204]
    Sep  4 14:40:31.443: INFO: Creating public IP resource named service-lb-public-none-IP3592 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:196]
    Sep  4 14:40:35.132: INFO: PIP to 20.230.140.106 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:209]
    STEP: Waiting for exposure of the original service without assigned lb IP 09/04/22 14:40:35.132
    Sep  4 14:40:35.189: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:40:45.247: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:40:55.255: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:41:05.254: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:41:15.251: INFO: Exposure successfully, get external ip: 20.230.139.145 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
    Sep  4 14:41:15.251: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-lb-zz9j2 to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
    Sep  4 14:41:15.371: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
    Sep  4 14:41:25.430: INFO: checking the connectivity of addr 20.230.139.145:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
    Sep  4 14:41:25.430: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
    Sep  4 14:41:25.430: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-service-lb-zz9j2 exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  20.230.139.145 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 34 lines ...
Sep  4 14:43:43.259: INFO: Creating a kubernetes client [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:55]
Sep  4 14:43:43.259: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:63]
Sep  4 14:43:43.428: INFO: Creating deployment deployment-lb-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:92]
Sep  4 14:43:43.491: INFO: Getting virtual network list [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:37]
Sep  4 14:43:45.926: INFO: Successfully created LoadBalancer service service-lb-test in namespace e2e-tests-service-lb-bmwbr [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:247]
STEP: Waiting for exposure of internal service with specific IP "10.240.0.8" 09/04/22 14:43:45.927
Sep  4 14:43:45.983: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:43:56.050: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:44:06.048: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:44:16.048: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:44:26.045: INFO: Exposure successfully, get external ip: 10.240.0.8 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
Sep  4 14:44:26.046: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-lb-bmwbr to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
Sep  4 14:44:26.166: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
Sep  4 14:44:36.225: INFO: checking the connectivity of addr 10.240.0.8:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
Sep  4 14:44:36.225: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
Sep  4 14:44:36.225: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-service-lb-bmwbr exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  10.240.0.8 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 77 lines ...
    Sep  4 14:43:43.259: INFO: Creating a kubernetes client [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:55]
    Sep  4 14:43:43.259: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:63]
    Sep  4 14:43:43.428: INFO: Creating deployment deployment-lb-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:92]
    Sep  4 14:43:43.491: INFO: Getting virtual network list [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:37]
    Sep  4 14:43:45.926: INFO: Successfully created LoadBalancer service service-lb-test in namespace e2e-tests-service-lb-bmwbr [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:247]
    STEP: Waiting for exposure of internal service with specific IP "10.240.0.8" 09/04/22 14:43:45.927
    Sep  4 14:43:45.983: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:43:56.050: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:44:06.048: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:44:16.048: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:44:26.045: INFO: Exposure successfully, get external ip: 10.240.0.8 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
    Sep  4 14:44:26.046: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-lb-bmwbr to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
    Sep  4 14:44:26.166: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
    Sep  4 14:44:36.225: INFO: checking the connectivity of addr 10.240.0.8:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
    Sep  4 14:44:36.225: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
    Sep  4 14:44:36.225: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-service-lb-bmwbr exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  10.240.0.8 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 74 lines ...
Sep  4 14:46:31.657: INFO: Creating a kubernetes client [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:55]
Sep  4 14:46:31.657: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:63]
Sep  4 14:46:31.825: INFO: Creating deployment deployment-lb-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:92]
Sep  4 14:46:32.017: INFO: Successfully created LoadBalancer service service-lb-test in namespace e2e-tests-service-lb-kwggc [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:288]
Sep  4 14:46:32.017: INFO: Creating public IP resource named service-lb-internal-none-public-IP9267 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:196]
STEP: Waiting for exposure of the original service without assigned lb private IP 09/04/22 14:46:36.446
Sep  4 14:46:36.529: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:46:46.591: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:46:56.594: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:47:06.592: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:47:16.587: INFO: Exposure successfully, get external ip: 10.240.0.8 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
Sep  4 14:47:16.587: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-lb-kwggc to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
Sep  4 14:47:16.708: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
Sep  4 14:47:26.767: INFO: checking the connectivity of addr 10.240.0.8:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
Sep  4 14:47:26.767: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
Sep  4 14:47:26.767: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-service-lb-kwggc exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  10.240.0.8 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 76 lines ...
    Sep  4 14:46:31.657: INFO: Creating a kubernetes client [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:55]
    Sep  4 14:46:31.657: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:63]
    Sep  4 14:46:31.825: INFO: Creating deployment deployment-lb-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:92]
    Sep  4 14:46:32.017: INFO: Successfully created LoadBalancer service service-lb-test in namespace e2e-tests-service-lb-kwggc [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:288]
    Sep  4 14:46:32.017: INFO: Creating public IP resource named service-lb-internal-none-public-IP9267 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:196]
    STEP: Waiting for exposure of the original service without assigned lb private IP 09/04/22 14:46:36.446
    Sep  4 14:46:36.529: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:46:46.591: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:46:56.594: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:47:06.592: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:47:16.587: INFO: Exposure successfully, get external ip: 10.240.0.8 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
    Sep  4 14:47:16.587: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-lb-kwggc to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
    Sep  4 14:47:16.708: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
    Sep  4 14:47:26.767: INFO: checking the connectivity of addr 10.240.0.8:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
    Sep  4 14:47:26.767: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
    Sep  4 14:47:26.767: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-service-lb-kwggc exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  10.240.0.8 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 76 lines ...
Sep  4 14:50:14.455: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:63]
Sep  4 14:50:14.621: INFO: Creating deployment deployment-lb-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:92]
Sep  4 14:50:14.681: INFO: Creating public IP resource named service-lb-public-remain-cbf1 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:196]
Sep  4 14:50:18.695: INFO: Creating Service "service-lb-test-0" [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:416]
Sep  4 14:50:18.774: INFO: Creating deployment "deployment-lb-test-1" [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:402]
Sep  4 14:50:18.840: INFO: Creating Service "service-lb-test-1" [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:416]
Sep  4 14:50:19.047: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:50:29.115: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:50:39.107: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:50:49.113: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:50:59.106: INFO: Exposure successfully, get external ip: 20.236.38.233 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
Sep  4 14:50:59.106: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-lb-rc7qm to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
Sep  4 14:50:59.231: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
Sep  4 14:51:09.290: INFO: checking the connectivity of addr 20.236.38.233:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
Sep  4 14:51:09.290: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
Sep  4 14:51:09.291: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-service-lb-rc7qm exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  20.236.38.233 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
Sep  4 14:51:10.134: INFO: stderr: "+ nc -vz -w 4 20.236.38.233 80\nConnection to 20.236.38.233 80 port [tcp/http] succeeded!\n" [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:165]
Sep  4 14:51:10.134: INFO: stdout: "" [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:166]
Sep  4 14:51:10.134: INFO: Validation succeeded: Service addr 20.236.38.233:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:201]
Sep  4 14:51:10.221: INFO: Deleting pod exec-agnhost-pod in namespace e2e-tests-service-lb-rc7qm [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:118]
Sep  4 14:51:10.277: INFO: Successfully created LoadBalancer Service "service-lb-test-0" in namespace e2e-tests-service-lb-rc7qm with IP 20.236.38.233 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:435]
Sep  4 14:51:10.333: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:51:20.391: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:51:30.392: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:51:40.399: INFO: Exposure successfully, get external ip: 20.236.38.233 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
Sep  4 14:51:40.400: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-lb-rc7qm to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
Sep  4 14:51:40.528: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
Sep  4 14:51:50.586: INFO: checking the connectivity of addr 20.236.38.233:81 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
Sep  4 14:51:50.586: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
Sep  4 14:51:50.586: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-service-lb-rc7qm exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  20.236.38.233 81' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 21 lines ...
    Sep  4 14:50:14.455: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:63]
    Sep  4 14:50:14.621: INFO: Creating deployment deployment-lb-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:92]
    Sep  4 14:50:14.681: INFO: Creating public IP resource named service-lb-public-remain-cbf1 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:196]
    Sep  4 14:50:18.695: INFO: Creating Service "service-lb-test-0" [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:416]
    Sep  4 14:50:18.774: INFO: Creating deployment "deployment-lb-test-1" [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:402]
    Sep  4 14:50:18.840: INFO: Creating Service "service-lb-test-1" [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:416]
    Sep  4 14:50:19.047: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:50:29.115: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:50:39.107: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:50:49.113: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:50:59.106: INFO: Exposure successfully, get external ip: 20.236.38.233 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
    Sep  4 14:50:59.106: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-lb-rc7qm to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
    Sep  4 14:50:59.231: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
    Sep  4 14:51:09.290: INFO: checking the connectivity of addr 20.236.38.233:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
    Sep  4 14:51:09.290: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
    Sep  4 14:51:09.291: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-service-lb-rc7qm exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  20.236.38.233 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
    Sep  4 14:51:10.134: INFO: stderr: "+ nc -vz -w 4 20.236.38.233 80\nConnection to 20.236.38.233 80 port [tcp/http] succeeded!\n" [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:165]
    Sep  4 14:51:10.134: INFO: stdout: "" [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:166]
    Sep  4 14:51:10.134: INFO: Validation succeeded: Service addr 20.236.38.233:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:201]
    Sep  4 14:51:10.221: INFO: Deleting pod exec-agnhost-pod in namespace e2e-tests-service-lb-rc7qm [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:118]
    Sep  4 14:51:10.277: INFO: Successfully created LoadBalancer Service "service-lb-test-0" in namespace e2e-tests-service-lb-rc7qm with IP 20.236.38.233 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:435]
    Sep  4 14:51:10.333: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:51:20.391: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:51:30.392: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:51:40.399: INFO: Exposure successfully, get external ip: 20.236.38.233 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
    Sep  4 14:51:40.400: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-lb-rc7qm to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
    Sep  4 14:51:40.528: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
    Sep  4 14:51:50.586: INFO: checking the connectivity of addr 20.236.38.233:81 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
    Sep  4 14:51:50.586: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
    Sep  4 14:51:50.586: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-service-lb-rc7qm exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  20.236.38.233 81' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 14 lines ...
Sep  4 14:53:14.867: INFO: Creating a kubernetes client [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:55]
Sep  4 14:53:14.867: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:63]
Sep  4 14:53:14.933: INFO: Created a test namespace "e2e-tests-service-lb-dp4ml" [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:109]
Sep  4 14:53:14.934: INFO: Creating a kubernetes client [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:55]
Sep  4 14:53:14.934: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:63]
Sep  4 14:53:15.100: INFO: Creating deployment deployment-lb-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:92]
Sep  4 14:53:15.360: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:53:25.425: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:53:35.418: INFO: Exposure successfully, get external ip: 20.230.216.149 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
Sep  4 14:53:35.418: INFO: Creating deployment deployment-lb-test-1 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:450]
Sep  4 14:53:35.664: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:53:45.729: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:53:55.731: INFO: Exposure successfully, get external ip: 20.230.216.149 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
Sep  4 14:53:55.787: INFO: Exposure successfully, get external ip: 20.230.216.149 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
Sep  4 14:53:55.787: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-lb-dp4ml to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
Sep  4 14:53:55.909: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
Sep  4 14:54:05.967: INFO: checking the connectivity of addr 20.230.216.149:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
Sep  4 14:54:05.967: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
... skipping 41 lines ...
    Sep  4 14:53:14.867: INFO: Creating a kubernetes client [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:55]
    Sep  4 14:53:14.867: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:63]
    Sep  4 14:53:14.933: INFO: Created a test namespace "e2e-tests-service-lb-dp4ml" [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:109]
    Sep  4 14:53:14.934: INFO: Creating a kubernetes client [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:55]
    Sep  4 14:53:14.934: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:63]
    Sep  4 14:53:15.100: INFO: Creating deployment deployment-lb-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:92]
    Sep  4 14:53:15.360: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:53:25.425: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:53:35.418: INFO: Exposure successfully, get external ip: 20.230.216.149 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
    Sep  4 14:53:35.418: INFO: Creating deployment deployment-lb-test-1 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:450]
    Sep  4 14:53:35.664: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:53:45.729: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:53:55.731: INFO: Exposure successfully, get external ip: 20.230.216.149 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
    Sep  4 14:53:55.787: INFO: Exposure successfully, get external ip: 20.230.216.149 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
    Sep  4 14:53:55.787: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-lb-dp4ml to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
    Sep  4 14:53:55.909: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
    Sep  4 14:54:05.967: INFO: checking the connectivity of addr 20.230.216.149:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
    Sep  4 14:54:05.967: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
... skipping 38 lines ...
Sep  4 14:56:24.521: INFO: Creating a kubernetes client [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:55]
Sep  4 14:56:24.521: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:63]
Sep  4 14:56:24.580: INFO: Created a test namespace "e2e-tests-service-lb-4cqr5" [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:109]
Sep  4 14:56:24.580: INFO: Creating a kubernetes client [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:55]
Sep  4 14:56:24.580: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:63]
Sep  4 14:56:24.746: INFO: Creating deployment deployment-lb-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:92]
Sep  4 14:56:25.031: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:56:35.097: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:56:45.098: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:56:55.097: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:57:05.097: INFO: Exposure successfully, get external ip: 10.240.0.8 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
Sep  4 14:57:05.097: INFO: Creating deployment deployment-lb-test-1 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:537]
Sep  4 14:57:05.370: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:57:15.426: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 14:57:25.426: INFO: Exposure successfully, get external ip: 10.240.0.8 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
Sep  4 14:57:25.482: INFO: Exposure successfully, get external ip: 10.240.0.8 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
Sep  4 14:57:25.482: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-lb-4cqr5 to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
Sep  4 14:57:25.597: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
Sep  4 14:57:35.656: INFO: checking the connectivity of addr 10.240.0.8:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
Sep  4 14:57:35.656: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
... skipping 28 lines ...
    Sep  4 14:56:24.521: INFO: Creating a kubernetes client [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:55]
    Sep  4 14:56:24.521: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:63]
    Sep  4 14:56:24.580: INFO: Created a test namespace "e2e-tests-service-lb-4cqr5" [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:109]
    Sep  4 14:56:24.580: INFO: Creating a kubernetes client [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:55]
    Sep  4 14:56:24.580: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:63]
    Sep  4 14:56:24.746: INFO: Creating deployment deployment-lb-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:92]
    Sep  4 14:56:25.031: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:56:35.097: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:56:45.098: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:56:55.097: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:57:05.097: INFO: Exposure successfully, get external ip: 10.240.0.8 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
    Sep  4 14:57:05.097: INFO: Creating deployment deployment-lb-test-1 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:537]
    Sep  4 14:57:05.370: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:57:15.426: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 14:57:25.426: INFO: Exposure successfully, get external ip: 10.240.0.8 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
    Sep  4 14:57:25.482: INFO: Exposure successfully, get external ip: 10.240.0.8 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
    Sep  4 14:57:25.482: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-lb-4cqr5 to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
    Sep  4 14:57:25.597: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
    Sep  4 14:57:35.656: INFO: checking the connectivity of addr 10.240.0.8:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
    Sep  4 14:57:35.656: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
... skipping 61 lines ...
Sep  4 15:01:49.170: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:63]
Sep  4 15:01:49.339: INFO: Creating deployment deployment-lb-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:92]
STEP: creating a public IP with tags 09/04/22 15:01:49.398
Sep  4 15:01:49.399: INFO: Creating public IP resource named service-lb-public-IPf2af [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:196]
Sep  4 15:01:53.871: INFO: created pip with address 20.29.230.2 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:626]
STEP: creating a service referencing the public IP 09/04/22 15:01:53.872
Sep  4 15:01:54.021: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 15:02:04.090: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 15:02:14.079: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 15:02:24.087: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 15:02:34.092: INFO: Exposure successfully, get external ip: 20.29.230.2 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
Sep  4 15:02:34.092: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-lb-mpzz9 to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
Sep  4 15:02:34.215: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
Sep  4 15:02:44.273: INFO: checking the connectivity of addr 20.29.230.2:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
Sep  4 15:02:44.274: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
Sep  4 15:02:44.274: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-service-lb-mpzz9 exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  20.29.230.2 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 32 lines ...
    Sep  4 15:01:49.170: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:63]
    Sep  4 15:01:49.339: INFO: Creating deployment deployment-lb-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:92]
    STEP: creating a public IP with tags 09/04/22 15:01:49.398
    Sep  4 15:01:49.399: INFO: Creating public IP resource named service-lb-public-IPf2af [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:196]
    Sep  4 15:01:53.871: INFO: created pip with address 20.29.230.2 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:626]
    STEP: creating a service referencing the public IP 09/04/22 15:01:53.872
    Sep  4 15:01:54.021: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 15:02:04.090: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 15:02:14.079: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 15:02:24.087: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 15:02:34.092: INFO: Exposure successfully, get external ip: 20.29.230.2 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
    Sep  4 15:02:34.092: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-lb-mpzz9 to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
    Sep  4 15:02:34.215: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
    Sep  4 15:02:44.273: INFO: checking the connectivity of addr 20.29.230.2:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
    Sep  4 15:02:44.274: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
    Sep  4 15:02:44.274: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-service-lb-mpzz9 exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  20.29.230.2 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 76 lines ...
Sep  4 15:04:16.931: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:63]
Sep  4 15:04:17.096: INFO: Creating deployment deployment-lb-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:694]
STEP: Creating a service and expose it 09/04/22 15:04:17.155
Sep  4 15:04:17.156: INFO: Creating service service-lb-test in namespace e2e-tests-service-lb-vf2mj [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:949]
Sep  4 15:04:17.345: INFO: Successfully created LoadBalancer service service-lb-test in namespace e2e-tests-service-lb-vf2mj [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:953]
Sep  4 15:04:17.345: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:956]
Sep  4 15:04:17.403: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 15:04:27.466: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 15:04:37.468: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 15:04:47.461: INFO: Exposure successfully, get external ip: 20.236.18.243 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
Sep  4 15:04:47.461: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-lb-vf2mj to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
Sep  4 15:04:47.583: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
Sep  4 15:04:57.643: INFO: checking the connectivity of addr 20.236.18.243:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
Sep  4 15:04:57.643: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
Sep  4 15:04:57.643: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-service-lb-vf2mj exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  20.236.18.243 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 58 lines ...
    Sep  4 15:04:16.931: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:63]
    Sep  4 15:04:17.096: INFO: Creating deployment deployment-lb-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:694]
    STEP: Creating a service and expose it 09/04/22 15:04:17.155
    Sep  4 15:04:17.156: INFO: Creating service service-lb-test in namespace e2e-tests-service-lb-vf2mj [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:949]
    Sep  4 15:04:17.345: INFO: Successfully created LoadBalancer service service-lb-test in namespace e2e-tests-service-lb-vf2mj [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:953]
    Sep  4 15:04:17.345: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:956]
    Sep  4 15:04:17.403: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 15:04:27.466: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 15:04:37.468: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 15:04:47.461: INFO: Exposure successfully, get external ip: 20.236.18.243 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
    Sep  4 15:04:47.461: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-lb-vf2mj to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
    Sep  4 15:04:47.583: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
    Sep  4 15:04:57.643: INFO: checking the connectivity of addr 20.236.18.243:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
    Sep  4 15:04:57.643: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
    Sep  4 15:04:57.643: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-service-lb-vf2mj exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  20.236.18.243 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 54 lines ...
Sep  4 15:06:36.029: INFO: Creating a kubernetes client [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:55]
Sep  4 15:06:36.029: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:63]
Sep  4 15:06:36.198: INFO: Creating deployment deployment-lb-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:694]
STEP: Creating a BYO public IP 09/04/22 15:06:36.257
Sep  4 15:06:36.257: INFO: Creating public IP resource named service-lb-public-IP4920 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:196]
STEP: Creating a service and expose it 09/04/22 15:06:40.134
Sep  4 15:06:40.293: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 15:06:50.350: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 15:07:00.352: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 15:07:10.352: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 15:07:20.350: INFO: Exposure successfully, get external ip: 20.125.34.240 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
Sep  4 15:07:20.350: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-lb-m8k4h to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
Sep  4 15:07:20.475: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
Sep  4 15:07:30.533: INFO: checking the connectivity of addr 20.125.34.240:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
Sep  4 15:07:30.533: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
Sep  4 15:07:30.533: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-service-lb-m8k4h exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  20.125.34.240 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 58 lines ...
    Sep  4 15:06:36.029: INFO: Creating a kubernetes client [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:55]
    Sep  4 15:06:36.029: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:63]
    Sep  4 15:06:36.198: INFO: Creating deployment deployment-lb-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:694]
    STEP: Creating a BYO public IP 09/04/22 15:06:36.257
    Sep  4 15:06:36.257: INFO: Creating public IP resource named service-lb-public-IP4920 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:196]
    STEP: Creating a service and expose it 09/04/22 15:06:40.134
    Sep  4 15:06:40.293: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 15:06:50.350: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 15:07:00.352: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 15:07:10.352: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 15:07:20.350: INFO: Exposure successfully, get external ip: 20.125.34.240 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
    Sep  4 15:07:20.350: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-lb-m8k4h to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
    Sep  4 15:07:20.475: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
    Sep  4 15:07:30.533: INFO: checking the connectivity of addr 20.125.34.240:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
    Sep  4 15:07:30.533: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
    Sep  4 15:07:30.533: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-service-lb-m8k4h exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  20.125.34.240 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 90 lines ...
STEP: Test subnet doesn't exist. Creating a new one... 09/04/22 15:11:50.365
Sep  4 15:11:52.415: INFO: creating a new subnet testSubnet, 10.0.0.0/24 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:74]
STEP: Creating a service and expose it 09/04/22 15:11:52.913
Sep  4 15:11:52.913: INFO: Creating service service-lb-test in namespace e2e-tests-service-lb-t4l9p [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:949]
Sep  4 15:11:53.000: INFO: Successfully created LoadBalancer service service-lb-test in namespace e2e-tests-service-lb-t4l9p [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:953]
Sep  4 15:11:53.000: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:956]
Sep  4 15:11:53.107: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 15:12:03.176: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 15:12:13.177: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 15:12:23.166: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 15:12:33.170: INFO: Exposure successfully, get external ip: 10.0.0.4 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
Sep  4 15:12:33.170: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-lb-t4l9p to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
Sep  4 15:12:33.297: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
Sep  4 15:12:43.358: INFO: checking the connectivity of addr 10.0.0.4:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
Sep  4 15:12:43.358: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
Sep  4 15:12:43.358: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-service-lb-t4l9p exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  10.0.0.4 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 68 lines ...
    STEP: Test subnet doesn't exist. Creating a new one... 09/04/22 15:11:50.365
    Sep  4 15:11:52.415: INFO: creating a new subnet testSubnet, 10.0.0.0/24 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:74]
    STEP: Creating a service and expose it 09/04/22 15:11:52.913
    Sep  4 15:11:52.913: INFO: Creating service service-lb-test in namespace e2e-tests-service-lb-t4l9p [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:949]
    Sep  4 15:11:53.000: INFO: Successfully created LoadBalancer service service-lb-test in namespace e2e-tests-service-lb-t4l9p [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:953]
    Sep  4 15:11:53.000: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:956]
    Sep  4 15:11:53.107: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 15:12:03.176: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 15:12:13.177: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 15:12:23.166: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 15:12:33.170: INFO: Exposure successfully, get external ip: 10.0.0.4 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
    Sep  4 15:12:33.170: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-lb-t4l9p to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
    Sep  4 15:12:33.297: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
    Sep  4 15:12:43.358: INFO: checking the connectivity of addr 10.0.0.4:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
    Sep  4 15:12:43.358: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
    Sep  4 15:12:43.358: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-service-lb-t4l9p exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  10.0.0.4 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 49 lines ...
    Sep  4 15:13:55.562: INFO: subnet testSubnet still exists, will retry [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:113]
    Sep  4 15:13:57.532: INFO: subnet testSubnet has been deleted [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:116]
    Sep  4 15:13:57.595: INFO: Deleting namespace e2e-tests-service-lb-t4l9p [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:134]
  << End Captured GinkgoWriter Output
------------------------------
Multi-ports service When ExternalTrafficPolicy is updated
  Should not have error occurred [Multi-Ports]
  /home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:767
Sep  4 15:14:03.807: INFO: Creating a kubernetes client [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:55]
Sep  4 15:14:03.807: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:63]
Sep  4 15:14:03.870: INFO: Created a test namespace "e2e-tests-mpservice-bwctj" [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:109]
Sep  4 15:14:03.870: INFO: Creating Azure clients [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:721]
Sep  4 15:14:03.870: INFO: Creating a kubernetes client [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:55]
... skipping 3 lines ...
Sep  4 15:14:04.174: INFO: 5 pods in namespace e2e-tests-mpservice-bwctj are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
Sep  4 15:14:14.299: INFO: 0 pods in namespace e2e-tests-mpservice-bwctj are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
STEP: Getting the service 09/04/22 15:14:14.299
Sep  4 15:14:14.299: INFO: Creating service multiport-test in namespace e2e-tests-mpservice-bwctj [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:770]
Sep  4 15:14:14.386: INFO: Successfully created LoadBalancer service multiport-test in namespace e2e-tests-mpservice-bwctj [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:774]
Sep  4 15:14:14.386: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:777]
Sep  4 15:14:14.445: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 15:14:24.513: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
Sep  4 15:14:34.507: INFO: Exposure successfully, get external ip: 20.236.23.0 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
Sep  4 15:14:34.507: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-mpservice-bwctj to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
Sep  4 15:14:34.635: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
Sep  4 15:14:44.696: INFO: checking the connectivity of addr 20.236.23.0:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
Sep  4 15:14:44.696: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
Sep  4 15:14:44.696: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-mpservice-bwctj exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  20.236.23.0 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 65 lines ...
------------------------------
• [SLOW TEST] [154.391 seconds]
Multi-ports service [Multi-Ports]
/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:686
  When ExternalTrafficPolicy is updated
  /home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:766
    Should not have error occurred
    /home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:767

  Begin Captured GinkgoWriter Output >>
    Sep  4 15:14:03.807: INFO: Creating a kubernetes client [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:55]
    Sep  4 15:14:03.807: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:63]
    Sep  4 15:14:03.870: INFO: Created a test namespace "e2e-tests-mpservice-bwctj" [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:109]
... skipping 5 lines ...
    Sep  4 15:14:04.174: INFO: 5 pods in namespace e2e-tests-mpservice-bwctj are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
    Sep  4 15:14:14.299: INFO: 0 pods in namespace e2e-tests-mpservice-bwctj are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:84]
    STEP: Getting the service 09/04/22 15:14:14.299
    Sep  4 15:14:14.299: INFO: Creating service multiport-test in namespace e2e-tests-mpservice-bwctj [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:770]
    Sep  4 15:14:14.386: INFO: Successfully created LoadBalancer service multiport-test in namespace e2e-tests-mpservice-bwctj [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:774]
    Sep  4 15:14:14.386: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:777]
    Sep  4 15:14:14.445: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 15:14:24.513: INFO: Fail to find ingress, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:165]
    Sep  4 15:14:34.507: INFO: Exposure successfully, get external ip: 20.236.23.0 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:180]
    Sep  4 15:14:34.507: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-mpservice-bwctj to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:142]
    Sep  4 15:14:34.635: INFO: waiting for the pod status to be Running, current status: Pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:258]
    Sep  4 15:14:44.696: INFO: checking the connectivity of addr 20.236.23.0:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:131]
    Sep  4 15:14:44.696: INFO: Kubernetes configuration file name: /root/tmp979128089/kubeconfig/kubeconfig.westus2.json [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:100]
    Sep  4 15:14:44.696: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/root/tmp979128089/kubeconfig/kubeconfig.westus2.json --namespace=e2e-tests-mpservice-bwctj exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4  20.236.23.0 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:140]
... skipping 200 lines ...
[ReportAfterSuite] PASSED [0.006 seconds]
[ReportAfterSuite] Autogenerated ReportAfterSuite for --junit-report
autogenerated by Ginkgo
------------------------------

Ran 34 of 59 Specs in 6283.300 seconds
SUCCESS! -- 34 Passed | 0 Failed | 1 Flaked | 0 Pending | 25 Skipped
PASS

Ginkgo ran 1 suite in 1h45m58.63359015s
Test Suite Passed
2022/09/04 15:16:38 process.go:155: Step 'make test-ccm-e2e' finished in 1h46m2.980756101s
2022/09/04 15:16:38 aksengine_helpers.go:426: downloading /root/tmp979128089/log-dump.sh from https://raw.githubusercontent.com/kubernetes-sigs/cloud-provider-azure/master/hack/log-dump/log-dump.sh
... skipping 274 lines ...