This job view page is being replaced by Spyglass soon. Check out the new job view.
PRandyzhangx: fix: blobfuse mount silent failure issue
ResultABORTED
Tests 0 failed / 18 succeeded
Started2021-07-21 14:55
Elapsed19m57s
Revisionca70e8990a4ee12b12bbd30bd8f90344cdb87aab
Refs 479

No Test Failures!


Show 18 Passed Tests

Error lines from build-log.txt

... skipping 71 lines ...
Downloading https://get.helm.sh/helm-v3.6.3-linux-amd64.tar.gz
Verifying checksum... Done.
Preparing to install helm into /usr/local/bin
helm installed into /usr/local/bin/helm
# Only build and push the image if it does not exist in the registry
docker pull k8sprow.azurecr.io/blob-csi:e2e-b85d778d60c7864593cadd8bc92dbd8182b951ef || make blob-container push
Error response from daemon: manifest for k8sprow.azurecr.io/blob-csi:e2e-b85d778d60c7864593cadd8bc92dbd8182b951ef not found: manifest unknown: manifest tagged by "e2e-b85d778d60c7864593cadd8bc92dbd8182b951ef" is not found
make[2]: Entering directory '/home/prow/go/src/sigs.k8s.io/blob-csi-driver'
docker buildx rm container-builder || true
error: no builder "container-builder" found
docker buildx create --use --name=container-builder
container-builder
# enable qemu for arm64 build
# docker run --rm --privileged multiarch/qemu-user-static --reset -p yes
for arch in amd64 ; do \
	ARCH=${arch} make blob; \
... skipping 68 lines ...
#8 5.299 Reading state information...
#8 5.484 The following additional packages will be installed:
#8 5.485   cmake-data libarchive13 libblkid1 libc-dev-bin libc6-dev libcom-err2
#8 5.485   libcurl3-gnutls libcurl4 libdpkg-perl libevent-2.1-6 libexpat1 libfuse2
#8 5.485   libgcrypt20 libgdbm-compat4 libgdbm6 libglib2.0-0 libgmp-dev libgmpxx4ldbl
#8 5.485   libgnutls-dane0 libgnutls-openssl27 libgnutls30 libgnutlsxx28
#8 5.485   libgpg-error-dev libgssapi-krb5-2 libhogweed4 libicu63 libidn2-dev
#8 5.485   libjsoncpp1 libk5crypto3 libkeyutils1 libkrb5-3 libkrb5support0
#8 5.485   libldap-2.4-2 libldap-common libmount1 libncurses6 libncursesw6 libnettle6
#8 5.485   libnghttp2-14 libp11-kit-dev libpcre16-3 libpcre2-8-0 libpcre3-dev
#8 5.485   libpcre32-3 libpcrecpp0v5 libperl5.28 libprocps7 libpsl5 librhash0 librtmp1
#8 5.485   libsasl2-2 libsasl2-modules-db libselinux1-dev libsepol1-dev libssh2-1
#8 5.485   libssl1.1 libtasn1-6-dev libtinfo6 libunbound8 libuuid1 libuv1 libxml2
... skipping 14 lines ...
#8 6.090 The following NEW packages will be installed:
#8 6.091   ca-certificates cmake cmake-data libarchive13 libblkid1 libc-dev-bin
#8 6.091   libc6-dev libcom-err2 libcurl3-gnutls libcurl4 libcurl4-gnutls-dev
#8 6.091   libdpkg-perl libevent-2.1-6 libexpat1 libfuse-dev libfuse2 libgcrypt20-dev
#8 6.091   libgdbm-compat4 libgdbm6 libglib2.0-0 libgmp-dev libgmpxx4ldbl
#8 6.091   libgnutls-dane0 libgnutls-openssl27 libgnutls28-dev libgnutlsxx28
#8 6.091   libgpg-error-dev libgssapi-krb5-2 libicu63 libidn2-dev libjsoncpp1
#8 6.091   libk5crypto3 libkeyutils1 libkrb5-3 libkrb5support0 libldap-2.4-2
#8 6.092   libldap-common libmount1 libncurses6 libncursesw6 libnghttp2-14
#8 6.092   libp11-kit-dev libpcre16-3 libpcre2-8-0 libpcre3-dev libpcre32-3
#8 6.092   libpcrecpp0v5 libperl5.28 libprocps7 libpsl5 librhash0 librtmp1 libsasl2-2
#8 6.092   libsasl2-modules-db libselinux1-dev libsepol1-dev libssh2-1 libssl1.1
#8 6.092   libtasn1-6-dev libtinfo6 libunbound8 libuuid1 libuv1 libxml2 linux-libc-dev
... skipping 63 lines ...
#8 9.074 Get:57 http://deb.debian.org/debian buster/main amd64 libpcre16-3 amd64 2:8.39-12 [259 kB]
#8 9.099 Get:58 http://deb.debian.org/debian buster/main amd64 libpcre32-3 amd64 2:8.39-12 [250 kB]
#8 9.123 Get:59 http://deb.debian.org/debian buster/main amd64 libpcrecpp0v5 amd64 2:8.39-12 [152 kB]
#8 9.136 Get:60 http://deb.debian.org/debian buster/main amd64 libpcre3-dev amd64 2:8.39-12 [650 kB]
#8 9.201 Get:61 http://deb.debian.org/debian buster/main amd64 libselinux1-dev amd64 2.8-1+b1 [169 kB]
#8 9.215 Get:62 http://deb.debian.org/debian buster/main amd64 libfuse-dev amd64 2.9.9-1+deb10u1 [152 kB]
#8 9.231 Get:63 http://deb.debian.org/debian buster/main amd64 libgpg-error-dev amd64 1.35-1 [124 kB]
#8 9.242 Get:64 http://deb.debian.org/debian buster/main amd64 libgcrypt20-dev amd64 1.8.4-5+deb10u1 [608 kB]
#8 9.304 Get:65 http://deb.debian.org/debian buster/main amd64 libmount1 amd64 2.33.1-0.1 [207 kB]
#8 9.325 Get:66 http://deb.debian.org/debian buster/main amd64 libglib2.0-0 amd64 2.58.3-2+deb10u3 [1259 kB]
#8 9.446 Get:67 http://deb.debian.org/debian buster/main amd64 libgmpxx4ldbl amd64 2:6.1.2+dfsg-4 [22.9 kB]
#8 9.451 Get:68 http://deb.debian.org/debian buster/main amd64 libgmp-dev amd64 2:6.1.2+dfsg-4 [628 kB]
#8 9.510 Get:69 http://deb.debian.org/debian buster/main amd64 libunbound8 amd64 1.9.0-2+deb10u2 [462 kB]
... skipping 193 lines ...
#8 18.12 Selecting previously unselected package libselinux1-dev:amd64.
#8 18.12 Preparing to unpack .../50-libselinux1-dev_2.8-1+b1_amd64.deb ...
#8 18.12 Unpacking libselinux1-dev:amd64 (2.8-1+b1) ...
#8 18.18 Selecting previously unselected package libfuse-dev.
#8 18.18 Preparing to unpack .../51-libfuse-dev_2.9.9-1+deb10u1_amd64.deb ...
#8 18.19 Unpacking libfuse-dev (2.9.9-1+deb10u1) ...
#8 18.24 Selecting previously unselected package libgpg-error-dev.

