This job view page is being replaced by Spyglass soon. Check out the new job view.
PRpohly: pull-test.sh: test importing csi-release-tools into other repo
ResultFAILURE
Tests 1 failed / 48 succeeded
Started2021-04-28 18:07
Elapsed21m52s
Revision09dfe7dfbf34a9e4ba6a38813c0b4015f4c90de2
Refs 144

Test Failures


test-shellcheck 0.00s

go run hack/e2e.go -v --test --test_args='--ginkgo.focus=test\-shellcheck$'
/usr/bin/docker

/home/prow/go/src/github.com/kubernetes-csi/external-provisioner/release-tools:
Using shellcheck 0.6.0 docker image.
Errors from shellcheck:

In ./pull-test.sh line 10:
OTHER_REPO_DIR="/home/prow/go/src/github.com/kubernetes-csi/$(ls /home/prow/go/src/github.com/kubernetes-csi | grep -v csi-release-tools)"
m                                                              ^-- SC2010: Don't use ls | grep. Use a glob or a for loop with a condition to allow non-alphanumeric filenames.

For more information:
  https://www.shellcheck.net/wiki/SC2010 -- Don't use ls | grep. Use a glob o...

Please review the above warnings. You can test via "./hack/verify-shellcheck"
If the above warnings do not make sense, you can exempt them from shellcheck
checking by adding the "shellcheck disable" directive
(https://github.com/koalaman/shellcheck/wiki/Directive#disable).

    
				
				Click to see stdout/stderrfrom junit_make_test.xml

Filter through log files | View test history on testgrid


Show 48 Passed Tests

Show 363 Skipped Tests

Error lines from build-log.txt

... skipping 70 lines ...
artifacts: ARTIFACTS=/logs/artifacts
Wed Apr 28 18:07:48 UTC 2021 go1.16.3 $ make all GOFLAGS_VENDOR=-mod=vendor BUILD_PLATFORMS=linux amd64; windows amd64 .exe; linux ppc64le -ppc64le; linux s390x -s390x; linux arm64 -arm64
./release-tools/verify-go-version.sh "go"
mkdir -p bin
echo 'linux amd64; windows amd64 .exe; linux ppc64le -ppc64le; linux s390x -s390x; linux arm64 -arm64' | tr ';' '\n' | while read -r os arch suffix; do \
	if ! (set -x; CGO_ENABLED=0 GOOS="$os" GOARCH="$arch" go build -mod=vendor -a -ldflags ' -X main.version=v2.2.0-2-gc72fea915  -extldflags "-static"' -o "./bin/csi-provisioner$suffix" ./cmd/csi-provisioner); then \
		echo "Building csi-provisioner for GOOS=$os GOARCH=$arch failed, see error(s) above."; \
		exit 1; \
	fi; \
done
+ CGO_ENABLED=0 GOOS=linux GOARCH=amd64 go build -mod=vendor -a -ldflags  -X main.version=v2.2.0-2-gc72fea915  -extldflags "-static" -o ./bin/csi-provisioner ./cmd/csi-provisioner
+ CGO_ENABLED=0 GOOS=windows GOARCH=amd64 go build -mod=vendor -a -ldflags  -X main.version=v2.2.0-2-gc72fea915  -extldflags "-static" -o ./bin/csi-provisioner.exe ./cmd/csi-provisioner
+ CGO_ENABLED=0 GOOS=linux GOARCH=ppc64le go build -mod=vendor -a -ldflags  -X main.version=v2.2.0-2-gc72fea915  -extldflags "-static" -o ./bin/csi-provisioner-ppc64le ./cmd/csi-provisioner
... skipping 128 lines ...

Please review the above warnings. You can test via "./hack/verify-shellcheck"
If the above warnings do not make sense, you can exempt them from shellcheck
checking by adding the "shellcheck disable" directive
(https://github.com/koalaman/shellcheck/wiki/Directive#disable).

make: *** [release-tools/build.make:260: test-shellcheck] Error 1
make: Target 'test' not remade because of errors.
ERROR: 'make test' failed
WARNING: 'make test' failed, proceeding anyway
Wed Apr 28 18:13:35 UTC 2021 go1.16.3 $ make container GOFLAGS_VENDOR=-mod=vendor
./release-tools/verify-go-version.sh "go"
mkdir -p bin
echo '' | tr ';' '\n' | while read -r os arch suffix; do \
	if ! (set -x; CGO_ENABLED=0 GOOS="$os" GOARCH="$arch" go build -mod=vendor -a -ldflags ' -X main.version=v2.2.0-2-gc72fea915  -extldflags "-static"' -o "./bin/csi-provisioner$suffix" ./cmd/csi-provisioner); then \
		echo "Building csi-provisioner for GOOS=$os GOARCH=$arch failed, see error(s) above."; \
		exit 1; \
	fi; \
done
+ CGO_ENABLED=0 GOOS= GOARCH= go build -mod=vendor -a -ldflags  -X main.version=v2.2.0-2-gc72fea915  -extldflags "-static" -o ./bin/csi-provisioner ./cmd/csi-provisioner
docker build -t csi-provisioner:latest -f Dockerfile --label revision=v2.2.0-2-gc72fea915 .
Sending build context to Docker daemon  400.4MB

... skipping 27 lines ...
Step 7/7 : LABEL revision=v2.2.0-2-gc72fea915
 ---> Running in 7684cd2708db
Removing intermediate container 7684cd2708db
 ---> 0ba480fcb7db
Successfully built 0ba480fcb7db
Successfully tagged csi-provisioner:latest
Wed Apr 28 18:14:25 UTC 2021 go1.16.3 $ curl --fail --location -o /home/prow/go/pkg/csiprow.YmckKwjqmV/bin/kind https://github.com/kubernetes-sigs/kind/releases/download/v0.10.0/kind-linux-amd64
  % Total    % Received % Xferd  Average Speed   Time    Time     Time  Current
                                 Dload  Upload   Total   Spent    Left  Speed

  0     0    0     0    0     0      0      0 --:--:-- --:--:-- --:--:--     0
100   624  100   624    0     0   3466      0 --:--:-- --:--:-- --:--:--  3486

100 7277k  100 7277k    0     0   9.8M      0 --:--:-- --:--:-- --:--:--  9.8M
No kind clusters found.
INFO: kind-config.yaml:
... skipping 187 lines ...
do so (now or later) by using -b with the checkout command again. Example:

  git checkout -b <new-branch-name>

HEAD is now at af46c47c Merge pull request #97075 from adtac/apfe2e-5
Wed Apr 28 18:17:23 UTC 2021 go1.16.3 /home/prow/go/src/k8s.io/kubernetes$ git clean -fdx
Wed Apr 28 18:17:23 UTC 2021 go1.16.3 $ curl --fail --location https://dl.google.com/go/go1.15.linux-amd64.tar.gz
  % Total    % Received % Xferd  Average Speed   Time    Time     Time  Current
                                 Dload  Upload   Total   Spent    Left  Speed

  0     0    0     0    0     0      0      0 --:--:-- --:--:-- --:--:--     0
 19  115M   19 22.0M    0     0  23.7M      0  0:00:04 --:--:--  0:00:04 23.6M
 39  115M   39 45.5M    0     0  23.4M      0  0:00:04  0:00:01  0:00:03 23.4M
 74  115M   74 86.2M    0     0  29.6M      0  0:00:03  0:00:02  0:00:01 29.6M
 97  115M   97  112M    0     0  28.9M      0  0:00:03  0:00:03 --:--:-- 28.9M
100  115M  100  115M    0     0  27.8M      0  0:00:04  0:00:04 --:--:-- 27.8M
Wed Apr 28 18:17:27 UTC 2021 go1.15 $ make WHAT=test/e2e/e2e.test -C/home/prow/go/src/k8s.io/kubernetes
make: Entering directory '/home/prow/go/src/k8s.io/kubernetes'
make[1]: Entering directory '/home/prow/go/src/k8s.io/kubernetes'
... skipping 248 lines ...

S [SKIPPING] in Spec Setup (BeforeEach) [0.001 seconds]
External Storage [Driver: hostpath.csi.k8s.io]
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Dynamic PV (ntfs)][sig-windows] subPath
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should fail if non-existent subpath is outside the volume [Slow][LinuxOnly] [BeforeEach]
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:264

    Driver hostpath.csi.k8s.io doesn't support ntfs -- skipping

    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:178
------------------------------
... skipping 168 lines ...

S [SKIPPING] in Spec Setup (BeforeEach) [0.001 seconds]
External Storage [Driver: hostpath.csi.k8s.io]
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Inline-volume (default fs)] subPath
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should fail if non-existent subpath is outside the volume [Slow][LinuxOnly] [BeforeEach]
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:264

    Driver supports dynamic provisioning, skipping InlineVolume pattern

    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:833
------------------------------
... skipping 115 lines ...
Apr 28 18:21:41.448: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
Apr 28 18:21:41.455: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.iobq2n5] to have phase Bound
Apr 28 18:21:41.458: INFO: PersistentVolumeClaim hostpath.csi.k8s.iobq2n5 found but phase is Pending instead of Bound.
Apr 28 18:21:43.461: INFO: PersistentVolumeClaim hostpath.csi.k8s.iobq2n5 found and phase=Bound (2.005921777s)
STEP: Creating pod pod-subpath-test-dynamicpv-r2fm
STEP: Creating a pod to test subpath
Apr 28 18:21:43.470: INFO: Waiting up to 5m0s for pod "pod-subpath-test-dynamicpv-r2fm" in namespace "provisioning-7250" to be "Succeeded or Failed"
Apr 28 18:21:43.473: INFO: Pod "pod-subpath-test-dynamicpv-r2fm": Phase="Pending", Reason="", readiness=false. Elapsed: 2.401048ms
Apr 28 18:21:45.476: INFO: Pod "pod-subpath-test-dynamicpv-r2fm": Phase="Pending", Reason="", readiness=false. Elapsed: 2.005674042s
Apr 28 18:21:47.836: INFO: Pod "pod-subpath-test-dynamicpv-r2fm": Phase="Pending", Reason="", readiness=false. Elapsed: 4.366071627s
Apr 28 18:21:49.840: INFO: Pod "pod-subpath-test-dynamicpv-r2fm": Phase="Pending", Reason="", readiness=false. Elapsed: 6.369493674s
Apr 28 18:21:51.844: INFO: Pod "pod-subpath-test-dynamicpv-r2fm": Phase="Pending", Reason="", readiness=false. Elapsed: 8.373992906s
Apr 28 18:21:53.848: INFO: Pod "pod-subpath-test-dynamicpv-r2fm": Phase="Pending", Reason="", readiness=false. Elapsed: 10.377924899s
Apr 28 18:21:55.851: INFO: Pod "pod-subpath-test-dynamicpv-r2fm": Phase="Pending", Reason="", readiness=false. Elapsed: 12.380963026s
Apr 28 18:21:57.856: INFO: Pod "pod-subpath-test-dynamicpv-r2fm": Phase="Pending", Reason="", readiness=false. Elapsed: 14.385188788s
Apr 28 18:21:59.860: INFO: Pod "pod-subpath-test-dynamicpv-r2fm": Phase="Pending", Reason="", readiness=false. Elapsed: 16.389908551s
Apr 28 18:22:01.864: INFO: Pod "pod-subpath-test-dynamicpv-r2fm": Phase="Pending", Reason="", readiness=false. Elapsed: 18.393487582s
Apr 28 18:22:03.868: INFO: Pod "pod-subpath-test-dynamicpv-r2fm": Phase="Succeeded", Reason="", readiness=false. Elapsed: 20.397270291s
STEP: Saw pod success
Apr 28 18:22:03.868: INFO: Pod "pod-subpath-test-dynamicpv-r2fm" satisfied condition "Succeeded or Failed"
Apr 28 18:22:03.870: INFO: Trying to get logs from node csi-prow-worker2 pod pod-subpath-test-dynamicpv-r2fm container test-container-subpath-dynamicpv-r2fm: <nil>
STEP: delete the pod
Apr 28 18:22:03.895: INFO: Waiting for pod pod-subpath-test-dynamicpv-r2fm to disappear
Apr 28 18:22:03.897: INFO: Pod pod-subpath-test-dynamicpv-r2fm no longer exists
STEP: Deleting pod pod-subpath-test-dynamicpv-r2fm
Apr 28 18:22:03.898: INFO: Deleting pod "pod-subpath-test-dynamicpv-r2fm" in namespace "provisioning-7250"
... skipping 16 lines ...
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Dynamic PV (default fs)] subPath
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should support readOnly file specified in the volumeMount [LinuxOnly]
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:376
------------------------------
{"msg":"PASSED External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (default fs)] subPath should support readOnly file specified in the volumeMount [LinuxOnly]","total":-1,"completed":1,"skipped":315,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (default fs)] subPath 
  should fail if subpath directory is outside the volume [Slow][LinuxOnly]
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:237

[BeforeEach] [Testpattern: Dynamic PV (default fs)] subPath
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:130
[BeforeEach] [Testpattern: Dynamic PV (default fs)] subPath
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:174
STEP: Creating a kubernetes client
Apr 28 18:21:41.121: INFO: >>> kubeConfig: /root/.kube/config
STEP: Building a namespace api object, basename provisioning
Apr 28 18:21:41.172: INFO: No PodSecurityPolicies found; assuming PodSecurityPolicy is disabled.
STEP: Waiting for a default service account to be provisioned in namespace
[It] should fail if subpath directory is outside the volume [Slow][LinuxOnly]
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:237
Apr 28 18:21:41.175: INFO: Creating resource for dynamic PV
Apr 28 18:21:41.175: INFO: Using claimSize:1Mi, test suite supported size:{ 1Mi}, driver(hostpath.csi.k8s.io) supported size:{ 1Mi} 
STEP: creating a StorageClass provisioning-6531-e2e-scw29p5
STEP: creating a claim
Apr 28 18:21:41.180: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
Apr 28 18:21:41.188: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.iov8b62] to have phase Bound
Apr 28 18:21:41.191: INFO: PersistentVolumeClaim hostpath.csi.k8s.iov8b62 found but phase is Pending instead of Bound.
Apr 28 18:21:43.195: INFO: PersistentVolumeClaim hostpath.csi.k8s.iov8b62 found and phase=Bound (2.007093233s)
STEP: Creating pod pod-subpath-test-dynamicpv-bnhm
STEP: Checking for subpath error in container status
Apr 28 18:21:59.211: INFO: Deleting pod "pod-subpath-test-dynamicpv-bnhm" in namespace "provisioning-6531"
Apr 28 18:21:59.215: INFO: Wait up to 5m0s for pod "pod-subpath-test-dynamicpv-bnhm" to be fully deleted
STEP: Deleting pod
Apr 28 18:22:05.223: INFO: Deleting pod "pod-subpath-test-dynamicpv-bnhm" in namespace "provisioning-6531"
STEP: Deleting pvc
Apr 28 18:22:05.226: INFO: Deleting PersistentVolumeClaim "hostpath.csi.k8s.iov8b62"
... skipping 9 lines ...

• [SLOW TEST:29.126 seconds]
External Storage [Driver: hostpath.csi.k8s.io]
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Dynamic PV (default fs)] subPath
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should fail if subpath directory is outside the volume [Slow][LinuxOnly]
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:237
------------------------------
{"msg":"PASSED External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (default fs)] subPath should fail if subpath directory is outside the volume [Slow][LinuxOnly]","total":-1,"completed":1,"skipped":159,"failed":0}

