This job view page is being replaced by Spyglass soon. Check out the new job view.
PRandyzhangx: fix: create snapshot on external resource group failure
ResultFAILURE
Tests 0 failed / 0 succeeded
Started2020-09-09 13:36
Elapsed40m4s
Revisiond37b5e335a424ebb7c422421078f6848701812ad
Refs 532

No Test Failures!


Error lines from build-log.txt

... skipping 61 lines ...

  0     0    0     0    0     0      0      0 --:--:-- --:--:-- --:--:--     0
100 11213  100 11213    0     0   142k      0 --:--:-- --:--:-- --:--:--  144k
Downloading https://get.helm.sh/helm-v3.3.1-linux-amd64.tar.gz
Verifying checksum... Done.
Preparing to install helm into /usr/local/bin
helm installed into /usr/local/bin/helm
docker pull k8sprow.azurecr.io/azuredisk-csi:e2e-35f35defd2eafed8c9d75641ee57880267c525f7 || make azuredisk-container push
Error response from daemon: manifest for k8sprow.azurecr.io/azuredisk-csi:e2e-35f35defd2eafed8c9d75641ee57880267c525f7 not found: manifest unknown: manifest tagged by "e2e-35f35defd2eafed8c9d75641ee57880267c525f7" is not found
make[2]: Entering directory '/home/prow/go/src/sigs.k8s.io/azuredisk-csi-driver'
CGO_ENABLED=0 GOOS=linux go build -a -ldflags "-X sigs.k8s.io/azuredisk-csi-driver/pkg/azuredisk.driverVersion=e2e-35f35defd2eafed8c9d75641ee57880267c525f7 -X sigs.k8s.io/azuredisk-csi-driver/pkg/azuredisk.gitCommit=35f35defd2eafed8c9d75641ee57880267c525f7 -X sigs.k8s.io/azuredisk-csi-driver/pkg/azuredisk.buildDate=2020-09-09T13:45:50Z -X sigs.k8s.io/azuredisk-csi-driver/pkg/azuredisk.DriverName=disk.csi.azure.com -X sigs.k8s.io/azuredisk-csi-driver/pkg/azuredisk.topologyKey=topology.disk.csi.azure.com/zone -extldflags "-static"" -o _output/azurediskplugin ./pkg/azurediskplugin
CGO_ENABLED=0 GOOS=windows go build -a -ldflags "-X sigs.k8s.io/azuredisk-csi-driver/pkg/azuredisk.driverVersion=e2e-35f35defd2eafed8c9d75641ee57880267c525f7 -X sigs.k8s.io/azuredisk-csi-driver/pkg/azuredisk.gitCommit=35f35defd2eafed8c9d75641ee57880267c525f7 -X sigs.k8s.io/azuredisk-csi-driver/pkg/azuredisk.buildDate=2020-09-09T13:46:40Z -X sigs.k8s.io/azuredisk-csi-driver/pkg/azuredisk.DriverName=disk.csi.azure.com -X sigs.k8s.io/azuredisk-csi-driver/pkg/azuredisk.topologyKey=topology.disk.csi.azure.com/zone -extldflags "-static"" -o _output/azurediskplugin.exe ./pkg/azurediskplugin
docker buildx rm container-builder || true
no builder "container-builder" found
docker buildx create --use --name=container-builder
... skipping 1267 lines ...
Go Version: go1.15
Platform: linux/amd64
Topology Key: N/A

