This job view page is being replaced by Spyglass soon. Check out the new job view.
PRandyzhangx: fix: huge storage account list usage
ResultABORTED
Tests 0 failed / 0 succeeded
Started2021-07-22 06:55
Elapsed58m27s
Revisiond99bdde39fbc12728ca392edba55817efa66e540
Refs 480

No Test Failures!


Error lines from build-log.txt

... skipping 771 lines ...
        - name: csi-resizer
          image: "mcr.microsoft.com/oss/kubernetes-csi/csi-resizer:v1.1.0"
          args:
            - "-csi-address=$(ADDRESS)"
            - "-v=2"
            - "-leader-election"
            - '-handle-volume-inuse-error=false'
          env:
            - name: ADDRESS
              value: /csi/csi.sock
          imagePullPolicy: IfNotPresent
          volumeMounts:
            - name: socket-dir
... skipping 57 lines ...
Git Commit: N/A
Go Version: go1.16.6
Platform: linux/amd64

Streaming logs below:
STEP: Building a namespace api object, basename blob
E0722 07:02:37.439303   14051 azure_config.go:45] Failed to get cloud-config from secret: failed to get secret /: resource name may not be empty
I0722 07:02:37.441595   14051 driver.go:80] Enabling controller service capability: CREATE_DELETE_VOLUME
I0722 07:02:37.441617   14051 driver.go:80] Enabling controller service capability: EXPAND_VOLUME
I0722 07:02:37.441624   14051 driver.go:99] Enabling volume access mode: SINGLE_NODE_WRITER
I0722 07:02:37.441629   14051 driver.go:99] Enabling volume access mode: SINGLE_NODE_READER_ONLY
I0722 07:02:37.441632   14051 driver.go:99] Enabling volume access mode: MULTI_NODE_READER_ONLY
I0722 07:02:37.441636   14051 driver.go:99] Enabling volume access mode: MULTI_NODE_SINGLE_WRITER
... skipping 27 lines ...
Jul 22 07:02:56.776: INFO: PersistentVolumeClaim pvc-w7ghv found but phase is Pending instead of Bound.
Jul 22 07:02:58.803: INFO: PersistentVolumeClaim pvc-w7ghv found and phase=Bound (20.309619318s)
STEP: checking the PVC
STEP: validating provisioned PV
STEP: checking the PV
STEP: deploying the pod
STEP: checking that the pods command exits with no error
Jul 22 07:02:58.886: INFO: Waiting up to 15m0s for pod "blob-volume-tester-jprdc" in namespace "blob-8081" to be "Succeeded or Failed"
Jul 22 07:02:58.917: INFO: Pod "blob-volume-tester-jprdc": Phase="Pending", Reason="", readiness=false. Elapsed: 30.34995ms
Jul 22 07:03:00.946: INFO: Pod "blob-volume-tester-jprdc": Phase="Pending", Reason="", readiness=false. Elapsed: 2.059470978s
Jul 22 07:03:02.974: INFO: Pod "blob-volume-tester-jprdc": Phase="Pending", Reason="", readiness=false. Elapsed: 4.087579556s
Jul 22 07:03:05.002: INFO: Pod "blob-volume-tester-jprdc": Phase="Pending", Reason="", readiness=false. Elapsed: 6.116146401s
Jul 22 07:03:07.031: INFO: Pod "blob-volume-tester-jprdc": Phase="Pending", Reason="", readiness=false. Elapsed: 8.144510982s
Jul 22 07:03:09.059: INFO: Pod "blob-volume-tester-jprdc": Phase="Pending", Reason="", readiness=false. Elapsed: 10.17283232s
... skipping 433 lines ...
Jul 22 07:17:49.461: INFO: Pod "blob-volume-tester-jprdc": Phase="Pending", Reason="", readiness=false. Elapsed: 14m50.574239951s
Jul 22 07:17:51.490: INFO: Pod "blob-volume-tester-jprdc": Phase="Pending", Reason="", readiness=false. Elapsed: 14m52.603834926s
Jul 22 07:17:53.519: INFO: Pod "blob-volume-tester-jprdc": Phase="Pending", Reason="", readiness=false. Elapsed: 14m54.632826249s
Jul 22 07:17:55.548: INFO: Pod "blob-volume-tester-jprdc": Phase="Pending", Reason="", readiness=false. Elapsed: 14m56.661683857s
Jul 22 07:17:57.577: INFO: Pod "blob-volume-tester-jprdc": Phase="Pending", Reason="", readiness=false. Elapsed: 14m58.690278637s
Jul 22 07:17:59.578: INFO: deleting Pod "blob-8081"/"blob-volume-tester-jprdc"
Jul 22 07:17:59.657: INFO: Error getting logs for pod blob-volume-tester-jprdc: the server rejected our request for an unknown reason (get pods blob-volume-tester-jprdc)
STEP: Deleting pod blob-volume-tester-jprdc in namespace blob-8081
Jul 22 07:17:59.685: INFO: deleting PVC "blob-8081"/"pvc-w7ghv"
Jul 22 07:17:59.685: INFO: Deleting PersistentVolumeClaim "pvc-w7ghv"
STEP: waiting for claim's PV "pvc-93288a66-0733-4c54-9022-c4c8304a0163" to be deleted
Jul 22 07:17:59.714: INFO: Waiting up to 10m0s for PersistentVolume pvc-93288a66-0733-4c54-9022-c4c8304a0163 to get deleted
Jul 22 07:17:59.740: INFO: PersistentVolume pvc-93288a66-0733-4c54-9022-c4c8304a0163 found and phase=Bound (26.237113ms)
... skipping 5 lines ...
STEP: Collecting events from namespace "blob-8081".
STEP: Found 7 events.
Jul 22 07:18:09.884: INFO: At 2021-07-22 07:02:38 +0000 UTC - event for pvc-w7ghv: {blob.csi.azure.com_k8s-master-41387152-0_d8515a45-baa2-4a03-b4d5-fb8b01947d05 } Provisioning: External provisioner is provisioning volume for claim "blob-8081/pvc-w7ghv"
Jul 22 07:18:09.884: INFO: At 2021-07-22 07:02:38 +0000 UTC - event for pvc-w7ghv: {persistentvolume-controller } ExternalProvisioning: waiting for a volume to be created, either by external provisioner "blob.csi.azure.com" or manually created by system administrator
Jul 22 07:18:09.884: INFO: At 2021-07-22 07:02:58 +0000 UTC - event for blob-volume-tester-jprdc: {default-scheduler } Scheduled: Successfully assigned blob-8081/blob-volume-tester-jprdc to k8s-agentpool1-41387152-1
Jul 22 07:18:09.884: INFO: At 2021-07-22 07:02:58 +0000 UTC - event for pvc-w7ghv: {blob.csi.azure.com_k8s-master-41387152-0_d8515a45-baa2-4a03-b4d5-fb8b01947d05 } ProvisioningSucceeded: Successfully provisioned volume pvc-93288a66-0733-4c54-9022-c4c8304a0163
Jul 22 07:18:09.884: INFO: At 2021-07-22 07:02:59 +0000 UTC - event for blob-volume-tester-jprdc: {kubelet k8s-agentpool1-41387152-1} FailedMount: MountVolume.MountDevice failed for volume "pvc-93288a66-0733-4c54-9022-c4c8304a0163" : rpc error: code = Unknown desc = Mount failed with error: rpc error: code = Unknown desc = exit status 1, output: 
Jul 22 07:18:09.884: INFO: At 2021-07-22 07:05:01 +0000 UTC - event for blob-volume-tester-jprdc: {kubelet k8s-agentpool1-41387152-1} FailedMount: Unable to attach or mount volumes: unmounted volumes=[test-volume-1], unattached volumes=[default-token-dhtn2 test-volume-1]: timed out waiting for the condition
Jul 22 07:18:09.884: INFO: At 2021-07-22 07:07:19 +0000 UTC - event for blob-volume-tester-jprdc: {kubelet k8s-agentpool1-41387152-1} FailedMount: Unable to attach or mount volumes: unmounted volumes=[test-volume-1], unattached volumes=[test-volume-1 default-token-dhtn2]: timed out waiting for the condition
Jul 22 07:18:09.914: INFO: POD  NODE  PHASE  GRACE  CONDITIONS
Jul 22 07:18:09.914: INFO: 
Jul 22 07:18:09.965: INFO: 
Logging node info for node k8s-agentpool1-41387152-0
... skipping 90 lines ...
• Failure [933.472 seconds]
[blob-csi-e2e] Dynamic Provisioning
/home/prow/go/src/sigs.k8s.io/blob-csi-driver/test/e2e/dynamic_provisioning_test.go:37
  should create a volume on demand without saving storage account key [It]
  /home/prow/go/src/sigs.k8s.io/blob-csi-driver/test/e2e/dynamic_provisioning_test.go:60

  Unexpected error:
      <*errors.errorString | 0xc000887510>: {
          s: "Gave up after waiting 15m0s for pod \"blob-volume-tester-jprdc\" to be \"Succeeded or Failed\"",
      }
      Gave up after waiting 15m0s for pod "blob-volume-tester-jprdc" to be "Succeeded or Failed"
  occurred

  /home/prow/go/src/sigs.k8s.io/blob-csi-driver/test/e2e/testsuites/testsuites.go:457
