This job view page is being replaced by Spyglass soon. Check out the new job view.
PRnilo19: Add metrics for azure disk attach and detach operations
ResultFAILURE
Tests 0 failed / 0 succeeded
Started2020-09-09 07:54
Elapsed28m28s
Revision2af35385a93dc2b21a23751fd5c67c87dd92c4ff
Refs 529

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   165k      0 --:--:-- --:--:-- --:--:--  165k
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-a7dcd338656fb9e9314eb8a3d02556b6697633cd || make azuredisk-container push
Error response from daemon: manifest for k8sprow.azurecr.io/azuredisk-csi:e2e-a7dcd338656fb9e9314eb8a3d02556b6697633cd not found: manifest unknown: manifest tagged by "e2e-a7dcd338656fb9e9314eb8a3d02556b6697633cd" 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-a7dcd338656fb9e9314eb8a3d02556b6697633cd -X sigs.k8s.io/azuredisk-csi-driver/pkg/azuredisk.gitCommit=a7dcd338656fb9e9314eb8a3d02556b6697633cd -X sigs.k8s.io/azuredisk-csi-driver/pkg/azuredisk.buildDate=2020-09-09T08:05:34Z -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-a7dcd338656fb9e9314eb8a3d02556b6697633cd -X sigs.k8s.io/azuredisk-csi-driver/pkg/azuredisk.gitCommit=a7dcd338656fb9e9314eb8a3d02556b6697633cd -X sigs.k8s.io/azuredisk-csi-driver/pkg/azuredisk.buildDate=2020-09-09T08:06:30Z -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 1271 lines ...
Go Version: go1.15
Platform: linux/amd64
Topology Key: N/A

Streaming logs below:
STEP: Building a namespace api object, basename azuredisk
W0909 08:14:33.623175   12502 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 08:14:33.624611   12502 azuredisk.go:110] disable UseInstanceMetadata for controller
I0909 08:14:33.624983   12502 driver.go:80] Enabling controller service capability: CREATE_DELETE_VOLUME
I0909 08:14:33.625003   12502 driver.go:80] Enabling controller service capability: PUBLISH_UNPUBLISH_VOLUME
I0909 08:14:33.625009   12502 driver.go:80] Enabling controller service capability: CREATE_DELETE_SNAPSHOT
I0909 08:14:33.625015   12502 driver.go:80] Enabling controller service capability: LIST_SNAPSHOTS
I0909 08:14:33.625020   12502 driver.go:80] Enabling controller service capability: CLONE_VOLUME
... skipping 21 lines ...
Sep  9 08:14:39.584: INFO: PersistentVolumeClaim pvc-n7r4z found and phase=Bound (4.154283163s)
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 08:14:39.742: INFO: Waiting up to 15m0s for pod "azuredisk-volume-tester-p2hxg" in namespace "azuredisk-8047" to be "Succeeded or Failed"
Sep  9 08:14:39.795: INFO: Pod "azuredisk-volume-tester-p2hxg": Phase="Pending", Reason="", readiness=false. Elapsed: 52.525345ms
Sep  9 08:14:41.848: INFO: Pod "azuredisk-volume-tester-p2hxg": Phase="Pending", Reason="", readiness=false. Elapsed: 2.105470548s
Sep  9 08:14:43.900: INFO: Pod "azuredisk-volume-tester-p2hxg": Phase="Pending", Reason="", readiness=false. Elapsed: 4.157336662s
Sep  9 08:14:45.952: INFO: Pod "azuredisk-volume-tester-p2hxg": Phase="Pending", Reason="", readiness=false. Elapsed: 6.209511903s
Sep  9 08:14:48.004: INFO: Pod "azuredisk-volume-tester-p2hxg": Phase="Pending", Reason="", readiness=false. Elapsed: 8.2617579s
Sep  9 08:14:50.057: INFO: Pod "azuredisk-volume-tester-p2hxg": Phase="Pending", Reason="", readiness=false. Elapsed: 10.314885849s
... skipping 66 lines ...
Sep  9 08:17:07.664: INFO: Pod "azuredisk-volume-tester-p2hxg": Phase="Pending", Reason="", readiness=false. Elapsed: 2m27.922215863s
Sep  9 08:17:09.717: INFO: Pod "azuredisk-volume-tester-p2hxg": Phase="Pending", Reason="", readiness=false. Elapsed: 2m29.974405324s
Sep  9 08:17:11.771: INFO: Pod "azuredisk-volume-tester-p2hxg": Phase="Pending", Reason="", readiness=false. Elapsed: 2m32.028662934s
Sep  9 08:17:13.823: INFO: Pod "azuredisk-volume-tester-p2hxg": Phase="Pending", Reason="", readiness=false. Elapsed: 2m34.081114811s
Sep  9 08:17:15.876: INFO: Pod "azuredisk-volume-tester-p2hxg": Phase="Succeeded", Reason="", readiness=false. Elapsed: 2m36.133331322s
STEP: Saw pod success
Sep  9 08:17:15.876: INFO: Pod "azuredisk-volume-tester-p2hxg" satisfied condition "Succeeded or Failed"
Sep  9 08:17:15.876: INFO: deleting Pod "azuredisk-8047"/"azuredisk-volume-tester-p2hxg"
Sep  9 08:17:15.964: INFO: Pod azuredisk-volume-tester-p2hxg has the following logs: hello world