Streaming logs below:
STEP: Building a namespace api object, basename azuredisk
W0909 13:53:41.257739   12634 azure_config.go:52] Failed to get cloud-config from secret: failed to get secret azure-cloud-provider: secrets "azure-cloud-provider" not found, skip initializing from secret
I0909 13:53:41.258656   12634 azuredisk.go:110] disable UseInstanceMetadata for controller
I0909 13:53:41.259026   12634 driver.go:80] Enabling controller service capability: CREATE_DELETE_VOLUME
I0909 13:53:41.259044   12634 driver.go:80] Enabling controller service capability: PUBLISH_UNPUBLISH_VOLUME
I0909 13:53:41.259050   12634 driver.go:80] Enabling controller service capability: CREATE_DELETE_SNAPSHOT
I0909 13:53:41.259057   12634 driver.go:80] Enabling controller service capability: LIST_SNAPSHOTS
I0909 13:53:41.259062   12634 driver.go:80] Enabling controller service capability: CLONE_VOLUME
... skipping 15 lines ...
Sep  9 13:53:46.719: INFO: Waiting up to 5m0s for PersistentVolumeClaims [pvc-rcs7m] to have phase Bound
Sep  9 13:53:46.770: INFO: PersistentVolumeClaim pvc-rcs7m found and phase=Bound (51.499587ms)
STEP: checking the PVC
STEP: validating provisioned PV
STEP: checking the PV
STEP: deploying the pod
STEP: checking that the pod's command exits with an error
Sep  9 13:53:46.926: INFO: Waiting up to 10m0s for pod "azuredisk-volume-tester-thgcc" in namespace "azuredisk-8047" to be "Error status code"
Sep  9 13:53:46.979: INFO: Pod "azuredisk-volume-tester-thgcc": Phase="Pending", Reason="", readiness=false. Elapsed: 53.32805ms
Sep  9 13:53:49.033: INFO: Pod "azuredisk-volume-tester-thgcc": Phase="Pending", Reason="", readiness=false. Elapsed: 2.1065063s
Sep  9 13:53:51.087: INFO: Pod "azuredisk-volume-tester-thgcc": Phase="Pending", Reason="", readiness=false. Elapsed: 4.161030071s
Sep  9 13:53:53.140: INFO: Pod "azuredisk-volume-tester-thgcc": Phase="Pending", Reason="", readiness=false. Elapsed: 6.213825509s
Sep  9 13:53:55.192: INFO: Pod "azuredisk-volume-tester-thgcc": Phase="Pending", Reason="", readiness=false. Elapsed: 8.266194923s
Sep  9 13:53:57.244: INFO: Pod "azuredisk-volume-tester-thgcc": Phase="Pending", Reason="", readiness=false. Elapsed: 10.317910209s
... skipping 152 lines ...
Sep  9 13:59:11.276: INFO: Pod "azuredisk-volume-tester-thgcc": Phase="Pending", Reason="", readiness=false. Elapsed: 5m24.349521865s
Sep  9 13:59:13.328: INFO: Pod "azuredisk-volume-tester-thgcc": Phase="Pending", Reason="", readiness=false. Elapsed: 5m26.401654037s
Sep  9 13:59:15.380: INFO: Pod "azuredisk-volume-tester-thgcc": Phase="Pending", Reason="", readiness=false. Elapsed: 5m28.453525889s
Sep  9 13:59:17.431: INFO: Pod "azuredisk-volume-tester-thgcc": Phase="Pending", Reason="", readiness=false. Elapsed: 5m30.504737677s
Sep  9 13:59:19.484: INFO: Pod "azuredisk-volume-tester-thgcc": Phase="Pending", Reason="", readiness=false. Elapsed: 5m32.557708567s
Sep  9 13:59:21.535: INFO: Pod "azuredisk-volume-tester-thgcc": Phase="Pending", Reason="", readiness=false. Elapsed: 5m34.608962372s
Sep  9 13:59:23.587: INFO: Pod "azuredisk-volume-tester-thgcc": Phase="Failed", Reason="", readiness=false. Elapsed: 5m36.660554223s
STEP: Saw pod failure
Sep  9 13:59:23.587: INFO: Pod "azuredisk-volume-tester-thgcc" satisfied condition "Error status code"
STEP: checking that pod logs contain expected message
Sep  9 13:59:23.761: INFO: deleting Pod "azuredisk-8047"/"azuredisk-volume-tester-thgcc"
Sep  9 13:59:23.841: INFO: Pod azuredisk-volume-tester-thgcc has the following logs: Out-File : Access to the path 'C:\mnt\test-1\data.txt' is denied.
At line:1 char:22
+ ... cho 'hello world' | Out-File -FilePath C:\mnt\test-1\data.txt; Get-Co ...
+                         ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~
... skipping 96 lines ...
  [single-az]
  /home/prow/go/src/sigs.k8s.io/azuredisk-csi-driver/test/e2e/pre_provisioning_test.go:67
    should succeed when creating a shared disk [disk.csi.azure.com][windows]
    /home/prow/go/src/sigs.k8s.io/azuredisk-csi-driver/test/e2e/pre_provisioning_test.go:138
