This job view page is being replaced by Spyglass soon. Check out the new job view.
PRpohly: prow.sh: collect cluster logs
ResultFAILURE
Tests 1 failed / 112 succeeded
Started2021-05-11 13:14
Elapsed18m39s
Revisiond5f135239d64519310e3975b1e303fd3a6f6283c
Refs 149

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/csi-test/release-tools:
Using shellcheck 0.6.0 docker image.
Errors from shellcheck:

In ./prow.sh line 644:
            run kind export logs --name=csi-prow ${ARTIFACTS}/cluster-logs/$name
m                                                 ^----------^ SC2086: Double quote to prevent globbing and word splitting.
m                                                                           ^---^ SC2086: Double quote to prevent globbing and word splitting.

For more information:
  https://www.shellcheck.net/wiki/SC2086 -- Double quote to prevent globbing ...

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 112 Passed Tests

Show 378 Skipped Tests

Error lines from build-log.txt

... skipping 85 lines ...
artifacts: ARTIFACTS=/logs/artifacts
Tue May 11 13:14:30 UTC 2021 go1.16.4 $ 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=v4.2.0-2-g7c32028  -extldflags "-static"' -o "./bin/mock-driver$suffix" ./cmd/mock-driver); then \
		echo "Building mock-driver 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=v4.2.0-2-g7c32028  -extldflags "-static" -o ./bin/mock-driver ./cmd/mock-driver
+ CGO_ENABLED=0 GOOS=windows GOARCH=amd64 go build -mod=vendor -a -ldflags  -X main.version=v4.2.0-2-g7c32028  -extldflags "-static" -o ./bin/mock-driver.exe ./cmd/mock-driver
+ CGO_ENABLED=0 GOOS=linux GOARCH=ppc64le go build -mod=vendor -a -ldflags  -X main.version=v4.2.0-2-g7c32028  -extldflags "-static" -o ./bin/mock-driver-ppc64le ./cmd/mock-driver
... skipping 84 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

### test-sanity:
./hack/e2e.sh
make[1]: Entering directory '/home/prow/go/src/github.com/kubernetes-csi/csi-test'
./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=v4.2.0-2-g7c32028  -extldflags "-static"' -o "./bin/mock-driver$suffix" ./cmd/mock-driver); then \
		echo "Building mock-driver 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=v4.2.0-2-g7c32028  -extldflags "-static" -o ./bin/mock-driver ./cmd/mock-driver
make -C cmd/csi-sanity all
make[2]: Entering directory '/home/prow/go/src/github.com/kubernetes-csi/csi-test/cmd/csi-sanity'
... skipping 27 lines ...
------------------------------
S [SKIPPING] in Spec Setup (BeforeEach) [0.003 seconds]
Node Service
/home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/tests.go:45
  NodeExpandVolume
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:732
    should fail when no volume id is provided [BeforeEach]
    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:740

    NodeExpandVolume not supported

    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:735
------------------------------
S [SKIPPING] in Spec Setup (BeforeEach) [0.005 seconds]
Node Service
/home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/tests.go:45
  NodeExpandVolume
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:732
    should fail when no volume path is provided [BeforeEach]
    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:755

    NodeExpandVolume not supported

    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:735
------------------------------
S [SKIPPING] in Spec Setup (BeforeEach) [0.003 seconds]
Node Service
/home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/tests.go:45
  NodeExpandVolume
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:732
    should fail when volume is not found [BeforeEach]
    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:774

    NodeExpandVolume not supported

    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:735
------------------------------
... skipping 21 lines ...
I0511 13:16:34.063127   21250 resources.go:322] deleting snapshot ID 15
•I0511 13:16:34.066461   21250 resources.go:322] deleting snapshot ID 16
•I0511 13:16:34.069301   21250 resources.go:322] deleting snapshot ID 17
I0511 13:16:34.069738   21250 resources.go:322] deleting snapshot ID 17
••••
Ran 73 of 78 Specs in 0.325 seconds
SUCCESS! -- 73 Passed | 0 Failed | 1 Pending | 4 Skipped
I0511 13:16:34.088469   21475 main.go:126] mock driver started
Running Suite: CSI Driver Test Suite
====================================
Random Seed: 1620738994
Will run 77 of 78 specs

... skipping 26 lines ...
------------------------------
S [SKIPPING] in Spec Setup (BeforeEach) [0.004 seconds]
Node Service
/home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/tests.go:45
  NodeExpandVolume
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:732
    should fail when no volume id is provided [BeforeEach]
    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:740

    NodeExpandVolume not supported

    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:735
------------------------------
S [SKIPPING] in Spec Setup (BeforeEach) [0.004 seconds]
Node Service
/home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/tests.go:45
  NodeExpandVolume
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:732
    should fail when no volume path is provided [BeforeEach]
    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:755

    NodeExpandVolume not supported

    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:735
------------------------------
S [SKIPPING] in Spec Setup (BeforeEach) [0.003 seconds]
Node Service
/home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/tests.go:45
  NodeExpandVolume
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:732
    should fail when volume is not found [BeforeEach]
    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:774

    NodeExpandVolume not supported

    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:735
------------------------------
... skipping 8 lines ...
    NodeExpandVolume not supported

    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:735
------------------------------
••
Ran 73 of 78 Specs in 0.222 seconds
SUCCESS! -- 73 Passed | 0 Failed | 1 Pending | 4 Skipped
I0511 13:16:34.344322   21697 main.go:126] mock driver started
Running Suite: CSI Driver Test Suite
====================================
Random Seed: 1620738994
Will run 77 of 78 specs

... skipping 26 lines ...
------------------------------
S [SKIPPING] in Spec Setup (BeforeEach) [0.002 seconds]
Node Service
/home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/tests.go:45
  NodeExpandVolume
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:732
    should fail when no volume id is provided [BeforeEach]
    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:740

    NodeExpandVolume not supported

    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:735
------------------------------
S [SKIPPING] in Spec Setup (BeforeEach) [0.003 seconds]
Node Service
/home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/tests.go:45
  NodeExpandVolume
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:732
    should fail when no volume path is provided [BeforeEach]
    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:755

    NodeExpandVolume not supported

    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:735
------------------------------
S [SKIPPING] in Spec Setup (BeforeEach) [0.002 seconds]
Node Service
/home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/tests.go:45
  NodeExpandVolume
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:732
    should fail when volume is not found [BeforeEach]
    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:774

    NodeExpandVolume not supported

    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:735
------------------------------
... skipping 8 lines ...
    NodeExpandVolume not supported

    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:735
------------------------------
••
Ran 73 of 78 Specs in 0.223 seconds
SUCCESS! -- 73 Passed | 0 Failed | 1 Pending | 4 Skipped
I0511 13:16:34.598545   21932 main.go:126] mock driver started
=== RUN   TestMyDriver
Running Suite: CSI Driver Test Suite
====================================
Random Seed: 1620738995
Will run 77 of 78 specs
... skipping 7 lines ...
------------------------------
S [SKIPPING] in Spec Setup (BeforeEach) [0.004 seconds]
Node Service
/home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/tests.go:45
  NodeExpandVolume
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:732
    should fail when no volume id is provided [BeforeEach]
    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:740

    NodeExpandVolume not supported

    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:735
------------------------------
S [SKIPPING] in Spec Setup (BeforeEach) [0.003 seconds]
Node Service
/home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/tests.go:45
  NodeExpandVolume
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:732
    should fail when no volume path is provided [BeforeEach]
    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:755

    NodeExpandVolume not supported

    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:735
------------------------------
S [SKIPPING] in Spec Setup (BeforeEach) [0.002 seconds]
Node Service
/home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/tests.go:45
  NodeExpandVolume
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:732
    should fail when volume is not found [BeforeEach]
    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:774

    NodeExpandVolume not supported

    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:735
------------------------------
... skipping 28 lines ...
I0511 13:16:35.798322   22825 resources.go:322] deleting snapshot ID 13
I0511 13:16:35.798763   22825 resources.go:322] deleting snapshot ID 12
•••I0511 13:16:35.802220   22825 resources.go:322] deleting snapshot ID 17
I0511 13:16:35.802534   22825 resources.go:322] deleting snapshot ID 16
•
Ran 73 of 78 Specs in 0.200 seconds
SUCCESS! -- 73 Passed | 0 Failed | 1 Pending | 4 Skipped
--- PASS: TestMyDriver (0.22s)
PASS
ok  	command-line-arguments	0.228s
=== RUN   TestMyDriverGinkgo
Running Suite: CSI Sanity Test Suite
====================================
... skipping 41 lines ...
    CSI Driver Test Suite
    /home/prow/go/src/github.com/kubernetes-csi/csi-test/hack/_embedded/embedded_test.go:57
      Node Service
      /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/tests.go:45
        NodeExpandVolume
        /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:732
          should fail when no volume id is provided [BeforeEach]
          /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:740

          NodeExpandVolume not supported

          /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:735
------------------------------
... skipping 5 lines ...
    CSI Driver Test Suite
    /home/prow/go/src/github.com/kubernetes-csi/csi-test/hack/_embedded/embedded_test.go:57
      Node Service
      /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/tests.go:45
        NodeExpandVolume
        /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:732
          should fail when no volume path is provided [BeforeEach]
          /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:755

          NodeExpandVolume not supported

          /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:735
------------------------------
... skipping 5 lines ...
    CSI Driver Test Suite
    /home/prow/go/src/github.com/kubernetes-csi/csi-test/hack/_embedded/embedded_test.go:57
      Node Service
      /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/tests.go:45
        NodeExpandVolume
        /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:732
          should fail when volume is not found [BeforeEach]
          /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:774

          NodeExpandVolume not supported

          /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:735
------------------------------
... skipping 14 lines ...
          NodeExpandVolume not supported

          /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:735
------------------------------
••
Ran 73 of 78 Specs in 0.204 seconds
SUCCESS! -- 73 Passed | 0 Failed | 1 Pending | 4 Skipped
--- PASS: TestMyDriverGinkgo (0.23s)
PASS
ok  	command-line-arguments	0.240s
I0511 13:16:37.075981   24137 main.go:174] mock controller driver started
I0511 13:16:37.076124   24137 main.go:190] mock node driver started
Running Suite: CSI Driver Test Suite
... skipping 22 lines ...
------------------------------
S [SKIPPING] [0.001 seconds]
Controller Service [Controller Server]
/home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/tests.go:45
  ControllerPublishVolume
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:844
    should fail when publishing more volumes than the node max attach limit [It]
    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:899

    testnodevolumeattachlimit not enabled

    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:901
------------------------------
... skipping 9 lines ...
------------------------------
S [SKIPPING] in Spec Setup (BeforeEach) [0.003 seconds]
Node Service
/home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/tests.go:45
  NodeExpandVolume
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:732
    should fail when no volume id is provided [BeforeEach]
    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:740

    NodeExpandVolume not supported

    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:735
------------------------------
S [SKIPPING] in Spec Setup (BeforeEach) [0.003 seconds]
Node Service
/home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/tests.go:45
  NodeExpandVolume
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:732
    should fail when no volume path is provided [BeforeEach]
    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:755

    NodeExpandVolume not supported

    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:735
------------------------------
S [SKIPPING] in Spec Setup (BeforeEach) [0.003 seconds]
Node Service
/home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/tests.go:45
  NodeExpandVolume
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:732
    should fail when volume is not found [BeforeEach]
    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:774

    NodeExpandVolume not supported

    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:735
------------------------------
... skipping 8 lines ...
    NodeExpandVolume not supported

    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:735
------------------------------
••
Ran 72 of 78 Specs in 0.212 seconds
SUCCESS! -- 72 Passed | 0 Failed | 1 Pending | 5 Skipped
I0511 13:16:37.317025   24348 main.go:126] mock driver started
=== RUN   TestMyDriverWithCustomTargetPaths
Running Suite: CSI Driver Test Suite
====================================
Random Seed: 1620738998
Will run 3 of 78 specs

SSSSS•••SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
Ran 3 of 78 Specs in 0.017 seconds
SUCCESS! -- 3 Passed | 0 Failed | 0 Pending | 75 Skipped
--- PASS: TestMyDriverWithCustomTargetPaths (0.04s)
PASS
ok  	command-line-arguments	0.046s
I0511 13:16:38.355591   25281 main.go:126] mock driver started
Running Suite: CSI Driver Test Suite
====================================
... skipping 4 lines ...
------------------------------
S [SKIPPING] in Spec Setup (BeforeEach) [0.020 seconds]
Node Service
/home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/tests.go:45
  NodeExpandVolume
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:732
    should fail when no volume id is provided [BeforeEach]
    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:740

    NodeExpandVolume not supported

    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:735
------------------------------
S [SKIPPING] in Spec Setup (BeforeEach) [0.017 seconds]
Node Service
/home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/tests.go:45
  NodeExpandVolume
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:732
    should fail when no volume path is provided [BeforeEach]
    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:755

    NodeExpandVolume not supported

    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:735
------------------------------
S [SKIPPING] in Spec Setup (BeforeEach) [0.018 seconds]
Node Service
/home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/tests.go:45
  NodeExpandVolume
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:732
    should fail when volume is not found [BeforeEach]
    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:774

    NodeExpandVolume not supported

    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:735
------------------------------
... skipping 24 lines ...
------------------------------
S [SKIPPING] [0.016 seconds]
Controller Service [Controller Server]
/home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/tests.go:45
  ControllerPublishVolume
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:844
    should fail when publishing more volumes than the node max attach limit [It]
    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:899

    testnodevolumeattachlimit not enabled

    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:901
------------------------------
... skipping 10 lines ...
I0511 13:16:39.751054   25282 resources.go:322] deleting snapshot ID 11
•••I0511 13:16:39.806080   25282 resources.go:322] deleting snapshot ID 16
I0511 13:16:39.806871   25282 resources.go:322] deleting snapshot ID 15
•••I0511 13:16:39.857933   25282 resources.go:322] deleting snapshot ID 17
•
Ran 72 of 78 Specs in 1.490 seconds
SUCCESS! -- 72 Passed | 0 Failed | 1 Pending | 5 Skipped
make: Target 'test' not remade because of errors.
ERROR: 'make test' failed
WARNING: 'make test' failed, proceeding anyway
Tue May 11 13:16:39 UTC 2021 go1.16.4 $ 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=v4.2.0-2-g7c32028  -extldflags "-static"' -o "./bin/mock-driver$suffix" ./cmd/mock-driver); then \
		echo "Building mock-driver 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=v4.2.0-2-g7c32028  -extldflags "-static" -o ./bin/mock-driver ./cmd/mock-driver
docker build -t mock-driver:latest -f ./cmd/mock-driver/Dockerfile --label revision=v4.2.0-2-g7c32028 .
Sending build context to Docker daemon  125.3MB

... skipping 27 lines ...
Step 7/7 : LABEL revision=v4.2.0-2-g7c32028
 ---> Running in 6e28665c69bf
Removing intermediate container 6e28665c69bf
 ---> abb0b18e5b54
Successfully built abb0b18e5b54
Successfully tagged mock-driver:latest
Tue May 11 13:16:56 UTC 2021 go1.16.4 $ curl --fail --location -o /home/prow/go/pkg/csiprow.attqYwZIwu/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   6303      0 --:--:-- --:--:-- --:--:--  6303

