cloud-provider-azure-master-capz-main #1611754598010195968
Recent runs || View in Spyglass
| Result | FAILURE |
| Tests | 1 failed / 45 succeeded |
| Started | |
| Elapsed | 2h34m |
| Revision | main |
go run hack/e2e.go -v --test --test_args='--ginkgo.focus=Cloud\sprovider\sAzure\se2e\ssuite\s\[It\]\sAzure\sCredential\sProvider\sshould\sbe\sable\sto\spull\sprivate\simages\sfrom\sacr\swithout\sdocker\ssecrets\sset\sexplicitly\s\[Credential\]$'
[FAILED] Unexpected error:
<*fmt.wrapError | 0xc0001185a0>: {
msg: "docker failed to login with error: exit status 1",
err: <*exec.ExitError | 0xc000118580>{
ProcessState: {
pid: 39569,
status: 256,
rusage: {
Utime: {Sec: 0, Usec: 20518},
Stime: {Sec: 0, Usec: 20534},
Maxrss: 603676,
Ixrss: 0,
Idrss: 0,
Isrss: 0,
Minflt: 3475,
Majflt: 0,
Nswap: 0,
Inblock: 0,
Oublock: 0,
Msgsnd: 0,
Msgrcv: 0,
Nsignals: 0,
Nvcsw: 183,
Nivcsw: 10,
},
},
Stderr: nil,
},
}
docker failed to login with error: exit status 1
occurred
In [It] at: /home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/auth/cred.go:71 @ 01/07/23 18:27:52.403
There were additional failures detected after the initial failure. These are visible in the timeline
> Enter [BeforeEach] Azure Credential Provider - /home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/auth/cred.go:39 @ 01/07/23 18:27:26.266
Jan 7 18:27:26.266: INFO: Creating a kubernetes client [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:55]
Jan 7 18:27:26.266: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:63]
Jan 7 18:27:26.303: INFO: Created a test namespace "e2e-tests-cred-6zbz6" [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:109]
Jan 7 18:27:26.303: INFO: Creating a kubernetes client [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:55]
Jan 7 18:27:26.303: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:63]
Jan 7 18:27:26.340: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107]
Jan 7 18:27:26.340: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig cluster-info dump | grep service-cluster-ip-range' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:149]
< Exit [BeforeEach] Azure Credential Provider - /home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/auth/cred.go:39 @ 01/07/23 18:27:27.747 (1.481s)
> Enter [It] should be able to pull private images from acr without docker secrets set explicitly - /home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/auth/cred.go:59 @ 01/07/23 18:27:27.747
Jan 7 18:27:27.747: INFO: Creating acr e2eacrc6d5 in resource group capz-28olb1. [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/container_registry_utils.go:44]
Jan 7 18:27:35.991: INFO: Attempting Docker login with azure cred. [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/container_registry_utils.go:85]
Jan 7 18:27:36.547: INFO: Deleting acr e2eacrc6d5 in resource group capz-28olb1. [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/container_registry_utils.go:61]
[FAILED] Failure recorded during attempt 1:
Unexpected error:
<*fmt.wrapError | 0xc01ba563c0>: {
msg: "docker failed to login with error: exit status 1",
err: <*exec.ExitError | 0xc01ba563a0>{
ProcessState: {
pid: 39527,
status: 256,
rusage: {
Utime: {Sec: 0, Usec: 24881},
Stime: {Sec: 0, Usec: 19898},
Maxrss: 603676,
Ixrss: 0,
Idrss: 0,
Isrss: 0,
Minflt: 3512,
Majflt: 2,
Nswap: 0,
Inblock: 128,
Oublock: 0,
Msgsnd: 0,
Msgrcv: 0,
Nsignals: 0,
Nvcsw: 222,
Nivcsw: 13,
},
},
Stderr: nil,
},
}
docker failed to login with error: exit status 1
occurred
In [It] at: /home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/auth/cred.go:71 @ 01/07/23 18:27:40.148
< Exit [It] should be able to pull private images from acr without docker secrets set explicitly - /home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/auth/cred.go:59 @ 01/07/23 18:27:40.148 (12.401s)
> Enter [AfterEach] Azure Credential Provider - /home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/auth/cred.go:50 @ 01/07/23 18:27:40.148
Jan 7 18:27:40.149: INFO: Deleting namespace e2e-tests-cred-6zbz6 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:134]
< Exit [AfterEach] Azure Credential Provider - /home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/auth/cred.go:50 @ 01/07/23 18:27:46.243 (6.094s)
Attempt #1 Failed. Retrying ↺ @ 01/07/23 18:27:46.243
> Enter [BeforeEach] Azure Credential Provider - /home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/auth/cred.go:39 @ 01/07/23 18:27:46.243
Jan 7 18:27:46.243: INFO: Creating a kubernetes client [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:55]
Jan 7 18:27:46.243: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:63]
Jan 7 18:27:46.278: INFO: Created a test namespace "e2e-tests-cred-f4vsg" [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:109]
Jan 7 18:27:46.278: INFO: Creating a kubernetes client [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:55]
Jan 7 18:27:46.278: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:63]
Jan 7 18:27:46.314: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107]
Jan 7 18:27:46.314: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig cluster-info dump | grep service-cluster-ip-range' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:149]
< Exit [BeforeEach] Azure Credential Provider - /home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/auth/cred.go:39 @ 01/07/23 18:27:47.872 (1.629s)
> Enter [It] should be able to pull private images from acr without docker secrets set explicitly - /home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/auth/cred.go:59 @ 01/07/23 18:27:47.872
Jan 7 18:27:47.872: INFO: Creating acr e2eacrea9b in resource group capz-28olb1. [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/container_registry_utils.go:44]
Jan 7 18:27:50.396: INFO: Attempting Docker login with azure cred. [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/container_registry_utils.go:85]
Jan 7 18:27:50.762: INFO: Deleting acr e2eacrea9b in resource group capz-28olb1. [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/container_registry_utils.go:61]
[FAILED] Unexpected error:
<*fmt.wrapError | 0xc0001185a0>: {
msg: "docker failed to login with error: exit status 1",
err: <*exec.ExitError | 0xc000118580>{
ProcessState: {
pid: 39569,
status: 256,
rusage: {
Utime: {Sec: 0, Usec: 20518},
Stime: {Sec: 0, Usec: 20534},
Maxrss: 603676,
Ixrss: 0,
Idrss: 0,
Isrss: 0,
Minflt: 3475,
Majflt: 0,
Nswap: 0,
Inblock: 0,
Oublock: 0,
Msgsnd: 0,
Msgrcv: 0,
Nsignals: 0,
Nvcsw: 183,
Nivcsw: 10,
},
},
Stderr: nil,
},
}
docker failed to login with error: exit status 1
occurred
In [It] at: /home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/auth/cred.go:71 @ 01/07/23 18:27:52.403
< Exit [It] should be able to pull private images from acr without docker secrets set explicitly - /home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/auth/cred.go:59 @ 01/07/23 18:27:52.403 (4.531s)
> Enter [AfterEach] Azure Credential Provider - /home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/auth/cred.go:50 @ 01/07/23 18:27:52.403
Jan 7 18:27:52.403: INFO: Deleting namespace e2e-tests-cred-f4vsg [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:134]
< Exit [AfterEach] Azure Credential Provider - /home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/auth/cred.go:50 @ 01/07/23 18:27:58.499 (6.096s)
from junit_01.xml
Filter through log files | View test history on testgrid
Cloud provider Azure e2e suite [It] Azure node resources should set correct private IP address for every node [Node]
Cloud provider Azure e2e suite [It] Azure node resources should set node provider id correctly [Node]
Cloud provider Azure e2e suite [It] Azure node resources should set route table correctly when the cluster is enabled by kubenet [Node, Kubenet]
Cloud provider Azure e2e suite [It] Ensure LoadBalancer should support BYO public IP [LB]
Cloud provider Azure e2e suite [It] Ensure LoadBalancer should support assigning to specific IP when updating public service [LB]
Cloud provider Azure e2e suite [It] Ensure LoadBalancer should support disabling floating IP in load balancer rule with kubernetes service annotations [LB]
Cloud provider Azure e2e suite [It] Ensure LoadBalancer should support mixed protocol services [LB]
Cloud provider Azure e2e suite [It] Ensure LoadBalancer should support multiple external services sharing one newly created public IP address [LB]
Cloud provider Azure e2e suite [It] Ensure LoadBalancer should support multiple external services sharing one preset public IP address [LB]
Cloud provider Azure e2e suite [It] Ensure LoadBalancer should support multiple internal services sharing one IP address [LB]
Cloud provider Azure e2e suite [It] Ensure LoadBalancer should support updating an internal service to a public service with assigned IP [LB]
Cloud provider Azure e2e suite [It] Ensure LoadBalancer should support updating internal IP when updating internal service [LB]
Cloud provider Azure e2e suite [It] EnsureLoadBalancer should not update any resources when service config is not changed should respect internal service with various configurations [LB]
Cloud provider Azure e2e suite [It] EnsureLoadBalancer should not update any resources when service config is not changed should respect service with BYO public IP prefix with various configurations [LB]
Cloud provider Azure e2e suite [It] EnsureLoadBalancer should not update any resources when service config is not changed should respect service with BYO public IP with various configurations [LB]
Cloud provider Azure e2e suite [It] EnsureLoadBalancer should not update any resources when service config is not changed should respect service with various configurations [LB]
Cloud provider Azure e2e suite [It] Multi-ports service When ExternalTrafficPolicy is updated Should not have error occurred [Multi-Ports]
Cloud provider Azure e2e suite [It] Network security group can set source IP prefixes automatically according to corresponding service tag [NSG]
Cloud provider Azure e2e suite [It] Network security group should add the rule when expose a service [NSG]
Cloud provider Azure e2e suite [It] Network security group should support service annotation `service.beta.kubernetes.io/azure-deny-all-except-load-balancer-source-ranges` [NSG]
Cloud provider Azure e2e suite [It] Network security group should support service annotation `service.beta.kubernetes.io/azure-disable-load-balancer-floating-ip` [NSG]
Cloud provider Azure e2e suite [It] Network security group should support service annotation `service.beta.kubernetes.io/azure-shared-securityrule` [NSG]
Cloud provider Azure e2e suite [It] Private link service should support multiple internal services sharing one private link service [PLS]
Cloud provider Azure e2e suite [It] Private link service should support service annotation 'service.beta.kubernetes.io/azure-pls-auto-approval' [PLS]
Cloud provider Azure e2e suite [It] Private link service should support service annotation 'service.beta.kubernetes.io/azure-pls-create' [PLS]
Cloud provider Azure e2e suite [It] Private link service should support service annotation 'service.beta.kubernetes.io/azure-pls-fqdns' [PLS]
Cloud provider Azure e2e suite [It] Private link service should support service annotation 'service.beta.kubernetes.io/azure-pls-ip-configuration-ip-address' [PLS]
Cloud provider Azure e2e suite [It] Private link service should support service annotation 'service.beta.kubernetes.io/azure-pls-ip-configuration-ip-address-count' [PLS]
Cloud provider Azure e2e suite [It] Private link service should support service annotation 'service.beta.kubernetes.io/azure-pls-ip-configuration-subnet' [PLS]
Cloud provider Azure e2e suite [It] Private link service should support service annotation 'service.beta.kubernetes.io/azure-pls-name' [PLS]
Cloud provider Azure e2e suite [It] Private link service should support service annotation 'service.beta.kubernetes.io/azure-pls-proxy-protocol' [PLS]
Cloud provider Azure e2e suite [It] Private link service should support service annotation 'service.beta.kubernetes.io/azure-pls-visibility' [PLS]
Cloud provider Azure e2e suite [It] Service with annotation should generate health probe configs in multi-port scenario [ServiceAnnotation]
Cloud provider Azure e2e suite [It] Service with annotation should support service annotation 'service.beta.kubernetes.io/azure-dns-label-name' [ServiceAnnotation]
Cloud provider Azure e2e suite [It] Service with annotation should support service annotation 'service.beta.kubernetes.io/azure-load-balancer-enable-high-availability-ports' [ServiceAnnotation]
Cloud provider Azure e2e suite [It] Service with annotation should support service annotation 'service.beta.kubernetes.io/azure-load-balancer-health-probe-num-of-probe', 'service.beta.kubernetes.io/azure-load-balancer-health-probe-interval', 'service.beta.kubernetes.io/azure-load-balancer-health-probe-protocol' and port specific configs [ServiceAnnotation]
Cloud provider Azure e2e suite [It] Service with annotation should support service annotation 'service.beta.kubernetes.io/azure-load-balancer-internal' [ServiceAnnotation]
Cloud provider Azure e2e suite [It] Service with annotation should support service annotation 'service.beta.kubernetes.io/azure-load-balancer-internal-subnet' [ServiceAnnotation]
Cloud provider Azure e2e suite [It] Service with annotation should support service annotation 'service.beta.kubernetes.io/azure-load-balancer-ip' [ServiceAnnotation]
Cloud provider Azure e2e suite [It] Service with annotation should support service annotation 'service.beta.kubernetes.io/azure-load-balancer-tcp-idle-timeout' [ServiceAnnotation]
Cloud provider Azure e2e suite [It] Service with annotation should support service annotation `service.beta.kubernetes.io/azure-additional-public-ips` [ServiceAnnotation]
Cloud provider Azure e2e suite [It] Service with annotation should support service annotation `service.beta.kubernetes.io/azure-pip-name` [ServiceAnnotation]
Cloud provider Azure e2e suite [It] Service with annotation should support service annotation `service.beta.kubernetes.io/azure-pip-prefix-id` [ServiceAnnotation]
Cloud provider Azure e2e suite [It] Service with annotation should support service annotation `service.beta.kubernetes.io/azure-pip-tags` [ServiceAnnotation]
Cloud provider Azure e2e suite [It] [StandardLoadBalancer] Standard load balancer should add all nodes in different agent pools to backends [Multi-Nodepool]
Cloud provider Azure e2e suite [It] Azure nodes should expose zones correctly after created [VMSS, Serial, Slow]
Cloud provider Azure e2e suite [It] Azure nodes should support crossing resource groups [Multi-Group, AvailabilitySet]
Cloud provider Azure e2e suite [It] Cluster size autoscaler should balance the sizes of multiple node group if the `--balance-node-groups` is set to true [Feature:Autoscaling, Serial, Slow, Multi-Nodepool]
Cloud provider Azure e2e suite [It] Cluster size autoscaler should scale up or down if deployment replicas leave nodes busy or idle [Feature:Autoscaling, Serial, Slow]
Cloud provider Azure e2e suite [It] Cluster size autoscaler should scale up, deploy a statefulset with disks attached, scale down, and certain pods + disks should be evicted to a new node [Feature:Autoscaling, Serial, Slow]
Cloud provider Azure e2e suite [It] Cluster size autoscaler should support multiple node pools with quick scaling [Feature:Autoscaling, Serial, Slow, Multi-Nodepool]
Cloud provider Azure e2e suite [It] Cluster size autoscaler should support one node pool with slow scaling [Feature:Autoscaling, Serial, Slow, Single-Nodepool]
Cloud provider Azure e2e suite [It] Cluster size autoscaler should support scaling up or down Azure Spot VM [Feature:Autoscaling, Serial, Slow, VMSS, Spot-VM]
Cloud provider Azure e2e suite [It] Cluster size autoscaler should support scaling up or down due to the consuming of GPU resource [Feature:Autoscaling, Serial, Slow]
Cloud provider Azure e2e suite [It] Ensure LoadBalancer should have no operation since no change in service when update [LB, Slow]
Cloud provider Azure e2e suite [It] Ensure LoadBalancer should support node label `node.kubernetes.io/exclude-from-external-load-balancers` [LB]
Cloud provider Azure e2e suite [It] Lifecycle of VMSS should add node object when VMSS instance allocated [VMSS, VMSS-Scale]
Cloud provider Azure e2e suite [It] Lifecycle of VMSS should delete node object when VMSS instance deallocated [VMSS, VMSS-Scale]
Cloud provider Azure e2e suite [It] Multiple VMSS should support service annotation `service.beta.kubernetes.io/azure-load-balancer-mode` [Multi-Nodepool, VMSS]
Cloud provider Azure e2e suite [It] Service with annotation should support service annotation 'service.beta.kubernetes.io/azure-load-balancer-resource-group' [ServiceAnnotation]
Cloud provider Azure e2e suite [It] [StandardLoadBalancer] Standard load balancer should make outbound IP of pod same as in SLB's outbound rules [SLBOutbound]
... skipping 789 lines ... certificate.cert-manager.io "selfsigned-cert" deleted # Create secret for AzureClusterIdentity ./hack/create-identity-secret.sh make[2]: Entering directory '/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure' make[2]: Nothing to be done for 'kubectl'. make[2]: Leaving directory '/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure' Error from server (NotFound): secrets "cluster-identity-secret" not found secret/cluster-identity-secret created secret/cluster-identity-secret labeled # Create customized cloud provider configs ./hack/create-custom-cloud-provider-config.sh make[2]: Entering directory '/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure' make[2]: Nothing to be done for 'kubectl'. ... skipping 216 lines ... Jan 7 16:17:30.314: INFO: 2 pods in namespace e2e-tests-nsg-c7d7n are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:87] Jan 7 16:17:40.365: INFO: 0 pods in namespace e2e-tests-nsg-c7d7n are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:87] [1mSTEP:[0m Creating a service and expose it [38;5;243m@ 01/07/23 16:17:40.365[0m Jan 7 16:17:40.365: INFO: Creating service nsg-test in namespace e2e-tests-nsg-c7d7n [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1196] Jan 7 16:17:40.415: INFO: Successfully created LoadBalancer service nsg-test in namespace e2e-tests-nsg-c7d7n [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1200] Jan 7 16:17:40.415: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1203] Jan 7 16:17:40.459: 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:158] Jan 7 16:17:50.494: 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:158] Jan 7 16:18:00.492: 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:158] Jan 7 16:18:10.491: 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:158] Jan 7 16:18:20.494: 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:158] Jan 7 16:18:30.497: 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:158] Jan 7 16:18:40.498: 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:158] Jan 7 16:18:50.499: INFO: Exposure successfully, get external ip: 20.119.118.175 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] Jan 7 16:18:50.499: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-nsg-c7d7n to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:159] Jan 7 16:18:50.499: INFO: creating pod exec-agnhost-pod in namespace e2e-tests-nsg-c7d7n [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:152] Jan 7 16:18:50.580: 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:317] Jan 7 16:19:00.613: INFO: checking the connectivity of addr 20.119.118.175:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:124] Jan 7 16:19:00.613: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] ... skipping 47 lines ... Jan 7 16:20:04.742: INFO: 3 pods in namespace e2e-tests-nsg-nxjgb are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:87] Jan 7 16:20:14.794: INFO: 0 pods in namespace e2e-tests-nsg-nxjgb are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:87] [1mSTEP:[0m Exposing two services with shared security rule [38;5;243m@ 01/07/23 16:20:14.794[0m Jan 7 16:20:14.794: INFO: Creating service nsg-test in namespace e2e-tests-nsg-nxjgb [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1196] Jan 7 16:20:14.842: INFO: Successfully created LoadBalancer service nsg-test in namespace e2e-tests-nsg-nxjgb [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1200] Jan 7 16:20:14.842: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1203] Jan 7 16:20:14.872: 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:158] Jan 7 16:20:24.907: 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:158] Jan 7 16:20:34.904: 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:158] Jan 7 16:20:44.904: 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:158] Jan 7 16:20:54.912: 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:158] Jan 7 16:21:04.909: INFO: Exposure successfully, get external ip: 20.237.25.179 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] Jan 7 16:21:04.909: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-nsg-nxjgb to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:159] Jan 7 16:21:04.909: INFO: creating pod exec-agnhost-pod in namespace e2e-tests-nsg-nxjgb [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:152] Jan 7 16:21:04.979: 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:317] Jan 7 16:21:15.012: INFO: checking the connectivity of addr 20.237.25.179:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:124] Jan 7 16:21:15.012: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] ... skipping 2 lines ... Jan 7 16:21:15.574: INFO: stdout: "" [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:177] Jan 7 16:21:15.574: INFO: Validation succeeded: Service addr 20.237.25.179 and port 80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:194] Jan 7 16:21:15.628: INFO: Deleting pod exec-agnhost-pod in namespace e2e-tests-nsg-nxjgb [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:138] Jan 7 16:21:15.658: INFO: Creating service nsg-test-share in namespace e2e-tests-nsg-nxjgb [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1196] Jan 7 16:21:15.709: INFO: Successfully created LoadBalancer service nsg-test-share in namespace e2e-tests-nsg-nxjgb [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1200] Jan 7 16:21:15.709: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1203] Jan 7 16:21:15.739: 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:158] Jan 7 16:21:25.772: INFO: Exposure successfully, get external ip: 20.237.27.66 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] Jan 7 16:21:25.772: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-nsg-nxjgb to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:159] Jan 7 16:21:25.772: INFO: creating pod exec-agnhost-pod in namespace e2e-tests-nsg-nxjgb [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:152] Jan 7 16:21:25.844: 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:317] Jan 7 16:21:35.884: INFO: checking the connectivity of addr 20.237.27.66:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:124] Jan 7 16:21:35.884: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] ... skipping 43 lines ... Jan 7 16:23:05.569: INFO: 3 pods in namespace e2e-tests-nsg-kv6f2 are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:87] Jan 7 16:23:15.617: INFO: 0 pods in namespace e2e-tests-nsg-kv6f2 are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:87] [1mSTEP:[0m Creating service and wait it to expose [38;5;243m@ 01/07/23 16:23:15.617[0m Jan 7 16:23:15.617: INFO: Creating service nsg-test in namespace e2e-tests-nsg-kv6f2 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/network_security_group.go:191] Jan 7 16:23:15.670: INFO: Successfully created LoadBalancer service nsg-test in namespace e2e-tests-nsg-kv6f2 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/network_security_group.go:195] [1mSTEP:[0m Waiting for the service to be exposed [38;5;243m@ 01/07/23 16:23:15.67[0m Jan 7 16:23:15.701: 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:158] Jan 7 16:23:25.742: 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:158] Jan 7 16:23:35.735: 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:158] Jan 7 16:23:45.744: 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:158] Jan 7 16:23:55.742: 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:158] Jan 7 16:24:05.743: 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:158] Jan 7 16:24:15.736: 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:158] Jan 7 16:24:25.733: INFO: Exposure successfully, get external ip: 20.237.27.66 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] [1mSTEP:[0m Validating if the corresponding IP prefix existing in nsg [38;5;243m@ 01/07/23 16:24:25.733[0m Jan 7 16:24:25.733: INFO: Getting virtual network list [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:183] Jan 7 16:24:26.130: INFO: got sg list, length = 2 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:208] Jan 7 16:24:26.171: INFO: Deleting namespace e2e-tests-nsg-kv6f2 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:134] [38;5;10m• [158.508 seconds][0m ... skipping 10 lines ... Jan 7 16:25:43.870: INFO: Creating deployment nsg-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/network_security_group.go:69] Jan 7 16:25:43.915: 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] Jan 7 16:25:43.955: INFO: 3 pods in namespace e2e-tests-nsg-2d5wz are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:87] Jan 7 16:25:53.998: INFO: 0 pods in namespace e2e-tests-nsg-2d5wz are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:87] [1mSTEP:[0m Creating a test service with the deny rule annotation but without `service.Spec.LoadBalancerSourceRanges` [38;5;243m@ 01/07/23 16:25:53.998[0m [1mSTEP:[0m Waiting for the service to expose [38;5;243m@ 01/07/23 16:25:54.115[0m Jan 7 16:25:54.147: 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:158] Jan 7 16:26:04.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:158] Jan 7 16:26:14.185: 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:158] Jan 7 16:26:24.186: 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:158] Jan 7 16:26:34.187: 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:158] Jan 7 16:26:44.187: INFO: Exposure successfully, get external ip: 10.1.0.6 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] Jan 7 16:26:44.187: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-nsg-2d5wz to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:159] Jan 7 16:26:44.187: INFO: creating pod exec-agnhost-pod in namespace e2e-tests-nsg-2d5wz [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:152] Jan 7 16:26:44.266: 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:317] Jan 7 16:26:54.306: INFO: checking the connectivity of addr 10.1.0.6:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:124] Jan 7 16:26:54.307: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] ... skipping 11 lines ... Jan 7 16:26:55.635: INFO: Deleting service "nsg-test" in namespace "e2e-tests-nsg-2d5wz" [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:47] [1mSTEP:[0m Creating a test service with the deny rule annotation and `service.Spec.LoadBalancerSourceRanges` [38;5;243m@ 01/07/23 16:27:33.745[0m Jan 7 16:27:33.745: INFO: Creating a hostNetwork Pod exec-agnhost-pod-deny-all-except-lb-range in namespace e2e-tests-nsg-2d5wz to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:159] Jan 7 16:27:33.745: INFO: creating pod exec-agnhost-pod-deny-all-except-lb-range in namespace e2e-tests-nsg-2d5wz [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:152] Jan 7 16:27:33.821: 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:317] [1mSTEP:[0m Waiting for the service to expose [38;5;243m@ 01/07/23 16:27:43.959[0m Jan 7 16:27:43.990: 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:158] Jan 7 16:27:54.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:158] Jan 7 16:28:04.029: 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:158] Jan 7 16:28:14.022: 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:158] Jan 7 16:28:24.023: 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:158] Jan 7 16:28:34.029: 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:158] Jan 7 16:28:44.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:158] Jan 7 16:28:54.022: INFO: Exposure successfully, get external ip: 10.1.0.6 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] Jan 7 16:28:54.022: INFO: checking the connectivity of addr 10.1.0.6:80 with protocol [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/network_security_group.go:275] Jan 7 16:28:54.022: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] Jan 7 16:28:54.022: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig --namespace=e2e-tests-nsg-2d5wz exec exec-agnhost-pod-deny-all-except-lb-range -- /bin/sh -x -c nc -vz -w 4 10.1.0.6 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:149] Jan 7 16:28:54.565: INFO: stderr: "+ nc -vz -w 4 10.1.0.6 80\nConnection to 10.1.0.6 80 port [tcp/http] succeeded!\n" [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:176] Jan 7 16:28:54.565: INFO: stdout: "" [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:177] ... skipping 27 lines ... Jan 7 16:30:05.166: INFO: 3 pods in namespace e2e-tests-nsg-sjxsr are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:87] Jan 7 16:30:15.217: INFO: 0 pods in namespace e2e-tests-nsg-sjxsr are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:87] [1mSTEP:[0m Creating a public IP with tags [38;5;243m@ 01/07/23 16:30:15.217[0m Jan 7 16:30:15.217: 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:241] Jan 7 16:30:19.078: INFO: created pip with address 4.227.206.88 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/network_security_group.go:298] [1mSTEP:[0m Creating a test load balancer service with floating IP disabled [38;5;243m@ 01/07/23 16:30:19.078[0m Jan 7 16:30:19.171: 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:158] Jan 7 16:30:29.203: 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:158] Jan 7 16:30:39.203: 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:158] Jan 7 16:30:49.206: 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:158] Jan 7 16:30:59.206: 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:158] Jan 7 16:31:09.212: 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:158] Jan 7 16:31:19.203: 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:158] Jan 7 16:31:29.206: INFO: Exposure successfully, get external ip: 4.227.206.88 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] Jan 7 16:31:29.206: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-nsg-sjxsr to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:159] Jan 7 16:31:29.207: INFO: creating pod exec-agnhost-pod in namespace e2e-tests-nsg-sjxsr [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:152] Jan 7 16:31:29.283: 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:317] Jan 7 16:31:39.316: INFO: checking the connectivity of addr 4.227.206.88:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:124] Jan 7 16:31:39.316: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] ... skipping 20 lines ... Jan 7 16:32:26.720: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:63] Jan 7 16:32:26.767: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] Jan 7 16:32:26.767: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig cluster-info dump | grep service-cluster-ip-range' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:149] Jan 7 16:32:28.118: INFO: Creating deployment deployment-lb-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:93] Jan 7 16:32:28.160: INFO: Updating deployment deployment-lb-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:112] [1mSTEP:[0m creating a mixed protocol service [38;5;243m@ 01/07/23 16:32:28.217[0m Jan 7 16:32:28.355: 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:158] Jan 7 16:32:38.387: 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:158] Jan 7 16:32:48.396: 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:158] Jan 7 16:32:58.393: 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:158] Jan 7 16:33:08.394: 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:158] Jan 7 16:33:18.386: 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:158] Jan 7 16:33:28.386: 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:158] Jan 7 16:33:38.396: INFO: Exposure successfully, get external ip: 20.237.30.235 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] Jan 7 16:33:38.396: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-lb-jxhxd to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:159] Jan 7 16:33:38.396: INFO: creating pod exec-agnhost-pod in namespace e2e-tests-service-lb-jxhxd [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:152] Jan 7 16:33:38.468: 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:317] Jan 7 16:33:48.501: INFO: checking the connectivity of addr 20.237.30.235:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:124] Jan 7 16:33:48.501: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] ... skipping 29 lines ... Jan 7 16:35:10.785: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig cluster-info dump | grep service-cluster-ip-range' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:149] Jan 7 16:35:12.318: INFO: Creating deployment deployment-lb-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:93] [1mSTEP:[0m creating a public IP with tags [38;5;243m@ 01/07/23 16:35:12.357[0m Jan 7 16:35:12.357: INFO: Creating public IP resource named service-lb-public-IP8cde [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:241] Jan 7 16:35:15.824: INFO: created pip with address 20.172.202.226 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:171] [1mSTEP:[0m creating a service referencing the public IP [38;5;243m@ 01/07/23 16:35:15.824[0m Jan 7 16:35:15.901: 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:158] Jan 7 16:35:25.942: 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:158] Jan 7 16:35:35.933: 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:158] Jan 7 16:35:45.935: 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:158] Jan 7 16:35:55.937: 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:158] Jan 7 16:36:05.941: 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:158] Jan 7 16:36:15.942: 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:158] Jan 7 16:36:25.941: INFO: Exposure successfully, get external ip: 20.172.202.226 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] Jan 7 16:36:25.941: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-lb-4h95k to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:159] Jan 7 16:36:25.941: INFO: creating pod exec-agnhost-pod in namespace e2e-tests-service-lb-4h95k [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:152] Jan 7 16:36:26.012: 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:317] Jan 7 16:36:36.046: INFO: checking the connectivity of addr 20.172.202.226:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:124] Jan 7 16:36:36.046: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] ... skipping 22 lines ... Jan 7 16:37:15.873: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig cluster-info dump | grep service-cluster-ip-range' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:149] Jan 7 16:37:17.230: INFO: Creating deployment deployment-lb-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:93] Jan 7 16:37:17.364: INFO: Successfully created LoadBalancer service service-lb-test in namespace e2e-tests-service-lb-2x5td [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:205] Jan 7 16:37:17.364: INFO: Creating public IP resource named service-lb-public-none-IPcacc [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:241] Jan 7 16:37:21.173: INFO: PIP to 4.227.215.104 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:210] [1mSTEP:[0m Waiting for exposure of the original service without assigned lb IP [38;5;243m@ 01/07/23 16:37:21.173[0m Jan 7 16:37:21.205: 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:158] Jan 7 16:37:31.241: 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:158] Jan 7 16:37:41.238: 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:158] Jan 7 16:37:51.236: 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:158] Jan 7 16:38:01.237: 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:158] Jan 7 16:38:11.236: 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:158] Jan 7 16:38:21.236: 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:158] Jan 7 16:38:31.245: INFO: Exposure successfully, get external ip: 20.237.27.144 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] Jan 7 16:38:31.245: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-lb-2x5td to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:159] Jan 7 16:38:31.245: INFO: creating pod exec-agnhost-pod in namespace e2e-tests-service-lb-2x5td [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:152] Jan 7 16:38:31.314: 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:317] Jan 7 16:38:41.355: INFO: checking the connectivity of addr 20.237.27.144:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:124] Jan 7 16:38:41.355: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] ... skipping 34 lines ... Jan 7 16:40:25.684: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] Jan 7 16:40:25.684: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig cluster-info dump | grep service-cluster-ip-range' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:149] Jan 7 16:40:27.202: INFO: Creating deployment deployment-lb-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:93] Jan 7 16:40:27.242: INFO: Getting virtual network list [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:48] Jan 7 16:40:28.839: INFO: Successfully created LoadBalancer service service-lb-test in namespace e2e-tests-service-lb-5ncfp [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:248] [1mSTEP:[0m Waiting for exposure of internal service with specific IP "10.1.0.6" [38;5;243m@ 01/07/23 16:40:28.839[0m Jan 7 16:40:28.870: 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:158] Jan 7 16:40:38.902: 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:158] Jan 7 16:40:48.902: 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:158] Jan 7 16:40:58.908: 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:158] Jan 7 16:41:08.901: 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:158] Jan 7 16:41:18.909: 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:158] Jan 7 16:41:28.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:158] Jan 7 16:41:38.903: INFO: Exposure successfully, get external ip: 10.1.0.6 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] Jan 7 16:41:38.903: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-lb-5ncfp to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:159] Jan 7 16:41:38.903: INFO: creating pod exec-agnhost-pod in namespace e2e-tests-service-lb-5ncfp [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:152] Jan 7 16:41:38.975: 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:317] Jan 7 16:41:49.010: INFO: checking the connectivity of addr 10.1.0.6:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:124] Jan 7 16:41:49.010: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] ... skipping 37 lines ... Jan 7 16:41:49.650: INFO: 31. {{ } {exec-agnhost-pod.173814681ae3959c e2e-tests-service-lb-5ncfp bb59bcae-3376-41b1-9d19-e6e802b58370 7422 0 2023-01-07 16:41:38 +0000 UTC <nil> <nil> map[] map[] [] [] [{kube-scheduler Update v1 2023-01-07 16:41:38 +0000 UTC FieldsV1 {"f:count":{},"f:firstTimestamp":{},"f:involvedObject":{},"f:lastTimestamp":{},"f:message":{},"f:reason":{},"f:source":{"f:component":{}},"f:type":{}} }]} {Pod e2e-tests-service-lb-5ncfp exec-agnhost-pod 82936c5a-0a8f-497c-ac41-348c461be04e v1 7420 } Scheduled Successfully assigned e2e-tests-service-lb-5ncfp/exec-agnhost-pod to capz-28olb1-md-0-xpnpj {default-scheduler } 2023-01-07 16:41:38 +0000 UTC 2023-01-07 16:41:38 +0000 UTC 1 Normal 0001-01-01 00:00:00 +0000 UTC nil nil } [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:264] Jan 7 16:41:49.650: INFO: 32. {{ } {exec-agnhost-pod.1738146837a9562f e2e-tests-service-lb-5ncfp 447f5e0f-c4a9-49ef-bfb2-4045afc0bd31 7424 0 2023-01-07 16:41:39 +0000 UTC <nil> <nil> map[] map[] [] [] [{kubelet Update v1 2023-01-07 16:41:39 +0000 UTC FieldsV1 {"f:count":{},"f:firstTimestamp":{},"f:involvedObject":{},"f:lastTimestamp":{},"f:message":{},"f:reason":{},"f:source":{"f:component":{},"f:host":{}},"f:type":{}} }]} {Pod e2e-tests-service-lb-5ncfp exec-agnhost-pod 82936c5a-0a8f-497c-ac41-348c461be04e v1 7421 spec.containers{agnhost}} Pulled Container image "registry.k8s.io/e2e-test-images/agnhost:2.36" already present on machine {kubelet capz-28olb1-md-0-xpnpj} 2023-01-07 16:41:39 +0000 UTC 2023-01-07 16:41:39 +0000 UTC 1 Normal 0001-01-01 00:00:00 +0000 UTC nil nil } [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:264] Jan 7 16:41:49.650: INFO: 33. {{ } {exec-agnhost-pod.173814683ad392a5 e2e-tests-service-lb-5ncfp 6bea54b4-4a83-4d2d-b59b-93a62e9e4062 7425 0 2023-01-07 16:41:39 +0000 UTC <nil> <nil> map[] map[] [] [] [{kubelet Update v1 2023-01-07 16:41:39 +0000 UTC FieldsV1 {"f:count":{},"f:firstTimestamp":{},"f:involvedObject":{},"f:lastTimestamp":{},"f:message":{},"f:reason":{},"f:source":{"f:component":{},"f:host":{}},"f:type":{}} }]} {Pod e2e-tests-service-lb-5ncfp exec-agnhost-pod 82936c5a-0a8f-497c-ac41-348c461be04e v1 7421 spec.containers{agnhost}} Created Created container agnhost {kubelet capz-28olb1-md-0-xpnpj} 2023-01-07 16:41:39 +0000 UTC 2023-01-07 16:41:39 +0000 UTC 1 Normal 0001-01-01 00:00:00 +0000 UTC nil nil } [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:264] Jan 7 16:41:49.650: INFO: 34. {{ } {exec-agnhost-pod.173814683fb0d9c9 e2e-tests-service-lb-5ncfp 7f6a4ab9-c63e-43a0-946c-26f8a5a00f4e 7427 0 2023-01-07 16:41:39 +0000 UTC <nil> <nil> map[] map[] [] [] [{kubelet Update v1 2023-01-07 16:41:39 +0000 UTC FieldsV1 {"f:count":{},"f:firstTimestamp":{},"f:involvedObject":{},"f:lastTimestamp":{},"f:message":{},"f:reason":{},"f:source":{"f:component":{},"f:host":{}},"f:type":{}} }]} {Pod e2e-tests-service-lb-5ncfp exec-agnhost-pod 82936c5a-0a8f-497c-ac41-348c461be04e v1 7421 spec.containers{agnhost}} Started Started container agnhost {kubelet capz-28olb1-md-0-xpnpj} 2023-01-07 16:41:39 +0000 UTC 2023-01-07 16:41:39 +0000 UTC 1 Normal 0001-01-01 00:00:00 +0000 UTC nil nil } [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:264] Jan 7 16:41:49.650: INFO: 35. {{ } {exec-agnhost-pod.1738146a93aecb51 e2e-tests-service-lb-5ncfp 7745d013-40d3-44af-b368-9c72763b37fd 7457 0 2023-01-07 16:41:49 +0000 UTC <nil> <nil> map[] map[] [] [] [{kubelet Update v1 2023-01-07 16:41:49 +0000 UTC FieldsV1 {"f:count":{},"f:firstTimestamp":{},"f:involvedObject":{},"f:lastTimestamp":{},"f:message":{},"f:reason":{},"f:source":{"f:component":{},"f:host":{}},"f:type":{}} }]} {Pod e2e-tests-service-lb-5ncfp exec-agnhost-pod 82936c5a-0a8f-497c-ac41-348c461be04e v1 7421 spec.containers{agnhost}} Killing Stopping container agnhost {kubelet capz-28olb1-md-0-xpnpj} 2023-01-07 16:41:49 +0000 UTC 2023-01-07 16:41:49 +0000 UTC 1 Normal 0001-01-01 00:00:00 +0000 UTC nil nil } [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:264] Jan 7 16:41:49.650: INFO: 36. {{ } {service-lb-test.17381457c7e412c8 e2e-tests-service-lb-5ncfp d7b2cd9a-2128-4964-bfde-cdf598fcf8d3 7216 0 2023-01-07 16:40:28 +0000 UTC <nil> <nil> map[] map[] [] [] [{cloud-controller-manager Update v1 2023-01-07 16:40:28 +0000 UTC FieldsV1 {"f:count":{},"f:firstTimestamp":{},"f:involvedObject":{},"f:lastTimestamp":{},"f:message":{},"f:reason":{},"f:source":{"f:component":{}},"f:type":{}} }]} {Service e2e-tests-service-lb-5ncfp service-lb-test e3249566-cf9c-46a3-94bd-82eec8665d2e v1 7214 } EnsuringLoadBalancer Ensuring load balancer {service-controller } 2023-01-07 16:40:28 +0000 UTC 2023-01-07 16:40:28 +0000 UTC 1 Normal 0001-01-01 00:00:00 +0000 UTC nil nil } [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:264] Jan 7 16:41:49.650: INFO: 37. {{ } {service-lb-test.17381457f1838b67 e2e-tests-service-lb-5ncfp 23c3ecc7-0c7a-416b-9455-f55768081b49 7242 0 2023-01-07 16:40:29 +0000 UTC <nil> <nil> map[] map[] [] [] [{kube-controller-manager Update v1 2023-01-07 16:40:29 +0000 UTC FieldsV1 {"f:count":{},"f:firstTimestamp":{},"f:involvedObject":{},"f:lastTimestamp":{},"f:message":{},"f:reason":{},"f:source":{"f:component":{}},"f:type":{}} }]} {Endpoints e2e-tests-service-lb-5ncfp service-lb-test 79764823-3025-42e0-91e3-c2e90ec72a12 v1 7230 } FailedToUpdateEndpoint Failed to update endpoint e2e-tests-service-lb-5ncfp/service-lb-test: Operation cannot be fulfilled on endpoints "service-lb-test": the object has been modified; please apply your changes to the latest version and try again {endpoint-controller } 2023-01-07 16:40:29 +0000 UTC 2023-01-07 16:40:29 +0000 UTC 1 Warning 0001-01-01 00:00:00 +0000 UTC nil nil } [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:264] Jan 7 16:41:49.650: INFO: 38. {{ } {service-lb-test.17381465f2fef200 e2e-tests-service-lb-5ncfp c0de14b7-7a76-4b63-9361-c782873a1a46 7397 0 2023-01-07 16:41:29 +0000 UTC <nil> <nil> map[] map[] [] [] [{cloud-controller-manager Update v1 2023-01-07 16:41:29 +0000 UTC FieldsV1 {"f:count":{},"f:firstTimestamp":{},"f:involvedObject":{},"f:lastTimestamp":{},"f:message":{},"f:reason":{},"f:source":{"f:component":{}},"f:type":{}} }]} {Service e2e-tests-service-lb-5ncfp service-lb-test e3249566-cf9c-46a3-94bd-82eec8665d2e v1 7214 } EnsuredLoadBalancer Ensured load balancer {service-controller } 2023-01-07 16:41:29 +0000 UTC 2023-01-07 16:41:29 +0000 UTC 1 Normal 0001-01-01 00:00:00 +0000 UTC nil nil } [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:264] Jan 7 16:41:49.651: INFO: Getting virtual network list [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:48] [1mSTEP:[0m Updating internal service private IP [38;5;243m@ 01/07/23 16:41:50.895[0m Jan 7 16:41:50.895: INFO: will update IP to 10.1.0.7 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:271] Jan 7 16:41:51.000: INFO: expected IP is 10.1.0.7, current IP is 10.1.0.6, retry in 10 seconds [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:164] Jan 7 16:42:01.033: INFO: Exposure successfully, get external ip: 10.1.0.7 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] ... skipping 22 lines ... Jan 7 16:42:46.091: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] Jan 7 16:42:46.092: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig cluster-info dump | grep service-cluster-ip-range' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:149] Jan 7 16:42:47.530: INFO: Creating deployment deployment-lb-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:93] Jan 7 16:42:47.667: INFO: Successfully created LoadBalancer service service-lb-test in namespace e2e-tests-service-lb-6n54c [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:289] Jan 7 16:42:47.667: INFO: Creating public IP resource named service-lb-internal-none-public-IP26f0 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:241] [1mSTEP:[0m Waiting for exposure of the original service without assigned lb private IP [38;5;243m@ 01/07/23 16:42:51.246[0m Jan 7 16:42:51.277: 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:158] Jan 7 16:43:01.318: 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:158] Jan 7 16:43:11.317: 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:158] Jan 7 16:43:21.309: 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:158] Jan 7 16:43:31.318: 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:158] Jan 7 16:43:41.317: 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:158] Jan 7 16:43:51.318: INFO: Exposure successfully, get external ip: 10.1.0.6 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] Jan 7 16:43:51.319: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-lb-6n54c to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:159] Jan 7 16:43:51.319: INFO: creating pod exec-agnhost-pod in namespace e2e-tests-service-lb-6n54c [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:152] Jan 7 16:43:51.390: 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:317] Jan 7 16:44:01.426: INFO: checking the connectivity of addr 10.1.0.6:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:124] Jan 7 16:44:01.426: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] ... skipping 79 lines ... Jan 7 16:45:59.688: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig cluster-info dump | grep service-cluster-ip-range' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:149] Jan 7 16:46:01.207: INFO: Creating deployment deployment-lb-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:93] Jan 7 16:46:01.242: INFO: Creating public IP resource named service-lb-public-remain-b061 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:241] Jan 7 16:46:05.067: INFO: Creating Service "service-lb-test-0" [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:417] Jan 7 16:46:05.120: INFO: Creating deployment "deployment-lb-test-1" [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:403] Jan 7 16:46:05.155: INFO: Creating Service "service-lb-test-1" [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:417] Jan 7 16:46:05.277: 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:158] Jan 7 16:46:15.313: 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:158] Jan 7 16:46:25.313: 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:158] Jan 7 16:46:35.311: 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:158] Jan 7 16:46:45.318: 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:158] Jan 7 16:46:55.309: 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:158] Jan 7 16:47:05.308: 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:158] Jan 7 16:47:15.315: 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:158] Jan 7 16:47:25.309: 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:158] Jan 7 16:47:35.309: 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:158] Jan 7 16:47:45.319: INFO: Exposure successfully, get external ip: 20.163.239.67 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] Jan 7 16:47:45.319: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-lb-868qs to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:159] Jan 7 16:47:45.319: INFO: creating pod exec-agnhost-pod in namespace e2e-tests-service-lb-868qs [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:152] Jan 7 16:47:45.396: 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:317] Jan 7 16:47:55.429: INFO: checking the connectivity of addr 20.163.239.67:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:124] Jan 7 16:47:55.429: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] ... skipping 28 lines ... Jan 7 16:49:01.710: INFO: Created a test namespace "e2e-tests-service-lb-nskbg" [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:109] Jan 7 16:49:01.710: INFO: Creating a kubernetes client [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:55] Jan 7 16:49:01.710: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:63] Jan 7 16:49:01.753: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] Jan 7 16:49:01.753: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig cluster-info dump | grep service-cluster-ip-range' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:149] Jan 7 16:49:03.258: INFO: Creating deployment deployment-lb-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:93] Jan 7 16:49:03.428: 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:158] Jan 7 16:49:13.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:158] Jan 7 16:49:23.459: 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:158] Jan 7 16:49:33.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:158] Jan 7 16:49:43.462: 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:158] Jan 7 16:49:53.462: 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:158] Jan 7 16:50:03.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:158] Jan 7 16:50:13.465: INFO: Exposure successfully, get external ip: 20.253.50.198 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] Jan 7 16:50:13.466: INFO: Creating deployment deployment-lb-test-1 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:451] Jan 7 16:50:13.624: 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:158] Jan 7 16:50:23.665: INFO: Exposure successfully, get external ip: 20.253.50.198 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] Jan 7 16:50:23.696: INFO: Exposure successfully, get external ip: 20.253.50.198 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] Jan 7 16:50:23.696: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-lb-nskbg to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:159] Jan 7 16:50:23.696: INFO: creating pod exec-agnhost-pod in namespace e2e-tests-service-lb-nskbg [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:152] Jan 7 16:50:23.787: 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:317] Jan 7 16:50:33.820: INFO: checking the connectivity of addr 20.253.50.198:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:124] ... skipping 42 lines ... Jan 7 16:52:17.095: INFO: Created a test namespace "e2e-tests-service-lb-lx8v8" [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:109] Jan 7 16:52:17.096: INFO: Creating a kubernetes client [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:55] Jan 7 16:52:17.096: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:63] Jan 7 16:52:17.142: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] Jan 7 16:52:17.142: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig cluster-info dump | grep service-cluster-ip-range' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:149] Jan 7 16:52:18.640: INFO: Creating deployment deployment-lb-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:93] Jan 7 16:52:18.798: 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:158] Jan 7 16:52:28.830: 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:158] Jan 7 16:52:38.838: 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:158] Jan 7 16:52:48.838: 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:158] Jan 7 16:52:58.839: 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:158] Jan 7 16:53:08.838: 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:158] Jan 7 16:53:18.840: 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:158] Jan 7 16:53:28.838: INFO: Exposure successfully, get external ip: 10.1.0.6 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] Jan 7 16:53:28.839: INFO: Creating deployment deployment-lb-test-1 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:538] Jan 7 16:53:28.998: 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:158] Jan 7 16:53:39.036: INFO: Exposure successfully, get external ip: 10.1.0.6 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] Jan 7 16:53:39.067: INFO: Exposure successfully, get external ip: 10.1.0.6 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] Jan 7 16:53:39.067: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-lb-lx8v8 to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:159] Jan 7 16:53:39.067: INFO: creating pod exec-agnhost-pod in namespace e2e-tests-service-lb-lx8v8 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:152] Jan 7 16:53:39.157: 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:317] Jan 7 16:53:49.195: INFO: checking the connectivity of addr 10.1.0.6:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:124] ... skipping 52 lines ... Jan 7 16:56:58.810: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig cluster-info dump | grep service-cluster-ip-range' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:149] Jan 7 16:57:00.384: INFO: Creating deployment deployment-lb-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:93] [1mSTEP:[0m creating a public IP [38;5;243m@ 01/07/23 16:57:00.419[0m Jan 7 16:57:00.420: INFO: Creating public IP resource named service-lb-public-IPaa8f [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:241] Jan 7 16:57:03.882: INFO: created pip with address 172.173.175.78 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:627] [1mSTEP:[0m creating a service referencing the public IP [38;5;243m@ 01/07/23 16:57:03.882[0m Jan 7 16:57:03.976: 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:158] Jan 7 16:57:14.013: 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:158] Jan 7 16:57:24.018: 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:158] Jan 7 16:57:34.011: 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:158] Jan 7 16:57:44.017: 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:158] Jan 7 16:57:54.017: 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:158] Jan 7 16:58:04.017: 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:158] Jan 7 16:58:14.009: INFO: Exposure successfully, get external ip: 172.173.175.78 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] Jan 7 16:58:14.009: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-lb-sfrj4 to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:159] Jan 7 16:58:14.009: INFO: creating pod exec-agnhost-pod in namespace e2e-tests-service-lb-sfrj4 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:152] Jan 7 16:58:14.078: 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:317] Jan 7 16:58:24.111: INFO: checking the connectivity of addr 172.173.175.78:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:124] Jan 7 16:58:24.111: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] ... skipping 36 lines ... Jan 7 16:59:29.558: INFO: 1 pods in namespace e2e-tests-service-b8684 are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:87] Jan 7 16:59:39.606: INFO: 0 pods in namespace e2e-tests-service-b8684 are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:87] [1mSTEP:[0m Create a Service with managed PIP [38;5;243m@ 01/07/23 16:59:39.606[0m Jan 7 16:59:39.606: INFO: Creating service annotation-test in namespace e2e-tests-service-b8684 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1196] Jan 7 16:59:39.661: INFO: Successfully created LoadBalancer service annotation-test in namespace e2e-tests-service-b8684 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1200] Jan 7 16:59:39.661: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1203] Jan 7 16:59:39.691: 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:158] Jan 7 16:59:49.725: 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:158] Jan 7 16:59:59.723: 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:158] Jan 7 17:00:09.722: 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:158] Jan 7 17:00:19.732: 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:158] Jan 7 17:00:29.726: 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:158] Jan 7 17:00:39.727: 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:158] Jan 7 17:00:49.729: INFO: Exposure successfully, get external ip: 20.253.51.125 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] Jan 7 17:00:49.729: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-b8684 to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:159] Jan 7 17:00:49.729: INFO: creating pod exec-agnhost-pod in namespace e2e-tests-service-b8684 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:152] Jan 7 17:00:49.797: 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:317] Jan 7 17:00:59.829: INFO: checking the connectivity of addr 20.253.51.125:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:124] Jan 7 17:00:59.829: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] ... skipping 15 lines ... [1mSTEP:[0m Delete the Service [38;5;243m@ 01/07/23 17:01:11.075[0m Jan 7 17:01:11.075: INFO: Deleting service "annotation-test" in namespace "e2e-tests-service-b8684" [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:47] [1mSTEP:[0m Create a PIP [38;5;243m@ 01/07/23 17:02:43.174[0m Jan 7 17:02:43.174: INFO: Creating public IP resource named service-public-IP-0a8b [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:241] Jan 7 17:02:46.894: INFO: PIP "service-public-IP-0a8b" to "4.227.218.84" [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:189] [1mSTEP:[0m Create a Service which will be deleted with the PIP [38;5;243m@ 01/07/23 17:02:46.894[0m Jan 7 17:02:46.974: 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:158] Jan 7 17:02:57.011: 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:158] Jan 7 17:03:07.014: 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:158] Jan 7 17:03:17.008: 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:158] Jan 7 17:03:27.009: 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:158] Jan 7 17:03:37.006: 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:158] Jan 7 17:03:47.014: 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:158] Jan 7 17:03:57.013: INFO: Exposure successfully, get external ip: 4.227.218.84 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] Jan 7 17:03:57.013: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-b8684 to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:159] Jan 7 17:03:57.013: INFO: creating pod exec-agnhost-pod in namespace e2e-tests-service-b8684 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:152] Jan 7 17:03:57.084: 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:317] Jan 7 17:04:07.117: INFO: checking the connectivity of addr 4.227.218.84:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:124] Jan 7 17:04:07.117: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] ... skipping 8 lines ... [1mSTEP:[0m Create a different Service with the same azure-dns-label-name tag [38;5;243m@ 01/07/23 17:05:06.063[0m Jan 7 17:05:06.115: INFO: Get domain name: annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:70] [1mSTEP:[0m Validating External domain name "annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com" [38;5;243m@ 01/07/23 17:05:06.115[0m Jan 7 17:05:06.115: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] Jan 7 17:05:06.115: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig --namespace=e2e-tests-service-b8684 exec exec-agnhost-pod-azure-dns-label-name -- /bin/sh -x -c nc -vz -w 4 annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:149] Jan 7 17:05:10.650: INFO: rc: 1 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:164] Jan 7 17:05:10.650: INFO: got error error running /usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig --namespace=e2e-tests-service-b8684 exec exec-agnhost-pod-azure-dns-label-name -- /bin/sh -x -c nc -vz -w 4 annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com 80: Command stdout: stderr: + nc -vz -w 4 annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com 80 nc: connect to annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com port 80 (tcp) timed out: Operation in progress command terminated with exit code 1 error: exit status 1, will retry, output: stdout: stderr:+ nc -vz -w 4 annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com 80 nc: connect to annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com port 80 (tcp) timed out: Operation in progress command terminated with exit code 1 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:187] Jan 7 17:05:20.653: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] Jan 7 17:05:20.653: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig --namespace=e2e-tests-service-b8684 exec exec-agnhost-pod-azure-dns-label-name -- /bin/sh -x -c nc -vz -w 4 annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:149] Jan 7 17:05:25.236: INFO: rc: 1 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:164] Jan 7 17:05:25.236: INFO: got error error running /usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig --namespace=e2e-tests-service-b8684 exec exec-agnhost-pod-azure-dns-label-name -- /bin/sh -x -c nc -vz -w 4 annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com 80: Command stdout: stderr: + nc -vz -w 4 annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com 80 nc: connect to annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com port 80 (tcp) timed out: Operation in progress command terminated with exit code 1 error: exit status 1, will retry, output: stdout: stderr:+ nc -vz -w 4 annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com 80 nc: connect to annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com port 80 (tcp) timed out: Operation in progress command terminated with exit code 1 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:187] Jan 7 17:05:30.651: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] Jan 7 17:05:30.651: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig --namespace=e2e-tests-service-b8684 exec exec-agnhost-pod-azure-dns-label-name -- /bin/sh -x -c nc -vz -w 4 annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:149] Jan 7 17:05:35.197: INFO: rc: 1 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:164] Jan 7 17:05:35.198: INFO: got error error running /usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig --namespace=e2e-tests-service-b8684 exec exec-agnhost-pod-azure-dns-label-name -- /bin/sh -x -c nc -vz -w 4 annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com 80: Command stdout: stderr: + nc -vz -w 4 annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com 80 nc: connect to annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com port 80 (tcp) timed out: Operation in progress command terminated with exit code 1 error: exit status 1, will retry, output: stdout: stderr:+ nc -vz -w 4 annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com 80 nc: connect to annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com port 80 (tcp) timed out: Operation in progress command terminated with exit code 1 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:187] Jan 7 17:05:40.653: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] Jan 7 17:05:40.653: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig --namespace=e2e-tests-service-b8684 exec exec-agnhost-pod-azure-dns-label-name -- /bin/sh -x -c nc -vz -w 4 annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:149] Jan 7 17:05:45.218: INFO: rc: 1 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:164] Jan 7 17:05:45.218: INFO: got error error running /usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig --namespace=e2e-tests-service-b8684 exec exec-agnhost-pod-azure-dns-label-name -- /bin/sh -x -c nc -vz -w 4 annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com 80: Command stdout: stderr: + nc -vz -w 4 annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com 80 nc: connect to annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com port 80 (tcp) timed out: Operation in progress command terminated with exit code 1 error: exit status 1, will retry, output: stdout: stderr:+ nc -vz -w 4 annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com 80 nc: connect to annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com port 80 (tcp) timed out: Operation in progress command terminated with exit code 1 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:187] Jan 7 17:05:50.654: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] Jan 7 17:05:50.654: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig --namespace=e2e-tests-service-b8684 exec exec-agnhost-pod-azure-dns-label-name -- /bin/sh -x -c nc -vz -w 4 annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:149] Jan 7 17:05:55.176: INFO: rc: 1 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:164] Jan 7 17:05:55.176: INFO: got error error running /usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig --namespace=e2e-tests-service-b8684 exec exec-agnhost-pod-azure-dns-label-name -- /bin/sh -x -c nc -vz -w 4 annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com 80: Command stdout: stderr: + nc -vz -w 4 annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com 80 nc: connect to annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com port 80 (tcp) timed out: Operation in progress command terminated with exit code 1 error: exit status 1, will retry, output: stdout: stderr:+ nc -vz -w 4 annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com 80 nc: connect to annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com port 80 (tcp) timed out: Operation in progress command terminated with exit code 1 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:187] Jan 7 17:06:00.654: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] Jan 7 17:06:00.654: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig --namespace=e2e-tests-service-b8684 exec exec-agnhost-pod-azure-dns-label-name -- /bin/sh -x -c nc -vz -w 4 annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:149] Jan 7 17:06:05.212: INFO: rc: 1 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:164] Jan 7 17:06:05.212: INFO: got error error running /usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig --namespace=e2e-tests-service-b8684 exec exec-agnhost-pod-azure-dns-label-name -- /bin/sh -x -c nc -vz -w 4 annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com 80: Command stdout: stderr: + nc -vz -w 4 annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com 80 nc: connect to annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com port 80 (tcp) timed out: Operation in progress command terminated with exit code 1 error: exit status 1, will retry, output: stdout: stderr:+ nc -vz -w 4 annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com 80 nc: connect to annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com port 80 (tcp) timed out: Operation in progress command terminated with exit code 1 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:187] Jan 7 17:06:10.651: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] Jan 7 17:06:10.651: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig --namespace=e2e-tests-service-b8684 exec exec-agnhost-pod-azure-dns-label-name -- /bin/sh -x -c nc -vz -w 4 annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:149] Jan 7 17:06:15.198: INFO: rc: 1 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:164] Jan 7 17:06:15.198: INFO: got error error running /usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig --namespace=e2e-tests-service-b8684 exec exec-agnhost-pod-azure-dns-label-name -- /bin/sh -x -c nc -vz -w 4 annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com 80: Command stdout: stderr: + nc -vz -w 4 annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com 80 nc: connect to annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com port 80 (tcp) timed out: Operation in progress command terminated with exit code 1 error: exit status 1, will retry, output: stdout: stderr:+ nc -vz -w 4 annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com 80 nc: connect to annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com port 80 (tcp) timed out: Operation in progress command terminated with exit code 1 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:187] Jan 7 17:06:20.654: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] Jan 7 17:06:20.654: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig --namespace=e2e-tests-service-b8684 exec exec-agnhost-pod-azure-dns-label-name -- /bin/sh -x -c nc -vz -w 4 annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:149] Jan 7 17:06:25.328: INFO: rc: 1 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:164] Jan 7 17:06:25.328: INFO: got error error running /usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig --namespace=e2e-tests-service-b8684 exec exec-agnhost-pod-azure-dns-label-name -- /bin/sh -x -c nc -vz -w 4 annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com 80: Command stdout: stderr: + nc -vz -w 4 annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com 80 nc: connect to annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com port 80 (tcp) timed out: Operation in progress command terminated with exit code 1 error: exit status 1, will retry, output: stdout: stderr:+ nc -vz -w 4 annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com 80 nc: connect to annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com port 80 (tcp) timed out: Operation in progress command terminated with exit code 1 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:187] Jan 7 17:06:30.654: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] Jan 7 17:06:30.654: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig --namespace=e2e-tests-service-b8684 exec exec-agnhost-pod-azure-dns-label-name -- /bin/sh -x -c nc -vz -w 4 annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:149] Jan 7 17:06:35.210: INFO: rc: 1 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:164] Jan 7 17:06:35.210: INFO: got error error running /usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig --namespace=e2e-tests-service-b8684 exec exec-agnhost-pod-azure-dns-label-name -- /bin/sh -x -c nc -vz -w 4 annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com 80: Command stdout: stderr: + nc -vz -w 4 annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com 80 nc: connect to annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com port 80 (tcp) timed out: Operation in progress command terminated with exit code 1 error: exit status 1, will retry, output: stdout: stderr:+ nc -vz -w 4 annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com 80 nc: connect to annotation-test-cc55b86f-588e-4128-b4f0-01c7f31c2ea8.eastus.cloudapp.azure.com port 80 (tcp) timed out: Operation in progress command terminated with exit code 1 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:187] Jan 7 17:06:40.654: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] ... skipping 36 lines ... Jan 7 17:07:52.478: INFO: Waiting for backend pods to be ready [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:95] Jan 7 17:07:52.511: INFO: 1 pods in namespace e2e-tests-service-mgj78 are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:87] Jan 7 17:08:02.548: INFO: 0 pods in namespace e2e-tests-service-mgj78 are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:87] Jan 7 17:08:02.548: INFO: Creating service annotation-test in namespace e2e-tests-service-mgj78 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1196] Jan 7 17:08:02.604: INFO: Successfully created LoadBalancer service annotation-test in namespace e2e-tests-service-mgj78 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1200] Jan 7 17:08:02.604: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1203] Jan 7 17:08:02.634: 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:158] Jan 7 17:08:12.674: 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:158] Jan 7 17:08:22.669: 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:158] Jan 7 17:08:32.666: 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:158] Jan 7 17:08:42.674: 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:158] Jan 7 17:08:52.666: INFO: Exposure successfully, get external ip: 10.1.0.6 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] Jan 7 17:08:52.666: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-mgj78 to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:159] Jan 7 17:08:52.666: INFO: creating pod exec-agnhost-pod in namespace e2e-tests-service-mgj78 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:152] Jan 7 17:08:52.734: 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:317] Jan 7 17:09:02.774: INFO: checking the connectivity of addr 10.1.0.6:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:124] Jan 7 17:09:02.774: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] ... skipping 26 lines ... [1mSTEP:[0m Test subnet doesn't exist. Creating a new one... [38;5;243m@ 01/07/23 17:10:08.159[0m [1mSTEP:[0m Creating a subnet "10.2.0.0/24" [38;5;243m@ 01/07/23 17:10:10.31[0m Jan 7 17:10:10.310: INFO: creating a new subnet a--------------------------------------------------z, 10.2.0.0/24 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:85] Jan 7 17:10:10.556: INFO: Creating service annotation-test in namespace e2e-tests-service-bfcdv [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1196] Jan 7 17:10:10.613: INFO: Successfully created LoadBalancer service annotation-test in namespace e2e-tests-service-bfcdv [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1200] Jan 7 17:10:10.613: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1203] Jan 7 17:10:10.649: 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:158] Jan 7 17:10:20.689: 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:158] Jan 7 17:10:30.690: 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:158] Jan 7 17:10:40.682: 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:158] Jan 7 17:10:50.687: 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:158] Jan 7 17:11:00.690: 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:158] Jan 7 17:11:10.685: 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:158] Jan 7 17:11:20.690: 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:158] Jan 7 17:11:30.694: 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:158] Jan 7 17:11:40.681: 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:158] Jan 7 17:11:50.690: INFO: Exposure successfully, get external ip: 10.2.0.4 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] Jan 7 17:11:50.691: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-bfcdv to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:159] Jan 7 17:11:50.691: INFO: creating pod exec-agnhost-pod in namespace e2e-tests-service-bfcdv [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:152] Jan 7 17:11:50.758: 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:317] Jan 7 17:12:00.793: INFO: checking the connectivity of addr 10.2.0.4:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:124] Jan 7 17:12:00.793: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] ... skipping 25 lines ... Jan 7 17:13:11.985: INFO: Waiting for backend pods to be ready [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:95] Jan 7 17:13:12.029: INFO: 3 pods in namespace e2e-tests-service-kbk67 are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:87] Jan 7 17:13:22.075: INFO: 0 pods in namespace e2e-tests-service-kbk67 are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:87] Jan 7 17:13:22.075: INFO: Creating service annotation-test in namespace e2e-tests-service-kbk67 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1196] Jan 7 17:13:22.119: INFO: Successfully created LoadBalancer service annotation-test in namespace e2e-tests-service-kbk67 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1200] Jan 7 17:13:22.119: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1203] Jan 7 17:13:22.149: 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:158] Jan 7 17:13:32.181: 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:158] Jan 7 17:13:42.181: 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:158] Jan 7 17:13:52.188: 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:158] Jan 7 17:14:02.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:158] Jan 7 17:14:12.180: 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:158] Jan 7 17:14:22.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:158] Jan 7 17:14:32.189: INFO: Exposure successfully, get external ip: 10.1.0.6 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] Jan 7 17:14:32.189: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-kbk67 to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:159] Jan 7 17:14:32.189: INFO: creating pod exec-agnhost-pod in namespace e2e-tests-service-kbk67 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:152] Jan 7 17:14:32.260: 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:317] Jan 7 17:14:42.298: INFO: checking the connectivity of addr 10.1.0.6:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:124] Jan 7 17:14:42.298: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] ... skipping 23 lines ... Jan 7 17:15:43.808: INFO: Waiting for backend pods to be ready [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:95] Jan 7 17:15:43.851: INFO: 3 pods in namespace e2e-tests-service-4vsvz are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:87] Jan 7 17:15:53.896: INFO: 0 pods in namespace e2e-tests-service-4vsvz are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:87] Jan 7 17:15:53.896: INFO: Creating service annotation-test in namespace e2e-tests-service-4vsvz [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1196] Jan 7 17:15:53.953: INFO: Successfully created LoadBalancer service annotation-test in namespace e2e-tests-service-4vsvz [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1200] Jan 7 17:15:53.954: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1203] Jan 7 17:15:53.984: 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:158] Jan 7 17:16:04.022: 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:158] Jan 7 17:16:14.016: 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:158] Jan 7 17:16:24.016: 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:158] Jan 7 17:16:34.016: 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:158] Jan 7 17:16:44.020: 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:158] Jan 7 17:16: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:158] Jan 7 17:17:04.026: INFO: Exposure successfully, get external ip: 20.102.32.16 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] Jan 7 17:17:04.026: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-4vsvz to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:159] Jan 7 17:17:04.026: INFO: creating pod exec-agnhost-pod in namespace e2e-tests-service-4vsvz [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:152] Jan 7 17:17:04.095: 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:317] Jan 7 17:17:14.133: INFO: checking the connectivity of addr 20.102.32.16:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:124] Jan 7 17:17:14.133: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] ... skipping 54 lines ... Jan 7 17:18:43.721: INFO: Creating public IP resource named service-public-IP478d [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:241] Jan 7 17:18:47.531: INFO: created pip with address 20.232.37.38 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:429] [1mSTEP:[0m Exposing service with additional pip [38;5;243m@ 01/07/23 17:18:47.531[0m Jan 7 17:18:47.531: INFO: Creating service annotation-test in namespace e2e-tests-service-q85zs [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1196] Jan 7 17:18:47.592: INFO: Successfully created LoadBalancer service annotation-test in namespace e2e-tests-service-q85zs [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1200] Jan 7 17:18:47.592: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1203] Jan 7 17:18:47.622: 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:158] Jan 7 17:18:57.654: 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:158] Jan 7 17:19:07.663: 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:158] Jan 7 17:19:17.656: 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:158] Jan 7 17:19:27.662: 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:158] Jan 7 17:19:37.663: 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:158] Jan 7 17:19:47.661: 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:158] Jan 7 17:19:57.655: INFO: Exposure successfully, get external ip: 20.102.32.16 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] Jan 7 17:19:57.655: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-q85zs to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:159] Jan 7 17:19:57.656: INFO: creating pod exec-agnhost-pod in namespace e2e-tests-service-q85zs [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:152] Jan 7 17:19:57.724: 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:317] Jan 7 17:20:07.755: INFO: checking the connectivity of addr 20.102.32.16:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:124] Jan 7 17:20:07.755: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] ... skipping 29 lines ... Jan 7 17:21:16.633: INFO: Creating deployment annotation-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:90] Jan 7 17:21:16.666: INFO: Waiting for backend pods to be ready [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:95] Jan 7 17:21:16.708: INFO: 3 pods in namespace e2e-tests-service-rsvmc are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:87] Jan 7 17:21:26.743: INFO: 0 pods in namespace e2e-tests-service-rsvmc are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:87] [1mSTEP:[0m Creating a service with custom tags [38;5;243m@ 01/07/23 17:21:26.743[0m [1mSTEP:[0m Waiting service to expose... [38;5;243m@ 01/07/23 17:21:26.799[0m Jan 7 17:21:26.829: 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:158] Jan 7 17:21:36.869: 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:158] Jan 7 17:21:46.861: 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:158] Jan 7 17:21:56.869: 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:158] Jan 7 17:22:06.869: 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:158] Jan 7 17:22:16.870: 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:158] Jan 7 17:22:26.869: 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:158] Jan 7 17:22:36.869: 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:158] Jan 7 17:22:46.863: 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:158] Jan 7 17:22:56.870: 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:158] Jan 7 17:23:06.870: INFO: Exposure successfully, get external ip: 20.102.32.16 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] Jan 7 17:23:06.871: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-rsvmc to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:159] Jan 7 17:23:06.871: INFO: creating pod exec-agnhost-pod in namespace e2e-tests-service-rsvmc [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:152] Jan 7 17:23:06.942: 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:317] Jan 7 17:23:16.974: INFO: checking the connectivity of addr 20.102.32.16:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:124] Jan 7 17:23:16.974: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] ... skipping 31 lines ... Jan 7 17:25:02.770: INFO: 0 pods in namespace e2e-tests-service-b9vp9 are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:87] [1mSTEP:[0m Creating two test pips [38;5;243m@ 01/07/23 17:25:02.77[0m Jan 7 17:25:02.770: INFO: Creating public IP resource named pip1 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:241] Jan 7 17:25:06.374: INFO: Creating public IP resource named pip2 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:241] [1mSTEP:[0m Creating a service referring to the first pip [38;5;243m@ 01/07/23 17:25:09.376[0m [1mSTEP:[0m Waiting for the service to expose [38;5;243m@ 01/07/23 17:25:09.425[0m Jan 7 17:25:09.455: 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:158] Jan 7 17:25:19.487: 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:158] Jan 7 17:25:29.487: 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:158] Jan 7 17:25:39.487: 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:158] Jan 7 17:25:49.492: 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:158] Jan 7 17:25:59.493: 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:158] Jan 7 17:26:09.492: 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:158] Jan 7 17:26:19.490: INFO: Exposure successfully, get external ip: 20.172.200.186 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] Jan 7 17:26:19.490: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-b9vp9 to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:159] Jan 7 17:26:19.490: INFO: creating pod exec-agnhost-pod in namespace e2e-tests-service-b9vp9 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:152] Jan 7 17:26:19.557: 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:317] Jan 7 17:26:29.597: INFO: checking the connectivity of addr 20.172.200.186:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:124] Jan 7 17:26:29.597: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] ... skipping 41 lines ... Jan 7 17:28:54.065: INFO: 0 pods in namespace e2e-tests-service-gt2sf are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:87] [1mSTEP:[0m Creating two test PIPPrefix [38;5;243m@ 01/07/23 17:28:54.065[0m Jan 7 17:28:54.065: INFO: Creating PublicIPPrefix named prefix1 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:266] Jan 7 17:29:45.593: INFO: Creating PublicIPPrefix named prefix2 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:266] [1mSTEP:[0m Creating a service referring to the prefix [38;5;243m@ 01/07/23 17:29:48.524[0m [1mSTEP:[0m Waiting for the service to expose [38;5;243m@ 01/07/23 17:29:48.573[0m Jan 7 17:29:48.603: 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:158] Jan 7 17:29:58.634: 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:158] Jan 7 17:30:08.637: 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:158] Jan 7 17:30:18.637: 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:158] Jan 7 17:30:28.638: 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:158] Jan 7 17:30:38.642: 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:158] Jan 7 17:30:48.636: 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:158] Jan 7 17:30:58.642: INFO: Exposure successfully, get external ip: 104.45.205.48 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] Jan 7 17:30:58.642: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-gt2sf to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:159] Jan 7 17:30:58.642: INFO: creating pod exec-agnhost-pod in namespace e2e-tests-service-gt2sf [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:152] Jan 7 17:30:58.709: 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:317] Jan 7 17:31:08.740: INFO: checking the connectivity of addr 104.45.205.48:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:124] Jan 7 17:31:08.740: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] ... skipping 44 lines ... Jan 7 17:33:01.748: INFO: 3 pods in namespace e2e-tests-service-zt86j are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:87] Jan 7 17:33:11.786: INFO: 0 pods in namespace e2e-tests-service-zt86j are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:87] [1mSTEP:[0m Creating a service with health probe annotations [38;5;243m@ 01/07/23 17:33:11.786[0m Jan 7 17:33:11.786: INFO: Creating service annotation-test in namespace e2e-tests-service-zt86j [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1196] Jan 7 17:33:11.835: INFO: Successfully created LoadBalancer service annotation-test in namespace e2e-tests-service-zt86j [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1200] Jan 7 17:33:11.835: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1203] Jan 7 17:33:11.865: 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:158] Jan 7 17:33:21.901: 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:158] Jan 7 17:33:31.905: 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:158] Jan 7 17:33:41.901: 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:158] Jan 7 17:33:51.904: 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:158] Jan 7 17:34:01.903: 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:158] Jan 7 17:34:11.904: 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:158] Jan 7 17:34:21.905: 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:158] Jan 7 17:34:31.896: 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:158] Jan 7 17:34:41.905: 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:158] Jan 7 17:34:51.904: INFO: Exposure successfully, get external ip: 20.81.58.142 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] Jan 7 17:34:51.905: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-zt86j to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:159] Jan 7 17:34:51.905: INFO: creating pod exec-agnhost-pod in namespace e2e-tests-service-zt86j [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:152] Jan 7 17:34:51.973: 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:317] Jan 7 17:35:02.005: INFO: checking the connectivity of addr 20.81.58.142:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:124] Jan 7 17:35:02.005: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] ... skipping 36 lines ... Jan 7 17:36:17.732: INFO: 3 pods in namespace e2e-tests-service-nlbdh are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:87] Jan 7 17:36:27.768: INFO: 0 pods in namespace e2e-tests-service-nlbdh are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:87] [1mSTEP:[0m Creating a service with health probe annotations [38;5;243m@ 01/07/23 17:36:27.768[0m Jan 7 17:36:27.768: INFO: Creating service annotation-test in namespace e2e-tests-service-nlbdh [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1196] Jan 7 17:36:27.829: INFO: Successfully created LoadBalancer service annotation-test in namespace e2e-tests-service-nlbdh [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1200] Jan 7 17:36:27.829: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1203] Jan 7 17:36:27.861: 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:158] Jan 7 17:36:37.895: 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:158] Jan 7 17:36:47.892: 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:158] Jan 7 17:36:57.892: 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:158] Jan 7 17:37:07.900: 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:158] Jan 7 17:37:17.901: 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:158] Jan 7 17:37:27.901: 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:158] Jan 7 17:37:37.901: INFO: Exposure successfully, get external ip: 20.81.58.142 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] Jan 7 17:37:37.901: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-nlbdh to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:159] Jan 7 17:37:37.901: INFO: creating pod exec-agnhost-pod in namespace e2e-tests-service-nlbdh [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:152] Jan 7 17:37:37.969: 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:317] Jan 7 17:37:48.009: INFO: checking the connectivity of addr 20.81.58.142:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:124] Jan 7 17:37:48.009: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] ... skipping 45 lines ... Jan 7 17:38:50.369: INFO: Creating public IP resource named service-public-IPce2d [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:241] Jan 7 17:38:53.579: INFO: Created pip with address 52.188.118.214 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:805] [1mSTEP:[0m Creating a Service [38;5;243m@ 01/07/23 17:38:53.579[0m Jan 7 17:38:53.579: INFO: Creating service annotation-test in namespace e2e-tests-service-5h6fg [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1196] Jan 7 17:38:53.630: INFO: Successfully created LoadBalancer service annotation-test in namespace e2e-tests-service-5h6fg [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1200] Jan 7 17:38:53.630: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1203] Jan 7 17:38:53.667: 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:158] Jan 7 17:39:03.706: 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:158] Jan 7 17:39:13.708: 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:158] Jan 7 17:39:23.698: 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:158] Jan 7 17:39:33.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:158] Jan 7 17:39:43.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:158] Jan 7 17:39:53.699: 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:158] Jan 7 17:40:03.708: INFO: Exposure successfully, get external ip: 52.188.118.214 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] Jan 7 17:40:03.708: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-5h6fg to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:159] Jan 7 17:40:03.708: INFO: creating pod exec-agnhost-pod in namespace e2e-tests-service-5h6fg [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:152] Jan 7 17:40:03.776: 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:317] Jan 7 17:40:13.817: INFO: checking the connectivity of addr 52.188.118.214:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:124] Jan 7 17:40:13.817: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] ... skipping 75 lines ... Jan 7 17:41:26.053: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] Jan 7 17:41:26.053: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig cluster-info dump | grep service-cluster-ip-range' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:149] Jan 7 17:41:27.770: INFO: Creating deployment pls-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/private_link_service.go:76] Jan 7 17:41:27.804: INFO: Creating service pls-test in namespace e2e-tests-pls-hw4j7 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1196] Jan 7 17:41:27.893: INFO: Successfully created LoadBalancer service pls-test in namespace e2e-tests-pls-hw4j7 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1200] Jan 7 17:41:27.893: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1203] Jan 7 17:41:27.929: 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:158] Jan 7 17:41:37.965: 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:158] Jan 7 17:41:47.961: 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:158] Jan 7 17:41:57.961: 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:158] Jan 7 17:42:07.960: 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:158] Jan 7 17:42:17.970: 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:158] Jan 7 17:42:27.970: 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:158] Jan 7 17:42:37.970: 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:158] Jan 7 17:42:47.965: 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:158] Jan 7 17:42:57.968: INFO: Exposure successfully, get external ip: 10.1.0.6 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] Jan 7 17:42:57.968: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-pls-hw4j7 to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:159] Jan 7 17:42:57.968: INFO: creating pod exec-agnhost-pod in namespace e2e-tests-pls-hw4j7 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:152] Jan 7 17:42:58.036: 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:317] Jan 7 17:43:08.072: INFO: checking the connectivity of addr 10.1.0.6:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:124] Jan 7 17:43:08.072: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] ... skipping 23 lines ... Jan 7 17:44:14.238: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] Jan 7 17:44:14.238: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig cluster-info dump | grep service-cluster-ip-range' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:149] Jan 7 17:44:15.850: INFO: Creating deployment pls-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/private_link_service.go:76] Jan 7 17:44:15.885: INFO: Creating service pls-test in namespace e2e-tests-pls-fxf7c [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1196] Jan 7 17:44:15.966: INFO: Successfully created LoadBalancer service pls-test in namespace e2e-tests-pls-fxf7c [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1200] Jan 7 17:44:15.966: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1203] Jan 7 17:44:15.996: 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:158] Jan 7 17:44:26.037: 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:158] Jan 7 17:44:36.030: 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:158] Jan 7 17:44:46.030: 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:158] Jan 7 17:44:56.028: 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:158] Jan 7 17:45:06.037: 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:158] Jan 7 17:45:16.034: INFO: Exposure successfully, get external ip: 10.1.0.6 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] Jan 7 17:45:16.034: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-pls-fxf7c to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:159] Jan 7 17:45:16.034: INFO: creating pod exec-agnhost-pod in namespace e2e-tests-pls-fxf7c [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:152] Jan 7 17:45:16.100: 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:317] Jan 7 17:45:26.132: INFO: checking the connectivity of addr 10.1.0.6:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:124] Jan 7 17:45:26.132: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] ... skipping 26 lines ... Jan 7 17:46:37.502: INFO: Getting virtual network list [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:48] [1mSTEP:[0m Test subnet doesn't exist. Creating a new one... [38;5;243m@ 01/07/23 17:46:37.797[0m Jan 7 17:46:39.224: INFO: creating a new subnet pls-subnet, 10.2.0.0/24 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:85] Jan 7 17:46:39.617: INFO: Creating service pls-test in namespace e2e-tests-pls-pqc4q [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1196] Jan 7 17:46:39.682: INFO: Successfully created LoadBalancer service pls-test in namespace e2e-tests-pls-pqc4q [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1200] Jan 7 17:46:39.682: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1203] Jan 7 17:46:39.727: 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:158] Jan 7 17:46:49.766: 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:158] Jan 7 17:46:59.763: 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:158] Jan 7 17:47:09.760: 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:158] Jan 7 17:47:19.766: 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:158] Jan 7 17:47:29.768: 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:158] Jan 7 17:47:39.766: 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:158] Jan 7 17:47:49.766: 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:158] Jan 7 17:47:59.767: INFO: Exposure successfully, get external ip: 10.1.0.6 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] Jan 7 17:47:59.767: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-pls-pqc4q to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:159] Jan 7 17:47:59.767: INFO: creating pod exec-agnhost-pod in namespace e2e-tests-pls-pqc4q [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:152] Jan 7 17:47:59.834: 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:317] Jan 7 17:48:09.866: INFO: checking the connectivity of addr 10.1.0.6:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:124] Jan 7 17:48:09.866: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] ... skipping 26 lines ... Jan 7 17:49:29.712: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] Jan 7 17:49:29.712: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig cluster-info dump | grep service-cluster-ip-range' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:149] Jan 7 17:49:31.378: INFO: Creating deployment pls-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/private_link_service.go:76] Jan 7 17:49:31.412: INFO: Creating service pls-test in namespace e2e-tests-pls-vzwgl [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1196] Jan 7 17:49:31.502: INFO: Successfully created LoadBalancer service pls-test in namespace e2e-tests-pls-vzwgl [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1200] Jan 7 17:49:31.502: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1203] Jan 7 17:49:31.539: 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:158] Jan 7 17:49:41.577: 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:158] Jan 7 17:49:51.577: 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:158] Jan 7 17:50:01.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:158] Jan 7 17:50:11.576: 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:158] Jan 7 17:50:21.579: 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:158] Jan 7 17:50:31.574: 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:158] Jan 7 17:50:41.578: 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:158] Jan 7 17:50:51.578: 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:158] Jan 7 17:51:01.577: 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:158] Jan 7 17:51:11.578: 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:158] Jan 7 17:51:21.577: 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:158] Jan 7 17:51:31.573: INFO: Exposure successfully, get external ip: 10.1.0.6 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] Jan 7 17:51:31.573: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-pls-vzwgl to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:159] Jan 7 17:51:31.573: INFO: creating pod exec-agnhost-pod in namespace e2e-tests-pls-vzwgl [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:152] Jan 7 17:51:31.641: 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:317] Jan 7 17:51:41.681: INFO: checking the connectivity of addr 10.1.0.6:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:124] Jan 7 17:51:41.681: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] ... skipping 23 lines ... Jan 7 17:53:17.401: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] Jan 7 17:53:17.401: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig cluster-info dump | grep service-cluster-ip-range' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:149] Jan 7 17:53:19.245: INFO: Creating deployment pls-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/private_link_service.go:76] Jan 7 17:53:19.282: INFO: Creating service pls-test in namespace e2e-tests-pls-lqtm6 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1196] Jan 7 17:53:19.367: INFO: Successfully created LoadBalancer service pls-test in namespace e2e-tests-pls-lqtm6 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1200] Jan 7 17:53:19.367: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1203] Jan 7 17:53:19.407: 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:158] Jan 7 17:53:29.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:158] Jan 7 17:53:39.449: 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:158] Jan 7 17:53:49.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:158] Jan 7 17:53:59.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:158] Jan 7 17:54:09.444: 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:158] Jan 7 17:54:19.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:158] Jan 7 17:54:29.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:158] Jan 7 17:54:39.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:158] Jan 7 17:54:49.439: INFO: Exposure successfully, get external ip: 10.1.0.6 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] Jan 7 17:54:49.439: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-pls-lqtm6 to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:159] Jan 7 17:54:49.439: INFO: creating pod exec-agnhost-pod in namespace e2e-tests-pls-lqtm6 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:152] Jan 7 17:54:49.505: 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:317] Jan 7 17:54:59.538: INFO: checking the connectivity of addr 10.1.0.6:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:124] Jan 7 17:54:59.538: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] ... skipping 37 lines ... Jan 7 17:56:07.817: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] Jan 7 17:56:07.818: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig cluster-info dump | grep service-cluster-ip-range' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:149] Jan 7 17:56:09.536: INFO: Creating deployment pls-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/private_link_service.go:76] Jan 7 17:56:09.572: INFO: Creating service pls-test in namespace e2e-tests-pls-5685g [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1196] Jan 7 17:56:09.652: INFO: Successfully created LoadBalancer service pls-test in namespace e2e-tests-pls-5685g [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1200] Jan 7 17:56:09.652: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1203] Jan 7 17:56:09.693: 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:158] Jan 7 17:56:19.733: 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:158] Jan 7 17:56:29.733: 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:158] Jan 7 17:56:39.725: 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:158] Jan 7 17:56:49.730: 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:158] Jan 7 17:56:59.724: 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:158] Jan 7 17:57:09.733: 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:158] Jan 7 17:57:19.725: 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:158] Jan 7 17:57:29.724: INFO: Exposure successfully, get external ip: 10.1.0.6 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] Jan 7 17:57:29.724: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-pls-5685g to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:159] Jan 7 17:57:29.724: INFO: creating pod exec-agnhost-pod in namespace e2e-tests-pls-5685g [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:152] Jan 7 17:57:29.796: 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:317] Jan 7 17:57:39.837: INFO: checking the connectivity of addr 10.1.0.6:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:124] Jan 7 17:57:39.837: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] ... skipping 23 lines ... Jan 7 17:58:59.561: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] Jan 7 17:58:59.561: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig cluster-info dump | grep service-cluster-ip-range' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:149] Jan 7 17:59:01.372: INFO: Creating deployment pls-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/private_link_service.go:76] Jan 7 17:59:01.409: INFO: Creating service pls-test in namespace e2e-tests-pls-6v5jb [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1196] Jan 7 17:59:01.520: INFO: Successfully created LoadBalancer service pls-test in namespace e2e-tests-pls-6v5jb [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1200] Jan 7 17:59:01.520: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1203] Jan 7 17:59:01.560: 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:158] Jan 7 17:59:11.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:158] Jan 7 17:59:21.602: 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:158] Jan 7 17:59:31.597: 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:158] Jan 7 17:59:41.601: 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:158] Jan 7 17:59:51.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:158] Jan 7 18:00:01.600: INFO: Exposure successfully, get external ip: 10.1.0.6 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] Jan 7 18:00:01.601: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-pls-6v5jb to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:159] Jan 7 18:00:01.601: INFO: creating pod exec-agnhost-pod in namespace e2e-tests-pls-6v5jb [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:152] Jan 7 18:00:01.670: 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:317] Jan 7 18:00:11.709: INFO: checking the connectivity of addr 10.1.0.6:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:124] Jan 7 18:00:11.709: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] ... skipping 23 lines ... Jan 7 18:01:19.653: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] Jan 7 18:01:19.653: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig cluster-info dump | grep service-cluster-ip-range' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:149] Jan 7 18:01:21.333: INFO: Creating deployment pls-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/private_link_service.go:76] Jan 7 18:01:21.369: INFO: Creating service pls-test in namespace e2e-tests-pls-x9h4m [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1196] Jan 7 18:01:21.475: INFO: Successfully created LoadBalancer service pls-test in namespace e2e-tests-pls-x9h4m [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1200] Jan 7 18:01:21.475: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1203] Jan 7 18:01:21.510: 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:158] Jan 7 18:01:31.549: 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:158] Jan 7 18:01:41.549: 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:158] Jan 7 18:01:51.541: 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:158] Jan 7 18:02:01.556: 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:158] Jan 7 18:02:11.549: 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:158] Jan 7 18:02:21.542: 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:158] Jan 7 18:02:31.549: INFO: Exposure successfully, get external ip: 10.1.0.6 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] Jan 7 18:02:31.549: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-pls-x9h4m to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:159] Jan 7 18:02:31.549: INFO: creating pod exec-agnhost-pod in namespace e2e-tests-pls-x9h4m [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:152] Jan 7 18:02:31.617: 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:317] Jan 7 18:02:41.657: INFO: checking the connectivity of addr 10.1.0.6:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:124] Jan 7 18:02:41.657: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] ... skipping 23 lines ... Jan 7 18:04:01.452: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] Jan 7 18:04:01.452: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig cluster-info dump | grep service-cluster-ip-range' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:149] Jan 7 18:04:03.184: INFO: Creating deployment pls-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/private_link_service.go:76] Jan 7 18:04:03.218: INFO: Creating service pls-test in namespace e2e-tests-pls-zqpff [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1196] Jan 7 18:04:03.307: INFO: Successfully created LoadBalancer service pls-test in namespace e2e-tests-pls-zqpff [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1200] Jan 7 18:04:03.307: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1203] Jan 7 18:04:03.338: 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:158] Jan 7 18:04:13.371: 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:158] Jan 7 18:04:23.373: 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:158] Jan 7 18:04:33.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:158] Jan 7 18:04:43.377: 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:158] Jan 7 18:04:53.377: 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:158] Jan 7 18:05:03.377: 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:158] Jan 7 18:05:13.375: 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:158] Jan 7 18:05:23.371: 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:158] Jan 7 18:05:33.383: 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:158] Jan 7 18:05:43.377: 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:158] Jan 7 18:05:53.377: 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:158] Jan 7 18:06:03.371: INFO: Exposure successfully, get external ip: 10.1.0.6 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] Jan 7 18:06:03.371: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-pls-zqpff to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:159] Jan 7 18:06:03.371: INFO: creating pod exec-agnhost-pod in namespace e2e-tests-pls-zqpff [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:152] Jan 7 18:06:03.440: 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:317] Jan 7 18:06:13.471: INFO: checking the connectivity of addr 10.1.0.6:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:124] Jan 7 18:06:13.472: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] ... skipping 23 lines ... Jan 7 18:07:25.278: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] Jan 7 18:07:25.278: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig cluster-info dump | grep service-cluster-ip-range' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:149] Jan 7 18:07:26.968: INFO: Creating deployment pls-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/private_link_service.go:76] Jan 7 18:07:27.002: INFO: Creating service service1 in namespace e2e-tests-pls-z6znb [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1196] Jan 7 18:07:27.081: INFO: Successfully created LoadBalancer service service1 in namespace e2e-tests-pls-z6znb [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1200] Jan 7 18:07:27.081: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1203] Jan 7 18:07:27.120: 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:158] Jan 7 18:07:37.160: 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:158] Jan 7 18:07:47.153: 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:158] Jan 7 18:07:57.159: 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:158] Jan 7 18:08:07.157: 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:158] Jan 7 18:08:17.160: 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:158] Jan 7 18:08:27.159: 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:158] Jan 7 18:08:37.158: 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:158] Jan 7 18:08:47.151: INFO: Exposure successfully, get external ip: 10.1.0.6 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] Jan 7 18:08:47.151: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-pls-z6znb to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:159] Jan 7 18:08:47.151: INFO: creating pod exec-agnhost-pod in namespace e2e-tests-pls-z6znb [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:152] Jan 7 18:08:47.218: 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:317] Jan 7 18:08:57.249: INFO: checking the connectivity of addr 10.1.0.6:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:124] Jan 7 18:08:57.250: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] Jan 7 18:08:57.250: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig --namespace=e2e-tests-pls-z6znb exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4 10.1.0.6 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:149] Jan 7 18:08:57.788: INFO: stderr: "+ nc -vz -w 4 10.1.0.6 80\nConnection to 10.1.0.6 80 port [tcp/http] succeeded!\n" [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:176] Jan 7 18:08:57.788: INFO: stdout: "" [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:177] Jan 7 18:08:57.788: INFO: Validation succeeded: Service addr 10.1.0.6 and port 80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:194] Jan 7 18:08:57.834: INFO: Deleting pod exec-agnhost-pod in namespace e2e-tests-pls-z6znb [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:138] Jan 7 18:08:57.865: INFO: Successfully created service1 in namespace e2e-tests-pls-z6znb with IP 10.1.0.6 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/private_link_service.go:374] Jan 7 18:08:57.865: INFO: Creating deployment pls-deploy0 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/private_link_service.go:377] Jan 7 18:08:58.024: 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:158] Jan 7 18:09:08.063: INFO: Exposure successfully, get external ip: 10.1.0.6 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] Jan 7 18:09:08.063: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-pls-z6znb to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:159] Jan 7 18:09:08.063: INFO: creating pod exec-agnhost-pod in namespace e2e-tests-pls-z6znb [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:152] Jan 7 18:09:08.151: 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:317] Jan 7 18:09:18.182: INFO: checking the connectivity of addr 10.1.0.6:81 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:124] Jan 7 18:09:18.182: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] ... skipping 46 lines ... Jan 7 18:10:23.792: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig cluster-info dump | grep service-cluster-ip-range' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:149] Jan 7 18:10:25.128: INFO: Creating deployment deployment-lb-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:695] [1mSTEP:[0m Creating a service and expose it [38;5;243m@ 01/07/23 18:10:25.162[0m Jan 7 18:10:25.162: INFO: Creating service service-lb-test in namespace e2e-tests-service-lb-8hvzs [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1196] Jan 7 18:10:25.289: INFO: Successfully created LoadBalancer service service-lb-test in namespace e2e-tests-service-lb-8hvzs [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1200] Jan 7 18:10:25.289: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1203] Jan 7 18:10:25.338: 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:158] Jan 7 18:10:35.379: 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:158] Jan 7 18:10:45.378: 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:158] Jan 7 18:10:55.373: 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:158] Jan 7 18:11:05.377: 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:158] Jan 7 18:11:15.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:158] Jan 7 18:11:25.379: 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:158] Jan 7 18:11:35.377: 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:158] Jan 7 18:11:45.377: 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:158] Jan 7 18:11:55.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:158] Jan 7 18:12:05.377: INFO: Exposure successfully, get external ip: 20.157.109.82 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] Jan 7 18:12:05.377: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-lb-8hvzs to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:159] Jan 7 18:12:05.377: INFO: creating pod exec-agnhost-pod in namespace e2e-tests-service-lb-8hvzs [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:152] Jan 7 18:12:05.455: 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:317] Jan 7 18:12:15.496: INFO: checking the connectivity of addr 20.157.109.82:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:124] Jan 7 18:12:15.496: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] ... skipping 57 lines ... Jan 7 18:13:35.041: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] Jan 7 18:13:35.041: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig cluster-info dump | grep service-cluster-ip-range' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:149] Jan 7 18:13:36.393: INFO: Creating deployment deployment-lb-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:695] [1mSTEP:[0m Creating a BYO public IP [38;5;243m@ 01/07/23 18:13:36.428[0m Jan 7 18:13:36.428: INFO: Creating public IP resource named service-lb-public-IP4d98 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:241] [1mSTEP:[0m Creating a service and expose it [38;5;243m@ 01/07/23 18:13:39.958[0m Jan 7 18:13:40.040: 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:158] Jan 7 18:13:50.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:158] Jan 7 18:14:00.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:158] Jan 7 18:14:10.080: 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:158] Jan 7 18:14:20.076: 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:158] Jan 7 18:14:30.081: 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:158] Jan 7 18:14:40.077: 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:158] Jan 7 18:14:50.077: INFO: Exposure successfully, get external ip: 20.168.193.98 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] Jan 7 18:14:50.077: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-lb-nkjpn to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:159] Jan 7 18:14:50.077: INFO: creating pod exec-agnhost-pod in namespace e2e-tests-service-lb-nkjpn [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:152] Jan 7 18:14:50.143: 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:317] Jan 7 18:15:00.177: INFO: checking the connectivity of addr 20.168.193.98:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:124] Jan 7 18:15:00.177: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] ... skipping 58 lines ... Jan 7 18:16:00.283: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] Jan 7 18:16:00.283: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig cluster-info dump | grep service-cluster-ip-range' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:149] Jan 7 18:16:01.646: INFO: Creating deployment deployment-lb-test [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/ensureloadbalancer.go:695] [1mSTEP:[0m Creating a BYO public IP prefix [38;5;243m@ 01/07/23 18:16:01.68[0m Jan 7 18:16:01.680: INFO: Creating PublicIPPrefix named prefix [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:266] [1mSTEP:[0m Creating a service and expose it [38;5;243m@ 01/07/23 18:16:51.505[0m Jan 7 18:16:51.597: 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:158] Jan 7 18:17:01.629: 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:158] Jan 7 18:17:11.637: 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:158] Jan 7 18:17:21.628: 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:158] Jan 7 18:17:31.633: 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:158] Jan 7 18:17:41.637: 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:158] Jan 7 18:17:51.636: 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:158] Jan 7 18:18:01.637: INFO: Exposure successfully, get external ip: 104.45.205.48 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] Jan 7 18:18:01.637: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-lb-8669h to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:159] Jan 7 18:18:01.637: INFO: creating pod exec-agnhost-pod in namespace e2e-tests-service-lb-8669h [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:152] Jan 7 18:18:01.706: 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:317] Jan 7 18:18:11.745: INFO: checking the connectivity of addr 104.45.205.48:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:124] Jan 7 18:18:11.745: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] ... skipping 63 lines ... [1mSTEP:[0m Test subnet doesn't exist. Creating a new one... [38;5;243m@ 01/07/23 18:19:29.179[0m Jan 7 18:19:30.706: INFO: creating a new subnet testSubnet, 10.2.0.0/24 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/network_utils.go:85] [1mSTEP:[0m Creating a service and expose it [38;5;243m@ 01/07/23 18:19:31.147[0m Jan 7 18:19:31.147: INFO: Creating service service-lb-test in namespace e2e-tests-service-lb-rvfhw [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1196] Jan 7 18:19:31.200: INFO: Successfully created LoadBalancer service service-lb-test in namespace e2e-tests-service-lb-rvfhw [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1200] Jan 7 18:19:31.200: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1203] Jan 7 18:19:31.230: 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:158] Jan 7 18:19:41.270: 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:158] Jan 7 18:19:51.265: 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:158] Jan 7 18:20:01.261: 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:158] Jan 7 18:20:11.262: 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:158] Jan 7 18:20:21.269: 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:158] Jan 7 18:20:31.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:158] Jan 7 18:20:41.269: INFO: Exposure successfully, get external ip: 10.2.0.4 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] Jan 7 18:20:41.269: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-lb-rvfhw to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:159] Jan 7 18:20:41.269: INFO: creating pod exec-agnhost-pod in namespace e2e-tests-service-lb-rvfhw [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:152] Jan 7 18:20:41.338: 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:317] Jan 7 18:20:51.377: INFO: checking the connectivity of addr 10.2.0.4:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:124] Jan 7 18:20:51.377: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] ... skipping 102 lines ... [0mLifecycle of VMSS [38;5;14m[1m[It] should add node object when VMSS instance allocated[0m [38;5;204m[VMSS, VMSS-Scale][0m [38;5;243m/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/node/vmss.go:95[0m [38;5;14m[SKIPPED] skip non-VMSS or VMSS Flex[0m [38;5;14mIn [1m[It][0m[38;5;14m at: [1m/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/node/vmss.go:100[0m [38;5;243m@ 01/07/23 18:24:15.619[0m [38;5;243m------------------------------[0m [0mMulti-ports service [38;5;243mWhen ExternalTrafficPolicy is updated [0m[1mShould not have error occurred[0m [38;5;204m[Multi-Ports][0m [38;5;243m/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:994[0m Jan 7 18:24:21.713: INFO: Creating a kubernetes client [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:55] Jan 7 18:24:21.713: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:63] Jan 7 18:24:21.748: INFO: Created a test namespace "e2e-tests-mpservice-mqf27" [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:109] Jan 7 18:24:21.748: INFO: Creating Azure clients [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:948] Jan 7 18:24:21.748: INFO: Creating a kubernetes client [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:55] ... skipping 5 lines ... Jan 7 18:24:23.219: INFO: 3 pods in namespace e2e-tests-mpservice-mqf27 are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:87] Jan 7 18:24:33.256: INFO: 0 pods in namespace e2e-tests-mpservice-mqf27 are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:87] [1mSTEP:[0m Getting the service [38;5;243m@ 01/07/23 18:24:33.256[0m Jan 7 18:24:33.256: INFO: Creating service multiport-test in namespace e2e-tests-mpservice-mqf27 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:997] Jan 7 18:24:33.309: INFO: Successfully created LoadBalancer service multiport-test in namespace e2e-tests-mpservice-mqf27 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1001] Jan 7 18:24:33.309: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1004] Jan 7 18:24:33.339: 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:158] Jan 7 18:24:43.377: 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:158] Jan 7 18:24:53.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:158] Jan 7 18:25:03.376: 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:158] Jan 7 18:25:13.377: 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:158] Jan 7 18:25:23.380: 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:158] Jan 7 18:25:33.377: 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:158] Jan 7 18:25:43.377: INFO: Exposure successfully, get external ip: 20.127.254.8 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] Jan 7 18:25:43.377: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-mpservice-mqf27 to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:159] Jan 7 18:25:43.377: INFO: creating pod exec-agnhost-pod in namespace e2e-tests-mpservice-mqf27 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:152] Jan 7 18:25:43.448: 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:317] Jan 7 18:25:53.486: INFO: checking the connectivity of addr 20.127.254.8:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:124] Jan 7 18:25:53.486: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] ... skipping 55 lines ... Jan 7 18:27:26.303: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:63] Jan 7 18:27:26.340: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] Jan 7 18:27:26.340: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig cluster-info dump | grep service-cluster-ip-range' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:149] Jan 7 18:27:27.747: INFO: Creating acr e2eacrc6d5 in resource group capz-28olb1. [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/container_registry_utils.go:44] Jan 7 18:27:35.991: INFO: Attempting Docker login with azure cred. [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/container_registry_utils.go:85] Jan 7 18:27:36.547: INFO: Deleting acr e2eacrc6d5 in resource group capz-28olb1. [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/container_registry_utils.go:61] [38;5;9m[FAILED][0m in [It] - /home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/auth/cred.go:71 [38;5;243m@ 01/07/23 18:27:40.148[0m Jan 7 18:27:40.149: INFO: Deleting namespace e2e-tests-cred-6zbz6 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:134] [1mAttempt #1 [38;5;9mFailed[0m[1m. Retrying ↺[0m [38;5;243m@ 01/07/23 18:27:46.243[0m Jan 7 18:27:46.243: INFO: Creating a kubernetes client [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:55] Jan 7 18:27:46.243: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:63] Jan 7 18:27:46.278: INFO: Created a test namespace "e2e-tests-cred-f4vsg" [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:109] Jan 7 18:27:46.278: INFO: Creating a kubernetes client [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:55] Jan 7 18:27:46.278: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:63] Jan 7 18:27:46.314: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] Jan 7 18:27:46.314: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig cluster-info dump | grep service-cluster-ip-range' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:149] Jan 7 18:27:47.872: INFO: Creating acr e2eacrea9b in resource group capz-28olb1. [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/container_registry_utils.go:44] Jan 7 18:27:50.396: INFO: Attempting Docker login with azure cred. [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/container_registry_utils.go:85] Jan 7 18:27:50.762: INFO: Deleting acr e2eacrea9b in resource group capz-28olb1. [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/container_registry_utils.go:61] [38;5;9m[FAILED][0m in [It] - /home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/auth/cred.go:71 [38;5;243m@ 01/07/23 18:27:52.403[0m Jan 7 18:27:52.403: INFO: Deleting namespace e2e-tests-cred-f4vsg [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/utils.go:134] [38;5;9m• [FAILED] [32.233 seconds][0m [0mAzure Credential Provider [38;5;9m[1m[It] should be able to pull private images from acr without docker secrets set explicitly[0m [38;5;204m[Credential][0m [38;5;243m/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/auth/cred.go:59[0m [38;5;9m[FAILED] Unexpected error: <*fmt.wrapError | 0xc0001185a0>: { msg: "docker failed to login with error: exit status 1", err: <*exec.ExitError | 0xc000118580>{ ProcessState: { pid: 39569, status: 256, rusage: { Utime: {Sec: 0, Usec: 20518}, ... skipping 14 lines ... Nivcsw: 10, }, }, Stderr: nil, }, } docker failed to login with error: exit status 1 occurred[0m [38;5;9mIn [1m[It][0m[38;5;9m at: [1m/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/auth/cred.go:71[0m [38;5;243m@ 01/07/23 18:27:52.403[0m There were [1m[38;5;9madditional failures[0m detected. To view them in detail run [1mginkgo -vv[0m [38;5;243m------------------------------[0m [0m[StandardLoadBalancer] Standard load balancer [0m[1mshould add all nodes in different agent pools to backends[0m [38;5;204m[Multi-Nodepool][0m ... skipping 9 lines ... Jan 7 18:27:59.903: INFO: Waiting for backend pods to be ready [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/standard_lb.go:70] Jan 7 18:27:59.947: INFO: 3 pods in namespace e2e-tests-service-lb-ldbbv are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:87] Jan 7 18:28:09.991: INFO: 0 pods in namespace e2e-tests-service-lb-ldbbv are pending [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:87] Jan 7 18:28:09.991: INFO: Creating service servicelb-test in namespace e2e-tests-service-lb-ldbbv [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1196] Jan 7 18:28:10.042: INFO: Successfully created LoadBalancer service servicelb-test in namespace e2e-tests-service-lb-ldbbv [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1200] Jan 7 18:28:10.042: INFO: Waiting service to expose... [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/network/service_annotations.go:1203] Jan 7 18:28:10.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:158] Jan 7 18:28:20.103: 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:158] Jan 7 18:28:30.102: 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:158] Jan 7 18:28:40.105: 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:158] Jan 7 18:28:50.104: 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:158] Jan 7 18:29:00.104: 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:158] Jan 7 18:29:10.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:158] Jan 7 18:29:20.104: INFO: Exposure successfully, get external ip: 20.241.168.113 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:173] Jan 7 18:29:20.104: INFO: Creating a hostNetwork Pod exec-agnhost-pod in namespace e2e-tests-service-lb-ldbbv to exec [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:159] Jan 7 18:29:20.104: INFO: creating pod exec-agnhost-pod in namespace e2e-tests-service-lb-ldbbv [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/pod_utils.go:152] Jan 7 18:29:20.177: 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:317] Jan 7 18:29:30.216: INFO: checking the connectivity of addr 20.241.168.113:80 with protocol TCP [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:124] Jan 7 18:29:30.216: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] Jan 7 18:29:30.216: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig --namespace=e2e-tests-service-lb-ldbbv exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4 20.241.168.113 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:149] Jan 7 18:29:40.379: INFO: rc: 1 [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:164] Jan 7 18:29:40.379: INFO: got error error running /usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig --namespace=e2e-tests-service-lb-ldbbv exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4 20.241.168.113 80: Command stdout: stderr: Unable to connect to the server: net/http: TLS handshake timeout error: exit status 1, will retry, output: stdout: stderr:Unable to connect to the server: net/http: TLS handshake timeout [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/service_utils.go:187] Jan 7 18:29:50.388: INFO: Kubernetes configuration file name: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:107] Jan 7 18:29:50.388: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig --namespace=e2e-tests-service-lb-ldbbv exec exec-agnhost-pod -- /bin/sh -x -c nc -vz -w 4 20.241.168.113 80' [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:149] Jan 7 18:29:50.953: INFO: stderr: "+ nc -vz -w 4 20.241.168.113 80\nConnection to 20.241.168.113 80 port [tcp/http] succeeded!\n" [/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/utils/kubectl.go:176] ... skipping 18 lines ... [0m[1m[ReportAfterSuite] Autogenerated ReportAfterSuite for --junit-report[0m [38;5;243mautogenerated by Ginkgo[0m [38;5;10m[ReportAfterSuite] PASSED [0.015 seconds][0m [38;5;243m------------------------------[0m [38;5;9m[1mSummarizing 1 Failure:[0m [38;5;9m[FAIL][0m [0mAzure Credential Provider [38;5;9m[1m[It] should be able to pull private images from acr without docker secrets set explicitly[0m [38;5;204m[Credential][0m [38;5;243m/home/prow/go/src/sigs.k8s.io/cloud-provider-azure/tests/e2e/auth/cred.go:71[0m [38;5;9m[1mRan 46 of 62 Specs in 8004.079 seconds[0m [38;5;9m[1mFAIL![0m -- [38;5;10m[1m45 Passed[0m | [38;5;9m[1m1 Failed[0m | [38;5;11m[1m0 Pending[0m | [38;5;14m[1m16 Skipped[0m --- FAIL: TestAzureTest (8004.10s) FAIL [38;5;228mYou're using deprecated Ginkgo functionality:[0m [38;5;228m=============================================[0m [38;5;11m--ginkgo.slow-spec-threshold is deprecated --slow-spec-threshold has been deprecated and will be removed in a future version of Ginkgo. This feature has proved to be more noisy than useful. You can use --poll-progress-after, instead, to get more actionable feedback about potentially slow specs and understand where they might be getting stuck.[0m [38;5;243mTo silence deprecations that can be silenced set the following environment variable:[0m [38;5;243mACK_GINKGO_DEPRECATIONS=2.6.1[0m Ginkgo ran 1 suite in 2h14m41.274086637s Test Suite Failed make: *** [Makefile:368: test-ccm-e2e] Error 1 NAME STATUS ROLES AGE VERSION INTERNAL-IP EXTERNAL-IP OS-IMAGE KERNEL-VERSION CONTAINER-RUNTIME capz-28olb1-control-plane-jtwd9 Ready control-plane 138m v1.27.0-alpha.0.830+ca5c522080bc62 10.0.0.4 <none> Ubuntu 18.04.6 LTS 5.4.0-1098-azure containerd://1.6.2 capz-28olb1-md-0-nl7b9 Ready <none> 136m v1.27.0-alpha.0.830+ca5c522080bc62 10.1.0.4 <none> Ubuntu 18.04.6 LTS 5.4.0-1098-azure containerd://1.6.2 capz-28olb1-md-0-xpnpj Ready <none> 135m v1.27.0-alpha.0.830+ca5c522080bc62 10.1.0.5 <none> Ubuntu 18.04.6 LTS 5.4.0-1098-azure containerd://1.6.2 NAMESPACE NAME READY STATUS RESTARTS AGE IP NODE NOMINATED NODE READINESS GATES calico-apiserver calico-apiserver-68d87c49dc-cvx8b 1/1 Running 0 135m 192.168.228.1 capz-28olb1-md-0-xpnpj <none> <none> ... skipping 83 lines ... Jan 7 18:33:31.307: INFO: Collecting events for Pod kube-system/kube-proxy-qgwwv Jan 7 18:33:31.307: INFO: Creating log watcher for controller kube-system/kube-apiserver-capz-28olb1-control-plane-jtwd9, container kube-apiserver Jan 7 18:33:31.385: INFO: Fetching kube-system pod logs took 543.491249ms Jan 7 18:33:31.385: INFO: Dumping workload cluster default/capz-28olb1 Azure activity log Jan 7 18:33:31.386: INFO: Creating log watcher for controller tigera-operator/tigera-operator-7795f5d79b-d4xpc, container tigera-operator Jan 7 18:33:31.386: INFO: Collecting events for Pod tigera-operator/tigera-operator-7795f5d79b-d4xpc Jan 7 18:33:39.103: INFO: Got error while iterating over activity logs for resource group capz-28olb1: insights.ActivityLogsClient#listNextResults: Failure responding to next results request: StatusCode=404 -- Original Error: autorest/azure: error response cannot be parsed: {"<!DOCTYPE html PUBLIC \"-//W3C//DTD XHTML 1.0 Strict//EN\" \"http://www.w3.org/TR/xhtml1/DTD/xhtml1-strict.dtd\">\r\n<html xmlns=\"http://www.w3.org/1999/xhtml\">\r\n<head>\r\n<meta http-equiv=\"Content-Type\" content=\"text/html; charset=iso-8859-1\"/>\r\n<title>404 - File or directory not found.</title>\r\n<style type=\"text/css\">\r\n<!--\r\nbody{margin:0;font-size:.7em;font-family:Verdana, Arial, Helvetica, sans-serif;background:#EEEEEE;}\r\nfieldset{padding:0 15px 10px 15px;} \r\nh1{font-size:2.4em;margin:0;color:#FFF;}\r\nh2{font-si" '\x00' '\x00'} error: invalid character '<' looking for beginning of value Jan 7 18:33:39.103: INFO: Fetching activity logs took 7.718083605s ================ REDACTING LOGS ================ All sensitive variables are redacted make: Entering directory '/home/prow/go/src/sigs.k8s.io/cloud-provider-azure' rm -rf bin .pkg_config testResults make: Leaving directory '/home/prow/go/src/sigs.k8s.io/cloud-provider-azure' ... skipping 11 lines ...