------------------------------
Pre-Provisioned [single-az] 
  should fail when maxShares is invalid [disk.csi.azure.com][windows]
  /home/prow/go/src/sigs.k8s.io/azuredisk-csi-driver/test/e2e/pre_provisioning_test.go:157
STEP: Creating a kubernetes client
Sep  9 14:00:09.701: INFO: >>> kubeConfig: /root/tmp362127304/kubeconfig/kubeconfig.westus2.json
STEP: Building a namespace api object, basename azuredisk
STEP: Binding the e2e-test-privileged-psp PodSecurityPolicy to the default service account in azuredisk-5094
STEP: Waiting for a default service account to be provisioned in namespace
... skipping 21 lines ...
Sep  9 14:00:13.777: INFO: Waiting up to 5m0s for PersistentVolumeClaims [pvc-5tdtl] to have phase Bound
Sep  9 14:00:13.828: INFO: PersistentVolumeClaim pvc-5tdtl found and phase=Bound (51.204819ms)
STEP: checking the PVC
STEP: validating provisioned PV
STEP: checking the PV
STEP: deploying the pod
STEP: checking that the pod's command exits with no error
Sep  9 14:00:13.984: INFO: Waiting up to 15m0s for pod "azuredisk-volume-tester-cbrf4" in namespace "azuredisk-1577" to be "Succeeded or Failed"
Sep  9 14:00:14.040: INFO: Pod "azuredisk-volume-tester-cbrf4": Phase="Pending", Reason="", readiness=false. Elapsed: 55.3529ms
Sep  9 14:00:16.091: INFO: Pod "azuredisk-volume-tester-cbrf4": Phase="Pending", Reason="", readiness=false. Elapsed: 2.106546761s
Sep  9 14:00:18.143: INFO: Pod "azuredisk-volume-tester-cbrf4": Phase="Pending", Reason="", readiness=false. Elapsed: 4.158327047s
Sep  9 14:00:20.195: INFO: Pod "azuredisk-volume-tester-cbrf4": Phase="Pending", Reason="", readiness=false. Elapsed: 6.210020695s
Sep  9 14:00:22.246: INFO: Pod "azuredisk-volume-tester-cbrf4": Phase="Pending", Reason="", readiness=false. Elapsed: 8.261446339s
Sep  9 14:00:24.298: INFO: Pod "azuredisk-volume-tester-cbrf4": Phase="Pending", Reason="", readiness=false. Elapsed: 10.313433548s
... skipping 16 lines ...
Sep  9 14:00:59.184: INFO: Pod "azuredisk-volume-tester-cbrf4": Phase="Pending", Reason="", readiness=false. Elapsed: 45.199899535s
Sep  9 14:01:01.238: INFO: Pod "azuredisk-volume-tester-cbrf4": Phase="Pending", Reason="", readiness=false. Elapsed: 47.253678095s
Sep  9 14:01:03.293: INFO: Pod "azuredisk-volume-tester-cbrf4": Phase="Pending", Reason="", readiness=false. Elapsed: 49.308565384s
Sep  9 14:01:05.344: INFO: Pod "azuredisk-volume-tester-cbrf4": Phase="Pending", Reason="", readiness=false. Elapsed: 51.359079648s
Sep  9 14:01:07.396: INFO: Pod "azuredisk-volume-tester-cbrf4": Phase="Succeeded", Reason="", readiness=false. Elapsed: 53.411245779s
STEP: Saw pod success
Sep  9 14:01:07.396: INFO: Pod "azuredisk-volume-tester-cbrf4" satisfied condition "Succeeded or Failed"
STEP: setting up the PV
STEP: creating a PV
STEP: setting up the PVC
STEP: creating a PVC
STEP: waiting for PVC to be in phase "Bound"
Sep  9 14:01:07.512: INFO: Waiting up to 5m0s for PersistentVolumeClaims [pvc-vzfql] to have phase Bound
Sep  9 14:01:07.567: INFO: PersistentVolumeClaim pvc-vzfql found and phase=Bound (54.816898ms)
STEP: checking the PVC
STEP: validating provisioned PV
STEP: checking the PV
STEP: deploying the pod
STEP: checking that the pod's command exits with no error
Sep  9 14:01:07.722: INFO: Waiting up to 15m0s for pod "azuredisk-volume-tester-hz67k" in namespace "azuredisk-1577" to be "Succeeded or Failed"
Sep  9 14:01:07.773: INFO: Pod "azuredisk-volume-tester-hz67k": Phase="Pending", Reason="", readiness=false. Elapsed: 50.639191ms
Sep  9 14:01:09.824: INFO: Pod "azuredisk-volume-tester-hz67k": Phase="Pending", Reason="", readiness=false. Elapsed: 2.102320137s
Sep  9 14:01:11.876: INFO: Pod "azuredisk-volume-tester-hz67k": Phase="Pending", Reason="", readiness=false. Elapsed: 4.154024258s
Sep  9 14:01:13.928: INFO: Pod "azuredisk-volume-tester-hz67k": Phase="Pending", Reason="", readiness=false. Elapsed: 6.205628323s
Sep  9 14:01:15.980: INFO: Pod "azuredisk-volume-tester-hz67k": Phase="Pending", Reason="", readiness=false. Elapsed: 8.257898012s
Sep  9 14:01:18.032: INFO: Pod "azuredisk-volume-tester-hz67k": Phase="Pending", Reason="", readiness=false. Elapsed: 10.309661645s
... skipping 11 lines ...
Sep  9 14:01:42.666: INFO: Pod "azuredisk-volume-tester-hz67k": Phase="Pending", Reason="", readiness=false. Elapsed: 34.94451297s
Sep  9 14:01:44.719: INFO: Pod "azuredisk-volume-tester-hz67k": Phase="Pending", Reason="", readiness=false. Elapsed: 36.996881344s
Sep  9 14:01:46.770: INFO: Pod "azuredisk-volume-tester-hz67k": Phase="Pending", Reason="", readiness=false. Elapsed: 39.047646192s
Sep  9 14:01:48.821: INFO: Pod "azuredisk-volume-tester-hz67k": Phase="Pending", Reason="", readiness=false. Elapsed: 41.099036728s
Sep  9 14:01:50.874: INFO: Pod "azuredisk-volume-tester-hz67k": Phase="Succeeded", Reason="", readiness=false. Elapsed: 43.152168077s
STEP: Saw pod success
Sep  9 14:01:50.874: INFO: Pod "azuredisk-volume-tester-hz67k" satisfied condition "Succeeded or Failed"
STEP: setting up the PV
STEP: creating a PV
STEP: setting up the PVC
STEP: creating a PVC
STEP: waiting for PVC to be in phase "Bound"
Sep  9 14:01:51.005: INFO: Waiting up to 5m0s for PersistentVolumeClaims [pvc-84j96] to have phase Bound
Sep  9 14:01:51.056: INFO: PersistentVolumeClaim pvc-84j96 found and phase=Bound (50.498612ms)
STEP: checking the PVC
STEP: validating provisioned PV
STEP: checking the PV
STEP: deploying the pod
STEP: checking that the pod's command exits with no error
Sep  9 14:01:51.216: INFO: Waiting up to 15m0s for pod "azuredisk-volume-tester-trqn7" in namespace "azuredisk-1577" to be "Succeeded or Failed"
Sep  9 14:01:51.267: INFO: Pod "azuredisk-volume-tester-trqn7": Phase="Pending", Reason="", readiness=false. Elapsed: 50.404311ms
Sep  9 14:01:53.318: INFO: Pod "azuredisk-volume-tester-trqn7": Phase="Pending", Reason="", readiness=false. Elapsed: 2.102072936s
Sep  9 14:01:55.369: INFO: Pod "azuredisk-volume-tester-trqn7": Phase="Pending", Reason="", readiness=false. Elapsed: 4.152558182s
Sep  9 14:01:57.420: INFO: Pod "azuredisk-volume-tester-trqn7": Phase="Pending", Reason="", readiness=false. Elapsed: 6.204081448s
Sep  9 14:01:59.474: INFO: Pod "azuredisk-volume-tester-trqn7": Phase="Pending", Reason="", readiness=false. Elapsed: 8.257814802s
Sep  9 14:02:01.526: INFO: Pod "azuredisk-volume-tester-trqn7": Phase="Pending", Reason="", readiness=false. Elapsed: 10.310042653s
... skipping 6 lines ...
Sep  9 14:02:15.891: INFO: Pod "azuredisk-volume-tester-trqn7": Phase="Pending", Reason="", readiness=false. Elapsed: 24.67435166s
Sep  9 14:02:17.949: INFO: Pod "azuredisk-volume-tester-trqn7": Phase="Pending", Reason="", readiness=false. Elapsed: 26.733214698s
Sep  9 14:02:20.001: INFO: Pod "azuredisk-volume-tester-trqn7": Phase="Pending", Reason="", readiness=false. Elapsed: 28.784809418s
Sep  9 14:02:22.053: INFO: Pod "azuredisk-volume-tester-trqn7": Phase="Pending", Reason="", readiness=false. Elapsed: 30.836764262s
Sep  9 14:02:24.105: INFO: Pod "azuredisk-volume-tester-trqn7": Phase="Succeeded", Reason="", readiness=false. Elapsed: 32.888437826s
STEP: Saw pod success
Sep  9 14:02:24.105: INFO: Pod "azuredisk-volume-tester-trqn7" satisfied condition "Succeeded or Failed"
STEP: setting up the PV
STEP: creating a PV
STEP: setting up the PVC
STEP: creating a PVC
STEP: waiting for PVC to be in phase "Bound"
Sep  9 14:02:24.215: INFO: Waiting up to 5m0s for PersistentVolumeClaims [pvc-rq9fd] to have phase Bound
Sep  9 14:02:24.266: INFO: PersistentVolumeClaim pvc-rq9fd found and phase=Bound (50.836246ms)
STEP: checking the PVC
STEP: validating provisioned PV
STEP: checking the PV
STEP: deploying the pod
STEP: checking that the pod's command exits with no error
Sep  9 14:02:24.447: INFO: Waiting up to 15m0s for pod "azuredisk-volume-tester-46vxm" in namespace "azuredisk-1577" to be "Succeeded or Failed"
Sep  9 14:02:24.500: INFO: Pod "azuredisk-volume-tester-46vxm": Phase="Pending", Reason="", readiness=false. Elapsed: 53.024248ms
Sep  9 14:02:26.553: INFO: Pod "azuredisk-volume-tester-46vxm": Phase="Pending", Reason="", readiness=false. Elapsed: 2.106183049s
Sep  9 14:02:28.606: INFO: Pod "azuredisk-volume-tester-46vxm": Phase="Pending", Reason="", readiness=false. Elapsed: 4.158845939s
Sep  9 14:02:30.657: INFO: Pod "azuredisk-volume-tester-46vxm": Phase="Pending", Reason="", readiness=false. Elapsed: 6.210311975s
Sep  9 14:02:32.709: INFO: Pod "azuredisk-volume-tester-46vxm": Phase="Pending", Reason="", readiness=false. Elapsed: 8.262176633s
Sep  9 14:02:34.764: INFO: Pod "azuredisk-volume-tester-46vxm": Phase="Pending", Reason="", readiness=false. Elapsed: 10.316642012s
... skipping 5 lines ...
Sep  9 14:02:47.077: INFO: Pod "azuredisk-volume-tester-46vxm": Phase="Pending", Reason="", readiness=false. Elapsed: 22.629848497s
Sep  9 14:02:49.132: INFO: Pod "azuredisk-volume-tester-46vxm": Phase="Pending", Reason="", readiness=false. Elapsed: 24.684854582s
Sep  9 14:02:51.184: INFO: Pod "azuredisk-volume-tester-46vxm": Phase="Pending", Reason="", readiness=false. Elapsed: 26.736491515s
Sep  9 14:02:53.235: INFO: Pod "azuredisk-volume-tester-46vxm": Phase="Pending", Reason="", readiness=false. Elapsed: 28.787991619s
Sep  9 14:02:55.287: INFO: Pod "azuredisk-volume-tester-46vxm": Phase="Succeeded", Reason="", readiness=false. Elapsed: 30.839682624s
STEP: Saw pod success
Sep  9 14:02:55.287: INFO: Pod "azuredisk-volume-tester-46vxm" satisfied condition "Succeeded or Failed"
STEP: setting up the PV
STEP: creating a PV
STEP: setting up the PVC
STEP: creating a PVC
STEP: waiting for PVC to be in phase "Bound"
Sep  9 14:02:55.394: INFO: Waiting up to 5m0s for PersistentVolumeClaims [pvc-4wjrg] to have phase Bound
Sep  9 14:02:55.444: INFO: PersistentVolumeClaim pvc-4wjrg found and phase=Bound (50.085039ms)
STEP: checking the PVC
STEP: validating provisioned PV
STEP: checking the PV
STEP: deploying the pod
STEP: checking that the pod's command exits with no error
Sep  9 14:02:55.601: INFO: Waiting up to 15m0s for pod "azuredisk-volume-tester-jbrr2" in namespace "azuredisk-1577" to be "Succeeded or Failed"
Sep  9 14:02:55.653: INFO: Pod "azuredisk-volume-tester-jbrr2": Phase="Pending", Reason="", readiness=false. Elapsed: 51.309432ms
Sep  9 14:02:57.704: INFO: Pod "azuredisk-volume-tester-jbrr2": Phase="Pending", Reason="", readiness=false. Elapsed: 2.102421313s
Sep  9 14:02:59.756: INFO: Pod "azuredisk-volume-tester-jbrr2": Phase="Pending", Reason="", readiness=false. Elapsed: 4.154298839s
Sep  9 14:03:01.809: INFO: Pod "azuredisk-volume-tester-jbrr2": Phase="Pending", Reason="", readiness=false. Elapsed: 6.207658543s
Sep  9 14:03:03.861: INFO: Pod "azuredisk-volume-tester-jbrr2": Phase="Pending", Reason="", readiness=false. Elapsed: 8.259243719s
Sep  9 14:03:05.912: INFO: Pod "azuredisk-volume-tester-jbrr2": Phase="Pending", Reason="", readiness=false. Elapsed: 10.31059476s
... skipping 4 lines ...
Sep  9 14:03:16.171: INFO: Pod "azuredisk-volume-tester-jbrr2": Phase="Pending", Reason="", readiness=false. Elapsed: 20.569297381s
Sep  9 14:03:18.222: INFO: Pod "azuredisk-volume-tester-jbrr2": Phase="Pending", Reason="", readiness=false. Elapsed: 22.620800102s
Sep  9 14:03:20.275: INFO: Pod "azuredisk-volume-tester-jbrr2": Phase="Pending", Reason="", readiness=false. Elapsed: 24.673211555s
Sep  9 14:03:22.327: INFO: Pod "azuredisk-volume-tester-jbrr2": Phase="Pending", Reason="", readiness=false. Elapsed: 26.72550983s
Sep  9 14:03:24.379: INFO: Pod "azuredisk-volume-tester-jbrr2": Phase="Succeeded", Reason="", readiness=false. Elapsed: 28.777081944s
STEP: Saw pod success
Sep  9 14:03:24.379: INFO: Pod "azuredisk-volume-tester-jbrr2" satisfied condition "Succeeded or Failed"
Sep  9 14:03:24.379: INFO: deleting Pod "azuredisk-1577"/"azuredisk-volume-tester-jbrr2"
Sep  9 14:03:24.472: INFO: Pod azuredisk-volume-tester-jbrr2 has the following logs: hello world