#8 18.24 Preparing to unpack .../52-libgpg-error-dev_1.35-1_amd64.deb ...

#8 18.25 Unpacking libgpg-error-dev (1.35-1) ...

#8 18.29 Selecting previously unselected package libgcrypt20-dev.
#8 18.29 Preparing to unpack .../53-libgcrypt20-dev_1.8.4-5+deb10u1_amd64.deb ...
#8 18.30 Unpacking libgcrypt20-dev (1.8.4-5+deb10u1) ...
#8 18.40 Selecting previously unselected package libmount1:amd64.
#8 18.40 Preparing to unpack .../54-libmount1_2.33.1-0.1_amd64.deb ...
#8 18.41 Unpacking libmount1:amd64 (2.33.1-0.1) ...
... skipping 60 lines ...
#8 19.94 Setting up libldap-common (2.4.47+dfsg-3+deb10u6) ...
#8 19.95 Setting up libicu63:amd64 (63.1-6+deb10u1) ...
#8 19.96 Setting up libkrb5support0:amd64 (1.17-3+deb10u1) ...
#8 19.98 Setting up libsasl2-modules-db:amd64 (2.1.27+dfsg-1+deb10u1) ...
#8 19.99 Setting up libgmpxx4ldbl:amd64 (2:6.1.2+dfsg-4) ...
#8 20.00 Setting up libuv1:amd64 (1.24.1-1+deb10u1) ...
#8 20.01 Setting up libgpg-error-dev (1.35-1) ...