S
------------------------------
[BeforeEach] [Testpattern: Dynamic PV (immediate binding)] topology
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:130
[BeforeEach] [Testpattern: Dynamic PV (immediate binding)] topology
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/topology.go:88
[BeforeEach] [Testpattern: Dynamic PV (immediate binding)] topology
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:174
STEP: Creating a kubernetes client
Apr 28 18:22:10.250: INFO: >>> kubeConfig: /root/.kube/config
STEP: Building a namespace api object, basename topology
STEP: Waiting for a default service account to be provisioned in namespace
[It] should fail to schedule a pod which has topologies that conflict with AllowedTopologies
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/topology.go:192
Apr 28 18:22:10.283: INFO: Driver didn't provide topology keys -- skipping
[AfterEach] [Testpattern: Dynamic PV (immediate binding)] topology
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:175
Apr 28 18:22:10.284: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
STEP: Destroying namespace "topology-5028" for this suite.


S [SKIPPING] [0.040 seconds]
External Storage [Driver: hostpath.csi.k8s.io]
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Dynamic PV (immediate binding)] topology
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should fail to schedule a pod which has topologies that conflict with AllowedTopologies [It]
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/topology.go:192

    Driver didn't provide topology keys -- skipping

    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/topology.go:124
------------------------------
... skipping 75 lines ...
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Dynamic PV (block volmode)] volumeMode
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should not mount / map unused volumes in a pod [LinuxOnly]
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/volumemode.go:347
------------------------------
{"msg":"PASSED External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (block volmode)] volumeMode should not mount / map unused volumes in a pod [LinuxOnly]","total":-1,"completed":1,"skipped":235,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
[BeforeEach] [Testpattern: Dynamic PV (ntfs)(allowExpansion)][sig-windows] volume-expand
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:130
Apr 28 18:22:12.840: INFO: Driver hostpath.csi.k8s.io doesn't support ntfs -- skipping
... skipping 150 lines ...
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Dynamic PV (default fs)] subPath
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should be able to unmount after the subpath directory is deleted [LinuxOnly]
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:441
------------------------------
{"msg":"PASSED External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (default fs)] subPath should be able to unmount after the subpath directory is deleted [LinuxOnly]","total":-1,"completed":1,"skipped":3,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (default fs)] subPath 
  should support existing single file [LinuxOnly]
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:216
... skipping 15 lines ...
Apr 28 18:22:13.035: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
Apr 28 18:22:13.040: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.iohpv6b] to have phase Bound
Apr 28 18:22:13.042: INFO: PersistentVolumeClaim hostpath.csi.k8s.iohpv6b found but phase is Pending instead of Bound.
Apr 28 18:22:15.046: INFO: PersistentVolumeClaim hostpath.csi.k8s.iohpv6b found and phase=Bound (2.006037304s)
STEP: Creating pod pod-subpath-test-dynamicpv-xnjd
STEP: Creating a pod to test subpath
Apr 28 18:22:15.054: INFO: Waiting up to 5m0s for pod "pod-subpath-test-dynamicpv-xnjd" in namespace "provisioning-9004" to be "Succeeded or Failed"
Apr 28 18:22:15.057: INFO: Pod "pod-subpath-test-dynamicpv-xnjd": Phase="Pending", Reason="", readiness=false. Elapsed: 3.199947ms
Apr 28 18:22:17.061: INFO: Pod "pod-subpath-test-dynamicpv-xnjd": Phase="Pending", Reason="", readiness=false. Elapsed: 2.006581271s
Apr 28 18:22:19.065: INFO: Pod "pod-subpath-test-dynamicpv-xnjd": Phase="Pending", Reason="", readiness=false. Elapsed: 4.010532056s
Apr 28 18:22:21.068: INFO: Pod "pod-subpath-test-dynamicpv-xnjd": Phase="Pending", Reason="", readiness=false. Elapsed: 6.013473284s
Apr 28 18:22:23.071: INFO: Pod "pod-subpath-test-dynamicpv-xnjd": Phase="Succeeded", Reason="", readiness=false. Elapsed: 8.016437819s
STEP: Saw pod success
Apr 28 18:22:23.071: INFO: Pod "pod-subpath-test-dynamicpv-xnjd" satisfied condition "Succeeded or Failed"
Apr 28 18:22:23.073: INFO: Trying to get logs from node csi-prow-worker2 pod pod-subpath-test-dynamicpv-xnjd container test-container-subpath-dynamicpv-xnjd: <nil>
STEP: delete the pod
Apr 28 18:22:23.088: INFO: Waiting for pod pod-subpath-test-dynamicpv-xnjd to disappear
Apr 28 18:22:23.090: INFO: Pod pod-subpath-test-dynamicpv-xnjd no longer exists
STEP: Deleting pod pod-subpath-test-dynamicpv-xnjd
Apr 28 18:22:23.090: INFO: Deleting pod "pod-subpath-test-dynamicpv-xnjd" in namespace "provisioning-9004"
... skipping 16 lines ...
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Dynamic PV (default fs)] subPath
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should support existing single file [LinuxOnly]
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:216
------------------------------
{"msg":"PASSED External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (default fs)] subPath should support existing single file [LinuxOnly]","total":-1,"completed":2,"skipped":486,"failed":0}

SSSSSSSSSSSSSSSSSS
------------------------------
[BeforeEach] [Testpattern: Dynamic PV (ntfs)][sig-windows] subPath
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:130
Apr 28 18:22:28.150: INFO: Driver hostpath.csi.k8s.io doesn't support ntfs -- skipping
... skipping 146 lines ...
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Dynamic PV (default fs)] volumeIO
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should write files of various sizes, verify size, validate content [Slow][LinuxOnly]
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/volume_io.go:144
------------------------------
{"msg":"PASSED External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (default fs)] volumeIO should write files of various sizes, verify size, validate content [Slow][LinuxOnly]","total":-1,"completed":1,"skipped":235,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (default fs)] volumes 
  should allow exec of files on the volume
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/volumes.go:192
... skipping 15 lines ...
Apr 28 18:22:10.403: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
Apr 28 18:22:10.407: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.io2kz5s] to have phase Bound
Apr 28 18:22:10.409: INFO: PersistentVolumeClaim hostpath.csi.k8s.io2kz5s found but phase is Pending instead of Bound.
Apr 28 18:22:12.414: INFO: PersistentVolumeClaim hostpath.csi.k8s.io2kz5s found and phase=Bound (2.007323824s)
STEP: Creating pod exec-volume-test-dynamicpv-h74k
STEP: Creating a pod to test exec-volume-test
Apr 28 18:22:12.424: INFO: Waiting up to 5m0s for pod "exec-volume-test-dynamicpv-h74k" in namespace "volume-5287" to be "Succeeded or Failed"
Apr 28 18:22:12.435: INFO: Pod "exec-volume-test-dynamicpv-h74k": Phase="Pending", Reason="", readiness=false. Elapsed: 10.739732ms
Apr 28 18:22:14.443: INFO: Pod "exec-volume-test-dynamicpv-h74k": Phase="Pending", Reason="", readiness=false. Elapsed: 2.019008535s
Apr 28 18:22:16.446: INFO: Pod "exec-volume-test-dynamicpv-h74k": Phase="Pending", Reason="", readiness=false. Elapsed: 4.022071526s
Apr 28 18:22:18.449: INFO: Pod "exec-volume-test-dynamicpv-h74k": Phase="Pending", Reason="", readiness=false. Elapsed: 6.024768062s
Apr 28 18:22:20.452: INFO: Pod "exec-volume-test-dynamicpv-h74k": Phase="Pending", Reason="", readiness=false. Elapsed: 8.028192441s
Apr 28 18:22:22.456: INFO: Pod "exec-volume-test-dynamicpv-h74k": Phase="Pending", Reason="", readiness=false. Elapsed: 10.032247336s
Apr 28 18:22:24.460: INFO: Pod "exec-volume-test-dynamicpv-h74k": Phase="Pending", Reason="", readiness=false. Elapsed: 12.035727784s
Apr 28 18:22:26.463: INFO: Pod "exec-volume-test-dynamicpv-h74k": Phase="Succeeded", Reason="", readiness=false. Elapsed: 14.03904303s
STEP: Saw pod success
Apr 28 18:22:26.463: INFO: Pod "exec-volume-test-dynamicpv-h74k" satisfied condition "Succeeded or Failed"
Apr 28 18:22:26.465: INFO: Trying to get logs from node csi-prow-worker2 pod exec-volume-test-dynamicpv-h74k container exec-container-dynamicpv-h74k: <nil>
STEP: delete the pod
Apr 28 18:22:26.480: INFO: Waiting for pod exec-volume-test-dynamicpv-h74k to disappear
Apr 28 18:22:26.482: INFO: Pod exec-volume-test-dynamicpv-h74k no longer exists
STEP: Deleting pod exec-volume-test-dynamicpv-h74k
Apr 28 18:22:26.482: INFO: Deleting pod "exec-volume-test-dynamicpv-h74k" in namespace "volume-5287"
... skipping 14 lines ...
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Dynamic PV (default fs)] volumes
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should allow exec of files on the volume
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/volumes.go:192
------------------------------
{"msg":"PASSED External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (default fs)] volumes should allow exec of files on the volume","total":-1,"completed":2,"skipped":220,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (block volmode)(allowExpansion)] volume-expand 
  Verify if offline PVC expansion works
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/volume_expand.go:169
... skipping 52 lines ...
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Dynamic PV (block volmode)(allowExpansion)] volume-expand
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    Verify if offline PVC expansion works
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/volume_expand.go:169
------------------------------
{"msg":"PASSED External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (block volmode)(allowExpansion)] volume-expand Verify if offline PVC expansion works","total":-1,"completed":1,"skipped":23,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (default fs)] subPath 
  should support readOnly directory specified in the volumeMount
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:361
... skipping 15 lines ...
Apr 28 18:22:31.125: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
Apr 28 18:22:31.132: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.ior8lqv] to have phase Bound
Apr 28 18:22:31.134: INFO: PersistentVolumeClaim hostpath.csi.k8s.ior8lqv found but phase is Pending instead of Bound.
Apr 28 18:22:33.137: INFO: PersistentVolumeClaim hostpath.csi.k8s.ior8lqv found and phase=Bound (2.005127401s)
STEP: Creating pod pod-subpath-test-dynamicpv-jkk4
STEP: Creating a pod to test subpath
Apr 28 18:22:33.148: INFO: Waiting up to 5m0s for pod "pod-subpath-test-dynamicpv-jkk4" in namespace "provisioning-6265" to be "Succeeded or Failed"
Apr 28 18:22:33.151: INFO: Pod "pod-subpath-test-dynamicpv-jkk4": Phase="Pending", Reason="", readiness=false. Elapsed: 2.624359ms
Apr 28 18:22:35.156: INFO: Pod "pod-subpath-test-dynamicpv-jkk4": Phase="Pending", Reason="", readiness=false. Elapsed: 2.008203878s
Apr 28 18:22:37.161: INFO: Pod "pod-subpath-test-dynamicpv-jkk4": Phase="Pending", Reason="", readiness=false. Elapsed: 4.013239897s
Apr 28 18:22:39.167: INFO: Pod "pod-subpath-test-dynamicpv-jkk4": Phase="Pending", Reason="", readiness=false. Elapsed: 6.01907763s
Apr 28 18:22:41.170: INFO: Pod "pod-subpath-test-dynamicpv-jkk4": Phase="Pending", Reason="", readiness=false. Elapsed: 8.022394429s
Apr 28 18:22:43.174: INFO: Pod "pod-subpath-test-dynamicpv-jkk4": Phase="Pending", Reason="", readiness=false. Elapsed: 10.025908257s
Apr 28 18:22:45.176: INFO: Pod "pod-subpath-test-dynamicpv-jkk4": Phase="Pending", Reason="", readiness=false. Elapsed: 12.028505129s
Apr 28 18:22:47.180: INFO: Pod "pod-subpath-test-dynamicpv-jkk4": Phase="Succeeded", Reason="", readiness=false. Elapsed: 14.031852934s
STEP: Saw pod success
Apr 28 18:22:47.180: INFO: Pod "pod-subpath-test-dynamicpv-jkk4" satisfied condition "Succeeded or Failed"
Apr 28 18:22:47.182: INFO: Trying to get logs from node csi-prow-worker2 pod pod-subpath-test-dynamicpv-jkk4 container test-container-subpath-dynamicpv-jkk4: <nil>
STEP: delete the pod
Apr 28 18:22:47.197: INFO: Waiting for pod pod-subpath-test-dynamicpv-jkk4 to disappear
Apr 28 18:22:47.199: INFO: Pod pod-subpath-test-dynamicpv-jkk4 no longer exists
STEP: Deleting pod pod-subpath-test-dynamicpv-jkk4
Apr 28 18:22:47.199: INFO: Deleting pod "pod-subpath-test-dynamicpv-jkk4" in namespace "provisioning-6265"
... skipping 16 lines ...
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Dynamic PV (default fs)] subPath
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should support readOnly directory specified in the volumeMount
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:361
------------------------------
{"msg":"PASSED External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (default fs)] subPath should support readOnly directory specified in the volumeMount","total":-1,"completed":2,"skipped":295,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
[BeforeEach] [Testpattern: Dynamic PV (ntfs)][sig-windows] volumes
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:130
Apr 28 18:22:52.265: INFO: Driver hostpath.csi.k8s.io doesn't support ntfs -- skipping
... skipping 58 lines ...
STEP: creating a claim
Apr 28 18:22:20.344: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.iot8zmm] to have phase Bound
Apr 28 18:22:20.347: INFO: PersistentVolumeClaim hostpath.csi.k8s.iot8zmm found but phase is Pending instead of Bound.
Apr 28 18:22:22.351: INFO: PersistentVolumeClaim hostpath.csi.k8s.iot8zmm found and phase=Bound (2.006067525s)
STEP: Expanding non-expandable pvc
Apr 28 18:22:22.356: INFO: currentPvcSize {{1073741824 0} {<nil>} 1Gi BinarySI}, newSize {{2147483648 0} {<nil>}  BinarySI}
Apr 28 18:22:22.362: INFO: Error updating pvc hostpath.csi.k8s.iot8zmm: persistentvolumeclaims "hostpath.csi.k8s.iot8zmm" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
Apr 28 18:22:24.371: INFO: Error updating pvc hostpath.csi.k8s.iot8zmm: persistentvolumeclaims "hostpath.csi.k8s.iot8zmm" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
Apr 28 18:22:26.370: INFO: Error updating pvc hostpath.csi.k8s.iot8zmm: persistentvolumeclaims "hostpath.csi.k8s.iot8zmm" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
Apr 28 18:22:28.386: INFO: Error updating pvc hostpath.csi.k8s.iot8zmm: persistentvolumeclaims "hostpath.csi.k8s.iot8zmm" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
Apr 28 18:22:30.372: INFO: Error updating pvc hostpath.csi.k8s.iot8zmm: persistentvolumeclaims "hostpath.csi.k8s.iot8zmm" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
Apr 28 18:22:32.372: INFO: Error updating pvc hostpath.csi.k8s.iot8zmm: persistentvolumeclaims "hostpath.csi.k8s.iot8zmm" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
Apr 28 18:22:34.371: INFO: Error updating pvc hostpath.csi.k8s.iot8zmm: persistentvolumeclaims "hostpath.csi.k8s.iot8zmm" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
Apr 28 18:22:36.373: INFO: Error updating pvc hostpath.csi.k8s.iot8zmm: persistentvolumeclaims "hostpath.csi.k8s.iot8zmm" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
Apr 28 18:22:38.371: INFO: Error updating pvc hostpath.csi.k8s.iot8zmm: persistentvolumeclaims "hostpath.csi.k8s.iot8zmm" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
Apr 28 18:22:40.372: INFO: Error updating pvc hostpath.csi.k8s.iot8zmm: persistentvolumeclaims "hostpath.csi.k8s.iot8zmm" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
Apr 28 18:22:42.370: INFO: Error updating pvc hostpath.csi.k8s.iot8zmm: persistentvolumeclaims "hostpath.csi.k8s.iot8zmm" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
Apr 28 18:22:44.371: INFO: Error updating pvc hostpath.csi.k8s.iot8zmm: persistentvolumeclaims "hostpath.csi.k8s.iot8zmm" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
Apr 28 18:22:46.370: INFO: Error updating pvc hostpath.csi.k8s.iot8zmm: persistentvolumeclaims "hostpath.csi.k8s.iot8zmm" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
Apr 28 18:22:48.371: INFO: Error updating pvc hostpath.csi.k8s.iot8zmm: persistentvolumeclaims "hostpath.csi.k8s.iot8zmm" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
Apr 28 18:22:50.372: INFO: Error updating pvc hostpath.csi.k8s.iot8zmm: persistentvolumeclaims "hostpath.csi.k8s.iot8zmm" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
Apr 28 18:22:52.377: INFO: Error updating pvc hostpath.csi.k8s.iot8zmm: persistentvolumeclaims "hostpath.csi.k8s.iot8zmm" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
Apr 28 18:22:52.384: INFO: Error updating pvc hostpath.csi.k8s.iot8zmm: persistentvolumeclaims "hostpath.csi.k8s.iot8zmm" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
STEP: Deleting pvc
Apr 28 18:22:52.384: INFO: Deleting PersistentVolumeClaim "hostpath.csi.k8s.iot8zmm"
Apr 28 18:22:52.391: INFO: Waiting up to 5m0s for PersistentVolume pvc-da5afbc0-6308-46ab-9aba-5195a6b66809 to get deleted
Apr 28 18:22:52.397: INFO: PersistentVolume pvc-da5afbc0-6308-46ab-9aba-5195a6b66809 found and phase=Bound (6.018369ms)
Apr 28 18:22:57.400: INFO: PersistentVolume pvc-da5afbc0-6308-46ab-9aba-5195a6b66809 was removed
STEP: Deleting sc
... skipping 8 lines ...
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Dynamic PV (block volmode)] volume-expand
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should not allow expansion of pvcs without AllowVolumeExpansion property
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/volume_expand.go:154
------------------------------
{"msg":"PASSED External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (block volmode)] volume-expand should not allow expansion of pvcs without AllowVolumeExpansion property","total":-1,"completed":2,"skipped":46,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
[BeforeEach] [Testpattern: Pre-provisioned PV (default fs)] subPath
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:130
Apr 28 18:22:57.478: INFO: Driver supports dynamic provisioning, skipping PreprovisionedPV pattern
... skipping 3 lines ...

S [SKIPPING] in Spec Setup (BeforeEach) [0.001 seconds]
External Storage [Driver: hostpath.csi.k8s.io]
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Pre-provisioned PV (default fs)] subPath
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should fail if non-existent subpath is outside the volume [Slow][LinuxOnly] [BeforeEach]
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:264

    Driver supports dynamic provisioning, skipping PreprovisionedPV pattern

    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:833
