Recent runs || View in Spyglass
PR | andyzhangx: test: support Win2022 test on capz |
Result | FAILURE |
Tests | 3 failed / 17 succeeded |
Started | |
Elapsed | 1h16m |
Revision | 1ecf7e2b24335790fae9e49b3535eab947e6ad78 |
Refs |
988 |
go run hack/e2e.go -v --test --test_args='--ginkgo.focus=AzureFile\sCSI\sDriver\sEnd\-to\-End\sTests\sDynamic\sProvisioning\sshould\screate\sa\sstatefulset\sobject\,\swrite\sand\sread\sto\sit\,\sdelete\sthe\spod\sand\swrite\sand\sread\sto\sit\sagain\s\[file\.csi\.azure\.com\]$'
/home/prow/go/src/sigs.k8s.io/azurefile-csi-driver/test/e2e/dynamic_provisioning_test.go:777 Unexpected error: <exec.CodeExitError>: { Err: <*errors.errorString | 0xc000a87e00>{ s: "error running /usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig --namespace=azurefile-7051 exec azurefile-volume-tester-vgvn6-0 --namespace=azurefile-7051 -- cmd /c type C:\\mnt\\test-1\\data.txt:\nCommand stdout:\n\nstderr:\nThe system cannot find the file specified.\r\ncommand terminated with exit code 1\n\nerror:\nexit status 1", }, Code: 1, } error running /usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig --namespace=azurefile-7051 exec azurefile-volume-tester-vgvn6-0 --namespace=azurefile-7051 -- cmd /c type C:\mnt\test-1\data.txt: Command stdout: stderr: The system cannot find the file specified. command terminated with exit code 1 error: exit status 1 occurred /home/prow/go/src/sigs.k8s.io/azurefile-csi-driver/vendor/k8s.io/kubernetes/test/e2e/framework/util.go:630from junit_01.xml
�[1mSTEP�[0m: Creating a kubernetes client Apr 22 03:46:23.184: INFO: >>> kubeConfig: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig �[1mSTEP�[0m: Building a namespace api object, basename azurefile �[1mSTEP�[0m: Waiting for a default service account to be provisioned in namespace �[1mSTEP�[0m: Waiting for kube-root-ca.crt to be provisioned in namespace Apr 22 03:46:23.765: INFO: >>> kubeConfig: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig �[1mSTEP�[0m: setting up the StorageClass �[1mSTEP�[0m: creating a StorageClass �[1mSTEP�[0m: setting up the PVC �[1mSTEP�[0m: setting up the statefulset �[1mSTEP�[0m: deploying the statefulset �[1mSTEP�[0m: checking that the pod is running �[1mSTEP�[0m: sleep 3s and then check pod exec Apr 22 03:46:40.991: INFO: Running '/usr/local/bin/kubectl --kubeconfig=/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig --namespace=azurefile-7051 exec azurefile-volume-tester-vgvn6-0 --namespace=azurefile-7051 -- cmd /c type C:\mnt\test-1\data.txt' Apr 22 03:46:41.656: INFO: rc: 1 Apr 22 03:46:41.656: INFO: deleting StatefulSet "azurefile-7051"/"azurefile-volume-tester-vgvn6" Apr 22 03:46:41.698: INFO: Pod azurefile-volume-tester-vgvn6-0 has the following logs: Apr 22 03:46:41.737: INFO: deleting StorageClass azurefile-7051-file.csi.azure.com-dynamic-sc-ft9rp �[1mSTEP�[0m: Collecting events from namespace "azurefile-7051". �[1mSTEP�[0m: Found 11 events. Apr 22 03:46:41.823: INFO: At 2022-04-22 03:46:23 +0000 UTC - event for azurefile-volume-tester-vgvn6: {statefulset-controller } SuccessfulCreate: create Claim pvc-azurefile-volume-tester-vgvn6-0 Pod azurefile-volume-tester-vgvn6-0 in StatefulSet azurefile-volume-tester-vgvn6 success Apr 22 03:46:41.824: INFO: At 2022-04-22 03:46:23 +0000 UTC - event for azurefile-volume-tester-vgvn6: {statefulset-controller } SuccessfulCreate: create Pod azurefile-volume-tester-vgvn6-0 in StatefulSet azurefile-volume-tester-vgvn6 successful Apr 22 03:46:41.824: INFO: At 2022-04-22 03:46:23 +0000 UTC - event for azurefile-volume-tester-vgvn6-0: {default-scheduler } FailedScheduling: 0/3 nodes are available: 3 pod has unbound immediate PersistentVolumeClaims. Apr 22 03:46:41.824: INFO: At 2022-04-22 03:46:23 +0000 UTC - event for pvc-azurefile-volume-tester-vgvn6-0: {file.csi.azure.com_capz-8a45pa-control-plane-cqlqm_5a679a69-5840-4af9-acb9-2bb06de8c5c8 } Provisioning: External provisioner is provisioning volume for claim "azurefile-7051/pvc-azurefile-volume-tester-vgvn6-0" Apr 22 03:46:41.824: INFO: At 2022-04-22 03:46:23 +0000 UTC - event for pvc-azurefile-volume-tester-vgvn6-0: {persistentvolume-controller } ExternalProvisioning: waiting for a volume to be created, either by external provisioner "file.csi.azure.com" or manually created by system administrator Apr 22 03:46:41.824: INFO: At 2022-04-22 03:46:24 +0000 UTC - event for azurefile-volume-tester-vgvn6-0: {default-scheduler } Scheduled: Successfully assigned azurefile-7051/azurefile-volume-tester-vgvn6-0 to capz-8a45-pzhtj Apr 22 03:46:41.824: INFO: At 2022-04-22 03:46:24 +0000 UTC - event for pvc-azurefile-volume-tester-vgvn6-0: {file.csi.azure.com_capz-8a45pa-control-plane-cqlqm_5a679a69-5840-4af9-acb9-2bb06de8c5c8 } ProvisioningSucceeded: Successfully provisioned volume pvc-61ed445d-fcfe-4a81-be23-ec0b5d9d6c8d Apr 22 03:46:41.824: INFO: At 2022-04-22 03:46:32 +0000 UTC - event for azurefile-volume-tester-vgvn6-0: {kubelet capz-8a45-pzhtj} Pulled: Container image "mcr.microsoft.com/windows/servercore:ltsc2022" already present on machine Apr 22 03:46:41.824: INFO: At 2022-04-22 03:46:32 +0000 UTC - event for azurefile-volume-tester-vgvn6-0: {kubelet capz-8a45-pzhtj} Created: Created container volume-tester Apr 22 03:46:41.824: INFO: At 2022-04-22 03:46:36 +0000 UTC - event for azurefile-volume-tester-vgvn6-0: {kubelet capz-8a45-pzhtj} Started: Started container volume-tester Apr 22 03:46:41.824: INFO: At 2022-04-22 03:46:41 +0000 UTC - event for azurefile-volume-tester-vgvn6-0: {kubelet capz-8a45-pzhtj} Killing: Stopping container volume-tester Apr 22 03:46:41.859: INFO: POD NODE PHASE GRACE CONDITIONS Apr 22 03:46:41.859: INFO: azurefile-volume-tester-vgvn6-0 capz-8a45-pzhtj Running 30s [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2022-04-22 03:46:24 +0000 UTC } {Ready True 0001-01-01 00:00:00 +0000 UTC 2022-04-22 03:46:37 +0000 UTC } {ContainersReady True 0001-01-01 00:00:00 +0000 UTC 2022-04-22 03:46:37 +0000 UTC } {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2022-04-22 03:46:24 +0000 UTC }] Apr 22 03:46:41.859: INFO: Apr 22 03:46:41.897: INFO: Logging node info for node capz-8a45-b775t Apr 22 03:46:41.932: INFO: Node Info: &Node{ObjectMeta:{capz-8a45-b775t e84b96d4-fdad-4ef5-868d-c1945c856ad3 5608 0 2022-04-22 03:11:35 +0000 UTC <nil> <nil> map[beta.kubernetes.io/arch:amd64 beta.kubernetes.io/instance-type:Standard_D4s_v3 beta.kubernetes.io/os:windows failure-domain.beta.kubernetes.io/region:eastus2 failure-domain.beta.kubernetes.io/zone:0 kubernetes.io/arch:amd64 kubernetes.io/hostname:capz-8a45-b775t kubernetes.io/os:windows node.kubernetes.io/instance-type:Standard_D4s_v3 node.kubernetes.io/windows-build:10.0.20348 topology.kubernetes.io/region:eastus2 topology.kubernetes.io/zone:0] map[cluster.x-k8s.io/cluster-name:capz-8a45pa cluster.x-k8s.io/cluster-namespace:default cluster.x-k8s.io/machine:capz-8a45pa-md-win-b5fffb599-htlnk cluster.x-k8s.io/owner-kind:MachineSet cluster.x-k8s.io/owner-name:capz-8a45pa-md-win-b5fffb599 csi.volume.kubernetes.io/nodeid:{"file.csi.azure.com":"capz-8a45-b775t"} kubeadm.alpha.kubernetes.io/cri-socket:npipe:////./pipe/containerd-containerd node.alpha.kubernetes.io/ttl:0 projectcalico.org/IPv4Address:10.1.0.5/16 projectcalico.org/IPv4VXLANTunnelAddr:192.168.216.193 projectcalico.org/VXLANTunnelMACAddr:00:15:5d:2f:65:42 volumes.kubernetes.io/controller-managed-attach-detach:true] [] [] [{Go-http-client Update v1 2022-04-22 03:11:35 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{".":{},"f:kubeadm.alpha.kubernetes.io/cri-socket":{},"f:volumes.kubernetes.io/controller-managed-attach-detach":{}},"f:labels":{".":{},"f:beta.kubernetes.io/arch":{},"f:beta.kubernetes.io/instance-type":{},"f:beta.kubernetes.io/os":{},"f:failure-domain.beta.kubernetes.io/region":{},"f:failure-domain.beta.kubernetes.io/zone":{},"f:kubernetes.io/arch":{},"f:kubernetes.io/hostname":{},"f:kubernetes.io/os":{},"f:node.kubernetes.io/instance-type":{},"f:node.kubernetes.io/windows-build":{},"f:topology.kubernetes.io/region":{},"f:topology.kubernetes.io/zone":{}}},"f:spec":{"f:providerID":{}}} } {kube-controller-manager Update v1 2022-04-22 03:11:39 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{"f:node.alpha.kubernetes.io/ttl":{}}}} } {manager Update v1 2022-04-22 03:12:57 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{"f:cluster.x-k8s.io/cluster-name":{},"f:cluster.x-k8s.io/cluster-namespace":{},"f:cluster.x-k8s.io/machine":{},"f:cluster.x-k8s.io/owner-kind":{},"f:cluster.x-k8s.io/owner-name":{}}}} } {calico-node.exe Update v1 2022-04-22 03:13:19 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{"f:projectcalico.org/IPv4Address":{},"f:projectcalico.org/IPv4VXLANTunnelAddr":{},"f:projectcalico.org/VXLANTunnelMACAddr":{}}}} status} {Go-http-client Update v1 2022-04-22 03:29:26 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{"f:csi.volume.kubernetes.io/nodeid":{}}},"f:status":{"f:conditions":{"k:{\"type\":\"DiskPressure\"}":{"f:lastHeartbeatTime":{}},"k:{\"type\":\"MemoryPressure\"}":{"f:lastHeartbeatTime":{}},"k:{\"type\":\"PIDPressure\"}":{"f:lastHeartbeatTime":{}},"k:{\"type\":\"Ready\"}":{"f:lastHeartbeatTime":{},"f:lastTransitionTime":{},"f:message":{},"f:reason":{},"f:status":{}}},"f:images":{}}} status}]},Spec:NodeSpec{PodCIDR:,DoNotUseExternalID:,ProviderID:azure:///subscriptions/===REDACTED===/resourceGroups/capz-8a45pa/providers/Microsoft.Compute/virtualMachines/capz-8a45-b775t,Unschedulable:false,Taints:[]Taint{},ConfigSource:nil,PodCIDRs:[],},Status:NodeStatus{Capacity:ResourceList{attachable-volumes-azure-disk: {{8 0} {<nil>} 8 DecimalSI},cpu: {{4 0} {<nil>} 4 DecimalSI},ephemeral-storage: {{136912564224 0} {<nil>} 133703676Ki BinarySI},memory: {{17179398144 0} {<nil>} 16776756Ki BinarySI},pods: {{110 0} {<nil>} 110 DecimalSI},},Allocatable:ResourceList{attachable-volumes-azure-disk: {{8 0} {<nil>} 8 DecimalSI},cpu: {{4 0} {<nil>} 4 DecimalSI},ephemeral-storage: {{123221307598 0} {<nil>} 123221307598 DecimalSI},memory: {{17074540544 0} {<nil>} 16674356Ki BinarySI},pods: {{110 0} {<nil>} 110 DecimalSI},},Phase:,Conditions:[]NodeCondition{NodeCondition{Type:MemoryPressure,Status:False,LastHeartbeatTime:2022-04-22 03:44:59 +0000 UTC,LastTransitionTime:2022-04-22 03:11:35 +0000 UTC,Reason:KubeletHasSufficientMemory,Message:kubelet has sufficient memory available,},NodeCondition{Type:DiskPressure,Status:False,LastHeartbeatTime:2022-04-22 03:44:59 +0000 UTC,LastTransitionTime:2022-04-22 03:11:35 +0000 UTC,Reason:KubeletHasNoDiskPressure,Message:kubelet has no disk pressure,},NodeCondition{Type:PIDPressure,Status:False,LastHeartbeatTime:2022-04-22 03:44:59 +0000 UTC,LastTransitionTime:2022-04-22 03:11:35 +0000 UTC,Reason:KubeletHasSufficientPID,Message:kubelet has sufficient PID available,},NodeCondition{Type:Ready,Status:True,LastHeartbeatTime:2022-04-22 03:44:59 +0000 UTC,LastTransitionTime:2022-04-22 03:12:36 +0000 UTC,Reason:KubeletReady,Message:kubelet is posting ready status,},},Addresses:[]NodeAddress{NodeAddress{Type:Hostname,Address:capz-8a45-b775t,},NodeAddress{Type:InternalIP,Address:10.1.0.5,},},DaemonEndpoints:NodeDaemonEndpoints{KubeletEndpoint:DaemonEndpoint{Port:10250,},},NodeInfo:NodeSystemInfo{MachineID:capz-8a45-b775t,SystemUUID:998B47FF-53B3-4E94-92EE-87251E992BE4,BootID:,KernelVersion:10.0.20348.405,OSImage:Windows Server 2022 Datacenter,ContainerRuntimeVersion:containerd://1.6.1,KubeletVersion:v1.23.5,KubeProxyVersion:v1.23.5,OperatingSystem:windows,Architecture:amd64,},Images:[]ContainerImage{ContainerImage{Names:[docker.io/sigwindowstools/calico-install@sha256:141afecd724eb757ee41593cc73f35fb19a2ce13cad73179cf3b1cef81a637d1 docker.io/sigwindowstools/calico-install:v3.22.1-hostprocess],SizeBytes:148096127,},ContainerImage{Names:[capzci.azurecr.io/azurefile-csi@sha256:47b232ada3d11bf92017193d2c00e90a3f3947ecc5ac4e8a7e368d5fb87907fd capzci.azurecr.io/azurefile-csi:e2e-07bfd478d868c055f36b20367e57ff932dd3f619],SizeBytes:130302144,},ContainerImage{Names:[docker.io/sigwindowstools/calico-node@sha256:b8e6e2f190e58d6b61b7f2a19b0e2e17a377e5b9d7b9528e9b7953d9f9ab59bb docker.io/sigwindowstools/calico-node:v3.22.1-hostprocess],SizeBytes:128793648,},ContainerImage{Names:[mcr.microsoft.com/oss/kubernetes-csi/csi-node-driver-registrar@sha256:dbec3a8166686b09b242176ab5b99e993da4126438bbce68147c3fd654f35662 mcr.microsoft.com/oss/kubernetes-csi/csi-node-driver-registrar:v2.4.0],SizeBytes:125554391,},ContainerImage{Names:[mcr.microsoft.com/oss/kubernetes-csi/livenessprobe@sha256:c96a6255c42766f6b8bb1a7cda02b0060ab1b20b2e2dafcc64ec09e7646745a6 mcr.microsoft.com/oss/kubernetes-csi/livenessprobe:v2.5.0],SizeBytes:124471446,},ContainerImage{Names:[ghcr.io/kubernetes-sigs/sig-windows/csi-proxy@sha256:96b4144986319a747ba599892454be2737aae6005d96b8e13ed481321ac3afba ghcr.io/kubernetes-sigs/sig-windows/csi-proxy:v1.0.2],SizeBytes:123925937,},ContainerImage{Names:[k8s.gcr.io/pause@sha256:3d380ca8864549e74af4b29c10f9cb0956236dfb01c40ca076fb6c37253234db k8s.gcr.io/pause:3.6],SizeBytes:119397646,},ContainerImage{Names:[docker.io/sigwindowstools/kube-proxy@sha256:0f8a44b795d1824358f24cc56f0024d18a39ae044656686596d8b7fa6d78e1fa docker.io/sigwindowstools/kube-proxy:v1.23.5-calico-hostprocess],SizeBytes:116337721,},},VolumesInUse:[],VolumesAttached:[]AttachedVolume{},Config:nil,},} Apr 22 03:46:41.933: INFO: Logging kubelet events for node capz-8a45-b775t Apr 22 03:46:41.970: INFO: Logging pods the kubelet thinks is on node capz-8a45-b775t Apr 22 03:46:42.026: INFO: kube-proxy-windows-tq6rp started at 2022-04-22 03:11:35 +0000 UTC (0+1 container statuses recorded) Apr 22 03:46:42.026: INFO: Container kube-proxy ready: true, restart count 0 Apr 22 03:46:42.026: INFO: calico-node-windows-5crjp started at 2022-04-22 03:11:35 +0000 UTC (1+2 container statuses recorded) Apr 22 03:46:42.026: INFO: Init container install-cni ready: true, restart count 0 Apr 22 03:46:42.026: INFO: Container calico-node-felix ready: true, restart count 1 Apr 22 03:46:42.026: INFO: Container calico-node-startup ready: true, restart count 0 Apr 22 03:46:42.026: INFO: csi-proxy-zxbhr started at 2022-04-22 03:12:36 +0000 UTC (0+1 container statuses recorded) Apr 22 03:46:42.026: INFO: Container csi-proxy ready: true, restart count 0 Apr 22 03:46:42.026: INFO: csi-azurefile-node-win-fv9jz started at 2022-04-22 03:28:13 +0000 UTC (0+3 container statuses recorded) Apr 22 03:46:42.026: INFO: Container azurefile ready: true, restart count 0 Apr 22 03:46:42.026: INFO: Container liveness-probe ready: true, restart count 0 Apr 22 03:46:42.026: INFO: Container node-driver-registrar ready: true, restart count 0 Apr 22 03:46:42.249: INFO: Latency metrics for node capz-8a45-b775t Apr 22 03:46:42.249: INFO: Logging node info for node capz-8a45-pzhtj Apr 22 03:46:42.285: INFO: Node Info: &Node{ObjectMeta:{capz-8a45-pzhtj ddafc1c7-e411-4bcb-9471-d504ffe910ad 4959 0 2022-04-22 03:11:25 +0000 UTC <nil> <nil> map[beta.kubernetes.io/arch:amd64 beta.kubernetes.io/instance-type:Standard_D4s_v3 beta.kubernetes.io/os:windows failure-domain.beta.kubernetes.io/region:eastus2 failure-domain.beta.kubernetes.io/zone:0 kubernetes.io/arch:amd64 kubernetes.io/hostname:capz-8a45-pzhtj kubernetes.io/os:windows node.kubernetes.io/instance-type:Standard_D4s_v3 node.kubernetes.io/windows-build:10.0.20348 topology.kubernetes.io/region:eastus2 topology.kubernetes.io/zone:0] map[cluster.x-k8s.io/cluster-name:capz-8a45pa cluster.x-k8s.io/cluster-namespace:default cluster.x-k8s.io/machine:capz-8a45pa-md-win-b5fffb599-gvkp4 cluster.x-k8s.io/owner-kind:MachineSet cluster.x-k8s.io/owner-name:capz-8a45pa-md-win-b5fffb599 csi.volume.kubernetes.io/nodeid:{"file.csi.azure.com":"capz-8a45-pzhtj"} kubeadm.alpha.kubernetes.io/cri-socket:npipe:////./pipe/containerd-containerd node.alpha.kubernetes.io/ttl:0 projectcalico.org/IPv4Address:10.1.0.4/16 projectcalico.org/IPv4VXLANTunnelAddr:192.168.59.193 projectcalico.org/VXLANTunnelMACAddr:00:15:5d:8c:1c:33 volumes.kubernetes.io/controller-managed-attach-detach:true] [] [] [{Go-http-client Update v1 2022-04-22 03:11:27 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{".":{},"f:kubeadm.alpha.kubernetes.io/cri-socket":{},"f:volumes.kubernetes.io/controller-managed-attach-detach":{}},"f:labels":{".":{},"f:beta.kubernetes.io/arch":{},"f:beta.kubernetes.io/instance-type":{},"f:beta.kubernetes.io/os":{},"f:failure-domain.beta.kubernetes.io/region":{},"f:failure-domain.beta.kubernetes.io/zone":{},"f:kubernetes.io/arch":{},"f:kubernetes.io/hostname":{},"f:kubernetes.io/os":{},"f:node.kubernetes.io/instance-type":{},"f:node.kubernetes.io/windows-build":{},"f:topology.kubernetes.io/region":{},"f:topology.kubernetes.io/zone":{}}},"f:spec":{"f:providerID":{}}} } {kube-controller-manager Update v1 2022-04-22 03:11:29 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{"f:node.alpha.kubernetes.io/ttl":{}}}} } {manager Update v1 2022-04-22 03:12:41 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{"f:cluster.x-k8s.io/cluster-name":{},"f:cluster.x-k8s.io/cluster-namespace":{},"f:cluster.x-k8s.io/machine":{},"f:cluster.x-k8s.io/owner-kind":{},"f:cluster.x-k8s.io/owner-name":{}}}} } {calico-node.exe Update v1 2022-04-22 03:13:16 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{"f:projectcalico.org/IPv4Address":{},"f:projectcalico.org/IPv4VXLANTunnelAddr":{},"f:projectcalico.org/VXLANTunnelMACAddr":{}}}} status} {Go-http-client Update v1 2022-04-22 03:29:29 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{"f:csi.volume.kubernetes.io/nodeid":{}}},"f:status":{"f:conditions":{"k:{\"type\":\"DiskPressure\"}":{"f:lastHeartbeatTime":{}},"k:{\"type\":\"MemoryPressure\"}":{"f:lastHeartbeatTime":{}},"k:{\"type\":\"PIDPressure\"}":{"f:lastHeartbeatTime":{}},"k:{\"type\":\"Ready\"}":{"f:lastHeartbeatTime":{},"f:lastTransitionTime":{},"f:message":{},"f:reason":{},"f:status":{}}},"f:images":{}}} status}]},Spec:NodeSpec{PodCIDR:,DoNotUseExternalID:,ProviderID:azure:///subscriptions/===REDACTED===/resourceGroups/capz-8a45pa/providers/Microsoft.Compute/virtualMachines/capz-8a45-pzhtj,Unschedulable:false,Taints:[]Taint{},ConfigSource:nil,PodCIDRs:[],},Status:NodeStatus{Capacity:ResourceList{attachable-volumes-azure-disk: {{8 0} {<nil>} 8 DecimalSI},cpu: {{4 0} {<nil>} 4 DecimalSI},ephemeral-storage: {{136912564224 0} {<nil>} 133703676Ki BinarySI},memory: {{17179398144 0} {<nil>} 16776756Ki BinarySI},pods: {{110 0} {<nil>} 110 DecimalSI},},Allocatable:ResourceList{attachable-volumes-azure-disk: {{8 0} {<nil>} 8 DecimalSI},cpu: {{4 0} {<nil>} 4 DecimalSI},ephemeral-storage: {{123221307598 0} {<nil>} 123221307598 DecimalSI},memory: {{17074540544 0} {<nil>} 16674356Ki BinarySI},pods: {{110 0} {<nil>} 110 DecimalSI},},Phase:,Conditions:[]NodeCondition{NodeCondition{Type:MemoryPressure,Status:False,LastHeartbeatTime:2022-04-22 03:42:34 +0000 UTC,LastTransitionTime:2022-04-22 03:11:25 +0000 UTC,Reason:KubeletHasSufficientMemory,Message:kubelet has sufficient memory available,},NodeCondition{Type:DiskPressure,Status:False,LastHeartbeatTime:2022-04-22 03:42:34 +0000 UTC,LastTransitionTime:2022-04-22 03:11:25 +0000 UTC,Reason:KubeletHasNoDiskPressure,Message:kubelet has no disk pressure,},NodeCondition{Type:PIDPressure,Status:False,LastHeartbeatTime:2022-04-22 03:42:34 +0000 UTC,LastTransitionTime:2022-04-22 03:11:25 +0000 UTC,Reason:KubeletHasSufficientPID,Message:kubelet has sufficient PID available,},NodeCondition{Type:Ready,Status:True,LastHeartbeatTime:2022-04-22 03:42:34 +0000 UTC,LastTransitionTime:2022-04-22 03:12:46 +0000 UTC,Reason:KubeletReady,Message:kubelet is posting ready status,},},Addresses:[]NodeAddress{NodeAddress{Type:Hostname,Address:capz-8a45-pzhtj,},NodeAddress{Type:InternalIP,Address:10.1.0.4,},},DaemonEndpoints:NodeDaemonEndpoints{KubeletEndpoint:DaemonEndpoint{Port:10250,},},NodeInfo:NodeSystemInfo{MachineID:capz-8a45-pzhtj,SystemUUID:5CA444EC-9BBE-4627-9CEE-7A41926E2CAA,BootID:,KernelVersion:10.0.20348.405,OSImage:Windows Server 2022 Datacenter,ContainerRuntimeVersion:containerd://1.6.1,KubeletVersion:v1.23.5,KubeProxyVersion:v1.23.5,OperatingSystem:windows,Architecture:amd64,},Images:[]ContainerImage{ContainerImage{Names:[mcr.microsoft.com/windows/servercore@sha256:378d85bd8e7388a777d25009f8523d1e95a5f544f131eaada83171045d5b2c1e mcr.microsoft.com/windows/servercore:ltsc2022],SizeBytes:2226956779,},ContainerImage{Names:[docker.io/sigwindowstools/calico-install@sha256:141afecd724eb757ee41593cc73f35fb19a2ce13cad73179cf3b1cef81a637d1 docker.io/sigwindowstools/calico-install:v3.22.1-hostprocess],SizeBytes:148096127,},ContainerImage{Names:[capzci.azurecr.io/azurefile-csi@sha256:47b232ada3d11bf92017193d2c00e90a3f3947ecc5ac4e8a7e368d5fb87907fd capzci.azurecr.io/azurefile-csi:e2e-07bfd478d868c055f36b20367e57ff932dd3f619],SizeBytes:130302144,},ContainerImage{Names:[docker.io/sigwindowstools/calico-node@sha256:b8e6e2f190e58d6b61b7f2a19b0e2e17a377e5b9d7b9528e9b7953d9f9ab59bb docker.io/sigwindowstools/calico-node:v3.22.1-hostprocess],SizeBytes:128793648,},ContainerImage{Names:[mcr.microsoft.com/oss/kubernetes-csi/csi-node-driver-registrar@sha256:dbec3a8166686b09b242176ab5b99e993da4126438bbce68147c3fd654f35662 mcr.microsoft.com/oss/kubernetes-csi/csi-node-driver-registrar:v2.4.0],SizeBytes:125554391,},ContainerImage{Names:[mcr.microsoft.com/oss/kubernetes-csi/livenessprobe@sha256:c96a6255c42766f6b8bb1a7cda02b0060ab1b20b2e2dafcc64ec09e7646745a6 mcr.microsoft.com/oss/kubernetes-csi/livenessprobe:v2.5.0],SizeBytes:124471446,},ContainerImage{Names:[ghcr.io/kubernetes-sigs/sig-windows/csi-proxy@sha256:96b4144986319a747ba599892454be2737aae6005d96b8e13ed481321ac3afba ghcr.io/kubernetes-sigs/sig-windows/csi-proxy:v1.0.2],SizeBytes:123925937,},ContainerImage{Names:[k8s.gcr.io/pause@sha256:3d380ca8864549e74af4b29c10f9cb0956236dfb01c40ca076fb6c37253234db k8s.gcr.io/pause:3.6],SizeBytes:119397646,},ContainerImage{Names:[docker.io/sigwindowstools/kube-proxy@sha256:0f8a44b795d1824358f24cc56f0024d18a39ae044656686596d8b7fa6d78e1fa docker.io/sigwindowstools/kube-proxy:v1.23.5-calico-hostprocess],SizeBytes:116337721,},},VolumesInUse:[],VolumesAttached:[]AttachedVolume{},Config:nil,},} Apr 22 03:46:42.285: INFO: Logging kubelet events for node capz-8a45-pzhtj Apr 22 03:46:42.323: INFO: Logging pods the kubelet thinks is on node capz-8a45-pzhtj Apr 22 03:46:42.369: INFO: csi-azurefile-node-win-8496k started at 2022-04-22 03:28:13 +0000 UTC (0+3 container statuses recorded) Apr 22 03:46:42.369: INFO: Container azurefile ready: true, restart count 0 Apr 22 03:46:42.369: INFO: Container liveness-probe ready: true, restart count 0 Apr 22 03:46:42.369: INFO: Container node-driver-registrar ready: true, restart count 0 Apr 22 03:46:42.369: INFO: azurefile-volume-tester-vgvn6-0 started at 2022-04-22 03:46:24 +0000 UTC (0+1 container statuses recorded) Apr 22 03:46:42.369: INFO: Container volume-tester ready: true, restart count 0 Apr 22 03:46:42.369: INFO: kube-proxy-windows-h6c26 started at 2022-04-22 03:11:25 +0000 UTC (0+1 container statuses recorded) Apr 22 03:46:42.369: INFO: Container kube-proxy ready: true, restart count 0 Apr 22 03:46:42.369: INFO: calico-node-windows-qfnvz started at 2022-04-22 03:11:25 +0000 UTC (1+2 container statuses recorded) Apr 22 03:46:42.369: INFO: Init container install-cni ready: true, restart count 0 Apr 22 03:46:42.369: INFO: Container calico-node-felix ready: true, restart count 0 Apr 22 03:46:42.369: INFO: Container calico-node-startup ready: true, restart count 0 Apr 22 03:46:42.369: INFO: csi-proxy-cnsgc started at 2022-04-22 03:12:46 +0000 UTC (0+1 container statuses recorded) Apr 22 03:46:42.369: INFO: Container csi-proxy ready: true, restart count 0 Apr 22 03:46:42.585: INFO: Latency metrics for node capz-8a45-pzhtj Apr 22 03:46:42.585: INFO: Logging node info for node capz-8a45pa-control-plane-cqlqm Apr 22 03:46:42.622: INFO: Node Info: &Node{ObjectMeta:{capz-8a45pa-control-plane-cqlqm e1bacca4-d09d-45ef-bb60-44a59d556b5e 5447 0 2022-04-22 03:08:34 +0000 UTC <nil> <nil> map[beta.kubernetes.io/arch:amd64 beta.kubernetes.io/instance-type:Standard_D2s_v3 beta.kubernetes.io/os:linux failure-domain.beta.kubernetes.io/region:eastus2 failure-domain.beta.kubernetes.io/zone:eastus2-1 kubernetes.io/arch:amd64 kubernetes.io/hostname:capz-8a45pa-control-plane-cqlqm kubernetes.io/os:linux node-role.kubernetes.io/control-plane: node-role.kubernetes.io/master: node.kubernetes.io/exclude-from-external-load-balancers: node.kubernetes.io/instance-type:Standard_D2s_v3 topology.kubernetes.io/region:eastus2 topology.kubernetes.io/zone:eastus2-1] map[cluster.x-k8s.io/cluster-name:capz-8a45pa cluster.x-k8s.io/cluster-namespace:default cluster.x-k8s.io/machine:capz-8a45pa-control-plane-s49xv cluster.x-k8s.io/owner-kind:KubeadmControlPlane cluster.x-k8s.io/owner-name:capz-8a45pa-control-plane kubeadm.alpha.kubernetes.io/cri-socket:/run/containerd/containerd.sock node.alpha.kubernetes.io/ttl:0 projectcalico.org/IPv4Address:10.0.0.4/16 projectcalico.org/IPv4VXLANTunnelAddr:192.168.3.0 volumes.kubernetes.io/controller-managed-attach-detach:true] [] [] [{Go-http-client Update v1 2022-04-22 03:08:40 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{".":{},"f:kubeadm.alpha.kubernetes.io/cri-socket":{},"f:volumes.kubernetes.io/controller-managed-attach-detach":{}},"f:labels":{".":{},"f:beta.kubernetes.io/arch":{},"f:beta.kubernetes.io/instance-type":{},"f:beta.kubernetes.io/os":{},"f:failure-domain.beta.kubernetes.io/region":{},"f:failure-domain.beta.kubernetes.io/zone":{},"f:kubernetes.io/arch":{},"f:kubernetes.io/hostname":{},"f:kubernetes.io/os":{},"f:node-role.kubernetes.io/control-plane":{},"f:node-role.kubernetes.io/master":{},"f:node.kubernetes.io/exclude-from-external-load-balancers":{},"f:node.kubernetes.io/instance-type":{},"f:topology.kubernetes.io/region":{},"f:topology.kubernetes.io/zone":{}}},"f:spec":{"f:providerID":{}}} } {manager Update v1 2022-04-22 03:09:08 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{"f:cluster.x-k8s.io/cluster-name":{},"f:cluster.x-k8s.io/cluster-namespace":{},"f:cluster.x-k8s.io/machine":{},"f:cluster.x-k8s.io/owner-kind":{},"f:cluster.x-k8s.io/owner-name":{}}}} } {Go-http-client Update v1 2022-04-22 03:09:16 +0000 UTC FieldsV1 {"f:status":{"f:allocatable":{"f:ephemeral-storage":{}},"f:capacity":{"f:ephemeral-storage":{}},"f:conditions":{"k:{\"type\":\"DiskPressure\"}":{"f:lastHeartbeatTime":{}},"k:{\"type\":\"MemoryPressure\"}":{"f:lastHeartbeatTime":{}},"k:{\"type\":\"PIDPressure\"}":{"f:lastHeartbeatTime":{}},"k:{\"type\":\"Ready\"}":{"f:lastHeartbeatTime":{},"f:lastTransitionTime":{},"f:message":{},"f:reason":{},"f:status":{}}},"f:images":{}}} status} {kube-controller-manager Update v1 2022-04-22 03:09:16 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{"f:node.alpha.kubernetes.io/ttl":{}}},"f:spec":{"f:taints":{}}} } {calico-node Update v1 2022-04-22 03:09:23 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{"f:projectcalico.org/IPv4Address":{},"f:projectcalico.org/IPv4VXLANTunnelAddr":{}}},"f:status":{"f:conditions":{"k:{\"type\":\"NetworkUnavailable\"}":{".":{},"f:lastHeartbeatTime":{},"f:lastTransitionTime":{},"f:message":{},"f:reason":{},"f:status":{},"f:type":{}}}}} status}]},Spec:NodeSpec{PodCIDR:,DoNotUseExternalID:,ProviderID:azure:///subscriptions/===REDACTED===/resourceGroups/capz-8a45pa/providers/Microsoft.Compute/virtualMachines/capz-8a45pa-control-plane-cqlqm,Unschedulable:false,Taints:[]Taint{Taint{Key:node-role.kubernetes.io/master,Value:,Effect:NoSchedule,TimeAdded:<nil>,},},ConfigSource:nil,PodCIDRs:[],},Status:NodeStatus{Capacity:ResourceList{attachable-volumes-azure-disk: {{4 0} {<nil>} 4 DecimalSI},cpu: {{2 0} {<nil>} 2 DecimalSI},ephemeral-storage: {{133018140672 0} {<nil>} BinarySI},hugepages-1Gi: {{0 0} {<nil>} 0 DecimalSI},hugepages-2Mi: {{0 0} {<nil>} 0 DecimalSI},memory: {{8340819968 0} {<nil>} 8145332Ki BinarySI},pods: {{110 0} {<nil>} 110 DecimalSI},},Allocatable:ResourceList{attachable-volumes-azure-disk: {{4 0} {<nil>} 4 DecimalSI},cpu: {{2 0} {<nil>} 2 DecimalSI},ephemeral-storage: {{119716326407 0} {<nil>} 119716326407 DecimalSI},hugepages-1Gi: {{0 0} {<nil>} 0 DecimalSI},hugepages-2Mi: {{0 0} {<nil>} 0 DecimalSI},memory: {{8235962368 0} {<nil>} 8042932Ki BinarySI},pods: {{110 0} {<nil>} 110 DecimalSI},},Phase:,Conditions:[]NodeCondition{NodeCondition{Type:NetworkUnavailable,Status:False,LastHeartbeatTime:2022-04-22 03:09:22 +0000 UTC,LastTransitionTime:2022-04-22 03:09:22 +0000 UTC,Reason:CalicoIsUp,Message:Calico is running on this node,},NodeCondition{Type:MemoryPressure,Status:False,LastHeartbeatTime:2022-04-22 03:44:09 +0000 UTC,LastTransitionTime:2022-04-22 03:08:13 +0000 UTC,Reason:KubeletHasSufficientMemory,Message:kubelet has sufficient memory available,},NodeCondition{Type:DiskPressure,Status:False,LastHeartbeatTime:2022-04-22 03:44:09 +0000 UTC,LastTransitionTime:2022-04-22 03:08:13 +0000 UTC,Reason:KubeletHasNoDiskPressure,Message:kubelet has no disk pressure,},NodeCondition{Type:PIDPressure,Status:False,LastHeartbeatTime:2022-04-22 03:44:09 +0000 UTC,LastTransitionTime:2022-04-22 03:08:13 +0000 UTC,Reason:KubeletHasSufficientPID,Message:kubelet has sufficient PID available,},NodeCondition{Type:Ready,Status:True,LastHeartbeatTime:2022-04-22 03:44:09 +0000 UTC,LastTransitionTime:2022-04-22 03:09:16 +0000 UTC,Reason:KubeletReady,Message:kubelet is posting ready status. AppArmor enabled,},},Addresses:[]NodeAddress{NodeAddress{Type:Hostname,Address:capz-8a45pa-control-plane-cqlqm,},NodeAddress{Type:InternalIP,Address:10.0.0.4,},},DaemonEndpoints:NodeDaemonEndpoints{KubeletEndpoint:DaemonEndpoint{Port:10250,},},NodeInfo:NodeSystemInfo{MachineID:9d60ca8e799b409f873858218da52249,SystemUUID:88815db8-a2d9-534e-9f6c-74f652c2b89d,BootID:3322475a-69df-4c7d-b2a7-dad0257fb0bf,KernelVersion:5.13.0-1017-azure,OSImage:Ubuntu 20.04.4 LTS,ContainerRuntimeVersion:containerd://1.6.1,KubeletVersion:v1.23.5,KubeProxyVersion:v1.23.5,OperatingSystem:linux,Architecture:amd64,},Images:[]ContainerImage{ContainerImage{Names:[k8s.gcr.io/etcd@sha256:64b9ea357325d5db9f8a723dcf503b5a449177b17ac87d69481e126bb724c263 k8s.gcr.io/etcd:3.5.1-0],SizeBytes:98888614,},ContainerImage{Names:[docker.io/calico/cni@sha256:2219eae79544b098119a06a8bb5608867f9ac00471592a00e2347f3ae4bea687 docker.io/calico/cni:v3.22.1],SizeBytes:80514590,},ContainerImage{Names:[capzci.azurecr.io/azurefile-csi@sha256:47b232ada3d11bf92017193d2c00e90a3f3947ecc5ac4e8a7e368d5fb87907fd capzci.azurecr.io/azurefile-csi:e2e-07bfd478d868c055f36b20367e57ff932dd3f619],SizeBytes:73271375,},ContainerImage{Names:[docker.io/calico/node@sha256:1f8ed83e5264b4206cce7e1def11bca0b3ea7d5f4eb9b0ca0dbfc8cb968ca57e docker.io/calico/node:v3.22.1],SizeBytes:69647221,},ContainerImage{Names:[mcr.microsoft.com/oss/kubernetes-csi/csi-provisioner@sha256:542c9258a1441e4927883ea73425e21f9a14043a649686bf6b51700f34c64f8e mcr.microsoft.com/oss/kubernetes-csi/csi-provisioner:v3.1.0],SizeBytes:59205633,},ContainerImage{Names:[mcr.microsoft.com/oss/kubernetes-csi/csi-resizer@sha256:ab6c2e18a4d943f2bf8688e1779622277a1d14c355c9d4bfc0d761d86c5108b3 mcr.microsoft.com/oss/kubernetes-csi/csi-resizer:v1.4.0],SizeBytes:56924121,},ContainerImage{Names:[mcr.microsoft.com/oss/kubernetes-csi/csi-attacher@sha256:19fbca01394f7ed80151731180cfde0a3367f038beae2a97cda7928034010057 mcr.microsoft.com/oss/kubernetes-csi/csi-attacher:v3.4.0],SizeBytes:56301028,},ContainerImage{Names:[docker.io/calico/kube-controllers@sha256:e42a0aba3637d123481cca14fd8314a482616593edf58f9594c9382e50498f9b docker.io/calico/kube-controllers:v3.22.1],SizeBytes:54948023,},ContainerImage{Names:[k8s.gcr.io/kube-proxy@sha256:c1f625d115fbd9a12eac615653fc81c0edb33b2b5a76d1e09d5daed11fa557c1 k8s.gcr.io/kube-proxy:v1.23.5],SizeBytes:39278412,},ContainerImage{Names:[k8s.gcr.io/kube-apiserver@sha256:ddf5bf7196eb534271f9e5d403f4da19838d5610bb5ca191001bde5f32b5492e k8s.gcr.io/kube-apiserver:v1.23.5],SizeBytes:32603217,},ContainerImage{Names:[k8s.gcr.io/kube-controller-manager@sha256:cca0fb3532abedcc95c5f64268d54da9ecc56cc4817ff08d0128941cf2b0e1a4 k8s.gcr.io/kube-controller-manager:v1.23.5],SizeBytes:30174093,},ContainerImage{Names:[mcr.microsoft.com/oss/kubernetes-csi/csi-snapshotter@sha256:a889e925e15f9423f7842f1b769f64cbcf6a20b6956122836fc835cf22d9073f mcr.microsoft.com/oss/kubernetes-csi/csi-snapshotter:v5.0.1],SizeBytes:22192414,},ContainerImage{Names:[k8s.gcr.io/kube-scheduler@sha256:489efb65da9edc40bf0911f3e6371e5bb6b8ad8fde1d55193a6cc84c2ef36626 k8s.gcr.io/kube-scheduler:v1.23.5],SizeBytes:15131395,},ContainerImage{Names:[k8s.gcr.io/coredns/coredns@sha256:5b6ec0d6de9baaf3e92d0f66cd96a25b9edbce8716f5f15dcd1a616b3abd590e k8s.gcr.io/coredns/coredns:v1.8.6],SizeBytes:13585107,},ContainerImage{Names:[docker.io/calico/pod2daemon-flexvol@sha256:35802ba083546a7c5e8b5bf0ee7ffad7f8a468e8c2b3631e7e9647512c94041d docker.io/calico/pod2daemon-flexvol:v3.22.1],SizeBytes:8462620,},ContainerImage{Names:[mcr.microsoft.com/oss/kubernetes-csi/livenessprobe@sha256:c96a6255c42766f6b8bb1a7cda02b0060ab1b20b2e2dafcc64ec09e7646745a6 mcr.microsoft.com/oss/kubernetes-csi/livenessprobe:v2.5.0],SizeBytes:8222208,},ContainerImage{Names:[k8s.gcr.io/pause@sha256:3d380ca8864549e74af4b29c10f9cb0956236dfb01c40ca076fb6c37253234db k8s.gcr.io/pause:3.6],SizeBytes:301773,},},VolumesInUse:[],VolumesAttached:[]AttachedVolume{},Config:nil,},} Apr 22 03:46:42.623: INFO: Logging kubelet events for node capz-8a45pa-control-plane-cqlqm Apr 22 03:46:42.661: INFO: Logging pods the kubelet thinks is on node capz-8a45pa-control-plane-cqlqm Apr 22 03:46:42.721: INFO: kube-scheduler-capz-8a45pa-control-plane-cqlqm started at 2022-04-22 03:08:47 +0000 UTC (0+1 container statuses recorded) Apr 22 03:46:42.721: INFO: Container kube-scheduler ready: true, restart count 0 Apr 22 03:46:42.721: INFO: etcd-capz-8a45pa-control-plane-cqlqm started at 2022-04-22 03:08:47 +0000 UTC (0+1 container statuses recorded) Apr 22 03:46:42.721: INFO: Container etcd ready: true, restart count 0 Apr 22 03:46:42.721: INFO: kube-proxy-dgbs5 started at 2022-04-22 03:08:47 +0000 UTC (0+1 container statuses recorded) Apr 22 03:46:42.721: INFO: Container kube-proxy ready: true, restart count 0 Apr 22 03:46:42.721: INFO: csi-azurefile-controller-66dd57cd58-4tn67 started at 2022-04-22 03:28:13 +0000 UTC (0+6 container statuses recorded) Apr 22 03:46:42.721: INFO: Container azurefile ready: true, restart count 0 Apr 22 03:46:42.721: INFO: Container csi-attacher ready: true, restart count 0 Apr 22 03:46:42.721: INFO: Container csi-provisioner ready: true, restart count 0 Apr 22 03:46:42.721: INFO: Container csi-resizer ready: true, restart count 0 Apr 22 03:46:42.721: INFO: Container csi-snapshotter ready: true, restart count 0 Apr 22 03:46:42.721: INFO: Container liveness-probe ready: true, restart count 0 Apr 22 03:46:42.721: INFO: coredns-64897985d-7t4hq started at 2022-04-22 03:09:16 +0000 UTC (0+1 container statuses recorded) Apr 22 03:46:42.721: INFO: Container coredns ready: true, restart count 0 Apr 22 03:46:42.721: INFO: kube-controller-manager-capz-8a45pa-control-plane-cqlqm started at 2022-04-22 03:08:46 +0000 UTC (0+1 container statuses recorded) Apr 22 03:46:42.721: INFO: Container kube-controller-manager ready: true, restart count 0 Apr 22 03:46:42.721: INFO: kube-apiserver-capz-8a45pa-control-plane-cqlqm started at 2022-04-22 03:08:47 +0000 UTC (0+1 container statuses recorded) Apr 22 03:46:42.721: INFO: Container kube-apiserver ready: true, restart count 0 Apr 22 03:46:42.721: INFO: calico-node-gkjpk started at 2022-04-22 03:08:58 +0000 UTC (3+1 container statuses recorded) Apr 22 03:46:42.721: INFO: Init container upgrade-ipam ready: true, restart count 0 Apr 22 03:46:42.721: INFO: Init container install-cni ready: true, restart count 0 Apr 22 03:46:42.721: INFO: Init container flexvol-driver ready: true, restart count 0 Apr 22 03:46:42.721: INFO: Container calico-node ready: true, restart count 0 Apr 22 03:46:42.721: INFO: coredns-64897985d-pr2wd started at 2022-04-22 03:09:16 +0000 UTC (0+1 container statuses recorded) Apr 22 03:46:42.721: INFO: Container coredns ready: true, restart count 0 Apr 22 03:46:42.721: INFO: calico-kube-controllers-7c664f4648-7c59f started at 2022-04-22 03:09:16 +0000 UTC (0+1 container statuses recorded) Apr 22 03:46:42.721: INFO: Container calico-kube-controllers ready: true, restart count 0 Apr 22 03:46:42.932: INFO: Latency metrics for node capz-8a45pa-control-plane-cqlqm Apr 22 03:46:42.932: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready �[1mSTEP�[0m: Destroying namespace "azurefile-7051" for this suite.
Filter through log files | View test history on testgrid
go run hack/e2e.go -v --test --test_args='--ginkgo.focus=AzureFile\sCSI\sDriver\sEnd\-to\-End\sTests\sDynamic\sProvisioning\sshould\screate\sa\svolume\son\sdemand\swith\smount\soptions\s\[kubernetes\.io\/azure\-file\]\s\[file\.csi\.azure\.com\]\s\[Windows\]$'
/home/prow/go/src/sigs.k8s.io/azurefile-csi-driver/test/e2e/dynamic_provisioning_test.go:104 Unexpected error: <*errors.errorString | 0xc000826cb0>: { s: "pod \"azurefile-volume-tester-h42mh\" failed with status: {Phase:Failed Conditions:[{Type:Initialized Status:True LastProbeTime:0001-01-01 00:00:00 +0000 UTC LastTransitionTime:2022-04-22 03:31:33 +0000 UTC Reason: Message:} {Type:Ready Status:False LastProbeTime:0001-01-01 00:00:00 +0000 UTC LastTransitionTime:2022-04-22 03:31:33 +0000 UTC Reason:ContainersNotReady Message:containers with unready status: [volume-tester]} {Type:ContainersReady Status:False LastProbeTime:0001-01-01 00:00:00 +0000 UTC LastTransitionTime:2022-04-22 03:31:33 +0000 UTC Reason:ContainersNotReady Message:containers with unready status: [volume-tester]} {Type:PodScheduled Status:True LastProbeTime:0001-01-01 00:00:00 +0000 UTC LastTransitionTime:2022-04-22 03:31:33 +0000 UTC Reason: Message:}] Message: Reason: NominatedNodeName: HostIP:10.1.0.4 PodIP:192.168.59.196 PodIPs:[{IP:192.168.59.196}] StartTime:2022-04-22 03:31:33 +0000 UTC InitContainerStatuses:[] ContainerStatuses:[{Name:volume-tester State:{Waiting:&ContainerStateWaiting{Reason:RunContainerError,Message:context deadline exceeded,} Running:nil Terminated:nil} LastTerminationState:{Waiting:nil Running:nil Terminated:&ContainerStateTerminated{ExitCode:0,Signal:0,Reason:,Message:,StartedAt:0001-01-01 00:00:00 +0000 UTC,FinishedAt:0001-01-01 00:00:00 +0000 UTC,ContainerID:containerd://73e3dd0dc504f25ba9911f2c22f101a6b1cb836a45cff6c7149899ccf75911ad,}} Ready:false RestartCount:0 Image:mcr.microsoft.com/windows/servercore:ltsc2022 ImageID:mcr.microsoft.com/windows/servercore@sha256:378d85bd8e7388a777d25009f8523d1e95a5f544f131eaada83171045d5b2c1e ContainerID:containerd://73e3dd0dc504f25ba9911f2c22f101a6b1cb836a45cff6c7149899ccf75911ad Started:0xc000895e08}] QOSClass:BestEffort EphemeralContainerStatuses:[]}", } pod "azurefile-volume-tester-h42mh" failed with status: {Phase:Failed Conditions:[{Type:Initialized Status:True LastProbeTime:0001-01-01 00:00:00 +0000 UTC LastTransitionTime:2022-04-22 03:31:33 +0000 UTC Reason: Message:} {Type:Ready Status:False LastProbeTime:0001-01-01 00:00:00 +0000 UTC LastTransitionTime:2022-04-22 03:31:33 +0000 UTC Reason:ContainersNotReady Message:containers with unready status: [volume-tester]} {Type:ContainersReady Status:False LastProbeTime:0001-01-01 00:00:00 +0000 UTC LastTransitionTime:2022-04-22 03:31:33 +0000 UTC Reason:ContainersNotReady Message:containers with unready status: [volume-tester]} {Type:PodScheduled Status:True LastProbeTime:0001-01-01 00:00:00 +0000 UTC LastTransitionTime:2022-04-22 03:31:33 +0000 UTC Reason: Message:}] Message: Reason: NominatedNodeName: HostIP:10.1.0.4 PodIP:192.168.59.196 PodIPs:[{IP:192.168.59.196}] StartTime:2022-04-22 03:31:33 +0000 UTC InitContainerStatuses:[] ContainerStatuses:[{Name:volume-tester State:{Waiting:&ContainerStateWaiting{Reason:RunContainerError,Message:context deadline exceeded,} Running:nil Terminated:nil} LastTerminationState:{Waiting:nil Running:nil Terminated:&ContainerStateTerminated{ExitCode:0,Signal:0,Reason:,Message:,StartedAt:0001-01-01 00:00:00 +0000 UTC,FinishedAt:0001-01-01 00:00:00 +0000 UTC,ContainerID:containerd://73e3dd0dc504f25ba9911f2c22f101a6b1cb836a45cff6c7149899ccf75911ad,}} Ready:false RestartCount:0 Image:mcr.microsoft.com/windows/servercore:ltsc2022 ImageID:mcr.microsoft.com/windows/servercore@sha256:378d85bd8e7388a777d25009f8523d1e95a5f544f131eaada83171045d5b2c1e ContainerID:containerd://73e3dd0dc504f25ba9911f2c22f101a6b1cb836a45cff6c7149899ccf75911ad Started:0xc000895e08}] QOSClass:BestEffort EphemeralContainerStatuses:[]} occurred /home/prow/go/src/sigs.k8s.io/azurefile-csi-driver/test/e2e/testsuites/testsuites.go:691from junit_01.xml
�[1mSTEP�[0m: Creating a kubernetes client Apr 22 03:29:55.361: INFO: >>> kubeConfig: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig �[1mSTEP�[0m: Building a namespace api object, basename azurefile �[1mSTEP�[0m: Waiting for a default service account to be provisioned in namespace �[1mSTEP�[0m: Waiting for kube-root-ca.crt to be provisioned in namespace Apr 22 03:29:55.959: INFO: >>> kubeConfig: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig �[1mSTEP�[0m: setting up the StorageClass �[1mSTEP�[0m: creating a StorageClass �[1mSTEP�[0m: setting up the PVC and PV �[1mSTEP�[0m: creating a PVC �[1mSTEP�[0m: waiting for PVC to be in phase "Bound" Apr 22 03:29:56.035: INFO: Waiting up to timeout=5m0s for PersistentVolumeClaims [pvc-gj7qd] to have phase Bound Apr 22 03:29:56.073: INFO: PersistentVolumeClaim pvc-gj7qd found but phase is Pending instead of Bound. Apr 22 03:29:58.109: INFO: PersistentVolumeClaim pvc-gj7qd found but phase is Pending instead of Bound. Apr 22 03:30:00.146: INFO: PersistentVolumeClaim pvc-gj7qd found but phase is Pending instead of Bound. Apr 22 03:30:02.186: INFO: PersistentVolumeClaim pvc-gj7qd found but phase is Pending instead of Bound. Apr 22 03:30:04.223: INFO: PersistentVolumeClaim pvc-gj7qd found but phase is Pending instead of Bound. Apr 22 03:30:06.259: INFO: PersistentVolumeClaim pvc-gj7qd found but phase is Pending instead of Bound. Apr 22 03:30:08.296: INFO: PersistentVolumeClaim pvc-gj7qd found but phase is Pending instead of Bound. Apr 22 03:30:10.332: INFO: PersistentVolumeClaim pvc-gj7qd found but phase is Pending instead of Bound. Apr 22 03:30:12.368: INFO: PersistentVolumeClaim pvc-gj7qd found but phase is Pending instead of Bound. Apr 22 03:30:14.406: INFO: PersistentVolumeClaim pvc-gj7qd found but phase is Pending instead of Bound. Apr 22 03:30:16.444: INFO: PersistentVolumeClaim pvc-gj7qd found but phase is Pending instead of Bound. Apr 22 03:30:18.481: INFO: PersistentVolumeClaim pvc-gj7qd found but phase is Pending instead of Bound. Apr 22 03:30:20.518: INFO: PersistentVolumeClaim pvc-gj7qd found but phase is Pending instead of Bound. Apr 22 03:30:22.555: INFO: PersistentVolumeClaim pvc-gj7qd found but phase is Pending instead of Bound. Apr 22 03:30:24.593: INFO: PersistentVolumeClaim pvc-gj7qd found but phase is Pending instead of Bound. Apr 22 03:30:26.629: INFO: PersistentVolumeClaim pvc-gj7qd found but phase is Pending instead of Bound. Apr 22 03:30:28.666: INFO: PersistentVolumeClaim pvc-gj7qd found but phase is Pending instead of Bound. Apr 22 03:30:30.702: INFO: PersistentVolumeClaim pvc-gj7qd found but phase is Pending instead of Bound. Apr 22 03:30:32.739: INFO: PersistentVolumeClaim pvc-gj7qd found but phase is Pending instead of Bound. Apr 22 03:30:34.776: INFO: PersistentVolumeClaim pvc-gj7qd found but phase is Pending instead of Bound. Apr 22 03:30:36.814: INFO: PersistentVolumeClaim pvc-gj7qd found but phase is Pending instead of Bound. Apr 22 03:30:38.851: INFO: PersistentVolumeClaim pvc-gj7qd found but phase is Pending instead of Bound. Apr 22 03:30:40.888: INFO: PersistentVolumeClaim pvc-gj7qd found but phase is Pending instead of Bound. Apr 22 03:30:42.924: INFO: PersistentVolumeClaim pvc-gj7qd found but phase is Pending instead of Bound. Apr 22 03:30:44.962: INFO: PersistentVolumeClaim pvc-gj7qd found but phase is Pending instead of Bound. Apr 22 03:30:46.998: INFO: PersistentVolumeClaim pvc-gj7qd found but phase is Pending instead of Bound. Apr 22 03:30:49.037: INFO: PersistentVolumeClaim pvc-gj7qd found but phase is Pending instead of Bound. Apr 22 03:30:51.073: INFO: PersistentVolumeClaim pvc-gj7qd found but phase is Pending instead of Bound. Apr 22 03:30:53.109: INFO: PersistentVolumeClaim pvc-gj7qd found but phase is Pending instead of Bound. Apr 22 03:30:55.147: INFO: PersistentVolumeClaim pvc-gj7qd found but phase is Pending instead of Bound. Apr 22 03:30:57.183: INFO: PersistentVolumeClaim pvc-gj7qd found but phase is Pending instead of Bound. Apr 22 03:30:59.227: INFO: PersistentVolumeClaim pvc-gj7qd found but phase is Pending instead of Bound. Apr 22 03:31:01.264: INFO: PersistentVolumeClaim pvc-gj7qd found but phase is Pending instead of Bound. Apr 22 03:31:03.300: INFO: PersistentVolumeClaim pvc-gj7qd found but phase is Pending instead of Bound. Apr 22 03:31:05.336: INFO: PersistentVolumeClaim pvc-gj7qd found but phase is Pending instead of Bound. Apr 22 03:31:07.373: INFO: PersistentVolumeClaim pvc-gj7qd found but phase is Pending instead of Bound. Apr 22 03:31:09.416: INFO: PersistentVolumeClaim pvc-gj7qd found but phase is Pending instead of Bound. Apr 22 03:31:11.452: INFO: PersistentVolumeClaim pvc-gj7qd found but phase is Pending instead of Bound. Apr 22 03:31:13.489: INFO: PersistentVolumeClaim pvc-gj7qd found but phase is Pending instead of Bound. Apr 22 03:31:15.526: INFO: PersistentVolumeClaim pvc-gj7qd found but phase is Pending instead of Bound. Apr 22 03:31:17.563: INFO: PersistentVolumeClaim pvc-gj7qd found but phase is Pending instead of Bound. Apr 22 03:31:19.602: INFO: PersistentVolumeClaim pvc-gj7qd found but phase is Pending instead of Bound. Apr 22 03:31:21.639: INFO: PersistentVolumeClaim pvc-gj7qd found but phase is Pending instead of Bound. Apr 22 03:31:23.676: INFO: PersistentVolumeClaim pvc-gj7qd found but phase is Pending instead of Bound. Apr 22 03:31:25.712: INFO: PersistentVolumeClaim pvc-gj7qd found but phase is Pending instead of Bound. Apr 22 03:31:27.749: INFO: PersistentVolumeClaim pvc-gj7qd found but phase is Pending instead of Bound. Apr 22 03:31:29.786: INFO: PersistentVolumeClaim pvc-gj7qd found but phase is Pending instead of Bound. Apr 22 03:31:31.823: INFO: PersistentVolumeClaim pvc-gj7qd found but phase is Pending instead of Bound. Apr 22 03:31:33.859: INFO: PersistentVolumeClaim pvc-gj7qd found and phase=Bound (1m37.824504668s) �[1mSTEP�[0m: checking the PVC �[1mSTEP�[0m: validating provisioned PV �[1mSTEP�[0m: checking the PV �[1mSTEP�[0m: deploying the pod �[1mSTEP�[0m: checking that the pods command exits with no error Apr 22 03:31:33.970: INFO: Waiting up to 15m0s for pod "azurefile-volume-tester-h42mh" in namespace "azurefile-2540" to be "Succeeded or Failed" Apr 22 03:31:34.005: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 34.856784ms Apr 22 03:31:36.042: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 2.071901875s Apr 22 03:31:38.079: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 4.108937993s Apr 22 03:31:40.117: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 6.146767919s Apr 22 03:31:42.155: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 8.185189387s Apr 22 03:31:44.194: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 10.224012947s Apr 22 03:31:46.233: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 12.263558728s Apr 22 03:31:48.271: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 14.301375999s Apr 22 03:31:50.310: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 16.340411926s Apr 22 03:31:52.350: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 18.380395204s Apr 22 03:31:54.390: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 20.419942546s Apr 22 03:31:56.429: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 22.458739065s Apr 22 03:31:58.470: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 24.499859589s Apr 22 03:32:00.509: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 26.539105839s Apr 22 03:32:02.549: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 28.578924248s Apr 22 03:32:04.587: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 30.617013317s Apr 22 03:32:06.625: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 32.655361836s Apr 22 03:32:08.665: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 34.694721097s Apr 22 03:32:10.703: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 36.733535663s Apr 22 03:32:12.742: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 38.772264341s Apr 22 03:32:14.782: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 40.812257125s Apr 22 03:32:16.820: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 42.85039988s Apr 22 03:32:18.859: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 44.889269511s Apr 22 03:32:20.898: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 46.928153046s Apr 22 03:32:22.938: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 48.968039737s Apr 22 03:32:24.977: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 51.007132208s Apr 22 03:32:27.016: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 53.04643686s Apr 22 03:32:29.057: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 55.087122662s Apr 22 03:32:31.097: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 57.126733959s Apr 22 03:32:33.137: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 59.166784404s Apr 22 03:32:35.176: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 1m1.205774739s Apr 22 03:32:37.214: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 1m3.244207146s Apr 22 03:32:39.252: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 1m5.282541105s Apr 22 03:32:41.291: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 1m7.32100105s Apr 22 03:32:43.331: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 1m9.360727633s Apr 22 03:32:45.369: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 1m11.399425902s Apr 22 03:32:47.408: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 1m13.438097176s Apr 22 03:32:49.451: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 1m15.481073091s Apr 22 03:32:51.490: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 1m17.519685981s Apr 22 03:32:53.529: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 1m19.559135892s Apr 22 03:32:55.573: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 1m21.602772405s Apr 22 03:32:57.611: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 1m23.641064426s Apr 22 03:32:59.649: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 1m25.679050115s Apr 22 03:33:01.688: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 1m27.717859161s Apr 22 03:33:03.728: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 1m29.758230773s Apr 22 03:33:05.769: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 1m31.799238402s Apr 22 03:33:07.807: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 1m33.837478676s Apr 22 03:33:09.847: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 1m35.876700161s Apr 22 03:33:11.886: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 1m37.9163047s Apr 22 03:33:13.925: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 1m39.954634454s Apr 22 03:33:15.964: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 1m41.994252018s Apr 22 03:33:18.004: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 1m44.033718346s Apr 22 03:33:20.043: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 1m46.072573515s Apr 22 03:33:22.081: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 1m48.111411919s Apr 22 03:33:24.119: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 1m50.149458322s Apr 22 03:33:26.159: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 1m52.18880189s Apr 22 03:33:28.197: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 1m54.226941643s Apr 22 03:33:30.236: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 1m56.266385221s Apr 22 03:33:32.276: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 1m58.305897628s Apr 22 03:33:34.324: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 2m0.353606893s Apr 22 03:33:36.364: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 2m2.394536149s Apr 22 03:33:38.406: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 2m4.435587748s Apr 22 03:33:40.445: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 2m6.475522213s Apr 22 03:33:42.486: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 2m8.515670428s Apr 22 03:33:44.524: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 2m10.554218865s Apr 22 03:33:46.564: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 2m12.59386876s Apr 22 03:33:48.602: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 2m14.632421433s Apr 22 03:33:50.642: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 2m16.671582143s Apr 22 03:33:52.683: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 2m18.712628593s Apr 22 03:33:54.721: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 2m20.75079529s Apr 22 03:33:56.759: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 2m22.789418627s Apr 22 03:33:58.799: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 2m24.829084835s Apr 22 03:34:00.839: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 2m26.868995362s Apr 22 03:34:02.878: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 2m28.908020985s Apr 22 03:34:04.918: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 2m30.948414939s Apr 22 03:34:06.958: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 2m32.988269229s Apr 22 03:34:08.998: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 2m35.02796877s Apr 22 03:34:11.036: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 2m37.065967066s Apr 22 03:34:13.077: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 2m39.106827407s Apr 22 03:34:15.116: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 2m41.145851161s Apr 22 03:34:17.155: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 2m43.184826071s Apr 22 03:34:19.194: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 2m45.223798149s Apr 22 03:34:21.234: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 2m47.264026423s Apr 22 03:34:23.274: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 2m49.303926353s Apr 22 03:34:25.312: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 2m51.342168291s Apr 22 03:34:27.350: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 2m53.380170816s Apr 22 03:34:29.388: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 2m55.418522021s Apr 22 03:34:31.430: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 2m57.459754315s Apr 22 03:34:33.469: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 2m59.4989644s Apr 22 03:34:35.508: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 3m1.538288646s Apr 22 03:34:37.547: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 3m3.577080084s Apr 22 03:34:39.586: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 3m5.616286162s Apr 22 03:34:41.628: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 3m7.657789195s Apr 22 03:34:43.668: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 3m9.69764949s Apr 22 03:34:45.706: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 3m11.736317728s Apr 22 03:34:47.745: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 3m13.775278394s Apr 22 03:34:49.785: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 3m15.814898984s Apr 22 03:34:51.825: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 3m17.85458058s Apr 22 03:34:53.863: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 3m19.892979548s Apr 22 03:34:55.903: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 3m21.932958774s Apr 22 03:34:57.943: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 3m23.97297863s Apr 22 03:34:59.982: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 3m26.012072531s Apr 22 03:35:02.021: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 3m28.051139272s Apr 22 03:35:04.064: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 3m30.09435869s Apr 22 03:35:06.103: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 3m32.133263142s Apr 22 03:35:08.143: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 3m34.173455637s Apr 22 03:35:10.183: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 3m36.212994854s Apr 22 03:35:12.221: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 3m38.251538819s Apr 22 03:35:14.261: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 3m40.291033102s Apr 22 03:35:16.300: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 3m42.330066404s Apr 22 03:35:18.338: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 3m44.368387798s Apr 22 03:35:20.378: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 3m46.407914272s Apr 22 03:35:22.418: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 3m48.447655947s Apr 22 03:35:24.456: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 3m50.485873795s Apr 22 03:35:26.496: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 3m52.525999664s Apr 22 03:35:28.538: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 3m54.567864105s Apr 22 03:35:30.577: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 3m56.606602585s Apr 22 03:35:32.615: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 3m58.645117187s Apr 22 03:35:34.654: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 4m0.684494898s Apr 22 03:35:36.692: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 4m2.722264216s Apr 22 03:35:38.732: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 4m4.762424199s Apr 22 03:35:40.771: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 4m6.801540191s Apr 22 03:35:42.814: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 4m8.843606355s Apr 22 03:35:44.852: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 4m10.882202485s Apr 22 03:35:46.893: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 4m12.922718332s Apr 22 03:35:48.932: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 4m14.962474084s Apr 22 03:35:50.973: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 4m17.002642736s Apr 22 03:35:53.011: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 4m19.041052783s Apr 22 03:35:55.051: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 4m21.080736616s Apr 22 03:35:57.089: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 4m23.119306574s Apr 22 03:35:59.129: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 4m25.159501016s Apr 22 03:36:01.168: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 4m27.197603684s Apr 22 03:36:03.208: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 4m29.237795228s Apr 22 03:36:05.246: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 4m31.275820979s Apr 22 03:36:07.285: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 4m33.314682268s Apr 22 03:36:09.324: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 4m35.35447384s Apr 22 03:36:11.364: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 4m37.394174356s Apr 22 03:36:13.402: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 4m39.432046532s Apr 22 03:36:15.442: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 4m41.472048294s Apr 22 03:36:17.483: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 4m43.513345626s Apr 22 03:36:19.522: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 4m45.552206801s Apr 22 03:36:21.561: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 4m47.591176108s Apr 22 03:36:23.600: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 4m49.629863464s Apr 22 03:36:25.638: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 4m51.668446501s Apr 22 03:36:27.678: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 4m53.708412462s Apr 22 03:36:29.720: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 4m55.750308616s Apr 22 03:36:31.759: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 4m57.789246159s Apr 22 03:36:33.797: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 4m59.82735533s Apr 22 03:36:35.836: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 5m1.86650711s Apr 22 03:36:37.875: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 5m3.904775704s Apr 22 03:36:39.914: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 5m5.9439657s Apr 22 03:36:41.952: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 5m7.982507386s Apr 22 03:36:43.994: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 5m10.024382024s Apr 22 03:36:46.033: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 5m12.063014765s Apr 22 03:36:48.071: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 5m14.101411123s Apr 22 03:36:50.111: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 5m16.141421179s Apr 22 03:36:52.151: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 5m18.180673127s Apr 22 03:36:54.189: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 5m20.219291307s Apr 22 03:36:56.227: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 5m22.257236102s Apr 22 03:36:58.266: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 5m24.295762406s Apr 22 03:37:00.304: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 5m26.334330519s Apr 22 03:37:02.343: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 5m28.373074813s Apr 22 03:37:04.383: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 5m30.412629327s Apr 22 03:37:06.421: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 5m32.451279275s Apr 22 03:37:08.461: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 5m34.49075529s Apr 22 03:37:10.500: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 5m36.529731676s Apr 22 03:37:12.538: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 5m38.568446534s Apr 22 03:37:14.578: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 5m40.607713757s Apr 22 03:37:16.617: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 5m42.647527425s Apr 22 03:37:18.657: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 5m44.686752516s Apr 22 03:37:20.696: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 5m46.726329508s Apr 22 03:37:22.735: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 5m48.765193708s Apr 22 03:37:24.774: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 5m50.804338552s Apr 22 03:37:26.813: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 5m52.843286213s Apr 22 03:37:28.854: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 5m54.88443284s Apr 22 03:37:30.893: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 5m56.923151649s Apr 22 03:37:32.933: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 5m58.963459925s Apr 22 03:37:34.972: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 6m1.002276424s Apr 22 03:37:37.011: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 6m3.04155129s Apr 22 03:37:39.053: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 6m5.083508466s Apr 22 03:37:41.093: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 6m7.123440519s Apr 22 03:37:43.132: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 6m9.161971439s Apr 22 03:37:45.170: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 6m11.200214174s Apr 22 03:37:47.210: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 6m13.239957204s Apr 22 03:37:49.249: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 6m15.279019362s Apr 22 03:37:51.288: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 6m17.318154269s Apr 22 03:37:53.328: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 6m19.357831382s Apr 22 03:37:55.366: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 6m21.395912615s Apr 22 03:37:57.405: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 6m23.435194925s Apr 22 03:37:59.444: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 6m25.474542768s Apr 22 03:38:01.486: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 6m27.515818365s Apr 22 03:38:03.525: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 6m29.554591431s Apr 22 03:38:05.564: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 6m31.594021327s Apr 22 03:38:07.603: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 6m33.632636971s Apr 22 03:38:09.644: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 6m35.673812267s Apr 22 03:38:11.688: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 6m37.717965709s Apr 22 03:38:13.727: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 6m39.757251801s Apr 22 03:38:15.766: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 6m41.796060547s Apr 22 03:38:17.820: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 6m43.849873692s Apr 22 03:38:19.865: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 6m45.895260906s Apr 22 03:38:21.905: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 6m47.93468891s Apr 22 03:38:23.945: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 6m49.974729345s Apr 22 03:38:25.985: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 6m52.015060122s Apr 22 03:38:28.024: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 6m54.054065508s Apr 22 03:38:30.062: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 6m56.092524575s Apr 22 03:38:32.101: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 6m58.131304663s Apr 22 03:38:34.140: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 7m0.170484603s Apr 22 03:38:36.180: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 7m2.2098361s Apr 22 03:38:38.220: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 7m4.250314404s Apr 22 03:38:40.260: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 7m6.290363755s Apr 22 03:38:42.300: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 7m8.330062721s Apr 22 03:38:44.339: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 7m10.369557235s Apr 22 03:38:46.378: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 7m12.408194334s Apr 22 03:38:48.418: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 7m14.447844156s Apr 22 03:38:50.457: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 7m16.487161891s Apr 22 03:38:52.496: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 7m18.526030323s Apr 22 03:38:54.535: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 7m20.56532994s Apr 22 03:38:56.575: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Pending", Reason="", readiness=false. Elapsed: 7m22.604615609s Apr 22 03:38:58.613: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Failed", Reason="", readiness=false. Elapsed: 7m24.643540145s �[1mSTEP�[0m: hit error(pod "azurefile-volume-tester-h42mh" failed with status: {Phase:Failed Conditions:[{Type:Initialized Status:True LastProbeTime:0001-01-01 00:00:00 +0000 UTC LastTransitionTime:2022-04-22 03:31:33 +0000 UTC Reason: Message:} {Type:Ready Status:False LastProbeTime:0001-01-01 00:00:00 +0000 UTC LastTransitionTime:2022-04-22 03:31:33 +0000 UTC Reason:ContainersNotReady Message:containers with unready status: [volume-tester]} {Type:ContainersReady Status:False LastProbeTime:0001-01-01 00:00:00 +0000 UTC LastTransitionTime:2022-04-22 03:31:33 +0000 UTC Reason:ContainersNotReady Message:containers with unready status: [volume-tester]} {Type:PodScheduled Status:True LastProbeTime:0001-01-01 00:00:00 +0000 UTC LastTransitionTime:2022-04-22 03:31:33 +0000 UTC Reason: Message:}] Message: Reason: NominatedNodeName: HostIP:10.1.0.4 PodIP:192.168.59.196 PodIPs:[{IP:192.168.59.196}] StartTime:2022-04-22 03:31:33 +0000 UTC InitContainerStatuses:[] ContainerStatuses:[{Name:volume-tester State:{Waiting:&ContainerStateWaiting{Reason:RunContainerError,Message:context deadline exceeded,} Running:nil Terminated:nil} LastTerminationState:{Waiting:nil Running:nil Terminated:&ContainerStateTerminated{ExitCode:0,Signal:0,Reason:,Message:,StartedAt:0001-01-01 00:00:00 +0000 UTC,FinishedAt:0001-01-01 00:00:00 +0000 UTC,ContainerID:containerd://73e3dd0dc504f25ba9911f2c22f101a6b1cb836a45cff6c7149899ccf75911ad,}} Ready:false RestartCount:0 Image:mcr.microsoft.com/windows/servercore:ltsc2022 ImageID:mcr.microsoft.com/windows/servercore@sha256:378d85bd8e7388a777d25009f8523d1e95a5f544f131eaada83171045d5b2c1e ContainerID:containerd://73e3dd0dc504f25ba9911f2c22f101a6b1cb836a45cff6c7149899ccf75911ad Started:0xc0004db9f8}] QOSClass:BestEffort EphemeralContainerStatuses:[]}) in first run, give another try Apr 22 03:38:58.614: INFO: Waiting up to 15m0s for pod "azurefile-volume-tester-h42mh" in namespace "azurefile-2540" to be "Succeeded or Failed" Apr 22 03:38:58.651: INFO: Pod "azurefile-volume-tester-h42mh": Phase="Failed", Reason="", readiness=false. Elapsed: 37.607055ms Apr 22 03:38:58.652: INFO: deleting Pod "azurefile-2540"/"azurefile-volume-tester-h42mh" Apr 22 03:38:58.719: INFO: Pod azurefile-volume-tester-h42mh has the following logs: �[1mSTEP�[0m: Deleting pod azurefile-volume-tester-h42mh in namespace azurefile-2540 Apr 22 03:38:58.798: INFO: deleting PVC "azurefile-2540"/"pvc-gj7qd" Apr 22 03:38:58.798: INFO: Deleting PersistentVolumeClaim "pvc-gj7qd" �[1mSTEP�[0m: waiting for claim's PV "pvc-4d01a63b-71a5-4744-bff9-cd33d4785bf8" to be deleted Apr 22 03:38:58.917: INFO: Waiting up to 10m0s for PersistentVolume pvc-4d01a63b-71a5-4744-bff9-cd33d4785bf8 to get deleted Apr 22 03:38:58.952: INFO: PersistentVolume pvc-4d01a63b-71a5-4744-bff9-cd33d4785bf8 found and phase=Released (35.220046ms) Apr 22 03:39:03.990: INFO: PersistentVolume pvc-4d01a63b-71a5-4744-bff9-cd33d4785bf8 was removed Apr 22 03:39:03.990: INFO: Waiting up to 5m0s for PersistentVolumeClaim azurefile-2540 to be removed Apr 22 03:39:04.027: INFO: Claim "azurefile-2540" in namespace "pvc-gj7qd" doesn't exist in the system Apr 22 03:39:04.027: INFO: deleting StorageClass azurefile-2540-file.csi.azure.com-dynamic-sc-dvpmn �[1mSTEP�[0m: Collecting events from namespace "azurefile-2540". �[1mSTEP�[0m: Found 11 events. Apr 22 03:39:04.104: INFO: At 2022-04-22 03:29:56 +0000 UTC - event for pvc-gj7qd: {persistentvolume-controller } ExternalProvisioning: waiting for a volume to be created, either by external provisioner "file.csi.azure.com" or manually created by system administrator Apr 22 03:39:04.104: INFO: At 2022-04-22 03:29:56 +0000 UTC - event for pvc-gj7qd: {file.csi.azure.com_capz-8a45pa-control-plane-cqlqm_5a679a69-5840-4af9-acb9-2bb06de8c5c8 } Provisioning: External provisioner is provisioning volume for claim "azurefile-2540/pvc-gj7qd" Apr 22 03:39:04.105: INFO: At 2022-04-22 03:31:32 +0000 UTC - event for pvc-gj7qd: {file.csi.azure.com_capz-8a45pa-control-plane-cqlqm_5a679a69-5840-4af9-acb9-2bb06de8c5c8 } ProvisioningSucceeded: Successfully provisioned volume pvc-4d01a63b-71a5-4744-bff9-cd33d4785bf8 Apr 22 03:39:04.105: INFO: At 2022-04-22 03:31:33 +0000 UTC - event for azurefile-volume-tester-h42mh: {default-scheduler } Scheduled: Successfully assigned azurefile-2540/azurefile-volume-tester-h42mh to capz-8a45-pzhtj Apr 22 03:39:04.105: INFO: At 2022-04-22 03:31:45 +0000 UTC - event for azurefile-volume-tester-h42mh: {kubelet capz-8a45-pzhtj} Pulling: Pulling image "mcr.microsoft.com/windows/servercore:ltsc2022" Apr 22 03:39:04.105: INFO: At 2022-04-22 03:36:56 +0000 UTC - event for azurefile-volume-tester-h42mh: {kubelet capz-8a45-pzhtj} Pulled: Successfully pulled image "mcr.microsoft.com/windows/servercore:ltsc2022" in 5m11.0358798s Apr 22 03:39:04.105: INFO: At 2022-04-22 03:36:56 +0000 UTC - event for azurefile-volume-tester-h42mh: {kubelet capz-8a45-pzhtj} Created: Created container volume-tester Apr 22 03:39:04.105: INFO: At 2022-04-22 03:38:56 +0000 UTC - event for azurefile-volume-tester-h42mh: {kubelet capz-8a45-pzhtj} Failed: Error: context deadline exceeded Apr 22 03:39:04.105: INFO: At 2022-04-22 03:38:57 +0000 UTC - event for azurefile-volume-tester-h42mh: {kubelet capz-8a45-pzhtj} Pulled: Container image "mcr.microsoft.com/windows/servercore:ltsc2022" already present on machine Apr 22 03:39:04.105: INFO: At 2022-04-22 03:39:01 +0000 UTC - event for azurefile-volume-tester-h42mh: {kubelet capz-8a45-pzhtj} Started: Started container volume-tester Apr 22 03:39:04.105: INFO: At 2022-04-22 03:39:02 +0000 UTC - event for azurefile-volume-tester-h42mh: {kubelet capz-8a45-pzhtj} Killing: Stopping container volume-tester Apr 22 03:39:04.139: INFO: POD NODE PHASE GRACE CONDITIONS Apr 22 03:39:04.139: INFO: Apr 22 03:39:04.189: INFO: Logging node info for node capz-8a45-b775t Apr 22 03:39:04.226: INFO: Node Info: &Node{ObjectMeta:{capz-8a45-b775t e84b96d4-fdad-4ef5-868d-c1945c856ad3 3531 0 2022-04-22 03:11:35 +0000 UTC <nil> <nil> map[beta.kubernetes.io/arch:amd64 beta.kubernetes.io/instance-type:Standard_D4s_v3 beta.kubernetes.io/os:windows failure-domain.beta.kubernetes.io/region:eastus2 failure-domain.beta.kubernetes.io/zone:0 kubernetes.io/arch:amd64 kubernetes.io/hostname:capz-8a45-b775t kubernetes.io/os:windows node.kubernetes.io/instance-type:Standard_D4s_v3 node.kubernetes.io/windows-build:10.0.20348 topology.kubernetes.io/region:eastus2 topology.kubernetes.io/zone:0] map[cluster.x-k8s.io/cluster-name:capz-8a45pa cluster.x-k8s.io/cluster-namespace:default cluster.x-k8s.io/machine:capz-8a45pa-md-win-b5fffb599-htlnk cluster.x-k8s.io/owner-kind:MachineSet cluster.x-k8s.io/owner-name:capz-8a45pa-md-win-b5fffb599 csi.volume.kubernetes.io/nodeid:{"file.csi.azure.com":"capz-8a45-b775t"} kubeadm.alpha.kubernetes.io/cri-socket:npipe:////./pipe/containerd-containerd node.alpha.kubernetes.io/ttl:0 projectcalico.org/IPv4Address:10.1.0.5/16 projectcalico.org/IPv4VXLANTunnelAddr:192.168.216.193 projectcalico.org/VXLANTunnelMACAddr:00:15:5d:2f:65:42 volumes.kubernetes.io/controller-managed-attach-detach:true] [] [] [{Go-http-client Update v1 2022-04-22 03:11:35 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{".":{},"f:kubeadm.alpha.kubernetes.io/cri-socket":{},"f:volumes.kubernetes.io/controller-managed-attach-detach":{}},"f:labels":{".":{},"f:beta.kubernetes.io/arch":{},"f:beta.kubernetes.io/instance-type":{},"f:beta.kubernetes.io/os":{},"f:failure-domain.beta.kubernetes.io/region":{},"f:failure-domain.beta.kubernetes.io/zone":{},"f:kubernetes.io/arch":{},"f:kubernetes.io/hostname":{},"f:kubernetes.io/os":{},"f:node.kubernetes.io/instance-type":{},"f:node.kubernetes.io/windows-build":{},"f:topology.kubernetes.io/region":{},"f:topology.kubernetes.io/zone":{}}},"f:spec":{"f:providerID":{}}} } {kube-controller-manager Update v1 2022-04-22 03:11:39 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{"f:node.alpha.kubernetes.io/ttl":{}}}} } {manager Update v1 2022-04-22 03:12:57 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{"f:cluster.x-k8s.io/cluster-name":{},"f:cluster.x-k8s.io/cluster-namespace":{},"f:cluster.x-k8s.io/machine":{},"f:cluster.x-k8s.io/owner-kind":{},"f:cluster.x-k8s.io/owner-name":{}}}} } {calico-node.exe Update v1 2022-04-22 03:13:19 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{"f:projectcalico.org/IPv4Address":{},"f:projectcalico.org/IPv4VXLANTunnelAddr":{},"f:projectcalico.org/VXLANTunnelMACAddr":{}}}} status} {Go-http-client Update v1 2022-04-22 03:29:26 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{"f:csi.volume.kubernetes.io/nodeid":{}}},"f:status":{"f:conditions":{"k:{\"type\":\"DiskPressure\"}":{"f:lastHeartbeatTime":{}},"k:{\"type\":\"MemoryPressure\"}":{"f:lastHeartbeatTime":{}},"k:{\"type\":\"PIDPressure\"}":{"f:lastHeartbeatTime":{}},"k:{\"type\":\"Ready\"}":{"f:lastHeartbeatTime":{},"f:lastTransitionTime":{},"f:message":{},"f:reason":{},"f:status":{}}},"f:images":{}}} status}]},Spec:NodeSpec{PodCIDR:,DoNotUseExternalID:,ProviderID:azure:///subscriptions/===REDACTED===/resourceGroups/capz-8a45pa/providers/Microsoft.Compute/virtualMachines/capz-8a45-b775t,Unschedulable:false,Taints:[]Taint{},ConfigSource:nil,PodCIDRs:[],},Status:NodeStatus{Capacity:ResourceList{attachable-volumes-azure-disk: {{8 0} {<nil>} 8 DecimalSI},cpu: {{4 0} {<nil>} 4 DecimalSI},ephemeral-storage: {{136912564224 0} {<nil>} 133703676Ki BinarySI},memory: {{17179398144 0} {<nil>} 16776756Ki BinarySI},pods: {{110 0} {<nil>} 110 DecimalSI},},Allocatable:ResourceList{attachable-volumes-azure-disk: {{8 0} {<nil>} 8 DecimalSI},cpu: {{4 0} {<nil>} 4 DecimalSI},ephemeral-storage: {{123221307598 0} {<nil>} 123221307598 DecimalSI},memory: {{17074540544 0} {<nil>} 16674356Ki BinarySI},pods: {{110 0} {<nil>} 110 DecimalSI},},Phase:,Conditions:[]NodeCondition{NodeCondition{Type:MemoryPressure,Status:False,LastHeartbeatTime:2022-04-22 03:34:45 +0000 UTC,LastTransitionTime:2022-04-22 03:11:35 +0000 UTC,Reason:KubeletHasSufficientMemory,Message:kubelet has sufficient memory available,},NodeCondition{Type:DiskPressure,Status:False,LastHeartbeatTime:2022-04-22 03:34:45 +0000 UTC,LastTransitionTime:2022-04-22 03:11:35 +0000 UTC,Reason:KubeletHasNoDiskPressure,Message:kubelet has no disk pressure,},NodeCondition{Type:PIDPressure,Status:False,LastHeartbeatTime:2022-04-22 03:34:45 +0000 UTC,LastTransitionTime:2022-04-22 03:11:35 +0000 UTC,Reason:KubeletHasSufficientPID,Message:kubelet has sufficient PID available,},NodeCondition{Type:Ready,Status:True,LastHeartbeatTime:2022-04-22 03:34:45 +0000 UTC,LastTransitionTime:2022-04-22 03:12:36 +0000 UTC,Reason:KubeletReady,Message:kubelet is posting ready status,},},Addresses:[]NodeAddress{NodeAddress{Type:Hostname,Address:capz-8a45-b775t,},NodeAddress{Type:InternalIP,Address:10.1.0.5,},},DaemonEndpoints:NodeDaemonEndpoints{KubeletEndpoint:DaemonEndpoint{Port:10250,},},NodeInfo:NodeSystemInfo{MachineID:capz-8a45-b775t,SystemUUID:998B47FF-53B3-4E94-92EE-87251E992BE4,BootID:,KernelVersion:10.0.20348.405,OSImage:Windows Server 2022 Datacenter,ContainerRuntimeVersion:containerd://1.6.1,KubeletVersion:v1.23.5,KubeProxyVersion:v1.23.5,OperatingSystem:windows,Architecture:amd64,},Images:[]ContainerImage{ContainerImage{Names:[docker.io/sigwindowstools/calico-install@sha256:141afecd724eb757ee41593cc73f35fb19a2ce13cad73179cf3b1cef81a637d1 docker.io/sigwindowstools/calico-install:v3.22.1-hostprocess],SizeBytes:148096127,},ContainerImage{Names:[capzci.azurecr.io/azurefile-csi@sha256:47b232ada3d11bf92017193d2c00e90a3f3947ecc5ac4e8a7e368d5fb87907fd capzci.azurecr.io/azurefile-csi:e2e-07bfd478d868c055f36b20367e57ff932dd3f619],SizeBytes:130302144,},ContainerImage{Names:[docker.io/sigwindowstools/calico-node@sha256:b8e6e2f190e58d6b61b7f2a19b0e2e17a377e5b9d7b9528e9b7953d9f9ab59bb docker.io/sigwindowstools/calico-node:v3.22.1-hostprocess],SizeBytes:128793648,},ContainerImage{Names:[mcr.microsoft.com/oss/kubernetes-csi/csi-node-driver-registrar@sha256:dbec3a8166686b09b242176ab5b99e993da4126438bbce68147c3fd654f35662 mcr.microsoft.com/oss/kubernetes-csi/csi-node-driver-registrar:v2.4.0],SizeBytes:125554391,},ContainerImage{Names:[mcr.microsoft.com/oss/kubernetes-csi/livenessprobe@sha256:c96a6255c42766f6b8bb1a7cda02b0060ab1b20b2e2dafcc64ec09e7646745a6 mcr.microsoft.com/oss/kubernetes-csi/livenessprobe:v2.5.0],SizeBytes:124471446,},ContainerImage{Names:[ghcr.io/kubernetes-sigs/sig-windows/csi-proxy@sha256:96b4144986319a747ba599892454be2737aae6005d96b8e13ed481321ac3afba ghcr.io/kubernetes-sigs/sig-windows/csi-proxy:v1.0.2],SizeBytes:123925937,},ContainerImage{Names:[k8s.gcr.io/pause@sha256:3d380ca8864549e74af4b29c10f9cb0956236dfb01c40ca076fb6c37253234db k8s.gcr.io/pause:3.6],SizeBytes:119397646,},ContainerImage{Names:[docker.io/sigwindowstools/kube-proxy@sha256:0f8a44b795d1824358f24cc56f0024d18a39ae044656686596d8b7fa6d78e1fa docker.io/sigwindowstools/kube-proxy:v1.23.5-calico-hostprocess],SizeBytes:116337721,},},VolumesInUse:[],VolumesAttached:[]AttachedVolume{},Config:nil,},} Apr 22 03:39:04.227: INFO: Logging kubelet events for node capz-8a45-b775t Apr 22 03:39:04.265: INFO: Logging pods the kubelet thinks is on node capz-8a45-b775t Apr 22 03:39:04.387: INFO: calico-node-windows-5crjp started at 2022-04-22 03:11:35 +0000 UTC (1+2 container statuses recorded) Apr 22 03:39:04.387: INFO: Init container install-cni ready: true, restart count 0 Apr 22 03:39:04.387: INFO: Container calico-node-felix ready: true, restart count 1 Apr 22 03:39:04.387: INFO: Container calico-node-startup ready: true, restart count 0 Apr 22 03:39:04.387: INFO: csi-proxy-zxbhr started at 2022-04-22 03:12:36 +0000 UTC (0+1 container statuses recorded) Apr 22 03:39:04.387: INFO: Container csi-proxy ready: true, restart count 0 Apr 22 03:39:04.387: INFO: csi-azurefile-node-win-fv9jz started at 2022-04-22 03:28:13 +0000 UTC (0+3 container statuses recorded) Apr 22 03:39:04.387: INFO: Container azurefile ready: true, restart count 0 Apr 22 03:39:04.387: INFO: Container liveness-probe ready: true, restart count 0 Apr 22 03:39:04.387: INFO: Container node-driver-registrar ready: true, restart count 0 Apr 22 03:39:04.387: INFO: kube-proxy-windows-tq6rp started at 2022-04-22 03:11:35 +0000 UTC (0+1 container statuses recorded) Apr 22 03:39:04.387: INFO: Container kube-proxy ready: true, restart count 0 Apr 22 03:39:04.642: INFO: Latency metrics for node capz-8a45-b775t Apr 22 03:39:04.642: INFO: Logging node info for node capz-8a45-pzhtj Apr 22 03:39:04.679: INFO: Node Info: &Node{ObjectMeta:{capz-8a45-pzhtj ddafc1c7-e411-4bcb-9471-d504ffe910ad 3888 0 2022-04-22 03:11:25 +0000 UTC <nil> <nil> map[beta.kubernetes.io/arch:amd64 beta.kubernetes.io/instance-type:Standard_D4s_v3 beta.kubernetes.io/os:windows failure-domain.beta.kubernetes.io/region:eastus2 failure-domain.beta.kubernetes.io/zone:0 kubernetes.io/arch:amd64 kubernetes.io/hostname:capz-8a45-pzhtj kubernetes.io/os:windows node.kubernetes.io/instance-type:Standard_D4s_v3 node.kubernetes.io/windows-build:10.0.20348 topology.kubernetes.io/region:eastus2 topology.kubernetes.io/zone:0] map[cluster.x-k8s.io/cluster-name:capz-8a45pa cluster.x-k8s.io/cluster-namespace:default cluster.x-k8s.io/machine:capz-8a45pa-md-win-b5fffb599-gvkp4 cluster.x-k8s.io/owner-kind:MachineSet cluster.x-k8s.io/owner-name:capz-8a45pa-md-win-b5fffb599 csi.volume.kubernetes.io/nodeid:{"file.csi.azure.com":"capz-8a45-pzhtj"} kubeadm.alpha.kubernetes.io/cri-socket:npipe:////./pipe/containerd-containerd node.alpha.kubernetes.io/ttl:0 projectcalico.org/IPv4Address:10.1.0.4/16 projectcalico.org/IPv4VXLANTunnelAddr:192.168.59.193 projectcalico.org/VXLANTunnelMACAddr:00:15:5d:8c:1c:33 volumes.kubernetes.io/controller-managed-attach-detach:true] [] [] [{Go-http-client Update v1 2022-04-22 03:11:27 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{".":{},"f:kubeadm.alpha.kubernetes.io/cri-socket":{},"f:volumes.kubernetes.io/controller-managed-attach-detach":{}},"f:labels":{".":{},"f:beta.kubernetes.io/arch":{},"f:beta.kubernetes.io/instance-type":{},"f:beta.kubernetes.io/os":{},"f:failure-domain.beta.kubernetes.io/region":{},"f:failure-domain.beta.kubernetes.io/zone":{},"f:kubernetes.io/arch":{},"f:kubernetes.io/hostname":{},"f:kubernetes.io/os":{},"f:node.kubernetes.io/instance-type":{},"f:node.kubernetes.io/windows-build":{},"f:topology.kubernetes.io/region":{},"f:topology.kubernetes.io/zone":{}}},"f:spec":{"f:providerID":{}}} } {kube-controller-manager Update v1 2022-04-22 03:11:29 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{"f:node.alpha.kubernetes.io/ttl":{}}}} } {manager Update v1 2022-04-22 03:12:41 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{"f:cluster.x-k8s.io/cluster-name":{},"f:cluster.x-k8s.io/cluster-namespace":{},"f:cluster.x-k8s.io/machine":{},"f:cluster.x-k8s.io/owner-kind":{},"f:cluster.x-k8s.io/owner-name":{}}}} } {calico-node.exe Update v1 2022-04-22 03:13:16 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{"f:projectcalico.org/IPv4Address":{},"f:projectcalico.org/IPv4VXLANTunnelAddr":{},"f:projectcalico.org/VXLANTunnelMACAddr":{}}}} status} {Go-http-client Update v1 2022-04-22 03:29:29 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{"f:csi.volume.kubernetes.io/nodeid":{}}},"f:status":{"f:conditions":{"k:{\"type\":\"DiskPressure\"}":{"f:lastHeartbeatTime":{}},"k:{\"type\":\"MemoryPressure\"}":{"f:lastHeartbeatTime":{}},"k:{\"type\":\"PIDPressure\"}":{"f:lastHeartbeatTime":{}},"k:{\"type\":\"Ready\"}":{"f:lastHeartbeatTime":{},"f:lastTransitionTime":{},"f:message":{},"f:reason":{},"f:status":{}}},"f:images":{}}} status}]},Spec:NodeSpec{PodCIDR:,DoNotUseExternalID:,ProviderID:azure:///subscriptions/===REDACTED===/resourceGroups/capz-8a45pa/providers/Microsoft.Compute/virtualMachines/capz-8a45-pzhtj,Unschedulable:false,Taints:[]Taint{},ConfigSource:nil,PodCIDRs:[],},Status:NodeStatus{Capacity:ResourceList{attachable-volumes-azure-disk: {{8 0} {<nil>} 8 DecimalSI},cpu: {{4 0} {<nil>} 4 DecimalSI},ephemeral-storage: {{136912564224 0} {<nil>} 133703676Ki BinarySI},memory: {{17179398144 0} {<nil>} 16776756Ki BinarySI},pods: {{110 0} {<nil>} 110 DecimalSI},},Allocatable:ResourceList{attachable-volumes-azure-disk: {{8 0} {<nil>} 8 DecimalSI},cpu: {{4 0} {<nil>} 4 DecimalSI},ephemeral-storage: {{123221307598 0} {<nil>} 123221307598 DecimalSI},memory: {{17074540544 0} {<nil>} 16674356Ki BinarySI},pods: {{110 0} {<nil>} 110 DecimalSI},},Phase:,Conditions:[]NodeCondition{NodeCondition{Type:MemoryPressure,Status:False,LastHeartbeatTime:2022-04-22 03:37:27 +0000 UTC,LastTransitionTime:2022-04-22 03:11:25 +0000 UTC,Reason:KubeletHasSufficientMemory,Message:kubelet has sufficient memory available,},NodeCondition{Type:DiskPressure,Status:False,LastHeartbeatTime:2022-04-22 03:37:27 +0000 UTC,LastTransitionTime:2022-04-22 03:11:25 +0000 UTC,Reason:KubeletHasNoDiskPressure,Message:kubelet has no disk pressure,},NodeCondition{Type:PIDPressure,Status:False,LastHeartbeatTime:2022-04-22 03:37:27 +0000 UTC,LastTransitionTime:2022-04-22 03:11:25 +0000 UTC,Reason:KubeletHasSufficientPID,Message:kubelet has sufficient PID available,},NodeCondition{Type:Ready,Status:True,LastHeartbeatTime:2022-04-22 03:37:27 +0000 UTC,LastTransitionTime:2022-04-22 03:12:46 +0000 UTC,Reason:KubeletReady,Message:kubelet is posting ready status,},},Addresses:[]NodeAddress{NodeAddress{Type:Hostname,Address:capz-8a45-pzhtj,},NodeAddress{Type:InternalIP,Address:10.1.0.4,},},DaemonEndpoints:NodeDaemonEndpoints{KubeletEndpoint:DaemonEndpoint{Port:10250,},},NodeInfo:NodeSystemInfo{MachineID:capz-8a45-pzhtj,SystemUUID:5CA444EC-9BBE-4627-9CEE-7A41926E2CAA,BootID:,KernelVersion:10.0.20348.405,OSImage:Windows Server 2022 Datacenter,ContainerRuntimeVersion:containerd://1.6.1,KubeletVersion:v1.23.5,KubeProxyVersion:v1.23.5,OperatingSystem:windows,Architecture:amd64,},Images:[]ContainerImage{ContainerImage{Names:[mcr.microsoft.com/windows/servercore@sha256:378d85bd8e7388a777d25009f8523d1e95a5f544f131eaada83171045d5b2c1e mcr.microsoft.com/windows/servercore:ltsc2022],SizeBytes:2226956779,},ContainerImage{Names:[docker.io/sigwindowstools/calico-install@sha256:141afecd724eb757ee41593cc73f35fb19a2ce13cad73179cf3b1cef81a637d1 docker.io/sigwindowstools/calico-install:v3.22.1-hostprocess],SizeBytes:148096127,},ContainerImage{Names:[capzci.azurecr.io/azurefile-csi@sha256:47b232ada3d11bf92017193d2c00e90a3f3947ecc5ac4e8a7e368d5fb87907fd capzci.azurecr.io/azurefile-csi:e2e-07bfd478d868c055f36b20367e57ff932dd3f619],SizeBytes:130302144,},ContainerImage{Names:[docker.io/sigwindowstools/calico-node@sha256:b8e6e2f190e58d6b61b7f2a19b0e2e17a377e5b9d7b9528e9b7953d9f9ab59bb docker.io/sigwindowstools/calico-node:v3.22.1-hostprocess],SizeBytes:128793648,},ContainerImage{Names:[mcr.microsoft.com/oss/kubernetes-csi/csi-node-driver-registrar@sha256:dbec3a8166686b09b242176ab5b99e993da4126438bbce68147c3fd654f35662 mcr.microsoft.com/oss/kubernetes-csi/csi-node-driver-registrar:v2.4.0],SizeBytes:125554391,},ContainerImage{Names:[mcr.microsoft.com/oss/kubernetes-csi/livenessprobe@sha256:c96a6255c42766f6b8bb1a7cda02b0060ab1b20b2e2dafcc64ec09e7646745a6 mcr.microsoft.com/oss/kubernetes-csi/livenessprobe:v2.5.0],SizeBytes:124471446,},ContainerImage{Names:[ghcr.io/kubernetes-sigs/sig-windows/csi-proxy@sha256:96b4144986319a747ba599892454be2737aae6005d96b8e13ed481321ac3afba ghcr.io/kubernetes-sigs/sig-windows/csi-proxy:v1.0.2],SizeBytes:123925937,},ContainerImage{Names:[k8s.gcr.io/pause@sha256:3d380ca8864549e74af4b29c10f9cb0956236dfb01c40ca076fb6c37253234db k8s.gcr.io/pause:3.6],SizeBytes:119397646,},ContainerImage{Names:[docker.io/sigwindowstools/kube-proxy@sha256:0f8a44b795d1824358f24cc56f0024d18a39ae044656686596d8b7fa6d78e1fa docker.io/sigwindowstools/kube-proxy:v1.23.5-calico-hostprocess],SizeBytes:116337721,},},VolumesInUse:[],VolumesAttached:[]AttachedVolume{},Config:nil,},} Apr 22 03:39:04.680: INFO: Logging kubelet events for node capz-8a45-pzhtj Apr 22 03:39:04.725: INFO: Logging pods the kubelet thinks is on node capz-8a45-pzhtj Apr 22 03:39:04.773: INFO: calico-node-windows-qfnvz started at 2022-04-22 03:11:25 +0000 UTC (1+2 container statuses recorded) Apr 22 03:39:04.773: INFO: Init container install-cni ready: true, restart count 0 Apr 22 03:39:04.773: INFO: Container calico-node-felix ready: true, restart count 0 Apr 22 03:39:04.773: INFO: Container calico-node-startup ready: true, restart count 0 Apr 22 03:39:04.773: INFO: csi-proxy-cnsgc started at 2022-04-22 03:12:46 +0000 UTC (0+1 container statuses recorded) Apr 22 03:39:04.773: INFO: Container csi-proxy ready: true, restart count 0 Apr 22 03:39:04.773: INFO: csi-azurefile-node-win-8496k started at 2022-04-22 03:28:13 +0000 UTC (0+3 container statuses recorded) Apr 22 03:39:04.773: INFO: Container azurefile ready: true, restart count 0 Apr 22 03:39:04.773: INFO: Container liveness-probe ready: true, restart count 0 Apr 22 03:39:04.773: INFO: Container node-driver-registrar ready: true, restart count 0 Apr 22 03:39:04.773: INFO: kube-proxy-windows-h6c26 started at 2022-04-22 03:11:25 +0000 UTC (0+1 container statuses recorded) Apr 22 03:39:04.773: INFO: Container kube-proxy ready: true, restart count 0 Apr 22 03:39:04.986: INFO: Latency metrics for node capz-8a45-pzhtj Apr 22 03:39:04.986: INFO: Logging node info for node capz-8a45pa-control-plane-cqlqm Apr 22 03:39:05.022: INFO: Node Info: &Node{ObjectMeta:{capz-8a45pa-control-plane-cqlqm e1bacca4-d09d-45ef-bb60-44a59d556b5e 4124 0 2022-04-22 03:08:34 +0000 UTC <nil> <nil> map[beta.kubernetes.io/arch:amd64 beta.kubernetes.io/instance-type:Standard_D2s_v3 beta.kubernetes.io/os:linux failure-domain.beta.kubernetes.io/region:eastus2 failure-domain.beta.kubernetes.io/zone:eastus2-1 kubernetes.io/arch:amd64 kubernetes.io/hostname:capz-8a45pa-control-plane-cqlqm kubernetes.io/os:linux node-role.kubernetes.io/control-plane: node-role.kubernetes.io/master: node.kubernetes.io/exclude-from-external-load-balancers: node.kubernetes.io/instance-type:Standard_D2s_v3 topology.kubernetes.io/region:eastus2 topology.kubernetes.io/zone:eastus2-1] map[cluster.x-k8s.io/cluster-name:capz-8a45pa cluster.x-k8s.io/cluster-namespace:default cluster.x-k8s.io/machine:capz-8a45pa-control-plane-s49xv cluster.x-k8s.io/owner-kind:KubeadmControlPlane cluster.x-k8s.io/owner-name:capz-8a45pa-control-plane kubeadm.alpha.kubernetes.io/cri-socket:/run/containerd/containerd.sock node.alpha.kubernetes.io/ttl:0 projectcalico.org/IPv4Address:10.0.0.4/16 projectcalico.org/IPv4VXLANTunnelAddr:192.168.3.0 volumes.kubernetes.io/controller-managed-attach-detach:true] [] [] [{Go-http-client Update v1 2022-04-22 03:08:40 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{".":{},"f:kubeadm.alpha.kubernetes.io/cri-socket":{},"f:volumes.kubernetes.io/controller-managed-attach-detach":{}},"f:labels":{".":{},"f:beta.kubernetes.io/arch":{},"f:beta.kubernetes.io/instance-type":{},"f:beta.kubernetes.io/os":{},"f:failure-domain.beta.kubernetes.io/region":{},"f:failure-domain.beta.kubernetes.io/zone":{},"f:kubernetes.io/arch":{},"f:kubernetes.io/hostname":{},"f:kubernetes.io/os":{},"f:node-role.kubernetes.io/control-plane":{},"f:node-role.kubernetes.io/master":{},"f:node.kubernetes.io/exclude-from-external-load-balancers":{},"f:node.kubernetes.io/instance-type":{},"f:topology.kubernetes.io/region":{},"f:topology.kubernetes.io/zone":{}}},"f:spec":{"f:providerID":{}}} } {manager Update v1 2022-04-22 03:09:08 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{"f:cluster.x-k8s.io/cluster-name":{},"f:cluster.x-k8s.io/cluster-namespace":{},"f:cluster.x-k8s.io/machine":{},"f:cluster.x-k8s.io/owner-kind":{},"f:cluster.x-k8s.io/owner-name":{}}}} } {Go-http-client Update v1 2022-04-22 03:09:16 +0000 UTC FieldsV1 {"f:status":{"f:allocatable":{"f:ephemeral-storage":{}},"f:capacity":{"f:ephemeral-storage":{}},"f:conditions":{"k:{\"type\":\"DiskPressure\"}":{"f:lastHeartbeatTime":{}},"k:{\"type\":\"MemoryPressure\"}":{"f:lastHeartbeatTime":{}},"k:{\"type\":\"PIDPressure\"}":{"f:lastHeartbeatTime":{}},"k:{\"type\":\"Ready\"}":{"f:lastHeartbeatTime":{},"f:lastTransitionTime":{},"f:message":{},"f:reason":{},"f:status":{}}},"f:images":{}}} status} {kube-controller-manager Update v1 2022-04-22 03:09:16 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{"f:node.alpha.kubernetes.io/ttl":{}}},"f:spec":{"f:taints":{}}} } {calico-node Update v1 2022-04-22 03:09:23 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{"f:projectcalico.org/IPv4Address":{},"f:projectcalico.org/IPv4VXLANTunnelAddr":{}}},"f:status":{"f:conditions":{"k:{\"type\":\"NetworkUnavailable\"}":{".":{},"f:lastHeartbeatTime":{},"f:lastTransitionTime":{},"f:message":{},"f:reason":{},"f:status":{},"f:type":{}}}}} status}]},Spec:NodeSpec{PodCIDR:,DoNotUseExternalID:,ProviderID:azure:///subscriptions/===REDACTED===/resourceGroups/capz-8a45pa/providers/Microsoft.Compute/virtualMachines/capz-8a45pa-control-plane-cqlqm,Unschedulable:false,Taints:[]Taint{Taint{Key:node-role.kubernetes.io/master,Value:,Effect:NoSchedule,TimeAdded:<nil>,},},ConfigSource:nil,PodCIDRs:[],},Status:NodeStatus{Capacity:ResourceList{attachable-volumes-azure-disk: {{4 0} {<nil>} 4 DecimalSI},cpu: {{2 0} {<nil>} 2 DecimalSI},ephemeral-storage: {{133018140672 0} {<nil>} BinarySI},hugepages-1Gi: {{0 0} {<nil>} 0 DecimalSI},hugepages-2Mi: {{0 0} {<nil>} 0 DecimalSI},memory: {{8340819968 0} {<nil>} 8145332Ki BinarySI},pods: {{110 0} {<nil>} 110 DecimalSI},},Allocatable:ResourceList{attachable-volumes-azure-disk: {{4 0} {<nil>} 4 DecimalSI},cpu: {{2 0} {<nil>} 2 DecimalSI},ephemeral-storage: {{119716326407 0} {<nil>} 119716326407 DecimalSI},hugepages-1Gi: {{0 0} {<nil>} 0 DecimalSI},hugepages-2Mi: {{0 0} {<nil>} 0 DecimalSI},memory: {{8235962368 0} {<nil>} 8042932Ki BinarySI},pods: {{110 0} {<nil>} 110 DecimalSI},},Phase:,Conditions:[]NodeCondition{NodeCondition{Type:NetworkUnavailable,Status:False,LastHeartbeatTime:2022-04-22 03:09:22 +0000 UTC,LastTransitionTime:2022-04-22 03:09:22 +0000 UTC,Reason:CalicoIsUp,Message:Calico is running on this node,},NodeCondition{Type:MemoryPressure,Status:False,LastHeartbeatTime:2022-04-22 03:39:04 +0000 UTC,LastTransitionTime:2022-04-22 03:08:13 +0000 UTC,Reason:KubeletHasSufficientMemory,Message:kubelet has sufficient memory available,},NodeCondition{Type:DiskPressure,Status:False,LastHeartbeatTime:2022-04-22 03:39:04 +0000 UTC,LastTransitionTime:2022-04-22 03:08:13 +0000 UTC,Reason:KubeletHasNoDiskPressure,Message:kubelet has no disk pressure,},NodeCondition{Type:PIDPressure,Status:False,LastHeartbeatTime:2022-04-22 03:39:04 +0000 UTC,LastTransitionTime:2022-04-22 03:08:13 +0000 UTC,Reason:KubeletHasSufficientPID,Message:kubelet has sufficient PID available,},NodeCondition{Type:Ready,Status:True,LastHeartbeatTime:2022-04-22 03:39:04 +0000 UTC,LastTransitionTime:2022-04-22 03:09:16 +0000 UTC,Reason:KubeletReady,Message:kubelet is posting ready status. AppArmor enabled,},},Addresses:[]NodeAddress{NodeAddress{Type:Hostname,Address:capz-8a45pa-control-plane-cqlqm,},NodeAddress{Type:InternalIP,Address:10.0.0.4,},},DaemonEndpoints:NodeDaemonEndpoints{KubeletEndpoint:DaemonEndpoint{Port:10250,},},NodeInfo:NodeSystemInfo{MachineID:9d60ca8e799b409f873858218da52249,SystemUUID:88815db8-a2d9-534e-9f6c-74f652c2b89d,BootID:3322475a-69df-4c7d-b2a7-dad0257fb0bf,KernelVersion:5.13.0-1017-azure,OSImage:Ubuntu 20.04.4 LTS,ContainerRuntimeVersion:containerd://1.6.1,KubeletVersion:v1.23.5,KubeProxyVersion:v1.23.5,OperatingSystem:linux,Architecture:amd64,},Images:[]ContainerImage{ContainerImage{Names:[k8s.gcr.io/etcd@sha256:64b9ea357325d5db9f8a723dcf503b5a449177b17ac87d69481e126bb724c263 k8s.gcr.io/etcd:3.5.1-0],SizeBytes:98888614,},ContainerImage{Names:[docker.io/calico/cni@sha256:2219eae79544b098119a06a8bb5608867f9ac00471592a00e2347f3ae4bea687 docker.io/calico/cni:v3.22.1],SizeBytes:80514590,},ContainerImage{Names:[capzci.azurecr.io/azurefile-csi@sha256:47b232ada3d11bf92017193d2c00e90a3f3947ecc5ac4e8a7e368d5fb87907fd capzci.azurecr.io/azurefile-csi:e2e-07bfd478d868c055f36b20367e57ff932dd3f619],SizeBytes:73271375,},ContainerImage{Names:[docker.io/calico/node@sha256:1f8ed83e5264b4206cce7e1def11bca0b3ea7d5f4eb9b0ca0dbfc8cb968ca57e docker.io/calico/node:v3.22.1],SizeBytes:69647221,},ContainerImage{Names:[mcr.microsoft.com/oss/kubernetes-csi/csi-provisioner@sha256:542c9258a1441e4927883ea73425e21f9a14043a649686bf6b51700f34c64f8e mcr.microsoft.com/oss/kubernetes-csi/csi-provisioner:v3.1.0],SizeBytes:59205633,},ContainerImage{Names:[mcr.microsoft.com/oss/kubernetes-csi/csi-resizer@sha256:ab6c2e18a4d943f2bf8688e1779622277a1d14c355c9d4bfc0d761d86c5108b3 mcr.microsoft.com/oss/kubernetes-csi/csi-resizer:v1.4.0],SizeBytes:56924121,},ContainerImage{Names:[mcr.microsoft.com/oss/kubernetes-csi/csi-attacher@sha256:19fbca01394f7ed80151731180cfde0a3367f038beae2a97cda7928034010057 mcr.microsoft.com/oss/kubernetes-csi/csi-attacher:v3.4.0],SizeBytes:56301028,},ContainerImage{Names:[docker.io/calico/kube-controllers@sha256:e42a0aba3637d123481cca14fd8314a482616593edf58f9594c9382e50498f9b docker.io/calico/kube-controllers:v3.22.1],SizeBytes:54948023,},ContainerImage{Names:[k8s.gcr.io/kube-proxy@sha256:c1f625d115fbd9a12eac615653fc81c0edb33b2b5a76d1e09d5daed11fa557c1 k8s.gcr.io/kube-proxy:v1.23.5],SizeBytes:39278412,},ContainerImage{Names:[k8s.gcr.io/kube-apiserver@sha256:ddf5bf7196eb534271f9e5d403f4da19838d5610bb5ca191001bde5f32b5492e k8s.gcr.io/kube-apiserver:v1.23.5],SizeBytes:32603217,},ContainerImage{Names:[k8s.gcr.io/kube-controller-manager@sha256:cca0fb3532abedcc95c5f64268d54da9ecc56cc4817ff08d0128941cf2b0e1a4 k8s.gcr.io/kube-controller-manager:v1.23.5],SizeBytes:30174093,},ContainerImage{Names:[mcr.microsoft.com/oss/kubernetes-csi/csi-snapshotter@sha256:a889e925e15f9423f7842f1b769f64cbcf6a20b6956122836fc835cf22d9073f mcr.microsoft.com/oss/kubernetes-csi/csi-snapshotter:v5.0.1],SizeBytes:22192414,},ContainerImage{Names:[k8s.gcr.io/kube-scheduler@sha256:489efb65da9edc40bf0911f3e6371e5bb6b8ad8fde1d55193a6cc84c2ef36626 k8s.gcr.io/kube-scheduler:v1.23.5],SizeBytes:15131395,},ContainerImage{Names:[k8s.gcr.io/coredns/coredns@sha256:5b6ec0d6de9baaf3e92d0f66cd96a25b9edbce8716f5f15dcd1a616b3abd590e k8s.gcr.io/coredns/coredns:v1.8.6],SizeBytes:13585107,},ContainerImage{Names:[docker.io/calico/pod2daemon-flexvol@sha256:35802ba083546a7c5e8b5bf0ee7ffad7f8a468e8c2b3631e7e9647512c94041d docker.io/calico/pod2daemon-flexvol:v3.22.1],SizeBytes:8462620,},ContainerImage{Names:[mcr.microsoft.com/oss/kubernetes-csi/livenessprobe@sha256:c96a6255c42766f6b8bb1a7cda02b0060ab1b20b2e2dafcc64ec09e7646745a6 mcr.microsoft.com/oss/kubernetes-csi/livenessprobe:v2.5.0],SizeBytes:8222208,},ContainerImage{Names:[k8s.gcr.io/pause@sha256:3d380ca8864549e74af4b29c10f9cb0956236dfb01c40ca076fb6c37253234db k8s.gcr.io/pause:3.6],SizeBytes:301773,},},VolumesInUse:[],VolumesAttached:[]AttachedVolume{},Config:nil,},} Apr 22 03:39:05.023: INFO: Logging kubelet events for node capz-8a45pa-control-plane-cqlqm Apr 22 03:39:05.062: INFO: Logging pods the kubelet thinks is on node capz-8a45pa-control-plane-cqlqm Apr 22 03:39:05.122: INFO: coredns-64897985d-pr2wd started at 2022-04-22 03:09:16 +0000 UTC (0+1 container statuses recorded) Apr 22 03:39:05.122: INFO: Container coredns ready: true, restart count 0 Apr 22 03:39:05.122: INFO: calico-kube-controllers-7c664f4648-7c59f started at 2022-04-22 03:09:16 +0000 UTC (0+1 container statuses recorded) Apr 22 03:39:05.122: INFO: Container calico-kube-controllers ready: true, restart count 0 Apr 22 03:39:05.122: INFO: coredns-64897985d-7t4hq started at 2022-04-22 03:09:16 +0000 UTC (0+1 container statuses recorded) Apr 22 03:39:05.122: INFO: Container coredns ready: true, restart count 0 Apr 22 03:39:05.122: INFO: kube-controller-manager-capz-8a45pa-control-plane-cqlqm started at 2022-04-22 03:08:46 +0000 UTC (0+1 container statuses recorded) Apr 22 03:39:05.122: INFO: Container kube-controller-manager ready: true, restart count 0 Apr 22 03:39:05.122: INFO: kube-apiserver-capz-8a45pa-control-plane-cqlqm started at 2022-04-22 03:08:47 +0000 UTC (0+1 container statuses recorded) Apr 22 03:39:05.122: INFO: Container kube-apiserver ready: true, restart count 0 Apr 22 03:39:05.122: INFO: calico-node-gkjpk started at 2022-04-22 03:08:58 +0000 UTC (3+1 container statuses recorded) Apr 22 03:39:05.122: INFO: Init container upgrade-ipam ready: true, restart count 0 Apr 22 03:39:05.122: INFO: Init container install-cni ready: true, restart count 0 Apr 22 03:39:05.122: INFO: Init container flexvol-driver ready: true, restart count 0 Apr 22 03:39:05.122: INFO: Container calico-node ready: true, restart count 0 Apr 22 03:39:05.122: INFO: csi-azurefile-controller-66dd57cd58-4tn67 started at 2022-04-22 03:28:13 +0000 UTC (0+6 container statuses recorded) Apr 22 03:39:05.122: INFO: Container azurefile ready: true, restart count 0 Apr 22 03:39:05.122: INFO: Container csi-attacher ready: true, restart count 0 Apr 22 03:39:05.122: INFO: Container csi-provisioner ready: true, restart count 0 Apr 22 03:39:05.122: INFO: Container csi-resizer ready: true, restart count 0 Apr 22 03:39:05.122: INFO: Container csi-snapshotter ready: true, restart count 0 Apr 22 03:39:05.122: INFO: Container liveness-probe ready: true, restart count 0 Apr 22 03:39:05.122: INFO: kube-scheduler-capz-8a45pa-control-plane-cqlqm started at 2022-04-22 03:08:47 +0000 UTC (0+1 container statuses recorded) Apr 22 03:39:05.122: INFO: Container kube-scheduler ready: true, restart count 0 Apr 22 03:39:05.122: INFO: etcd-capz-8a45pa-control-plane-cqlqm started at 2022-04-22 03:08:47 +0000 UTC (0+1 container statuses recorded) Apr 22 03:39:05.122: INFO: Container etcd ready: true, restart count 0 Apr 22 03:39:05.122: INFO: kube-proxy-dgbs5 started at 2022-04-22 03:08:47 +0000 UTC (0+1 container statuses recorded) Apr 22 03:39:05.122: INFO: Container kube-proxy ready: true, restart count 0 Apr 22 03:39:05.316: INFO: Latency metrics for node capz-8a45pa-control-plane-cqlqm Apr 22 03:39:05.316: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready �[1mSTEP�[0m: Destroying namespace "azurefile-2540" for this suite.
Find azurefile-volume-tester-h42mh mentions in log files | View test history on testgrid
go run hack/e2e.go -v --test --test_args='--ginkgo.focus=AzureFile\sCSI\sDriver\sEnd\-to\-End\sTests\sDynamic\sProvisioning\sshould\smount\son\-prem\ssmb\sserver\s\[file\.csi\.azure\.com\]$'
/home/prow/go/src/sigs.k8s.io/azurefile-csi-driver/test/e2e/dynamic_provisioning_test.go:961 Unexpected error: <*errors.errorString | 0xc00048cb80>: { s: "Gave up after waiting 15m0s for pod \"azurefile-volume-tester-s5gj6\" to be \"Succeeded or Failed\"", } Gave up after waiting 15m0s for pod "azurefile-volume-tester-s5gj6" to be "Succeeded or Failed" occurred /home/prow/go/src/sigs.k8s.io/azurefile-csi-driver/test/e2e/testsuites/testsuites.go:691from junit_01.xml
�[1mSTEP�[0m: Creating a kubernetes client Apr 22 03:47:06.094: INFO: >>> kubeConfig: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig �[1mSTEP�[0m: Building a namespace api object, basename azurefile �[1mSTEP�[0m: Waiting for a default service account to be provisioned in namespace �[1mSTEP�[0m: Waiting for kube-root-ca.crt to be provisioned in namespace Apr 22 03:47:06.722: INFO: >>> kubeConfig: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig �[1mSTEP�[0m: creating secret smbcreds in namespace azurefile-1166 �[1mSTEP�[0m: deploying the pod �[1mSTEP�[0m: checking that the pods command exits with no error Apr 22 03:47:07.032: INFO: Waiting up to 15m0s for pod "azurefile-volume-tester-s5gj6" in namespace "azurefile-1166" to be "Succeeded or Failed" Apr 22 03:47:07.067: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 35.524382ms Apr 22 03:47:09.105: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 2.073562874s Apr 22 03:47:11.144: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 4.111989127s Apr 22 03:47:13.182: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 6.150256017s Apr 22 03:47:15.219: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 8.187470277s Apr 22 03:47:17.256: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 10.224005441s Apr 22 03:47:19.294: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 12.262484491s Apr 22 03:47:21.332: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 14.300303459s Apr 22 03:47:23.369: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 16.337427608s Apr 22 03:47:25.406: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 18.374247793s Apr 22 03:47:27.444: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 20.411668468s Apr 22 03:47:29.481: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 22.449222466s Apr 22 03:47:31.518: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 24.485633624s Apr 22 03:47:33.554: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 26.521735996s Apr 22 03:47:35.591: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 28.559556677s Apr 22 03:47:37.630: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 30.598139616s Apr 22 03:47:39.667: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 32.634648352s Apr 22 03:47:41.704: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 34.671929508s Apr 22 03:47:43.741: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 36.708782355s Apr 22 03:47:45.777: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 38.745458315s Apr 22 03:47:47.815: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 40.782734873s Apr 22 03:47:49.853: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 42.820611735s Apr 22 03:47:51.889: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 44.85717536s Apr 22 03:47:53.925: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 46.893509079s Apr 22 03:47:55.962: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 48.930390937s Apr 22 03:47:58.002: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 50.969853861s Apr 22 03:48:00.038: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 53.005720169s Apr 22 03:48:02.075: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 55.042631739s Apr 22 03:48:04.112: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 57.079719211s Apr 22 03:48:06.148: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 59.115901465s Apr 22 03:48:08.184: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 1m1.152596919s Apr 22 03:48:10.224: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 1m3.19172663s Apr 22 03:48:12.260: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 1m5.227664467s Apr 22 03:48:14.296: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 1m7.264448941s Apr 22 03:48:16.333: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 1m9.301286238s Apr 22 03:48:18.370: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 1m11.338432201s Apr 22 03:48:20.409: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 1m13.37680106s Apr 22 03:48:22.447: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 1m15.414759825s Apr 22 03:48:24.483: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 1m17.451468863s Apr 22 03:48:26.521: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 1m19.488839484s Apr 22 03:48:28.557: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 1m21.525354712s Apr 22 03:48:30.595: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 1m23.562714359s Apr 22 03:48:32.633: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 1m25.600930458s Apr 22 03:48:34.669: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 1m27.637400235s Apr 22 03:48:36.706: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 1m29.673945555s Apr 22 03:48:38.742: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 1m31.710342621s Apr 22 03:48:40.780: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 1m33.747815259s Apr 22 03:48:42.816: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 1m35.783781288s Apr 22 03:48:44.852: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 1m37.820068477s Apr 22 03:48:46.889: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 1m39.856947745s Apr 22 03:48:48.927: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 1m41.894897576s Apr 22 03:48:50.964: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 1m43.932443203s Apr 22 03:48:53.001: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 1m45.968905986s Apr 22 03:48:55.037: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 1m48.005301805s Apr 22 03:48:57.074: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 1m50.042599077s Apr 22 03:48:59.114: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 1m52.081754554s Apr 22 03:49:01.151: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 1m54.118892223s Apr 22 03:49:03.188: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 1m56.155958253s Apr 22 03:49:05.225: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 1m58.192789479s Apr 22 03:49:07.263: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 2m0.230781398s Apr 22 03:49:09.301: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 2m2.268693551s Apr 22 03:49:11.338: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 2m4.306149031s Apr 22 03:49:13.375: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 2m6.343549846s Apr 22 03:49:15.412: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 2m8.380367067s Apr 22 03:49:17.450: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 2m10.417867859s Apr 22 03:49:19.487: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 2m12.455170145s Apr 22 03:49:21.526: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 2m14.494420441s Apr 22 03:49:23.566: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 2m16.534218202s Apr 22 03:49:25.603: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 2m18.571531389s Apr 22 03:49:27.641: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 2m20.609591718s Apr 22 03:49:29.682: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 2m22.650254713s Apr 22 03:49:31.718: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 2m24.685969028s Apr 22 03:49:33.754: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 2m26.721950603s Apr 22 03:49:35.791: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 2m28.758774973s Apr 22 03:49:37.827: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 2m30.795225424s Apr 22 03:49:39.864: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 2m32.832588172s Apr 22 03:49:41.901: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 2m34.868899636s Apr 22 03:49:43.937: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 2m36.905437406s Apr 22 03:49:45.973: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 2m38.941602798s Apr 22 03:49:48.011: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 2m40.979181877s Apr 22 03:49:50.048: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 2m43.015933646s Apr 22 03:49:52.084: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 2m45.052276952s Apr 22 03:49:54.121: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 2m47.089154011s Apr 22 03:49:56.159: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 2m49.127213958s Apr 22 03:49:58.197: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 2m51.164638673s Apr 22 03:50:00.233: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 2m53.200898262s Apr 22 03:50:02.269: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 2m55.237367962s Apr 22 03:50:04.305: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 2m57.273407745s Apr 22 03:50:06.342: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 2m59.310307974s Apr 22 03:50:08.380: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 3m1.348594607s Apr 22 03:50:10.418: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 3m3.386609268s Apr 22 03:50:12.457: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 3m5.425133381s Apr 22 03:50:14.495: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 3m7.462835089s Apr 22 03:50:16.531: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 3m9.499518124s Apr 22 03:50:18.570: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 3m11.538154694s Apr 22 03:50:20.608: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 3m13.576383892s Apr 22 03:50:22.646: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 3m15.613860164s Apr 22 03:50:24.681: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 3m17.649320373s Apr 22 03:50:26.718: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 3m19.685761977s Apr 22 03:50:28.754: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 3m21.722444367s Apr 22 03:50:30.790: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 3m23.758453799s Apr 22 03:50:32.826: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 3m25.79427697s Apr 22 03:50:34.864: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 3m27.832435256s Apr 22 03:50:36.901: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 3m29.868960737s Apr 22 03:50:38.939: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 3m31.906862933s Apr 22 03:50:40.976: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 3m33.943763628s Apr 22 03:50:43.013: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 3m35.980778248s Apr 22 03:50:45.049: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 3m38.016906325s Apr 22 03:50:47.085: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 3m40.053093787s Apr 22 03:50:49.123: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 3m42.090974919s Apr 22 03:50:51.161: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 3m44.128881364s Apr 22 03:50:53.197: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 3m46.165053301s Apr 22 03:50:55.233: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 3m48.201392224s Apr 22 03:50:57.272: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 3m50.239771801s Apr 22 03:50:59.308: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 3m52.276215056s Apr 22 03:51:01.345: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 3m54.313021551s Apr 22 03:51:03.382: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 3m56.350184477s Apr 22 03:51:05.419: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 3m58.386881611s Apr 22 03:51:07.461: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 4m0.42903913s Apr 22 03:51:09.499: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 4m2.467037566s Apr 22 03:51:11.539: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 4m4.506844604s Apr 22 03:51:13.576: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 4m6.54412582s Apr 22 03:51:15.613: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 4m8.581570729s Apr 22 03:51:17.649: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 4m10.617460871s Apr 22 03:51:19.685: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 4m12.65308511s Apr 22 03:51:21.721: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 4m14.689160741s Apr 22 03:51:23.757: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 4m16.725299332s Apr 22 03:51:25.794: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 4m18.762475612s Apr 22 03:51:27.833: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 4m20.800890541s Apr 22 03:51:29.870: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 4m22.837641303s Apr 22 03:51:31.907: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 4m24.875060153s Apr 22 03:51:33.944: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 4m26.911933148s Apr 22 03:51:35.981: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 4m28.948927777s Apr 22 03:51:38.018: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 4m30.985965671s Apr 22 03:51:40.056: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 4m33.023849745s Apr 22 03:51:42.093: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 4m35.060988194s Apr 22 03:51:44.128: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 4m37.096577265s Apr 22 03:51:46.165: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 4m39.133190288s Apr 22 03:51:48.202: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 4m41.169775527s Apr 22 03:51:50.239: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 4m43.206665337s Apr 22 03:51:52.275: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 4m45.243081631s Apr 22 03:51:54.312: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 4m47.279884528s Apr 22 03:51:56.348: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 4m49.31659459s Apr 22 03:51:58.385: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 4m51.353450978s Apr 22 03:52:00.424: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 4m53.391932468s Apr 22 03:52:02.461: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 4m55.42940307s Apr 22 03:52:04.498: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 4m57.46656812s Apr 22 03:52:06.535: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 4m59.503050654s Apr 22 03:52:08.572: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 5m1.540308479s Apr 22 03:52:10.609: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 5m3.577276798s Apr 22 03:52:12.646: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 5m5.613956635s Apr 22 03:52:14.684: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 5m7.651865458s Apr 22 03:52:16.722: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 5m9.689966817s Apr 22 03:52:18.759: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 5m11.727014897s Apr 22 03:52:20.797: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 5m13.764955404s Apr 22 03:52:22.833: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 5m15.800649968s Apr 22 03:52:24.869: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 5m17.837048293s Apr 22 03:52:26.905: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 5m19.873481032s Apr 22 03:52:28.943: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 5m21.911121678s Apr 22 03:52:30.981: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 5m23.948884742s Apr 22 03:52:33.017: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 5m25.985128972s Apr 22 03:52:35.054: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 5m28.022134841s Apr 22 03:52:37.091: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 5m30.059561346s Apr 22 03:52:39.129: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 5m32.096745167s Apr 22 03:52:41.170: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 5m34.137871776s Apr 22 03:52:43.207: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 5m36.17464742s Apr 22 03:52:45.244: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 5m38.212138366s Apr 22 03:52:47.281: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 5m40.248889115s Apr 22 03:52:49.317: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 5m42.28529156s Apr 22 03:52:51.355: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 5m44.323228308s Apr 22 03:52:53.393: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 5m46.360958212s Apr 22 03:52:55.431: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 5m48.398854943s Apr 22 03:52:57.468: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 5m50.43634885s Apr 22 03:52:59.505: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 5m52.472980466s Apr 22 03:53:01.542: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 5m54.510554458s Apr 22 03:53:03.579: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 5m56.547527917s Apr 22 03:53:05.616: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 5m58.583819192s Apr 22 03:53:07.653: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 6m0.621024349s Apr 22 03:53:09.689: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 6m2.657139127s Apr 22 03:53:11.726: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 6m4.693684387s Apr 22 03:53:13.763: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 6m6.731346038s Apr 22 03:53:15.799: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 6m8.767567202s Apr 22 03:53:17.836: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 6m10.803813012s Apr 22 03:53:19.872: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 6m12.840562449s Apr 22 03:53:21.909: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 6m14.877401013s Apr 22 03:53:23.947: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 6m16.914838296s Apr 22 03:53:25.983: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 6m18.950917149s Apr 22 03:53:28.020: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 6m20.988511314s Apr 22 03:53:30.057: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 6m23.024978583s Apr 22 03:53:32.093: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 6m25.060851064s Apr 22 03:53:34.129: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 6m27.096617583s Apr 22 03:53:36.168: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 6m29.136297458s Apr 22 03:53:38.204: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 6m31.171927433s Apr 22 03:53:40.240: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 6m33.208518831s Apr 22 03:53:42.278: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 6m35.245622901s Apr 22 03:53:44.315: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 6m37.282643748s Apr 22 03:53:46.352: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 6m39.319805441s Apr 22 03:53:48.390: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 6m41.357629462s Apr 22 03:53:50.428: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 6m43.39636972s Apr 22 03:53:52.465: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 6m45.432861785s Apr 22 03:53:54.503: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 6m47.470695784s Apr 22 03:53:56.539: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 6m49.507466608s Apr 22 03:53:58.576: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 6m51.544243557s Apr 22 03:54:00.613: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 6m53.581265369s Apr 22 03:54:02.649: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 6m55.617323822s Apr 22 03:54:04.686: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 6m57.653986093s Apr 22 03:54:06.722: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 6m59.690275926s Apr 22 03:54:08.760: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 7m1.727793422s Apr 22 03:54:10.797: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 7m3.764951746s Apr 22 03:54:12.833: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 7m5.801081472s Apr 22 03:54:14.869: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 7m7.83668459s Apr 22 03:54:16.904: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 7m9.872524781s Apr 22 03:54:18.941: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 7m11.90929561s Apr 22 03:54:20.978: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 7m13.945667495s Apr 22 03:54:23.013: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 7m15.981023066s Apr 22 03:54:25.049: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 7m18.01683118s Apr 22 03:54:27.088: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 7m20.055705732s Apr 22 03:54:29.128: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 7m22.096487482s Apr 22 03:54:31.165: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 7m24.133086268s Apr 22 03:54:33.201: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 7m26.169554934s Apr 22 03:54:35.238: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 7m28.206531299s Apr 22 03:54:37.274: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 7m30.242471401s Apr 22 03:54:39.311: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 7m32.279577669s Apr 22 03:54:41.348: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 7m34.31606323s Apr 22 03:54:43.385: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 7m36.353284964s Apr 22 03:54:45.422: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 7m38.390507274s Apr 22 03:54:47.461: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 7m40.42865017s Apr 22 03:54:49.498: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 7m42.466344173s Apr 22 03:54:51.537: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 7m44.504745332s Apr 22 03:54:53.573: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 7m46.54136874s Apr 22 03:54:55.610: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 7m48.577682642s Apr 22 03:54:57.647: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 7m50.614746473s Apr 22 03:54:59.683: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 7m52.65160664s Apr 22 03:55:01.720: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 7m54.688139402s Apr 22 03:55:03.757: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 7m56.724899027s Apr 22 03:55:05.793: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 7m58.761012544s Apr 22 03:55:07.830: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 8m0.798515037s Apr 22 03:55:09.867: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 8m2.835514315s Apr 22 03:55:11.906: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 8m4.873712669s Apr 22 03:55:13.941: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 8m6.909581783s Apr 22 03:55:15.978: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 8m8.945721669s Apr 22 03:55:18.015: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 8m10.983119229s Apr 22 03:55:20.053: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 8m13.02079092s Apr 22 03:55:22.090: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 8m15.058049372s Apr 22 03:55:24.127: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 8m17.094939253s Apr 22 03:55:26.163: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 8m19.131441823s Apr 22 03:55:28.201: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 8m21.168938948s Apr 22 03:55:30.237: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 8m23.205496742s Apr 22 03:55:32.275: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 8m25.242963907s Apr 22 03:55:34.312: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 8m27.279799107s Apr 22 03:55:36.348: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 8m29.316217754s Apr 22 03:55:38.385: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 8m31.352972681s Apr 22 03:55:40.422: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 8m33.38986003s Apr 22 03:55:42.459: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 8m35.426726885s Apr 22 03:55:44.495: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 8m37.463536974s Apr 22 03:55:46.532: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 8m39.500462176s Apr 22 03:55:48.570: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 8m41.53807768s Apr 22 03:55:50.606: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 8m43.574047756s Apr 22 03:55:52.644: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 8m45.612350938s Apr 22 03:55:54.683: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 8m47.650621605s Apr 22 03:55:56.719: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 8m49.686881372s Apr 22 03:55:58.757: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 8m51.725076439s Apr 22 03:56:00.794: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 8m53.762030313s Apr 22 03:56:02.831: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 8m55.79923866s Apr 22 03:56:04.869: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 8m57.837171679s Apr 22 03:56:06.905: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 8m59.87352557s Apr 22 03:56:08.943: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 9m1.910839976s Apr 22 03:56:10.979: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 9m3.94749926s Apr 22 03:56:13.016: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 9m5.984290873s Apr 22 03:56:15.053: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 9m8.020657425s Apr 22 03:56:17.092: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 9m10.059929338s Apr 22 03:56:19.128: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 9m12.096259836s Apr 22 03:56:21.180: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 9m14.14772902s Apr 22 03:56:23.215: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 9m16.183578099s Apr 22 03:56:25.253: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 9m18.221380597s Apr 22 03:56:27.290: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 9m20.258097398s Apr 22 03:56:29.326: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 9m22.294547755s Apr 22 03:56:31.363: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 9m24.330833278s Apr 22 03:56:33.399: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 9m26.367340004s Apr 22 03:56:35.437: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 9m28.404641442s Apr 22 03:56:37.474: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 9m30.441928804s Apr 22 03:56:39.511: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 9m32.479260375s Apr 22 03:56:41.548: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 9m34.516229415s Apr 22 03:56:43.587: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 9m36.55489074s Apr 22 03:56:45.623: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 9m38.591598322s Apr 22 03:56:47.660: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 9m40.628320907s Apr 22 03:56:49.697: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 9m42.665194314s Apr 22 03:56:51.734: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 9m44.702379399s Apr 22 03:56:53.773: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 9m46.7409301s Apr 22 03:56:55.810: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 9m48.777624744s Apr 22 03:56:57.847: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 9m50.814619197s Apr 22 03:56:59.884: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 9m52.852396814s Apr 22 03:57:01.921: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 9m54.888979987s Apr 22 03:57:03.957: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 9m56.925362988s Apr 22 03:57:05.994: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 9m58.962413027s Apr 22 03:57:08.035: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 10m1.003533037s Apr 22 03:57:10.072: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 10m3.040252012s Apr 22 03:57:12.109: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 10m5.076889656s Apr 22 03:57:14.146: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 10m7.113900327s Apr 22 03:57:16.181: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 10m9.149383663s Apr 22 03:57:18.218: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 10m11.185867622s Apr 22 03:57:20.254: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 10m13.222064682s Apr 22 03:57:22.292: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 10m15.259643756s Apr 22 03:57:24.329: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 10m17.297153664s Apr 22 03:57:26.365: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 10m19.333126093s Apr 22 03:57:28.402: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 10m21.370382409s Apr 22 03:57:30.438: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 10m23.406469821s Apr 22 03:57:32.475: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 10m25.443601405s Apr 22 03:57:34.513: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 10m27.480858397s Apr 22 03:57:36.550: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 10m29.517696426s Apr 22 03:57:38.587: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 10m31.555571185s Apr 22 03:57:40.626: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 10m33.59417393s Apr 22 03:57:42.663: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 10m35.631539492s Apr 22 03:57:44.701: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 10m37.668725612s Apr 22 03:57:46.739: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 10m39.70722171s Apr 22 03:57:48.775: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 10m41.74358782s Apr 22 03:57:50.812: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 10m43.780544787s Apr 22 03:57:52.851: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 10m45.819202438s Apr 22 03:57:54.889: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 10m47.856787847s Apr 22 03:57:56.926: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 10m49.894125427s Apr 22 03:57:58.964: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 10m51.932328628s Apr 22 03:58:01.002: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 10m53.969762008s Apr 22 03:58:03.039: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 10m56.007037889s Apr 22 03:58:05.076: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 10m58.043785509s Apr 22 03:58:07.112: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 11m0.080231391s Apr 22 03:58:09.152: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 11m2.120030503s Apr 22 03:58:11.189: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 11m4.157179837s Apr 22 03:58:13.227: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 11m6.194711123s Apr 22 03:58:15.263: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 11m8.231568533s Apr 22 03:58:17.301: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 11m10.269458214s Apr 22 03:58:19.338: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 11m12.306576839s Apr 22 03:58:21.376: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 11m14.343981702s Apr 22 03:58:23.413: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 11m16.380996098s Apr 22 03:58:25.451: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 11m18.418789642s Apr 22 03:58:27.488: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 11m20.456528469s Apr 22 03:58:29.526: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 11m22.494260227s Apr 22 03:58:31.564: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 11m24.531650225s Apr 22 03:58:33.600: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 11m26.567963428s Apr 22 03:58:35.636: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 11m28.604439458s Apr 22 03:58:37.674: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 11m30.642467136s Apr 22 03:58:39.711: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 11m32.679316342s Apr 22 03:58:41.747: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 11m34.715039994s Apr 22 03:58:43.785: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 11m36.752989703s Apr 22 03:58:45.822: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 11m38.790284029s Apr 22 03:58:47.859: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 11m40.826964787s Apr 22 03:58:49.896: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 11m42.863746333s Apr 22 03:58:51.933: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 11m44.900887419s Apr 22 03:58:53.970: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 11m46.938053766s Apr 22 03:58:56.007: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 11m48.975275956s Apr 22 03:58:58.044: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 11m51.012596541s Apr 22 03:59:00.083: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 11m53.050881857s Apr 22 03:59:02.120: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 11m55.088105126s Apr 22 03:59:04.156: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 11m57.123804483s Apr 22 03:59:06.192: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 11m59.159649115s Apr 22 03:59:08.233: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 12m1.200670701s Apr 22 03:59:10.269: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 12m3.237216608s Apr 22 03:59:12.306: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 12m5.274126938s Apr 22 03:59:14.343: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 12m7.310630933s Apr 22 03:59:16.379: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 12m9.347407208s Apr 22 03:59:18.418: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 12m11.385689532s Apr 22 03:59:20.454: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 12m13.422250236s Apr 22 03:59:22.493: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 12m15.460730107s Apr 22 03:59:24.529: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 12m17.496696762s Apr 22 03:59:26.565: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 12m19.532734896s Apr 22 03:59:28.601: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 12m21.568821087s Apr 22 03:59:30.638: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 12m23.605798837s Apr 22 03:59:32.673: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 12m25.641562467s Apr 22 03:59:34.709: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 12m27.677121869s Apr 22 03:59:36.764: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 12m29.731899575s Apr 22 03:59:38.799: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 12m31.767587697s Apr 22 03:59:40.836: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 12m33.804127107s Apr 22 03:59:42.873: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 12m35.840659037s Apr 22 03:59:44.909: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 12m37.876964587s Apr 22 03:59:46.945: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 12m39.913129427s Apr 22 03:59:48.985: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 12m41.953114646s Apr 22 03:59:51.022: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 12m43.990009185s Apr 22 03:59:53.058: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 12m46.025841065s Apr 22 03:59:55.093: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 12m48.061499096s Apr 22 03:59:57.132: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 12m50.099972675s Apr 22 03:59:59.168: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 12m52.136479793s Apr 22 04:00:01.206: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 12m54.174215494s Apr 22 04:00:03.244: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 12m56.211609105s Apr 22 04:00:05.280: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 12m58.247898373s Apr 22 04:00:07.316: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 13m0.284119593s Apr 22 04:00:09.353: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 13m2.321252405s Apr 22 04:00:11.390: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 13m4.358365062s Apr 22 04:00:13.428: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 13m6.395822186s Apr 22 04:00:15.465: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 13m8.432758486s Apr 22 04:00:17.501: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 13m10.469485172s Apr 22 04:00:19.538: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 13m12.506149447s Apr 22 04:00:21.575: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 13m14.543457149s Apr 22 04:00:23.612: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 13m16.579672398s Apr 22 04:00:25.649: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 13m18.617232855s Apr 22 04:00:27.686: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 13m20.653760561s Apr 22 04:00:29.724: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 13m22.691755202s Apr 22 04:00:31.760: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 13m24.727890043s Apr 22 04:00:33.798: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 13m26.765690622s Apr 22 04:00:35.834: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 13m28.801809749s Apr 22 04:00:37.870: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 13m30.837659096s Apr 22 04:00:39.906: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 13m32.873918757s Apr 22 04:00:41.941: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 13m34.909474902s Apr 22 04:00:43.977: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 13m36.945478064s Apr 22 04:00:46.014: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 13m38.982229414s Apr 22 04:00:48.050: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 13m41.018258955s Apr 22 04:00:50.087: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 13m43.054852076s Apr 22 04:00:52.124: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 13m45.091697068s Apr 22 04:00:54.160: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 13m47.128539385s Apr 22 04:00:56.197: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 13m49.16473969s Apr 22 04:00:58.233: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 13m51.200829545s Apr 22 04:01:00.268: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 13m53.236434074s Apr 22 04:01:02.304: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 13m55.272460398s Apr 22 04:01:04.341: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 13m57.309419038s Apr 22 04:01:06.378: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 13m59.34576889s Apr 22 04:01:08.415: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 14m1.383579595s Apr 22 04:01:10.452: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 14m3.420587467s Apr 22 04:01:12.490: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 14m5.458194081s Apr 22 04:01:14.527: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 14m7.495456976s Apr 22 04:01:16.565: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 14m9.532720422s Apr 22 04:01:18.601: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 14m11.569519253s Apr 22 04:01:20.638: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 14m13.606265767s Apr 22 04:01:22.675: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 14m15.642794407s Apr 22 04:01:24.711: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 14m17.679077639s Apr 22 04:01:26.748: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 14m19.716238888s Apr 22 04:01:28.784: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 14m21.752548682s Apr 22 04:01:30.822: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 14m23.789756206s Apr 22 04:01:32.860: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 14m25.827675793s Apr 22 04:01:34.896: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 14m27.863961796s Apr 22 04:01:36.933: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 14m29.900934521s Apr 22 04:01:38.970: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 14m31.938319495s Apr 22 04:01:41.007: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 14m33.97485477s Apr 22 04:01:43.043: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 14m36.010879125s Apr 22 04:01:45.083: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 14m38.050967976s Apr 22 04:01:47.120: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 14m40.088032273s Apr 22 04:01:49.159: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 14m42.126717934s Apr 22 04:01:51.195: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 14m44.163382232s Apr 22 04:01:53.232: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 14m46.199778525s Apr 22 04:01:55.268: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 14m48.236261365s Apr 22 04:01:57.304: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 14m50.272077558s Apr 22 04:01:59.342: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 14m52.310055646s Apr 22 04:02:01.379: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 14m54.347542538s Apr 22 04:02:03.417: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 14m56.384817733s Apr 22 04:02:05.453: INFO: Pod "azurefile-volume-tester-s5gj6": Phase="Pending", Reason="", readiness=false. Elapsed: 14m58.421187853s Apr 22 04:02:07.454: INFO: deleting Pod "azurefile-1166"/"azurefile-volume-tester-s5gj6" Apr 22 04:02:07.521: INFO: Error getting logs for pod azurefile-volume-tester-s5gj6: the server rejected our request for an unknown reason (get pods azurefile-volume-tester-s5gj6) �[1mSTEP�[0m: Deleting pod azurefile-volume-tester-s5gj6 in namespace azurefile-1166 Apr 22 04:02:07.559: INFO: deleting Secret smbcreds �[1mSTEP�[0m: Collecting events from namespace "azurefile-1166". �[1mSTEP�[0m: Found 3 events. Apr 22 04:02:07.632: INFO: At 2022-04-22 03:47:07 +0000 UTC - event for azurefile-volume-tester-s5gj6: {default-scheduler } Scheduled: Successfully assigned azurefile-1166/azurefile-volume-tester-s5gj6 to capz-8a45-pzhtj Apr 22 04:02:07.632: INFO: At 2022-04-22 03:47:31 +0000 UTC - event for azurefile-volume-tester-s5gj6: {kubelet capz-8a45-pzhtj} FailedMount: MountVolume.SetUp failed for volume "test-volume-1" : rpc error: code = Internal desc = volume(csi-961158652599406988fabb4e8ccfa5056665c021422957d36409c7fde0d9bd6f) mount "\\\\20.72.114.55\\share" on "c:\\var\\lib\\kubelet\\pods\\958d1bab-90c5-46ac-a9e5-1351e47a9da2\\volumes\\kubernetes.io~csi\\test-volume-1\\mount" failed with smb mapping failed with error: rpc error: code = Unknown desc = NewSmbGlobalMapping failed. output: "New-SmbGlobalMapping : The network path was not found. \r\nAt line:1 char:190\r\n+ ... ser, $PWord;New-SmbGlobalMapping -RemotePath $Env:smbremotepath -Cred ...\r\n+ ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~\r\n + CategoryInfo : NotSpecified: (MSFT_SmbGlobalMapping:ROOT/Microsoft/...mbGlobalMapping) [New-SmbGlobalMa \r\n pping], CimException\r\n + FullyQualifiedErrorId : Windows System Error 53,New-SmbGlobalMapping\r\n \r\n", err: exit status 1 Apr 22 04:02:07.632: INFO: At 2022-04-22 03:49:10 +0000 UTC - event for azurefile-volume-tester-s5gj6: {kubelet capz-8a45-pzhtj} FailedMount: Unable to attach or mount volumes: unmounted volumes=[test-volume-1], unattached volumes=[test-volume-1]: timed out waiting for the condition Apr 22 04:02:07.679: INFO: POD NODE PHASE GRACE CONDITIONS Apr 22 04:02:07.679: INFO: azurefile-volume-tester-s5gj6 capz-8a45-pzhtj Pending 30s [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2022-04-22 03:47:07 +0000 UTC } {Ready False 0001-01-01 00:00:00 +0000 UTC 2022-04-22 03:47:07 +0000 UTC ContainersNotReady containers with unready status: [volume-tester]} {ContainersReady False 0001-01-01 00:00:00 +0000 UTC 2022-04-22 03:47:07 +0000 UTC ContainersNotReady containers with unready status: [volume-tester]} {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2022-04-22 03:47:07 +0000 UTC }] Apr 22 04:02:07.679: INFO: Apr 22 04:02:07.718: INFO: Logging node info for node capz-8a45-b775t Apr 22 04:02:07.754: INFO: Node Info: &Node{ObjectMeta:{capz-8a45-b775t e84b96d4-fdad-4ef5-868d-c1945c856ad3 7957 0 2022-04-22 03:11:35 +0000 UTC <nil> <nil> map[beta.kubernetes.io/arch:amd64 beta.kubernetes.io/instance-type:Standard_D4s_v3 beta.kubernetes.io/os:windows failure-domain.beta.kubernetes.io/region:eastus2 failure-domain.beta.kubernetes.io/zone:0 kubernetes.io/arch:amd64 kubernetes.io/hostname:capz-8a45-b775t kubernetes.io/os:windows node.kubernetes.io/instance-type:Standard_D4s_v3 node.kubernetes.io/windows-build:10.0.20348 topology.kubernetes.io/region:eastus2 topology.kubernetes.io/zone:0] map[cluster.x-k8s.io/cluster-name:capz-8a45pa cluster.x-k8s.io/cluster-namespace:default cluster.x-k8s.io/machine:capz-8a45pa-md-win-b5fffb599-htlnk cluster.x-k8s.io/owner-kind:MachineSet cluster.x-k8s.io/owner-name:capz-8a45pa-md-win-b5fffb599 csi.volume.kubernetes.io/nodeid:{"file.csi.azure.com":"capz-8a45-b775t"} kubeadm.alpha.kubernetes.io/cri-socket:npipe:////./pipe/containerd-containerd node.alpha.kubernetes.io/ttl:0 projectcalico.org/IPv4Address:10.1.0.5/16 projectcalico.org/IPv4VXLANTunnelAddr:192.168.216.193 projectcalico.org/VXLANTunnelMACAddr:00:15:5d:2f:65:42 volumes.kubernetes.io/controller-managed-attach-detach:true] [] [] [{Go-http-client Update v1 2022-04-22 03:11:35 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{".":{},"f:kubeadm.alpha.kubernetes.io/cri-socket":{},"f:volumes.kubernetes.io/controller-managed-attach-detach":{}},"f:labels":{".":{},"f:beta.kubernetes.io/arch":{},"f:beta.kubernetes.io/instance-type":{},"f:beta.kubernetes.io/os":{},"f:failure-domain.beta.kubernetes.io/region":{},"f:failure-domain.beta.kubernetes.io/zone":{},"f:kubernetes.io/arch":{},"f:kubernetes.io/hostname":{},"f:kubernetes.io/os":{},"f:node.kubernetes.io/instance-type":{},"f:node.kubernetes.io/windows-build":{},"f:topology.kubernetes.io/region":{},"f:topology.kubernetes.io/zone":{}}},"f:spec":{"f:providerID":{}}} } {kube-controller-manager Update v1 2022-04-22 03:11:39 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{"f:node.alpha.kubernetes.io/ttl":{}}}} } {manager Update v1 2022-04-22 03:12:57 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{"f:cluster.x-k8s.io/cluster-name":{},"f:cluster.x-k8s.io/cluster-namespace":{},"f:cluster.x-k8s.io/machine":{},"f:cluster.x-k8s.io/owner-kind":{},"f:cluster.x-k8s.io/owner-name":{}}}} } {calico-node.exe Update v1 2022-04-22 03:13:19 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{"f:projectcalico.org/IPv4Address":{},"f:projectcalico.org/IPv4VXLANTunnelAddr":{},"f:projectcalico.org/VXLANTunnelMACAddr":{}}}} status} {Go-http-client Update v1 2022-04-22 03:29:26 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{"f:csi.volume.kubernetes.io/nodeid":{}}},"f:status":{"f:conditions":{"k:{\"type\":\"DiskPressure\"}":{"f:lastHeartbeatTime":{}},"k:{\"type\":\"MemoryPressure\"}":{"f:lastHeartbeatTime":{}},"k:{\"type\":\"PIDPressure\"}":{"f:lastHeartbeatTime":{}},"k:{\"type\":\"Ready\"}":{"f:lastHeartbeatTime":{},"f:lastTransitionTime":{},"f:message":{},"f:reason":{},"f:status":{}}},"f:images":{}}} status}]},Spec:NodeSpec{PodCIDR:,DoNotUseExternalID:,ProviderID:azure:///subscriptions/===REDACTED===/resourceGroups/capz-8a45pa/providers/Microsoft.Compute/virtualMachines/capz-8a45-b775t,Unschedulable:false,Taints:[]Taint{},ConfigSource:nil,PodCIDRs:[],},Status:NodeStatus{Capacity:ResourceList{attachable-volumes-azure-disk: {{8 0} {<nil>} 8 DecimalSI},cpu: {{4 0} {<nil>} 4 DecimalSI},ephemeral-storage: {{136912564224 0} {<nil>} 133703676Ki BinarySI},memory: {{17179398144 0} {<nil>} 16776756Ki BinarySI},pods: {{110 0} {<nil>} 110 DecimalSI},},Allocatable:ResourceList{attachable-volumes-azure-disk: {{8 0} {<nil>} 8 DecimalSI},cpu: {{4 0} {<nil>} 4 DecimalSI},ephemeral-storage: {{123221307598 0} {<nil>} 123221307598 DecimalSI},memory: {{17074540544 0} {<nil>} 16674356Ki BinarySI},pods: {{110 0} {<nil>} 110 DecimalSI},},Phase:,Conditions:[]NodeCondition{NodeCondition{Type:MemoryPressure,Status:False,LastHeartbeatTime:2022-04-22 04:00:18 +0000 UTC,LastTransitionTime:2022-04-22 03:11:35 +0000 UTC,Reason:KubeletHasSufficientMemory,Message:kubelet has sufficient memory available,},NodeCondition{Type:DiskPressure,Status:False,LastHeartbeatTime:2022-04-22 04:00:18 +0000 UTC,LastTransitionTime:2022-04-22 03:11:35 +0000 UTC,Reason:KubeletHasNoDiskPressure,Message:kubelet has no disk pressure,},NodeCondition{Type:PIDPressure,Status:False,LastHeartbeatTime:2022-04-22 04:00:18 +0000 UTC,LastTransitionTime:2022-04-22 03:11:35 +0000 UTC,Reason:KubeletHasSufficientPID,Message:kubelet has sufficient PID available,},NodeCondition{Type:Ready,Status:True,LastHeartbeatTime:2022-04-22 04:00:18 +0000 UTC,LastTransitionTime:2022-04-22 03:12:36 +0000 UTC,Reason:KubeletReady,Message:kubelet is posting ready status,},},Addresses:[]NodeAddress{NodeAddress{Type:Hostname,Address:capz-8a45-b775t,},NodeAddress{Type:InternalIP,Address:10.1.0.5,},},DaemonEndpoints:NodeDaemonEndpoints{KubeletEndpoint:DaemonEndpoint{Port:10250,},},NodeInfo:NodeSystemInfo{MachineID:capz-8a45-b775t,SystemUUID:998B47FF-53B3-4E94-92EE-87251E992BE4,BootID:,KernelVersion:10.0.20348.405,OSImage:Windows Server 2022 Datacenter,ContainerRuntimeVersion:containerd://1.6.1,KubeletVersion:v1.23.5,KubeProxyVersion:v1.23.5,OperatingSystem:windows,Architecture:amd64,},Images:[]ContainerImage{ContainerImage{Names:[docker.io/sigwindowstools/calico-install@sha256:141afecd724eb757ee41593cc73f35fb19a2ce13cad73179cf3b1cef81a637d1 docker.io/sigwindowstools/calico-install:v3.22.1-hostprocess],SizeBytes:148096127,},ContainerImage{Names:[capzci.azurecr.io/azurefile-csi@sha256:47b232ada3d11bf92017193d2c00e90a3f3947ecc5ac4e8a7e368d5fb87907fd capzci.azurecr.io/azurefile-csi:e2e-07bfd478d868c055f36b20367e57ff932dd3f619],SizeBytes:130302144,},ContainerImage{Names:[docker.io/sigwindowstools/calico-node@sha256:b8e6e2f190e58d6b61b7f2a19b0e2e17a377e5b9d7b9528e9b7953d9f9ab59bb docker.io/sigwindowstools/calico-node:v3.22.1-hostprocess],SizeBytes:128793648,},ContainerImage{Names:[mcr.microsoft.com/oss/kubernetes-csi/csi-node-driver-registrar@sha256:dbec3a8166686b09b242176ab5b99e993da4126438bbce68147c3fd654f35662 mcr.microsoft.com/oss/kubernetes-csi/csi-node-driver-registrar:v2.4.0],SizeBytes:125554391,},ContainerImage{Names:[mcr.microsoft.com/oss/kubernetes-csi/livenessprobe@sha256:c96a6255c42766f6b8bb1a7cda02b0060ab1b20b2e2dafcc64ec09e7646745a6 mcr.microsoft.com/oss/kubernetes-csi/livenessprobe:v2.5.0],SizeBytes:124471446,},ContainerImage{Names:[ghcr.io/kubernetes-sigs/sig-windows/csi-proxy@sha256:96b4144986319a747ba599892454be2737aae6005d96b8e13ed481321ac3afba ghcr.io/kubernetes-sigs/sig-windows/csi-proxy:v1.0.2],SizeBytes:123925937,},ContainerImage{Names:[k8s.gcr.io/pause@sha256:3d380ca8864549e74af4b29c10f9cb0956236dfb01c40ca076fb6c37253234db k8s.gcr.io/pause:3.6],SizeBytes:119397646,},ContainerImage{Names:[docker.io/sigwindowstools/kube-proxy@sha256:0f8a44b795d1824358f24cc56f0024d18a39ae044656686596d8b7fa6d78e1fa docker.io/sigwindowstools/kube-proxy:v1.23.5-calico-hostprocess],SizeBytes:116337721,},},VolumesInUse:[],VolumesAttached:[]AttachedVolume{},Config:nil,},} Apr 22 04:02:07.754: INFO: Logging kubelet events for node capz-8a45-b775t Apr 22 04:02:07.793: INFO: Logging pods the kubelet thinks is on node capz-8a45-b775t Apr 22 04:02:07.850: INFO: calico-node-windows-5crjp started at 2022-04-22 03:11:35 +0000 UTC (1+2 container statuses recorded) Apr 22 04:02:07.851: INFO: Init container install-cni ready: true, restart count 0 Apr 22 04:02:07.851: INFO: Container calico-node-felix ready: true, restart count 1 Apr 22 04:02:07.851: INFO: Container calico-node-startup ready: true, restart count 0 Apr 22 04:02:07.851: INFO: csi-proxy-zxbhr started at 2022-04-22 03:12:36 +0000 UTC (0+1 container statuses recorded) Apr 22 04:02:07.851: INFO: Container csi-proxy ready: true, restart count 0 Apr 22 04:02:07.851: INFO: csi-azurefile-node-win-fv9jz started at 2022-04-22 03:28:13 +0000 UTC (0+3 container statuses recorded) Apr 22 04:02:07.851: INFO: Container azurefile ready: true, restart count 0 Apr 22 04:02:07.851: INFO: Container liveness-probe ready: true, restart count 0 Apr 22 04:02:07.851: INFO: Container node-driver-registrar ready: true, restart count 0 Apr 22 04:02:07.851: INFO: kube-proxy-windows-tq6rp started at 2022-04-22 03:11:35 +0000 UTC (0+1 container statuses recorded) Apr 22 04:02:07.851: INFO: Container kube-proxy ready: true, restart count 0 Apr 22 04:02:08.082: INFO: Latency metrics for node capz-8a45-b775t Apr 22 04:02:08.082: INFO: Logging node info for node capz-8a45-pzhtj Apr 22 04:02:08.118: INFO: Node Info: &Node{ObjectMeta:{capz-8a45-pzhtj ddafc1c7-e411-4bcb-9471-d504ffe910ad 7633 0 2022-04-22 03:11:25 +0000 UTC <nil> <nil> map[beta.kubernetes.io/arch:amd64 beta.kubernetes.io/instance-type:Standard_D4s_v3 beta.kubernetes.io/os:windows failure-domain.beta.kubernetes.io/region:eastus2 failure-domain.beta.kubernetes.io/zone:0 kubernetes.io/arch:amd64 kubernetes.io/hostname:capz-8a45-pzhtj kubernetes.io/os:windows node.kubernetes.io/instance-type:Standard_D4s_v3 node.kubernetes.io/windows-build:10.0.20348 topology.kubernetes.io/region:eastus2 topology.kubernetes.io/zone:0] map[cluster.x-k8s.io/cluster-name:capz-8a45pa cluster.x-k8s.io/cluster-namespace:default cluster.x-k8s.io/machine:capz-8a45pa-md-win-b5fffb599-gvkp4 cluster.x-k8s.io/owner-kind:MachineSet cluster.x-k8s.io/owner-name:capz-8a45pa-md-win-b5fffb599 csi.volume.kubernetes.io/nodeid:{"file.csi.azure.com":"capz-8a45-pzhtj"} kubeadm.alpha.kubernetes.io/cri-socket:npipe:////./pipe/containerd-containerd node.alpha.kubernetes.io/ttl:0 projectcalico.org/IPv4Address:10.1.0.4/16 projectcalico.org/IPv4VXLANTunnelAddr:192.168.59.193 projectcalico.org/VXLANTunnelMACAddr:00:15:5d:8c:1c:33 volumes.kubernetes.io/controller-managed-attach-detach:true] [] [] [{Go-http-client Update v1 2022-04-22 03:11:27 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{".":{},"f:kubeadm.alpha.kubernetes.io/cri-socket":{},"f:volumes.kubernetes.io/controller-managed-attach-detach":{}},"f:labels":{".":{},"f:beta.kubernetes.io/arch":{},"f:beta.kubernetes.io/instance-type":{},"f:beta.kubernetes.io/os":{},"f:failure-domain.beta.kubernetes.io/region":{},"f:failure-domain.beta.kubernetes.io/zone":{},"f:kubernetes.io/arch":{},"f:kubernetes.io/hostname":{},"f:kubernetes.io/os":{},"f:node.kubernetes.io/instance-type":{},"f:node.kubernetes.io/windows-build":{},"f:topology.kubernetes.io/region":{},"f:topology.kubernetes.io/zone":{}}},"f:spec":{"f:providerID":{}}} } {kube-controller-manager Update v1 2022-04-22 03:11:29 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{"f:node.alpha.kubernetes.io/ttl":{}}}} } {manager Update v1 2022-04-22 03:12:41 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{"f:cluster.x-k8s.io/cluster-name":{},"f:cluster.x-k8s.io/cluster-namespace":{},"f:cluster.x-k8s.io/machine":{},"f:cluster.x-k8s.io/owner-kind":{},"f:cluster.x-k8s.io/owner-name":{}}}} } {calico-node.exe Update v1 2022-04-22 03:13:16 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{"f:projectcalico.org/IPv4Address":{},"f:projectcalico.org/IPv4VXLANTunnelAddr":{},"f:projectcalico.org/VXLANTunnelMACAddr":{}}}} status} {Go-http-client Update v1 2022-04-22 03:29:29 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{"f:csi.volume.kubernetes.io/nodeid":{}}},"f:status":{"f:conditions":{"k:{\"type\":\"DiskPressure\"}":{"f:lastHeartbeatTime":{}},"k:{\"type\":\"MemoryPressure\"}":{"f:lastHeartbeatTime":{}},"k:{\"type\":\"PIDPressure\"}":{"f:lastHeartbeatTime":{}},"k:{\"type\":\"Ready\"}":{"f:lastHeartbeatTime":{},"f:lastTransitionTime":{},"f:message":{},"f:reason":{},"f:status":{}}},"f:images":{}}} status}]},Spec:NodeSpec{PodCIDR:,DoNotUseExternalID:,ProviderID:azure:///subscriptions/===REDACTED===/resourceGroups/capz-8a45pa/providers/Microsoft.Compute/virtualMachines/capz-8a45-pzhtj,Unschedulable:false,Taints:[]Taint{},ConfigSource:nil,PodCIDRs:[],},Status:NodeStatus{Capacity:ResourceList{attachable-volumes-azure-disk: {{8 0} {<nil>} 8 DecimalSI},cpu: {{4 0} {<nil>} 4 DecimalSI},ephemeral-storage: {{136912564224 0} {<nil>} 133703676Ki BinarySI},memory: {{17179398144 0} {<nil>} 16776756Ki BinarySI},pods: {{110 0} {<nil>} 110 DecimalSI},},Allocatable:ResourceList{attachable-volumes-azure-disk: {{8 0} {<nil>} 8 DecimalSI},cpu: {{4 0} {<nil>} 4 DecimalSI},ephemeral-storage: {{123221307598 0} {<nil>} 123221307598 DecimalSI},memory: {{17074540544 0} {<nil>} 16674356Ki BinarySI},pods: {{110 0} {<nil>} 110 DecimalSI},},Phase:,Conditions:[]NodeCondition{NodeCondition{Type:MemoryPressure,Status:False,LastHeartbeatTime:2022-04-22 03:57:54 +0000 UTC,LastTransitionTime:2022-04-22 03:11:25 +0000 UTC,Reason:KubeletHasSufficientMemory,Message:kubelet has sufficient memory available,},NodeCondition{Type:DiskPressure,Status:False,LastHeartbeatTime:2022-04-22 03:57:54 +0000 UTC,LastTransitionTime:2022-04-22 03:11:25 +0000 UTC,Reason:KubeletHasNoDiskPressure,Message:kubelet has no disk pressure,},NodeCondition{Type:PIDPressure,Status:False,LastHeartbeatTime:2022-04-22 03:57:54 +0000 UTC,LastTransitionTime:2022-04-22 03:11:25 +0000 UTC,Reason:KubeletHasSufficientPID,Message:kubelet has sufficient PID available,},NodeCondition{Type:Ready,Status:True,LastHeartbeatTime:2022-04-22 03:57:54 +0000 UTC,LastTransitionTime:2022-04-22 03:12:46 +0000 UTC,Reason:KubeletReady,Message:kubelet is posting ready status,},},Addresses:[]NodeAddress{NodeAddress{Type:Hostname,Address:capz-8a45-pzhtj,},NodeAddress{Type:InternalIP,Address:10.1.0.4,},},DaemonEndpoints:NodeDaemonEndpoints{KubeletEndpoint:DaemonEndpoint{Port:10250,},},NodeInfo:NodeSystemInfo{MachineID:capz-8a45-pzhtj,SystemUUID:5CA444EC-9BBE-4627-9CEE-7A41926E2CAA,BootID:,KernelVersion:10.0.20348.405,OSImage:Windows Server 2022 Datacenter,ContainerRuntimeVersion:containerd://1.6.1,KubeletVersion:v1.23.5,KubeProxyVersion:v1.23.5,OperatingSystem:windows,Architecture:amd64,},Images:[]ContainerImage{ContainerImage{Names:[mcr.microsoft.com/windows/servercore@sha256:378d85bd8e7388a777d25009f8523d1e95a5f544f131eaada83171045d5b2c1e mcr.microsoft.com/windows/servercore:ltsc2022],SizeBytes:2226956779,},ContainerImage{Names:[docker.io/sigwindowstools/calico-install@sha256:141afecd724eb757ee41593cc73f35fb19a2ce13cad73179cf3b1cef81a637d1 docker.io/sigwindowstools/calico-install:v3.22.1-hostprocess],SizeBytes:148096127,},ContainerImage{Names:[capzci.azurecr.io/azurefile-csi@sha256:47b232ada3d11bf92017193d2c00e90a3f3947ecc5ac4e8a7e368d5fb87907fd capzci.azurecr.io/azurefile-csi:e2e-07bfd478d868c055f36b20367e57ff932dd3f619],SizeBytes:130302144,},ContainerImage{Names:[docker.io/sigwindowstools/calico-node@sha256:b8e6e2f190e58d6b61b7f2a19b0e2e17a377e5b9d7b9528e9b7953d9f9ab59bb docker.io/sigwindowstools/calico-node:v3.22.1-hostprocess],SizeBytes:128793648,},ContainerImage{Names:[mcr.microsoft.com/oss/kubernetes-csi/csi-node-driver-registrar@sha256:dbec3a8166686b09b242176ab5b99e993da4126438bbce68147c3fd654f35662 mcr.microsoft.com/oss/kubernetes-csi/csi-node-driver-registrar:v2.4.0],SizeBytes:125554391,},ContainerImage{Names:[mcr.microsoft.com/oss/kubernetes-csi/livenessprobe@sha256:c96a6255c42766f6b8bb1a7cda02b0060ab1b20b2e2dafcc64ec09e7646745a6 mcr.microsoft.com/oss/kubernetes-csi/livenessprobe:v2.5.0],SizeBytes:124471446,},ContainerImage{Names:[ghcr.io/kubernetes-sigs/sig-windows/csi-proxy@sha256:96b4144986319a747ba599892454be2737aae6005d96b8e13ed481321ac3afba ghcr.io/kubernetes-sigs/sig-windows/csi-proxy:v1.0.2],SizeBytes:123925937,},ContainerImage{Names:[k8s.gcr.io/pause@sha256:3d380ca8864549e74af4b29c10f9cb0956236dfb01c40ca076fb6c37253234db k8s.gcr.io/pause:3.6],SizeBytes:119397646,},ContainerImage{Names:[docker.io/sigwindowstools/kube-proxy@sha256:0f8a44b795d1824358f24cc56f0024d18a39ae044656686596d8b7fa6d78e1fa docker.io/sigwindowstools/kube-proxy:v1.23.5-calico-hostprocess],SizeBytes:116337721,},},VolumesInUse:[],VolumesAttached:[]AttachedVolume{},Config:nil,},} Apr 22 04:02:08.119: INFO: Logging kubelet events for node capz-8a45-pzhtj Apr 22 04:02:08.156: INFO: Logging pods the kubelet thinks is on node capz-8a45-pzhtj Apr 22 04:02:08.201: INFO: csi-proxy-cnsgc started at 2022-04-22 03:12:46 +0000 UTC (0+1 container statuses recorded) Apr 22 04:02:08.201: INFO: Container csi-proxy ready: true, restart count 0 Apr 22 04:02:08.201: INFO: csi-azurefile-node-win-8496k started at 2022-04-22 03:28:13 +0000 UTC (0+3 container statuses recorded) Apr 22 04:02:08.201: INFO: Container azurefile ready: true, restart count 0 Apr 22 04:02:08.201: INFO: Container liveness-probe ready: true, restart count 0 Apr 22 04:02:08.201: INFO: Container node-driver-registrar ready: true, restart count 0 Apr 22 04:02:08.201: INFO: azurefile-volume-tester-s5gj6 started at 2022-04-22 03:47:07 +0000 UTC (0+1 container statuses recorded) Apr 22 04:02:08.201: INFO: Container volume-tester ready: false, restart count 0 Apr 22 04:02:08.201: INFO: kube-proxy-windows-h6c26 started at 2022-04-22 03:11:25 +0000 UTC (0+1 container statuses recorded) Apr 22 04:02:08.201: INFO: Container kube-proxy ready: true, restart count 0 Apr 22 04:02:08.201: INFO: calico-node-windows-qfnvz started at 2022-04-22 03:11:25 +0000 UTC (1+2 container statuses recorded) Apr 22 04:02:08.201: INFO: Init container install-cni ready: true, restart count 0 Apr 22 04:02:08.201: INFO: Container calico-node-felix ready: true, restart count 0 Apr 22 04:02:08.201: INFO: Container calico-node-startup ready: true, restart count 0 Apr 22 04:02:08.438: INFO: Latency metrics for node capz-8a45-pzhtj Apr 22 04:02:08.438: INFO: Logging node info for node capz-8a45pa-control-plane-cqlqm Apr 22 04:02:08.475: INFO: Node Info: &Node{ObjectMeta:{capz-8a45pa-control-plane-cqlqm e1bacca4-d09d-45ef-bb60-44a59d556b5e 7845 0 2022-04-22 03:08:34 +0000 UTC <nil> <nil> map[beta.kubernetes.io/arch:amd64 beta.kubernetes.io/instance-type:Standard_D2s_v3 beta.kubernetes.io/os:linux failure-domain.beta.kubernetes.io/region:eastus2 failure-domain.beta.kubernetes.io/zone:eastus2-1 kubernetes.io/arch:amd64 kubernetes.io/hostname:capz-8a45pa-control-plane-cqlqm kubernetes.io/os:linux node-role.kubernetes.io/control-plane: node-role.kubernetes.io/master: node.kubernetes.io/exclude-from-external-load-balancers: node.kubernetes.io/instance-type:Standard_D2s_v3 topology.kubernetes.io/region:eastus2 topology.kubernetes.io/zone:eastus2-1] map[cluster.x-k8s.io/cluster-name:capz-8a45pa cluster.x-k8s.io/cluster-namespace:default cluster.x-k8s.io/machine:capz-8a45pa-control-plane-s49xv cluster.x-k8s.io/owner-kind:KubeadmControlPlane cluster.x-k8s.io/owner-name:capz-8a45pa-control-plane kubeadm.alpha.kubernetes.io/cri-socket:/run/containerd/containerd.sock node.alpha.kubernetes.io/ttl:0 projectcalico.org/IPv4Address:10.0.0.4/16 projectcalico.org/IPv4VXLANTunnelAddr:192.168.3.0 volumes.kubernetes.io/controller-managed-attach-detach:true] [] [] [{Go-http-client Update v1 2022-04-22 03:08:40 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{".":{},"f:kubeadm.alpha.kubernetes.io/cri-socket":{},"f:volumes.kubernetes.io/controller-managed-attach-detach":{}},"f:labels":{".":{},"f:beta.kubernetes.io/arch":{},"f:beta.kubernetes.io/instance-type":{},"f:beta.kubernetes.io/os":{},"f:failure-domain.beta.kubernetes.io/region":{},"f:failure-domain.beta.kubernetes.io/zone":{},"f:kubernetes.io/arch":{},"f:kubernetes.io/hostname":{},"f:kubernetes.io/os":{},"f:node-role.kubernetes.io/control-plane":{},"f:node-role.kubernetes.io/master":{},"f:node.kubernetes.io/exclude-from-external-load-balancers":{},"f:node.kubernetes.io/instance-type":{},"f:topology.kubernetes.io/region":{},"f:topology.kubernetes.io/zone":{}}},"f:spec":{"f:providerID":{}}} } {manager Update v1 2022-04-22 03:09:08 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{"f:cluster.x-k8s.io/cluster-name":{},"f:cluster.x-k8s.io/cluster-namespace":{},"f:cluster.x-k8s.io/machine":{},"f:cluster.x-k8s.io/owner-kind":{},"f:cluster.x-k8s.io/owner-name":{}}}} } {Go-http-client Update v1 2022-04-22 03:09:16 +0000 UTC FieldsV1 {"f:status":{"f:allocatable":{"f:ephemeral-storage":{}},"f:capacity":{"f:ephemeral-storage":{}},"f:conditions":{"k:{\"type\":\"DiskPressure\"}":{"f:lastHeartbeatTime":{}},"k:{\"type\":\"MemoryPressure\"}":{"f:lastHeartbeatTime":{}},"k:{\"type\":\"PIDPressure\"}":{"f:lastHeartbeatTime":{}},"k:{\"type\":\"Ready\"}":{"f:lastHeartbeatTime":{},"f:lastTransitionTime":{},"f:message":{},"f:reason":{},"f:status":{}}},"f:images":{}}} status} {kube-controller-manager Update v1 2022-04-22 03:09:16 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{"f:node.alpha.kubernetes.io/ttl":{}}},"f:spec":{"f:taints":{}}} } {calico-node Update v1 2022-04-22 03:09:23 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{"f:projectcalico.org/IPv4Address":{},"f:projectcalico.org/IPv4VXLANTunnelAddr":{}}},"f:status":{"f:conditions":{"k:{\"type\":\"NetworkUnavailable\"}":{".":{},"f:lastHeartbeatTime":{},"f:lastTransitionTime":{},"f:message":{},"f:reason":{},"f:status":{},"f:type":{}}}}} status}]},Spec:NodeSpec{PodCIDR:,DoNotUseExternalID:,ProviderID:azure:///subscriptions/===REDACTED===/resourceGroups/capz-8a45pa/providers/Microsoft.Compute/virtualMachines/capz-8a45pa-control-plane-cqlqm,Unschedulable:false,Taints:[]Taint{Taint{Key:node-role.kubernetes.io/master,Value:,Effect:NoSchedule,TimeAdded:<nil>,},},ConfigSource:nil,PodCIDRs:[],},Status:NodeStatus{Capacity:ResourceList{attachable-volumes-azure-disk: {{4 0} {<nil>} 4 DecimalSI},cpu: {{2 0} {<nil>} 2 DecimalSI},ephemeral-storage: {{133018140672 0} {<nil>} BinarySI},hugepages-1Gi: {{0 0} {<nil>} 0 DecimalSI},hugepages-2Mi: {{0 0} {<nil>} 0 DecimalSI},memory: {{8340819968 0} {<nil>} 8145332Ki BinarySI},pods: {{110 0} {<nil>} 110 DecimalSI},},Allocatable:ResourceList{attachable-volumes-azure-disk: {{4 0} {<nil>} 4 DecimalSI},cpu: {{2 0} {<nil>} 2 DecimalSI},ephemeral-storage: {{119716326407 0} {<nil>} 119716326407 DecimalSI},hugepages-1Gi: {{0 0} {<nil>} 0 DecimalSI},hugepages-2Mi: {{0 0} {<nil>} 0 DecimalSI},memory: {{8235962368 0} {<nil>} 8042932Ki BinarySI},pods: {{110 0} {<nil>} 110 DecimalSI},},Phase:,Conditions:[]NodeCondition{NodeCondition{Type:NetworkUnavailable,Status:False,LastHeartbeatTime:2022-04-22 03:09:22 +0000 UTC,LastTransitionTime:2022-04-22 03:09:22 +0000 UTC,Reason:CalicoIsUp,Message:Calico is running on this node,},NodeCondition{Type:MemoryPressure,Status:False,LastHeartbeatTime:2022-04-22 03:59:28 +0000 UTC,LastTransitionTime:2022-04-22 03:08:13 +0000 UTC,Reason:KubeletHasSufficientMemory,Message:kubelet has sufficient memory available,},NodeCondition{Type:DiskPressure,Status:False,LastHeartbeatTime:2022-04-22 03:59:28 +0000 UTC,LastTransitionTime:2022-04-22 03:08:13 +0000 UTC,Reason:KubeletHasNoDiskPressure,Message:kubelet has no disk pressure,},NodeCondition{Type:PIDPressure,Status:False,LastHeartbeatTime:2022-04-22 03:59:28 +0000 UTC,LastTransitionTime:2022-04-22 03:08:13 +0000 UTC,Reason:KubeletHasSufficientPID,Message:kubelet has sufficient PID available,},NodeCondition{Type:Ready,Status:True,LastHeartbeatTime:2022-04-22 03:59:28 +0000 UTC,LastTransitionTime:2022-04-22 03:09:16 +0000 UTC,Reason:KubeletReady,Message:kubelet is posting ready status. AppArmor enabled,},},Addresses:[]NodeAddress{NodeAddress{Type:Hostname,Address:capz-8a45pa-control-plane-cqlqm,},NodeAddress{Type:InternalIP,Address:10.0.0.4,},},DaemonEndpoints:NodeDaemonEndpoints{KubeletEndpoint:DaemonEndpoint{Port:10250,},},NodeInfo:NodeSystemInfo{MachineID:9d60ca8e799b409f873858218da52249,SystemUUID:88815db8-a2d9-534e-9f6c-74f652c2b89d,BootID:3322475a-69df-4c7d-b2a7-dad0257fb0bf,KernelVersion:5.13.0-1017-azure,OSImage:Ubuntu 20.04.4 LTS,ContainerRuntimeVersion:containerd://1.6.1,KubeletVersion:v1.23.5,KubeProxyVersion:v1.23.5,OperatingSystem:linux,Architecture:amd64,},Images:[]ContainerImage{ContainerImage{Names:[k8s.gcr.io/etcd@sha256:64b9ea357325d5db9f8a723dcf503b5a449177b17ac87d69481e126bb724c263 k8s.gcr.io/etcd:3.5.1-0],SizeBytes:98888614,},ContainerImage{Names:[docker.io/calico/cni@sha256:2219eae79544b098119a06a8bb5608867f9ac00471592a00e2347f3ae4bea687 docker.io/calico/cni:v3.22.1],SizeBytes:80514590,},ContainerImage{Names:[capzci.azurecr.io/azurefile-csi@sha256:47b232ada3d11bf92017193d2c00e90a3f3947ecc5ac4e8a7e368d5fb87907fd capzci.azurecr.io/azurefile-csi:e2e-07bfd478d868c055f36b20367e57ff932dd3f619],SizeBytes:73271375,},ContainerImage{Names:[docker.io/calico/node@sha256:1f8ed83e5264b4206cce7e1def11bca0b3ea7d5f4eb9b0ca0dbfc8cb968ca57e docker.io/calico/node:v3.22.1],SizeBytes:69647221,},ContainerImage{Names:[mcr.microsoft.com/oss/kubernetes-csi/csi-provisioner@sha256:542c9258a1441e4927883ea73425e21f9a14043a649686bf6b51700f34c64f8e mcr.microsoft.com/oss/kubernetes-csi/csi-provisioner:v3.1.0],SizeBytes:59205633,},ContainerImage{Names:[mcr.microsoft.com/oss/kubernetes-csi/csi-resizer@sha256:ab6c2e18a4d943f2bf8688e1779622277a1d14c355c9d4bfc0d761d86c5108b3 mcr.microsoft.com/oss/kubernetes-csi/csi-resizer:v1.4.0],SizeBytes:56924121,},ContainerImage{Names:[mcr.microsoft.com/oss/kubernetes-csi/csi-attacher@sha256:19fbca01394f7ed80151731180cfde0a3367f038beae2a97cda7928034010057 mcr.microsoft.com/oss/kubernetes-csi/csi-attacher:v3.4.0],SizeBytes:56301028,},ContainerImage{Names:[docker.io/calico/kube-controllers@sha256:e42a0aba3637d123481cca14fd8314a482616593edf58f9594c9382e50498f9b docker.io/calico/kube-controllers:v3.22.1],SizeBytes:54948023,},ContainerImage{Names:[k8s.gcr.io/kube-proxy@sha256:c1f625d115fbd9a12eac615653fc81c0edb33b2b5a76d1e09d5daed11fa557c1 k8s.gcr.io/kube-proxy:v1.23.5],SizeBytes:39278412,},ContainerImage{Names:[k8s.gcr.io/kube-apiserver@sha256:ddf5bf7196eb534271f9e5d403f4da19838d5610bb5ca191001bde5f32b5492e k8s.gcr.io/kube-apiserver:v1.23.5],SizeBytes:32603217,},ContainerImage{Names:[k8s.gcr.io/kube-controller-manager@sha256:cca0fb3532abedcc95c5f64268d54da9ecc56cc4817ff08d0128941cf2b0e1a4 k8s.gcr.io/kube-controller-manager:v1.23.5],SizeBytes:30174093,},ContainerImage{Names:[mcr.microsoft.com/oss/kubernetes-csi/csi-snapshotter@sha256:a889e925e15f9423f7842f1b769f64cbcf6a20b6956122836fc835cf22d9073f mcr.microsoft.com/oss/kubernetes-csi/csi-snapshotter:v5.0.1],SizeBytes:22192414,},ContainerImage{Names:[k8s.gcr.io/kube-scheduler@sha256:489efb65da9edc40bf0911f3e6371e5bb6b8ad8fde1d55193a6cc84c2ef36626 k8s.gcr.io/kube-scheduler:v1.23.5],SizeBytes:15131395,},ContainerImage{Names:[k8s.gcr.io/coredns/coredns@sha256:5b6ec0d6de9baaf3e92d0f66cd96a25b9edbce8716f5f15dcd1a616b3abd590e k8s.gcr.io/coredns/coredns:v1.8.6],SizeBytes:13585107,},ContainerImage{Names:[docker.io/calico/pod2daemon-flexvol@sha256:35802ba083546a7c5e8b5bf0ee7ffad7f8a468e8c2b3631e7e9647512c94041d docker.io/calico/pod2daemon-flexvol:v3.22.1],SizeBytes:8462620,},ContainerImage{Names:[mcr.microsoft.com/oss/kubernetes-csi/livenessprobe@sha256:c96a6255c42766f6b8bb1a7cda02b0060ab1b20b2e2dafcc64ec09e7646745a6 mcr.microsoft.com/oss/kubernetes-csi/livenessprobe:v2.5.0],SizeBytes:8222208,},ContainerImage{Names:[k8s.gcr.io/pause@sha256:3d380ca8864549e74af4b29c10f9cb0956236dfb01c40ca076fb6c37253234db k8s.gcr.io/pause:3.6],SizeBytes:301773,},},VolumesInUse:[],VolumesAttached:[]AttachedVolume{},Config:nil,},} Apr 22 04:02:08.475: INFO: Logging kubelet events for node capz-8a45pa-control-plane-cqlqm Apr 22 04:02:08.514: INFO: Logging pods the kubelet thinks is on node capz-8a45pa-control-plane-cqlqm Apr 22 04:02:08.581: INFO: calico-node-gkjpk started at 2022-04-22 03:08:58 +0000 UTC (3+1 container statuses recorded) Apr 22 04:02:08.581: INFO: Init container upgrade-ipam ready: true, restart count 0 Apr 22 04:02:08.581: INFO: Init container install-cni ready: true, restart count 0 Apr 22 04:02:08.581: INFO: Init container flexvol-driver ready: true, restart count 0 Apr 22 04:02:08.581: INFO: Container calico-node ready: true, restart count 0 Apr 22 04:02:08.581: INFO: coredns-64897985d-pr2wd started at 2022-04-22 03:09:16 +0000 UTC (0+1 container statuses recorded) Apr 22 04:02:08.581: INFO: Container coredns ready: true, restart count 0 Apr 22 04:02:08.581: INFO: calico-kube-controllers-7c664f4648-7c59f started at 2022-04-22 03:09:16 +0000 UTC (0+1 container statuses recorded) Apr 22 04:02:08.581: INFO: Container calico-kube-controllers ready: true, restart count 0 Apr 22 04:02:08.581: INFO: coredns-64897985d-7t4hq started at 2022-04-22 03:09:16 +0000 UTC (0+1 container statuses recorded) Apr 22 04:02:08.581: INFO: Container coredns ready: true, restart count 0 Apr 22 04:02:08.581: INFO: kube-controller-manager-capz-8a45pa-control-plane-cqlqm started at 2022-04-22 03:08:46 +0000 UTC (0+1 container statuses recorded) Apr 22 04:02:08.581: INFO: Container kube-controller-manager ready: true, restart count 0 Apr 22 04:02:08.581: INFO: kube-apiserver-capz-8a45pa-control-plane-cqlqm started at 2022-04-22 03:08:47 +0000 UTC (0+1 container statuses recorded) Apr 22 04:02:08.581: INFO: Container kube-apiserver ready: true, restart count 0 Apr 22 04:02:08.581: INFO: kube-proxy-dgbs5 started at 2022-04-22 03:08:47 +0000 UTC (0+1 container statuses recorded) Apr 22 04:02:08.581: INFO: Container kube-proxy ready: true, restart count 0 Apr 22 04:02:08.581: INFO: csi-azurefile-controller-66dd57cd58-4tn67 started at 2022-04-22 03:28:13 +0000 UTC (0+6 container statuses recorded) Apr 22 04:02:08.581: INFO: Container azurefile ready: true, restart count 0 Apr 22 04:02:08.581: INFO: Container csi-attacher ready: true, restart count 0 Apr 22 04:02:08.581: INFO: Container csi-provisioner ready: true, restart count 0 Apr 22 04:02:08.581: INFO: Container csi-resizer ready: true, restart count 0 Apr 22 04:02:08.581: INFO: Container csi-snapshotter ready: true, restart count 0 Apr 22 04:02:08.581: INFO: Container liveness-probe ready: true, restart count 0 Apr 22 04:02:08.581: INFO: kube-scheduler-capz-8a45pa-control-plane-cqlqm started at 2022-04-22 03:08:47 +0000 UTC (0+1 container statuses recorded) Apr 22 04:02:08.581: INFO: Container kube-scheduler ready: true, restart count 0 Apr 22 04:02:08.581: INFO: etcd-capz-8a45pa-control-plane-cqlqm started at 2022-04-22 03:08:47 +0000 UTC (0+1 container statuses recorded) Apr 22 04:02:08.581: INFO: Container etcd ready: true, restart count 0 Apr 22 04:02:08.785: INFO: Latency metrics for node capz-8a45pa-control-plane-cqlqm Apr 22 04:02:08.785: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready �[1mSTEP�[0m: Destroying namespace "azurefile-1166" for this suite.
Find azurefile-volume-tester-s5gj6 mentions in log files | View test history on testgrid
AzureFile CSI Driver End-to-End Tests Dynamic Provisioning should create a deployment object, write and read to it, delete the pod and write and read to it again [kubernetes.io/azure-file] [file.csi.azure.com] [Windows]
AzureFile CSI Driver End-to-End Tests Dynamic Provisioning should create a pod with multiple volumes [kubernetes.io/azure-file] [file.csi.azure.com] [Windows]
AzureFile CSI Driver End-to-End Tests Dynamic Provisioning should create a pod with volume mount subpath [file.csi.azure.com] [Windows]
AzureFile CSI Driver End-to-End Tests Dynamic Provisioning should create a storage account with tags [file.csi.azure.com] [Windows]
AzureFile CSI Driver End-to-End Tests Dynamic Provisioning should create a volume on demand and mount it as readOnly in a pod [kubernetes.io/azure-file] [file.csi.azure.com] [Windows]
AzureFile CSI Driver End-to-End Tests Dynamic Provisioning should create a volume on demand and resize it [kubernetes.io/azure-file] [file.csi.azure.com] [Windows]
AzureFile CSI Driver End-to-End Tests Dynamic Provisioning should create a volume on demand with mount options (Bring Your Own Key) [file.csi.azure.com] [Windows]
AzureFile CSI Driver End-to-End Tests Dynamic Provisioning should create a volume on demand with useDataPlaneAPI [file.csi.azure.com] [Windows]
AzureFile CSI Driver End-to-End Tests Dynamic Provisioning should create an CSI inline volume [file.csi.azure.com]
AzureFile CSI Driver End-to-End Tests Dynamic Provisioning should create multiple PV objects, bind to PVCs and attach all to different pods on the same node [kubernetes.io/azure-file] [file.csi.azure.com] [Windows]
AzureFile CSI Driver End-to-End Tests Dynamic Provisioning should delete PV with reclaimPolicy "Delete" [kubernetes.io/azure-file] [file.csi.azure.com] [Windows]
AzureFile CSI Driver End-to-End Tests Dynamic Provisioning should retain PV with reclaimPolicy "Retain" [file.csi.azure.com] [Windows]
AzureFile CSI Driver End-to-End Tests Pre-Provisioned should use a pre-provisioned volume and mount it as readOnly in a pod [file.csi.azure.com] [Windows]
AzureFile CSI Driver End-to-End Tests Pre-Provisioned should use a pre-provisioned volume and mount it by multiple pods [file.csi.azure.com] [Windows]
AzureFile CSI Driver End-to-End Tests Pre-Provisioned should use a pre-provisioned volume and retain PV with reclaimPolicy "Retain" [file.csi.azure.com] [Windows]
AzureFile CSI Driver End-to-End Tests Pre-Provisioned should use existing credentials in k8s cluster [file.csi.azure.com] [Windows]
AzureFile CSI Driver End-to-End Tests Pre-Provisioned should use provided credentials [file.csi.azure.com] [Windows]
AzureFile CSI Driver End-to-End Tests Dynamic Provisioning [env] should retain PV with reclaimPolicy "Retain" [file.csi.azure.com] [disk]
AzureFile CSI Driver End-to-End Tests Dynamic Provisioning should create a NFS volume on demand on a storage account with private endpoint [file.csi.azure.com] [nfs]
AzureFile CSI Driver End-to-End Tests Dynamic Provisioning should create a NFS volume on demand with mount options [file.csi.azure.com] [nfs]
AzureFile CSI Driver End-to-End Tests Dynamic Provisioning should create a deployment object, write and read to it, delete the pod and write and read to it again [file.csi.azure.com] [disk]
AzureFile CSI Driver End-to-End Tests Dynamic Provisioning should create a pod with multiple NFS volumes [file.csi.azure.com]
AzureFile CSI Driver End-to-End Tests Dynamic Provisioning should create a pod, write and read to it, take a volume snapshot, and validate whether it is ready to use [file.csi.azure.com]
AzureFile CSI Driver End-to-End Tests Dynamic Provisioning should create a vhd disk volume on demand [kubernetes.io/azure-file] [file.csi.azure.com][disk]
AzureFile CSI Driver End-to-End Tests Dynamic Provisioning should create a vhd disk volume on demand and mount it as readOnly in a pod [file.csi.azure.com][disk]
AzureFile CSI Driver End-to-End Tests Dynamic Provisioning should create a volume after driver restart [kubernetes.io/azure-file] [file.csi.azure.com]
AzureFile CSI Driver End-to-End Tests Dynamic Provisioning should create an inline volume by in-tree driver [kubernetes.io/azure-file]
AzureFile CSI Driver End-to-End Tests Dynamic Provisioning should create multiple PV objects, bind to PVCs and attach all to different pods on the same node [file.csi.azure.com][disk]
AzureFile CSI Driver End-to-End Tests Dynamic Provisioning should delete PV with reclaimPolicy "Delete" [file.csi.azure.com] [disk]
AzureFile CSI Driver End-to-End Tests Dynamic Provisioning should receive FailedMount event with invalid mount options [file.csi.azure.com] [disk]
AzureFile CSI Driver End-to-End Tests Dynamic Provisioning should receive FailedMount event with invalid mount options [file.csi.azure.com] [disk]