#8 20.03 Setting up librtmp1:amd64 (2.4+20151223.gitfa8646d.1-2) ...
#8 20.04 Setting up libpcre32-3:amd64 (2:8.39-12) ...
#8 20.05 Setting up libuuid1:amd64 (2.33.1-0.1) ...
#8 20.06 Setting up libgnutlsxx28:amd64 (3.6.7-4+deb10u7) ...
#8 20.07 Setting up libpcre2-8-0:amd64 (10.32-5) ...
#8 20.09 Setting up libk5crypto3:amd64 (1.17-3+deb10u1) ...
... skipping 389 lines ...
#11 8.544 Setting up libpython-stdlib:amd64 (2.7.16-1) ...
#11 8.557 Setting up python (2.7.16-1) ...
#11 8.579 Setting up libdevmapper1.02.1:amd64 (2:1.02.155-3) ...
#11 8.593 Setting up dmsetup (2:1.02.155-3) ...
#11 8.609 Setting up nfs-common (1:1.3.4-2.5+deb10u1) ...
#11 8.633 /var/lib/dpkg/info/nfs-common.postinst: 7: /var/lib/dpkg/info/nfs-common.postinst: ucf: not found
#11 8.633 dpkg: error processing package nfs-common (--configure):

#11 8.633  installed nfs-common package post-installation script subprocess returned error exit status 127

#11 8.634 dpkg: dependency problems prevent configuration of nfs-kernel-server:
#11 8.634  nfs-kernel-server depends on nfs-common (= 1:1.3.4-2.5+deb10u1); however:
#11 8.634   Package nfs-common is not configured yet.
#11 8.634 
#11 8.634 dpkg: error processing package nfs-kernel-server (--configure):

#11 8.634  dependency problems - leaving unconfigured
#11 8.634 Processing triggers for libc-bin (2.28-10) ...
#11 8.670 Errors were encountered while processing:
#11 8.670  nfs-common
#11 8.670  nfs-kernel-server
#11 8.687 E: Sub-process /usr/bin/dpkg returned an error code (1)
#11 DONE 8.8s

#12 exporting to image
#12 sha256:e8c613e07b0b7ff33893b694f7759a10d42e180f2b4dc349fb57dc6b71dcab00
#12 exporting layers
#12 exporting layers 10.9s done
... skipping 710 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
E0721 15:03:56.730459   13956 azure_config.go:45] Failed to get cloud-config from secret: failed to get secret /: resource name may not be empty
I0721 15:03:56.731645   13956 driver.go:80] Enabling controller service capability: CREATE_DELETE_VOLUME
I0721 15:03:56.731671   13956 driver.go:80] Enabling controller service capability: EXPAND_VOLUME
I0721 15:03:56.731680   13956 driver.go:99] Enabling volume access mode: SINGLE_NODE_WRITER
I0721 15:03:56.731691   13956 driver.go:99] Enabling volume access mode: SINGLE_NODE_READER_ONLY
I0721 15:03:56.731699   13956 driver.go:99] Enabling volume access mode: MULTI_NODE_READER_ONLY
I0721 15:03:56.731705   13956 driver.go:99] Enabling volume access mode: MULTI_NODE_SINGLE_WRITER
... skipping 19 lines ...
Jul 21 15:04:23.425: INFO: Waiting up to timeout=5m0s for PersistentVolumeClaims [pvc-8qfc9] to have phase Bound
Jul 21 15:04:23.535: INFO: PersistentVolumeClaim pvc-8qfc9 found and phase=Bound (109.976124ms)
STEP: checking the PVC
STEP: validating provisioned PV
STEP: checking the PV
STEP: deploying the pod
STEP: checking that the pods command exits with an error
Jul 21 15:04:23.868: INFO: Waiting up to 15m0s for pod "blob-volume-tester-7xl5z" in namespace "blob-8081" to be "Error status code"
Jul 21 15:04:23.981: INFO: Pod "blob-volume-tester-7xl5z": Phase="Pending", Reason="", readiness=false. Elapsed: 112.264792ms
Jul 21 15:04:26.093: INFO: Pod "blob-volume-tester-7xl5z": Phase="Pending", Reason="", readiness=false. Elapsed: 2.224950488s
Jul 21 15:04:28.204: INFO: Pod "blob-volume-tester-7xl5z": Phase="Failed", Reason="", readiness=false. Elapsed: 4.335880579s
STEP: Saw pod failure
Jul 21 15:04:28.204: INFO: Pod "blob-volume-tester-7xl5z" satisfied condition "Error status code"
STEP: checking that pod logs contain expected message
Jul 21 15:04:28.363: INFO: deleting Pod "blob-8081"/"blob-volume-tester-7xl5z"
Jul 21 15:04:28.475: INFO: Pod blob-volume-tester-7xl5z has the following logs: /bin/sh: can't create /mnt/test-1/data: Read-only file system