------------------------------
... skipping 20 lines ...
Apr 28 18:22:52.543: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
Apr 28 18:22:52.552: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.io47clv] to have phase Bound
Apr 28 18:22:52.554: INFO: PersistentVolumeClaim hostpath.csi.k8s.io47clv found but phase is Pending instead of Bound.
Apr 28 18:22:54.558: INFO: PersistentVolumeClaim hostpath.csi.k8s.io47clv found and phase=Bound (2.005460192s)
STEP: Creating pod pod-subpath-test-dynamicpv-sczg
STEP: Creating a pod to test multi_subpath
Apr 28 18:22:54.568: INFO: Waiting up to 5m0s for pod "pod-subpath-test-dynamicpv-sczg" in namespace "provisioning-2917" to be "Succeeded or Failed"
Apr 28 18:22:54.571: INFO: Pod "pod-subpath-test-dynamicpv-sczg": Phase="Pending", Reason="", readiness=false. Elapsed: 2.212011ms
Apr 28 18:22:56.576: INFO: Pod "pod-subpath-test-dynamicpv-sczg": Phase="Pending", Reason="", readiness=false. Elapsed: 2.006457125s
Apr 28 18:22:58.579: INFO: Pod "pod-subpath-test-dynamicpv-sczg": Phase="Pending", Reason="", readiness=false. Elapsed: 4.009636147s
Apr 28 18:23:00.582: INFO: Pod "pod-subpath-test-dynamicpv-sczg": Phase="Pending", Reason="", readiness=false. Elapsed: 6.013113779s
Apr 28 18:23:02.585: INFO: Pod "pod-subpath-test-dynamicpv-sczg": Phase="Pending", Reason="", readiness=false. Elapsed: 8.016039341s
Apr 28 18:23:04.590: INFO: Pod "pod-subpath-test-dynamicpv-sczg": Phase="Pending", Reason="", readiness=false. Elapsed: 10.020822419s
Apr 28 18:23:06.594: INFO: Pod "pod-subpath-test-dynamicpv-sczg": Phase="Succeeded", Reason="", readiness=false. Elapsed: 12.024617247s
STEP: Saw pod success
Apr 28 18:23:06.594: INFO: Pod "pod-subpath-test-dynamicpv-sczg" satisfied condition "Succeeded or Failed"
Apr 28 18:23:06.597: INFO: Trying to get logs from node csi-prow-worker2 pod pod-subpath-test-dynamicpv-sczg container test-container-subpath-dynamicpv-sczg: <nil>
STEP: delete the pod
Apr 28 18:23:06.611: INFO: Waiting for pod pod-subpath-test-dynamicpv-sczg to disappear
Apr 28 18:23:06.613: INFO: Pod pod-subpath-test-dynamicpv-sczg no longer exists
STEP: Deleting pod
Apr 28 18:23:06.613: INFO: Deleting pod "pod-subpath-test-dynamicpv-sczg" in namespace "provisioning-2917"
... skipping 14 lines ...
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Dynamic PV (default fs)] subPath
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should support creating multiple subpath from same volumes [Slow]
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:291
------------------------------
{"msg":"PASSED External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (default fs)] subPath should support creating multiple subpath from same volumes [Slow]","total":-1,"completed":3,"skipped":511,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
[BeforeEach] [Testpattern: Inline-volume (ext4)] volumes
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:130
Apr 28 18:23:11.893: INFO: Driver "hostpath.csi.k8s.io" does not support volume type "InlineVolume" - skipping
... skipping 127 lines ...
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Dynamic PV (filesystem volmode)] multiVolume [Slow]
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should concurrently access the single read-only volume from pods on the same node
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/multivolume.go:333
------------------------------
{"msg":"PASSED External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (filesystem volmode)] multiVolume [Slow] should concurrently access the single read-only volume from pods on the same node","total":-1,"completed":2,"skipped":341,"failed":0}

SSSSSS
------------------------------
[BeforeEach] [Testpattern: Dynamic PV (ntfs)][sig-windows] subPath
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:130
Apr 28 18:23:12.735: INFO: Driver hostpath.csi.k8s.io doesn't support ntfs -- skipping
... skipping 3 lines ...

S [SKIPPING] in Spec Setup (BeforeEach) [0.001 seconds]
External Storage [Driver: hostpath.csi.k8s.io]
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Dynamic PV (ntfs)][sig-windows] subPath
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should fail if subpath directory is outside the volume [Slow][LinuxOnly] [BeforeEach]
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:237

    Driver hostpath.csi.k8s.io doesn't support ntfs -- skipping

    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:178
------------------------------
... skipping 50 lines ...
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Dynamic PV (default fs)(allowExpansion)] volume-expand
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should resize volume when PVC is edited while pod is using it
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/volume_expand.go:241
------------------------------
{"msg":"PASSED External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (default fs)(allowExpansion)] volume-expand should resize volume when PVC is edited while pod is using it","total":-1,"completed":1,"skipped":3,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
[BeforeEach] [Testpattern: Pre-provisioned PV (block volmode)] volumeMode
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:130
Apr 28 18:23:22.060: INFO: Driver "hostpath.csi.k8s.io" does not support volume type "PreprovisionedPV" - skipping
... skipping 3 lines ...

S [SKIPPING] in Spec Setup (BeforeEach) [0.001 seconds]
External Storage [Driver: hostpath.csi.k8s.io]
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Pre-provisioned PV (block volmode)] volumeMode
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should fail to use a volume in a pod with mismatched mode [Slow] [BeforeEach]
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/volumemode.go:292

    Driver "hostpath.csi.k8s.io" does not support volume type "PreprovisionedPV" - skipping

    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:247
------------------------------
... skipping 64 lines ...
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Dynamic PV (block volmode)] multiVolume [Slow]
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should concurrently access the single read-only volume from pods on the same node
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/multivolume.go:333
------------------------------
{"msg":"PASSED External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (block volmode)] multiVolume [Slow] should concurrently access the single read-only volume from pods on the same node","total":-1,"completed":3,"skipped":700,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
[BeforeEach] [Testpattern: Dynamic PV (ext3)] volumes
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:130
Apr 28 18:23:22.151: INFO: Driver hostpath.csi.k8s.io doesn't support ext3 -- skipping
... skipping 117 lines ...
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Dynamic PV (block volmode)] multiVolume [Slow]
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should concurrently access the single volume from pods on the same node [LinuxOnly]
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/multivolume.go:308
------------------------------
{"msg":"PASSED External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (block volmode)] multiVolume [Slow] should concurrently access the single volume from pods on the same node [LinuxOnly]","total":-1,"completed":2,"skipped":78,"failed":0}

SSSSSSSSSSSSSSSSS
------------------------------
[BeforeEach] [Testpattern: Inline-volume (default fs)] subPath
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:130
Apr 28 18:23:31.284: INFO: Driver supports dynamic provisioning, skipping InlineVolume pattern
... skipping 24 lines ...

S [SKIPPING] in Spec Setup (BeforeEach) [0.001 seconds]
External Storage [Driver: hostpath.csi.k8s.io]
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Pre-provisioned PV (default fs)] subPath
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should fail if subpath file is outside the volume [Slow][LinuxOnly] [BeforeEach]
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:253

    Driver supports dynamic provisioning, skipping PreprovisionedPV pattern

    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:833
------------------------------
... skipping 53 lines ...
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Dynamic PV (filesystem volmode)] volumeMode
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should not mount / map unused volumes in a pod [LinuxOnly]
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/volumemode.go:347
------------------------------
{"msg":"PASSED External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (filesystem volmode)] volumeMode should not mount / map unused volumes in a pod [LinuxOnly]","total":-1,"completed":4,"skipped":756,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
[BeforeEach] [Testpattern: Inline-volume (default fs)] subPath
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:130
Apr 28 18:23:41.464: INFO: Driver supports dynamic provisioning, skipping InlineVolume pattern
... skipping 89 lines ...

S [SKIPPING] in Spec Setup (BeforeEach) [0.001 seconds]
External Storage [Driver: hostpath.csi.k8s.io]
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Inline-volume (default fs)] subPath
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should fail if subpath file is outside the volume [Slow][LinuxOnly] [BeforeEach]
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:253

    Driver supports dynamic provisioning, skipping InlineVolume pattern

    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:833
------------------------------
... skipping 129 lines ...
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Dynamic PV (default fs)] volumes
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should store data
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/volumes.go:151
------------------------------
{"msg":"PASSED External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (default fs)] volumes should store data","total":-1,"completed":3,"skipped":106,"failed":0}

SSS
------------------------------
[BeforeEach] [Testpattern: Pre-provisioned PV (default fs)] subPath
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:130
Apr 28 18:23:43.574: INFO: Driver supports dynamic provisioning, skipping PreprovisionedPV pattern
... skipping 34 lines ...

    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:178
------------------------------
SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (default fs)] subPath 
  should fail if subpath file is outside the volume [Slow][LinuxOnly]
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:253

[BeforeEach] [Testpattern: Dynamic PV (default fs)] subPath
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:130
[BeforeEach] [Testpattern: Dynamic PV (default fs)] subPath
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:174
STEP: Creating a kubernetes client
Apr 28 18:23:41.674: INFO: >>> kubeConfig: /root/.kube/config
STEP: Building a namespace api object, basename provisioning
STEP: Waiting for a default service account to be provisioned in namespace
[It] should fail if subpath file is outside the volume [Slow][LinuxOnly]
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:253
Apr 28 18:23:41.706: INFO: Creating resource for dynamic PV
Apr 28 18:23:41.706: INFO: Using claimSize:1Mi, test suite supported size:{ 1Mi}, driver(hostpath.csi.k8s.io) supported size:{ 1Mi} 
STEP: creating a StorageClass provisioning-1351-e2e-scmqfdz
STEP: creating a claim
Apr 28 18:23:41.709: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
Apr 28 18:23:41.715: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.io8bt86] to have phase Bound
Apr 28 18:23:41.718: INFO: PersistentVolumeClaim hostpath.csi.k8s.io8bt86 found but phase is Pending instead of Bound.
Apr 28 18:23:43.723: INFO: PersistentVolumeClaim hostpath.csi.k8s.io8bt86 found and phase=Bound (2.008150736s)
STEP: Creating pod pod-subpath-test-dynamicpv-2r7z
STEP: Checking for subpath error in container status
Apr 28 18:23:55.739: INFO: Deleting pod "pod-subpath-test-dynamicpv-2r7z" in namespace "provisioning-1351"
Apr 28 18:23:55.750: INFO: Wait up to 5m0s for pod "pod-subpath-test-dynamicpv-2r7z" to be fully deleted
STEP: Deleting pod
Apr 28 18:24:05.756: INFO: Deleting pod "pod-subpath-test-dynamicpv-2r7z" in namespace "provisioning-1351"
STEP: Deleting pvc
Apr 28 18:24:05.759: INFO: Deleting PersistentVolumeClaim "hostpath.csi.k8s.io8bt86"
... skipping 9 lines ...

• [SLOW TEST:29.108 seconds]
External Storage [Driver: hostpath.csi.k8s.io]
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Dynamic PV (default fs)] subPath
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should fail if subpath file is outside the volume [Slow][LinuxOnly]
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:253
------------------------------
{"msg":"PASSED External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (default fs)] subPath should fail if subpath file is outside the volume [Slow][LinuxOnly]","total":-1,"completed":5,"skipped":954,"failed":0}

SSSSSSSSSSSSSSSSSSSSS
------------------------------
External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (default fs)] subPath 
  should fail if subpath with backstepping is outside the volume [Slow][LinuxOnly]
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:275