STEP: Deleting pod azuredisk-volume-tester-p2hxg in namespace azuredisk-8047
Sep  9 08:17:16.031: INFO: deleting PVC "azuredisk-8047"/"pvc-n7r4z"
Sep  9 08:17:16.031: INFO: Deleting PersistentVolumeClaim "pvc-n7r4z"
... skipping 105 lines ...
Sep  9 08:18:05.823: INFO: PersistentVolumeClaim pvc-n97lp found and phase=Bound (4.160619818s)
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 08:18:05.982: INFO: Waiting up to 10m0s for pod "azuredisk-volume-tester-4h9xt" in namespace "azuredisk-5026" to be "Error status code"
Sep  9 08:18:06.046: INFO: Pod "azuredisk-volume-tester-4h9xt": Phase="Pending", Reason="", readiness=false. Elapsed: 64.437631ms
Sep  9 08:18:08.098: INFO: Pod "azuredisk-volume-tester-4h9xt": Phase="Pending", Reason="", readiness=false. Elapsed: 2.116232693s
Sep  9 08:18:10.150: INFO: Pod "azuredisk-volume-tester-4h9xt": Phase="Pending", Reason="", readiness=false. Elapsed: 4.168778024s
Sep  9 08:18:12.203: INFO: Pod "azuredisk-volume-tester-4h9xt": Phase="Pending", Reason="", readiness=false. Elapsed: 6.221364456s
Sep  9 08:18:14.260: INFO: Pod "azuredisk-volume-tester-4h9xt": Phase="Pending", Reason="", readiness=false. Elapsed: 8.278467442s
Sep  9 08:18:16.312: INFO: Pod "azuredisk-volume-tester-4h9xt": Phase="Pending", Reason="", readiness=false. Elapsed: 10.330915018s
... skipping 38 lines ...
Sep  9 08:19:36.382: INFO: Pod "azuredisk-volume-tester-4h9xt": Phase="Pending", Reason="", readiness=false. Elapsed: 1m30.399965101s
Sep  9 08:19:38.434: INFO: Pod "azuredisk-volume-tester-4h9xt": Phase="Pending", Reason="", readiness=false. Elapsed: 1m32.452268438s
Sep  9 08:19:40.486: INFO: Pod "azuredisk-volume-tester-4h9xt": Phase="Pending", Reason="", readiness=false. Elapsed: 1m34.504472708s
Sep  9 08:19:42.538: INFO: Pod "azuredisk-volume-tester-4h9xt": Phase="Pending", Reason="", readiness=false. Elapsed: 1m36.556601222s
Sep  9 08:19:44.591: INFO: Pod "azuredisk-volume-tester-4h9xt": Phase="Pending", Reason="", readiness=false. Elapsed: 1m38.609222956s
Sep  9 08:19:46.643: INFO: Pod "azuredisk-volume-tester-4h9xt": Phase="Pending", Reason="", readiness=false. Elapsed: 1m40.6614254s
Sep  9 08:19:48.695: INFO: Pod "azuredisk-volume-tester-4h9xt": Phase="Failed", Reason="", readiness=false. Elapsed: 1m42.713738478s
STEP: Saw pod failure
Sep  9 08:19:48.695: INFO: Pod "azuredisk-volume-tester-4h9xt" satisfied condition "Error status code"
STEP: checking that pod logs contain expected message
Sep  9 08:19:48.815: INFO: deleting Pod "azuredisk-5026"/"azuredisk-volume-tester-4h9xt"
Sep  9 08:19:48.875: INFO: Pod azuredisk-volume-tester-4h9xt 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 85 lines ...
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 is running
{"component":"entrypoint","file":"prow/entrypoint/run.go:169","func":"k8s.io/test-infra/prow/entrypoint.Options.ExecuteProcess","level":"error","msg":"Entrypoint received interrupt: terminated","severity":"error","time":"2020-09-09T08:23:20Z"}