STEP: Deleting pod azuredisk-volume-tester-jbrr2 in namespace azuredisk-1577
Sep  9 14:03:24.539: INFO: deleting PVC "azuredisk-1577"/"pvc-4wjrg"
Sep  9 14:03:24.539: INFO: Deleting PersistentVolumeClaim "pvc-4wjrg"
... skipping 97 lines ...
Sep  9 14:03:57.697: INFO: PersistentVolumeClaim pvc-trzmb found and phase=Bound (4.184136942s)
STEP: checking the PVC
STEP: validating provisioned PV
STEP: checking the PV
STEP: setting up the pod
STEP: deploying the pod
STEP: checking that the pod's command exits with no error
Sep  9 14:03:57.854: INFO: Waiting up to 15m0s for pod "azuredisk-volume-tester-lmjm6" in namespace "azuredisk-7463" to be "Succeeded or Failed"
Sep  9 14:03:57.904: INFO: Pod "azuredisk-volume-tester-lmjm6": Phase="Pending", Reason="", readiness=false. Elapsed: 50.313331ms
Sep  9 14:03:59.956: INFO: Pod "azuredisk-volume-tester-lmjm6": Phase="Pending", Reason="", readiness=false. Elapsed: 2.102699625s
Sep  9 14:04:02.009: INFO: Pod "azuredisk-volume-tester-lmjm6": Phase="Pending", Reason="", readiness=false. Elapsed: 4.155680123s
Sep  9 14:04:04.062: INFO: Pod "azuredisk-volume-tester-lmjm6": Phase="Pending", Reason="", readiness=false. Elapsed: 6.208322189s
Sep  9 14:04:06.115: INFO: Pod "azuredisk-volume-tester-lmjm6": Phase="Pending", Reason="", readiness=false. Elapsed: 8.260972359s
Sep  9 14:04:08.166: INFO: Pod "azuredisk-volume-tester-lmjm6": Phase="Pending", Reason="", readiness=false. Elapsed: 10.312274573s
... skipping 39 lines ...
Sep  9 14:05:30.235: INFO: Pod "azuredisk-volume-tester-lmjm6": Phase="Pending", Reason="", readiness=false. Elapsed: 1m32.380966044s
Sep  9 14:05:32.286: INFO: Pod "azuredisk-volume-tester-lmjm6": Phase="Pending", Reason="", readiness=false. Elapsed: 1m34.432409585s
Sep  9 14:05:34.338: INFO: Pod "azuredisk-volume-tester-lmjm6": Phase="Pending", Reason="", readiness=false. Elapsed: 1m36.484084611s
Sep  9 14:05:36.390: INFO: Pod "azuredisk-volume-tester-lmjm6": Phase="Pending", Reason="", readiness=false. Elapsed: 1m38.536289858s
Sep  9 14:05:38.446: INFO: Pod "azuredisk-volume-tester-lmjm6": Phase="Succeeded", Reason="", readiness=false. Elapsed: 1m40.592739253s
STEP: Saw pod success
Sep  9 14:05:38.446: INFO: Pod "azuredisk-volume-tester-lmjm6" satisfied condition "Succeeded or Failed"
Sep  9 14:05:38.446: INFO: deleting Pod "azuredisk-7463"/"azuredisk-volume-tester-lmjm6"
Sep  9 14:05:38.552: INFO: Pod azuredisk-volume-tester-lmjm6 has the following logs: hello world