[BeforeEach] [Testpattern: Dynamic PV (default fs)] subPath
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:130
[BeforeEach] [Testpattern: Dynamic PV (default fs)] subPath
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:174
STEP: Creating a kubernetes client
Apr 28 18:23:43.694: INFO: >>> kubeConfig: /root/.kube/config
STEP: Building a namespace api object, basename provisioning
STEP: Waiting for a default service account to be provisioned in namespace
[It] should fail if subpath with backstepping is outside the volume [Slow][LinuxOnly]
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:275
Apr 28 18:23:43.725: INFO: Creating resource for dynamic PV
Apr 28 18:23:43.725: INFO: Using claimSize:1Mi, test suite supported size:{ 1Mi}, driver(hostpath.csi.k8s.io) supported size:{ 1Mi} 
STEP: creating a StorageClass provisioning-1130-e2e-scnv96m
STEP: creating a claim
Apr 28 18:23:43.729: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
Apr 28 18:23:43.739: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.io46nw5] to have phase Bound
Apr 28 18:23:43.743: INFO: PersistentVolumeClaim hostpath.csi.k8s.io46nw5 found but phase is Pending instead of Bound.
Apr 28 18:23:45.746: INFO: PersistentVolumeClaim hostpath.csi.k8s.io46nw5 found and phase=Bound (2.006948456s)
STEP: Creating pod pod-subpath-test-dynamicpv-fq76
STEP: Checking for subpath error in container status
Apr 28 18:23:57.761: INFO: Deleting pod "pod-subpath-test-dynamicpv-fq76" in namespace "provisioning-1130"
Apr 28 18:23:57.767: INFO: Wait up to 5m0s for pod "pod-subpath-test-dynamicpv-fq76" to be fully deleted
STEP: Deleting pod
Apr 28 18:24:05.775: INFO: Deleting pod "pod-subpath-test-dynamicpv-fq76" in namespace "provisioning-1130"
STEP: Deleting pvc
Apr 28 18:24:05.778: INFO: Deleting PersistentVolumeClaim "hostpath.csi.k8s.io46nw5"
... skipping 9 lines ...

• [SLOW TEST:27.120 seconds]
External Storage [Driver: hostpath.csi.k8s.io]
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Dynamic PV (default fs)] subPath
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should fail if subpath with backstepping is outside the volume [Slow][LinuxOnly]
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:275
------------------------------
S
------------------------------
{"msg":"PASSED External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (default fs)] subPath should fail if subpath with backstepping is outside the volume [Slow][LinuxOnly]","total":-1,"completed":4,"skipped":204,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
[BeforeEach] [Testpattern: Dynamic PV (ntfs)][sig-windows] subPath
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:130
Apr 28 18:24:10.855: INFO: Driver hostpath.csi.k8s.io doesn't support ntfs -- skipping
... skipping 291 lines ...
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Dynamic PV (filesystem volmode)] multiVolume [Slow]
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should access to two volumes with the same volume mode and retain data across pod recreation on the same node [LinuxOnly]
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/multivolume.go:130
------------------------------
{"msg":"PASSED External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (filesystem volmode)] multiVolume [Slow] should access to two volumes with the same volume mode and retain data across pod recreation on the same node [LinuxOnly]","total":-1,"completed":3,"skipped":388,"failed":0}

SSSSSSSSSSSSSSSSSSSS
------------------------------
External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (default fs)] subPath 
  should support restarting containers using directory as subpath [Slow]
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:317
... skipping 57 lines ...
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Dynamic PV (default fs)] subPath
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should support restarting containers using directory as subpath [Slow]
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:317
------------------------------
{"msg":"PASSED External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (default fs)] subPath should support restarting containers using directory as subpath [Slow]","total":-1,"completed":3,"skipped":245,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
[BeforeEach] [Testpattern: Dynamic PV (ntfs)][sig-windows] subPath
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:130
Apr 28 18:24:31.131: INFO: Driver hostpath.csi.k8s.io doesn't support ntfs -- skipping
... skipping 271 lines ...
STEP: creating a claim
Apr 28 18:24:25.380: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
Apr 28 18:24:25.385: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.io4jfkc] to have phase Bound
Apr 28 18:24:25.387: INFO: PersistentVolumeClaim hostpath.csi.k8s.io4jfkc found but phase is Pending instead of Bound.
Apr 28 18:24:27.391: INFO: PersistentVolumeClaim hostpath.csi.k8s.io4jfkc found and phase=Bound (2.005902566s)
STEP: Creating pod to format volume volume-prep-provisioning-8418
Apr 28 18:24:27.402: INFO: Waiting up to 5m0s for pod "volume-prep-provisioning-8418" in namespace "provisioning-8418" to be "Succeeded or Failed"
Apr 28 18:24:27.405: INFO: Pod "volume-prep-provisioning-8418": Phase="Pending", Reason="", readiness=false. Elapsed: 3.210646ms
Apr 28 18:24:29.409: INFO: Pod "volume-prep-provisioning-8418": Phase="Pending", Reason="", readiness=false. Elapsed: 2.006706431s
Apr 28 18:24:31.412: INFO: Pod "volume-prep-provisioning-8418": Phase="Succeeded", Reason="", readiness=false. Elapsed: 4.010239018s
STEP: Saw pod success
Apr 28 18:24:31.412: INFO: Pod "volume-prep-provisioning-8418" satisfied condition "Succeeded or Failed"
Apr 28 18:24:31.412: INFO: Deleting pod "volume-prep-provisioning-8418" in namespace "provisioning-8418"
Apr 28 18:24:31.423: INFO: Wait up to 5m0s for pod "volume-prep-provisioning-8418" to be fully deleted
STEP: Creating pod pod-subpath-test-dynamicpv-hgk2
STEP: Checking for subpath error in container status
Apr 28 18:24:41.438: INFO: Deleting pod "pod-subpath-test-dynamicpv-hgk2" in namespace "provisioning-8418"
Apr 28 18:24:41.448: INFO: Wait up to 5m0s for pod "pod-subpath-test-dynamicpv-hgk2" to be fully deleted
STEP: Deleting pod
Apr 28 18:24:41.450: INFO: Deleting pod "pod-subpath-test-dynamicpv-hgk2" in namespace "provisioning-8418"
STEP: Deleting pvc
Apr 28 18:24:41.453: INFO: Deleting PersistentVolumeClaim "hostpath.csi.k8s.io4jfkc"
... skipping 12 lines ...
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Dynamic PV (default fs)] subPath
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should verify container cannot write to subpath readonly volumes [Slow]
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:419
------------------------------
{"msg":"PASSED External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (default fs)] subPath should verify container cannot write to subpath readonly volumes [Slow]","total":-1,"completed":4,"skipped":408,"failed":0}

SSSSSSSS
------------------------------
[BeforeEach] [Testpattern: Pre-provisioned PV (filesystem volmode)] multiVolume [Slow]
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:130
Apr 28 18:24:46.490: INFO: Driver supports dynamic provisioning, skipping PreprovisionedPV pattern
... skipping 24 lines ...

S [SKIPPING] in Spec Setup (BeforeEach) [0.001 seconds]
External Storage [Driver: hostpath.csi.k8s.io]
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Pre-provisioned PV (filesystem volmode)] volumeMode
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should fail to use a volume in a pod with mismatched mode [Slow] [BeforeEach]
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/volumemode.go:292

    Driver "hostpath.csi.k8s.io" does not support volume type "PreprovisionedPV" - skipping

    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:247
------------------------------
... skipping 149 lines ...
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Dynamic PV (block volmode)] multiVolume [Slow]
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should access to two volumes with different volume mode and retain data across pod recreation on the same node [LinuxOnly]
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/multivolume.go:210
------------------------------
{"msg":"PASSED External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (block volmode)] multiVolume [Slow] should access to two volumes with different volume mode and retain data across pod recreation on the same node [LinuxOnly]","total":-1,"completed":5,"skipped":452,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
[BeforeEach] [Testpattern: Pre-provisioned PV (ext4)] volumes
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:130
Apr 28 18:25:05.915: INFO: Driver "hostpath.csi.k8s.io" does not support volume type "PreprovisionedPV" - skipping
... skipping 222 lines ...
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Dynamic PV (filesystem volmode)] multiVolume [Slow]
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should concurrently access the single volume from pods on the same node [LinuxOnly]
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/multivolume.go:308
------------------------------
{"msg":"PASSED External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (filesystem volmode)] multiVolume [Slow] should concurrently access the single volume from pods on the same node [LinuxOnly]","total":-1,"completed":4,"skipped":624,"failed":0}

SSSSSSSSSSSSS
------------------------------
[BeforeEach] [Testpattern: Pre-provisioned PV (default fs)] subPath
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:130
Apr 28 18:25:10.762: INFO: Driver supports dynamic provisioning, skipping PreprovisionedPV pattern
... skipping 108 lines ...

S [SKIPPING] in Spec Setup (BeforeEach) [0.001 seconds]
External Storage [Driver: hostpath.csi.k8s.io]
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Inline-volume (default fs)] subPath
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should fail if subpath directory is outside the volume [Slow][LinuxOnly] [BeforeEach]
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:237

    Driver supports dynamic provisioning, skipping InlineVolume pattern

    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:833
------------------------------
... skipping 50 lines ...

S [SKIPPING] in Spec Setup (BeforeEach) [0.001 seconds]
External Storage [Driver: hostpath.csi.k8s.io]
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Dynamic PV (ntfs)][sig-windows] subPath
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should fail if subpath file is outside the volume [Slow][LinuxOnly] [BeforeEach]
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:253

    Driver hostpath.csi.k8s.io doesn't support ntfs -- skipping

    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:178
------------------------------
... skipping 48 lines ...
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Dynamic PV (block volmode)(allowExpansion)] volume-expand
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should resize volume when PVC is edited while pod is using it
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/volume_expand.go:241
------------------------------
{"msg":"PASSED External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (block volmode)(allowExpansion)] volume-expand should resize volume when PVC is edited while pod is using it","total":-1,"completed":2,"skipped":88,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
[BeforeEach] [Testpattern: Pre-provisioned PV (default fs)] subPath
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:130
Apr 28 18:25:11.489: INFO: Driver supports dynamic provisioning, skipping PreprovisionedPV pattern
... skipping 3 lines ...

S [SKIPPING] in Spec Setup (BeforeEach) [0.001 seconds]
External Storage [Driver: hostpath.csi.k8s.io]
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Pre-provisioned PV (default fs)] subPath
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should fail if subpath with backstepping is outside the volume [Slow][LinuxOnly] [BeforeEach]
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:275

    Driver supports dynamic provisioning, skipping PreprovisionedPV pattern

    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:833
------------------------------
... skipping 141 lines ...
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Dynamic PV (default fs)(allowExpansion)] volume-expand
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    Verify if offline PVC expansion works
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/volume_expand.go:169
------------------------------
{"msg":"PASSED External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (default fs)(allowExpansion)] volume-expand Verify if offline PVC expansion works","total":-1,"completed":3,"skipped":204,"failed":0}

SSSSSSSSSSS
------------------------------
[BeforeEach] [Testpattern: Pre-provisioned PV (ext3)] volumes
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:130
Apr 28 18:25:12.600: INFO: Driver "hostpath.csi.k8s.io" does not support volume type "PreprovisionedPV" - skipping
... skipping 99 lines ...

S [SKIPPING] in Spec Setup (BeforeEach) [0.001 seconds]
External Storage [Driver: hostpath.csi.k8s.io]
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Dynamic PV (ntfs)][sig-windows] subPath
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should fail if subpath with backstepping is outside the volume [Slow][LinuxOnly] [BeforeEach]
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:275

    Driver hostpath.csi.k8s.io doesn't support ntfs -- skipping

    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:178
------------------------------
... skipping 232 lines ...
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Dynamic PV (default fs)] subPath
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should support restarting containers using file as subpath [Slow][LinuxOnly]
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:332
------------------------------
{"msg":"PASSED External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (default fs)] subPath should support restarting containers using file as subpath [Slow][LinuxOnly]","total":-1,"completed":4,"skipped":736,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
[BeforeEach] [Testpattern: Pre-provisioned PV (ext4)] volumes
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:130
Apr 28 18:25:17.843: INFO: Driver "hostpath.csi.k8s.io" does not support volume type "PreprovisionedPV" - skipping
... skipping 24 lines ...

S [SKIPPING] in Spec Setup (BeforeEach) [0.001 seconds]
External Storage [Driver: hostpath.csi.k8s.io]
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Inline-volume (default fs)] subPath
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should fail if subpath with backstepping is outside the volume [Slow][LinuxOnly] [BeforeEach]
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:275

    Driver supports dynamic provisioning, skipping InlineVolume pattern

    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:833
------------------------------
SSSSSSSS
------------------------------
External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (filesystem volmode)] volumeMode 
  should fail to use a volume in a pod with mismatched mode [Slow]
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/volumemode.go:292

[BeforeEach] [Testpattern: Dynamic PV (filesystem volmode)] volumeMode
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:130
[BeforeEach] [Testpattern: Dynamic PV (filesystem volmode)] volumeMode
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:174
STEP: Creating a kubernetes client
Apr 28 18:25:06.162: INFO: >>> kubeConfig: /root/.kube/config
STEP: Building a namespace api object, basename volumemode
STEP: Waiting for a default service account to be provisioned in namespace
[It] should fail to use a volume in a pod with mismatched mode [Slow]
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/volumemode.go:292
Apr 28 18:25:06.196: INFO: Creating resource for dynamic PV
Apr 28 18:25:06.196: INFO: Using claimSize:1Mi, test suite supported size:{ 1Mi}, driver(hostpath.csi.k8s.io) supported size:{ 1Mi} 
STEP: creating a StorageClass volumemode-2963-e2e-sc6qm26
STEP: creating a claim
Apr 28 18:25:06.204: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.iovr5lf] to have phase Bound
Apr 28 18:25:06.208: INFO: PersistentVolumeClaim hostpath.csi.k8s.iovr5lf found but phase is Pending instead of Bound.
Apr 28 18:25:08.211: INFO: PersistentVolumeClaim hostpath.csi.k8s.iovr5lf found and phase=Bound (2.006285568s)
STEP: Creating pod
STEP: Waiting for the pod to fail
Apr 28 18:25:10.230: INFO: Deleting pod "pod-c89f8917-be30-473f-82c4-a048e6a4e34a" in namespace "volumemode-2963"
Apr 28 18:25:10.234: INFO: Wait up to 5m0s for pod "pod-c89f8917-be30-473f-82c4-a048e6a4e34a" to be fully deleted
STEP: Deleting pvc
Apr 28 18:25:14.241: INFO: Deleting PersistentVolumeClaim "hostpath.csi.k8s.iovr5lf"
Apr 28 18:25:14.246: INFO: Waiting up to 5m0s for PersistentVolume pvc-00d0ece9-d602-46aa-a854-85afdbceade9 to get deleted
Apr 28 18:25:14.249: INFO: PersistentVolume pvc-00d0ece9-d602-46aa-a854-85afdbceade9 found and phase=Bound (3.012096ms)
... skipping 7 lines ...

• [SLOW TEST:13.104 seconds]
External Storage [Driver: hostpath.csi.k8s.io]
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Dynamic PV (filesystem volmode)] volumeMode
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should fail to use a volume in a pod with mismatched mode [Slow]
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/volumemode.go:292
------------------------------
{"msg":"PASSED External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (filesystem volmode)] volumeMode should fail to use a volume in a pod with mismatched mode [Slow]","total":-1,"completed":6,"skipped":663,"failed":0}

SSSSSSSSSS
------------------------------
[BeforeEach] [Testpattern: Dynamic PV (block volmode)] provisioning
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:130
[BeforeEach] [Testpattern: Dynamic PV (block volmode)] provisioning
... skipping 233 lines ...
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Dynamic PV (block volmode)] multiVolume [Slow]
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should access to two volumes with the same volume mode and retain data across pod recreation on the same node [LinuxOnly]
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/multivolume.go:130
------------------------------
{"msg":"PASSED External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (block volmode)] multiVolume [Slow] should access to two volumes with the same volume mode and retain data across pod recreation on the same node [LinuxOnly]","total":-1,"completed":6,"skipped":979,"failed":0}