STEP: Deleting pod blob-volume-tester-7xl5z in namespace blob-8081
Jul 21 15:04:28.592: INFO: deleting PVC "blob-8081"/"pvc-8qfc9"
... skipping 87 lines ...
Jul 21 15:04:40.923: INFO: Waiting up to timeout=5m0s for PersistentVolumeClaims [pvc-2bwbt] to have phase Bound
Jul 21 15:04:41.034: INFO: PersistentVolumeClaim pvc-2bwbt found and phase=Bound (110.05956ms)
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 21 15:04:41.368: INFO: Waiting up to 15m0s for pod "blob-volume-tester-c9nn6" in namespace "blob-694" to be "Succeeded or Failed"
Jul 21 15:04:41.478: INFO: Pod "blob-volume-tester-c9nn6": Phase="Pending", Reason="", readiness=false. Elapsed: 110.011284ms
Jul 21 15:04:43.589: INFO: Pod "blob-volume-tester-c9nn6": Phase="Succeeded", Reason="", readiness=false. Elapsed: 2.220940406s
STEP: Saw pod success
Jul 21 15:04:43.589: INFO: Pod "blob-volume-tester-c9nn6" 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"
Jul 21 15:04:43.812: INFO: Waiting up to timeout=5m0s for PersistentVolumeClaims [pvc-zz4k6] to have phase Bound
Jul 21 15:04:43.922: INFO: PersistentVolumeClaim pvc-zz4k6 found and phase=Bound (110.306227ms)
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 21 15:04:44.258: INFO: Waiting up to 15m0s for pod "blob-volume-tester-wvtqf" in namespace "blob-694" to be "Succeeded or Failed"
Jul 21 15:04:44.372: INFO: Pod "blob-volume-tester-wvtqf": Phase="Pending", Reason="", readiness=false. Elapsed: 113.625108ms
Jul 21 15:04:46.485: INFO: Pod "blob-volume-tester-wvtqf": Phase="Succeeded", Reason="", readiness=false. Elapsed: 2.226227699s
STEP: Saw pod success
Jul 21 15:04:46.485: INFO: Pod "blob-volume-tester-wvtqf" 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"
Jul 21 15:04:46.711: INFO: Waiting up to timeout=5m0s for PersistentVolumeClaims [pvc-bc9qv] to have phase Bound
Jul 21 15:04:46.821: INFO: PersistentVolumeClaim pvc-bc9qv found and phase=Bound (110.07595ms)
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 21 15:04:47.156: INFO: Waiting up to 15m0s for pod "blob-volume-tester-hfl25" in namespace "blob-694" to be "Succeeded or Failed"
Jul 21 15:04:47.266: INFO: Pod "blob-volume-tester-hfl25": Phase="Pending", Reason="", readiness=false. Elapsed: 110.119329ms
Jul 21 15:04:49.379: INFO: Pod "blob-volume-tester-hfl25": Phase="Succeeded", Reason="", readiness=false. Elapsed: 2.222963014s
STEP: Saw pod success
Jul 21 15:04:49.379: INFO: Pod "blob-volume-tester-hfl25" 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"
Jul 21 15:04:49.602: INFO: Waiting up to timeout=5m0s for PersistentVolumeClaims [pvc-4kgnp] to have phase Bound
Jul 21 15:04:49.715: INFO: PersistentVolumeClaim pvc-4kgnp found and phase=Bound (113.115615ms)
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 21 15:04:50.048: INFO: Waiting up to 15m0s for pod "blob-volume-tester-rh7nt" in namespace "blob-694" to be "Succeeded or Failed"
Jul 21 15:04:50.158: INFO: Pod "blob-volume-tester-rh7nt": Phase="Pending", Reason="", readiness=false. Elapsed: 110.603377ms
Jul 21 15:04:52.269: INFO: Pod "blob-volume-tester-rh7nt": Phase="Succeeded", Reason="", readiness=false. Elapsed: 2.221659052s
STEP: Saw pod success
Jul 21 15:04:52.269: INFO: Pod "blob-volume-tester-rh7nt" 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"
Jul 21 15:04:52.493: INFO: Waiting up to timeout=5m0s for PersistentVolumeClaims [pvc-rcxbf] to have phase Bound
Jul 21 15:04:52.603: INFO: PersistentVolumeClaim pvc-rcxbf found and phase=Bound (110.219207ms)
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 21 15:04:52.938: INFO: Waiting up to 15m0s for pod "blob-volume-tester-xxz9x" in namespace "blob-694" to be "Succeeded or Failed"
Jul 21 15:04:53.048: INFO: Pod "blob-volume-tester-xxz9x": Phase="Pending", Reason="", readiness=false. Elapsed: 110.40922ms
Jul 21 15:04:55.159: INFO: Pod "blob-volume-tester-xxz9x": Phase="Succeeded", Reason="", readiness=false. Elapsed: 2.221794021s
STEP: Saw pod success
Jul 21 15:04:55.159: INFO: Pod "blob-volume-tester-xxz9x" 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"
Jul 21 15:04:55.384: INFO: Waiting up to timeout=5m0s for PersistentVolumeClaims [pvc-svb85] to have phase Bound
Jul 21 15:04:55.495: INFO: PersistentVolumeClaim pvc-svb85 found and phase=Bound (110.66729ms)
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 21 15:04:55.830: INFO: Waiting up to 15m0s for pod "blob-volume-tester-9rk5g" in namespace "blob-694" to be "Succeeded or Failed"
Jul 21 15:04:55.941: INFO: Pod "blob-volume-tester-9rk5g": Phase="Pending", Reason="", readiness=false. Elapsed: 111.068682ms
Jul 21 15:04:58.054: INFO: Pod "blob-volume-tester-9rk5g": Phase="Succeeded", Reason="", readiness=false. Elapsed: 2.224051471s
STEP: Saw pod success
Jul 21 15:04:58.054: INFO: Pod "blob-volume-tester-9rk5g" satisfied condition "Succeeded or Failed"
Jul 21 15:04:58.054: INFO: deleting Pod "blob-694"/"blob-volume-tester-9rk5g"
Jul 21 15:04:58.166: INFO: Pod blob-volume-tester-9rk5g has the following logs: hello world