------------------------------
[blob-csi-e2e] Dynamic Provisioning 
  should create a volume on demand with mount options
... skipping 26 lines ...
Jul 22 07:18:30.134: INFO: PersistentVolumeClaim pvc-p96zt found but phase is Pending instead of Bound.
Jul 22 07:18:32.160: INFO: PersistentVolumeClaim pvc-p96zt found and phase=Bound (20.304486999s)
STEP: checking the PVC
STEP: validating provisioned PV
STEP: checking the PV
STEP: deploying the pod
STEP: checking that the pods command exits with no error
Jul 22 07:18:32.245: INFO: Waiting up to 15m0s for pod "blob-volume-tester-m757m" in namespace "blob-1318" to be "Succeeded or Failed"
Jul 22 07:18:32.272: INFO: Pod "blob-volume-tester-m757m": Phase="Pending", Reason="", readiness=false. Elapsed: 26.301317ms
Jul 22 07:18:34.300: INFO: Pod "blob-volume-tester-m757m": Phase="Pending", Reason="", readiness=false. Elapsed: 2.055047391s
Jul 22 07:18:36.328: INFO: Pod "blob-volume-tester-m757m": Phase="Pending", Reason="", readiness=false. Elapsed: 4.083241375s
Jul 22 07:18:38.356: INFO: Pod "blob-volume-tester-m757m": Phase="Pending", Reason="", readiness=false. Elapsed: 6.111183498s
Jul 22 07:18:40.385: INFO: Pod "blob-volume-tester-m757m": Phase="Pending", Reason="", readiness=false. Elapsed: 8.140209771s
Jul 22 07:18:42.415: INFO: Pod "blob-volume-tester-m757m": Phase="Pending", Reason="", readiness=false. Elapsed: 10.169588058s
... skipping 433 lines ...
Jul 22 07:33:22.903: INFO: Pod "blob-volume-tester-m757m": Phase="Pending", Reason="", readiness=false. Elapsed: 14m50.657836103s
Jul 22 07:33:24.931: INFO: Pod "blob-volume-tester-m757m": Phase="Pending", Reason="", readiness=false. Elapsed: 14m52.685623504s
Jul 22 07:33:26.958: INFO: Pod "blob-volume-tester-m757m": Phase="Pending", Reason="", readiness=false. Elapsed: 14m54.712586074s
Jul 22 07:33:28.986: INFO: Pod "blob-volume-tester-m757m": Phase="Pending", Reason="", readiness=false. Elapsed: 14m56.740708729s
Jul 22 07:33:31.013: INFO: Pod "blob-volume-tester-m757m": Phase="Pending", Reason="", readiness=false. Elapsed: 14m58.767797974s
Jul 22 07:33:33.014: INFO: deleting Pod "blob-1318"/"blob-volume-tester-m757m"
Jul 22 07:33:33.069: INFO: Error getting logs for pod blob-volume-tester-m757m: the server rejected our request for an unknown reason (get pods blob-volume-tester-m757m)
STEP: Deleting pod blob-volume-tester-m757m in namespace blob-1318
Jul 22 07:33:33.097: INFO: deleting PVC "blob-1318"/"pvc-p96zt"
Jul 22 07:33:33.097: INFO: Deleting PersistentVolumeClaim "pvc-p96zt"
STEP: waiting for claim's PV "pvc-401245b3-6c10-4713-ae2d-396f0bb45c0b" to be deleted
Jul 22 07:33:33.129: INFO: Waiting up to 10m0s for PersistentVolume pvc-401245b3-6c10-4713-ae2d-396f0bb45c0b to get deleted
Jul 22 07:33:33.155: INFO: PersistentVolume pvc-401245b3-6c10-4713-ae2d-396f0bb45c0b found and phase=Bound (26.509084ms)
... skipping 4 lines ...
Jul 22 07:33:43.236: INFO: deleting StorageClass blob-1318-blob.csi.azure.com-dynamic-sc-5kt4f
STEP: Collecting events from namespace "blob-1318".
STEP: Found 7 events.
Jul 22 07:33:43.293: INFO: At 2021-07-22 07:18:11 +0000 UTC - event for pvc-p96zt: {blob.csi.azure.com_k8s-master-41387152-0_d8515a45-baa2-4a03-b4d5-fb8b01947d05 } Provisioning: External provisioner is provisioning volume for claim "blob-1318/pvc-p96zt"
Jul 22 07:33:43.294: INFO: At 2021-07-22 07:18:11 +0000 UTC - event for pvc-p96zt: {persistentvolume-controller } ExternalProvisioning: waiting for a volume to be created, either by external provisioner "blob.csi.azure.com" or manually created by system administrator
Jul 22 07:33:43.294: INFO: At 2021-07-22 07:18:31 +0000 UTC - event for pvc-p96zt: {blob.csi.azure.com_k8s-master-41387152-0_d8515a45-baa2-4a03-b4d5-fb8b01947d05 } ProvisioningSucceeded: Successfully provisioned volume pvc-401245b3-6c10-4713-ae2d-396f0bb45c0b
Jul 22 07:33:43.294: INFO: At 2021-07-22 07:18:32 +0000 UTC - event for blob-volume-tester-m757m: {kubelet k8s-agentpool1-41387152-1} FailedMount: MountVolume.MountDevice failed for volume "pvc-401245b3-6c10-4713-ae2d-396f0bb45c0b" : rpc error: code = Unknown desc = Mount failed with error: rpc error: code = Unknown desc = exit status 1, output: 
Jul 22 07:33:43.294: INFO: At 2021-07-22 07:18:32 +0000 UTC - event for blob-volume-tester-m757m: {default-scheduler } Scheduled: Successfully assigned blob-1318/blob-volume-tester-m757m to k8s-agentpool1-41387152-1
Jul 22 07:33:43.294: INFO: At 2021-07-22 07:20:35 +0000 UTC - event for blob-volume-tester-m757m: {kubelet k8s-agentpool1-41387152-1} FailedMount: Unable to attach or mount volumes: unmounted volumes=[test-volume-1], unattached volumes=[test-volume-1 default-token-fhvzz]: timed out waiting for the condition
Jul 22 07:33:43.294: INFO: At 2021-07-22 07:22:52 +0000 UTC - event for blob-volume-tester-m757m: {kubelet k8s-agentpool1-41387152-1} FailedMount: Unable to attach or mount volumes: unmounted volumes=[test-volume-1], unattached volumes=[default-token-fhvzz test-volume-1]: timed out waiting for the condition
Jul 22 07:33:43.320: INFO: POD  NODE  PHASE  GRACE  CONDITIONS
Jul 22 07:33:43.320: INFO: 
Jul 22 07:33:43.382: INFO: 
... skipping 91 lines ...
• Failure [933.425 seconds]
[blob-csi-e2e] Dynamic Provisioning
/home/prow/go/src/sigs.k8s.io/blob-csi-driver/test/e2e/dynamic_provisioning_test.go:37
  should create a volume on demand with mount options [It]
  /home/prow/go/src/sigs.k8s.io/blob-csi-driver/test/e2e/dynamic_provisioning_test.go:93

  Unexpected error:
      <*errors.errorString | 0xc0007f1530>: {
          s: "Gave up after waiting 15m0s for pod \"blob-volume-tester-m757m\" to be \"Succeeded or Failed\"",
      }
      Gave up after waiting 15m0s for pod "blob-volume-tester-m757m" to be "Succeeded or Failed"
  occurred

  /home/prow/go/src/sigs.k8s.io/blob-csi-driver/test/e2e/testsuites/testsuites.go:457
------------------------------
[blob-csi-e2e] Dynamic Provisioning 
  should create a deployment object, write and read to it, delete the pod and write and read to it again
... skipping 177 lines ...