SSSSSSSSS
------------------------------
[BeforeEach] [Testpattern: Pre-provisioned PV (default fs)] subPath
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:130
Apr 28 18:25:21.344: INFO: Driver supports dynamic provisioning, skipping PreprovisionedPV pattern
... skipping 3 lines ...

S [SKIPPING] in Spec Setup (BeforeEach) [0.001 seconds]
External Storage [Driver: hostpath.csi.k8s.io]
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Pre-provisioned PV (default fs)] subPath
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should fail if subpath directory is outside the volume [Slow][LinuxOnly] [BeforeEach]
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:237

    Driver supports dynamic provisioning, skipping PreprovisionedPV pattern

    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:833
------------------------------
... skipping 41 lines ...
Apr 28 18:25:13.368: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
Apr 28 18:25:13.377: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.iosln7j] to have phase Bound
Apr 28 18:25:13.380: INFO: PersistentVolumeClaim hostpath.csi.k8s.iosln7j found but phase is Pending instead of Bound.
Apr 28 18:25:15.384: INFO: PersistentVolumeClaim hostpath.csi.k8s.iosln7j found and phase=Bound (2.006896332s)
STEP: Creating pod pod-subpath-test-dynamicpv-49x4
STEP: Creating a pod to test subpath
Apr 28 18:25:15.393: INFO: Waiting up to 5m0s for pod "pod-subpath-test-dynamicpv-49x4" in namespace "provisioning-2810" to be "Succeeded or Failed"
Apr 28 18:25:15.398: INFO: Pod "pod-subpath-test-dynamicpv-49x4": Phase="Pending", Reason="", readiness=false. Elapsed: 5.058409ms
Apr 28 18:25:17.402: INFO: Pod "pod-subpath-test-dynamicpv-49x4": Phase="Pending", Reason="", readiness=false. Elapsed: 2.008542385s
Apr 28 18:25:19.407: INFO: Pod "pod-subpath-test-dynamicpv-49x4": Phase="Pending", Reason="", readiness=false. Elapsed: 4.013661723s
Apr 28 18:25:21.412: INFO: Pod "pod-subpath-test-dynamicpv-49x4": Phase="Pending", Reason="", readiness=false. Elapsed: 6.018444546s
Apr 28 18:25:23.415: INFO: Pod "pod-subpath-test-dynamicpv-49x4": Phase="Pending", Reason="", readiness=false. Elapsed: 8.021554801s
Apr 28 18:25:25.419: INFO: Pod "pod-subpath-test-dynamicpv-49x4": Phase="Succeeded", Reason="", readiness=false. Elapsed: 10.025421068s
STEP: Saw pod success
Apr 28 18:25:25.419: INFO: Pod "pod-subpath-test-dynamicpv-49x4" satisfied condition "Succeeded or Failed"
Apr 28 18:25:25.423: INFO: Trying to get logs from node csi-prow-worker2 pod pod-subpath-test-dynamicpv-49x4 container test-container-volume-dynamicpv-49x4: <nil>
STEP: delete the pod
Apr 28 18:25:25.449: INFO: Waiting for pod pod-subpath-test-dynamicpv-49x4 to disappear
Apr 28 18:25:25.451: INFO: Pod pod-subpath-test-dynamicpv-49x4 no longer exists
STEP: Deleting pod pod-subpath-test-dynamicpv-49x4
Apr 28 18:25:25.451: INFO: Deleting pod "pod-subpath-test-dynamicpv-49x4" in namespace "provisioning-2810"
... skipping 16 lines ...
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Dynamic PV (default fs)] subPath
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should support non-existent path
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:191
------------------------------
{"msg":"PASSED External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (default fs)] subPath should support non-existent path","total":-1,"completed":4,"skipped":691,"failed":0}

SSSSSSSS
------------------------------
[BeforeEach] [Testpattern: Dynamic PV (ext4)] volumes
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:130
Apr 28 18:25:30.497: INFO: Driver hostpath.csi.k8s.io doesn't support ext4 -- skipping
... skipping 13 lines ...

    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:178
------------------------------
SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (block volmode)] volumeMode 
  should fail to use a volume in a pod with mismatched mode [Slow]
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/volumemode.go:292

[BeforeEach] [Testpattern: Dynamic PV (block volmode)] volumeMode
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:130
[BeforeEach] [Testpattern: Dynamic PV (block volmode)] volumeMode
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:174
STEP: Creating a kubernetes client
Apr 28 18:25:17.892: INFO: >>> kubeConfig: /root/.kube/config
STEP: Building a namespace api object, basename volumemode
STEP: Waiting for a default service account to be provisioned in namespace
[It] should fail to use a volume in a pod with mismatched mode [Slow]
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/volumemode.go:292
Apr 28 18:25:17.927: INFO: Creating resource for dynamic PV
Apr 28 18:25:17.927: INFO: Using claimSize:1Mi, test suite supported size:{ 1Mi}, driver(hostpath.csi.k8s.io) supported size:{ 1Mi} 
STEP: creating a StorageClass volumemode-7429-e2e-scf5clw
STEP: creating a claim
Apr 28 18:25:17.935: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.iop6wnf] to have phase Bound
Apr 28 18:25:17.938: INFO: PersistentVolumeClaim hostpath.csi.k8s.iop6wnf found but phase is Pending instead of Bound.
Apr 28 18:25:19.942: INFO: PersistentVolumeClaim hostpath.csi.k8s.iop6wnf found and phase=Bound (2.006212994s)
STEP: Creating pod
STEP: Waiting for the pod to fail
Apr 28 18:25:21.962: INFO: Deleting pod "pod-2a2ab06f-f1b6-4411-bfee-ef3351481b7e" in namespace "volumemode-7429"
Apr 28 18:25:21.967: INFO: Wait up to 5m0s for pod "pod-2a2ab06f-f1b6-4411-bfee-ef3351481b7e" to be fully deleted
STEP: Deleting pvc
Apr 28 18:25:25.975: INFO: Deleting PersistentVolumeClaim "hostpath.csi.k8s.iop6wnf"
Apr 28 18:25:25.980: INFO: Waiting up to 5m0s for PersistentVolume pvc-080d08dd-3d4f-4a63-b990-7d48216f9bf1 to get deleted
Apr 28 18:25:25.984: INFO: PersistentVolume pvc-080d08dd-3d4f-4a63-b990-7d48216f9bf1 found and phase=Bound (3.763762ms)
... skipping 7 lines ...

• [SLOW TEST:13.106 seconds]
External Storage [Driver: hostpath.csi.k8s.io]
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Dynamic PV (block volmode)] volumeMode
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should fail to use a volume in a pod with mismatched mode [Slow]
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/volumemode.go:292
------------------------------
{"msg":"PASSED External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (block volmode)] volumeMode should fail to use a volume in a pod with mismatched mode [Slow]","total":-1,"completed":5,"skipped":862,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
[BeforeEach] [Testpattern: Dynamic PV (delayed binding)] topology
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:130
[BeforeEach] [Testpattern: Dynamic PV (delayed binding)] topology
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/topology.go:88
[BeforeEach] [Testpattern: Dynamic PV (delayed binding)] topology
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:174
STEP: Creating a kubernetes client
Apr 28 18:25:31.109: INFO: >>> kubeConfig: /root/.kube/config
STEP: Building a namespace api object, basename topology
STEP: Waiting for a default service account to be provisioned in namespace
[It] should fail to schedule a pod which has topologies that conflict with AllowedTopologies
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/topology.go:192
Apr 28 18:25:31.137: INFO: Driver didn't provide topology keys -- skipping
[AfterEach] [Testpattern: Dynamic PV (delayed binding)] topology
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:175
Apr 28 18:25:31.137: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
STEP: Destroying namespace "topology-5922" for this suite.


S [SKIPPING] [0.035 seconds]
External Storage [Driver: hostpath.csi.k8s.io]
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Dynamic PV (delayed binding)] topology
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should fail to schedule a pod which has topologies that conflict with AllowedTopologies [It]
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/topology.go:192

    Driver didn't provide topology keys -- skipping

    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/topology.go:124
------------------------------
... skipping 65 lines ...
Apr 28 18:24:46.813: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
Apr 28 18:24:46.818: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.iowvh6c] to have phase Bound
Apr 28 18:24:46.823: INFO: PersistentVolumeClaim hostpath.csi.k8s.iowvh6c found but phase is Pending instead of Bound.
Apr 28 18:24:48.829: INFO: PersistentVolumeClaim hostpath.csi.k8s.iowvh6c found and phase=Bound (2.010799397s)
STEP: Creating pod pod-subpath-test-dynamicpv-d9mr
STEP: Creating a pod to test atomic-volume-subpath
Apr 28 18:24:48.841: INFO: Waiting up to 5m0s for pod "pod-subpath-test-dynamicpv-d9mr" in namespace "provisioning-6917" to be "Succeeded or Failed"
Apr 28 18:24:48.843: INFO: Pod "pod-subpath-test-dynamicpv-d9mr": Phase="Pending", Reason="", readiness=false. Elapsed: 2.41308ms
Apr 28 18:24:50.846: INFO: Pod "pod-subpath-test-dynamicpv-d9mr": Phase="Pending", Reason="", readiness=false. Elapsed: 2.005846935s
Apr 28 18:24:52.851: INFO: Pod "pod-subpath-test-dynamicpv-d9mr": Phase="Pending", Reason="", readiness=false. Elapsed: 4.010281598s
Apr 28 18:24:54.854: INFO: Pod "pod-subpath-test-dynamicpv-d9mr": Phase="Pending", Reason="", readiness=false. Elapsed: 6.013519452s
Apr 28 18:24:56.857: INFO: Pod "pod-subpath-test-dynamicpv-d9mr": Phase="Pending", Reason="", readiness=false. Elapsed: 8.016900111s
Apr 28 18:24:58.862: INFO: Pod "pod-subpath-test-dynamicpv-d9mr": Phase="Pending", Reason="", readiness=false. Elapsed: 10.02148641s
... skipping 11 lines ...
Apr 28 18:25:22.905: INFO: Pod "pod-subpath-test-dynamicpv-d9mr": Phase="Running", Reason="", readiness=true. Elapsed: 34.064401401s
Apr 28 18:25:24.909: INFO: Pod "pod-subpath-test-dynamicpv-d9mr": Phase="Running", Reason="", readiness=true. Elapsed: 36.068433944s
Apr 28 18:25:26.913: INFO: Pod "pod-subpath-test-dynamicpv-d9mr": Phase="Running", Reason="", readiness=true. Elapsed: 38.072293496s
Apr 28 18:25:28.917: INFO: Pod "pod-subpath-test-dynamicpv-d9mr": Phase="Running", Reason="", readiness=true. Elapsed: 40.075951668s
Apr 28 18:25:30.921: INFO: Pod "pod-subpath-test-dynamicpv-d9mr": Phase="Succeeded", Reason="", readiness=false. Elapsed: 42.080178336s
STEP: Saw pod success
Apr 28 18:25:30.921: INFO: Pod "pod-subpath-test-dynamicpv-d9mr" satisfied condition "Succeeded or Failed"
Apr 28 18:25:30.923: INFO: Trying to get logs from node csi-prow-worker2 pod pod-subpath-test-dynamicpv-d9mr container test-container-subpath-dynamicpv-d9mr: <nil>
STEP: delete the pod
Apr 28 18:25:30.938: INFO: Waiting for pod pod-subpath-test-dynamicpv-d9mr to disappear
Apr 28 18:25:30.940: INFO: Pod pod-subpath-test-dynamicpv-d9mr no longer exists
STEP: Deleting pod pod-subpath-test-dynamicpv-d9mr
Apr 28 18:25:30.940: INFO: Deleting pod "pod-subpath-test-dynamicpv-d9mr" in namespace "provisioning-6917"
... skipping 16 lines ...
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Dynamic PV (default fs)] subPath
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should support file as subpath [LinuxOnly]
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:227
------------------------------
{"msg":"PASSED External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (default fs)] subPath should support file as subpath [LinuxOnly]","total":-1,"completed":5,"skipped":652,"failed":0}
Apr 28 18:25:35.967: INFO: Running AfterSuite actions on all nodes


External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (default fs)] subPath 
  should support existing directory
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:202
... skipping 15 lines ...
Apr 28 18:25:19.563: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
Apr 28 18:25:19.568: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.io8xqfh] to have phase Bound
Apr 28 18:25:19.572: INFO: PersistentVolumeClaim hostpath.csi.k8s.io8xqfh found but phase is Pending instead of Bound.
Apr 28 18:25:21.575: INFO: PersistentVolumeClaim hostpath.csi.k8s.io8xqfh found and phase=Bound (2.006958178s)
STEP: Creating pod pod-subpath-test-dynamicpv-8qh9
STEP: Creating a pod to test subpath
Apr 28 18:25:21.587: INFO: Waiting up to 5m0s for pod "pod-subpath-test-dynamicpv-8qh9" in namespace "provisioning-146" to be "Succeeded or Failed"
Apr 28 18:25:21.594: INFO: Pod "pod-subpath-test-dynamicpv-8qh9": Phase="Pending", Reason="", readiness=false. Elapsed: 6.867496ms
Apr 28 18:25:23.597: INFO: Pod "pod-subpath-test-dynamicpv-8qh9": Phase="Pending", Reason="", readiness=false. Elapsed: 2.010559104s
Apr 28 18:25:25.601: INFO: Pod "pod-subpath-test-dynamicpv-8qh9": Phase="Pending", Reason="", readiness=false. Elapsed: 4.013931469s
Apr 28 18:25:27.604: INFO: Pod "pod-subpath-test-dynamicpv-8qh9": Phase="Pending", Reason="", readiness=false. Elapsed: 6.017603482s
Apr 28 18:25:29.608: INFO: Pod "pod-subpath-test-dynamicpv-8qh9": Phase="Pending", Reason="", readiness=false. Elapsed: 8.021261132s
Apr 28 18:25:31.611: INFO: Pod "pod-subpath-test-dynamicpv-8qh9": Phase="Pending", Reason="", readiness=false. Elapsed: 10.024454537s
Apr 28 18:25:33.615: INFO: Pod "pod-subpath-test-dynamicpv-8qh9": Phase="Pending", Reason="", readiness=false. Elapsed: 12.027679304s
Apr 28 18:25:35.617: INFO: Pod "pod-subpath-test-dynamicpv-8qh9": Phase="Succeeded", Reason="", readiness=false. Elapsed: 14.030606484s
STEP: Saw pod success
Apr 28 18:25:35.618: INFO: Pod "pod-subpath-test-dynamicpv-8qh9" satisfied condition "Succeeded or Failed"
Apr 28 18:25:35.621: INFO: Trying to get logs from node csi-prow-worker2 pod pod-subpath-test-dynamicpv-8qh9 container test-container-volume-dynamicpv-8qh9: <nil>
STEP: delete the pod
Apr 28 18:25:35.636: INFO: Waiting for pod pod-subpath-test-dynamicpv-8qh9 to disappear
Apr 28 18:25:35.639: INFO: Pod pod-subpath-test-dynamicpv-8qh9 no longer exists
STEP: Deleting pod pod-subpath-test-dynamicpv-8qh9
Apr 28 18:25:35.639: INFO: Deleting pod "pod-subpath-test-dynamicpv-8qh9" in namespace "provisioning-146"
... skipping 16 lines ...
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Dynamic PV (default fs)] subPath
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should support existing directory
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:202
------------------------------
{"msg":"PASSED External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (default fs)] subPath should support existing directory","total":-1,"completed":7,"skipped":815,"failed":0}
Apr 28 18:25:40.676: INFO: Running AfterSuite actions on all nodes