STEP: Deleting pod blob-volume-tester-9rk5g in namespace blob-694
Jul 21 15:04:58.287: INFO: deleting PVC "blob-694"/"pvc-svb85"
Jul 21 15:04:58.287: INFO: Deleting PersistentVolumeClaim "pvc-svb85"
... skipping 103 lines ...
Jul 21 15:05:05.999: INFO: PersistentVolumeClaim pvc-zsl2b found but phase is Pending instead of Bound.
Jul 21 15:05:08.111: INFO: PersistentVolumeClaim pvc-zsl2b found and phase=Bound (2.224915149s)
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 21 15:05:08.445: INFO: Waiting up to 15m0s for pod "blob-volume-tester-c8pk9" in namespace "blob-3274" to be "Succeeded or Failed"
Jul 21 15:05:08.556: INFO: Pod "blob-volume-tester-c8pk9": Phase="Pending", Reason="", readiness=false. Elapsed: 111.722404ms
Jul 21 15:05:10.675: INFO: Pod "blob-volume-tester-c8pk9": Phase="Running", Reason="", readiness=true. Elapsed: 2.230766874s
Jul 21 15:05:12.787: INFO: Pod "blob-volume-tester-c8pk9": Phase="Succeeded", Reason="", readiness=false. Elapsed: 4.342566076s
STEP: Saw pod success
Jul 21 15:05:12.787: INFO: Pod "blob-volume-tester-c8pk9" satisfied condition "Succeeded or Failed"
Jul 21 15:05:12.787: INFO: deleting Pod "blob-3274"/"blob-volume-tester-c8pk9"
Jul 21 15:05:12.902: INFO: Pod blob-volume-tester-c8pk9 has the following logs: hello world

STEP: Deleting pod blob-volume-tester-c8pk9 in namespace blob-3274
Jul 21 15:05:13.023: INFO: deleting PVC "blob-3274"/"pvc-zsl2b"
Jul 21 15:05:13.023: INFO: Deleting PersistentVolumeClaim "pvc-zsl2b"
... skipping 33 lines ...
Jul 21 15:05:22.899: INFO: Waiting up to timeout=5m0s for PersistentVolumeClaims [pvc-nhppj] to have phase Bound
Jul 21 15:05:23.009: INFO: PersistentVolumeClaim pvc-nhppj found and phase=Bound (110.001436ms)
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 21 15:05:23.344: INFO: Waiting up to 15m0s for pod "blob-volume-tester-p6b4z" in namespace "blob-495" to be "Succeeded or Failed"
Jul 21 15:05:23.454: INFO: Pod "blob-volume-tester-p6b4z": Phase="Pending", Reason="", readiness=false. Elapsed: 110.282259ms
Jul 21 15:05:25.566: INFO: Pod "blob-volume-tester-p6b4z": Phase="Succeeded", Reason="", readiness=false. Elapsed: 2.222395522s
STEP: Saw pod success
Jul 21 15:05:25.566: INFO: Pod "blob-volume-tester-p6b4z" satisfied condition "Succeeded or Failed"
Jul 21 15:05:25.566: INFO: deleting Pod "blob-495"/"blob-volume-tester-p6b4z"
Jul 21 15:05:25.680: INFO: Pod blob-volume-tester-p6b4z has the following logs: hello world