STEP: Deleting pod azuredisk-volume-tester-lmjm6 in namespace azuredisk-7463
Sep  9 14:05:38.612: INFO: deleting PVC "azuredisk-7463"/"pvc-trzmb"
Sep  9 14:05:38.612: INFO: Deleting PersistentVolumeClaim "pvc-trzmb"
... skipping 102 lines ...
Sep  9 14:06:13.148: INFO: PersistentVolumeClaim pvc-gghmf found and phase=Bound (4.161904082s)
STEP: checking the PVC
STEP: validating provisioned PV
STEP: checking the PV
STEP: setting up the pod
STEP: deploying the pod
STEP: checking that the pod's command exits with an error
Sep  9 14:06:13.306: INFO: Waiting up to 10m0s for pod "azuredisk-volume-tester-7vtdd" in namespace "azuredisk-8623" to be "Error status code"
Sep  9 14:06:13.384: INFO: Pod "azuredisk-volume-tester-7vtdd": Phase="Pending", Reason="", readiness=false. Elapsed: 77.443235ms
Sep  9 14:06:15.436: INFO: Pod "azuredisk-volume-tester-7vtdd": Phase="Pending", Reason="", readiness=false. Elapsed: 2.129208324s
Sep  9 14:06:17.489: INFO: Pod "azuredisk-volume-tester-7vtdd": Phase="Pending", Reason="", readiness=false. Elapsed: 4.183110484s
Sep  9 14:06:19.541: INFO: Pod "azuredisk-volume-tester-7vtdd": Phase="Pending", Reason="", readiness=false. Elapsed: 6.234821032s
Sep  9 14:06:21.594: INFO: Pod "azuredisk-volume-tester-7vtdd": Phase="Pending", Reason="", readiness=false. Elapsed: 8.287898776s
Sep  9 14:06:23.646: INFO: Pod "azuredisk-volume-tester-7vtdd": Phase="Pending", Reason="", readiness=false. Elapsed: 10.339998959s
... skipping 37 lines ...
Sep  9 14:07:41.627: INFO: Pod "azuredisk-volume-tester-7vtdd": Phase="Pending", Reason="", readiness=false. Elapsed: 1m28.320315723s
Sep  9 14:07:43.679: INFO: Pod "azuredisk-volume-tester-7vtdd": Phase="Pending", Reason="", readiness=false. Elapsed: 1m30.372514622s
Sep  9 14:07:45.734: INFO: Pod "azuredisk-volume-tester-7vtdd": Phase="Pending", Reason="", readiness=false. Elapsed: 1m32.428087882s
Sep  9 14:07:47.785: INFO: Pod "azuredisk-volume-tester-7vtdd": Phase="Pending", Reason="", readiness=false. Elapsed: 1m34.479015527s
Sep  9 14:07:49.843: INFO: Pod "azuredisk-volume-tester-7vtdd": Phase="Pending", Reason="", readiness=false. Elapsed: 1m36.536169653s
Sep  9 14:07:51.894: INFO: Pod "azuredisk-volume-tester-7vtdd": Phase="Pending", Reason="", readiness=false. Elapsed: 1m38.58779625s
Sep  9 14:07:53.953: INFO: Pod "azuredisk-volume-tester-7vtdd": Phase="Failed", Reason="", readiness=false. Elapsed: 1m40.646549149s
STEP: Saw pod failure
Sep  9 14:07:53.953: INFO: Pod "azuredisk-volume-tester-7vtdd" satisfied condition "Error status code"
STEP: checking that pod logs contain expected message
Sep  9 14:07:54.064: INFO: deleting Pod "azuredisk-8623"/"azuredisk-volume-tester-7vtdd"
Sep  9 14:07:54.126: INFO: Pod azuredisk-volume-tester-7vtdd has the following logs: out-file : Access to the path 'C:\mnt\test-1\data' is denied.
At line:1 char:1
+ echo $null >> C:\mnt\test-1\data
+ ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~
... skipping 362 lines ...
Sep  9 14:15:13.064: INFO: PersistentVolumeClaim pvc-t4bx2 found and phase=Bound (4.155648213s)
STEP: checking the PVC
STEP: validating provisioned PV
STEP: checking the PV
STEP: setting up the pod
STEP: deploying the pod
STEP: checking that the pod's command exits with no error
Sep  9 14:15:13.226: INFO: Waiting up to 15m0s for pod "azuredisk-volume-tester-vqbjp" in namespace "azuredisk-2205" to be "Succeeded or Failed"
Sep  9 14:15:13.279: INFO: Pod "azuredisk-volume-tester-vqbjp": Phase="Pending", Reason="", readiness=false. Elapsed: 52.417995ms
Sep  9 14:15:15.332: INFO: Pod "azuredisk-volume-tester-vqbjp": Phase="Pending", Reason="", readiness=false. Elapsed: 2.105106089s
Sep  9 14:15:17.384: INFO: Pod "azuredisk-volume-tester-vqbjp": Phase="Pending", Reason="", readiness=false. Elapsed: 4.157514713s
Sep  9 14:15:19.436: INFO: Pod "azuredisk-volume-tester-vqbjp": Phase="Pending", Reason="", readiness=false. Elapsed: 6.209169791s
Sep  9 14:15:21.489: INFO: Pod "azuredisk-volume-tester-vqbjp": Phase="Pending", Reason="", readiness=false. Elapsed: 8.262254718s
Sep  9 14:15:23.541: INFO: Pod "azuredisk-volume-tester-vqbjp": Phase="Pending", Reason="", readiness=false. Elapsed: 10.314823167s
... skipping 43 lines ...