External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (default fs)] subPath 
  should support existing directories when readOnly specified in the volumeSource
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:391
... skipping 15 lines ...
Apr 28 18:25:21.481: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
Apr 28 18:25:21.487: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.io62rvl] to have phase Bound
Apr 28 18:25:21.491: INFO: PersistentVolumeClaim hostpath.csi.k8s.io62rvl found but phase is Pending instead of Bound.
Apr 28 18:25:23.494: INFO: PersistentVolumeClaim hostpath.csi.k8s.io62rvl found and phase=Bound (2.005533353s)
STEP: Creating pod pod-subpath-test-dynamicpv-6s7j
STEP: Creating a pod to test subpath
Apr 28 18:25:23.506: INFO: Waiting up to 5m0s for pod "pod-subpath-test-dynamicpv-6s7j" in namespace "provisioning-1181" to be "Succeeded or Failed"
Apr 28 18:25:23.509: INFO: Pod "pod-subpath-test-dynamicpv-6s7j": Phase="Pending", Reason="", readiness=false. Elapsed: 2.59849ms
Apr 28 18:25:25.514: INFO: Pod "pod-subpath-test-dynamicpv-6s7j": Phase="Pending", Reason="", readiness=false. Elapsed: 2.007676035s
Apr 28 18:25:27.517: INFO: Pod "pod-subpath-test-dynamicpv-6s7j": Phase="Pending", Reason="", readiness=false. Elapsed: 4.010552855s
Apr 28 18:25:29.520: INFO: Pod "pod-subpath-test-dynamicpv-6s7j": Phase="Pending", Reason="", readiness=false. Elapsed: 6.013527168s
Apr 28 18:25:31.524: INFO: Pod "pod-subpath-test-dynamicpv-6s7j": Phase="Pending", Reason="", readiness=false. Elapsed: 8.016798215s
Apr 28 18:25:33.529: INFO: Pod "pod-subpath-test-dynamicpv-6s7j": Phase="Pending", Reason="", readiness=false. Elapsed: 10.022328059s
Apr 28 18:25:35.532: INFO: Pod "pod-subpath-test-dynamicpv-6s7j": Phase="Pending", Reason="", readiness=false. Elapsed: 12.025312798s
Apr 28 18:25:37.537: INFO: Pod "pod-subpath-test-dynamicpv-6s7j": Phase="Succeeded", Reason="", readiness=false. Elapsed: 14.030439225s
STEP: Saw pod success
Apr 28 18:25:37.537: INFO: Pod "pod-subpath-test-dynamicpv-6s7j" satisfied condition "Succeeded or Failed"
Apr 28 18:25:37.540: INFO: Trying to get logs from node csi-prow-worker2 pod pod-subpath-test-dynamicpv-6s7j container test-container-subpath-dynamicpv-6s7j: <nil>
STEP: delete the pod
Apr 28 18:25:37.562: INFO: Waiting for pod pod-subpath-test-dynamicpv-6s7j to disappear
Apr 28 18:25:37.566: INFO: Pod pod-subpath-test-dynamicpv-6s7j no longer exists
STEP: Deleting pod pod-subpath-test-dynamicpv-6s7j
Apr 28 18:25:37.566: INFO: Deleting pod "pod-subpath-test-dynamicpv-6s7j" in namespace "provisioning-1181"
STEP: Creating pod pod-subpath-test-dynamicpv-6s7j
STEP: Creating a pod to test subpath
Apr 28 18:25:37.572: INFO: Waiting up to 5m0s for pod "pod-subpath-test-dynamicpv-6s7j" in namespace "provisioning-1181" to be "Succeeded or Failed"
Apr 28 18:25:37.574: INFO: Pod "pod-subpath-test-dynamicpv-6s7j": Phase="Pending", Reason="", readiness=false. Elapsed: 2.253031ms
Apr 28 18:25:39.582: INFO: Pod "pod-subpath-test-dynamicpv-6s7j": Phase="Pending", Reason="", readiness=false. Elapsed: 2.009876535s
Apr 28 18:25:41.587: INFO: Pod "pod-subpath-test-dynamicpv-6s7j": Phase="Succeeded", Reason="", readiness=false. Elapsed: 4.014390809s
STEP: Saw pod success
Apr 28 18:25:41.587: INFO: Pod "pod-subpath-test-dynamicpv-6s7j" satisfied condition "Succeeded or Failed"
Apr 28 18:25:41.596: INFO: Trying to get logs from node csi-prow-worker2 pod pod-subpath-test-dynamicpv-6s7j container test-container-subpath-dynamicpv-6s7j: <nil>
STEP: delete the pod
Apr 28 18:25:41.621: INFO: Waiting for pod pod-subpath-test-dynamicpv-6s7j to disappear
Apr 28 18:25:41.625: INFO: Pod pod-subpath-test-dynamicpv-6s7j no longer exists
STEP: Deleting pod pod-subpath-test-dynamicpv-6s7j
Apr 28 18:25:41.625: INFO: Deleting pod "pod-subpath-test-dynamicpv-6s7j" in namespace "provisioning-1181"
... skipping 16 lines ...
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Dynamic PV (default fs)] subPath
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should support existing directories when readOnly specified in the volumeSource
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:391
------------------------------
{"msg":"PASSED External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (default fs)] subPath should support existing directories when readOnly specified in the volumeSource","total":-1,"completed":7,"skipped":1048,"failed":0}
Apr 28 18:25:46.656: INFO: Running AfterSuite actions on all nodes


External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (default fs)] volume-expand 
  should not allow expansion of pvcs without AllowVolumeExpansion property
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/volume_expand.go:154
... skipping 17 lines ...
Apr 28 18:25:11.271: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
Apr 28 18:25:11.284: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.io2nz9k] to have phase Bound
Apr 28 18:25:11.292: INFO: PersistentVolumeClaim hostpath.csi.k8s.io2nz9k found but phase is Pending instead of Bound.
Apr 28 18:25:13.295: INFO: PersistentVolumeClaim hostpath.csi.k8s.io2nz9k found and phase=Bound (2.010881873s)
STEP: Expanding non-expandable pvc
Apr 28 18:25:13.307: INFO: currentPvcSize {{1073741824 0} {<nil>} 1Gi BinarySI}, newSize {{2147483648 0} {<nil>}  BinarySI}
Apr 28 18:25:13.314: INFO: Error updating pvc hostpath.csi.k8s.io2nz9k: persistentvolumeclaims "hostpath.csi.k8s.io2nz9k" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
Apr 28 18:25:15.323: INFO: Error updating pvc hostpath.csi.k8s.io2nz9k: persistentvolumeclaims "hostpath.csi.k8s.io2nz9k" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
Apr 28 18:25:17.323: INFO: Error updating pvc hostpath.csi.k8s.io2nz9k: persistentvolumeclaims "hostpath.csi.k8s.io2nz9k" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
Apr 28 18:25:19.324: INFO: Error updating pvc hostpath.csi.k8s.io2nz9k: persistentvolumeclaims "hostpath.csi.k8s.io2nz9k" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
Apr 28 18:25:21.321: INFO: Error updating pvc hostpath.csi.k8s.io2nz9k: persistentvolumeclaims "hostpath.csi.k8s.io2nz9k" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
Apr 28 18:25:23.322: INFO: Error updating pvc hostpath.csi.k8s.io2nz9k: persistentvolumeclaims "hostpath.csi.k8s.io2nz9k" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
Apr 28 18:25:25.330: INFO: Error updating pvc hostpath.csi.k8s.io2nz9k: persistentvolumeclaims "hostpath.csi.k8s.io2nz9k" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
Apr 28 18:25:27.323: INFO: Error updating pvc hostpath.csi.k8s.io2nz9k: persistentvolumeclaims "hostpath.csi.k8s.io2nz9k" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
Apr 28 18:25:29.322: INFO: Error updating pvc hostpath.csi.k8s.io2nz9k: persistentvolumeclaims "hostpath.csi.k8s.io2nz9k" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
Apr 28 18:25:31.322: INFO: Error updating pvc hostpath.csi.k8s.io2nz9k: persistentvolumeclaims "hostpath.csi.k8s.io2nz9k" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
Apr 28 18:25:33.322: INFO: Error updating pvc hostpath.csi.k8s.io2nz9k: persistentvolumeclaims "hostpath.csi.k8s.io2nz9k" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
Apr 28 18:25:35.322: INFO: Error updating pvc hostpath.csi.k8s.io2nz9k: persistentvolumeclaims "hostpath.csi.k8s.io2nz9k" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
Apr 28 18:25:37.325: INFO: Error updating pvc hostpath.csi.k8s.io2nz9k: persistentvolumeclaims "hostpath.csi.k8s.io2nz9k" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
Apr 28 18:25:39.324: INFO: Error updating pvc hostpath.csi.k8s.io2nz9k: persistentvolumeclaims "hostpath.csi.k8s.io2nz9k" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
Apr 28 18:25:41.323: INFO: Error updating pvc hostpath.csi.k8s.io2nz9k: persistentvolumeclaims "hostpath.csi.k8s.io2nz9k" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
Apr 28 18:25:43.325: INFO: Error updating pvc hostpath.csi.k8s.io2nz9k: persistentvolumeclaims "hostpath.csi.k8s.io2nz9k" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
Apr 28 18:25:43.331: INFO: Error updating pvc hostpath.csi.k8s.io2nz9k: persistentvolumeclaims "hostpath.csi.k8s.io2nz9k" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
STEP: Deleting pvc
Apr 28 18:25:43.331: INFO: Deleting PersistentVolumeClaim "hostpath.csi.k8s.io2nz9k"
Apr 28 18:25:43.335: INFO: Waiting up to 5m0s for PersistentVolume pvc-5b74ac80-2220-4390-b3f7-113dd7aae267 to get deleted
Apr 28 18:25:43.339: INFO: PersistentVolume pvc-5b74ac80-2220-4390-b3f7-113dd7aae267 found and phase=Bound (4.505024ms)
Apr 28 18:25:48.342: INFO: PersistentVolume pvc-5b74ac80-2220-4390-b3f7-113dd7aae267 was removed
STEP: Deleting sc
... skipping 8 lines ...
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Dynamic PV (default fs)] volume-expand
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should not allow expansion of pvcs without AllowVolumeExpansion property
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/volume_expand.go:154
------------------------------
{"msg":"PASSED External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (default fs)] volume-expand should not allow expansion of pvcs without AllowVolumeExpansion property","total":-1,"completed":5,"skipped":1002,"failed":0}
Apr 28 18:25:48.356: INFO: Running AfterSuite actions on all nodes


External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (block volmode)] volumes 
  should store data
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/volumes.go:151
... skipping 79 lines ...
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Dynamic PV (block volmode)] volumes
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should store data
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/volumes.go:151
------------------------------
{"msg":"PASSED External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (block volmode)] volumes should store data","total":-1,"completed":3,"skipped":485,"failed":0}
Apr 28 18:26:09.714: INFO: Running AfterSuite actions on all nodes


External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (default fs)] subPath 
  should fail if non-existent subpath is outside the volume [Slow][LinuxOnly]
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:264

[BeforeEach] [Testpattern: Dynamic PV (default fs)] subPath
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:130
[BeforeEach] [Testpattern: Dynamic PV (default fs)] subPath
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:174
STEP: Creating a kubernetes client
Apr 28 18:25:30.634: INFO: >>> kubeConfig: /root/.kube/config
STEP: Building a namespace api object, basename provisioning
STEP: Waiting for a default service account to be provisioned in namespace
[It] should fail if non-existent subpath is outside the volume [Slow][LinuxOnly]
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:264
Apr 28 18:25:30.679: INFO: Creating resource for dynamic PV
Apr 28 18:25:30.679: INFO: Using claimSize:1Mi, test suite supported size:{ 1Mi}, driver(hostpath.csi.k8s.io) supported size:{ 1Mi} 
STEP: creating a StorageClass provisioning-5612-e2e-scjr2n6
STEP: creating a claim
Apr 28 18:25:30.682: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
Apr 28 18:25:30.688: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.io6hg4c] to have phase Bound
Apr 28 18:25:30.692: INFO: PersistentVolumeClaim hostpath.csi.k8s.io6hg4c found but phase is Pending instead of Bound.
Apr 28 18:25:32.696: INFO: PersistentVolumeClaim hostpath.csi.k8s.io6hg4c found and phase=Bound (2.006114223s)
STEP: Creating pod pod-subpath-test-dynamicpv-m9r5
STEP: Checking for subpath error in container status
Apr 28 18:25:44.718: INFO: Deleting pod "pod-subpath-test-dynamicpv-m9r5" in namespace "provisioning-5612"
Apr 28 18:25:44.723: INFO: Wait up to 5m0s for pod "pod-subpath-test-dynamicpv-m9r5" to be fully deleted
STEP: Deleting pod
Apr 28 18:26:54.735: INFO: Deleting pod "pod-subpath-test-dynamicpv-m9r5" in namespace "provisioning-5612"
STEP: Deleting pvc
Apr 28 18:26:54.737: INFO: Deleting PersistentVolumeClaim "hostpath.csi.k8s.io6hg4c"
... skipping 9 lines ...

• [SLOW TEST:89.126 seconds]
External Storage [Driver: hostpath.csi.k8s.io]
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Dynamic PV (default fs)] subPath
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should fail if non-existent subpath is outside the volume [Slow][LinuxOnly]
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:264
------------------------------
{"msg":"PASSED External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (default fs)] subPath should fail if non-existent subpath is outside the volume [Slow][LinuxOnly]","total":-1,"completed":5,"skipped":795,"failed":0}
Apr 28 18:26:59.762: INFO: Running AfterSuite actions on all nodes
Apr 28 18:26:59.762: INFO: Running AfterSuite actions on node 1
Apr 28 18:26:59.762: INFO: Dumping logs locally to: /logs/artifacts
Apr 28 18:26:59.763: INFO: Error running cluster/log-dump/log-dump.sh: fork/exec ../../cluster/log-dump/log-dump.sh: no such file or directory


Ran 37 of 5870 Specs in 319.412 seconds
SUCCESS! -- 37 Passed | 0 Failed | 0 Pending | 5833 Skipped


Ginkgo ran 1 suite in 5m22.702406785s
Test Suite Passed
Wed Apr 28 18:26:59 UTC 2021 go1.16.3 /home/prow/go/src/k8s.io/kubernetes$ go run /home/prow/go/src/github.com/kubernetes-csi/external-provisioner/release-tools/filter-junit.go -t=External Storage -o /logs/artifacts/junit_parallel.xml /logs/artifacts/junit_01.xml /logs/artifacts/junit_02.xml /logs/artifacts/junit_03.xml /logs/artifacts/junit_04.xml /logs/artifacts/junit_05.xml /logs/artifacts/junit_06.xml /logs/artifacts/junit_07.xml
Wed Apr 28 18:27:00 UTC 2021 go1.16.3 /home/prow/go/src/github.com/onsi/ginkgo$ git fetch --depth=1 https://github.com/onsi/ginkgo v1.7.0
... skipping 195 lines ...
/home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:169
  [Testpattern: Dynamic PV (block volmode)] provisioning
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:129
    should provision storage with snapshot data source [Feature:VolumeSnapshotDataSource]
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/provisioning.go:198
------------------------------
{"msg":"PASSED External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (block volmode)] provisioning should provision storage with snapshot data source [Feature:VolumeSnapshotDataSource]","total":-1,"completed":1,"skipped":1482,"failed":0}
Apr 28 18:28:13.218: INFO: Running AfterSuite actions on all nodes