100 7277k  100 7277k    0     0  17.0M      0 --:--:-- --:--:-- --:--:-- 17.0M
No kind clusters found.
INFO: kind-config.yaml:
... skipping 175 lines ...
Running Suite: CSI Driver Test Suite
====================================
Random Seed: 1620739200
Will run 77 of 78 specs

CreateSnapshot [Controller Server] 
  should fail when no name is provided
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:1383
STEP: connecting to CSI driver
STEP: creating mount and staging directories
•
------------------------------
CreateSnapshot [Controller Server] 
  should fail when no source volume id is provided
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:1400
STEP: reusing connection to CSI driver at dns:///172.18.0.4:30401
STEP: creating mount and staging directories
•
------------------------------
CreateSnapshot [Controller Server] 
... skipping 6 lines ...
STEP: creating a snapshot with the same name and source volume ID
I0511 13:20:02.697842   40095 resources.go:322] deleting snapshot ID 97fa9e13-b25b-11eb-ac64-4610369a323d
I0511 13:20:02.699491   40095 resources.go:322] deleting snapshot ID 97fa9e13-b25b-11eb-ac64-4610369a323d
•
------------------------------
CreateSnapshot [Controller Server] 
  should fail when requesting to create a snapshot with already existing name and different source volume ID
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:1431
STEP: reusing connection to CSI driver at dns:///172.18.0.4:30401
STEP: creating mount and staging directories
STEP: creating a snapshot
STEP: creating a new source volume
STEP: creating a snapshot with the same name but different source volume ID
... skipping 81 lines ...
I0511 13:20:10.614777   40095 resources.go:322] deleting snapshot ID 9cb05ef3-b25b-11eb-ac64-4610369a323d
I0511 13:20:10.618108   40095 resources.go:322] deleting snapshot ID 9ca9462d-b25b-11eb-ac64-4610369a323d
I0511 13:20:10.621122   40095 resources.go:322] deleting snapshot ID 9ca845e7-b25b-11eb-ac64-4610369a323d
•
------------------------------
DeleteSnapshot [Controller Server] 
  should fail when no snapshot id is provided
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:1327
STEP: reusing connection to CSI driver at dns:///172.18.0.4:30401
STEP: creating mount and staging directories
•
------------------------------
DeleteSnapshot [Controller Server] 
... skipping 26 lines ...
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:362
STEP: reusing connection to CSI driver at dns:///172.18.0.4:30401
STEP: creating mount and staging directories
•
------------------------------
Node Service NodePublishVolume 
  should fail when no volume id is provided
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:379
STEP: reusing connection to CSI driver at dns:///172.18.0.4:30401
STEP: creating mount and staging directories
•
------------------------------
Node Service NodePublishVolume 
  should fail when no target path is provided
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:393
STEP: reusing connection to CSI driver at dns:///172.18.0.4:30401
STEP: creating mount and staging directories
•
------------------------------
Node Service NodePublishVolume 
  should fail when no volume capability is provided
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:408
STEP: reusing connection to CSI driver at dns:///172.18.0.4:30401
STEP: creating mount and staging directories
•
------------------------------
Node Service NodeUnpublishVolume 
  should fail when no volume id is provided
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:427
STEP: reusing connection to CSI driver at dns:///172.18.0.4:30401
STEP: creating mount and staging directories
•
------------------------------
Node Service NodeUnpublishVolume 
  should fail when no target path is provided
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:439
STEP: reusing connection to CSI driver at dns:///172.18.0.4:30401
STEP: creating mount and staging directories
•
------------------------------
Node Service NodeUnpublishVolume 
... skipping 9 lines ...
STEP: Checking the target path exists
STEP: Unpublishing the volume
STEP: Checking the target path was removed
•
------------------------------
Node Service NodeStageVolume 
  should fail when no volume id is provided
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:525
STEP: reusing connection to CSI driver at dns:///172.18.0.4:30401
STEP: creating mount and staging directories
•
------------------------------
Node Service NodeStageVolume 
  should fail when no staging target path is provided
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:544
STEP: reusing connection to CSI driver at dns:///172.18.0.4:30401
STEP: creating mount and staging directories
•
------------------------------
Node Service NodeStageVolume 
  should fail when no volume capability is provided
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:563
STEP: reusing connection to CSI driver at dns:///172.18.0.4:30401
STEP: creating mount and staging directories
STEP: creating a single node writer volume
•
------------------------------
Node Service NodeUnstageVolume 
  should fail when no volume id is provided
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:614
STEP: reusing connection to CSI driver at dns:///172.18.0.4:30401
STEP: creating mount and staging directories
•
------------------------------
Node Service NodeUnstageVolume 
  should fail when no staging target path is provided
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:628
STEP: reusing connection to CSI driver at dns:///172.18.0.4:30401
STEP: creating mount and staging directories
•
------------------------------
Node Service NodeGetVolumeStats 
  should fail when no volume id is provided
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:650
STEP: reusing connection to CSI driver at dns:///172.18.0.4:30401
STEP: creating mount and staging directories

S [SKIPPING] in Spec Setup (BeforeEach) [0.823 seconds]
Node Service
/home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/tests.go:45
  NodeGetVolumeStats
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:643
    should fail when no volume id is provided [BeforeEach]
    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:650

    NodeGetVolume not supported

    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:646
------------------------------
Node Service NodeGetVolumeStats 
  should fail when no volume path is provided
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:664
STEP: reusing connection to CSI driver at dns:///172.18.0.4:30401
STEP: creating mount and staging directories

S [SKIPPING] in Spec Setup (BeforeEach) [0.792 seconds]
Node Service
/home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/tests.go:45
  NodeGetVolumeStats
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:643
    should fail when no volume path is provided [BeforeEach]
    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:664

    NodeGetVolume not supported

    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:646
------------------------------
Node Service NodeGetVolumeStats 
  should fail when volume is not found
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:678
STEP: reusing connection to CSI driver at dns:///172.18.0.4:30401
STEP: creating mount and staging directories

S [SKIPPING] in Spec Setup (BeforeEach) [0.819 seconds]
Node Service
/home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/tests.go:45
  NodeGetVolumeStats
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:643
    should fail when volume is not found [BeforeEach]
    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:678

    NodeGetVolume not supported

    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:646
------------------------------
Node Service NodeGetVolumeStats 
  should fail when volume does not exist on the specified path
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:693
STEP: reusing connection to CSI driver at dns:///172.18.0.4:30401
STEP: creating mount and staging directories

S [SKIPPING] in Spec Setup (BeforeEach) [0.805 seconds]
Node Service
/home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/tests.go:45
  NodeGetVolumeStats
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:643
    should fail when volume does not exist on the specified path [BeforeEach]
    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:693

    NodeGetVolume not supported

    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:646
------------------------------
Node Service NodeExpandVolume 
  should fail when no volume id is provided
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:740
STEP: reusing connection to CSI driver at dns:///172.18.0.4:30401
STEP: creating mount and staging directories
•
------------------------------
Node Service NodeExpandVolume 
  should fail when no volume path is provided
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:755
STEP: reusing connection to CSI driver at dns:///172.18.0.4:30401
STEP: creating mount and staging directories
STEP: creating a single node writer volume for expansion
•
------------------------------
Node Service NodeExpandVolume 
  should fail when volume is not found
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/node.go:774
STEP: reusing connection to CSI driver at dns:///172.18.0.4:30401
STEP: creating mount and staging directories
•
------------------------------
Node Service NodeExpandVolume 
... skipping 71 lines ...
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:181
STEP: reusing connection to CSI driver at dns:///172.18.0.4:30401
STEP: creating mount and staging directories
•
------------------------------
Controller Service [Controller Server] ListVolumes 
  should fail when an invalid starting_token is passed
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:193
STEP: reusing connection to CSI driver at dns:///172.18.0.4:30401
STEP: creating mount and staging directories
•
------------------------------
Controller Service [Controller Server] ListVolumes 
... skipping 11 lines ...
  ListVolumes
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:174
    pagination should detect volumes added between pages and accept tokens when the last volume from a page is deleted
    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:267
------------------------------
Controller Service [Controller Server] CreateVolume 
  should fail when no name is provided
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:375
STEP: reusing connection to CSI driver at dns:///172.18.0.4:30401
STEP: creating mount and staging directories
•
------------------------------
Controller Service [Controller Server] CreateVolume 
  should fail when no volume capabilities are provided
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:390
STEP: reusing connection to CSI driver at dns:///172.18.0.4:30401
STEP: creating mount and staging directories
•
------------------------------
Controller Service [Controller Server] CreateVolume 
... skipping 10 lines ...
STEP: reusing connection to CSI driver at dns:///172.18.0.4:30401
STEP: creating mount and staging directories
STEP: creating a volume
•
------------------------------
Controller Service [Controller Server] CreateVolume 
  should not fail when requesting to create a volume with already existing name and same capacity
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:459
STEP: reusing connection to CSI driver at dns:///172.18.0.4:30401
STEP: creating mount and staging directories
STEP: creating a volume
•
------------------------------
Controller Service [Controller Server] CreateVolume 
  should fail when requesting to create a volume with already existing name and different capacity
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:500
STEP: reusing connection to CSI driver at dns:///172.18.0.4:30401
STEP: creating mount and staging directories
STEP: creating a volume
•
------------------------------
Controller Service [Controller Server] CreateVolume 
  should not fail when creating volume with maximum-length name
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:544
STEP: reusing connection to CSI driver at dns:///172.18.0.4:30401
STEP: creating mount and staging directories
STEP: creating a volume
•
------------------------------
... skipping 5 lines ...
STEP: creating a snapshot
STEP: creating a volume from source snapshot
I0511 13:20:43.195964   40095 resources.go:322] deleting snapshot ID b01e4a3c-b25b-11eb-ac64-4610369a323d
•
------------------------------
Controller Service [Controller Server] CreateVolume 
  should fail when the volume source snapshot is not found
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:594
STEP: reusing connection to CSI driver at dns:///172.18.0.4:30401
STEP: creating mount and staging directories
STEP: creating a volume from source snapshot
•
------------------------------
... skipping 4 lines ...
STEP: creating mount and staging directories
STEP: creating a volume
STEP: creating a volume from source volume
•
------------------------------
Controller Service [Controller Server] CreateVolume 
  should fail when the volume source volume is not found
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:640
STEP: reusing connection to CSI driver at dns:///172.18.0.4:30401
STEP: creating mount and staging directories
STEP: creating a volume from source snapshot
•
------------------------------
Controller Service [Controller Server] DeleteVolume 
  should fail when no volume id is provided
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:670
STEP: reusing connection to CSI driver at dns:///172.18.0.4:30401
STEP: creating mount and staging directories
•
------------------------------
Controller Service [Controller Server] DeleteVolume 
... skipping 10 lines ...
STEP: creating mount and staging directories
STEP: creating a volume
STEP: deleting a volume
•
------------------------------
Controller Service [Controller Server] ValidateVolumeCapabilities 
  should fail when no volume id is provided
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:733
STEP: reusing connection to CSI driver at dns:///172.18.0.4:30401
STEP: creating mount and staging directories
•
------------------------------
Controller Service [Controller Server] ValidateVolumeCapabilities 
  should fail when no volume capabilities are provided
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:747
STEP: reusing connection to CSI driver at dns:///172.18.0.4:30401
STEP: creating mount and staging directories
STEP: creating a single node writer volume
•
------------------------------
... skipping 4 lines ...
STEP: creating mount and staging directories
STEP: creating a single node writer volume
STEP: validating volume capabilities
•
------------------------------
Controller Service [Controller Server] ValidateVolumeCapabilities 
  should fail when the requested volume does not exist
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:824
STEP: reusing connection to CSI driver at dns:///172.18.0.4:30401
STEP: creating mount and staging directories
•
------------------------------
Controller Service [Controller Server] ControllerPublishVolume 
  should fail when no volume id is provided
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:851
STEP: reusing connection to CSI driver at dns:///172.18.0.4:30401
STEP: creating mount and staging directories

S [SKIPPING] in Spec Setup (BeforeEach) [0.829 seconds]
Controller Service [Controller Server]
/home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/tests.go:45
  ControllerPublishVolume
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:844
    should fail when no volume id is provided [BeforeEach]
    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:851

    ControllerPublishVolume not supported

    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:847
------------------------------
Controller Service [Controller Server] ControllerPublishVolume 
  should fail when no node id is provided
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:866
STEP: reusing connection to CSI driver at dns:///172.18.0.4:30401
STEP: creating mount and staging directories

S [SKIPPING] in Spec Setup (BeforeEach) [0.808 seconds]
Controller Service [Controller Server]
/home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/tests.go:45
  ControllerPublishVolume
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:844
    should fail when no node id is provided [BeforeEach]
    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:866

    ControllerPublishVolume not supported

    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:847
------------------------------
Controller Service [Controller Server] ControllerPublishVolume 
  should fail when no volume capability is provided
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:882
STEP: reusing connection to CSI driver at dns:///172.18.0.4:30401
STEP: creating mount and staging directories

S [SKIPPING] in Spec Setup (BeforeEach) [0.833 seconds]
Controller Service [Controller Server]
/home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/tests.go:45
  ControllerPublishVolume
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:844
    should fail when no volume capability is provided [BeforeEach]
    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:882

    ControllerPublishVolume not supported

    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:847
------------------------------
Controller Service [Controller Server] ControllerPublishVolume 
  should fail when publishing more volumes than the node max attach limit
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:899
STEP: reusing connection to CSI driver at dns:///172.18.0.4:30401
STEP: creating mount and staging directories

S [SKIPPING] in Spec Setup (BeforeEach) [0.783 seconds]
Controller Service [Controller Server]
/home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/tests.go:45
  ControllerPublishVolume
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:844
    should fail when publishing more volumes than the node max attach limit [BeforeEach]
    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:899

    ControllerPublishVolume not supported

    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:847
------------------------------
Controller Service [Controller Server] ControllerPublishVolume 
  should fail when the volume does not exist
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:939
STEP: reusing connection to CSI driver at dns:///172.18.0.4:30401
STEP: creating mount and staging directories

S [SKIPPING] in Spec Setup (BeforeEach) [0.795 seconds]
Controller Service [Controller Server]
/home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/tests.go:45
  ControllerPublishVolume
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:844
    should fail when the volume does not exist [BeforeEach]
    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:939

    ControllerPublishVolume not supported

    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:847
------------------------------
Controller Service [Controller Server] ControllerPublishVolume 
  should fail when the node does not exist
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:961
STEP: reusing connection to CSI driver at dns:///172.18.0.4:30401
STEP: creating mount and staging directories

S [SKIPPING] in Spec Setup (BeforeEach) [0.789 seconds]
Controller Service [Controller Server]
/home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/tests.go:45
  ControllerPublishVolume
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:844
    should fail when the node does not exist [BeforeEach]
    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:961

    ControllerPublishVolume not supported

    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:847
------------------------------
Controller Service [Controller Server] ControllerPublishVolume 
  should fail when the volume is already published but is incompatible
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:1000
STEP: reusing connection to CSI driver at dns:///172.18.0.4:30401
STEP: creating mount and staging directories

S [SKIPPING] in Spec Setup (BeforeEach) [0.787 seconds]
Controller Service [Controller Server]
/home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/tests.go:45
  ControllerPublishVolume
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:844
    should fail when the volume is already published but is incompatible [BeforeEach]
    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:1000

    ControllerPublishVolume not supported

    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:847