STEP: Deleting pod blob-volume-tester-p6b4z in namespace blob-495
Jul 21 15:05:25.795: INFO: deleting PVC "blob-495"/"pvc-nhppj"
Jul 21 15:05:25.795: INFO: Deleting PersistentVolumeClaim "pvc-nhppj"
... skipping 45 lines ...
Jul 21 15:05:48.754: INFO: PersistentVolumeClaim pvc-z5pmv found but phase is Pending instead of Bound.
Jul 21 15:05:50.865: INFO: PersistentVolumeClaim pvc-z5pmv found and phase=Bound (21.232542099s)
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 21 15:05:51.201: INFO: Waiting up to 15m0s for pod "blob-volume-tester-xgrdm" in namespace "blob-9947" to be "Succeeded or Failed"
Jul 21 15:05:51.312: INFO: Pod "blob-volume-tester-xgrdm": Phase="Pending", Reason="", readiness=false. Elapsed: 110.724134ms
Jul 21 15:05:53.422: INFO: Pod "blob-volume-tester-xgrdm": Phase="Pending", Reason="", readiness=false. Elapsed: 2.221138561s
Jul 21 15:05:55.535: INFO: Pod "blob-volume-tester-xgrdm": Phase="Succeeded", Reason="", readiness=false. Elapsed: 4.334164442s
STEP: Saw pod success
Jul 21 15:05:55.535: INFO: Pod "blob-volume-tester-xgrdm" satisfied condition "Succeeded or Failed"
Jul 21 15:05:55.535: INFO: deleting Pod "blob-9947"/"blob-volume-tester-xgrdm"
Jul 21 15:05:55.648: INFO: Pod blob-volume-tester-xgrdm has the following logs: hello world

STEP: Deleting pod blob-volume-tester-xgrdm in namespace blob-9947
Jul 21 15:05:55.767: INFO: deleting PVC "blob-9947"/"pvc-z5pmv"
Jul 21 15:05:55.767: INFO: Deleting PersistentVolumeClaim "pvc-z5pmv"
... skipping 34 lines ...
Jul 21 15:05:58.582: INFO: PersistentVolumeClaim pvc-9dwnt found but phase is Pending instead of Bound.
Jul 21 15:06:00.694: INFO: PersistentVolumeClaim pvc-9dwnt found and phase=Bound (2.221333476s)
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 21 15:06:01.033: INFO: Waiting up to 15m0s for pod "blob-volume-tester-p992d" in namespace "blob-5541" to be "Succeeded or Failed"
Jul 21 15:06:01.143: INFO: Pod "blob-volume-tester-p992d": Phase="Pending", Reason="", readiness=false. Elapsed: 110.077827ms
Jul 21 15:06:03.255: INFO: Pod "blob-volume-tester-p992d": Phase="Running", Reason="", readiness=true. Elapsed: 2.222125863s
Jul 21 15:06:05.368: INFO: Pod "blob-volume-tester-p992d": Phase="Succeeded", Reason="", readiness=false. Elapsed: 4.335011214s
STEP: Saw pod success
Jul 21 15:06:05.368: INFO: Pod "blob-volume-tester-p992d" satisfied condition "Succeeded or Failed"
Jul 21 15:06:05.368: INFO: deleting Pod "blob-5541"/"blob-volume-tester-p992d"
Jul 21 15:06:05.480: INFO: Pod blob-volume-tester-p992d has the following logs: hello world

STEP: Deleting pod blob-volume-tester-p992d in namespace blob-5541
Jul 21 15:06:05.602: INFO: deleting PVC "blob-5541"/"pvc-9dwnt"
Jul 21 15:06:05.602: INFO: Deleting PersistentVolumeClaim "pvc-9dwnt"
... skipping 76 lines ...