External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (default fs)] provisioning 
  should provision storage with snapshot data source [Feature:VolumeSnapshotDataSource]
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/provisioning.go:198
... skipping 143 lines ...
STEP: creating a claim
Apr 28 18:27:07.427: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
Apr 28 18:27:07.435: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.iod2pqk] to have phase Bound
Apr 28 18:27:07.442: INFO: PersistentVolumeClaim hostpath.csi.k8s.iod2pqk found but phase is Pending instead of Bound.
Apr 28 18:27:09.445: INFO: PersistentVolumeClaim hostpath.csi.k8s.iod2pqk found and phase=Bound (2.010828555s)
STEP: starting a pod to use the claim
Apr 28 18:27:09.455: INFO: Waiting up to 15m0s for pod "pvc-snapshottable-tester-mc6dp" in namespace "snapshotting-7924" to be "Succeeded or Failed"
Apr 28 18:27:09.459: INFO: Pod "pvc-snapshottable-tester-mc6dp": Phase="Pending", Reason="", readiness=false. Elapsed: 3.000252ms
Apr 28 18:27:11.463: INFO: Pod "pvc-snapshottable-tester-mc6dp": Phase="Pending", Reason="", readiness=false. Elapsed: 2.006857613s
Apr 28 18:27:13.467: INFO: Pod "pvc-snapshottable-tester-mc6dp": Phase="Pending", Reason="", readiness=false. Elapsed: 4.010666541s
Apr 28 18:27:15.471: INFO: Pod "pvc-snapshottable-tester-mc6dp": Phase="Pending", Reason="", readiness=false. Elapsed: 6.014386477s
Apr 28 18:27:17.474: INFO: Pod "pvc-snapshottable-tester-mc6dp": Phase="Pending", Reason="", readiness=false. Elapsed: 8.017955017s
Apr 28 18:27:19.478: INFO: Pod "pvc-snapshottable-tester-mc6dp": Phase="Pending", Reason="", readiness=false. Elapsed: 10.021787319s
Apr 28 18:27:21.481: INFO: Pod "pvc-snapshottable-tester-mc6dp": Phase="Pending", Reason="", readiness=false. Elapsed: 12.025261696s
Apr 28 18:27:23.485: INFO: Pod "pvc-snapshottable-tester-mc6dp": Phase="Pending", Reason="", readiness=false. Elapsed: 14.028435148s
Apr 28 18:27:25.489: INFO: Pod "pvc-snapshottable-tester-mc6dp": Phase="Pending", Reason="", readiness=false. Elapsed: 16.032336222s
Apr 28 18:27:27.492: INFO: Pod "pvc-snapshottable-tester-mc6dp": Phase="Pending", Reason="", readiness=false. Elapsed: 18.035724414s
Apr 28 18:27:29.496: INFO: Pod "pvc-snapshottable-tester-mc6dp": Phase="Pending", Reason="", readiness=false. Elapsed: 20.03937451s
Apr 28 18:27:31.499: INFO: Pod "pvc-snapshottable-tester-mc6dp": Phase="Succeeded", Reason="", readiness=false. Elapsed: 22.043154398s
STEP: Saw pod success
Apr 28 18:27:31.499: INFO: Pod "pvc-snapshottable-tester-mc6dp" satisfied condition "Succeeded or Failed"
Apr 28 18:27:31.504: INFO: Pod pvc-snapshottable-tester-mc6dp has the following logs: 
Apr 28 18:27:31.504: INFO: Deleting pod "pvc-snapshottable-tester-mc6dp" in namespace "snapshotting-7924"
Apr 28 18:27:31.514: INFO: Wait up to 5m0s for pod "pvc-snapshottable-tester-mc6dp" to be fully deleted
Apr 28 18:27:31.517: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.iod2pqk] to have phase Bound
Apr 28 18:27:31.519: INFO: PersistentVolumeClaim hostpath.csi.k8s.iod2pqk found and phase=Bound (2.031622ms)
STEP: checking the claim
... skipping 11 lines ...
[It] should check snapshot fields, check restore correctly works after modifying source data, check deletion
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/snapshottable.go:213
STEP: checking the snapshot
STEP: checking the SnapshotContent
STEP: Modifying source data test
STEP: modifying the data in the source PVC
Apr 28 18:27:33.558: INFO: Waiting up to 15m0s for pod "pvc-snapshottable-data-tester-77rdd" in namespace "snapshotting-7924" to be "Succeeded or Failed"
Apr 28 18:27:33.564: INFO: Pod "pvc-snapshottable-data-tester-77rdd": Phase="Pending", Reason="", readiness=false. Elapsed: 5.625416ms
Apr 28 18:27:35.567: INFO: Pod "pvc-snapshottable-data-tester-77rdd": Phase="Pending", Reason="", readiness=false. Elapsed: 2.009058051s
Apr 28 18:27:37.571: INFO: Pod "pvc-snapshottable-data-tester-77rdd": Phase="Pending", Reason="", readiness=false. Elapsed: 4.012926803s
Apr 28 18:27:39.575: INFO: Pod "pvc-snapshottable-data-tester-77rdd": Phase="Pending", Reason="", readiness=false. Elapsed: 6.01650912s
Apr 28 18:27:41.578: INFO: Pod "pvc-snapshottable-data-tester-77rdd": Phase="Pending", Reason="", readiness=false. Elapsed: 8.020245458s
Apr 28 18:27:43.583: INFO: Pod "pvc-snapshottable-data-tester-77rdd": Phase="Succeeded", Reason="", readiness=false. Elapsed: 10.024683248s
STEP: Saw pod success
Apr 28 18:27:43.583: INFO: Pod "pvc-snapshottable-data-tester-77rdd" satisfied condition "Succeeded or Failed"
Apr 28 18:27:43.588: INFO: Pod pvc-snapshottable-data-tester-77rdd has the following logs: 
Apr 28 18:27:43.588: INFO: Deleting pod "pvc-snapshottable-data-tester-77rdd" in namespace "snapshotting-7924"
Apr 28 18:27:43.598: INFO: Wait up to 5m0s for pod "pvc-snapshottable-data-tester-77rdd" to be fully deleted
STEP: creating a pvc from the snapshot
STEP: starting a pod to use the claim
Apr 28 18:27:51.622: INFO: Running '/usr/local/bin/kubectl --server=https://127.0.0.1:46593 --kubeconfig=/root/.kube/config --namespace=snapshotting-7924 exec restored-pvc-tester-fzfhp --namespace=snapshotting-7924 -- cat /mnt/test/data'
... skipping 43 lines ...
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/snapshottable.go:121
      
      /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/snapshottable.go:196
        should check snapshot fields, check restore correctly works after modifying source data, check deletion
        /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/snapshottable.go:213
------------------------------
{"msg":"PASSED External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic Snapshot (delete policy)] snapshottable[Feature:VolumeSnapshotDataSource] volume snapshot controller  should check snapshot fields, check restore correctly works after modifying source data, check deletion","total":-1,"completed":1,"skipped":695,"failed":0}
Apr 28 18:28:40.883: INFO: Running AfterSuite actions on all nodes


External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Pre-provisioned Snapshot (delete policy)] snapshottable[Feature:VolumeSnapshotDataSource] volume snapshot controller  
  should check snapshot fields, check restore correctly works after modifying source data, check deletion
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/snapshottable.go:213
... skipping 17 lines ...
STEP: creating a claim
Apr 28 18:27:07.892: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
Apr 28 18:27:07.901: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.iomm7cs] to have phase Bound
Apr 28 18:27:07.904: INFO: PersistentVolumeClaim hostpath.csi.k8s.iomm7cs found but phase is Pending instead of Bound.
Apr 28 18:27:09.907: INFO: PersistentVolumeClaim hostpath.csi.k8s.iomm7cs found and phase=Bound (2.00626288s)
STEP: starting a pod to use the claim
Apr 28 18:27:09.920: INFO: Waiting up to 15m0s for pod "pvc-snapshottable-tester-29nxs" in namespace "snapshotting-7103" to be "Succeeded or Failed"
Apr 28 18:27:09.923: INFO: Pod "pvc-snapshottable-tester-29nxs": Phase="Pending", Reason="", readiness=false. Elapsed: 2.436129ms
Apr 28 18:27:11.926: INFO: Pod "pvc-snapshottable-tester-29nxs": Phase="Pending", Reason="", readiness=false. Elapsed: 2.006160726s
Apr 28 18:27:13.930: INFO: Pod "pvc-snapshottable-tester-29nxs": Phase="Pending", Reason="", readiness=false. Elapsed: 4.009522905s
Apr 28 18:27:15.933: INFO: Pod "pvc-snapshottable-tester-29nxs": Phase="Pending", Reason="", readiness=false. Elapsed: 6.013065297s
Apr 28 18:27:17.937: INFO: Pod "pvc-snapshottable-tester-29nxs": Phase="Pending", Reason="", readiness=false. Elapsed: 8.016460104s
Apr 28 18:27:19.940: INFO: Pod "pvc-snapshottable-tester-29nxs": Phase="Pending", Reason="", readiness=false. Elapsed: 10.019619815s
Apr 28 18:27:21.944: INFO: Pod "pvc-snapshottable-tester-29nxs": Phase="Pending", Reason="", readiness=false. Elapsed: 12.023441879s
Apr 28 18:27:23.948: INFO: Pod "pvc-snapshottable-tester-29nxs": Phase="Pending", Reason="", readiness=false. Elapsed: 14.027518705s
Apr 28 18:27:25.952: INFO: Pod "pvc-snapshottable-tester-29nxs": Phase="Pending", Reason="", readiness=false. Elapsed: 16.03207548s
Apr 28 18:27:27.956: INFO: Pod "pvc-snapshottable-tester-29nxs": Phase="Succeeded", Reason="", readiness=false. Elapsed: 18.035540298s
STEP: Saw pod success
Apr 28 18:27:27.956: INFO: Pod "pvc-snapshottable-tester-29nxs" satisfied condition "Succeeded or Failed"
Apr 28 18:27:27.962: INFO: Pod pvc-snapshottable-tester-29nxs has the following logs: 
Apr 28 18:27:27.962: INFO: Deleting pod "pvc-snapshottable-tester-29nxs" in namespace "snapshotting-7103"
Apr 28 18:27:27.972: INFO: Wait up to 5m0s for pod "pvc-snapshottable-tester-29nxs" to be fully deleted
Apr 28 18:27:27.975: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.iomm7cs] to have phase Bound
Apr 28 18:27:27.977: INFO: PersistentVolumeClaim hostpath.csi.k8s.iomm7cs found and phase=Bound (1.893449ms)
STEP: checking the claim
... skipping 31 lines ...
[It] should check snapshot fields, check restore correctly works after modifying source data, check deletion
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/snapshottable.go:213
STEP: checking the snapshot
STEP: checking the SnapshotContent
STEP: Modifying source data test
STEP: modifying the data in the source PVC
Apr 28 18:27:34.084: INFO: Waiting up to 15m0s for pod "pvc-snapshottable-data-tester-4925g" in namespace "snapshotting-7103" to be "Succeeded or Failed"
Apr 28 18:27:34.090: INFO: Pod "pvc-snapshottable-data-tester-4925g": Phase="Pending", Reason="", readiness=false. Elapsed: 5.148267ms
Apr 28 18:27:36.094: INFO: Pod "pvc-snapshottable-data-tester-4925g": Phase="Pending", Reason="", readiness=false. Elapsed: 2.008454972s
Apr 28 18:27:38.098: INFO: Pod "pvc-snapshottable-data-tester-4925g": Phase="Pending", Reason="", readiness=false. Elapsed: 4.012530968s
Apr 28 18:27:40.102: INFO: Pod "pvc-snapshottable-data-tester-4925g": Phase="Pending", Reason="", readiness=false. Elapsed: 6.016324451s
Apr 28 18:27:42.105: INFO: Pod "pvc-snapshottable-data-tester-4925g": Phase="Pending", Reason="", readiness=false. Elapsed: 8.019763745s
Apr 28 18:27:44.108: INFO: Pod "pvc-snapshottable-data-tester-4925g": Phase="Succeeded", Reason="", readiness=false. Elapsed: 10.023303652s
STEP: Saw pod success
Apr 28 18:27:44.109: INFO: Pod "pvc-snapshottable-data-tester-4925g" satisfied condition "Succeeded or Failed"
Apr 28 18:27:44.113: INFO: Pod pvc-snapshottable-data-tester-4925g has the following logs: 
Apr 28 18:27:44.113: INFO: Deleting pod "pvc-snapshottable-data-tester-4925g" in namespace "snapshotting-7103"
Apr 28 18:27:44.120: INFO: Wait up to 5m0s for pod "pvc-snapshottable-data-tester-4925g" to be fully deleted
STEP: creating a pvc from the snapshot
STEP: starting a pod to use the claim
Apr 28 18:27:54.144: INFO: Running '/usr/local/bin/kubectl --server=https://127.0.0.1:46593 --kubeconfig=/root/.kube/config --namespace=snapshotting-7103 exec restored-pvc-tester-87gsf --namespace=snapshotting-7103 -- cat /mnt/test/data'
... skipping 43 lines ...
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/snapshottable.go:121
      
      /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/snapshottable.go:196
        should check snapshot fields, check restore correctly works after modifying source data, check deletion
        /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/snapshottable.go:213
------------------------------
{"msg":"PASSED External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Pre-provisioned Snapshot (delete policy)] snapshottable[Feature:VolumeSnapshotDataSource] volume snapshot controller  should check snapshot fields, check restore correctly works after modifying source data, check deletion","total":-1,"completed":1,"skipped":977,"failed":0}
Apr 28 18:28:41.401: INFO: Running AfterSuite actions on all nodes