------------------------------
... skipping 31 lines ...

    Controller Publish, UnpublishVolume not supported

    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:1058
------------------------------
Controller Service [Controller Server] ControllerUnpublishVolume 
  should fail when no volume id is provided
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:1078
STEP: reusing connection to CSI driver at dns:///172.18.0.4:30401
STEP: creating mount and staging directories

S [SKIPPING] in Spec Setup (BeforeEach) [0.781 seconds]
Controller Service [Controller Server]
/home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/tests.go:45
  ControllerUnpublishVolume
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:1071
    should fail when no volume id is provided [BeforeEach]
    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:1078

    ControllerUnpublishVolume not supported

    /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:1074
------------------------------
... skipping 19 lines ...
STEP: reusing connection to CSI driver at dns:///172.18.0.4:30401
STEP: creating mount and staging directories
STEP: verifying name size and characters
•
------------------------------
ExpandVolume [Controller Server] 
  should fail if no volume id is given
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:1489
STEP: reusing connection to CSI driver at dns:///172.18.0.4:30401
STEP: creating mount and staging directories
•
------------------------------
ExpandVolume [Controller Server] 
  should fail if no capacity range is given
  /home/prow/go/src/github.com/kubernetes-csi/csi-test/pkg/sanity/controller.go:1506
STEP: reusing connection to CSI driver at dns:///172.18.0.4:30401
STEP: creating mount and staging directories
•
------------------------------
ExpandVolume [Controller Server] 
... skipping 4 lines ...
STEP: creating a new volume
STEP: expanding the volume
•
JUnit report was created: /logs/artifacts/junit_sanity.xml

Ran 63 of 78 Specs in 64.184 seconds
SUCCESS! -- 63 Passed | 0 Failed | 1 Pending | 14 Skipped
Tue May 11 13:21:04 UTC 2021 go1.16.4 $ git init /home/prow/go/src/k8s.io/kubernetes
Initialized empty Git repository in /home/prow/go/src/k8s.io/kubernetes/.git/
Tue May 11 13:21:04 UTC 2021 go1.16.4 /home/prow/go/src/k8s.io/kubernetes$ git fetch --depth=1 https://github.com/kubernetes/kubernetes v1.20.0
From https://github.com/kubernetes/kubernetes
 * tag                 v1.20.0    -> FETCH_HEAD
Tue May 11 13:21:17 UTC 2021 go1.16.4 /home/prow/go/src/k8s.io/kubernetes$ git checkout FETCH_HEAD
... skipping 7 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
Tue May 11 13:21:19 UTC 2021 go1.16.4 /home/prow/go/src/k8s.io/kubernetes$ git clean -fdx
Tue May 11 13:21:20 UTC 2021 go1.16.4 $ 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
 13  115M   13 15.3M    0     0  31.1M      0  0:00:03 --:--:--  0:00:03 31.0M
 33  115M   33 38.8M    0     0  25.8M      0  0:00:04  0:00:01  0:00:03 25.8M
 63  115M   63 73.2M    0     0  29.3M      0  0:00:03  0:00:02  0:00:01 29.3M
 91  115M   91  106M    0     0  30.4M      0  0:00:03  0:00:03 --:--:-- 30.4M
100  115M  100  115M    0     0  28.6M      0  0:00:04  0:00:04 --:--:-- 28.6M
Tue May 11 13:21:24 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 133 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
------------------------------
... skipping 144 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 406 lines ...
May 11 13:25:40.895: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
May 11 13:25:40.911: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.iocnzgt] to have phase Bound
May 11 13:25:40.934: INFO: PersistentVolumeClaim hostpath.csi.k8s.iocnzgt found but phase is Pending instead of Bound.
May 11 13:25:42.938: INFO: PersistentVolumeClaim hostpath.csi.k8s.iocnzgt found and phase=Bound (2.026316583s)
STEP: Creating pod pod-subpath-test-dynamicpv-5k9w
STEP: Creating a pod to test subpath
May 11 13:25:42.951: INFO: Waiting up to 5m0s for pod "pod-subpath-test-dynamicpv-5k9w" in namespace "provisioning-573" to be "Succeeded or Failed"
May 11 13:25:42.954: INFO: Pod "pod-subpath-test-dynamicpv-5k9w": Phase="Pending", Reason="", readiness=false. Elapsed: 3.025848ms
May 11 13:25:44.957: INFO: Pod "pod-subpath-test-dynamicpv-5k9w": Phase="Pending", Reason="", readiness=false. Elapsed: 2.006451035s
May 11 13:25:46.961: INFO: Pod "pod-subpath-test-dynamicpv-5k9w": Phase="Pending", Reason="", readiness=false. Elapsed: 4.009743865s
May 11 13:25:48.965: INFO: Pod "pod-subpath-test-dynamicpv-5k9w": Phase="Pending", Reason="", readiness=false. Elapsed: 6.013909605s
May 11 13:25:50.968: INFO: Pod "pod-subpath-test-dynamicpv-5k9w": Phase="Pending", Reason="", readiness=false. Elapsed: 8.017357611s
May 11 13:25:52.972: INFO: Pod "pod-subpath-test-dynamicpv-5k9w": Phase="Pending", Reason="", readiness=false. Elapsed: 10.0211029s
May 11 13:25:54.976: INFO: Pod "pod-subpath-test-dynamicpv-5k9w": Phase="Succeeded", Reason="", readiness=false. Elapsed: 12.025482205s
STEP: Saw pod success
May 11 13:25:54.976: INFO: Pod "pod-subpath-test-dynamicpv-5k9w" satisfied condition "Succeeded or Failed"
May 11 13:25:54.979: INFO: Trying to get logs from node csi-prow-worker2 pod pod-subpath-test-dynamicpv-5k9w container test-container-subpath-dynamicpv-5k9w: <nil>
STEP: delete the pod
May 11 13:25:55.004: INFO: Waiting for pod pod-subpath-test-dynamicpv-5k9w to disappear
May 11 13:25:55.008: INFO: Pod pod-subpath-test-dynamicpv-5k9w no longer exists
STEP: Deleting pod pod-subpath-test-dynamicpv-5k9w
May 11 13:25:55.008: INFO: Deleting pod "pod-subpath-test-dynamicpv-5k9w" in namespace "provisioning-573"
... 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":1,"skipped":81,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
[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
May 11 13:26:00.072: INFO: Driver hostpath.csi.k8s.io doesn't support ntfs -- skipping
... skipping 78 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 126 lines ...

    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/provisioning.go:182
------------------------------
SSSSSSSSS
------------------------------
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
May 11 13:25:40.789: INFO: >>> kubeConfig: /root/.kube/config
STEP: Building a namespace api object, basename provisioning
May 11 13:25:40.880: 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 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
May 11 13:25:40.887: INFO: Creating resource for dynamic PV
May 11 13:25:40.887: INFO: Using claimSize:1Mi, test suite supported size:{ 1Mi}, driver(hostpath.csi.k8s.io) supported size:{ 1Mi} 
STEP: creating a StorageClass provisioning-7499-e2e-sc7vcdd
STEP: creating a claim
May 11 13:25:40.898: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
May 11 13:25:40.937: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.iofcg7q] to have phase Bound
May 11 13:25:40.951: INFO: PersistentVolumeClaim hostpath.csi.k8s.iofcg7q found but phase is Pending instead of Bound.
May 11 13:25:42.954: INFO: PersistentVolumeClaim hostpath.csi.k8s.iofcg7q found and phase=Bound (2.016445235s)
STEP: Creating pod pod-subpath-test-dynamicpv-swkt
STEP: Checking for subpath error in container status
May 11 13:25:52.976: INFO: Deleting pod "pod-subpath-test-dynamicpv-swkt" in namespace "provisioning-7499"
May 11 13:25:52.981: INFO: Wait up to 5m0s for pod "pod-subpath-test-dynamicpv-swkt" to be fully deleted
STEP: Deleting pod
May 11 13:26:02.990: INFO: Deleting pod "pod-subpath-test-dynamicpv-swkt" in namespace "provisioning-7499"
STEP: Deleting pvc
May 11 13:26:02.993: INFO: Deleting PersistentVolumeClaim "hostpath.csi.k8s.iofcg7q"
... skipping 9 lines ...

• [SLOW TEST:27.228 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":1,"skipped":96,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (block volmode)] volumeMode 
  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
... 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)] 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":153,"failed":0}

