This job view page is being replaced by Spyglass soon. Check out the new job view.
ResultFAILURE
Tests 0 failed / 0 succeeded
Started2022-09-30 18:14
Elapsed2h38m
Revision
Builderb2b599ab-40eb-11ed-8a9c-0a5a8f92a653
Refs master:7f9927c5
376:259cd1f1
infra-commit4982ca61a
reposigs.k8s.io/gcp-filestore-csi-driver
repo-commit5037f30db14c0099528b156349568834cd8d7b3e
repos{u'sigs.k8s.io/gcp-filestore-csi-driver': u'master:7f9927c5d280fafb9bb909f36ccd72f1f5bfbba0,376:259cd1f1420a94f32f78192d9eb72e9fe907053e'}

No Test Failures!


Error lines from build-log.txt

... skipping 139 lines ...
I0930 18:15:49.077] PWD is /go/src/sigs.k8s.io/gcp-filestore-csi-driver
I0930 18:15:49.078] STAGINGVERSION is 9389aaa0-efdd-4798-92a1-71e46af39ebf
I0930 18:15:49.078] STAGINGIMAGE is gcr.io/gce-cvm-upg-1-4-1-5-ctl-skew/gcp-filestore-csi-driver
I0930 18:15:49.078] WEBHOOK_STAGINGIMAGE is gcr.io/gce-cvm-upg-1-4-1-5-ctl-skew/gcp-filestore-csi-driver-webhook
I0930 18:15:49.078] # Ensure we use a builder that can leverage it (the default on linux will not)
I0930 18:15:49.079] docker buildx rm multiarch-multiplatform-builder
W0930 18:15:49.336] error: no builder "multiarch-multiplatform-builder" found
W0930 18:15:49.342] make: [Makefile:179: init-buildx] Error 1 (ignored)
I0930 18:15:49.442] docker buildx create --use --name=multiarch-multiplatform-builder
I0930 18:15:49.486] multiarch-multiplatform-builder
I0930 18:15:49.491] docker run --rm --privileged multiarch/qemu-user-static --reset --credential yes --persistent yes
W0930 18:15:49.592] Unable to find image 'multiarch/qemu-user-static:latest' locally
W0930 18:15:49.789] latest: Pulling from multiarch/qemu-user-static
W0930 18:15:49.790] 19d511225f94: Pulling fs layer
... skipping 199 lines ...
W0930 18:16:18.487] #9 9.147 Setting up libtinfo6:amd64 (6.1+20181013-2+deb10u2) ...
W0930 18:16:18.487] #9 9.207 Selecting previously unselected package bash.
W0930 18:16:18.488] #9 9.207 (Reading database ... 
(Reading database ... 5%
(Reading database ... 10%
(Reading database ... 15%
(Reading database ... 20%
(Reading database ... 25%
(Reading database ... 30%
(Reading database ... 35%
(Reading database ... 40%
(Reading database ... 45%
(Reading database ... 50%
(Reading database ... 55%
(Reading database ... 60%
(Reading database ... 65%
(Reading database ... 70%
(Reading database ... 75%
(Reading database ... 80%
(Reading database ... 85%
(Reading database ... 90%
(Reading database ... 95%
(Reading database ... 100%
(Reading database ... 3900 files and directories currently installed.)
W0930 18:16:18.489] #9 9.214 Preparing to unpack .../archives/bash_5.0-4_amd64.deb ...
W0930 18:16:18.489] #9 9.225 Unpacking bash (5.0-4) ...
W0930 18:16:18.489] #9 9.502 Setting up bash (5.0-4) ...
W0930 18:16:18.490] #9 9.532 update-alternatives: error: alternative path /usr/share/man/man7/bash-builtins.7.gz doesn't exist

W0930 18:16:18.491] #9 9.607 (Reading database ... 
(Reading database ... 5%
(Reading database ... 10%
(Reading database ... 15%
(Reading database ... 20%
(Reading database ... 25%
(Reading database ... 30%
(Reading database ... 35%
(Reading database ... 40%
(Reading database ... 45%
(Reading database ... 50%
(Reading database ... 55%
(Reading database ... 60%
(Reading database ... 65%
(Reading database ... 70%
(Reading database ... 75%
(Reading database ... 80%
(Reading database ... 85%
(Reading database ... 90%
(Reading database ... 95%
(Reading database ... 100%
(Reading database ... 3972 files and directories currently installed.)
W0930 18:16:18.491] #9 9.617 Preparing to unpack .../archives/dpkg_1.19.8_amd64.deb ...
W0930 18:16:18.492] #9 9.630 Unpacking dpkg (1.19.8) over (1.19.7) ...
W0930 18:16:18.492] #9 9.903 Setting up dpkg (1.19.8) ...
W0930 18:16:18.492] #9 9.972 (Reading database ... 
(Reading database ... 5%
(Reading database ... 10%
(Reading database ... 15%
(Reading database ... 20%
(Reading database ... 25%
(Reading database ... 30%
(Reading database ... 35%
(Reading database ... 40%
(Reading database ... 45%
(Reading database ... 50%
(Reading database ... 55%
(Reading database ... 60%
(Reading database ... 65%
(Reading database ... 70%
(Reading database ... 75%
(Reading database ... 80%
(Reading database ... 85%
(Reading database ... 90%
(Reading database ... 95%
(Reading database ... 100%
(Reading database ... 3972 files and directories currently installed.)
W0930 18:16:18.493] #9 9.984 Preparing to unpack .../gzip_1.9-3+deb10u1_amd64.deb ...
... skipping 660 lines ...
W0930 18:44:17.462] NODE_NAMES=e2e-test-prow-minion-group-61th e2e-test-prow-minion-group-7rkg e2e-test-prow-minion-group-gxdd
W0930 18:44:17.463] Trying to find master named 'e2e-test-prow-master'
W0930 18:44:17.463] Looking for address 'e2e-test-prow-master-ip'
I0930 18:44:18.761] Waiting up to 300 seconds for cluster initialization.
I0930 18:44:18.761] 
I0930 18:44:18.761]   This will continually check to see if the API for kubernetes is reachable.
I0930 18:44:18.761]   This may time out if there was some uncaught error during start up.
I0930 18:44:18.761] 
W0930 18:44:18.862] Using master: e2e-test-prow-master (external IP: 34.170.232.180; internal IP: (not set))
I0930 18:45:04.068] ..........Kubernetes cluster created.
I0930 18:45:04.358] Cluster "gce-cvm-upg-1-4-1-5-ctl-skew_e2e-test-prow" set.
I0930 18:45:04.639] User "gce-cvm-upg-1-4-1-5-ctl-skew_e2e-test-prow" set.
I0930 18:45:04.909] Context "gce-cvm-upg-1-4-1-5-ctl-skew_e2e-test-prow" created.
... skipping 26 lines ...
I0930 18:46:02.091] e2e-test-prow-minion-group-gxdd   Ready                      <none>   29s   v1.26.0-alpha.1.207+ecdbb0258049b9
W0930 18:46:02.448] Warning: v1 ComponentStatus is deprecated in v1.19+
I0930 18:46:02.548] Validate output:
W0930 18:46:02.808] Warning: v1 ComponentStatus is deprecated in v1.19+
W0930 18:46:02.817] Done, listing cluster services:
W0930 18:46:02.817] 
I0930 18:46:02.918] NAME                 STATUS    MESSAGE                         ERROR
I0930 18:46:02.919] etcd-1               Healthy   {"health":"true","reason":""}   
I0930 18:46:02.919] etcd-0               Healthy   {"health":"true","reason":""}   
I0930 18:46:02.919] controller-manager   Healthy   ok                              
I0930 18:46:02.920] scheduler            Healthy   ok                              
I0930 18:46:02.920] Cluster validation succeeded
I0930 18:46:03.103] Kubernetes control plane is running at https://34.170.232.180
... skipping 90 lines ...
W0930 18:46:24.882] + ensure_var PKGDIR
W0930 18:46:24.883] + [[ -z /go/src/sigs.k8s.io/gcp-filestore-csi-driver ]]
W0930 18:46:24.883] + echo 'PKGDIR is /go/src/sigs.k8s.io/gcp-filestore-csi-driver'
W0930 18:46:24.884] + /go/src/sigs.k8s.io/gcp-filestore-csi-driver/deploy/kubernetes/install_kustomize.sh
I0930 18:46:25.790] {Version:kustomize/v4.0.4 GitCommit:9785bda7bedc6fc0fbd54f57fcf5b44a460cef76 BuildDate:2021-02-28T20:23:59Z GoOs:linux GoArch:amd64}
W0930 18:46:25.891] + kubectl get namespace gcp-filestore-csi-driver -v=2
W0930 18:46:26.278] Error from server (NotFound): namespaces "gcp-filestore-csi-driver" not found
W0930 18:46:26.283] + kubectl create namespace gcp-filestore-csi-driver -v=2
I0930 18:46:26.430] namespace/gcp-filestore-csi-driver created
W0930 18:46:26.531] + kubectl get clusterrolebinding cluster-admin-binding
W0930 18:46:26.575] Error from server (NotFound): clusterrolebindings.rbac.authorization.k8s.io "cluster-admin-binding" not found
W0930 18:46:26.579] ++ gcloud config get-value account
W0930 18:46:28.060] + kubectl create clusterrolebinding cluster-admin-binding --clusterrole cluster-admin --user pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0930 18:46:28.205] clusterrolebinding.rbac.authorization.k8s.io/cluster-admin-binding created
W0930 18:46:28.305] + '[' stable-master '!=' dev ']'
W0930 18:46:28.306] + kubectl get secret gcp-filestore-csi-driver-sa --namespace=gcp-filestore-csi-driver
W0930 18:46:28.359] Error from server (NotFound): secrets "gcp-filestore-csi-driver-sa" not found
W0930 18:46:28.364] + kubectl create secret generic gcp-filestore-csi-driver-sa --from-file=/tmp/gcp-fs-driver-tmp1207616562/gcp_filestore_csi_driver_sa.json --namespace=gcp-filestore-csi-driver
I0930 18:46:28.512] secret/gcp-filestore-csi-driver-sa created
W0930 18:46:28.613] + '[' stable-master == multishare ']'
W0930 18:46:28.613] + readonly tmp_spec=/tmp/gcp-filestore-csi-driver-specs-generated.yaml
W0930 18:46:28.614] + tmp_spec=/tmp/gcp-filestore-csi-driver-specs-generated.yaml
W0930 18:46:28.615] + /go/src/sigs.k8s.io/gcp-filestore-csi-driver/bin/kustomize build /go/src/sigs.k8s.io/gcp-filestore-csi-driver/deploy/kubernetes/overlays/stable-master
... skipping 1048 lines ...
W0930 18:46:40.186]                              node.kubernetes.io/unreachable:NoExecute op=Exists
W0930 18:46:40.186]                              node.kubernetes.io/unschedulable:NoSchedule op=Exists
W0930 18:46:40.186] Events:
W0930 18:46:40.187]   Type     Reason       Age   From               Message
W0930 18:46:40.187]   ----     ------       ----  ----               -------
W0930 18:46:40.187]   Normal   Scheduled    9s    default-scheduler  Successfully assigned gcp-filestore-csi-driver/gcp-filestore-csi-node-nvj86 to e2e-test-prow-minion-group-61th
W0930 18:46:40.187]   Warning  FailedMount  8s    kubelet            MountVolume.SetUp failed for volume "kube-api-access-zqqh2" : failed to sync configmap cache: timed out waiting for the condition
W0930 18:46:40.187]   Normal   Pulling      7s    kubelet            Pulling image "k8s.gcr.io/sig-storage/csi-node-driver-registrar:v2.2.0"
W0930 18:46:40.188]   Normal   Pulled       6s    kubelet            Successfully pulled image "k8s.gcr.io/sig-storage/csi-node-driver-registrar:v2.2.0" in 757.034671ms
W0930 18:46:40.188]   Normal   Created      6s    kubelet            Created container csi-driver-registrar
W0930 18:46:40.189]   Normal   Started      6s    kubelet            Started container csi-driver-registrar
W0930 18:46:40.189]   Normal   Pulling      6s    kubelet            Pulling image "gcr.io/gce-cvm-upg-1-4-1-5-ctl-skew/gcp-filestore-csi-driver:9389aaa0-efdd-4798-92a1-71e46af39ebf"
W0930 18:46:40.190]   Normal   Pulled       3s    kubelet            Successfully pulled image "gcr.io/gce-cvm-upg-1-4-1-5-ctl-skew/gcp-filestore-csi-driver:9389aaa0-efdd-4798-92a1-71e46af39ebf" in 3.403845056s
... skipping 36 lines ...
I0930 18:46:41.910] Running Tests
I0930 18:46:41.912] [kubetest2 gce --run-id=b2b599ab-40eb-11ed-8a9c-0a5a8f92a653 --test=ginkgo --legacy-mode --repo-root=/tmp/gcp-fs-driver-tmp1322601806/kubernetes --artifacts=/workspace/_artifacts/fs-sc-basic-hdd -- --use-built-binaries --focus-regex=External.Storage --skip-regex=\[Disruptive\]|\[Serial\] --parallel=3 --test-args=--storage.testdriver=/go/src/sigs.k8s.io/gcp-filestore-csi-driver/test/k8s-integration/config/test-config.yaml --ginkgo-args=--timeout=24h]
W0930 18:46:42.013] I0930 18:46:41.990136  106846 app.go:61] RunDir for this run: "/workspace/_artifacts/fs-sc-basic-hdd/b2b599ab-40eb-11ed-8a9c-0a5a8f92a653"
W0930 18:46:42.014] I0930 18:46:41.994158  106846 app.go:120] ID for this run: "b2b599ab-40eb-11ed-8a9c-0a5a8f92a653"
W0930 18:46:42.031] I0930 18:46:42.031400  106864 ginkgo.go:120] Using kubeconfig at /root/.kube/config
W0930 18:46:42.033] I0930 18:46:42.031990  106864 ginkgo.go:90] Running ginkgo test as /workspace/_artifacts/fs-sc-basic-hdd/b2b599ab-40eb-11ed-8a9c-0a5a8f92a653/ginkgo [--timeout=24h --nodes=3 /workspace/_artifacts/fs-sc-basic-hdd/b2b599ab-40eb-11ed-8a9c-0a5a8f92a653/e2e.test -- --kubeconfig=/root/.kube/config --kubectl-path=/workspace/_artifacts/fs-sc-basic-hdd/b2b599ab-40eb-11ed-8a9c-0a5a8f92a653/kubectl --ginkgo.flakeAttempts=1 --ginkgo.skip=\[Disruptive\]|\[Serial\] --ginkgo.focus=External.Storage --report-dir=/workspace/_artifacts/fs-sc-basic-hdd/b2b599ab-40eb-11ed-8a9c-0a5a8f92a653 --storage.testdriver=/go/src/sigs.k8s.io/gcp-filestore-csi-driver/test/k8s-integration/config/test-config.yaml]
I0930 18:46:42.574] {"msg":"Test Suite starting","completed":0,"skipped":0,"failed":0}
I0930 18:46:42.588] Running Suite: Kubernetes e2e suite - /workspace/_artifacts/fs-sc-basic-hdd/b2b599ab-40eb-11ed-8a9c-0a5a8f92a653
I0930 18:46:42.589] ================================================================================================================
I0930 18:46:42.589] Random Seed: 1664563602 - will randomize all specs
I0930 18:46:42.590] 
I0930 18:46:42.590] Will run 242 of 6863 specs
I0930 18:46:42.591] Running in parallel across 3 processes
I0930 18:47:38.708] ------------------------------
I0930 18:47:38.714] [SynchronizedBeforeSuite] PASSED [56.132 seconds]
I0930 18:47:38.715] [SynchronizedBeforeSuite] 
I0930 18:47:38.715] test/e2e/e2e.go:75
I0930 18:47:38.715] 
I0930 18:47:38.715]   Begin Captured StdOut/StdErr Output >>
I0930 18:47:38.715]     {"msg":"Test Suite starting","completed":0,"skipped":0,"failed":0}
I0930 18:47:38.715]   << End Captured StdOut/StdErr Output
I0930 18:47:38.716] ------------------------------
I0930 18:47:38.743] SSSSSSSSSS
I0930 18:47:38.743] ------------------------------
I0930 18:47:38.743] S [SKIPPED] [0.000 seconds]
I0930 18:47:38.744] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
... skipping 426 lines ...
I0930 18:47:39.268]   Driver "csi-gcpfs-fs-sc-basic-hdd" does not support cloning - skipping
I0930 18:47:39.268]   In [It] at: test/e2e/storage/testsuites/provisioning.go:469
I0930 18:47:39.268] ------------------------------
I0930 18:53:37.369] SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
I0930 18:53:37.369] ------------------------------
I0930 18:53:37.369] • [SLOW TEST] [358.383 seconds]
I0930 18:53:37.370] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] subPath should fail if subpath with backstepping is outside the volume [Slow][LinuxOnly]
I0930 18:53:37.370] test/e2e/storage/testsuites/subpath.go:279
I0930 18:53:37.370] 
I0930 18:53:37.370]   Begin Captured StdOut/StdErr Output >>
I0930 18:53:37.371]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] subPath should fail if subpath with backstepping is outside the volume [Slow][LinuxOnly]","completed":1,"skipped":252,"failed":0}
I0930 18:53:37.371]   << End Captured StdOut/StdErr Output
I0930 18:53:37.371] ------------------------------
I0930 18:53:37.383] SSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
I0930 18:53:37.383] ------------------------------
I0930 18:53:37.384] S [SKIPPED] [0.000 seconds]
I0930 18:53:37.384] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
... skipping 16 lines ...
I0930 18:53:40.257] ------------------------------
I0930 18:53:40.257] • [SLOW TEST] [361.356 seconds]
I0930 18:53:40.257] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)(allowExpansion)] volume-expand should resize volume when PVC is edited while pod is using it
I0930 18:53:40.257] test/e2e/storage/testsuites/volume_expand.go:252
I0930 18:53:40.257] 
I0930 18:53:40.257]   Begin Captured StdOut/StdErr Output >>
I0930 18:53:40.258]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)(allowExpansion)] volume-expand should resize volume when PVC is edited while pod is using it","completed":1,"skipped":148,"failed":0}
I0930 18:53:40.258]   << End Captured StdOut/StdErr Output
I0930 18:53:40.258] ------------------------------
I0930 18:53:40.330] SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
I0930 18:53:40.330] ------------------------------
I0930 18:53:40.330] S [SKIPPED] [0.049 seconds]
I0930 18:53:40.331] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
... skipping 70 lines ...
I0930 18:58:12.698] ------------------------------
I0930 18:58:12.698] • [SLOW TEST] [633.398 seconds]
I0930 18:58:12.700] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [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
I0930 18:58:12.700] test/e2e/storage/testsuites/multivolume.go:137
I0930 18:58:12.700] 
I0930 18:58:12.701]   Begin Captured StdOut/StdErr Output >>
I0930 18:58:12.701]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [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","completed":1,"skipped":545,"failed":0}
I0930 18:58:12.701]   << End Captured StdOut/StdErr Output
I0930 18:58:12.701] ------------------------------
I0930 18:58:12.812] SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
I0930 18:58:12.813] ------------------------------
I0930 18:58:12.814] S [SKIPPED] [0.000 seconds]
I0930 18:58:12.814] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
... skipping 163 lines ...
I0930 18:58:13.197] ------------------------------
I0930 18:58:13.197] S [SKIPPED] [0.001 seconds]
I0930 18:58:13.197] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
I0930 18:58:13.197] test/e2e/storage/external/external.go:174
I0930 18:58:13.198]   [Testpattern: Pre-provisioned PV (default fs)] subPath [BeforeEach]
I0930 18:58:13.198]   test/e2e/storage/framework/testsuite.go:51
I0930 18:58:13.198]     should fail if non-existent subpath is outside the volume [Slow][LinuxOnly]
I0930 18:58:13.198]     test/e2e/storage/testsuites/subpath.go:268
I0930 18:58:13.198] 
I0930 18:58:13.198]   Begin Captured GinkgoWriter Output >>
I0930 18:58:13.198]     [BeforeEach] [Testpattern: Pre-provisioned PV (default fs)] subPath
I0930 18:58:13.198]       test/e2e/storage/framework/testsuite.go:51
I0930 18:58:13.198]     Sep 30 18:58:13.194: INFO: Driver "csi-gcpfs-fs-sc-basic-hdd" does not support volume type "PreprovisionedPV" - skipping
... skipping 99 lines ...
I0930 18:59:22.789] ------------------------------
I0930 18:59:22.789] • [SLOW TEST] [342.402 seconds]
I0930 18:59:22.789] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (filesystem volmode)] multiVolume [Slow] should concurrently access the single volume from pods on different node
I0930 18:59:22.789] test/e2e/storage/testsuites/multivolume.go:454
I0930 18:59:22.789] 
I0930 18:59:22.789]   Begin Captured StdOut/StdErr Output >>
I0930 18:59:22.790]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (filesystem volmode)] multiVolume [Slow] should concurrently access the single volume from pods on different node","completed":2,"skipped":211,"failed":0}
I0930 18:59:22.790]   << End Captured StdOut/StdErr Output
I0930 18:59:22.790] ------------------------------
I0930 19:03:32.706] SSSSSSS
I0930 19:03:32.709] ------------------------------
I0930 19:03:32.710] • [SLOW TEST] [595.304 seconds]
I0930 19:03:32.710] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [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 (persistent)
I0930 19:03:32.710] test/e2e/storage/testsuites/snapshottable.go:277
I0930 19:03:32.710] 
I0930 19:03:32.710]   Begin Captured StdOut/StdErr Output >>
I0930 19:03:32.711]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [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 (persistent)","completed":2,"skipped":295,"failed":0}
I0930 19:03:32.711]   << End Captured StdOut/StdErr Output
I0930 19:03:32.711] ------------------------------
I0930 19:04:02.754] SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
I0930 19:04:02.755] ------------------------------
I0930 19:04:02.755] • [SLOW TEST] [349.418 seconds]
I0930 19:04:02.755] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] subPath should support file as subpath [LinuxOnly]
I0930 19:04:02.755] test/e2e/storage/testsuites/subpath.go:231
I0930 19:04:02.755] 
I0930 19:04:02.755]   Begin Captured StdOut/StdErr Output >>
I0930 19:04:02.755]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] subPath should support file as subpath [LinuxOnly]","completed":2,"skipped":1104,"failed":0}
I0930 19:04:02.756]   << End Captured StdOut/StdErr Output
I0930 19:04:02.756] ------------------------------
I0930 19:04:02.768] SSSSSSSSSSSSSSSSSSSSSS
I0930 19:04:02.768] ------------------------------
I0930 19:04:02.768] S [SKIPPED] [0.000 seconds]
I0930 19:04:02.768] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
... skipping 73 lines ...
I0930 19:04:02.858] ------------------------------
I0930 19:04:02.858] S [SKIPPED] [0.001 seconds]
I0930 19:04:02.858] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
I0930 19:04:02.858] test/e2e/storage/external/external.go:174
I0930 19:04:02.859]   [Testpattern: Pre-provisioned PV (block volmode)] volumeMode [BeforeEach]
I0930 19:04:02.859]   test/e2e/storage/framework/testsuite.go:51
I0930 19:04:02.859]     should fail to use a volume in a pod with mismatched mode [Slow]
I0930 19:04:02.859]     test/e2e/storage/testsuites/volumemode.go:299
I0930 19:04:02.859] 
I0930 19:04:02.860]   Begin Captured GinkgoWriter Output >>
I0930 19:04:02.860]     [BeforeEach] [Testpattern: Pre-provisioned PV (block volmode)] volumeMode
I0930 19:04:02.860]       test/e2e/storage/framework/testsuite.go:51
I0930 19:04:02.860]     Sep 30 19:04:02.857: INFO: Driver "csi-gcpfs-fs-sc-basic-hdd" does not support volume type "PreprovisionedPV" - skipping
... skipping 6 lines ...
I0930 19:04:02.871] ------------------------------
I0930 19:04:02.871] S [SKIPPED] [0.000 seconds]
I0930 19:04:02.871] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
I0930 19:04:02.871] test/e2e/storage/external/external.go:174
I0930 19:04:02.871]   [Testpattern: Pre-provisioned PV (default fs)] subPath [BeforeEach]
I0930 19:04:02.871]   test/e2e/storage/framework/testsuite.go:51
I0930 19:04:02.872]     should fail if subpath with backstepping is outside the volume [Slow][LinuxOnly]
I0930 19:04:02.872]     test/e2e/storage/testsuites/subpath.go:279
I0930 19:04:02.872] 
I0930 19:04:02.872]   Begin Captured GinkgoWriter Output >>
I0930 19:04:02.872]     [BeforeEach] [Testpattern: Pre-provisioned PV (default fs)] subPath
I0930 19:04:02.872]       test/e2e/storage/framework/testsuite.go:51
I0930 19:04:02.873]     Sep 30 19:04:02.869: INFO: Driver "csi-gcpfs-fs-sc-basic-hdd" does not support volume type "PreprovisionedPV" - skipping
... skipping 25 lines ...
I0930 19:05:46.300] ------------------------------
I0930 19:05:46.301] • [SLOW TEST] [383.504 seconds]
I0930 19:05:46.302] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Generic Ephemeral-volume (default fs) (late-binding)] ephemeral should support expansion of pvcs created for ephemeral pvcs
I0930 19:05:46.302] test/e2e/storage/testsuites/ephemeral.go:216
I0930 19:05:46.302] 
I0930 19:05:46.302]   Begin Captured StdOut/StdErr Output >>
I0930 19:05:46.302]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Generic Ephemeral-volume (default fs) (late-binding)] ephemeral should support expansion of pvcs created for ephemeral pvcs","completed":3,"skipped":218,"failed":0}
I0930 19:05:46.303]   << End Captured StdOut/StdErr Output
I0930 19:05:46.303] ------------------------------
I0930 19:05:46.366] SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
I0930 19:05:46.367] ------------------------------
I0930 19:05:46.367] S [SKIPPED] [0.000 seconds]
I0930 19:05:46.367] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
... skipping 35 lines ...
I0930 19:05:46.412] ------------------------------
I0930 19:05:46.412] S [SKIPPED] [0.000 seconds]
I0930 19:05:46.412] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
I0930 19:05:46.412] test/e2e/storage/external/external.go:174
I0930 19:05:46.413]   [Testpattern: Dynamic PV (ntfs)][Feature:Windows] subPath [BeforeEach]
I0930 19:05:46.413]   test/e2e/storage/framework/testsuite.go:51
I0930 19:05:46.413]     should fail if subpath with backstepping is outside the volume [Slow][LinuxOnly]
I0930 19:05:46.413]     test/e2e/storage/testsuites/subpath.go:279
I0930 19:05:46.413] 
I0930 19:05:46.413]   Begin Captured GinkgoWriter Output >>
I0930 19:05:46.413]     [BeforeEach] [Testpattern: Dynamic PV (ntfs)][Feature:Windows] subPath
I0930 19:05:46.413]       test/e2e/storage/framework/testsuite.go:51
I0930 19:05:46.413]     Sep 30 19:05:46.411: INFO: Driver csi-gcpfs-fs-sc-basic-hdd doesn't support ntfs -- skipping
... skipping 6 lines ...
I0930 19:09:27.958] ------------------------------
I0930 19:09:27.958] • [SLOW TEST] [325.077 seconds]
I0930 19:09:27.958] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (filesystem volmode)] multiVolume [Slow] should concurrently access the single read-only volume from pods on the same node
I0930 19:09:27.959] test/e2e/storage/testsuites/multivolume.go:422
I0930 19:09:27.959] 
I0930 19:09:27.959]   Begin Captured StdOut/StdErr Output >>
I0930 19:09:27.959]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (filesystem volmode)] multiVolume [Slow] should concurrently access the single read-only volume from pods on the same node","completed":3,"skipped":1327,"failed":0}
I0930 19:09:27.959]   << End Captured StdOut/StdErr Output
I0930 19:09:27.960] ------------------------------
I0930 19:09:27.994] S
I0930 19:09:27.994] ------------------------------
I0930 19:09:27.994] S [SKIPPED] [0.034 seconds]
I0930 19:09:27.994] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
... skipping 31 lines ...
I0930 19:09:40.199] ------------------------------
I0930 19:09:40.199] • [SLOW TEST] [367.477 seconds]
I0930 19:09:40.200] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Generic Ephemeral-volume (default fs) (immediate-binding)] ephemeral should create read-only inline ephemeral volume
I0930 19:09:40.200] test/e2e/storage/testsuites/ephemeral.go:175
I0930 19:09:40.200] 
I0930 19:09:40.200]   Begin Captured StdOut/StdErr Output >>
I0930 19:09:40.201]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Generic Ephemeral-volume (default fs) (immediate-binding)] ephemeral should create read-only inline ephemeral volume","completed":3,"skipped":344,"failed":0}
I0930 19:09:40.201]   << End Captured StdOut/StdErr Output
I0930 19:09:40.201] ------------------------------
I0930 19:12:35.036] SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
I0930 19:12:35.036] ------------------------------
I0930 19:12:35.037] • [SLOW TEST] [408.622 seconds]
I0930 19:12:35.037] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] subPath should support restarting containers using directory as subpath [Slow]
I0930 19:12:35.037] test/e2e/storage/testsuites/subpath.go:321
I0930 19:12:35.037] 
I0930 19:12:35.037]   Begin Captured StdOut/StdErr Output >>
I0930 19:12:35.037]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] subPath should support restarting containers using directory as subpath [Slow]","completed":4,"skipped":449,"failed":0}
I0930 19:12:35.037]   << End Captured StdOut/StdErr Output
I0930 19:12:35.037] ------------------------------
I0930 19:12:35.045] SSSSSSSSSSSSSSSS
I0930 19:12:35.046] ------------------------------
I0930 19:12:35.046] S [SKIPPED] [0.000 seconds]
I0930 19:12:35.046] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
I0930 19:12:35.046] test/e2e/storage/external/external.go:174
I0930 19:12:35.046]   [Testpattern: Pre-provisioned PV (block volmode)] volumeMode [BeforeEach]
I0930 19:12:35.047]   test/e2e/storage/framework/testsuite.go:51
I0930 19:12:35.047]     should fail to create pod by failing to mount volume [Slow]
I0930 19:12:35.047]     test/e2e/storage/testsuites/volumemode.go:199
I0930 19:12:35.047] 
I0930 19:12:35.047]   Begin Captured GinkgoWriter Output >>
I0930 19:12:35.047]     [BeforeEach] [Testpattern: Pre-provisioned PV (block volmode)] volumeMode
I0930 19:12:35.047]       test/e2e/storage/framework/testsuite.go:51
I0930 19:12:35.048]     Sep 30 19:12:35.045: INFO: Driver "csi-gcpfs-fs-sc-basic-hdd" does not support volume type "PreprovisionedPV" - skipping
... skipping 6 lines ...
I0930 19:14:46.881] ------------------------------
I0930 19:14:46.881] • [SLOW TEST] [318.870 seconds]
I0930 19:14:46.881] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (filesystem volmode)] volumeMode should not mount / map unused volumes in a pod [LinuxOnly]
I0930 19:14:46.881] test/e2e/storage/testsuites/volumemode.go:354
I0930 19:14:46.881] 
I0930 19:14:46.882]   Begin Captured StdOut/StdErr Output >>
I0930 19:14:46.882]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (filesystem volmode)] volumeMode should not mount / map unused volumes in a pod [LinuxOnly]","completed":4,"skipped":1362,"failed":0}
I0930 19:14:46.882]   << End Captured StdOut/StdErr Output
I0930 19:14:46.882] ------------------------------
I0930 19:14:46.893] SSSSSSSSSSSSSSSSSSSSSSSSS
I0930 19:14:46.893] ------------------------------
I0930 19:14:46.893] S [SKIPPED] [0.000 seconds]
I0930 19:14:46.893] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
... skipping 54 lines ...
I0930 19:17:56.386] ------------------------------
I0930 19:17:56.387] • [SLOW TEST] [321.325 seconds]
I0930 19:17:56.387] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] subPath should support readOnly directory specified in the volumeMount
I0930 19:17:56.387] test/e2e/storage/testsuites/subpath.go:366
I0930 19:17:56.387] 
I0930 19:17:56.387]   Begin Captured StdOut/StdErr Output >>
I0930 19:17:56.388]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] subPath should support readOnly directory specified in the volumeMount","completed":5,"skipped":492,"failed":0}
I0930 19:17:56.388]   << End Captured StdOut/StdErr Output
I0930 19:17:56.388] ------------------------------
I0930 19:17:56.410] SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
I0930 19:17:56.411] ------------------------------
I0930 19:17:56.411] S [SKIPPED] [0.000 seconds]
I0930 19:17:56.411] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
... skipping 16 lines ...
I0930 19:17:56.455] ------------------------------
I0930 19:17:56.455] S [SKIPPED] [0.041 seconds]
I0930 19:17:56.455] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
I0930 19:17:56.456] test/e2e/storage/external/external.go:174
I0930 19:17:56.456]   [Testpattern: Dynamic PV (block volmode)] volumeMode
I0930 19:17:56.456]   test/e2e/storage/framework/testsuite.go:50
I0930 19:17:56.456]     [It] should fail to use a volume in a pod with mismatched mode [Slow]
I0930 19:17:56.456]     test/e2e/storage/testsuites/volumemode.go:299
I0930 19:17:56.456] 
I0930 19:17:56.456]   Begin Captured GinkgoWriter Output >>
I0930 19:17:56.456]     [BeforeEach] [Testpattern: Dynamic PV (block volmode)] volumeMode
I0930 19:17:56.456]       test/e2e/storage/framework/testsuite.go:51
I0930 19:17:56.456]     [BeforeEach] [Testpattern: Dynamic PV (block volmode)] volumeMode
I0930 19:17:56.457]       set up framework | framework.go:158
I0930 19:17:56.457]     STEP: Creating a kubernetes client 09/30/22 19:17:56.413
I0930 19:17:56.457]     Sep 30 19:17:56.413: INFO: >>> kubeConfig: /root/.kube/config
I0930 19:17:56.457]     STEP: Building a namespace api object, basename volumemode 09/30/22 19:17:56.414
I0930 19:17:56.457]     STEP: Waiting for a default service account to be provisioned in namespace 09/30/22 19:17:56.432
I0930 19:17:56.457]     STEP: Waiting for kube-root-ca.crt to be provisioned in namespace 09/30/22 19:17:56.439
I0930 19:17:56.457]     [It] should fail to use a volume in a pod with mismatched mode [Slow]
I0930 19:17:56.457]       test/e2e/storage/testsuites/volumemode.go:299
I0930 19:17:56.458]     Sep 30 19:17:56.442: INFO: Driver "csi-gcpfs-fs-sc-basic-hdd" does not provide raw block - skipping
I0930 19:17:56.458]     [DeferCleanup] [Testpattern: Dynamic PV (block volmode)] volumeMode
I0930 19:17:56.458]       dump namespaces | framework.go:173
I0930 19:17:56.458]     [DeferCleanup] [Testpattern: Dynamic PV (block volmode)] volumeMode
I0930 19:17:56.458]       tear down framework | framework.go:170
... skipping 8 lines ...
I0930 19:17:56.461] ------------------------------
I0930 19:17:56.461] S [SKIPPED] [0.000 seconds]
I0930 19:17:56.461] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
I0930 19:17:56.461] test/e2e/storage/external/external.go:174
I0930 19:17:56.461]   [Testpattern: Pre-provisioned PV (filesystem volmode)] volumeMode [BeforeEach]
I0930 19:17:56.461]   test/e2e/storage/framework/testsuite.go:51
I0930 19:17:56.461]     should fail to use a volume in a pod with mismatched mode [Slow]
I0930 19:17:56.461]     test/e2e/storage/testsuites/volumemode.go:299
I0930 19:17:56.462] 
I0930 19:17:56.462]   Begin Captured GinkgoWriter Output >>
I0930 19:17:56.462]     [BeforeEach] [Testpattern: Pre-provisioned PV (filesystem volmode)] volumeMode
I0930 19:17:56.462]       test/e2e/storage/framework/testsuite.go:51
I0930 19:17:56.462]     Sep 30 19:17:56.460: INFO: Driver "csi-gcpfs-fs-sc-basic-hdd" does not support volume type "PreprovisionedPV" - skipping
... skipping 6 lines ...
I0930 19:17:56.468] ------------------------------
I0930 19:17:56.468] S [SKIPPED] [0.000 seconds]
I0930 19:17:56.468] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
I0930 19:17:56.468] test/e2e/storage/external/external.go:174
I0930 19:17:56.468]   [Testpattern: Inline-volume (default fs)] subPath [BeforeEach]
I0930 19:17:56.468]   test/e2e/storage/framework/testsuite.go:51
I0930 19:17:56.468]     should fail if subpath file is outside the volume [Slow][LinuxOnly]
I0930 19:17:56.468]     test/e2e/storage/testsuites/subpath.go:257
I0930 19:17:56.468] 
I0930 19:17:56.469]   Begin Captured GinkgoWriter Output >>
I0930 19:17:56.469]     [BeforeEach] [Testpattern: Inline-volume (default fs)] subPath
I0930 19:17:56.469]       test/e2e/storage/framework/testsuite.go:51
I0930 19:17:56.469]     Sep 30 19:17:56.467: INFO: Driver "csi-gcpfs-fs-sc-basic-hdd" does not support volume type "InlineVolume" - skipping
... skipping 133 lines ...
I0930 19:19:23.161] ------------------------------
I0930 19:19:23.162] • [SLOW TEST] [582.940 seconds]
I0930 19:19:23.162] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [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 (persistent)
I0930 19:19:23.162] test/e2e/storage/testsuites/snapshottable.go:277
I0930 19:19:23.163] 
I0930 19:19:23.163]   Begin Captured StdOut/StdErr Output >>
I0930 19:19:23.163]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [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 (persistent)","completed":4,"skipped":383,"failed":0}
I0930 19:19:23.164]   << End Captured StdOut/StdErr Output
I0930 19:19:23.164] ------------------------------
I0930 19:19:23.195] SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
I0930 19:19:23.195] ------------------------------
I0930 19:19:23.196] S [SKIPPED] [0.000 seconds]
I0930 19:19:23.196] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
... skipping 73 lines ...
I0930 19:19:23.226] ------------------------------
I0930 19:19:23.226] S [SKIPPED] [0.000 seconds]
I0930 19:19:23.226] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
I0930 19:19:23.227] test/e2e/storage/external/external.go:174
I0930 19:19:23.227]   [Testpattern: Inline-volume (default fs)] subPath [BeforeEach]
I0930 19:19:23.227]   test/e2e/storage/framework/testsuite.go:51
I0930 19:19:23.227]     should fail if subpath directory is outside the volume [Slow][LinuxOnly]
I0930 19:19:23.227]     test/e2e/storage/testsuites/subpath.go:241
I0930 19:19:23.228] 
I0930 19:19:23.228]   Begin Captured GinkgoWriter Output >>
I0930 19:19:23.228]     [BeforeEach] [Testpattern: Inline-volume (default fs)] subPath
I0930 19:19:23.228]       test/e2e/storage/framework/testsuite.go:51
I0930 19:19:23.228]     Sep 30 19:19:23.225: INFO: Driver "csi-gcpfs-fs-sc-basic-hdd" does not support volume type "InlineVolume" - skipping
... skipping 76 lines ...
I0930 19:19:23.260]   Driver csi-gcpfs-fs-sc-basic-hdd doesn't support ext3 -- skipping
I0930 19:19:23.260]   In [BeforeEach] at: test/e2e/storage/framework/testsuite.go:121
I0930 19:19:23.260] ------------------------------
I0930 19:20:22.225] SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
I0930 19:20:22.225] ------------------------------
I0930 19:20:22.225] • [SLOW TEST] [335.312 seconds]
I0930 19:20:22.225] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] subPath should fail if subpath directory is outside the volume [Slow][LinuxOnly]
I0930 19:20:22.225] test/e2e/storage/testsuites/subpath.go:241
I0930 19:20:22.225] 
I0930 19:20:22.226]   Begin Captured StdOut/StdErr Output >>
I0930 19:20:22.226]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] subPath should fail if subpath directory is outside the volume [Slow][LinuxOnly]","completed":5,"skipped":1425,"failed":0}
I0930 19:20:22.226]   << End Captured StdOut/StdErr Output
I0930 19:20:22.226] ------------------------------
I0930 19:20:22.251] SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
I0930 19:20:22.251] ------------------------------
I0930 19:20:22.251] S [SKIPPED] [0.001 seconds]
I0930 19:20:22.252] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
... skipping 16 lines ...
I0930 19:20:22.258] ------------------------------
I0930 19:20:22.259] S [SKIPPED] [0.000 seconds]
I0930 19:20:22.259] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
I0930 19:20:22.259] test/e2e/storage/external/external.go:174
I0930 19:20:22.259]   [Testpattern: Dynamic PV (ntfs)][Feature:Windows] subPath [BeforeEach]
I0930 19:20:22.259]   test/e2e/storage/framework/testsuite.go:51
I0930 19:20:22.259]     should fail if subpath file is outside the volume [Slow][LinuxOnly]
I0930 19:20:22.259]     test/e2e/storage/testsuites/subpath.go:257
I0930 19:20:22.259] 
I0930 19:20:22.259]   Begin Captured GinkgoWriter Output >>
I0930 19:20:22.260]     [BeforeEach] [Testpattern: Dynamic PV (ntfs)][Feature:Windows] subPath
I0930 19:20:22.260]       test/e2e/storage/framework/testsuite.go:51
I0930 19:20:22.260]     Sep 30 19:20:22.257: INFO: Driver csi-gcpfs-fs-sc-basic-hdd doesn't support ntfs -- skipping
... skipping 25 lines ...
I0930 19:23:16.897] ------------------------------
I0930 19:23:16.897] • [SLOW TEST] [320.299 seconds]
I0930 19:23:16.898] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] fsgroupchangepolicy (Always)[LinuxOnly], pod created with an initial fsgroup, volume contents ownership changed via chgrp in first pod, new pod with same fsgroup applied to the volume contents
I0930 19:23:16.898] test/e2e/storage/testsuites/fsgroupchangepolicy.go:216
I0930 19:23:16.898] 
I0930 19:23:16.898]   Begin Captured StdOut/StdErr Output >>
I0930 19:23:16.899]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] fsgroupchangepolicy (Always)[LinuxOnly], pod created with an initial fsgroup, volume contents ownership changed via chgrp in first pod, new pod with same fsgroup applied to the volume contents","completed":6,"skipped":615,"failed":0}
I0930 19:23:16.899]   << End Captured StdOut/StdErr Output
I0930 19:23:16.899] ------------------------------
I0930 19:24:34.876] SSSSSSSSSSSSSSSSSSSSSSSSSSS
I0930 19:24:34.876] ------------------------------
I0930 19:24:34.876] • [SLOW TEST] [311.590 seconds]
I0930 19:24:34.876] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] subPath should be able to unmount after the subpath directory is deleted [LinuxOnly]
I0930 19:24:34.877] test/e2e/storage/testsuites/subpath.go:446
I0930 19:24:34.877] 
I0930 19:24:34.877]   Begin Captured StdOut/StdErr Output >>
I0930 19:24:34.877]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] subPath should be able to unmount after the subpath directory is deleted [LinuxOnly]","completed":5,"skipped":632,"failed":0}
I0930 19:24:34.877]   << End Captured StdOut/StdErr Output
I0930 19:24:34.877] ------------------------------
I0930 19:24:34.878] SS
I0930 19:24:34.878] ------------------------------
I0930 19:24:34.878] S [SKIPPED] [0.000 seconds]
I0930 19:24:34.878] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
... skipping 35 lines ...
I0930 19:25:31.599] ------------------------------
I0930 19:25:31.599] • [SLOW TEST] [309.324 seconds]
I0930 19:25:31.600] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] volumes should allow exec of files on the volume
I0930 19:25:31.600] test/e2e/storage/testsuites/volumes.go:198
I0930 19:25:31.600] 
I0930 19:25:31.600]   Begin Captured StdOut/StdErr Output >>
I0930 19:25:31.600]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] volumes should allow exec of files on the volume","completed":6,"skipped":1512,"failed":0}
I0930 19:25:31.600]   << End Captured StdOut/StdErr Output
I0930 19:25:31.600] ------------------------------
I0930 19:30:12.189] SSSSSSSSSSSSSSSSSSSSSS
I0930 19:30:12.189] ------------------------------
I0930 19:30:12.189] • [SLOW TEST] [415.277 seconds]
I0930 19:30:12.190] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] fsgroupchangepolicy (OnRootMismatch)[LinuxOnly], pod created with an initial fsgroup, volume contents ownership changed via chgrp in first pod, new pod with different fsgroup applied to the volume contents
I0930 19:30:12.190] test/e2e/storage/testsuites/fsgroupchangepolicy.go:216
I0930 19:30:12.190] 
I0930 19:30:12.190]   Begin Captured StdOut/StdErr Output >>
I0930 19:30:12.190]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] fsgroupchangepolicy (OnRootMismatch)[LinuxOnly], pod created with an initial fsgroup, volume contents ownership changed via chgrp in first pod, new pod with different fsgroup applied to the volume contents","completed":7,"skipped":642,"failed":0}
I0930 19:30:12.190]   << End Captured StdOut/StdErr Output
I0930 19:30:12.190] ------------------------------
I0930 19:30:12.206] SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
I0930 19:30:12.207] ------------------------------
I0930 19:30:12.207] S [SKIPPED] [0.000 seconds]
I0930 19:30:12.207] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
... skipping 35 lines ...
I0930 19:31:59.272] ------------------------------
I0930 19:31:59.272] • [SLOW TEST] [444.379 seconds]
I0930 19:31:59.272] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Ephemeral Snapshot (delete policy)] snapshottable[Feature:VolumeSnapshotDataSource] volume snapshot controller  should check snapshot fields, check restore correctly works, check deletion (ephemeral)
I0930 19:31:59.273] test/e2e/storage/testsuites/snapshottable.go:176
I0930 19:31:59.273] 
I0930 19:31:59.273]   Begin Captured StdOut/StdErr Output >>
I0930 19:31:59.273]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Ephemeral Snapshot (delete policy)] snapshottable[Feature:VolumeSnapshotDataSource] volume snapshot controller  should check snapshot fields, check restore correctly works, check deletion (ephemeral)","completed":6,"skipped":659,"failed":0}
I0930 19:31:59.273]   << End Captured StdOut/StdErr Output
I0930 19:31:59.273] ------------------------------
I0930 19:36:16.623] SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
I0930 19:36:16.624] ------------------------------
I0930 19:36:16.624] • [SLOW TEST] [364.379 seconds]
I0930 19:36:16.624] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] volumeIO should write files of various sizes, verify size, validate content [Slow]
I0930 19:36:16.624] test/e2e/storage/testsuites/volume_io.go:149
I0930 19:36:16.625] 
I0930 19:36:16.625]   Begin Captured StdOut/StdErr Output >>
I0930 19:36:16.625]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] volumeIO should write files of various sizes, verify size, validate content [Slow]","completed":8,"skipped":754,"failed":0}
I0930 19:36:16.625]   << End Captured StdOut/StdErr Output
I0930 19:36:16.625] ------------------------------
I0930 19:36:16.626] SSS
I0930 19:36:16.627] ------------------------------
I0930 19:36:16.627] S [SKIPPED] [0.000 seconds]
I0930 19:36:16.627] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
... skipping 107 lines ...
I0930 19:37:19.382] ------------------------------
I0930 19:37:19.382] • [SLOW TEST] [707.770 seconds]
I0930 19:37:19.382] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Generic Ephemeral-volume (default fs) (immediate-binding)] ephemeral should support two pods which have the same volume definition
I0930 19:37:19.382] test/e2e/storage/testsuites/ephemeral.go:277
I0930 19:37:19.383] 
I0930 19:37:19.383]   Begin Captured StdOut/StdErr Output >>
I0930 19:37:19.383]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Generic Ephemeral-volume (default fs) (immediate-binding)] ephemeral should support two pods which have the same volume definition","completed":7,"skipped":1534,"failed":0}
I0930 19:37:19.384]   << End Captured StdOut/StdErr Output
I0930 19:37:19.384] ------------------------------
I0930 19:37:29.696] SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
I0930 19:37:29.696] ------------------------------
I0930 19:37:29.696] • [SLOW TEST] [330.409 seconds]
I0930 19:37:29.696] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] subPath should support creating multiple subpath from same volumes [Slow]
I0930 19:37:29.697] test/e2e/storage/testsuites/subpath.go:295
I0930 19:37:29.697] 
I0930 19:37:29.697]   Begin Captured StdOut/StdErr Output >>
I0930 19:37:29.697]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] subPath should support creating multiple subpath from same volumes [Slow]","completed":7,"skipped":693,"failed":0}
I0930 19:37:29.697]   << End Captured StdOut/StdErr Output
I0930 19:37:29.697] ------------------------------
I0930 19:37:49.558] SSSSSSSSSSSSSS
I0930 19:37:49.559] ------------------------------
I0930 19:37:49.559] • [SLOW TEST] [30.152 seconds]
I0930 19:37:49.559] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] volume-expand should not allow expansion of pvcs without AllowVolumeExpansion property
I0930 19:37:49.559] test/e2e/storage/testsuites/volume_expand.go:159
I0930 19:37:49.559] 
I0930 19:37:49.559]   Begin Captured StdOut/StdErr Output >>
I0930 19:37:49.559]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] volume-expand should not allow expansion of pvcs without AllowVolumeExpansion property","completed":8,"skipped":1579,"failed":0}
I0930 19:37:49.560]   << End Captured StdOut/StdErr Output
I0930 19:37:49.560] ------------------------------
I0930 19:37:49.561] SS
I0930 19:37:49.561] ------------------------------
I0930 19:37:49.562] S [SKIPPED] [0.001 seconds]
I0930 19:37:49.562] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
... skipping 16 lines ...
I0930 19:43:15.967] ------------------------------
I0930 19:43:15.967] • [SLOW TEST] [346.262 seconds]
I0930 19:43:15.967] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] fsgroupchangepolicy (Always)[LinuxOnly], pod created with an initial fsgroup, volume contents ownership changed via chgrp in first pod, new pod with different fsgroup applied to the volume contents
I0930 19:43:15.967] test/e2e/storage/testsuites/fsgroupchangepolicy.go:216
I0930 19:43:15.968] 
I0930 19:43:15.968]   Begin Captured StdOut/StdErr Output >>
I0930 19:43:15.968]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] fsgroupchangepolicy (Always)[LinuxOnly], pod created with an initial fsgroup, volume contents ownership changed via chgrp in first pod, new pod with different fsgroup applied to the volume contents","completed":8,"skipped":707,"failed":0}
I0930 19:43:15.968]   << End Captured StdOut/StdErr Output
I0930 19:43:15.969] ------------------------------
I0930 19:43:15.986] SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
I0930 19:43:15.987] ------------------------------
I0930 19:43:15.987] S [SKIPPED] [0.000 seconds]
I0930 19:43:15.987] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
... skipping 92 lines ...
I0930 19:43:39.009] ------------------------------
I0930 19:43:39.009] • [SLOW TEST] [349.429 seconds]
I0930 19:43:39.010] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Generic Ephemeral-volume (default fs) (late-binding)] ephemeral should create read/write inline ephemeral volume
I0930 19:43:39.010] test/e2e/storage/testsuites/ephemeral.go:196
I0930 19:43:39.010] 
I0930 19:43:39.010]   Begin Captured StdOut/StdErr Output >>
I0930 19:43:39.010]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Generic Ephemeral-volume (default fs) (late-binding)] ephemeral should create read/write inline ephemeral volume","completed":9,"skipped":1614,"failed":0}
I0930 19:43:39.011]   << End Captured StdOut/StdErr Output
I0930 19:43:39.011] ------------------------------
I0930 19:43:39.028] SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
I0930 19:43:39.028] ------------------------------
I0930 19:43:39.028] S [SKIPPED] [0.000 seconds]
I0930 19:43:39.028] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
... skipping 16 lines ...
I0930 19:43:39.103] ------------------------------
I0930 19:43:39.103] S [SKIPPED] [0.031 seconds]
I0930 19:43:39.103] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
I0930 19:43:39.104] test/e2e/storage/external/external.go:174
I0930 19:43:39.104]   [Testpattern: Dynamic PV (filesystem volmode)] volumeMode
I0930 19:43:39.104]   test/e2e/storage/framework/testsuite.go:50
I0930 19:43:39.104]     [It] should fail to use a volume in a pod with mismatched mode [Slow]
I0930 19:43:39.104]     test/e2e/storage/testsuites/volumemode.go:299
I0930 19:43:39.104] 
I0930 19:43:39.104]   Begin Captured GinkgoWriter Output >>
I0930 19:43:39.104]     [BeforeEach] [Testpattern: Dynamic PV (filesystem volmode)] volumeMode
I0930 19:43:39.104]       test/e2e/storage/framework/testsuite.go:51
I0930 19:43:39.105]     [BeforeEach] [Testpattern: Dynamic PV (filesystem volmode)] volumeMode
I0930 19:43:39.105]       set up framework | framework.go:158
I0930 19:43:39.105]     STEP: Creating a kubernetes client 09/30/22 19:43:39.071
I0930 19:43:39.105]     Sep 30 19:43:39.071: INFO: >>> kubeConfig: /root/.kube/config
I0930 19:43:39.105]     STEP: Building a namespace api object, basename volumemode 09/30/22 19:43:39.073
I0930 19:43:39.105]     STEP: Waiting for a default service account to be provisioned in namespace 09/30/22 19:43:39.086
I0930 19:43:39.105]     STEP: Waiting for kube-root-ca.crt to be provisioned in namespace 09/30/22 19:43:39.091
I0930 19:43:39.105]     [It] should fail to use a volume in a pod with mismatched mode [Slow]
I0930 19:43:39.105]       test/e2e/storage/testsuites/volumemode.go:299
I0930 19:43:39.106]     Sep 30 19:43:39.094: INFO: Driver "csi-gcpfs-fs-sc-basic-hdd" does not provide raw block - skipping
I0930 19:43:39.106]     [DeferCleanup] [Testpattern: Dynamic PV (filesystem volmode)] volumeMode
I0930 19:43:39.106]       dump namespaces | framework.go:173
I0930 19:43:39.106]     [DeferCleanup] [Testpattern: Dynamic PV (filesystem volmode)] volumeMode
I0930 19:43:39.106]       tear down framework | framework.go:170
... skipping 162 lines ...
I0930 19:47:50.501] ------------------------------
I0930 19:47:50.501] • [SLOW TEST] [693.765 seconds]
I0930 19:47:50.501] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Generic Ephemeral-volume (default fs) (late-binding)] ephemeral should support two pods which have the same volume definition
I0930 19:47:50.501] test/e2e/storage/testsuites/ephemeral.go:277
I0930 19:47:50.501] 
I0930 19:47:50.501]   Begin Captured StdOut/StdErr Output >>
I0930 19:47:50.502]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Generic Ephemeral-volume (default fs) (late-binding)] ephemeral should support two pods which have the same volume definition","completed":9,"skipped":830,"failed":0}
I0930 19:47:50.502]   << End Captured StdOut/StdErr Output
I0930 19:47:50.502] ------------------------------
I0930 19:49:01.298] SSSSSSSSSSSSSSSSSSSSSSSSSSSS
I0930 19:49:01.298] ------------------------------
I0930 19:49:01.299] • [SLOW TEST] [345.270 seconds]
I0930 19:49:01.299] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] subPath should fail if non-existent subpath is outside the volume [Slow][LinuxOnly]
I0930 19:49:01.299] test/e2e/storage/testsuites/subpath.go:268
I0930 19:49:01.299] 
I0930 19:49:01.300]   Begin Captured StdOut/StdErr Output >>
I0930 19:49:01.300]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] subPath should fail if non-existent subpath is outside the volume [Slow][LinuxOnly]","completed":9,"skipped":835,"failed":0}
I0930 19:49:01.300]   << End Captured StdOut/StdErr Output
I0930 19:49:01.300] ------------------------------
I0930 19:49:01.307] SSSSSSSSSSSSSSS
I0930 19:49:01.307] ------------------------------
I0930 19:49:01.307] S [SKIPPED] [0.000 seconds]
I0930 19:49:01.307] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
I0930 19:49:01.308] test/e2e/storage/external/external.go:174
I0930 19:49:01.308]   [Testpattern: Dynamic PV (immediate binding)] topology [BeforeEach]
I0930 19:49:01.308]   test/e2e/storage/framework/testsuite.go:51
I0930 19:49:01.308]     should fail to schedule a pod which has topologies that conflict with AllowedTopologies
I0930 19:49:01.308]     test/e2e/storage/testsuites/topology.go:194
I0930 19:49:01.308] 
I0930 19:49:01.308]   Begin Captured GinkgoWriter Output >>
I0930 19:49:01.308]     [BeforeEach] [Testpattern: Dynamic PV (immediate binding)] topology
I0930 19:49:01.308]       test/e2e/storage/framework/testsuite.go:51
I0930 19:49:01.309]     Sep 30 19:49:01.306: INFO: Driver "csi-gcpfs-fs-sc-basic-hdd" does not support topology - skipping
... skipping 28 lines ...
I0930 19:49:01.387]     STEP: Waiting for kube-root-ca.crt to be provisioned in namespace 09/30/22 19:49:01.344
I0930 19:49:01.388]     [It] should check snapshot fields, check restore correctly works, check deletion (ephemeral)
I0930 19:49:01.388]       test/e2e/storage/testsuites/snapshottable.go:176
I0930 19:49:01.388]     Sep 30 19:49:01.348: INFO: volume type "DynamicPV" is not ephemeral
I0930 19:49:01.388]     [AfterEach] volume snapshot controller
I0930 19:49:01.388]       test/e2e/storage/testsuites/snapshottable.go:171
I0930 19:49:01.388]     Sep 30 19:49:01.351: INFO: Error getting logs for pod restored-pvc-tester-k8fnx: the server could not find the requested resource (get pods restored-pvc-tester-k8fnx)
I0930 19:49:01.389]     Sep 30 19:49:01.351: INFO: Deleting pod "restored-pvc-tester-k8fnx" in namespace "snapshotting-6395"
I0930 19:49:01.389]     Sep 30 19:49:01.354: INFO: deleting claim "snapshotting-6395"/"pvc-6qdpz"
I0930 19:49:01.389]     Sep 30 19:49:01.356: INFO: deleting snapshot content "snapcontent-31b27e1f-bf71-45c1-aef8-1b1fbd2e11a4"
I0930 19:49:01.389]     Sep 30 19:49:01.359: INFO: deleting snapshot class "snapshotting-6395vnj6j"
I0930 19:49:01.389]     Sep 30 19:49:01.361: INFO: Waiting up to 5m0s for volumesnapshotclasses snapshotting-6395vnj6j to be deleted
I0930 19:49:01.389]     Sep 30 19:49:01.364: INFO: volumesnapshotclasses snapshotting-6395vnj6j is not found and has been deleted
... skipping 105 lines ...
I0930 19:50:20.878] ------------------------------
I0930 19:50:20.878] • [SLOW TEST] [401.645 seconds]
I0930 19:50:20.878] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] subPath should support restarting containers using file as subpath [Slow][LinuxOnly]
I0930 19:50:20.878] test/e2e/storage/testsuites/subpath.go:332
I0930 19:50:20.879] 
I0930 19:50:20.879]   Begin Captured StdOut/StdErr Output >>
I0930 19:50:20.879]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] subPath should support restarting containers using file as subpath [Slow][LinuxOnly]","completed":10,"skipped":1944,"failed":0}
I0930 19:50:20.879]   << End Captured StdOut/StdErr Output
I0930 19:50:20.879] ------------------------------
I0930 19:53:08.873] SSSSS
I0930 19:53:08.873] ------------------------------
I0930 19:53:08.873] • [SLOW TEST] [318.359 seconds]
I0930 19:53:08.874] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] subPath should support existing single file [LinuxOnly]
I0930 19:53:08.874] test/e2e/storage/testsuites/subpath.go:220
I0930 19:53:08.874] 
I0930 19:53:08.874]   Begin Captured StdOut/StdErr Output >>
I0930 19:53:08.874]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] subPath should support existing single file [LinuxOnly]","completed":10,"skipped":858,"failed":0}
I0930 19:53:08.875]   << End Captured StdOut/StdErr Output
I0930 19:53:08.875] ------------------------------
I0930 19:53:08.894] SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
I0930 19:53:08.894] ------------------------------
I0930 19:53:08.894] S [SKIPPED] [0.000 seconds]
I0930 19:53:08.894] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
... skipping 35 lines ...
I0930 19:53:08.924] ------------------------------
I0930 19:53:08.925] S [SKIPPED] [0.000 seconds]
I0930 19:53:08.925] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
I0930 19:53:08.925] test/e2e/storage/external/external.go:174
I0930 19:53:08.925]   [Testpattern: Dynamic PV (ntfs)][Feature:Windows] subPath [BeforeEach]
I0930 19:53:08.926]   test/e2e/storage/framework/testsuite.go:51
I0930 19:53:08.926]     should fail if subpath directory is outside the volume [Slow][LinuxOnly]
I0930 19:53:08.926]     test/e2e/storage/testsuites/subpath.go:241
I0930 19:53:08.926] 
I0930 19:53:08.927]   Begin Captured GinkgoWriter Output >>
I0930 19:53:08.927]     [BeforeEach] [Testpattern: Dynamic PV (ntfs)][Feature:Windows] subPath
I0930 19:53:08.927]       test/e2e/storage/framework/testsuite.go:51
I0930 19:53:08.927]     Sep 30 19:53:08.923: INFO: Driver csi-gcpfs-fs-sc-basic-hdd doesn't support ntfs -- skipping
... skipping 154 lines ...
I0930 19:54:42.840] ------------------------------
I0930 19:54:42.840] • [SLOW TEST] [341.339 seconds]
I0930 19:54:42.840] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] fsgroupchangepolicy (OnRootMismatch)[LinuxOnly], pod created with an initial fsgroup, volume contents ownership changed via chgrp in first pod, new pod with same fsgroup skips ownership changes to the volume contents
I0930 19:54:42.841] test/e2e/storage/testsuites/fsgroupchangepolicy.go:216
I0930 19:54:42.841] 
I0930 19:54:42.841]   Begin Captured StdOut/StdErr Output >>
I0930 19:54:42.842]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] fsgroupchangepolicy (OnRootMismatch)[LinuxOnly], pod created with an initial fsgroup, volume contents ownership changed via chgrp in first pod, new pod with same fsgroup skips ownership changes to the volume contents","completed":10,"skipped":984,"failed":0}
I0930 19:54:42.842]   << End Captured StdOut/StdErr Output
I0930 19:54:42.842] ------------------------------
I0930 19:54:42.852] SSSSSSSSSSSSSSSSSSS
I0930 19:54:42.852] ------------------------------
I0930 19:54:42.852] S [SKIPPED] [0.000 seconds]
I0930 19:54:42.853] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
... skipping 126 lines ...
I0930 19:55:43.272] ------------------------------
I0930 19:55:43.272] • [SLOW TEST] [322.389 seconds]
I0930 19:55:43.272] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] subPath should support readOnly file specified in the volumeMount [LinuxOnly]
I0930 19:55:43.272] test/e2e/storage/testsuites/subpath.go:381
I0930 19:55:43.272] 
I0930 19:55:43.273]   Begin Captured StdOut/StdErr Output >>
I0930 19:55:43.273]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] subPath should support readOnly file specified in the volumeMount [LinuxOnly]","completed":11,"skipped":1949,"failed":0}
I0930 19:55:43.273]   << End Captured StdOut/StdErr Output
I0930 19:55:43.273] ------------------------------
I0930 19:55:43.277] SSSSSS
I0930 19:55:43.277] ------------------------------
I0930 19:55:43.277] S [SKIPPED] [0.000 seconds]
I0930 19:55:43.277] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
... skipping 35 lines ...
I0930 20:00:22.456] ------------------------------
I0930 20:00:22.456] • [SLOW TEST] [339.513 seconds]
I0930 20:00:22.456] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Generic Ephemeral-volume (default fs) (late-binding)] ephemeral should create read-only inline ephemeral volume
I0930 20:00:22.456] test/e2e/storage/testsuites/ephemeral.go:175
I0930 20:00:22.456] 
I0930 20:00:22.457]   Begin Captured StdOut/StdErr Output >>
I0930 20:00:22.457]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Generic Ephemeral-volume (default fs) (late-binding)] ephemeral should create read-only inline ephemeral volume","completed":11,"skipped":1089,"failed":0}
I0930 20:00:22.457]   << End Captured StdOut/StdErr Output
I0930 20:00:22.457] ------------------------------
I0930 20:00:22.462] SSSSSSSSSS
I0930 20:00:22.462] ------------------------------
I0930 20:00:22.462] S [SKIPPED] [0.000 seconds]
I0930 20:00:22.462] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
... skipping 35 lines ...
I0930 20:05:26.538] ------------------------------
I0930 20:05:26.539] • [SLOW TEST] [583.230 seconds]
I0930 20:05:26.539] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [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 (persistent)
I0930 20:05:26.539] test/e2e/storage/testsuites/snapshottable.go:277
I0930 20:05:26.540] 
I0930 20:05:26.540]   Begin Captured StdOut/StdErr Output >>
I0930 20:05:26.541]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [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 (persistent)","completed":12,"skipped":2011,"failed":0}
I0930 20:05:26.541]   << End Captured StdOut/StdErr Output
I0930 20:05:26.541] ------------------------------
I0930 20:05:26.549] SSSSSSSSSSSSSSSSSSS
I0930 20:05:26.550] ------------------------------
I0930 20:05:26.550] S [SKIPPED] [0.000 seconds]
I0930 20:05:26.550] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
... skipping 12 lines ...
I0930 20:05:26.551]   Driver "csi-gcpfs-fs-sc-basic-hdd" does not support volume type "InlineVolume" - skipping
I0930 20:05:26.551]   In [BeforeEach] at: test/e2e/storage/external/external.go:269
I0930 20:05:26.552] ------------------------------
I0930 20:05:36.855] SSSSSSSSSSS
I0930 20:05:36.856] ------------------------------
I0930 20:05:36.856] • [SLOW TEST] [314.364 seconds]
I0930 20:05:36.856] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] subPath should fail if subpath file is outside the volume [Slow][LinuxOnly]
I0930 20:05:36.857] test/e2e/storage/testsuites/subpath.go:257
I0930 20:05:36.857] 
I0930 20:05:36.857]   Begin Captured StdOut/StdErr Output >>
I0930 20:05:36.857]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] subPath should fail if subpath file is outside the volume [Slow][LinuxOnly]","completed":12,"skipped":1159,"failed":0}
I0930 20:05:36.858]   << End Captured StdOut/StdErr Output
I0930 20:05:36.858] ------------------------------
I0930 20:05:36.863] SSSSSSSSSSSSSS
I0930 20:05:36.863] ------------------------------
I0930 20:05:36.863] S [SKIPPED] [0.000 seconds]
I0930 20:05:36.863] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
... skipping 30 lines ...
I0930 20:05:36.868] 
I0930 20:05:36.868]   Driver csi-gcpfs-fs-sc-basic-hdd doesn't support ntfs -- skipping
I0930 20:05:36.868]   In [BeforeEach] at: test/e2e/storage/framework/testsuite.go:121
I0930 20:05:36.868] ------------------------------
I0930 20:07:14.231] SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
I0930 20:07:14.232] ------------------------------
I0930 20:07:14.232] • [FAILED] [845.132 seconds]
I0930 20:07:14.232] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
I0930 20:07:14.232] test/e2e/storage/external/external.go:174
I0930 20:07:14.232]   [Testpattern: Dynamic PV (default fs)] volumes
I0930 20:07:14.232]   test/e2e/storage/framework/testsuite.go:50
I0930 20:07:14.233]     [It] should store data
I0930 20:07:14.233]     test/e2e/storage/testsuites/volumes.go:161
I0930 20:07:14.233] 
I0930 20:07:14.233]   Begin Captured StdOut/StdErr Output >>
I0930 20:07:14.233]     {"msg":"FAILED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] volumes should store data","completed":10,"skipped":1098,"failed":1,"failures":["External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] volumes should store data"]}
I0930 20:07:14.234]   << End Captured StdOut/StdErr Output
I0930 20:07:14.234] 
I0930 20:07:14.234]   Begin Captured GinkgoWriter Output >>
I0930 20:07:14.234]     [BeforeEach] [Testpattern: Dynamic PV (default fs)] volumes
I0930 20:07:14.234]       test/e2e/storage/framework/testsuite.go:51
I0930 20:07:14.234]     [BeforeEach] [Testpattern: Dynamic PV (default fs)] volumes
... skipping 408 lines ...
I0930 20:07:14.305]     Sep 30 20:04:39.423: INFO: Waiting for pod external-injector to disappear
I0930 20:07:14.305]     Sep 30 20:04:39.430: INFO: Pod external-injector still exists
I0930 20:07:14.305]     Sep 30 20:04:41.423: INFO: Waiting for pod external-injector to disappear
I0930 20:07:14.305]     Sep 30 20:04:41.428: INFO: Pod external-injector still exists
I0930 20:07:14.306]     Sep 30 20:04:43.423: INFO: Waiting for pod external-injector to disappear
I0930 20:07:14.306]     Sep 30 20:04:43.426: INFO: Pod external-injector no longer exists
I0930 20:07:14.306]     Sep 30 20:04:43.426: FAIL: Failed to create injector pod: timed out while waiting for pod volume-5199/external-injector to be running
I0930 20:07:14.306] 
I0930 20:07:14.306]     Full Stack Trace
I0930 20:07:14.306]     k8s.io/kubernetes/test/e2e/storage/testsuites.(*volumesTestSuite).DefineTests.func3()
I0930 20:07:14.306]     	test/e2e/storage/testsuites/volumes.go:188 +0x457
I0930 20:07:14.306]     STEP: cleaning the environment after external 09/30/22 20:04:43.426
I0930 20:07:14.306]     STEP: Deleting pvc 09/30/22 20:04:43.426
... skipping 38 lines ...
I0930 20:07:14.312]     STEP: Found 8 events. 09/30/22 20:07:13.623
I0930 20:07:14.312]     Sep 30 20:07:13.623: INFO: At 2022-09-30 19:53:09 +0000 UTC - event for csi-gcpfs-fs-sc-basic-hdd2t5vd: {persistentvolume-controller } WaitForFirstConsumer: waiting for first consumer to be created before binding
I0930 20:07:14.313]     Sep 30 20:07:13.623: INFO: At 2022-09-30 19:53:09 +0000 UTC - event for csi-gcpfs-fs-sc-basic-hdd2t5vd: {persistentvolume-controller } ExternalProvisioning: waiting for a volume to be created, either by external provisioner "filestore.csi.storage.gke.io" or manually created by system administrator
I0930 20:07:14.313]     Sep 30 20:07:13.623: INFO: At 2022-09-30 19:53:09 +0000 UTC - event for csi-gcpfs-fs-sc-basic-hdd2t5vd: {filestore.csi.storage.gke.io_e2e-test-prow-minion-group-7rkg_30eb1b2e-4aff-456b-8763-8fe68136579e } Provisioning: External provisioner is provisioning volume for claim "volume-5199/csi-gcpfs-fs-sc-basic-hdd2t5vd"
I0930 20:07:14.313]     Sep 30 20:07:13.623: INFO: At 2022-09-30 19:55:49 +0000 UTC - event for csi-gcpfs-fs-sc-basic-hdd2t5vd: {filestore.csi.storage.gke.io_e2e-test-prow-minion-group-7rkg_30eb1b2e-4aff-456b-8763-8fe68136579e } ProvisioningSucceeded: Successfully provisioned volume pvc-0ee5a905-1df7-4319-9718-57c6108c8e4f
I0930 20:07:14.314]     Sep 30 20:07:13.623: INFO: At 2022-09-30 19:55:50 +0000 UTC - event for external-injector: {default-scheduler } Scheduled: Successfully assigned volume-5199/external-injector to e2e-test-prow-minion-group-gxdd
I0930 20:07:14.314]     Sep 30 20:07:13.623: INFO: At 2022-09-30 19:55:53 +0000 UTC - event for external-injector: {kubelet e2e-test-prow-minion-group-gxdd} FailedMount: MountVolume.MountDevice failed for volume "pvc-0ee5a905-1df7-4319-9718-57c6108c8e4f" : rpc error: code = Internal desc = mount "/var/lib/kubelet/plugins/kubernetes.io/csi/filestore.csi.storage.gke.io/d6c451a2c642dffcdfa25a5505008825ee11d4e69d63562ab9fdd82ae6e649c2/globalmount" failed: mount failed: exit status 32
I0930 20:07:14.314]     Mounting command: mount
I0930 20:07:14.314]     Mounting arguments: -t nfs 10.190.105.194:/vol1 /var/lib/kubelet/plugins/kubernetes.io/csi/filestore.csi.storage.gke.io/d6c451a2c642dffcdfa25a5505008825ee11d4e69d63562ab9fdd82ae6e649c2/globalmount
I0930 20:07:14.314]     Output: mount.nfs: access denied by server while mounting 10.190.105.194:/vol1
I0930 20:07:14.314] 
I0930 20:07:14.315]     Sep 30 20:07:13.623: INFO: At 2022-09-30 19:57:53 +0000 UTC - event for external-injector: {kubelet e2e-test-prow-minion-group-gxdd} FailedMount: Unable to attach or mount volumes: unmounted volumes=[external-volume-0], unattached volumes=[external-volume-0 kube-api-access-mfqx2]: timed out waiting for the condition
I0930 20:07:14.315]     Sep 30 20:07:13.623: INFO: At 2022-09-30 20:00:10 +0000 UTC - event for external-injector: {kubelet e2e-test-prow-minion-group-gxdd} FailedMount: Unable to attach or mount volumes: unmounted volumes=[external-volume-0], unattached volumes=[kube-api-access-mfqx2 external-volume-0]: timed out waiting for the condition
... skipping 125 lines ...
I0930 20:07:14.365]     [DeferCleanup] [Testpattern: Dynamic PV (default fs)] volumes
I0930 20:07:14.365]       tear down framework | framework.go:170
I0930 20:07:14.366]     Sep 30 20:07:14.210: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
I0930 20:07:14.366]     STEP: Destroying namespace "volume-5199" for this suite. 09/30/22 20:07:14.218
I0930 20:07:14.366]   << End Captured GinkgoWriter Output
I0930 20:07:14.366] 
I0930 20:07:14.366]   Sep 30 20:04:43.426: Failed to create injector pod: timed out while waiting for pod volume-5199/external-injector to be running
I0930 20:07:14.366]   In [It] at: test/e2e/storage/testsuites/volumes.go:188
I0930 20:07:14.366] ------------------------------
I0930 20:11:20.948] SSSSSSSSSSSS
I0930 20:11:20.948] ------------------------------
I0930 20:11:20.949] • [SLOW TEST] [354.391 seconds]
I0930 20:11:20.949] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)(allowExpansion)] volume-expand Verify if offline PVC expansion works
I0930 20:11:20.949] test/e2e/storage/testsuites/volume_expand.go:176
I0930 20:11:20.949] 
I0930 20:11:20.949]   Begin Captured StdOut/StdErr Output >>
I0930 20:11:20.950]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)(allowExpansion)] volume-expand Verify if offline PVC expansion works","completed":13,"skipped":2042,"failed":0}
I0930 20:11:20.950]   << End Captured StdOut/StdErr Output
I0930 20:11:20.950] ------------------------------
I0930 20:11:20.963] SSSSSSSSSSSSSSSSSSSSSSSSSSSSS
I0930 20:11:20.964] ------------------------------
I0930 20:11:20.964] S [SKIPPED] [0.001 seconds]
I0930 20:11:20.964] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
... skipping 141 lines ...
I0930 20:11:36.408] ------------------------------
I0930 20:11:36.408] • [SLOW TEST] [359.514 seconds]
I0930 20:11:36.408] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Generic Ephemeral-volume (default fs) (late-binding)] ephemeral should support multiple inline ephemeral volumes
I0930 20:11:36.409] test/e2e/storage/testsuites/ephemeral.go:315
I0930 20:11:36.409] 
I0930 20:11:36.409]   Begin Captured StdOut/StdErr Output >>
I0930 20:11:36.409]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Generic Ephemeral-volume (default fs) (late-binding)] ephemeral should support multiple inline ephemeral volumes","completed":13,"skipped":1240,"failed":0}
I0930 20:11:36.409]   << End Captured StdOut/StdErr Output
I0930 20:11:36.409] ------------------------------
I0930 20:11:36.419] SSSSSSSSSSSSSSSSSSS
I0930 20:11:36.420] ------------------------------
I0930 20:11:36.420] S [SKIPPED] [0.000 seconds]
I0930 20:11:36.420] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
... skipping 71 lines ...
I0930 20:11:36.487] ------------------------------
I0930 20:11:36.487] S [SKIPPED] [0.001 seconds]
I0930 20:11:36.488] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
I0930 20:11:36.488] test/e2e/storage/external/external.go:174
I0930 20:11:36.488]   [Testpattern: Pre-provisioned PV (default fs)] subPath [BeforeEach]
I0930 20:11:36.488]   test/e2e/storage/framework/testsuite.go:51
I0930 20:11:36.489]     should fail if subpath file is outside the volume [Slow][LinuxOnly]
I0930 20:11:36.489]     test/e2e/storage/testsuites/subpath.go:257
I0930 20:11:36.489] 
I0930 20:11:36.489]   Begin Captured GinkgoWriter Output >>
I0930 20:11:36.489]     [BeforeEach] [Testpattern: Pre-provisioned PV (default fs)] subPath
I0930 20:11:36.489]       test/e2e/storage/framework/testsuite.go:51
I0930 20:11:36.489]     Sep 30 20:11:36.483: INFO: Driver "csi-gcpfs-fs-sc-basic-hdd" does not support volume type "PreprovisionedPV" - skipping
... skipping 44 lines ...
I0930 20:12:49.354] ------------------------------
I0930 20:12:49.355] • [SLOW TEST] [335.038 seconds]
I0930 20:12:49.356] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] fsgroupchangepolicy (OnRootMismatch)[LinuxOnly], pod created with an initial fsgroup, new pod fsgroup applied to volume contents
I0930 20:12:49.356] test/e2e/storage/testsuites/fsgroupchangepolicy.go:216
I0930 20:12:49.356] 
I0930 20:12:49.356]   Begin Captured StdOut/StdErr Output >>
I0930 20:12:49.357]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] fsgroupchangepolicy (OnRootMismatch)[LinuxOnly], pod created with an initial fsgroup, new pod fsgroup applied to volume contents","completed":11,"skipped":1110,"failed":1,"failures":["External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] volumes should store data"]}
I0930 20:12:49.357]   << End Captured StdOut/StdErr Output
I0930 20:12:49.357] ------------------------------
I0930 20:18:45.499] SSSSSS
I0930 20:18:45.500] ------------------------------
I0930 20:18:45.500] • [SLOW TEST] [356.134 seconds]
I0930 20:18:45.500] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] fsgroupchangepolicy (Always)[LinuxOnly], pod created with an initial fsgroup, new pod fsgroup applied to volume contents
I0930 20:18:45.500] test/e2e/storage/testsuites/fsgroupchangepolicy.go:216
I0930 20:18:45.500] 
I0930 20:18:45.500]   Begin Captured StdOut/StdErr Output >>
I0930 20:18:45.501]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] fsgroupchangepolicy (Always)[LinuxOnly], pod created with an initial fsgroup, new pod fsgroup applied to volume contents","completed":12,"skipped":1116,"failed":1,"failures":["External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] volumes should store data"]}
I0930 20:18:45.501]   << End Captured StdOut/StdErr Output
I0930 20:18:45.501] ------------------------------
I0930 20:21:13.002] SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
I0930 20:21:13.003] ------------------------------
I0930 20:21:13.003] • [SLOW TEST] [576.465 seconds]
I0930 20:21:13.003] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] provisioning should provision storage with snapshot data source [Feature:VolumeSnapshotDataSource]
I0930 20:21:13.004] test/e2e/storage/testsuites/provisioning.go:208
I0930 20:21:13.004] 
I0930 20:21:13.004]   Begin Captured StdOut/StdErr Output >>
I0930 20:21:13.004]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] provisioning should provision storage with snapshot data source [Feature:VolumeSnapshotDataSource]","completed":14,"skipped":1422,"failed":0}
I0930 20:21:13.004]   << End Captured StdOut/StdErr Output
I0930 20:21:13.004] ------------------------------
I0930 20:21:13.010] SSSSSSSSS
I0930 20:21:13.010] ------------------------------
I0930 20:21:13.010] S [SKIPPED] [0.000 seconds]
I0930 20:21:13.010] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
... skipping 16 lines ...
I0930 20:21:13.016] ------------------------------
I0930 20:21:13.016] S [SKIPPED] [0.000 seconds]
I0930 20:21:13.016] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
I0930 20:21:13.017] test/e2e/storage/external/external.go:174
I0930 20:21:13.017]   [Testpattern: Inline-volume (default fs)] subPath [BeforeEach]
I0930 20:21:13.017]   test/e2e/storage/framework/testsuite.go:51
I0930 20:21:13.017]     should fail if subpath with backstepping is outside the volume [Slow][LinuxOnly]
I0930 20:21:13.017]     test/e2e/storage/testsuites/subpath.go:279
I0930 20:21:13.018] 
I0930 20:21:13.018]   Begin Captured GinkgoWriter Output >>
I0930 20:21:13.018]     [BeforeEach] [Testpattern: Inline-volume (default fs)] subPath
I0930 20:21:13.018]       test/e2e/storage/framework/testsuite.go:51
I0930 20:21:13.018]     Sep 30 20:21:13.015: INFO: Driver "csi-gcpfs-fs-sc-basic-hdd" does not support volume type "InlineVolume" - skipping
... skipping 101 lines ...
I0930 20:21:15.968] ------------------------------
I0930 20:21:15.969] • [SLOW TEST] [594.875 seconds]
I0930 20:21:15.969] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [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 (persistent)
I0930 20:21:15.969] test/e2e/storage/testsuites/snapshottable.go:277
I0930 20:21:15.969] 
I0930 20:21:15.969]   Begin Captured StdOut/StdErr Output >>
I0930 20:21:15.970]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [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 (persistent)","completed":14,"skipped":2205,"failed":0}
I0930 20:21:15.970]   << End Captured StdOut/StdErr Output
I0930 20:21:15.970] ------------------------------
I0930 20:21:15.990] SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
I0930 20:21:15.991] ------------------------------
I0930 20:21:15.991] S [SKIPPED] [0.000 seconds]
I0930 20:21:15.991] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
... skipping 149 lines ...
I0930 20:24:14.198] ------------------------------
I0930 20:24:14.198] • [SLOW TEST] [328.665 seconds]
I0930 20:24:14.198] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (filesystem volmode)] multiVolume [Slow] should concurrently access the single volume from pods on the same node
I0930 20:24:14.198] test/e2e/storage/testsuites/multivolume.go:297
I0930 20:24:14.199] 
I0930 20:24:14.199]   Begin Captured StdOut/StdErr Output >>
I0930 20:24:14.199]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (filesystem volmode)] multiVolume [Slow] should concurrently access the single volume from pods on the same node","completed":13,"skipped":1170,"failed":1,"failures":["External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] volumes should store data"]}
I0930 20:24:14.199]   << End Captured StdOut/StdErr Output
I0930 20:24:14.200] ------------------------------
I0930 20:24:14.213] SSSSSSSSSSSSSSSSSSSSSSSSSSSSS
I0930 20:24:14.213] ------------------------------
I0930 20:24:14.214] S [SKIPPED] [0.000 seconds]
I0930 20:24:14.214] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
... skipping 12 lines ...
I0930 20:24:14.216]   Driver "csi-gcpfs-fs-sc-basic-hdd" does not support volume type "PreprovisionedPV" - skipping
I0930 20:24:14.216]   In [BeforeEach] at: test/e2e/storage/external/external.go:269
I0930 20:24:14.217] ------------------------------
I0930 20:24:16.381] SSSSSSSSSSSSSSSSSSSSS
I0930 20:24:16.381] ------------------------------
I0930 20:24:16.381] • [2.157 seconds]
I0930 20:24:16.382] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (block volmode)] volumeMode should fail in binding dynamic provisioned PV to PVC [Slow][LinuxOnly]
I0930 20:24:16.382] test/e2e/storage/testsuites/volumemode.go:260
I0930 20:24:16.382] 
I0930 20:24:16.382]   Begin Captured StdOut/StdErr Output >>
I0930 20:24:16.383]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (block volmode)] volumeMode should fail in binding dynamic provisioned PV to PVC [Slow][LinuxOnly]","completed":14,"skipped":1221,"failed":1,"failures":["External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] volumes should store data"]}
I0930 20:24:16.383]   << End Captured StdOut/StdErr Output
I0930 20:24:16.383] ------------------------------
I0930 20:24:16.389] SSSSSSSSSSSSSSSS
I0930 20:24:16.390] ------------------------------
I0930 20:24:16.390] S [SKIPPED] [0.000 seconds]
I0930 20:24:16.390] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
... skipping 35 lines ...
I0930 20:24:16.427] ------------------------------
I0930 20:24:16.428] S [SKIPPED] [0.000 seconds]
I0930 20:24:16.428] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
I0930 20:24:16.428] test/e2e/storage/external/external.go:174
I0930 20:24:16.428]   [Testpattern: Dynamic PV (ntfs)][Feature:Windows] subPath [BeforeEach]
I0930 20:24:16.428]   test/e2e/storage/framework/testsuite.go:51
I0930 20:24:16.429]     should fail if non-existent subpath is outside the volume [Slow][LinuxOnly]
I0930 20:24:16.429]     test/e2e/storage/testsuites/subpath.go:268
I0930 20:24:16.429] 
I0930 20:24:16.429]   Begin Captured GinkgoWriter Output >>
I0930 20:24:16.429]     [BeforeEach] [Testpattern: Dynamic PV (ntfs)][Feature:Windows] subPath
I0930 20:24:16.430]       test/e2e/storage/framework/testsuite.go:51
I0930 20:24:16.430]     Sep 30 20:24:16.426: INFO: Driver csi-gcpfs-fs-sc-basic-hdd doesn't support ntfs -- skipping
... skipping 25 lines ...
I0930 20:27:57.447] ------------------------------
I0930 20:27:57.447] • [SLOW TEST] [401.380 seconds]
I0930 20:27:57.447] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] subPath should support existing directories when readOnly specified in the volumeSource
I0930 20:27:57.447] test/e2e/storage/testsuites/subpath.go:396
I0930 20:27:57.447] 
I0930 20:27:57.448]   Begin Captured StdOut/StdErr Output >>
I0930 20:27:57.448]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] subPath should support existing directories when readOnly specified in the volumeSource","completed":15,"skipped":2372,"failed":0}
I0930 20:27:57.448]   << End Captured StdOut/StdErr Output
I0930 20:27:57.448] ------------------------------
I0930 20:27:57.472] SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
I0930 20:27:57.472] ------------------------------
I0930 20:27:57.473] S [SKIPPED] [0.000 seconds]
I0930 20:27:57.473] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
... skipping 16 lines ...
I0930 20:27:57.522] ------------------------------
I0930 20:27:57.522] S [SKIPPED] [0.000 seconds]
I0930 20:27:57.522] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
I0930 20:27:57.522] test/e2e/storage/external/external.go:174
I0930 20:27:57.522]   [Testpattern: Dynamic PV (delayed binding)] topology [BeforeEach]
I0930 20:27:57.523]   test/e2e/storage/framework/testsuite.go:51
I0930 20:27:57.523]     should fail to schedule a pod which has topologies that conflict with AllowedTopologies
I0930 20:27:57.523]     test/e2e/storage/testsuites/topology.go:194
I0930 20:27:57.523] 
I0930 20:27:57.523]   Begin Captured GinkgoWriter Output >>
I0930 20:27:57.523]     [BeforeEach] [Testpattern: Dynamic PV (delayed binding)] topology
I0930 20:27:57.524]       test/e2e/storage/framework/testsuite.go:51
I0930 20:27:57.524]     Sep 30 20:27:57.520: INFO: Driver "csi-gcpfs-fs-sc-basic-hdd" does not support topology - skipping
... skipping 116 lines ...
I0930 20:28:16.661] ------------------------------
I0930 20:28:16.661] • [SLOW TEST] [423.565 seconds]
I0930 20:28:16.662] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Generic Ephemeral-volume (default fs) (immediate-binding)] ephemeral should create read/write inline ephemeral volume
I0930 20:28:16.662] test/e2e/storage/testsuites/ephemeral.go:196
I0930 20:28:16.663] 
I0930 20:28:16.663]   Begin Captured StdOut/StdErr Output >>
I0930 20:28:16.663]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Generic Ephemeral-volume (default fs) (immediate-binding)] ephemeral should create read/write inline ephemeral volume","completed":15,"skipped":1574,"failed":0}
I0930 20:28:16.663]   << End Captured StdOut/StdErr Output
I0930 20:28:16.664] ------------------------------
I0930 20:28:16.667] SSSSS
I0930 20:28:16.667] ------------------------------
I0930 20:28:16.667] S [SKIPPED] [0.000 seconds]
I0930 20:28:16.667] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
... skipping 16 lines ...
I0930 20:29:49.041] ------------------------------
I0930 20:29:49.041] • [SLOW TEST] [332.568 seconds]
I0930 20:29:49.041] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] provisioning should mount multiple PV pointing to the same storage on the same node
I0930 20:29:49.041] test/e2e/storage/testsuites/provisioning.go:525
I0930 20:29:49.041] 
I0930 20:29:49.041]   Begin Captured StdOut/StdErr Output >>
I0930 20:29:49.042]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] provisioning should mount multiple PV pointing to the same storage on the same node","completed":15,"skipped":1383,"failed":1,"failures":["External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] volumes should store data"]}
I0930 20:29:49.042]   << End Captured StdOut/StdErr Output
I0930 20:29:49.042] ------------------------------
I0930 20:29:49.053] SSSSSSSSSSSSSSSSS
I0930 20:29:49.054] ------------------------------
I0930 20:29:49.054] S [SKIPPED] [0.000 seconds]
I0930 20:29:49.054] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
... skipping 14 lines ...
I0930 20:29:49.056] ------------------------------
I0930 20:34:15.178] • [SLOW TEST] [377.407 seconds]
I0930 20:34:15.178] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Generic Ephemeral-volume (default fs) (immediate-binding)] ephemeral should support expansion of pvcs created for ephemeral pvcs
I0930 20:34:15.179] test/e2e/storage/testsuites/ephemeral.go:216
I0930 20:34:15.179] 
I0930 20:34:15.179]   Begin Captured StdOut/StdErr Output >>
I0930 20:34:15.179]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Generic Ephemeral-volume (default fs) (immediate-binding)] ephemeral should support expansion of pvcs created for ephemeral pvcs","completed":16,"skipped":2787,"failed":0}
I0930 20:34:15.180]   << End Captured StdOut/StdErr Output
I0930 20:34:15.180] ------------------------------
I0930 20:34:56.392] SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
I0930 20:34:56.393] ------------------------------
I0930 20:34:56.393] • [SLOW TEST] [307.337 seconds]
I0930 20:34:56.393] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] subPath should verify container cannot write to subpath readonly volumes [Slow]
I0930 20:34:56.393] test/e2e/storage/testsuites/subpath.go:424
I0930 20:34:56.394] 
I0930 20:34:56.394]   Begin Captured StdOut/StdErr Output >>
I0930 20:34:56.394]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] subPath should verify container cannot write to subpath readonly volumes [Slow]","completed":16,"skipped":1401,"failed":1,"failures":["External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] volumes should store data"]}
I0930 20:34:56.394]   << End Captured StdOut/StdErr Output
I0930 20:34:56.394] ------------------------------
I0930 20:34:56.397] SSSS
I0930 20:34:56.397] ------------------------------
I0930 20:34:56.397] S [SKIPPED] [0.000 seconds]
I0930 20:34:56.397] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
... skipping 128 lines ...
I0930 20:36:34.236] ------------------------------
I0930 20:36:34.236] • [SLOW TEST] [497.559 seconds]
I0930 20:36:34.237] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (filesystem volmode)] multiVolume [Slow] should access to two volumes with the same volume mode and retain data across pod recreation on different node
I0930 20:36:34.237] test/e2e/storage/testsuites/multivolume.go:167
I0930 20:36:34.237] 
I0930 20:36:34.237]   Begin Captured StdOut/StdErr Output >>
I0930 20:36:34.237]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (filesystem volmode)] multiVolume [Slow] should access to two volumes with the same volume mode and retain data across pod recreation on different node","completed":16,"skipped":1593,"failed":0}
I0930 20:36:34.237]   << End Captured StdOut/StdErr Output
I0930 20:36:34.237] ------------------------------
I0930 20:36:34.307] SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
I0930 20:36:34.307] ------------------------------
I0930 20:36:34.309] S [SKIPPED] [0.000 seconds]
I0930 20:36:34.309] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
I0930 20:36:34.309] test/e2e/storage/external/external.go:174
I0930 20:36:34.309]   [Testpattern: Inline-volume (default fs)] subPath [BeforeEach]
I0930 20:36:34.310]   test/e2e/storage/framework/testsuite.go:51
I0930 20:36:34.310]     should fail if non-existent subpath is outside the volume [Slow][LinuxOnly]
I0930 20:36:34.310]     test/e2e/storage/testsuites/subpath.go:268
I0930 20:36:34.310] 
I0930 20:36:34.310]   Begin Captured GinkgoWriter Output >>
I0930 20:36:34.310]     [BeforeEach] [Testpattern: Inline-volume (default fs)] subPath
I0930 20:36:34.310]       test/e2e/storage/framework/testsuite.go:51
I0930 20:36:34.310]     Sep 30 20:36:34.306: INFO: Driver "csi-gcpfs-fs-sc-basic-hdd" does not support volume type "InlineVolume" - skipping
... skipping 6 lines ...
I0930 20:36:34.341] ------------------------------
I0930 20:36:34.342] S [SKIPPED] [0.001 seconds]
I0930 20:36:34.342] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
I0930 20:36:34.343] test/e2e/storage/external/external.go:174
I0930 20:36:34.343]   [Testpattern: Pre-provisioned PV (default fs)] subPath [BeforeEach]
I0930 20:36:34.344]   test/e2e/storage/framework/testsuite.go:51
I0930 20:36:34.344]     should fail if subpath directory is outside the volume [Slow][LinuxOnly]
I0930 20:36:34.345]     test/e2e/storage/testsuites/subpath.go:241
I0930 20:36:34.345] 
I0930 20:36:34.346]   Begin Captured GinkgoWriter Output >>
I0930 20:36:34.346]     [BeforeEach] [Testpattern: Pre-provisioned PV (default fs)] subPath
I0930 20:36:34.346]       test/e2e/storage/framework/testsuite.go:51
I0930 20:36:34.347]     Sep 30 20:36:34.337: INFO: Driver "csi-gcpfs-fs-sc-basic-hdd" does not support volume type "PreprovisionedPV" - skipping
... skipping 196 lines ...
I0930 20:39:31.538] ------------------------------
I0930 20:39:31.538] • [SLOW TEST] [316.302 seconds]
I0930 20:39:31.539] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] subPath should support existing directory
I0930 20:39:31.539] test/e2e/storage/testsuites/subpath.go:206
I0930 20:39:31.539] 
I0930 20:39:31.539]   Begin Captured StdOut/StdErr Output >>
I0930 20:39:31.540]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] subPath should support existing directory","completed":17,"skipped":2873,"failed":0}
I0930 20:39:31.540]   << End Captured StdOut/StdErr Output
I0930 20:39:31.541] ------------------------------
I0930 20:39:31.622] SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
I0930 20:39:31.623] ------------------------------
I0930 20:39:31.623] S [SKIPPED] [0.043 seconds]
I0930 20:39:31.623] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd]
... skipping 37 lines ...
I0930 20:39:31.633] ------------------------------
I0930 20:39:31.634] [SynchronizedAfterSuite] PASSED [0.000 seconds]
I0930 20:39:31.634] [SynchronizedAfterSuite] 
I0930 20:39:31.634] test/e2e/e2e.go:86
I0930 20:39:31.634] 
I0930 20:39:31.635]   Begin Captured StdOut/StdErr Output >>
I0930 20:39:31.635]     {"msg":"Test Suite completed","completed":17,"skipped":2953,"failed":0}
I0930 20:39:31.636]   << End Captured StdOut/StdErr Output
I0930 20:39:31.636] ------------------------------
I0930 20:40:11.045] • [SLOW TEST] [314.321 seconds]
I0930 20:40:11.045] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] subPath should support non-existent path
I0930 20:40:11.045] test/e2e/storage/testsuites/subpath.go:195
I0930 20:40:11.045] 
I0930 20:40:11.046]   Begin Captured StdOut/StdErr Output >>
I0930 20:40:11.046]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] subPath should support non-existent path","completed":17,"skipped":1824,"failed":1,"failures":["External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] volumes should store data"]}
I0930 20:40:11.047]   << End Captured StdOut/StdErr Output
I0930 20:40:11.047] ------------------------------
I0930 20:40:11.047] [SynchronizedAfterSuite] PASSED [0.000 seconds]
I0930 20:40:11.047] [SynchronizedAfterSuite] 
I0930 20:40:11.047] test/e2e/e2e.go:86
I0930 20:40:11.047] 
I0930 20:40:11.048]   Begin Captured StdOut/StdErr Output >>
I0930 20:40:11.048]     {"msg":"Test Suite completed","completed":17,"skipped":1824,"failed":1,"failures":["External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] volumes should store data"]}
I0930 20:40:11.048]   << End Captured StdOut/StdErr Output
I0930 20:40:11.048] ------------------------------
I0930 20:44:15.453] • [SLOW TEST] [460.748 seconds]
I0930 20:44:15.454] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Ephemeral Snapshot (retain policy)] snapshottable[Feature:VolumeSnapshotDataSource] volume snapshot controller  should check snapshot fields, check restore correctly works, check deletion (ephemeral)
I0930 20:44:15.455] test/e2e/storage/testsuites/snapshottable.go:176
I0930 20:44:15.455] 
I0930 20:44:15.455]   Begin Captured StdOut/StdErr Output >>
I0930 20:44:15.455]     {"msg":"PASSED External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Ephemeral Snapshot (retain policy)] snapshottable[Feature:VolumeSnapshotDataSource] volume snapshot controller  should check snapshot fields, check restore correctly works, check deletion (ephemeral)","completed":17,"skipped":2034,"failed":0}
I0930 20:44:15.456]   << End Captured StdOut/StdErr Output
I0930 20:44:15.456] ------------------------------
I0930 20:44:15.458] [SynchronizedAfterSuite] PASSED [0.001 seconds]
I0930 20:44:15.459] [SynchronizedAfterSuite] 
I0930 20:44:15.459] test/e2e/e2e.go:86
I0930 20:44:15.459] 
I0930 20:44:15.459]   Begin Captured StdOut/StdErr Output >>
I0930 20:44:15.459]     {"msg":"Test Suite completed","completed":17,"skipped":2034,"failed":0}
I0930 20:44:15.459]   << End Captured StdOut/StdErr Output
I0930 20:44:15.459] ------------------------------
I0930 20:44:15.757] 
I0930 20:44:15.758] 
I0930 20:44:15.758] Summarizing 1 Failure:
I0930 20:44:15.759]   [FAIL] External Storage [Driver: csi-gcpfs-fs-sc-basic-hdd] [Testpattern: Dynamic PV (default fs)] volumes [It] should store data
I0930 20:44:15.759]   test/e2e/storage/testsuites/volumes.go:188
I0930 20:44:15.759] 
I0930 20:44:15.774] Ran 52 of 6863 Specs in 7052.900 seconds
I0930 20:44:15.775] FAIL! -- 51 Passed | 1 Failed | 0 Pending | 6811 Skipped
I0930 20:44:15.786] 
I0930 20:44:15.786] 
I0930 20:44:15.787] Ginkgo ran 1 suite in 1h57m33.73442512s
I0930 20:44:15.787] 
I0930 20:44:15.787] Test Suite Failed
I0930 20:44:15.807] Deleting driver resources
I0930 20:44:15.808] [/go/src/sigs.k8s.io/gcp-filestore-csi-driver/deploy/kubernetes/cluster_cleanup.sh]
I0930 20:44:15.870] GOPATH is /go
W0930 20:44:15.972] Sep 30 18:46:42.263: INFO: Driver loaded from path [/go/src/sigs.k8s.io/gcp-filestore-csi-driver/test/k8s-integration/config/test-config.yaml]: &{DriverInfo:{Name:csi-gcpfs-fs-sc-basic-hdd InTreePluginName: FeatureTag: MaxFileSize:0 SupportedSizeRange:{Max:64Ti Min:1Ti} SupportedFsType:map[:{}] SupportedMountOption:map[] RequiredMountOption:map[] Capabilities:map[RWX:true controllerExpansion:true exec:true fsGroup:true multipods:true offlineExpansion:true onlineExpansion:true persistence:true snapshotDataSource:true] RequiredAccessModes:[] TopologyKeys:[] NumAllowedTopologies:0 StressTestOptions:0xc000cdb5e0 VolumeSnapshotStressTestOptions:<nil> PerformanceTestOptions:<nil>} StorageClass:{FromName:false FromFile:/go/src/sigs.k8s.io/gcp-filestore-csi-driver/test/k8s-integration/config/fs-sc-basic-hdd.yaml FromExistingClassName:} SnapshotClass:{FromName:false FromFile:/go/src/sigs.k8s.io/gcp-filestore-csi-driver/test/k8s-integration/config/fs-backup-volumesnapshotclass.yaml FromExistingClassName:} InlineVolumes:[] ClientNodeName: Timeouts:map[ClaimProvision:600s PVDelete:600s PodStart:600s]}
W0930 20:44:15.972] Sep 30 18:46:42.263: INFO: The --provider flag is not set. Continuing as if --provider=skeleton had been used.
W0930 20:44:15.972] I0930 18:46:42.264494  106878 e2e.go:124] Starting e2e run "94065896-d0f2-411e-8709-f2216ada42fa" on Ginkgo node 1
... skipping 15 lines ...
W0930 20:44:15.976]   --ginkgo.flakeAttempts is deprecated, use --ginkgo.flake-attempts instead
W0930 20:44:15.976]   Learn more at: https://onsi.github.io/ginkgo/MIGRATING_TO_V2#changed-command-line-flags
W0930 20:44:15.976] 
W0930 20:44:15.976] To silence deprecations that can be silenced set the following environment variable:
W0930 20:44:15.976]   ACK_GINKGO_DEPRECATIONS=2.2.0
W0930 20:44:15.976] 
W0930 20:44:15.976] --- FAIL: TestE2E (6808.82s)
W0930 20:44:15.976] FAIL
W0930 20:44:15.977] 
W0930 20:44:15.978] Sep 30 18:46:42.279: INFO: Driver loaded from path [/go/src/sigs.k8s.io/gcp-filestore-csi-driver/test/k8s-integration/config/test-config.yaml]: &{DriverInfo:{Name:csi-gcpfs-fs-sc-basic-hdd InTreePluginName: FeatureTag: MaxFileSize:0 SupportedSizeRange:{Max:64Ti Min:1Ti} SupportedFsType:map[:{}] SupportedMountOption:map[] RequiredMountOption:map[] Capabilities:map[RWX:true controllerExpansion:true exec:true fsGroup:true multipods:true offlineExpansion:true onlineExpansion:true persistence:true snapshotDataSource:true] RequiredAccessModes:[] TopologyKeys:[] NumAllowedTopologies:0 StressTestOptions:0xc00095e520 VolumeSnapshotStressTestOptions:<nil> PerformanceTestOptions:<nil>} StorageClass:{FromName:false FromFile:/go/src/sigs.k8s.io/gcp-filestore-csi-driver/test/k8s-integration/config/fs-sc-basic-hdd.yaml FromExistingClassName:} SnapshotClass:{FromName:false FromFile:/go/src/sigs.k8s.io/gcp-filestore-csi-driver/test/k8s-integration/config/fs-backup-volumesnapshotclass.yaml FromExistingClassName:} InlineVolumes:[] ClientNodeName: Timeouts:map[ClaimProvision:600s PVDelete:600s PodStart:600s]}
W0930 20:44:15.978] Sep 30 18:46:42.280: INFO: The --provider flag is not set. Continuing as if --provider=skeleton had been used.
W0930 20:44:15.978] I0930 18:46:42.280456  106881 e2e.go:124] Starting e2e run "c16b1c23-a769-417e-a04a-e71ac71b1e6f" on Ginkgo node 3
W0930 20:44:15.978] You're using deprecated Ginkgo functionality:
W0930 20:44:15.979] =============================================
... skipping 2 lines ...
W0930 20:44:15.979] 
W0930 20:44:15.979] To silence deprecations that can be silenced set the following environment variable:
W0930 20:44:15.979]   ACK_GINKGO_DEPRECATIONS=2.2.0
W0930 20:44:15.979] 
W0930 20:44:15.980] PASS
W0930 20:44:15.980] 
W0930 20:44:15.980] F0930 20:44:15.790161  106864 ginkgo.go:215] failed to run ginkgo tester: exit status 1
W0930 20:44:15.980] Error: exit status 255
I0930 20:44:17.166] namespace "gcp-filestore-csi-driver" deleted
I0930 20:44:17.172] serviceaccount "gcp-filestore-csi-controller-sa" deleted
I0930 20:44:17.178] serviceaccount "gcp-filestore-csi-node-sa" deleted
I0930 20:44:17.184] role.rbac.authorization.k8s.io "gcp-filestore-csi-leaderelection-role" deleted
I0930 20:44:17.197] clusterrole.rbac.authorization.k8s.io "gcp-filestore-csi-provisioner-role" deleted
I0930 20:44:17.206] clusterrole.rbac.authorization.k8s.io "gcp-filestore-csi-resizer-role" deleted
... skipping 6 lines ...
I0930 20:44:17.251] clusterrolebinding.rbac.authorization.k8s.io "gcp-filestore-csi-snapshotter-binding" deleted
I0930 20:44:17.257] priorityclass.scheduling.k8s.io "csi-gcp-fs-controller" deleted
I0930 20:44:17.262] priorityclass.scheduling.k8s.io "csi-gcp-fs-node" deleted
I0930 20:44:17.274] deployment.apps "gcp-filestore-csi-controller" deleted
I0930 20:44:17.284] daemonset.apps "gcp-filestore-csi-node" deleted
I0930 20:44:17.320] csidriver.storage.k8s.io "filestore.csi.storage.gke.io" deleted
W0930 20:45:02.335] Error from server (NotFound): namespaces "gcp-filestore-csi-driver" not found
W0930 20:45:02.409] Project: gce-cvm-upg-1-4-1-5-ctl-skew
W0930 20:45:02.410] Network Project: gce-cvm-upg-1-4-1-5-ctl-skew
W0930 20:45:02.410] Zone: us-central1-b
I0930 20:45:02.510] Bringing Down E2E Cluster on GCE
I0930 20:45:02.511] [/tmp/gcp-fs-driver-tmp1322601806/kubernetes/hack/e2e-internal/e2e-down.sh]
I0930 20:45:02.511] Shutting down test cluster in background.
... skipping 51 lines ...
W0930 20:52:48.257]   Associated tags:
W0930 20:52:48.258]  - 9389aaa0-efdd-4798-92a1-71e46af39ebf
W0930 20:52:48.258] Tags:
W0930 20:52:48.258] - gcr.io/gce-cvm-upg-1-4-1-5-ctl-skew/gcp-filestore-csi-driver:9389aaa0-efdd-4798-92a1-71e46af39ebf
W0930 20:52:48.412] Deleted [gcr.io/gce-cvm-upg-1-4-1-5-ctl-skew/gcp-filestore-csi-driver:9389aaa0-efdd-4798-92a1-71e46af39ebf].
W0930 20:52:49.033] Deleted [gcr.io/gce-cvm-upg-1-4-1-5-ctl-skew/gcp-filestore-csi-driver@sha256:fbade9540e46d30e6cddfddf954c62b6ed8bfe00759e06465c99d20095ebedd1].
W0930 20:52:50.314] F0930 20:52:50.314010    7077 main.go:179] Failed to run integration test: runCSITests failed: failed to run tests on e2e cluster: exit status 1
W0930 20:52:50.327] Traceback (most recent call last):
W0930 20:52:50.327]   File "/workspace/./test-infra/jenkins/../scenarios/execute.py", line 50, in <module>
W0930 20:52:50.331]     main(ARGS.env, ARGS.cmd + ARGS.args)
W0930 20:52:50.331]   File "/workspace/./test-infra/jenkins/../scenarios/execute.py", line 41, in main
W0930 20:52:50.331]     check(*cmd)
W0930 20:52:50.331]   File "/workspace/./test-infra/jenkins/../scenarios/execute.py", line 30, in check
W0930 20:52:50.332]     subprocess.check_call(cmd)
W0930 20:52:50.332]   File "/usr/lib/python2.7/subprocess.py", line 190, in check_call
W0930 20:52:50.333]     raise CalledProcessError(retcode, cmd)
W0930 20:52:50.335] subprocess.CalledProcessError: Command '('test/run-k8s-integration.sh',)' returned non-zero exit status 255
E0930 20:52:50.368] Command failed
I0930 20:52:50.369] process 623 exited with code 1 after 158.2m
E0930 20:52:50.371] FAIL: pull-gcp-filestore-csi-driver-kubernetes-integration
I0930 20:52:50.374] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0930 20:52:51.274] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0930 20:52:51.488] process 108342 exited with code 0 after 0.0m
I0930 20:52:51.489] Call:  gcloud config get-value account
I0930 20:52:52.464] process 108356 exited with code 0 after 0.0m
I0930 20:52:52.465] Will upload results to gs://kubernetes-jenkins/pr-logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0930 20:52:52.466] Upload result and artifacts...
I0930 20:52:52.467] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/pr-logs/pull/sigs.k8s.io_gcp-filestore-csi-driver/376/pull-gcp-filestore-csi-driver-kubernetes-integration/1575911930088919040
I0930 20:52:52.468] Call:  gsutil ls gs://kubernetes-jenkins/pr-logs/pull/sigs.k8s.io_gcp-filestore-csi-driver/376/pull-gcp-filestore-csi-driver-kubernetes-integration/1575911930088919040/artifacts
W0930 20:52:54.164] CommandException: One or more URLs matched no objects.
E0930 20:52:54.518] Command failed
I0930 20:52:54.518] process 108370 exited with code 1 after 0.0m
W0930 20:52:54.518] Remote dir gs://kubernetes-jenkins/pr-logs/pull/sigs.k8s.io_gcp-filestore-csi-driver/376/pull-gcp-filestore-csi-driver-kubernetes-integration/1575911930088919040/artifacts not exist yet
I0930 20:52:54.519] Call:  gsutil -m -q -o GSUtil:use_magicfile=True cp -r -c -z log,txt,xml /workspace/_artifacts gs://kubernetes-jenkins/pr-logs/pull/sigs.k8s.io_gcp-filestore-csi-driver/376/pull-gcp-filestore-csi-driver-kubernetes-integration/1575911930088919040/artifacts
I0930 20:52:58.929] process 108510 exited with code 0 after 0.1m
W0930 20:52:58.930] metadata path /workspace/_artifacts/metadata.json does not exist
W0930 20:52:58.930] metadata not found or invalid, init with empty metadata
... skipping 22 lines ...