External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic Snapshot (retain policy)] snapshottable[Feature:VolumeSnapshotDataSource] volume snapshot controller  
  should check snapshot fields, check restore correctly works after modifying source data, check deletion
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/snapshottable.go:213
... skipping 17 lines ...
STEP: creating a claim
Apr 28 18:27:06.796: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
Apr 28 18:27:06.809: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.iox2npf] to have phase Bound
Apr 28 18:27:06.813: INFO: PersistentVolumeClaim hostpath.csi.k8s.iox2npf found but phase is Pending instead of Bound.
Apr 28 18:27:08.821: INFO: PersistentVolumeClaim hostpath.csi.k8s.iox2npf found and phase=Bound (2.011178367s)
STEP: starting a pod to use the claim
Apr 28 18:27:08.831: INFO: Waiting up to 15m0s for pod "pvc-snapshottable-tester-f4ppt" in namespace "snapshotting-2230" to be "Succeeded or Failed"
Apr 28 18:27:08.835: INFO: Pod "pvc-snapshottable-tester-f4ppt": Phase="Pending", Reason="", readiness=false. Elapsed: 3.689886ms
Apr 28 18:27:10.838: INFO: Pod "pvc-snapshottable-tester-f4ppt": Phase="Pending", Reason="", readiness=false. Elapsed: 2.006919604s
Apr 28 18:27:12.841: INFO: Pod "pvc-snapshottable-tester-f4ppt": Phase="Pending", Reason="", readiness=false. Elapsed: 4.01025588s
Apr 28 18:27:14.844: INFO: Pod "pvc-snapshottable-tester-f4ppt": Phase="Pending", Reason="", readiness=false. Elapsed: 6.013508562s
Apr 28 18:27:16.848: INFO: Pod "pvc-snapshottable-tester-f4ppt": Phase="Succeeded", Reason="", readiness=false. Elapsed: 8.01658183s
STEP: Saw pod success
Apr 28 18:27:16.848: INFO: Pod "pvc-snapshottable-tester-f4ppt" satisfied condition "Succeeded or Failed"
Apr 28 18:27:16.852: INFO: Pod pvc-snapshottable-tester-f4ppt has the following logs: 
Apr 28 18:27:16.852: INFO: Deleting pod "pvc-snapshottable-tester-f4ppt" in namespace "snapshotting-2230"
Apr 28 18:27:16.862: INFO: Wait up to 5m0s for pod "pvc-snapshottable-tester-f4ppt" to be fully deleted
Apr 28 18:27:16.864: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.iox2npf] to have phase Bound
Apr 28 18:27:16.866: INFO: PersistentVolumeClaim hostpath.csi.k8s.iox2npf found and phase=Bound (2.117336ms)
STEP: checking the claim
... skipping 11 lines ...
[It] should check snapshot fields, check restore correctly works after modifying source data, check deletion
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/snapshottable.go:213
STEP: checking the snapshot
STEP: checking the SnapshotContent
STEP: Modifying source data test
STEP: modifying the data in the source PVC
Apr 28 18:27:18.907: INFO: Waiting up to 15m0s for pod "pvc-snapshottable-data-tester-nwn25" in namespace "snapshotting-2230" to be "Succeeded or Failed"
Apr 28 18:27:18.915: INFO: Pod "pvc-snapshottable-data-tester-nwn25": Phase="Pending", Reason="", readiness=false. Elapsed: 7.746534ms
Apr 28 18:27:20.919: INFO: Pod "pvc-snapshottable-data-tester-nwn25": Phase="Succeeded", Reason="", readiness=false. Elapsed: 2.011245331s
STEP: Saw pod success
Apr 28 18:27:20.919: INFO: Pod "pvc-snapshottable-data-tester-nwn25" satisfied condition "Succeeded or Failed"
Apr 28 18:27:20.924: INFO: Pod pvc-snapshottable-data-tester-nwn25 has the following logs: 
Apr 28 18:27:20.925: INFO: Deleting pod "pvc-snapshottable-data-tester-nwn25" in namespace "snapshotting-2230"
Apr 28 18:27:20.932: INFO: Wait up to 5m0s for pod "pvc-snapshottable-data-tester-nwn25" to be fully deleted
STEP: creating a pvc from the snapshot
STEP: starting a pod to use the claim
Apr 28 18:27:34.947: INFO: Running '/usr/local/bin/kubectl --server=https://127.0.0.1:46593 --kubeconfig=/root/.kube/config --namespace=snapshotting-2230 exec restored-pvc-tester-52dk5 --namespace=snapshotting-2230 -- cat /mnt/test/data'
... skipping 35 lines ...
Apr 28 18:28:01.246: INFO: volumesnapshotcontents snapcontent-0cec48a9-6bf5-4f57-bedc-71a46bf317e3 has been found and is not deleted
Apr 28 18:28:02.250: INFO: volumesnapshotcontents snapcontent-0cec48a9-6bf5-4f57-bedc-71a46bf317e3 has been found and is not deleted
Apr 28 18:28:03.254: INFO: volumesnapshotcontents snapcontent-0cec48a9-6bf5-4f57-bedc-71a46bf317e3 has been found and is not deleted
Apr 28 18:28:04.258: INFO: volumesnapshotcontents snapcontent-0cec48a9-6bf5-4f57-bedc-71a46bf317e3 has been found and is not deleted
Apr 28 18:28:05.262: INFO: volumesnapshotcontents snapcontent-0cec48a9-6bf5-4f57-bedc-71a46bf317e3 has been found and is not deleted
Apr 28 18:28:06.266: INFO: volumesnapshotcontents snapcontent-0cec48a9-6bf5-4f57-bedc-71a46bf317e3 has been found and is not deleted
Apr 28 18:28:07.266: INFO: WaitUntil failed after reaching the timeout 30s
[AfterEach] volume snapshot controller
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/snapshottable.go:192
Apr 28 18:28:07.272: INFO: Pod restored-pvc-tester-52dk5 has the following logs: 
Apr 28 18:28:07.272: INFO: Deleting pod "restored-pvc-tester-52dk5" in namespace "snapshotting-2230"
Apr 28 18:28:07.277: INFO: Wait up to 5m0s for pod "restored-pvc-tester-52dk5" to be fully deleted
Apr 28 18:28:45.283: INFO: deleting claim "snapshotting-2230"/"pvc-62nx4"
... skipping 28 lines ...
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/snapshottable.go:121
      
      /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/snapshottable.go:196
        should check snapshot fields, check restore correctly works after modifying source data, check deletion
        /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/snapshottable.go:213
------------------------------
{"msg":"PASSED External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic Snapshot (retain policy)] snapshottable[Feature:VolumeSnapshotDataSource] volume snapshot controller  should check snapshot fields, check restore correctly works after modifying source data, check deletion","total":-1,"completed":1,"skipped":329,"failed":0}
Apr 28 18:28:52.360: INFO: Running AfterSuite actions on all nodes


External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Pre-provisioned Snapshot (retain policy)] snapshottable[Feature:VolumeSnapshotDataSource] volume snapshot controller  
  should check snapshot fields, check restore correctly works after modifying source data, check deletion
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/snapshottable.go:213
... skipping 17 lines ...
STEP: creating a claim
Apr 28 18:27:06.494: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
Apr 28 18:27:06.502: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.iob7jqf] to have phase Bound
Apr 28 18:27:06.518: INFO: PersistentVolumeClaim hostpath.csi.k8s.iob7jqf found but phase is Pending instead of Bound.
Apr 28 18:27:08.521: INFO: PersistentVolumeClaim hostpath.csi.k8s.iob7jqf found and phase=Bound (2.018609421s)
STEP: starting a pod to use the claim
Apr 28 18:27:08.534: INFO: Waiting up to 15m0s for pod "pvc-snapshottable-tester-jtl7d" in namespace "snapshotting-1875" to be "Succeeded or Failed"
Apr 28 18:27:08.541: INFO: Pod "pvc-snapshottable-tester-jtl7d": Phase="Pending", Reason="", readiness=false. Elapsed: 7.314235ms
Apr 28 18:27:10.545: INFO: Pod "pvc-snapshottable-tester-jtl7d": Phase="Pending", Reason="", readiness=false. Elapsed: 2.011859427s
Apr 28 18:27:12.549: INFO: Pod "pvc-snapshottable-tester-jtl7d": Phase="Pending", Reason="", readiness=false. Elapsed: 4.015591199s
Apr 28 18:27:14.552: INFO: Pod "pvc-snapshottable-tester-jtl7d": Phase="Succeeded", Reason="", readiness=false. Elapsed: 6.018816024s
STEP: Saw pod success
Apr 28 18:27:14.552: INFO: Pod "pvc-snapshottable-tester-jtl7d" satisfied condition "Succeeded or Failed"
Apr 28 18:27:14.565: INFO: Pod pvc-snapshottable-tester-jtl7d has the following logs: 
Apr 28 18:27:14.565: INFO: Deleting pod "pvc-snapshottable-tester-jtl7d" in namespace "snapshotting-1875"
Apr 28 18:27:14.574: INFO: Wait up to 5m0s for pod "pvc-snapshottable-tester-jtl7d" to be fully deleted
Apr 28 18:27:14.578: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.iob7jqf] to have phase Bound
Apr 28 18:27:14.580: INFO: PersistentVolumeClaim hostpath.csi.k8s.iob7jqf found and phase=Bound (1.830881ms)
STEP: checking the claim
... skipping 31 lines ...
[It] should check snapshot fields, check restore correctly works after modifying source data, check deletion
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/snapshottable.go:213
STEP: checking the snapshot
STEP: checking the SnapshotContent
STEP: Modifying source data test
STEP: modifying the data in the source PVC
Apr 28 18:27:20.690: INFO: Waiting up to 15m0s for pod "pvc-snapshottable-data-tester-zxn4l" in namespace "snapshotting-1875" to be "Succeeded or Failed"
Apr 28 18:27:20.695: INFO: Pod "pvc-snapshottable-data-tester-zxn4l": Phase="Pending", Reason="", readiness=false. Elapsed: 4.89894ms
Apr 28 18:27:22.698: INFO: Pod "pvc-snapshottable-data-tester-zxn4l": Phase="Pending", Reason="", readiness=false. Elapsed: 2.008113032s
Apr 28 18:27:24.702: INFO: Pod "pvc-snapshottable-data-tester-zxn4l": Phase="Pending", Reason="", readiness=false. Elapsed: 4.012366299s
Apr 28 18:27:26.706: INFO: Pod "pvc-snapshottable-data-tester-zxn4l": Phase="Pending", Reason="", readiness=false. Elapsed: 6.016513705s
Apr 28 18:27:28.710: INFO: Pod "pvc-snapshottable-data-tester-zxn4l": Phase="Pending", Reason="", readiness=false. Elapsed: 8.020252996s
Apr 28 18:27:30.713: INFO: Pod "pvc-snapshottable-data-tester-zxn4l": Phase="Pending", Reason="", readiness=false. Elapsed: 10.023734425s
Apr 28 18:27:32.717: INFO: Pod "pvc-snapshottable-data-tester-zxn4l": Phase="Pending", Reason="", readiness=false. Elapsed: 12.027472608s
Apr 28 18:27:34.721: INFO: Pod "pvc-snapshottable-data-tester-zxn4l": Phase="Pending", Reason="", readiness=false. Elapsed: 14.031096666s
Apr 28 18:27:36.724: INFO: Pod "pvc-snapshottable-data-tester-zxn4l": Phase="Pending", Reason="", readiness=false. Elapsed: 16.034595787s
Apr 28 18:27:38.728: INFO: Pod "pvc-snapshottable-data-tester-zxn4l": Phase="Succeeded", Reason="", readiness=false. Elapsed: 18.038550175s
STEP: Saw pod success
Apr 28 18:27:38.728: INFO: Pod "pvc-snapshottable-data-tester-zxn4l" satisfied condition "Succeeded or Failed"
Apr 28 18:27:38.733: INFO: Pod pvc-snapshottable-data-tester-zxn4l has the following logs: 
Apr 28 18:27:38.733: INFO: Deleting pod "pvc-snapshottable-data-tester-zxn4l" in namespace "snapshotting-1875"
Apr 28 18:27:38.743: INFO: Wait up to 5m0s for pod "pvc-snapshottable-data-tester-zxn4l" to be fully deleted
STEP: creating a pvc from the snapshot
STEP: starting a pod to use the claim
Apr 28 18:27:58.778: INFO: Running '/usr/local/bin/kubectl --server=https://127.0.0.1:46593 --kubeconfig=/root/.kube/config --namespace=snapshotting-1875 exec restored-pvc-tester-f5fmd --namespace=snapshotting-1875 -- cat /mnt/test/data'
... skipping 35 lines ...
Apr 28 18:28:25.092: INFO: volumesnapshotcontents pre-provisioned-snapcontent-46f02ba8-bb51-41d9-9473-6c1a239c443e has been found and is not deleted
Apr 28 18:28:26.099: INFO: volumesnapshotcontents pre-provisioned-snapcontent-46f02ba8-bb51-41d9-9473-6c1a239c443e has been found and is not deleted
Apr 28 18:28:27.103: INFO: volumesnapshotcontents pre-provisioned-snapcontent-46f02ba8-bb51-41d9-9473-6c1a239c443e has been found and is not deleted
Apr 28 18:28:28.107: INFO: volumesnapshotcontents pre-provisioned-snapcontent-46f02ba8-bb51-41d9-9473-6c1a239c443e has been found and is not deleted
Apr 28 18:28:29.111: INFO: volumesnapshotcontents pre-provisioned-snapcontent-46f02ba8-bb51-41d9-9473-6c1a239c443e has been found and is not deleted
Apr 28 18:28:30.115: INFO: volumesnapshotcontents pre-provisioned-snapcontent-46f02ba8-bb51-41d9-9473-6c1a239c443e has been found and is not deleted
Apr 28 18:28:31.115: INFO: WaitUntil failed after reaching the timeout 30s
[AfterEach] volume snapshot controller
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/snapshottable.go:192
Apr 28 18:28:31.121: INFO: Pod restored-pvc-tester-f5fmd has the following logs: 
Apr 28 18:28:31.121: INFO: Deleting pod "restored-pvc-tester-f5fmd" in namespace "snapshotting-1875"
Apr 28 18:28:31.125: INFO: Wait up to 5m0s for pod "restored-pvc-tester-f5fmd" to be fully deleted
Apr 28 18:29:05.134: INFO: deleting claim "snapshotting-1875"/"pvc-7dxr7"
... skipping 28 lines ...
    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/snapshottable.go:121
      
      /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/snapshottable.go:196
        should check snapshot fields, check restore correctly works after modifying source data, check deletion
        /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/snapshottable.go:213
------------------------------
{"msg":"PASSED External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Pre-provisioned Snapshot (retain policy)] snapshottable[Feature:VolumeSnapshotDataSource] volume snapshot controller  should check snapshot fields, check restore correctly works after modifying source data, check deletion","total":-1,"completed":1,"skipped":181,"failed":0}
Apr 28 18:29:12.215: INFO: Running AfterSuite actions on all nodes


{"msg":"PASSED External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (default fs)] provisioning should provision storage with snapshot data source [Feature:VolumeSnapshotDataSource]","total":-1,"completed":1,"skipped":524,"failed":0}
Apr 28 18:28:23.311: INFO: Running AfterSuite actions on all nodes
Apr 28 18:29:12.234: INFO: Running AfterSuite actions on node 1
Apr 28 18:29:12.234: INFO: Dumping logs locally to: /logs/artifacts
Apr 28 18:29:12.235: INFO: Error running cluster/log-dump/log-dump.sh: fork/exec ../../cluster/log-dump/log-dump.sh: no such file or directory


Ran 6 of 5870 Specs in 126.472 seconds
SUCCESS! -- 6 Passed | 0 Failed | 0 Pending | 5864 Skipped


Ginkgo ran 1 suite in 2m9.471690081s
Test Suite Passed
Wed Apr 28 18:29:12 UTC 2021 go1.16.3 /home/prow/go/src/k8s.io/kubernetes$ go run /home/prow/go/src/github.com/kubernetes-csi/external-provisioner/release-tools/filter-junit.go -t=External Storage -o /logs/artifacts/junit_parallel-features.xml /logs/artifacts/junit_01.xml /logs/artifacts/junit_02.xml /logs/artifacts/junit_03.xml /logs/artifacts/junit_04.xml /logs/artifacts/junit_05.xml /logs/artifacts/junit_06.xml /logs/artifacts/junit_07.xml
Wed Apr 28 18:29:12 UTC 2021 go1.16.3 $ kind delete cluster --name=csi-prow
... skipping 17 lines ...