SSSSSSS
------------------------------
[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
May 11 13:26:08.600: 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 8 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 63 lines ...
May 11 13:25:41.114: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
May 11 13:25:41.123: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.ioj6wzz] to have phase Bound
May 11 13:25:41.130: INFO: PersistentVolumeClaim hostpath.csi.k8s.ioj6wzz found but phase is Pending instead of Bound.
May 11 13:25:43.133: INFO: PersistentVolumeClaim hostpath.csi.k8s.ioj6wzz found and phase=Bound (2.009918404s)
STEP: Creating pod pod-subpath-test-dynamicpv-dnwg
STEP: Creating a pod to test subpath
May 11 13:25:43.148: INFO: Waiting up to 5m0s for pod "pod-subpath-test-dynamicpv-dnwg" in namespace "provisioning-4073" to be "Succeeded or Failed"
May 11 13:25:43.151: INFO: Pod "pod-subpath-test-dynamicpv-dnwg": Phase="Pending", Reason="", readiness=false. Elapsed: 3.207713ms
May 11 13:25:45.155: INFO: Pod "pod-subpath-test-dynamicpv-dnwg": Phase="Pending", Reason="", readiness=false. Elapsed: 2.00712257s
May 11 13:25:47.158: INFO: Pod "pod-subpath-test-dynamicpv-dnwg": Phase="Pending", Reason="", readiness=false. Elapsed: 4.010588011s
May 11 13:25:49.162: INFO: Pod "pod-subpath-test-dynamicpv-dnwg": Phase="Pending", Reason="", readiness=false. Elapsed: 6.014223858s
May 11 13:25:51.165: INFO: Pod "pod-subpath-test-dynamicpv-dnwg": Phase="Pending", Reason="", readiness=false. Elapsed: 8.017280704s
May 11 13:25:53.170: INFO: Pod "pod-subpath-test-dynamicpv-dnwg": Phase="Pending", Reason="", readiness=false. Elapsed: 10.021946679s
... skipping 3 lines ...
May 11 13:26:01.183: INFO: Pod "pod-subpath-test-dynamicpv-dnwg": Phase="Pending", Reason="", readiness=false. Elapsed: 18.035384385s
May 11 13:26:03.186: INFO: Pod "pod-subpath-test-dynamicpv-dnwg": Phase="Pending", Reason="", readiness=false. Elapsed: 20.038345426s
May 11 13:26:05.190: INFO: Pod "pod-subpath-test-dynamicpv-dnwg": Phase="Pending", Reason="", readiness=false. Elapsed: 22.042678795s
May 11 13:26:07.194: INFO: Pod "pod-subpath-test-dynamicpv-dnwg": Phase="Pending", Reason="", readiness=false. Elapsed: 24.046702417s
May 11 13:26:09.201: INFO: Pod "pod-subpath-test-dynamicpv-dnwg": Phase="Succeeded", Reason="", readiness=false. Elapsed: 26.053060281s
STEP: Saw pod success
May 11 13:26:09.201: INFO: Pod "pod-subpath-test-dynamicpv-dnwg" satisfied condition "Succeeded or Failed"
May 11 13:26:09.204: INFO: Trying to get logs from node csi-prow-worker2 pod pod-subpath-test-dynamicpv-dnwg container test-container-subpath-dynamicpv-dnwg: <nil>
STEP: delete the pod
May 11 13:26:09.219: INFO: Waiting for pod pod-subpath-test-dynamicpv-dnwg to disappear
May 11 13:26:09.223: INFO: Pod pod-subpath-test-dynamicpv-dnwg no longer exists
STEP: Deleting pod pod-subpath-test-dynamicpv-dnwg
May 11 13:26:09.223: INFO: Deleting pod "pod-subpath-test-dynamicpv-dnwg" in namespace "provisioning-4073"
... 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":1,"skipped":166,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
[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
May 11 13:26:14.290: INFO: Driver hostpath.csi.k8s.io doesn't support ext3 -- skipping
... skipping 37 lines ...
STEP: creating a claim
May 11 13:25:41.208: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.iobbcjv] to have phase Bound
May 11 13:25:41.211: INFO: PersistentVolumeClaim hostpath.csi.k8s.iobbcjv found but phase is Pending instead of Bound.
May 11 13:25:43.214: INFO: PersistentVolumeClaim hostpath.csi.k8s.iobbcjv found and phase=Bound (2.006384123s)
STEP: Expanding non-expandable pvc
May 11 13:25:43.223: INFO: currentPvcSize {{1073741824 0} {<nil>} 1Gi BinarySI}, newSize {{2147483648 0} {<nil>}  BinarySI}
May 11 13:25:43.230: INFO: Error updating pvc hostpath.csi.k8s.iobbcjv: persistentvolumeclaims "hostpath.csi.k8s.iobbcjv" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
May 11 13:25:45.237: INFO: Error updating pvc hostpath.csi.k8s.iobbcjv: persistentvolumeclaims "hostpath.csi.k8s.iobbcjv" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
May 11 13:25:47.242: INFO: Error updating pvc hostpath.csi.k8s.iobbcjv: persistentvolumeclaims "hostpath.csi.k8s.iobbcjv" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
May 11 13:25:49.243: INFO: Error updating pvc hostpath.csi.k8s.iobbcjv: persistentvolumeclaims "hostpath.csi.k8s.iobbcjv" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
May 11 13:25:51.240: INFO: Error updating pvc hostpath.csi.k8s.iobbcjv: persistentvolumeclaims "hostpath.csi.k8s.iobbcjv" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
May 11 13:25:53.241: INFO: Error updating pvc hostpath.csi.k8s.iobbcjv: persistentvolumeclaims "hostpath.csi.k8s.iobbcjv" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
May 11 13:25:55.238: INFO: Error updating pvc hostpath.csi.k8s.iobbcjv: persistentvolumeclaims "hostpath.csi.k8s.iobbcjv" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
May 11 13:25:57.237: INFO: Error updating pvc hostpath.csi.k8s.iobbcjv: persistentvolumeclaims "hostpath.csi.k8s.iobbcjv" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
May 11 13:25:59.237: INFO: Error updating pvc hostpath.csi.k8s.iobbcjv: persistentvolumeclaims "hostpath.csi.k8s.iobbcjv" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
May 11 13:26:01.236: INFO: Error updating pvc hostpath.csi.k8s.iobbcjv: persistentvolumeclaims "hostpath.csi.k8s.iobbcjv" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
May 11 13:26:03.238: INFO: Error updating pvc hostpath.csi.k8s.iobbcjv: persistentvolumeclaims "hostpath.csi.k8s.iobbcjv" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
May 11 13:26:05.237: INFO: Error updating pvc hostpath.csi.k8s.iobbcjv: persistentvolumeclaims "hostpath.csi.k8s.iobbcjv" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
May 11 13:26:07.238: INFO: Error updating pvc hostpath.csi.k8s.iobbcjv: persistentvolumeclaims "hostpath.csi.k8s.iobbcjv" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
May 11 13:26:09.240: INFO: Error updating pvc hostpath.csi.k8s.iobbcjv: persistentvolumeclaims "hostpath.csi.k8s.iobbcjv" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
May 11 13:26:11.239: INFO: Error updating pvc hostpath.csi.k8s.iobbcjv: persistentvolumeclaims "hostpath.csi.k8s.iobbcjv" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
May 11 13:26:13.238: INFO: Error updating pvc hostpath.csi.k8s.iobbcjv: persistentvolumeclaims "hostpath.csi.k8s.iobbcjv" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
May 11 13:26:13.246: INFO: Error updating pvc hostpath.csi.k8s.iobbcjv: persistentvolumeclaims "hostpath.csi.k8s.iobbcjv" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
STEP: Deleting pvc
May 11 13:26:13.246: INFO: Deleting PersistentVolumeClaim "hostpath.csi.k8s.iobbcjv"
May 11 13:26:13.250: INFO: Waiting up to 5m0s for PersistentVolume pvc-55d7f157-b2b5-46f7-86bf-cc7b254448c3 to get deleted
May 11 13:26:13.255: INFO: PersistentVolume pvc-55d7f157-b2b5-46f7-86bf-cc7b254448c3 found and phase=Bound (4.31994ms)
May 11 13:26:18.258: INFO: PersistentVolume pvc-55d7f157-b2b5-46f7-86bf-cc7b254448c3 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":1,"skipped":205,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
[BeforeEach] [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:130
[BeforeEach] [Testpattern: Dynamic PV (block volmode)] multiVolume [Slow]
... skipping 201 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":1,"skipped":33,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (filesystem volmode)] volumeMode 
  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
... 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 (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":2,"skipped":218,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
[BeforeEach] [Testpattern: Pre-provisioned 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:130
May 11 13:26:45.837: INFO: Driver supports dynamic provisioning, skipping PreprovisionedPV pattern
... skipping 258 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 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 (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":2,"skipped":125,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
[BeforeEach] [Testpattern: Dynamic PV (xfs)][Slow] volumes
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:130
May 11 13:26:47.877: INFO: Driver hostpath.csi.k8s.io doesn't support xfs -- skipping
... skipping 45 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 111 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":2,"skipped":311,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
[BeforeEach] [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:130
[BeforeEach] [Testpattern: Dynamic PV (filesystem volmode)] multiVolume [Slow]
... skipping 57 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 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)(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":2,"skipped":276,"failed":0}

SSSSSSSSSSSS
------------------------------
[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
May 11 13:27:07.987: INFO: Driver supports dynamic provisioning, skipping InlineVolume pattern
... skipping 105 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":1,"skipped":303,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
[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
May 11 13:27:09.081: INFO: Driver hostpath.csi.k8s.io doesn't support ntfs -- skipping
... skipping 97 lines ...
[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
May 11 13:27:09.430: 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
May 11 13:27:09.466: 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
May 11 13:27:09.467: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
STEP: Destroying namespace "topology-221" for this suite.


S [SKIPPING] [0.047 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 143 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":3,"skipped":755,"failed":0}
[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
May 11 13:27:28.303: INFO: Driver supports dynamic provisioning, skipping InlineVolume pattern
[AfterEach] [Testpattern: Inline-volume (default fs)] subPath
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:175

... skipping 75 lines ...
May 11 13:26:43.453: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
May 11 13:26:43.460: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.iohm4lr] to have phase Bound
May 11 13:26:43.463: INFO: PersistentVolumeClaim hostpath.csi.k8s.iohm4lr found but phase is Pending instead of Bound.
May 11 13:26:45.466: INFO: PersistentVolumeClaim hostpath.csi.k8s.iohm4lr found and phase=Bound (2.006289946s)
STEP: Creating pod pod-subpath-test-dynamicpv-x6qq
STEP: Creating a pod to test subpath
May 11 13:26:45.481: INFO: Waiting up to 5m0s for pod "pod-subpath-test-dynamicpv-x6qq" in namespace "provisioning-7545" to be "Succeeded or Failed"
May 11 13:26:45.488: INFO: Pod "pod-subpath-test-dynamicpv-x6qq": Phase="Pending", Reason="", readiness=false. Elapsed: 6.301191ms
May 11 13:26:47.493: INFO: Pod "pod-subpath-test-dynamicpv-x6qq": Phase="Pending", Reason="", readiness=false. Elapsed: 2.010547785s
May 11 13:26:49.496: INFO: Pod "pod-subpath-test-dynamicpv-x6qq": Phase="Pending", Reason="", readiness=false. Elapsed: 4.01431101s
May 11 13:26:51.505: INFO: Pod "pod-subpath-test-dynamicpv-x6qq": Phase="Pending", Reason="", readiness=false. Elapsed: 6.022973629s
May 11 13:26:53.510: INFO: Pod "pod-subpath-test-dynamicpv-x6qq": Phase="Pending", Reason="", readiness=false. Elapsed: 8.027934015s
May 11 13:26:55.514: INFO: Pod "pod-subpath-test-dynamicpv-x6qq": Phase="Pending", Reason="", readiness=false. Elapsed: 10.03219054s
... skipping 3 lines ...
May 11 13:27:03.532: INFO: Pod "pod-subpath-test-dynamicpv-x6qq": Phase="Pending", Reason="", readiness=false. Elapsed: 18.049338885s
May 11 13:27:05.537: INFO: Pod "pod-subpath-test-dynamicpv-x6qq": Phase="Pending", Reason="", readiness=false. Elapsed: 20.054381313s
May 11 13:27:07.543: INFO: Pod "pod-subpath-test-dynamicpv-x6qq": Phase="Pending", Reason="", readiness=false. Elapsed: 22.060499033s
May 11 13:27:09.550: INFO: Pod "pod-subpath-test-dynamicpv-x6qq": Phase="Pending", Reason="", readiness=false. Elapsed: 24.067724769s
May 11 13:27:11.555: INFO: Pod "pod-subpath-test-dynamicpv-x6qq": Phase="Succeeded", Reason="", readiness=false. Elapsed: 26.072576841s
STEP: Saw pod success
May 11 13:27:11.555: INFO: Pod "pod-subpath-test-dynamicpv-x6qq" satisfied condition "Succeeded or Failed"
May 11 13:27:11.560: INFO: Trying to get logs from node csi-prow-worker2 pod pod-subpath-test-dynamicpv-x6qq container test-container-subpath-dynamicpv-x6qq: <nil>
STEP: delete the pod
May 11 13:27:11.584: INFO: Waiting for pod pod-subpath-test-dynamicpv-x6qq to disappear
May 11 13:27:11.590: INFO: Pod pod-subpath-test-dynamicpv-x6qq no longer exists
STEP: Deleting pod pod-subpath-test-dynamicpv-x6qq
May 11 13:27:11.591: INFO: Deleting pod "pod-subpath-test-dynamicpv-x6qq" in namespace "provisioning-7545"
STEP: Creating pod pod-subpath-test-dynamicpv-x6qq
STEP: Creating a pod to test subpath
May 11 13:27:11.602: INFO: Waiting up to 5m0s for pod "pod-subpath-test-dynamicpv-x6qq" in namespace "provisioning-7545" to be "Succeeded or Failed"
May 11 13:27:11.606: INFO: Pod "pod-subpath-test-dynamicpv-x6qq": Phase="Pending", Reason="", readiness=false. Elapsed: 3.563365ms
May 11 13:27:13.611: INFO: Pod "pod-subpath-test-dynamicpv-x6qq": Phase="Pending", Reason="", readiness=false. Elapsed: 2.0092945s
May 11 13:27:15.616: INFO: Pod "pod-subpath-test-dynamicpv-x6qq": Phase="Pending", Reason="", readiness=false. Elapsed: 4.014026982s
May 11 13:27:17.621: INFO: Pod "pod-subpath-test-dynamicpv-x6qq": Phase="Pending", Reason="", readiness=false. Elapsed: 6.018588499s
May 11 13:27:19.626: INFO: Pod "pod-subpath-test-dynamicpv-x6qq": Phase="Pending", Reason="", readiness=false. Elapsed: 8.023867934s
May 11 13:27:21.630: INFO: Pod "pod-subpath-test-dynamicpv-x6qq": Phase="Pending", Reason="", readiness=false. Elapsed: 10.027950717s
May 11 13:27:23.635: INFO: Pod "pod-subpath-test-dynamicpv-x6qq": Phase="Pending", Reason="", readiness=false. Elapsed: 12.033063819s
May 11 13:27:25.639: INFO: Pod "pod-subpath-test-dynamicpv-x6qq": Phase="Pending", Reason="", readiness=false. Elapsed: 14.03710145s
May 11 13:27:27.643: INFO: Pod "pod-subpath-test-dynamicpv-x6qq": Phase="Pending", Reason="", readiness=false. Elapsed: 16.040977611s
May 11 13:27:29.647: INFO: Pod "pod-subpath-test-dynamicpv-x6qq": Phase="Pending", Reason="", readiness=false. Elapsed: 18.044368825s
May 11 13:27:31.650: INFO: Pod "pod-subpath-test-dynamicpv-x6qq": Phase="Pending", Reason="", readiness=false. Elapsed: 20.047534974s
May 11 13:27:33.654: INFO: Pod "pod-subpath-test-dynamicpv-x6qq": Phase="Succeeded", Reason="", readiness=false. Elapsed: 22.051649753s
STEP: Saw pod success
May 11 13:27:33.654: INFO: Pod "pod-subpath-test-dynamicpv-x6qq" satisfied condition "Succeeded or Failed"
May 11 13:27:33.657: INFO: Trying to get logs from node csi-prow-worker2 pod pod-subpath-test-dynamicpv-x6qq container test-container-subpath-dynamicpv-x6qq: <nil>
STEP: delete the pod
May 11 13:27:33.673: INFO: Waiting for pod pod-subpath-test-dynamicpv-x6qq to disappear
May 11 13:27:33.676: INFO: Pod pod-subpath-test-dynamicpv-x6qq no longer exists
STEP: Deleting pod pod-subpath-test-dynamicpv-x6qq
May 11 13:27:33.676: INFO: Deleting pod "pod-subpath-test-dynamicpv-x6qq" in namespace "provisioning-7545"
... 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":2,"skipped":61,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
[BeforeEach] [Testpattern: Dynamic PV (default fs)] fsgroupchangepolicy
  /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)] fsgroupchangepolicy
... skipping 59 lines ...
May 11 13:27:09.645: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
May 11 13:27:09.659: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.iolmlsn] to have phase Bound
May 11 13:27:09.665: INFO: PersistentVolumeClaim hostpath.csi.k8s.iolmlsn found but phase is Pending instead of Bound.
May 11 13:27:11.670: INFO: PersistentVolumeClaim hostpath.csi.k8s.iolmlsn found and phase=Bound (2.010199581s)
STEP: Creating pod pod-subpath-test-dynamicpv-9nrc
STEP: Creating a pod to test subpath
May 11 13:27:11.685: INFO: Waiting up to 5m0s for pod "pod-subpath-test-dynamicpv-9nrc" in namespace "provisioning-2290" to be "Succeeded or Failed"
May 11 13:27:11.689: INFO: Pod "pod-subpath-test-dynamicpv-9nrc": Phase="Pending", Reason="", readiness=false. Elapsed: 4.094966ms
May 11 13:27:13.696: INFO: Pod "pod-subpath-test-dynamicpv-9nrc": Phase="Pending", Reason="", readiness=false. Elapsed: 2.011292317s
May 11 13:27:15.702: INFO: Pod "pod-subpath-test-dynamicpv-9nrc": Phase="Pending", Reason="", readiness=false. Elapsed: 4.01677732s
May 11 13:27:17.707: INFO: Pod "pod-subpath-test-dynamicpv-9nrc": Phase="Pending", Reason="", readiness=false. Elapsed: 6.021845833s
May 11 13:27:19.712: INFO: Pod "pod-subpath-test-dynamicpv-9nrc": Phase="Pending", Reason="", readiness=false. Elapsed: 8.026443019s
May 11 13:27:21.717: INFO: Pod "pod-subpath-test-dynamicpv-9nrc": Phase="Pending", Reason="", readiness=false. Elapsed: 10.031865809s
... skipping 4 lines ...
May 11 13:27:31.740: INFO: Pod "pod-subpath-test-dynamicpv-9nrc": Phase="Pending", Reason="", readiness=false. Elapsed: 20.054603831s
May 11 13:27:33.744: INFO: Pod "pod-subpath-test-dynamicpv-9nrc": Phase="Pending", Reason="", readiness=false. Elapsed: 22.058464656s
May 11 13:27:35.748: INFO: Pod "pod-subpath-test-dynamicpv-9nrc": Phase="Pending", Reason="", readiness=false. Elapsed: 24.062354633s
May 11 13:27:37.751: INFO: Pod "pod-subpath-test-dynamicpv-9nrc": Phase="Pending", Reason="", readiness=false. Elapsed: 26.066164707s
May 11 13:27:39.755: INFO: Pod "pod-subpath-test-dynamicpv-9nrc": Phase="Succeeded", Reason="", readiness=false. Elapsed: 28.069597525s
STEP: Saw pod success
May 11 13:27:39.755: INFO: Pod "pod-subpath-test-dynamicpv-9nrc" satisfied condition "Succeeded or Failed"
May 11 13:27:39.758: INFO: Trying to get logs from node csi-prow-worker2 pod pod-subpath-test-dynamicpv-9nrc container test-container-volume-dynamicpv-9nrc: <nil>
STEP: delete the pod
May 11 13:27:39.776: INFO: Waiting for pod pod-subpath-test-dynamicpv-9nrc to disappear
May 11 13:27:39.780: INFO: Pod pod-subpath-test-dynamicpv-9nrc no longer exists
STEP: Deleting pod pod-subpath-test-dynamicpv-9nrc
May 11 13:27:39.780: INFO: Deleting pod "pod-subpath-test-dynamicpv-9nrc" in namespace "provisioning-2290"
... 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":2,"skipped":548,"failed":0}

SSSSSSSSSSSSSSSSS
------------------------------
[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
May 11 13:27:44.832: INFO: Driver hostpath.csi.k8s.io doesn't support ntfs -- skipping
... skipping 45 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 136 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":2,"skipped":285,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
[BeforeEach] [Testpattern: CSI Ephemeral-volume (default fs)] ephemeral
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:130
May 11 13:27:49.754: INFO: Driver "hostpath.csi.k8s.io" does not support volume type "CSIInlineVolume" - skipping
... skipping 78 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 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 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":3,"skipped":574,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
[BeforeEach] [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:130
May 11 13:27:53.939: 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 (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 20 lines ...
May 11 13:27:38.939: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
May 11 13:27:38.944: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.ioslzgx] to have phase Bound
May 11 13:27:38.949: INFO: PersistentVolumeClaim hostpath.csi.k8s.ioslzgx found but phase is Pending instead of Bound.
May 11 13:27:40.952: INFO: PersistentVolumeClaim hostpath.csi.k8s.ioslzgx found and phase=Bound (2.007153359s)
STEP: Creating pod pod-subpath-test-dynamicpv-68cv
STEP: Creating a pod to test multi_subpath
May 11 13:27:40.962: INFO: Waiting up to 5m0s for pod "pod-subpath-test-dynamicpv-68cv" in namespace "provisioning-2988" to be "Succeeded or Failed"
May 11 13:27:40.964: INFO: Pod "pod-subpath-test-dynamicpv-68cv": Phase="Pending", Reason="", readiness=false. Elapsed: 2.413978ms
May 11 13:27:42.969: INFO: Pod "pod-subpath-test-dynamicpv-68cv": Phase="Pending", Reason="", readiness=false. Elapsed: 2.006499769s
May 11 13:27:44.971: INFO: Pod "pod-subpath-test-dynamicpv-68cv": Phase="Pending", Reason="", readiness=false. Elapsed: 4.009425002s
May 11 13:27:46.975: INFO: Pod "pod-subpath-test-dynamicpv-68cv": Phase="Pending", Reason="", readiness=false. Elapsed: 6.013193731s
May 11 13:27:48.979: INFO: Pod "pod-subpath-test-dynamicpv-68cv": Phase="Succeeded", Reason="", readiness=false. Elapsed: 8.017169333s
STEP: Saw pod success
May 11 13:27:48.979: INFO: Pod "pod-subpath-test-dynamicpv-68cv" satisfied condition "Succeeded or Failed"
May 11 13:27:48.982: INFO: Trying to get logs from node csi-prow-worker2 pod pod-subpath-test-dynamicpv-68cv container test-container-subpath-dynamicpv-68cv: <nil>
STEP: delete the pod
May 11 13:27:49.004: INFO: Waiting for pod pod-subpath-test-dynamicpv-68cv to disappear
May 11 13:27:49.008: INFO: Pod pod-subpath-test-dynamicpv-68cv no longer exists
STEP: Deleting pod
May 11 13:27:49.008: INFO: Deleting pod "pod-subpath-test-dynamicpv-68cv" in namespace "provisioning-2988"
... skipping 16 lines ...
  /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
------------------------------
S
------------------------------
{"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":186,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
[BeforeEach] [Testpattern: Pre-provisioned 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:130
May 11 13:27:54.125: INFO: Driver supports dynamic provisioning, skipping PreprovisionedPV 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: 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 175 lines ...

    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:833
------------------------------
SSSSSSSSSSSSSSSSSSS
------------------------------
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
May 11 13:27:50.010: 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
May 11 13:27:50.046: INFO: Creating resource for dynamic PV
May 11 13:27:50.046: INFO: Using claimSize:1Mi, test suite supported size:{ 1Mi}, driver(hostpath.csi.k8s.io) supported size:{ 1Mi} 
STEP: creating a StorageClass volumemode-5394-e2e-scxn4pb
STEP: creating a claim
May 11 13:27:50.056: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.iostzf5] to have phase Bound
May 11 13:27:50.058: INFO: PersistentVolumeClaim hostpath.csi.k8s.iostzf5 found but phase is Pending instead of Bound.
May 11 13:27:52.062: INFO: PersistentVolumeClaim hostpath.csi.k8s.iostzf5 found and phase=Bound (2.005952887s)
STEP: Creating pod
STEP: Waiting for the pod to fail
May 11 13:27:54.082: INFO: Deleting pod "pod-e0739d42-5c94-49ca-bd58-be95b1c0fbad" in namespace "volumemode-5394"
May 11 13:27:54.092: INFO: Wait up to 5m0s for pod "pod-e0739d42-5c94-49ca-bd58-be95b1c0fbad" to be fully deleted
STEP: Deleting pvc
May 11 13:28:02.100: INFO: Deleting PersistentVolumeClaim "hostpath.csi.k8s.iostzf5"
May 11 13:28:02.105: INFO: Waiting up to 5m0s for PersistentVolume pvc-ec664e0c-5a59-441f-af93-f8bd5b135cef to get deleted
May 11 13:28:02.108: INFO: PersistentVolume pvc-ec664e0c-5a59-441f-af93-f8bd5b135cef found and phase=Bound (2.80371ms)
... skipping 7 lines ...

• [SLOW TEST:17.117 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":3,"skipped":562,"failed":0}

SSSSSSSS
------------------------------
[BeforeEach] [Testpattern: Pre-provisioned 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:130
May 11 13:28:07.141: INFO: Driver supports dynamic provisioning, skipping PreprovisionedPV pattern
... skipping 85 lines ...
[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
May 11 13:28:07.318: 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
May 11 13:28:07.346: 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
May 11 13:28:07.346: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
STEP: Destroying namespace "topology-4798" for this suite.


S [SKIPPING] [0.036 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 29 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 40 lines ...
STEP: creating a claim
May 11 13:27:45.115: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
May 11 13:27:45.121: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.iosmmxb] to have phase Bound
May 11 13:27:45.123: INFO: PersistentVolumeClaim hostpath.csi.k8s.iosmmxb found but phase is Pending instead of Bound.
May 11 13:27:47.127: INFO: PersistentVolumeClaim hostpath.csi.k8s.iosmmxb found and phase=Bound (2.00632612s)
STEP: Creating pod to format volume volume-prep-provisioning-5820
May 11 13:27:47.139: INFO: Waiting up to 5m0s for pod "volume-prep-provisioning-5820" in namespace "provisioning-5820" to be "Succeeded or Failed"
May 11 13:27:47.142: INFO: Pod "volume-prep-provisioning-5820": Phase="Pending", Reason="", readiness=false. Elapsed: 3.365809ms
May 11 13:27:49.147: INFO: Pod "volume-prep-provisioning-5820": Phase="Pending", Reason="", readiness=false. Elapsed: 2.007444032s
May 11 13:27:51.151: INFO: Pod "volume-prep-provisioning-5820": Phase="Pending", Reason="", readiness=false. Elapsed: 4.011536585s
May 11 13:27:53.154: INFO: Pod "volume-prep-provisioning-5820": Phase="Pending", Reason="", readiness=false. Elapsed: 6.014927512s
May 11 13:27:55.160: INFO: Pod "volume-prep-provisioning-5820": Phase="Pending", Reason="", readiness=false. Elapsed: 8.020960067s
May 11 13:27:57.164: INFO: Pod "volume-prep-provisioning-5820": Phase="Succeeded", Reason="", readiness=false. Elapsed: 10.024567902s
STEP: Saw pod success
May 11 13:27:57.164: INFO: Pod "volume-prep-provisioning-5820" satisfied condition "Succeeded or Failed"
May 11 13:27:57.164: INFO: Deleting pod "volume-prep-provisioning-5820" in namespace "provisioning-5820"
May 11 13:27:57.173: INFO: Wait up to 5m0s for pod "volume-prep-provisioning-5820" to be fully deleted
STEP: Creating pod pod-subpath-test-dynamicpv-bwmq
STEP: Checking for subpath error in container status
May 11 13:28:09.186: INFO: Deleting pod "pod-subpath-test-dynamicpv-bwmq" in namespace "provisioning-5820"
May 11 13:28:09.196: INFO: Wait up to 5m0s for pod "pod-subpath-test-dynamicpv-bwmq" to be fully deleted
STEP: Deleting pod
May 11 13:28:09.199: INFO: Deleting pod "pod-subpath-test-dynamicpv-bwmq" in namespace "provisioning-5820"
STEP: Deleting pvc
May 11 13:28:09.202: INFO: Deleting PersistentVolumeClaim "hostpath.csi.k8s.iosmmxb"
... 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":3,"skipped":697,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
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 ...
May 11 13:27:54.545: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
May 11 13:27:54.550: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.iod648v] to have phase Bound
May 11 13:27:54.554: INFO: PersistentVolumeClaim hostpath.csi.k8s.iod648v found but phase is Pending instead of Bound.
May 11 13:27:56.558: INFO: PersistentVolumeClaim hostpath.csi.k8s.iod648v found and phase=Bound (2.007268503s)
STEP: Creating pod exec-volume-test-dynamicpv-rzdf
STEP: Creating a pod to test exec-volume-test
May 11 13:27:56.566: INFO: Waiting up to 5m0s for pod "exec-volume-test-dynamicpv-rzdf" in namespace "volume-1185" to be "Succeeded or Failed"
May 11 13:27:56.570: INFO: Pod "exec-volume-test-dynamicpv-rzdf": Phase="Pending", Reason="", readiness=false. Elapsed: 4.182559ms
May 11 13:27:58.574: INFO: Pod "exec-volume-test-dynamicpv-rzdf": Phase="Pending", Reason="", readiness=false. Elapsed: 2.007780999s
May 11 13:28:00.578: INFO: Pod "exec-volume-test-dynamicpv-rzdf": Phase="Pending", Reason="", readiness=false. Elapsed: 4.011436848s
May 11 13:28:02.581: INFO: Pod "exec-volume-test-dynamicpv-rzdf": Phase="Pending", Reason="", readiness=false. Elapsed: 6.015139331s
May 11 13:28:04.585: INFO: Pod "exec-volume-test-dynamicpv-rzdf": Phase="Pending", Reason="", readiness=false. Elapsed: 8.01886288s
May 11 13:28:06.589: INFO: Pod "exec-volume-test-dynamicpv-rzdf": Phase="Pending", Reason="", readiness=false. Elapsed: 10.022397195s
May 11 13:28:08.593: INFO: Pod "exec-volume-test-dynamicpv-rzdf": Phase="Pending", Reason="", readiness=false. Elapsed: 12.026336398s
May 11 13:28:10.596: INFO: Pod "exec-volume-test-dynamicpv-rzdf": Phase="Pending", Reason="", readiness=false. Elapsed: 14.030056722s
May 11 13:28:12.600: INFO: Pod "exec-volume-test-dynamicpv-rzdf": Phase="Succeeded", Reason="", readiness=false. Elapsed: 16.033810255s
STEP: Saw pod success
May 11 13:28:12.600: INFO: Pod "exec-volume-test-dynamicpv-rzdf" satisfied condition "Succeeded or Failed"
May 11 13:28:12.603: INFO: Trying to get logs from node csi-prow-worker2 pod exec-volume-test-dynamicpv-rzdf container exec-container-dynamicpv-rzdf: <nil>
STEP: delete the pod
May 11 13:28:12.617: INFO: Waiting for pod exec-volume-test-dynamicpv-rzdf to disappear
May 11 13:28:12.619: INFO: Pod exec-volume-test-dynamicpv-rzdf no longer exists
STEP: Deleting pod exec-volume-test-dynamicpv-rzdf
May 11 13:28:12.619: INFO: Deleting pod "exec-volume-test-dynamicpv-rzdf" in namespace "volume-1185"
... 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":4,"skipped":439,"failed":0}

SSSSSSSSSSSSSSSS
------------------------------
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]
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/multivolume.go:130
... skipping 123 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":4,"skipped":943,"failed":0}

SSSSSSSSSSSSSSSSSSS
------------------------------
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
May 11 13:28:07.427: 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
May 11 13:28:07.454: INFO: Creating resource for dynamic PV
May 11 13:28:07.454: INFO: Using claimSize:1Mi, test suite supported size:{ 1Mi}, driver(hostpath.csi.k8s.io) supported size:{ 1Mi} 
STEP: creating a StorageClass volumemode-7362-e2e-scc9kgx
STEP: creating a claim
May 11 13:28:07.463: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.io7pdsz] to have phase Bound
May 11 13:28:07.465: INFO: PersistentVolumeClaim hostpath.csi.k8s.io7pdsz found but phase is Pending instead of Bound.
May 11 13:28:09.469: INFO: PersistentVolumeClaim hostpath.csi.k8s.io7pdsz found and phase=Bound (2.006470095s)
STEP: Creating pod
STEP: Waiting for the pod to fail
May 11 13:28:11.488: INFO: Deleting pod "pod-71335e6f-4aa9-413b-ae86-54f5e1192c2d" in namespace "volumemode-7362"
May 11 13:28:11.492: INFO: Wait up to 5m0s for pod "pod-71335e6f-4aa9-413b-ae86-54f5e1192c2d" to be fully deleted
STEP: Deleting pvc
May 11 13:28:21.501: INFO: Deleting PersistentVolumeClaim "hostpath.csi.k8s.io7pdsz"
May 11 13:28:21.506: INFO: Waiting up to 5m0s for PersistentVolume pvc-56ca901d-c3dd-46bc-9e64-31fb1d26bdf4 to get deleted
May 11 13:28:21.509: INFO: PersistentVolume pvc-56ca901d-c3dd-46bc-9e64-31fb1d26bdf4 found and phase=Bound (2.594292ms)
... skipping 7 lines ...

• [SLOW TEST:19.099 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":4,"skipped":754,"failed":0}

SSSSSSSSSSSSSSSS
------------------------------
[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
... skipping 25 lines ...

    /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/topology.go:124
------------------------------
SSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
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
May 11 13:27:54.454: 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
May 11 13:27:54.490: INFO: Creating resource for dynamic PV
May 11 13:27:54.491: INFO: Using claimSize:1Mi, test suite supported size:{ 1Mi}, driver(hostpath.csi.k8s.io) supported size:{ 1Mi} 
STEP: creating a StorageClass provisioning-2564-e2e-scsqjwp
STEP: creating a claim
May 11 13:27:54.495: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
May 11 13:27:54.501: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.io5nmwg] to have phase Bound
May 11 13:27:54.504: INFO: PersistentVolumeClaim hostpath.csi.k8s.io5nmwg found but phase is Pending instead of Bound.
May 11 13:27:56.508: INFO: PersistentVolumeClaim hostpath.csi.k8s.io5nmwg found and phase=Bound (2.006790895s)
STEP: Creating pod pod-subpath-test-dynamicpv-np6g
STEP: Checking for subpath error in container status
May 11 13:28:08.528: INFO: Deleting pod "pod-subpath-test-dynamicpv-np6g" in namespace "provisioning-2564"
May 11 13:28:08.533: INFO: Wait up to 5m0s for pod "pod-subpath-test-dynamicpv-np6g" to be fully deleted
STEP: Deleting pod
May 11 13:28:22.541: INFO: Deleting pod "pod-subpath-test-dynamicpv-np6g" in namespace "provisioning-2564"
STEP: Deleting pvc
May 11 13:28:22.544: INFO: Deleting PersistentVolumeClaim "hostpath.csi.k8s.io5nmwg"
... skipping 9 lines ...

• [SLOW TEST:33.113 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":4,"skipped":980,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
[BeforeEach] [Testpattern: Pre-provisioned PV (block volmode)] volumes
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:130
May 11 13:28:27.661: 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 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 20 lines ...
May 11 13:28:14.413: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
May 11 13:28:14.419: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.io7rjkh] to have phase Bound
May 11 13:28:14.422: INFO: PersistentVolumeClaim hostpath.csi.k8s.io7rjkh found but phase is Pending instead of Bound.
May 11 13:28:16.426: INFO: PersistentVolumeClaim hostpath.csi.k8s.io7rjkh found and phase=Bound (2.006685045s)
STEP: Creating pod pod-subpath-test-dynamicpv-s6td
STEP: Creating a pod to test subpath
May 11 13:28:16.436: INFO: Waiting up to 5m0s for pod "pod-subpath-test-dynamicpv-s6td" in namespace "provisioning-2499" to be "Succeeded or Failed"
May 11 13:28:16.441: INFO: Pod "pod-subpath-test-dynamicpv-s6td": Phase="Pending", Reason="", readiness=false. Elapsed: 3.811172ms
May 11 13:28:18.445: INFO: Pod "pod-subpath-test-dynamicpv-s6td": Phase="Pending", Reason="", readiness=false. Elapsed: 2.007603042s
May 11 13:28:20.449: INFO: Pod "pod-subpath-test-dynamicpv-s6td": Phase="Pending", Reason="", readiness=false. Elapsed: 4.011263952s
May 11 13:28:22.452: INFO: Pod "pod-subpath-test-dynamicpv-s6td": Phase="Pending", Reason="", readiness=false. Elapsed: 6.014944753s
May 11 13:28:24.456: INFO: Pod "pod-subpath-test-dynamicpv-s6td": Phase="Pending", Reason="", readiness=false. Elapsed: 8.01868954s
May 11 13:28:26.459: INFO: Pod "pod-subpath-test-dynamicpv-s6td": Phase="Pending", Reason="", readiness=false. Elapsed: 10.021864199s
May 11 13:28:28.463: INFO: Pod "pod-subpath-test-dynamicpv-s6td": Phase="Pending", Reason="", readiness=false. Elapsed: 12.025350917s
May 11 13:28:30.466: INFO: Pod "pod-subpath-test-dynamicpv-s6td": Phase="Pending", Reason="", readiness=false. Elapsed: 14.028928976s
May 11 13:28:32.470: INFO: Pod "pod-subpath-test-dynamicpv-s6td": Phase="Pending", Reason="", readiness=false. Elapsed: 16.032744951s
May 11 13:28:34.474: INFO: Pod "pod-subpath-test-dynamicpv-s6td": Phase="Pending", Reason="", readiness=false. Elapsed: 18.036649383s
May 11 13:28:36.477: INFO: Pod "pod-subpath-test-dynamicpv-s6td": Phase="Succeeded", Reason="", readiness=false. Elapsed: 20.039907702s
STEP: Saw pod success
May 11 13:28:36.477: INFO: Pod "pod-subpath-test-dynamicpv-s6td" satisfied condition "Succeeded or Failed"
May 11 13:28:36.480: INFO: Trying to get logs from node csi-prow-worker2 pod pod-subpath-test-dynamicpv-s6td container test-container-volume-dynamicpv-s6td: <nil>
STEP: delete the pod
May 11 13:28:36.495: INFO: Waiting for pod pod-subpath-test-dynamicpv-s6td to disappear
May 11 13:28:36.498: INFO: Pod pod-subpath-test-dynamicpv-s6td no longer exists
STEP: Deleting pod pod-subpath-test-dynamicpv-s6td
May 11 13:28:36.498: INFO: Deleting pod "pod-subpath-test-dynamicpv-s6td" in namespace "provisioning-2499"
... 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":786,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
[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
May 11 13:28:41.653: INFO: Driver hostpath.csi.k8s.io doesn't support ext3 -- skipping
... skipping 148 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":3,"skipped":414,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
[BeforeEach] [Testpattern: Dynamic PV (ntfs)][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
May 11 13:28:47.490: INFO: Driver hostpath.csi.k8s.io doesn't support ntfs -- skipping
... skipping 78 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":3,"skipped":426,"failed":0}

SSSSSSSSSSSSSSSSSS
------------------------------
[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
May 11 13:28:47.825: INFO: Driver hostpath.csi.k8s.io doesn't support ext4 -- skipping
... skipping 59 lines ...
May 11 13:28:21.297: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
May 11 13:28:21.306: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.iobb89f] to have phase Bound
May 11 13:28:21.310: INFO: PersistentVolumeClaim hostpath.csi.k8s.iobb89f found but phase is Pending instead of Bound.
May 11 13:28:23.314: INFO: PersistentVolumeClaim hostpath.csi.k8s.iobb89f found and phase=Bound (2.00838238s)
STEP: Creating pod pod-subpath-test-dynamicpv-qcz9
STEP: Creating a pod to test atomic-volume-subpath
May 11 13:28:23.328: INFO: Waiting up to 5m0s for pod "pod-subpath-test-dynamicpv-qcz9" in namespace "provisioning-884" to be "Succeeded or Failed"
May 11 13:28:23.331: INFO: Pod "pod-subpath-test-dynamicpv-qcz9": Phase="Pending", Reason="", readiness=false. Elapsed: 3.497235ms
May 11 13:28:25.335: INFO: Pod "pod-subpath-test-dynamicpv-qcz9": Phase="Pending", Reason="", readiness=false. Elapsed: 2.007701087s
May 11 13:28:27.339: INFO: Pod "pod-subpath-test-dynamicpv-qcz9": Phase="Running", Reason="", readiness=true. Elapsed: 4.011140318s
May 11 13:28:29.343: INFO: Pod "pod-subpath-test-dynamicpv-qcz9": Phase="Running", Reason="", readiness=true. Elapsed: 6.015240777s
May 11 13:28:31.347: INFO: Pod "pod-subpath-test-dynamicpv-qcz9": Phase="Running", Reason="", readiness=true. Elapsed: 8.019585364s
May 11 13:28:33.352: INFO: Pod "pod-subpath-test-dynamicpv-qcz9": Phase="Running", Reason="", readiness=true. Elapsed: 10.024071964s
... skipping 2 lines ...
May 11 13:28:39.363: INFO: Pod "pod-subpath-test-dynamicpv-qcz9": Phase="Running", Reason="", readiness=true. Elapsed: 16.035461684s
May 11 13:28:41.367: INFO: Pod "pod-subpath-test-dynamicpv-qcz9": Phase="Running", Reason="", readiness=true. Elapsed: 18.039044608s
May 11 13:28:43.371: INFO: Pod "pod-subpath-test-dynamicpv-qcz9": Phase="Running", Reason="", readiness=true. Elapsed: 20.043250863s
May 11 13:28:45.374: INFO: Pod "pod-subpath-test-dynamicpv-qcz9": Phase="Running", Reason="", readiness=true. Elapsed: 22.046638593s
May 11 13:28:47.378: INFO: Pod "pod-subpath-test-dynamicpv-qcz9": Phase="Succeeded", Reason="", readiness=false. Elapsed: 24.050472106s
STEP: Saw pod success
May 11 13:28:47.378: INFO: Pod "pod-subpath-test-dynamicpv-qcz9" satisfied condition "Succeeded or Failed"
May 11 13:28:47.381: INFO: Trying to get logs from node csi-prow-worker2 pod pod-subpath-test-dynamicpv-qcz9 container test-container-subpath-dynamicpv-qcz9: <nil>
STEP: delete the pod
May 11 13:28:47.396: INFO: Waiting for pod pod-subpath-test-dynamicpv-qcz9 to disappear
May 11 13:28:47.400: INFO: Pod pod-subpath-test-dynamicpv-qcz9 no longer exists
STEP: Deleting pod pod-subpath-test-dynamicpv-qcz9
May 11 13:28:47.400: INFO: Deleting pod "pod-subpath-test-dynamicpv-qcz9" in namespace "provisioning-884"
... 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":962,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
[BeforeEach] [Testpattern: Dynamic PV (default fs)] fsgroupchangepolicy
  /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)] fsgroupchangepolicy
... skipping 61 lines ...
May 11 13:28:26.653: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
May 11 13:28:26.658: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.iow572d] to have phase Bound
May 11 13:28:26.661: INFO: PersistentVolumeClaim hostpath.csi.k8s.iow572d found but phase is Pending instead of Bound.
May 11 13:28:28.665: INFO: PersistentVolumeClaim hostpath.csi.k8s.iow572d found and phase=Bound (2.006333699s)
STEP: Expanding non-expandable pvc
May 11 13:28:28.670: INFO: currentPvcSize {{1073741824 0} {<nil>} 1Gi BinarySI}, newSize {{2147483648 0} {<nil>}  BinarySI}
May 11 13:28:28.677: INFO: Error updating pvc hostpath.csi.k8s.iow572d: persistentvolumeclaims "hostpath.csi.k8s.iow572d" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
May 11 13:28:30.685: INFO: Error updating pvc hostpath.csi.k8s.iow572d: persistentvolumeclaims "hostpath.csi.k8s.iow572d" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
May 11 13:28:32.689: INFO: Error updating pvc hostpath.csi.k8s.iow572d: persistentvolumeclaims "hostpath.csi.k8s.iow572d" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
May 11 13:28:34.685: INFO: Error updating pvc hostpath.csi.k8s.iow572d: persistentvolumeclaims "hostpath.csi.k8s.iow572d" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
May 11 13:28:36.685: INFO: Error updating pvc hostpath.csi.k8s.iow572d: persistentvolumeclaims "hostpath.csi.k8s.iow572d" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
May 11 13:28:38.689: INFO: Error updating pvc hostpath.csi.k8s.iow572d: persistentvolumeclaims "hostpath.csi.k8s.iow572d" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
May 11 13:28:40.684: INFO: Error updating pvc hostpath.csi.k8s.iow572d: persistentvolumeclaims "hostpath.csi.k8s.iow572d" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
May 11 13:28:42.685: INFO: Error updating pvc hostpath.csi.k8s.iow572d: persistentvolumeclaims "hostpath.csi.k8s.iow572d" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
May 11 13:28:44.686: INFO: Error updating pvc hostpath.csi.k8s.iow572d: persistentvolumeclaims "hostpath.csi.k8s.iow572d" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
May 11 13:28:46.684: INFO: Error updating pvc hostpath.csi.k8s.iow572d: persistentvolumeclaims "hostpath.csi.k8s.iow572d" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
May 11 13:28:48.686: INFO: Error updating pvc hostpath.csi.k8s.iow572d: persistentvolumeclaims "hostpath.csi.k8s.iow572d" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
May 11 13:28:50.692: INFO: Error updating pvc hostpath.csi.k8s.iow572d: persistentvolumeclaims "hostpath.csi.k8s.iow572d" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
May 11 13:28:52.683: INFO: Error updating pvc hostpath.csi.k8s.iow572d: persistentvolumeclaims "hostpath.csi.k8s.iow572d" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
May 11 13:28:54.685: INFO: Error updating pvc hostpath.csi.k8s.iow572d: persistentvolumeclaims "hostpath.csi.k8s.iow572d" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
May 11 13:28:56.686: INFO: Error updating pvc hostpath.csi.k8s.iow572d: persistentvolumeclaims "hostpath.csi.k8s.iow572d" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
May 11 13:28:58.685: INFO: Error updating pvc hostpath.csi.k8s.iow572d: persistentvolumeclaims "hostpath.csi.k8s.iow572d" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
May 11 13:28:58.690: INFO: Error updating pvc hostpath.csi.k8s.iow572d: persistentvolumeclaims "hostpath.csi.k8s.iow572d" is forbidden: only dynamically provisioned pvc can be resized and the storageclass that provisions the pvc must support resize
STEP: Deleting pvc
May 11 13:28:58.690: INFO: Deleting PersistentVolumeClaim "hostpath.csi.k8s.iow572d"
May 11 13:28:58.696: INFO: Waiting up to 5m0s for PersistentVolume pvc-e0b613ae-1550-4c3b-bef6-79660f698289 to get deleted
May 11 13:28:58.698: INFO: PersistentVolume pvc-e0b613ae-1550-4c3b-bef6-79660f698289 found and phase=Bound (2.491162ms)
May 11 13:29:03.702: INFO: PersistentVolume pvc-e0b613ae-1550-4c3b-bef6-79660f698289 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":796,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (default fs)] subPath 
  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
... skipping 15 lines ...
May 11 13:28:42.071: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
May 11 13:28:42.077: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.io85p67] to have phase Bound
May 11 13:28:42.080: INFO: PersistentVolumeClaim hostpath.csi.k8s.io85p67 found but phase is Pending instead of Bound.
May 11 13:28:44.084: INFO: PersistentVolumeClaim hostpath.csi.k8s.io85p67 found and phase=Bound (2.006908251s)
STEP: Creating pod pod-subpath-test-dynamicpv-r87h
STEP: Creating a pod to test subpath
May 11 13:28:44.094: INFO: Waiting up to 5m0s for pod "pod-subpath-test-dynamicpv-r87h" in namespace "provisioning-4227" to be "Succeeded or Failed"
May 11 13:28:44.101: INFO: Pod "pod-subpath-test-dynamicpv-r87h": Phase="Pending", Reason="", readiness=false. Elapsed: 5.183988ms
May 11 13:28:46.105: INFO: Pod "pod-subpath-test-dynamicpv-r87h": Phase="Pending", Reason="", readiness=false. Elapsed: 2.009175672s
May 11 13:28:48.110: INFO: Pod "pod-subpath-test-dynamicpv-r87h": Phase="Pending", Reason="", readiness=false. Elapsed: 4.014947137s
May 11 13:28:50.116: INFO: Pod "pod-subpath-test-dynamicpv-r87h": Phase="Pending", Reason="", readiness=false. Elapsed: 6.020387116s
May 11 13:28:52.119: INFO: Pod "pod-subpath-test-dynamicpv-r87h": Phase="Pending", Reason="", readiness=false. Elapsed: 8.023946956s
May 11 13:28:54.123: INFO: Pod "pod-subpath-test-dynamicpv-r87h": Phase="Pending", Reason="", readiness=false. Elapsed: 10.027999131s
... skipping 2 lines ...
May 11 13:29:00.135: INFO: Pod "pod-subpath-test-dynamicpv-r87h": Phase="Pending", Reason="", readiness=false. Elapsed: 16.040075675s
May 11 13:29:02.139: INFO: Pod "pod-subpath-test-dynamicpv-r87h": Phase="Pending", Reason="", readiness=false. Elapsed: 18.043367082s
May 11 13:29:04.143: INFO: Pod "pod-subpath-test-dynamicpv-r87h": Phase="Pending", Reason="", readiness=false. Elapsed: 20.047520414s
May 11 13:29:06.147: INFO: Pod "pod-subpath-test-dynamicpv-r87h": Phase="Pending", Reason="", readiness=false. Elapsed: 22.051843687s
May 11 13:29:08.151: INFO: Pod "pod-subpath-test-dynamicpv-r87h": Phase="Succeeded", Reason="", readiness=false. Elapsed: 24.055286743s
STEP: Saw pod success
May 11 13:29:08.151: INFO: Pod "pod-subpath-test-dynamicpv-r87h" satisfied condition "Succeeded or Failed"
May 11 13:29:08.154: INFO: Trying to get logs from node csi-prow-worker2 pod pod-subpath-test-dynamicpv-r87h container test-container-subpath-dynamicpv-r87h: <nil>
STEP: delete the pod
May 11 13:29:08.169: INFO: Waiting for pod pod-subpath-test-dynamicpv-r87h to disappear
May 11 13:29:08.172: INFO: Pod pod-subpath-test-dynamicpv-r87h no longer exists
STEP: Deleting pod pod-subpath-test-dynamicpv-r87h
May 11 13:29:08.172: INFO: Deleting pod "pod-subpath-test-dynamicpv-r87h" in namespace "provisioning-4227"
... 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":5,"skipped":1154,"failed":0}

SSSSSSSSSSSSSSS
------------------------------
[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
May 11 13:29:13.231: INFO: Driver hostpath.csi.k8s.io doesn't support ntfs -- skipping
... skipping 138 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":5,"skipped":1124,"failed":0}

S
------------------------------
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
May 11 13:28:47.895: 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 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
May 11 13:28:47.935: INFO: Creating resource for dynamic PV
May 11 13:28:47.935: INFO: Using claimSize:1Mi, test suite supported size:{ 1Mi}, driver(hostpath.csi.k8s.io) supported size:{ 1Mi} 
STEP: creating a StorageClass provisioning-6608-e2e-sct5qzw
STEP: creating a claim
May 11 13:28:47.941: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
May 11 13:28:47.959: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.iohzpjf] to have phase Bound
May 11 13:28:47.968: INFO: PersistentVolumeClaim hostpath.csi.k8s.iohzpjf found but phase is Pending instead of Bound.
May 11 13:28:49.974: INFO: PersistentVolumeClaim hostpath.csi.k8s.iohzpjf found and phase=Bound (2.014354497s)
STEP: Creating pod pod-subpath-test-dynamicpv-cqq2
STEP: Checking for subpath error in container status
May 11 13:29:02.002: INFO: Deleting pod "pod-subpath-test-dynamicpv-cqq2" in namespace "provisioning-6608"
May 11 13:29:02.008: INFO: Wait up to 5m0s for pod "pod-subpath-test-dynamicpv-cqq2" to be fully deleted
STEP: Deleting pod
May 11 13:29:12.017: INFO: Deleting pod "pod-subpath-test-dynamicpv-cqq2" in namespace "provisioning-6608"
STEP: Deleting pvc
May 11 13:29:12.020: INFO: Deleting PersistentVolumeClaim "hostpath.csi.k8s.iohzpjf"
... skipping 9 lines ...

• [SLOW TEST:29.161 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
------------------------------
S
------------------------------
{"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":4,"skipped":481,"failed":0}

SSSSSSSSSSSSSSSSSSSS
------------------------------
[BeforeEach] [Testpattern: Pre-provisioned 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:130
May 11 13:29:17.072: INFO: Driver supports dynamic provisioning, skipping PreprovisionedPV pattern
... skipping 87 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":6,"skipped":1037,"failed":0}
May 11 13:29:27.875: INFO: Running AfterSuite actions on all nodes


External Storage [Driver: hostpath.csi.k8s.io] [Testpattern: Dynamic PV (default fs)] 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 90 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":4,"skipped":473,"failed":0}
May 11 13:29:37.692: INFO: Running AfterSuite actions on all nodes


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
May 11 13:29:13.300: 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
May 11 13:29:13.335: INFO: Creating resource for dynamic PV
May 11 13:29:13.335: INFO: Using claimSize:1Mi, test suite supported size:{ 1Mi}, driver(hostpath.csi.k8s.io) supported size:{ 1Mi} 
STEP: creating a StorageClass provisioning-7526-e2e-scbgbvh
STEP: creating a claim
May 11 13:29:13.339: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
May 11 13:29:13.346: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.io9smcp] to have phase Bound
May 11 13:29:13.353: INFO: PersistentVolumeClaim hostpath.csi.k8s.io9smcp found but phase is Pending instead of Bound.
May 11 13:29:15.358: INFO: PersistentVolumeClaim hostpath.csi.k8s.io9smcp found and phase=Bound (2.011691098s)
STEP: Creating pod pod-subpath-test-dynamicpv-v4cx
STEP: Checking for subpath error in container status
May 11 13:29:33.374: INFO: Deleting pod "pod-subpath-test-dynamicpv-v4cx" in namespace "provisioning-7526"
May 11 13:29:33.380: INFO: Wait up to 5m0s for pod "pod-subpath-test-dynamicpv-v4cx" to be fully deleted
STEP: Deleting pod
May 11 13:29:41.389: INFO: Deleting pod "pod-subpath-test-dynamicpv-v4cx" in namespace "provisioning-7526"
STEP: Deleting pvc
May 11 13:29:41.392: INFO: Deleting PersistentVolumeClaim "hostpath.csi.k8s.io9smcp"
... skipping 9 lines ...

• [SLOW TEST:33.125 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
------------------------------
{"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":6,"skipped":1211,"failed":0}
May 11 13:29:46.428: INFO: Running AfterSuite actions on all nodes


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 51 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":6,"skipped":891,"failed":0}
May 11 13:29:57.040: INFO: Running AfterSuite actions on all nodes


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]
  /home/prow/go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/volume_io.go:144
... skipping 106 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":5,"skipped":455,"failed":0}
May 11 13:30:17.518: INFO: Running AfterSuite actions on all nodes


{"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":5,"skipped":527,"failed":0}
May 11 13:30:06.355: INFO: Running AfterSuite actions on all nodes
May 11 13:30:17.587: INFO: Running AfterSuite actions on node 1
May 11 13:30:17.587: INFO: Dumping logs locally to: /logs/artifacts
May 11 13:30:17.588: 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 277.249 seconds
SUCCESS! -- 37 Passed | 0 Failed | 0 Pending | 5833 Skipped


Ginkgo ran 1 suite in 4m40.635834848s
Test Suite Passed
Tue May 11 13:30:17 UTC 2021 go1.16.4 /home/prow/go/src/k8s.io/kubernetes$ go run /home/prow/go/src/github.com/kubernetes-csi/csi-test/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
Tue May 11 13:30:18 UTC 2021 go1.16.4 /home/prow/go/src/github.com/onsi/ginkgo$ git fetch --depth=1 https://github.com/onsi/ginkgo v1.7.0
... skipping 196 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":1353,"failed":0}
May 11 13:31:28.139: 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 113 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)] 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 (default fs)] provisioning should provision storage with snapshot data source [Feature:VolumeSnapshotDataSource]","total":-1,"completed":1,"skipped":498,"failed":0}
May 11 13:31:38.924: 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
May 11 13:30:28.361: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
May 11 13:30:28.377: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.io2zg5q] to have phase Bound
May 11 13:30:28.385: INFO: PersistentVolumeClaim hostpath.csi.k8s.io2zg5q found but phase is Pending instead of Bound.
May 11 13:30:30.389: INFO: PersistentVolumeClaim hostpath.csi.k8s.io2zg5q found and phase=Bound (2.012306692s)
STEP: starting a pod to use the claim
May 11 13:30:30.400: INFO: Waiting up to 15m0s for pod "pvc-snapshottable-tester-c8kds" in namespace "snapshotting-6695" to be "Succeeded or Failed"
May 11 13:30:30.405: INFO: Pod "pvc-snapshottable-tester-c8kds": Phase="Pending", Reason="", readiness=false. Elapsed: 5.15413ms
May 11 13:30:32.409: INFO: Pod "pvc-snapshottable-tester-c8kds": Phase="Pending", Reason="", readiness=false. Elapsed: 2.008646436s
May 11 13:30:34.412: INFO: Pod "pvc-snapshottable-tester-c8kds": Phase="Pending", Reason="", readiness=false. Elapsed: 4.012342136s
May 11 13:30:36.416: INFO: Pod "pvc-snapshottable-tester-c8kds": Phase="Pending", Reason="", readiness=false. Elapsed: 6.015816099s
May 11 13:30:38.420: INFO: Pod "pvc-snapshottable-tester-c8kds": Phase="Pending", Reason="", readiness=false. Elapsed: 8.020274238s
May 11 13:30:40.424: INFO: Pod "pvc-snapshottable-tester-c8kds": Phase="Pending", Reason="", readiness=false. Elapsed: 10.023865542s
May 11 13:30:42.428: INFO: Pod "pvc-snapshottable-tester-c8kds": Phase="Pending", Reason="", readiness=false. Elapsed: 12.027666614s
May 11 13:30:44.431: INFO: Pod "pvc-snapshottable-tester-c8kds": Phase="Pending", Reason="", readiness=false. Elapsed: 14.031165905s
May 11 13:30:46.435: INFO: Pod "pvc-snapshottable-tester-c8kds": Phase="Succeeded", Reason="", readiness=false. Elapsed: 16.03469541s
STEP: Saw pod success
May 11 13:30:46.435: INFO: Pod "pvc-snapshottable-tester-c8kds" satisfied condition "Succeeded or Failed"
May 11 13:30:46.443: INFO: Pod pvc-snapshottable-tester-c8kds has the following logs: 
May 11 13:30:46.443: INFO: Deleting pod "pvc-snapshottable-tester-c8kds" in namespace "snapshotting-6695"
May 11 13:30:46.453: INFO: Wait up to 5m0s for pod "pvc-snapshottable-tester-c8kds" to be fully deleted
May 11 13:30:46.459: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.io2zg5q] to have phase Bound
May 11 13:30:46.463: INFO: PersistentVolumeClaim hostpath.csi.k8s.io2zg5q found and phase=Bound (3.988348ms)
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
May 11 13:30:52.571: INFO: Waiting up to 15m0s for pod "pvc-snapshottable-data-tester-wr8ms" in namespace "snapshotting-6695" to be "Succeeded or Failed"
May 11 13:30:52.574: INFO: Pod "pvc-snapshottable-data-tester-wr8ms": Phase="Pending", Reason="", readiness=false. Elapsed: 3.20174ms
May 11 13:30:54.578: INFO: Pod "pvc-snapshottable-data-tester-wr8ms": Phase="Pending", Reason="", readiness=false. Elapsed: 2.006846399s
May 11 13:30:56.582: INFO: Pod "pvc-snapshottable-data-tester-wr8ms": Phase="Pending", Reason="", readiness=false. Elapsed: 4.011067204s
May 11 13:30:58.586: INFO: Pod "pvc-snapshottable-data-tester-wr8ms": Phase="Pending", Reason="", readiness=false. Elapsed: 6.015210755s
May 11 13:31:00.590: INFO: Pod "pvc-snapshottable-data-tester-wr8ms": Phase="Succeeded", Reason="", readiness=false. Elapsed: 8.019080093s
STEP: Saw pod success
May 11 13:31:00.590: INFO: Pod "pvc-snapshottable-data-tester-wr8ms" satisfied condition "Succeeded or Failed"
May 11 13:31:00.595: INFO: Pod pvc-snapshottable-data-tester-wr8ms has the following logs: 
May 11 13:31:00.596: INFO: Deleting pod "pvc-snapshottable-data-tester-wr8ms" in namespace "snapshotting-6695"
May 11 13:31:00.603: INFO: Wait up to 5m0s for pod "pvc-snapshottable-data-tester-wr8ms" to be fully deleted
STEP: creating a pvc from the snapshot
STEP: starting a pod to use the claim
May 11 13:31:08.641: INFO: Running '/usr/local/bin/kubectl --server=https://127.0.0.1:41329 --kubeconfig=/root/.kube/config --namespace=snapshotting-6695 exec restored-pvc-tester-2lwrx --namespace=snapshotting-6695 -- cat /mnt/test/data'
... skipping 69 lines ...
STEP: creating a claim
May 11 13:30:27.639: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
May 11 13:30:27.662: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.ioz7jtx] to have phase Bound
May 11 13:30:27.675: INFO: PersistentVolumeClaim hostpath.csi.k8s.ioz7jtx found but phase is Pending instead of Bound.
May 11 13:30:29.679: INFO: PersistentVolumeClaim hostpath.csi.k8s.ioz7jtx found and phase=Bound (2.017460948s)
STEP: starting a pod to use the claim
May 11 13:30:29.694: INFO: Waiting up to 15m0s for pod "pvc-snapshottable-tester-2ghlc" in namespace "snapshotting-8442" to be "Succeeded or Failed"
May 11 13:30:29.698: INFO: Pod "pvc-snapshottable-tester-2ghlc": Phase="Pending", Reason="", readiness=false. Elapsed: 3.010902ms
May 11 13:30:31.702: INFO: Pod "pvc-snapshottable-tester-2ghlc": Phase="Pending", Reason="", readiness=false. Elapsed: 2.006851145s
May 11 13:30:33.706: INFO: Pod "pvc-snapshottable-tester-2ghlc": Phase="Pending", Reason="", readiness=false. Elapsed: 4.011213225s
May 11 13:30:35.709: INFO: Pod "pvc-snapshottable-tester-2ghlc": Phase="Pending", Reason="", readiness=false. Elapsed: 6.014220539s
May 11 13:30:37.712: INFO: Pod "pvc-snapshottable-tester-2ghlc": Phase="Pending", Reason="", readiness=false. Elapsed: 8.017469149s
May 11 13:30:39.715: INFO: Pod "pvc-snapshottable-tester-2ghlc": Phase="Pending", Reason="", readiness=false. Elapsed: 10.020670893s
May 11 13:30:41.719: INFO: Pod "pvc-snapshottable-tester-2ghlc": Phase="Pending", Reason="", readiness=false. Elapsed: 12.024515166s
May 11 13:30:43.723: INFO: Pod "pvc-snapshottable-tester-2ghlc": Phase="Succeeded", Reason="", readiness=false. Elapsed: 14.028440924s
STEP: Saw pod success
May 11 13:30:43.723: INFO: Pod "pvc-snapshottable-tester-2ghlc" satisfied condition "Succeeded or Failed"
May 11 13:30:43.733: INFO: Pod pvc-snapshottable-tester-2ghlc has the following logs: 
May 11 13:30:43.733: INFO: Deleting pod "pvc-snapshottable-tester-2ghlc" in namespace "snapshotting-8442"
May 11 13:30:43.744: INFO: Wait up to 5m0s for pod "pvc-snapshottable-tester-2ghlc" to be fully deleted
May 11 13:30:43.746: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.ioz7jtx] to have phase Bound
May 11 13:30:43.749: INFO: PersistentVolumeClaim hostpath.csi.k8s.ioz7jtx found and phase=Bound (2.531015ms)
STEP: checking the claim
... skipping 12 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
May 11 13:30:47.800: INFO: Waiting up to 15m0s for pod "pvc-snapshottable-data-tester-9d5fq" in namespace "snapshotting-8442" to be "Succeeded or Failed"
May 11 13:30:47.803: INFO: Pod "pvc-snapshottable-data-tester-9d5fq": Phase="Pending", Reason="", readiness=false. Elapsed: 3.177756ms
May 11 13:30:49.807: INFO: Pod "pvc-snapshottable-data-tester-9d5fq": Phase="Pending", Reason="", readiness=false. Elapsed: 2.007155562s
May 11 13:30:51.811: INFO: Pod "pvc-snapshottable-data-tester-9d5fq": Phase="Pending", Reason="", readiness=false. Elapsed: 4.011159074s
May 11 13:30:53.815: INFO: Pod "pvc-snapshottable-data-tester-9d5fq": Phase="Pending", Reason="", readiness=false. Elapsed: 6.015095768s
May 11 13:30:55.819: INFO: Pod "pvc-snapshottable-data-tester-9d5fq": Phase="Pending", Reason="", readiness=false. Elapsed: 8.018515278s
May 11 13:30:57.822: INFO: Pod "pvc-snapshottable-data-tester-9d5fq": Phase="Pending", Reason="", readiness=false. Elapsed: 10.022490228s
May 11 13:30:59.826: INFO: Pod "pvc-snapshottable-data-tester-9d5fq": Phase="Succeeded", Reason="", readiness=false. Elapsed: 12.026060032s
STEP: Saw pod success
May 11 13:30:59.826: INFO: Pod "pvc-snapshottable-data-tester-9d5fq" satisfied condition "Succeeded or Failed"
May 11 13:30:59.832: INFO: Pod pvc-snapshottable-data-tester-9d5fq has the following logs: 
May 11 13:30:59.832: INFO: Deleting pod "pvc-snapshottable-data-tester-9d5fq" in namespace "snapshotting-8442"
May 11 13:30:59.843: INFO: Wait up to 5m0s for pod "pvc-snapshottable-data-tester-9d5fq" to be fully deleted
STEP: creating a pvc from the snapshot
STEP: starting a pod to use the claim
May 11 13:31:11.867: INFO: Running '/usr/local/bin/kubectl --server=https://127.0.0.1:41329 --kubeconfig=/root/.kube/config --namespace=snapshotting-8442 exec restored-pvc-tester-nnls9 --namespace=snapshotting-8442 -- 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":186,"failed":0}
May 11 13:31:57.160: 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
May 11 13:30:28.940: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
May 11 13:30:28.969: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.iowmb9d] to have phase Bound
May 11 13:30:28.977: INFO: PersistentVolumeClaim hostpath.csi.k8s.iowmb9d found but phase is Pending instead of Bound.
May 11 13:30:30.980: INFO: PersistentVolumeClaim hostpath.csi.k8s.iowmb9d found and phase=Bound (2.011352811s)
STEP: starting a pod to use the claim
May 11 13:30:30.990: INFO: Waiting up to 15m0s for pod "pvc-snapshottable-tester-2qxms" in namespace "snapshotting-4780" to be "Succeeded or Failed"
May 11 13:30:30.992: INFO: Pod "pvc-snapshottable-tester-2qxms": Phase="Pending", Reason="", readiness=false. Elapsed: 2.321868ms
May 11 13:30:33.003: INFO: Pod "pvc-snapshottable-tester-2qxms": Phase="Pending", Reason="", readiness=false. Elapsed: 2.013515644s
May 11 13:30:35.008: INFO: Pod "pvc-snapshottable-tester-2qxms": Phase="Pending", Reason="", readiness=false. Elapsed: 4.017985232s
May 11 13:30:37.012: INFO: Pod "pvc-snapshottable-tester-2qxms": Phase="Pending", Reason="", readiness=false. Elapsed: 6.022035621s
May 11 13:30:39.015: INFO: Pod "pvc-snapshottable-tester-2qxms": Phase="Succeeded", Reason="", readiness=false. Elapsed: 8.025454747s
STEP: Saw pod success
May 11 13:30:39.015: INFO: Pod "pvc-snapshottable-tester-2qxms" satisfied condition "Succeeded or Failed"
May 11 13:30:40.105: INFO: Pod pvc-snapshottable-tester-2qxms has the following logs: 
May 11 13:30:40.105: INFO: Deleting pod "pvc-snapshottable-tester-2qxms" in namespace "snapshotting-4780"
May 11 13:30:40.118: INFO: Wait up to 5m0s for pod "pvc-snapshottable-tester-2qxms" to be fully deleted
May 11 13:30:40.122: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.iowmb9d] to have phase Bound
May 11 13:30:40.128: INFO: PersistentVolumeClaim hostpath.csi.k8s.iowmb9d found and phase=Bound (5.395276ms)
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
May 11 13:30:46.237: INFO: Waiting up to 15m0s for pod "pvc-snapshottable-data-tester-nbrll" in namespace "snapshotting-4780" to be "Succeeded or Failed"
May 11 13:30:46.242: INFO: Pod "pvc-snapshottable-data-tester-nbrll": Phase="Pending", Reason="", readiness=false. Elapsed: 5.062586ms
May 11 13:30:48.245: INFO: Pod "pvc-snapshottable-data-tester-nbrll": Phase="Pending", Reason="", readiness=false. Elapsed: 2.008781225s
May 11 13:30:50.249: INFO: Pod "pvc-snapshottable-data-tester-nbrll": Phase="Pending", Reason="", readiness=false. Elapsed: 4.012169587s
May 11 13:30:52.252: INFO: Pod "pvc-snapshottable-data-tester-nbrll": Phase="Pending", Reason="", readiness=false. Elapsed: 6.015825128s
May 11 13:30:54.256: INFO: Pod "pvc-snapshottable-data-tester-nbrll": Phase="Pending", Reason="", readiness=false. Elapsed: 8.019387387s
May 11 13:30:56.263: INFO: Pod "pvc-snapshottable-data-tester-nbrll": Phase="Succeeded", Reason="", readiness=false. Elapsed: 10.025977987s
STEP: Saw pod success
May 11 13:30:56.263: INFO: Pod "pvc-snapshottable-data-tester-nbrll" satisfied condition "Succeeded or Failed"
May 11 13:30:56.268: INFO: Pod pvc-snapshottable-data-tester-nbrll has the following logs: 
May 11 13:30:56.268: INFO: Deleting pod "pvc-snapshottable-data-tester-nbrll" in namespace "snapshotting-4780"
May 11 13:30:56.275: INFO: Wait up to 5m0s for pod "pvc-snapshottable-data-tester-nbrll" to be fully deleted
STEP: creating a pvc from the snapshot
STEP: starting a pod to use the claim
May 11 13:31:14.298: INFO: Running '/usr/local/bin/kubectl --server=https://127.0.0.1:41329 --kubeconfig=/root/.kube/config --namespace=snapshotting-4780 exec restored-pvc-tester-5sv6h --namespace=snapshotting-4780 -- cat /mnt/test/data'
... skipping 35 lines ...
May 11 13:31:40.637: INFO: volumesnapshotcontents pre-provisioned-snapcontent-2a479ef8-4486-4f34-aabf-a03257abf002 has been found and is not deleted
May 11 13:31:41.642: INFO: volumesnapshotcontents pre-provisioned-snapcontent-2a479ef8-4486-4f34-aabf-a03257abf002 has been found and is not deleted
May 11 13:31:42.646: INFO: volumesnapshotcontents pre-provisioned-snapcontent-2a479ef8-4486-4f34-aabf-a03257abf002 has been found and is not deleted
May 11 13:31:43.650: INFO: volumesnapshotcontents pre-provisioned-snapcontent-2a479ef8-4486-4f34-aabf-a03257abf002 has been found and is not deleted
May 11 13:31:44.654: INFO: volumesnapshotcontents pre-provisioned-snapcontent-2a479ef8-4486-4f34-aabf-a03257abf002 has been found and is not deleted
May 11 13:31:45.658: INFO: volumesnapshotcontents pre-provisioned-snapcontent-2a479ef8-4486-4f34-aabf-a03257abf002 has been found and is not deleted
May 11 13:31:46.658: 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
May 11 13:31:46.665: INFO: Pod restored-pvc-tester-5sv6h has the following logs: 
May 11 13:31:46.665: INFO: Deleting pod "restored-pvc-tester-5sv6h" in namespace "snapshotting-4780"
May 11 13:31:46.672: INFO: Wait up to 5m0s for pod "restored-pvc-tester-5sv6h" to be fully deleted
May 11 13:32:22.681: INFO: deleting claim "snapshotting-4780"/"pvc-hd8sb"
... 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":684,"failed":0}
May 11 13:32:29.760: 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
May 11 13:30:29.257: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
May 11 13:30:29.269: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.io27d5s] to have phase Bound
May 11 13:30:29.283: INFO: PersistentVolumeClaim hostpath.csi.k8s.io27d5s found but phase is Pending instead of Bound.
May 11 13:30:31.286: INFO: PersistentVolumeClaim hostpath.csi.k8s.io27d5s found and phase=Bound (2.016656467s)
STEP: starting a pod to use the claim
May 11 13:30:31.295: INFO: Waiting up to 15m0s for pod "pvc-snapshottable-tester-mzcjw" in namespace "snapshotting-1970" to be "Succeeded or Failed"
May 11 13:30:31.297: INFO: Pod "pvc-snapshottable-tester-mzcjw": Phase="Pending", Reason="", readiness=false. Elapsed: 2.447223ms
May 11 13:30:33.300: INFO: Pod "pvc-snapshottable-tester-mzcjw": Phase="Pending", Reason="", readiness=false. Elapsed: 2.005440196s
May 11 13:30:35.304: INFO: Pod "pvc-snapshottable-tester-mzcjw": Phase="Pending", Reason="", readiness=false. Elapsed: 4.009216399s
May 11 13:30:37.307: INFO: Pod "pvc-snapshottable-tester-mzcjw": Phase="Pending", Reason="", readiness=false. Elapsed: 6.012527058s
May 11 13:30:39.310: INFO: Pod "pvc-snapshottable-tester-mzcjw": Phase="Pending", Reason="", readiness=false. Elapsed: 8.01563765s
May 11 13:30:41.316: INFO: Pod "pvc-snapshottable-tester-mzcjw": Phase="Running", Reason="", readiness=true. Elapsed: 10.021529336s
May 11 13:30:43.320: INFO: Pod "pvc-snapshottable-tester-mzcjw": Phase="Succeeded", Reason="", readiness=false. Elapsed: 12.024882998s
STEP: Saw pod success
May 11 13:30:43.320: INFO: Pod "pvc-snapshottable-tester-mzcjw" satisfied condition "Succeeded or Failed"
May 11 13:30:43.327: INFO: Pod pvc-snapshottable-tester-mzcjw has the following logs: 
May 11 13:30:43.327: INFO: Deleting pod "pvc-snapshottable-tester-mzcjw" in namespace "snapshotting-1970"
May 11 13:30:43.336: INFO: Wait up to 5m0s for pod "pvc-snapshottable-tester-mzcjw" to be fully deleted
May 11 13:30:43.339: INFO: Waiting up to 5m0s for PersistentVolumeClaims [hostpath.csi.k8s.io27d5s] to have phase Bound
May 11 13:30:43.342: INFO: PersistentVolumeClaim hostpath.csi.k8s.io27d5s found and phase=Bound (3.579111ms)
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
May 11 13:30:45.395: INFO: Waiting up to 15m0s for pod "pvc-snapshottable-data-tester-n9xlm" in namespace "snapshotting-1970" to be "Succeeded or Failed"
May 11 13:30:45.400: INFO: Pod "pvc-snapshottable-data-tester-n9xlm": Phase="Pending", Reason="", readiness=false. Elapsed: 4.559321ms
May 11 13:30:47.403: INFO: Pod "pvc-snapshottable-data-tester-n9xlm": Phase="Pending", Reason="", readiness=false. Elapsed: 2.007775915s
May 11 13:30:49.406: INFO: Pod "pvc-snapshottable-data-tester-n9xlm": Phase="Pending", Reason="", readiness=false. Elapsed: 4.011359679s
May 11 13:30:51.409: INFO: Pod "pvc-snapshottable-data-tester-n9xlm": Phase="Pending", Reason="", readiness=false. Elapsed: 6.014101024s
May 11 13:30:53.412: INFO: Pod "pvc-snapshottable-data-tester-n9xlm": Phase="Pending", Reason="", readiness=false. Elapsed: 8.017501601s
May 11 13:30:55.416: INFO: Pod "pvc-snapshottable-data-tester-n9xlm": Phase="Pending", Reason="", readiness=false. Elapsed: 10.020980038s
May 11 13:30:57.420: INFO: Pod "pvc-snapshottable-data-tester-n9xlm": Phase="Pending", Reason="", readiness=false. Elapsed: 12.024663229s
May 11 13:30:59.423: INFO: Pod "pvc-snapshottable-data-tester-n9xlm": Phase="Pending", Reason="", readiness=false. Elapsed: 14.028343151s
May 11 13:31:01.427: INFO: Pod "pvc-snapshottable-data-tester-n9xlm": Phase="Pending", Reason="", readiness=false. Elapsed: 16.031809875s
May 11 13:31:03.430: INFO: Pod "pvc-snapshottable-data-tester-n9xlm": Phase="Pending", Reason="", readiness=false. Elapsed: 18.034733505s
May 11 13:31:05.433: INFO: Pod "pvc-snapshottable-data-tester-n9xlm": Phase="Succeeded", Reason="", readiness=false. Elapsed: 20.037828378s
STEP: Saw pod success
May 11 13:31:05.433: INFO: Pod "pvc-snapshottable-data-tester-n9xlm" satisfied condition "Succeeded or Failed"
May 11 13:31:05.439: INFO: Pod pvc-snapshottable-data-tester-n9xlm has the following logs: 
May 11 13:31:05.439: INFO: Deleting pod "pvc-snapshottable-data-tester-n9xlm" in namespace "snapshotting-1970"
May 11 13:31:05.448: INFO: Wait up to 5m0s for pod "pvc-snapshottable-data-tester-n9xlm" to be fully deleted
STEP: creating a pvc from the snapshot
STEP: starting a pod to use the claim
May 11 13:31:17.478: INFO: Running '/usr/local/bin/kubectl --server=https://127.0.0.1:41329 --kubeconfig=/root/.kube/config --namespace=snapshotting-1970 exec restored-pvc-tester-gcx7x --namespace=snapshotting-1970 -- cat /mnt/test/data'
... skipping 35 lines ...
May 11 13:31:43.822: INFO: volumesnapshotcontents snapcontent-e912b4c5-0be3-444c-88d1-44b01b894e36 has been found and is not deleted
May 11 13:31:44.826: INFO: volumesnapshotcontents snapcontent-e912b4c5-0be3-444c-88d1-44b01b894e36 has been found and is not deleted
May 11 13:31:45.830: INFO: volumesnapshotcontents snapcontent-e912b4c5-0be3-444c-88d1-44b01b894e36 has been found and is not deleted
May 11 13:31:46.834: INFO: volumesnapshotcontents snapcontent-e912b4c5-0be3-444c-88d1-44b01b894e36 has been found and is not deleted
May 11 13:31:47.839: INFO: volumesnapshotcontents snapcontent-e912b4c5-0be3-444c-88d1-44b01b894e36 has been found and is not deleted
May 11 13:31:48.843: INFO: volumesnapshotcontents snapcontent-e912b4c5-0be3-444c-88d1-44b01b894e36 has been found and is not deleted
May 11 13:31:49.843: 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
May 11 13:31:49.849: INFO: Pod restored-pvc-tester-gcx7x has the following logs: 
May 11 13:31:49.849: INFO: Deleting pod "restored-pvc-tester-gcx7x" in namespace "snapshotting-1970"
May 11 13:31:49.855: INFO: Wait up to 5m0s for pod "restored-pvc-tester-gcx7x" to be fully deleted
May 11 13:32:31.867: INFO: deleting claim "snapshotting-1970"/"pvc-g599s"
... 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":855,"failed":0}
May 11 13:32:38.942: INFO: Running AfterSuite actions on all nodes


{"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":416,"failed":0}
May 11 13:31:56.958: INFO: Running AfterSuite actions on all nodes
May 11 13:32:38.991: INFO: Running AfterSuite actions on node 1
May 11 13:32:38.991: INFO: Dumping logs locally to: /logs/artifacts
May 11 13:32:38.992: 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 133.127 seconds
SUCCESS! -- 6 Passed | 0 Failed | 0 Pending | 5864 Skipped


Ginkgo ran 1 suite in 2m17.07180403s
Test Suite Passed
Tue May 11 13:32:39 UTC 2021 go1.16.4 /home/prow/go/src/k8s.io/kubernetes$ go run /home/prow/go/src/github.com/kubernetes-csi/csi-test/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
Tue May 11 13:32:39 UTC 2021 go1.16.4 $ kind export logs --name=csi-prow /logs/artifacts/cluster-logs/non-alpha
... skipping 23 lines ...