This job view page is being replaced by Spyglass soon. Check out the new job view.
PRwongma7: Run chart releaser action from release branches only
ResultABORTED
Tests 0 failed / 57 succeeded
Started2021-04-28 22:30
Elapsed34m49s
Revision0ac0fe7345ee16b1e88df17d969607d62172c96b
Refs 859

No Test Failures!


Show 57 Passed Tests

Show 428 Skipped Tests

Error lines from build-log.txt

... skipping 788 lines ...
## Validating cluster test-cluster-8941.k8s.local
#
Using cluster from kubectl context: test-cluster-8941.k8s.local

Validating cluster test-cluster-8941.k8s.local

W0428 22:34:15.138599    9308 validate_cluster.go:173] (will retry): unexpected error during validation: error listing nodes: Get "https://api-test-cluster-8941-k8s-69l3dm-2056760439.us-west-2.elb.amazonaws.com/api/v1/nodes": dial tcp: lookup api-test-cluster-8941-k8s-69l3dm-2056760439.us-west-2.elb.amazonaws.com on 10.63.240.10:53: no such host
W0428 22:34:25.175112    9308 validate_cluster.go:173] (will retry): unexpected error during validation: error listing nodes: Get "https://api-test-cluster-8941-k8s-69l3dm-2056760439.us-west-2.elb.amazonaws.com/api/v1/nodes": dial tcp: lookup api-test-cluster-8941-k8s-69l3dm-2056760439.us-west-2.elb.amazonaws.com on 10.63.240.10:53: no such host
W0428 22:34:35.206404    9308 validate_cluster.go:173] (will retry): unexpected error during validation: error listing nodes: Get "https://api-test-cluster-8941-k8s-69l3dm-2056760439.us-west-2.elb.amazonaws.com/api/v1/nodes": dial tcp: lookup api-test-cluster-8941-k8s-69l3dm-2056760439.us-west-2.elb.amazonaws.com on 10.63.240.10:53: no such host
W0428 22:34:45.251863    9308 validate_cluster.go:173] (will retry): unexpected error during validation: error listing nodes: Get "https://api-test-cluster-8941-k8s-69l3dm-2056760439.us-west-2.elb.amazonaws.com/api/v1/nodes": dial tcp: lookup api-test-cluster-8941-k8s-69l3dm-2056760439.us-west-2.elb.amazonaws.com on 10.63.240.10:53: no such host
W0428 22:34:55.309415    9308 validate_cluster.go:173] (will retry): unexpected error during validation: error listing nodes: Get "https://api-test-cluster-8941-k8s-69l3dm-2056760439.us-west-2.elb.amazonaws.com/api/v1/nodes": dial tcp: lookup api-test-cluster-8941-k8s-69l3dm-2056760439.us-west-2.elb.amazonaws.com on 10.63.240.10:53: no such host
W0428 22:35:16.928315    9308 validate_cluster.go:173] (will retry): unexpected error during validation: error listing nodes: an error on the server ("") has prevented the request from succeeding (get nodes)
W0428 22:35:38.584246    9308 validate_cluster.go:173] (will retry): unexpected error during validation: error listing nodes: an error on the server ("") has prevented the request from succeeding (get nodes)
W0428 22:36:00.132278    9308 validate_cluster.go:173] (will retry): unexpected error during validation: error listing nodes: an error on the server ("") has prevented the request from succeeding (get nodes)
W0428 22:36:22.220044    9308 validate_cluster.go:173] (will retry): unexpected error during validation: error listing nodes: an error on the server ("") has prevented the request from succeeding (get nodes)
W0428 22:36:44.013027    9308 validate_cluster.go:173] (will retry): unexpected error during validation: error listing nodes: an error on the server ("") has prevented the request from succeeding (get nodes)
W0428 22:37:06.153206    9308 validate_cluster.go:173] (will retry): unexpected error during validation: error listing nodes: an error on the server ("") has prevented the request from succeeding (get nodes)
W0428 22:37:27.801537    9308 validate_cluster.go:173] (will retry): unexpected error during validation: error listing nodes: an error on the server ("") has prevented the request from succeeding (get nodes)
W0428 22:37:49.447982    9308 validate_cluster.go:173] (will retry): unexpected error during validation: error listing nodes: an error on the server ("") has prevented the request from succeeding (get nodes)
INSTANCE GROUPS
NAME			ROLE	MACHINETYPE	MIN	MAX	SUBNETS
master-us-west-2a	Master	t3.medium	1	1	us-west-2a
nodes-us-west-2a	Node	c4.large	3	3	us-west-2a

NODE STATUS
... skipping 3 lines ...
VALIDATION ERRORS
KIND	NAME			MESSAGE
Machine	i-012b05f6bda38aa83	machine "i-012b05f6bda38aa83" has not yet joined cluster
Machine	i-060876107af859686	machine "i-060876107af859686" has not yet joined cluster
Machine	i-063d2c0b6f068fd82	machine "i-063d2c0b6f068fd82" has not yet joined cluster

Validation Failed
W0428 22:38:06.965477    9308 validate_cluster.go:221] (will retry): cluster not yet healthy
INSTANCE GROUPS
NAME			ROLE	MACHINETYPE	MIN	MAX	SUBNETS
master-us-west-2a	Master	t3.medium	1	1	us-west-2a
nodes-us-west-2a	Node	c4.large	3	3	us-west-2a

... skipping 4 lines ...
VALIDATION ERRORS
KIND	NAME			MESSAGE
Machine	i-012b05f6bda38aa83	machine "i-012b05f6bda38aa83" has not yet joined cluster
Machine	i-060876107af859686	machine "i-060876107af859686" has not yet joined cluster
Machine	i-063d2c0b6f068fd82	machine "i-063d2c0b6f068fd82" has not yet joined cluster

Validation Failed
W0428 22:38:18.077095    9308 validate_cluster.go:221] (will retry): cluster not yet healthy
INSTANCE GROUPS
NAME			ROLE	MACHINETYPE	MIN	MAX	SUBNETS
master-us-west-2a	Master	t3.medium	1	1	us-west-2a
nodes-us-west-2a	Node	c4.large	3	3	us-west-2a

... skipping 8 lines ...
Machine	i-063d2c0b6f068fd82				machine "i-063d2c0b6f068fd82" has not yet joined cluster
Pod	kube-system/coredns-5489b75945-zlmrp		system-cluster-critical pod "coredns-5489b75945-zlmrp" is pending
Pod	kube-system/coredns-autoscaler-6f594f4c58-sp7kb	system-cluster-critical pod "coredns-autoscaler-6f594f4c58-sp7kb" is pending
Pod	kube-system/dns-controller-cd496f988-9xnvv	system-cluster-critical pod "dns-controller-cd496f988-9xnvv" is pending
Pod	kube-system/kops-controller-99x4c		system-node-critical pod "kops-controller-99x4c" is pending

Validation Failed
W0428 22:38:29.149624    9308 validate_cluster.go:221] (will retry): cluster not yet healthy
INSTANCE GROUPS
NAME			ROLE	MACHINETYPE	MIN	MAX	SUBNETS
master-us-west-2a	Master	t3.medium	1	1	us-west-2a
nodes-us-west-2a	Node	c4.large	3	3	us-west-2a

... skipping 7 lines ...
Machine	i-060876107af859686				machine "i-060876107af859686" has not yet joined cluster
Machine	i-063d2c0b6f068fd82				machine "i-063d2c0b6f068fd82" has not yet joined cluster
Node	ip-172-20-33-152.us-west-2.compute.internal	master "ip-172-20-33-152.us-west-2.compute.internal" is missing kube-controller-manager pod
Pod	kube-system/coredns-5489b75945-zlmrp		system-cluster-critical pod "coredns-5489b75945-zlmrp" is pending
Pod	kube-system/coredns-autoscaler-6f594f4c58-sp7kb	system-cluster-critical pod "coredns-autoscaler-6f594f4c58-sp7kb" is pending

Validation Failed
W0428 22:38:40.305960    9308 validate_cluster.go:221] (will retry): cluster not yet healthy
INSTANCE GROUPS
NAME			ROLE	MACHINETYPE	MIN	MAX	SUBNETS
master-us-west-2a	Master	t3.medium	1	1	us-west-2a
nodes-us-west-2a	Node	c4.large	3	3	us-west-2a

... skipping 11 lines ...
Node	ip-172-20-39-169.us-west-2.compute.internal				node "ip-172-20-39-169.us-west-2.compute.internal" is not ready
Pod	kube-system/coredns-5489b75945-zlmrp					system-cluster-critical pod "coredns-5489b75945-zlmrp" is pending
Pod	kube-system/coredns-autoscaler-6f594f4c58-sp7kb				system-cluster-critical pod "coredns-autoscaler-6f594f4c58-sp7kb" is pending
Pod	kube-system/kube-proxy-ip-172-20-38-81.us-west-2.compute.internal	system-node-critical pod "kube-proxy-ip-172-20-38-81.us-west-2.compute.internal" is pending
Pod	kube-system/kube-proxy-ip-172-20-39-169.us-west-2.compute.internal	system-node-critical pod "kube-proxy-ip-172-20-39-169.us-west-2.compute.internal" is pending

Validation Failed
W0428 22:38:51.431432    9308 validate_cluster.go:221] (will retry): cluster not yet healthy
INSTANCE GROUPS
NAME			ROLE	MACHINETYPE	MIN	MAX	SUBNETS
master-us-west-2a	Master	t3.medium	1	1	us-west-2a
nodes-us-west-2a	Node	c4.large	3	3	us-west-2a

... skipping 7 lines ...
VALIDATION ERRORS
KIND	NAME										MESSAGE
Node	ip-172-20-33-152.us-west-2.compute.internal					master "ip-172-20-33-152.us-west-2.compute.internal" is missing kube-controller-manager pod
Pod	kube-system/coredns-5489b75945-5w7md						system-cluster-critical pod "coredns-5489b75945-5w7md" is pending
Pod	kube-system/kube-controller-manager-ip-172-20-33-152.us-west-2.compute.internal	system-cluster-critical pod "kube-controller-manager-ip-172-20-33-152.us-west-2.compute.internal" is pending

Validation Failed
W0428 22:39:02.649671    9308 validate_cluster.go:221] (will retry): cluster not yet healthy
INSTANCE GROUPS
NAME			ROLE	MACHINETYPE	MIN	MAX	SUBNETS
master-us-west-2a	Master	t3.medium	1	1	us-west-2a
nodes-us-west-2a	Node	c4.large	3	3	us-west-2a

... skipping 5 lines ...
ip-172-20-54-212.us-west-2.compute.internal	node	True

VALIDATION ERRORS
KIND	NAME									MESSAGE
Pod	kube-system/kube-proxy-ip-172-20-33-152.us-west-2.compute.internal	system-node-critical pod "kube-proxy-ip-172-20-33-152.us-west-2.compute.internal" is pending

Validation Failed
W0428 22:39:13.934693    9308 validate_cluster.go:221] (will retry): cluster not yet healthy
INSTANCE GROUPS
NAME			ROLE	MACHINETYPE	MIN	MAX	SUBNETS
master-us-west-2a	Master	t3.medium	1	1	us-west-2a
nodes-us-west-2a	Node	c4.large	3	3	us-west-2a

... skipping 215 lines ...
Apr 28 22:41:20.065: INFO: Using claimSize:1Gi, test suite supported size:{ 1Mi}, driver(ebs.csi.aws.com) supported size:{ 1Mi} 
STEP: creating a StorageClass volume-286-e2e-scf6kms
STEP: creating a claim
Apr 28 22:41:20.127: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
STEP: Creating pod exec-volume-test-dynamicpv-qwk4
STEP: Creating a pod to test exec-volume-test
Apr 28 22:41:20.314: INFO: Waiting up to 5m0s for pod "exec-volume-test-dynamicpv-qwk4" in namespace "volume-286" to be "Succeeded or Failed"
Apr 28 22:41:20.377: INFO: Pod "exec-volume-test-dynamicpv-qwk4": Phase="Pending", Reason="", readiness=false. Elapsed: 63.848479ms
Apr 28 22:41:22.438: INFO: Pod "exec-volume-test-dynamicpv-qwk4": Phase="Pending", Reason="", readiness=false. Elapsed: 2.12476701s
Apr 28 22:41:24.500: INFO: Pod "exec-volume-test-dynamicpv-qwk4": Phase="Pending", Reason="", readiness=false. Elapsed: 4.186000747s
Apr 28 22:41:26.561: INFO: Pod "exec-volume-test-dynamicpv-qwk4": Phase="Pending", Reason="", readiness=false. Elapsed: 6.247337742s
Apr 28 22:41:28.622: INFO: Pod "exec-volume-test-dynamicpv-qwk4": Phase="Pending", Reason="", readiness=false. Elapsed: 8.308194743s
Apr 28 22:41:30.683: INFO: Pod "exec-volume-test-dynamicpv-qwk4": Phase="Pending", Reason="", readiness=false. Elapsed: 10.369642919s
... skipping 3 lines ...
Apr 28 22:41:38.932: INFO: Pod "exec-volume-test-dynamicpv-qwk4": Phase="Pending", Reason="", readiness=false. Elapsed: 18.617953076s
Apr 28 22:41:40.992: INFO: Pod "exec-volume-test-dynamicpv-qwk4": Phase="Pending", Reason="", readiness=false. Elapsed: 20.678706964s
Apr 28 22:41:43.065: INFO: Pod "exec-volume-test-dynamicpv-qwk4": Phase="Pending", Reason="", readiness=false. Elapsed: 22.751060974s
Apr 28 22:41:45.125: INFO: Pod "exec-volume-test-dynamicpv-qwk4": Phase="Pending", Reason="", readiness=false. Elapsed: 24.811655605s
Apr 28 22:41:47.187: INFO: Pod "exec-volume-test-dynamicpv-qwk4": Phase="Succeeded", Reason="", readiness=false. Elapsed: 26.873558927s
STEP: Saw pod success
Apr 28 22:41:47.187: INFO: Pod "exec-volume-test-dynamicpv-qwk4" satisfied condition "Succeeded or Failed"
Apr 28 22:41:47.248: INFO: Trying to get logs from node ip-172-20-38-81.us-west-2.compute.internal pod exec-volume-test-dynamicpv-qwk4 container exec-container-dynamicpv-qwk4: <nil>
STEP: delete the pod
Apr 28 22:41:47.379: INFO: Waiting for pod exec-volume-test-dynamicpv-qwk4 to disappear
Apr 28 22:41:47.439: INFO: Pod exec-volume-test-dynamicpv-qwk4 no longer exists
STEP: Deleting pod exec-volume-test-dynamicpv-qwk4
Apr 28 22:41:47.439: INFO: Deleting pod "exec-volume-test-dynamicpv-qwk4" in namespace "volume-286"
... skipping 30 lines ...

S [SKIPPING] in Spec Setup (BeforeEach) [0.001 seconds]
External Storage [Driver: ebs.csi.aws.com]
/home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/external/external.go:175
  [Testpattern: Inline-volume (default fs)] subPath
  /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should fail if subpath with backstepping is outside the volume [Slow][LinuxOnly] [BeforeEach]
    /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:278

    Driver "ebs.csi.aws.com" does not support volume type "InlineVolume" - skipping

    /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/external/external.go:255
------------------------------
... skipping 27 lines ...

S [SKIPPING] in Spec Setup (BeforeEach) [0.001 seconds]
External Storage [Driver: ebs.csi.aws.com]
/home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/external/external.go:175
  [Testpattern: Dynamic PV (ntfs)][Feature:Windows] subPath
  /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should fail if subpath file is outside the volume [Slow][LinuxOnly] [BeforeEach]
    /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:256

    Driver ebs.csi.aws.com doesn't support ntfs -- skipping

    /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:121
------------------------------
... skipping 6 lines ...

S [SKIPPING] in Spec Setup (BeforeEach) [0.001 seconds]
External Storage [Driver: ebs.csi.aws.com]
/home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/external/external.go:175
  [Testpattern: Pre-provisioned PV (default fs)] subPath
  /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should fail if non-existent subpath is outside the volume [Slow][LinuxOnly] [BeforeEach]
    /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:267

    Driver "ebs.csi.aws.com" does not support volume type "PreprovisionedPV" - skipping

    /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/external/external.go:255
------------------------------
... skipping 256 lines ...

S [SKIPPING] in Spec Setup (BeforeEach) [0.001 seconds]
External Storage [Driver: ebs.csi.aws.com]
/home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/external/external.go:175
  [Testpattern: Pre-provisioned PV (default fs)] subPath
  /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should fail if subpath with backstepping is outside the volume [Slow][LinuxOnly] [BeforeEach]
    /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:278

    Driver "ebs.csi.aws.com" does not support volume type "PreprovisionedPV" - skipping

    /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/external/external.go:255
------------------------------
... skipping 46 lines ...
Apr 28 22:42:03.983: INFO: Using claimSize:1Gi, test suite supported size:{ 1Mi}, driver(ebs.csi.aws.com) supported size:{ 1Mi} 
STEP: creating a StorageClass provisioning-3743-e2e-scwfrh2
STEP: creating a claim
Apr 28 22:42:04.045: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
STEP: Creating pod pod-subpath-test-dynamicpv-wp9h
STEP: Creating a pod to test subpath
Apr 28 22:42:04.231: INFO: Waiting up to 5m0s for pod "pod-subpath-test-dynamicpv-wp9h" in namespace "provisioning-3743" to be "Succeeded or Failed"
Apr 28 22:42:04.292: INFO: Pod "pod-subpath-test-dynamicpv-wp9h": Phase="Pending", Reason="", readiness=false. Elapsed: 60.139586ms
Apr 28 22:42:06.352: INFO: Pod "pod-subpath-test-dynamicpv-wp9h": Phase="Pending", Reason="", readiness=false. Elapsed: 2.120852902s
Apr 28 22:42:08.414: INFO: Pod "pod-subpath-test-dynamicpv-wp9h": Phase="Pending", Reason="", readiness=false. Elapsed: 4.182108234s
Apr 28 22:42:10.474: INFO: Pod "pod-subpath-test-dynamicpv-wp9h": Phase="Pending", Reason="", readiness=false. Elapsed: 6.242780147s
Apr 28 22:42:12.535: INFO: Pod "pod-subpath-test-dynamicpv-wp9h": Phase="Pending", Reason="", readiness=false. Elapsed: 8.303729889s
Apr 28 22:42:14.596: INFO: Pod "pod-subpath-test-dynamicpv-wp9h": Phase="Pending", Reason="", readiness=false. Elapsed: 10.36497632s
Apr 28 22:42:16.658: INFO: Pod "pod-subpath-test-dynamicpv-wp9h": Phase="Pending", Reason="", readiness=false. Elapsed: 12.426117645s
Apr 28 22:42:18.718: INFO: Pod "pod-subpath-test-dynamicpv-wp9h": Phase="Pending", Reason="", readiness=false. Elapsed: 14.487053282s
Apr 28 22:42:20.780: INFO: Pod "pod-subpath-test-dynamicpv-wp9h": Phase="Pending", Reason="", readiness=false. Elapsed: 16.548484656s
Apr 28 22:42:22.841: INFO: Pod "pod-subpath-test-dynamicpv-wp9h": Phase="Pending", Reason="", readiness=false. Elapsed: 18.60994118s
Apr 28 22:42:24.903: INFO: Pod "pod-subpath-test-dynamicpv-wp9h": Phase="Succeeded", Reason="", readiness=false. Elapsed: 20.672060983s
STEP: Saw pod success
Apr 28 22:42:24.904: INFO: Pod "pod-subpath-test-dynamicpv-wp9h" satisfied condition "Succeeded or Failed"
Apr 28 22:42:24.967: INFO: Trying to get logs from node ip-172-20-38-81.us-west-2.compute.internal pod pod-subpath-test-dynamicpv-wp9h container test-container-volume-dynamicpv-wp9h: <nil>
STEP: delete the pod
Apr 28 22:42:25.103: INFO: Waiting for pod pod-subpath-test-dynamicpv-wp9h to disappear
Apr 28 22:42:25.162: INFO: Pod pod-subpath-test-dynamicpv-wp9h no longer exists
STEP: Deleting pod pod-subpath-test-dynamicpv-wp9h
Apr 28 22:42:25.163: INFO: Deleting pod "pod-subpath-test-dynamicpv-wp9h" in namespace "provisioning-3743"
... skipping 207 lines ...
Apr 28 22:42:21.510: INFO: Creating resource for dynamic PV
Apr 28 22:42:21.510: INFO: Using claimSize:1Gi, test suite supported size:{ 1Mi}, driver(ebs.csi.aws.com) supported size:{ 1Mi} 
STEP: creating a StorageClass provisioning-3403-e2e-sc6vxg4
STEP: creating a claim
Apr 28 22:42:21.572: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
STEP: Creating pod to format volume volume-prep-provisioning-3403
Apr 28 22:42:21.791: INFO: Waiting up to 5m0s for pod "volume-prep-provisioning-3403" in namespace "provisioning-3403" to be "Succeeded or Failed"
Apr 28 22:42:21.853: INFO: Pod "volume-prep-provisioning-3403": Phase="Pending", Reason="", readiness=false. Elapsed: 61.594708ms
Apr 28 22:42:23.915: INFO: Pod "volume-prep-provisioning-3403": Phase="Pending", Reason="", readiness=false. Elapsed: 2.123362923s
Apr 28 22:42:25.977: INFO: Pod "volume-prep-provisioning-3403": Phase="Pending", Reason="", readiness=false. Elapsed: 4.185476651s
Apr 28 22:42:28.056: INFO: Pod "volume-prep-provisioning-3403": Phase="Pending", Reason="", readiness=false. Elapsed: 6.264909413s
Apr 28 22:42:30.119: INFO: Pod "volume-prep-provisioning-3403": Phase="Pending", Reason="", readiness=false. Elapsed: 8.327767898s
Apr 28 22:42:32.183: INFO: Pod "volume-prep-provisioning-3403": Phase="Pending", Reason="", readiness=false. Elapsed: 10.391996789s
Apr 28 22:42:34.247: INFO: Pod "volume-prep-provisioning-3403": Phase="Pending", Reason="", readiness=false. Elapsed: 12.456135194s
Apr 28 22:42:36.309: INFO: Pod "volume-prep-provisioning-3403": Phase="Pending", Reason="", readiness=false. Elapsed: 14.517886278s
Apr 28 22:42:38.372: INFO: Pod "volume-prep-provisioning-3403": Phase="Pending", Reason="", readiness=false. Elapsed: 16.581125358s
Apr 28 22:42:40.436: INFO: Pod "volume-prep-provisioning-3403": Phase="Pending", Reason="", readiness=false. Elapsed: 18.644915946s
Apr 28 22:42:42.498: INFO: Pod "volume-prep-provisioning-3403": Phase="Pending", Reason="", readiness=false. Elapsed: 20.706972003s
Apr 28 22:42:44.560: INFO: Pod "volume-prep-provisioning-3403": Phase="Succeeded", Reason="", readiness=false. Elapsed: 22.768967112s
STEP: Saw pod success
Apr 28 22:42:44.560: INFO: Pod "volume-prep-provisioning-3403" satisfied condition "Succeeded or Failed"
Apr 28 22:42:44.560: INFO: Deleting pod "volume-prep-provisioning-3403" in namespace "provisioning-3403"
Apr 28 22:42:44.627: INFO: Wait up to 5m0s for pod "volume-prep-provisioning-3403" to be fully deleted
STEP: Creating pod pod-subpath-test-dynamicpv-4g5v
STEP: Checking for subpath error in container status
Apr 28 22:42:48.874: INFO: Deleting pod "pod-subpath-test-dynamicpv-4g5v" in namespace "provisioning-3403"
Apr 28 22:42:48.947: INFO: Wait up to 5m0s for pod "pod-subpath-test-dynamicpv-4g5v" to be fully deleted
STEP: Deleting pod
Apr 28 22:42:49.008: INFO: Deleting pod "pod-subpath-test-dynamicpv-4g5v" in namespace "provisioning-3403"
STEP: Deleting pvc
Apr 28 22:42:49.192: INFO: Deleting PersistentVolumeClaim "ebs.csi.aws.com6qj2h"
... skipping 26 lines ...

S [SKIPPING] in Spec Setup (BeforeEach) [0.001 seconds]
External Storage [Driver: ebs.csi.aws.com]
/home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/external/external.go:175
  [Testpattern: Dynamic PV (delayed binding)] topology
  /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should fail to schedule a pod which has topologies that conflict with AllowedTopologies [BeforeEach]
    /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/topology.go:192

    Driver "ebs.csi.aws.com" does not support topology - skipping

    /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/topology.go:92
------------------------------
... skipping 17 lines ...
Apr 28 22:42:38.437: INFO: Using claimSize:1Gi, test suite supported size:{ 1Mi}, driver(ebs.csi.aws.com) supported size:{ 1Mi} 
STEP: creating a StorageClass volume-8734-e2e-scjlnjh
STEP: creating a claim
Apr 28 22:42:38.501: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
STEP: Creating pod exec-volume-test-dynamicpv-gb59
STEP: Creating a pod to test exec-volume-test
Apr 28 22:42:38.694: INFO: Waiting up to 5m0s for pod "exec-volume-test-dynamicpv-gb59" in namespace "volume-8734" to be "Succeeded or Failed"
Apr 28 22:42:38.758: INFO: Pod "exec-volume-test-dynamicpv-gb59": Phase="Pending", Reason="", readiness=false. Elapsed: 63.43382ms
Apr 28 22:42:40.822: INFO: Pod "exec-volume-test-dynamicpv-gb59": Phase="Pending", Reason="", readiness=false. Elapsed: 2.127102362s
Apr 28 22:42:42.888: INFO: Pod "exec-volume-test-dynamicpv-gb59": Phase="Pending", Reason="", readiness=false. Elapsed: 4.193120899s
Apr 28 22:42:44.953: INFO: Pod "exec-volume-test-dynamicpv-gb59": Phase="Pending", Reason="", readiness=false. Elapsed: 6.258129739s
Apr 28 22:42:47.017: INFO: Pod "exec-volume-test-dynamicpv-gb59": Phase="Pending", Reason="", readiness=false. Elapsed: 8.322426593s
Apr 28 22:42:49.082: INFO: Pod "exec-volume-test-dynamicpv-gb59": Phase="Pending", Reason="", readiness=false. Elapsed: 10.387819673s
Apr 28 22:42:51.147: INFO: Pod "exec-volume-test-dynamicpv-gb59": Phase="Succeeded", Reason="", readiness=false. Elapsed: 12.452405905s
STEP: Saw pod success
Apr 28 22:42:51.147: INFO: Pod "exec-volume-test-dynamicpv-gb59" satisfied condition "Succeeded or Failed"
Apr 28 22:42:51.211: INFO: Trying to get logs from node ip-172-20-38-81.us-west-2.compute.internal pod exec-volume-test-dynamicpv-gb59 container exec-container-dynamicpv-gb59: <nil>
STEP: delete the pod
Apr 28 22:42:51.348: INFO: Waiting for pod exec-volume-test-dynamicpv-gb59 to disappear
Apr 28 22:42:51.444: INFO: Pod exec-volume-test-dynamicpv-gb59 no longer exists
STEP: Deleting pod exec-volume-test-dynamicpv-gb59
Apr 28 22:42:51.444: INFO: Deleting pod "exec-volume-test-dynamicpv-gb59" in namespace "volume-8734"
... skipping 41 lines ...
Apr 28 22:43:05.004: INFO: Using claimSize:1Gi, test suite supported size:{ 1Mi}, driver(ebs.csi.aws.com) supported size:{ 1Mi} 
STEP: creating a StorageClass volume-6570-e2e-scj6prj
STEP: creating a claim
Apr 28 22:43:05.066: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
STEP: Creating pod exec-volume-test-dynamicpv-bmds
STEP: Creating a pod to test exec-volume-test
Apr 28 22:43:05.258: INFO: Waiting up to 5m0s for pod "exec-volume-test-dynamicpv-bmds" in namespace "volume-6570" to be "Succeeded or Failed"
Apr 28 22:43:05.319: INFO: Pod "exec-volume-test-dynamicpv-bmds": Phase="Pending", Reason="", readiness=false. Elapsed: 60.850856ms
Apr 28 22:43:07.381: INFO: Pod "exec-volume-test-dynamicpv-bmds": Phase="Pending", Reason="", readiness=false. Elapsed: 2.122569707s
Apr 28 22:43:09.443: INFO: Pod "exec-volume-test-dynamicpv-bmds": Phase="Pending", Reason="", readiness=false. Elapsed: 4.185399461s
Apr 28 22:43:11.516: INFO: Pod "exec-volume-test-dynamicpv-bmds": Phase="Pending", Reason="", readiness=false. Elapsed: 6.258364823s
Apr 28 22:43:13.579: INFO: Pod "exec-volume-test-dynamicpv-bmds": Phase="Pending", Reason="", readiness=false. Elapsed: 8.320609138s
Apr 28 22:43:15.641: INFO: Pod "exec-volume-test-dynamicpv-bmds": Phase="Pending", Reason="", readiness=false. Elapsed: 10.38339849s
Apr 28 22:43:17.704: INFO: Pod "exec-volume-test-dynamicpv-bmds": Phase="Pending", Reason="", readiness=false. Elapsed: 12.446233588s
Apr 28 22:43:19.767: INFO: Pod "exec-volume-test-dynamicpv-bmds": Phase="Succeeded", Reason="", readiness=false. Elapsed: 14.508926569s
STEP: Saw pod success
Apr 28 22:43:19.767: INFO: Pod "exec-volume-test-dynamicpv-bmds" satisfied condition "Succeeded or Failed"
Apr 28 22:43:19.828: INFO: Trying to get logs from node ip-172-20-38-81.us-west-2.compute.internal pod exec-volume-test-dynamicpv-bmds container exec-container-dynamicpv-bmds: <nil>
STEP: delete the pod
Apr 28 22:43:19.960: INFO: Waiting for pod exec-volume-test-dynamicpv-bmds to disappear
Apr 28 22:43:20.021: INFO: Pod exec-volume-test-dynamicpv-bmds no longer exists
STEP: Deleting pod exec-volume-test-dynamicpv-bmds
Apr 28 22:43:20.021: INFO: Deleting pod "exec-volume-test-dynamicpv-bmds" in namespace "volume-6570"
... skipping 116 lines ...
Apr 28 22:41:20.629: INFO: Creating resource for dynamic PV
Apr 28 22:41:20.629: INFO: Using claimSize:1Gi, test suite supported size:{ 1Mi}, driver(ebs.csi.aws.com) supported size:{ 1Mi} 
STEP: creating a StorageClass snapshotting-9430-e2e-sc9gjwg
STEP: creating a claim
Apr 28 22:41:20.711: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
STEP: [init] starting a pod to use the claim
Apr 28 22:41:20.907: INFO: Waiting up to 15m0s for pod "pvc-snapshottable-tester-b9ns4" in namespace "snapshotting-9430" to be "Succeeded or Failed"
Apr 28 22:41:20.970: INFO: Pod "pvc-snapshottable-tester-b9ns4": Phase="Pending", Reason="", readiness=false. Elapsed: 63.381477ms
Apr 28 22:41:23.035: INFO: Pod "pvc-snapshottable-tester-b9ns4": Phase="Pending", Reason="", readiness=false. Elapsed: 2.128460383s
Apr 28 22:41:25.100: INFO: Pod "pvc-snapshottable-tester-b9ns4": Phase="Pending", Reason="", readiness=false. Elapsed: 4.192572785s
Apr 28 22:41:27.167: INFO: Pod "pvc-snapshottable-tester-b9ns4": Phase="Pending", Reason="", readiness=false. Elapsed: 6.259832398s
Apr 28 22:41:29.231: INFO: Pod "pvc-snapshottable-tester-b9ns4": Phase="Pending", Reason="", readiness=false. Elapsed: 8.324489237s
Apr 28 22:41:31.296: INFO: Pod "pvc-snapshottable-tester-b9ns4": Phase="Pending", Reason="", readiness=false. Elapsed: 10.388626896s
Apr 28 22:41:33.361: INFO: Pod "pvc-snapshottable-tester-b9ns4": Phase="Pending", Reason="", readiness=false. Elapsed: 12.454057928s
Apr 28 22:41:35.426: INFO: Pod "pvc-snapshottable-tester-b9ns4": Phase="Pending", Reason="", readiness=false. Elapsed: 14.518563011s
Apr 28 22:41:37.498: INFO: Pod "pvc-snapshottable-tester-b9ns4": Phase="Pending", Reason="", readiness=false. Elapsed: 16.590528277s
Apr 28 22:41:39.561: INFO: Pod "pvc-snapshottable-tester-b9ns4": Phase="Succeeded", Reason="", readiness=false. Elapsed: 18.654287621s
STEP: Saw pod success
Apr 28 22:41:39.561: INFO: Pod "pvc-snapshottable-tester-b9ns4" satisfied condition "Succeeded or Failed"
Apr 28 22:41:39.706: INFO: Pod pvc-snapshottable-tester-b9ns4 has the following logs: 
Apr 28 22:41:39.706: INFO: Deleting pod "pvc-snapshottable-tester-b9ns4" in namespace "snapshotting-9430"
Apr 28 22:41:39.778: INFO: Wait up to 5m0s for pod "pvc-snapshottable-tester-b9ns4" to be fully deleted
Apr 28 22:41:39.842: INFO: Waiting up to timeout=5m0s for PersistentVolumeClaims [ebs.csi.aws.com8tn5q] to have phase Bound
Apr 28 22:41:39.905: INFO: PersistentVolumeClaim ebs.csi.aws.com8tn5q found and phase=Bound (63.18487ms)
STEP: [init] checking the claim
... skipping 54 lines ...
[It] should check snapshot fields, check restore correctly works after modifying source data, check deletion
  /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/snapshottable.go:243
STEP: checking the snapshot
STEP: checking the SnapshotContent
STEP: Modifying source data test
STEP: modifying the data in the source PVC
Apr 28 22:42:35.016: INFO: Waiting up to 15m0s for pod "pvc-snapshottable-data-tester-9m7tb" in namespace "snapshotting-9430" to be "Succeeded or Failed"
Apr 28 22:42:35.079: INFO: Pod "pvc-snapshottable-data-tester-9m7tb": Phase="Pending", Reason="", readiness=false. Elapsed: 63.610996ms
Apr 28 22:42:37.149: INFO: Pod "pvc-snapshottable-data-tester-9m7tb": Phase="Pending", Reason="", readiness=false. Elapsed: 2.13295909s
Apr 28 22:42:39.213: INFO: Pod "pvc-snapshottable-data-tester-9m7tb": Phase="Pending", Reason="", readiness=false. Elapsed: 4.19765669s
Apr 28 22:42:41.277: INFO: Pod "pvc-snapshottable-data-tester-9m7tb": Phase="Pending", Reason="", readiness=false. Elapsed: 6.261657936s
Apr 28 22:42:43.342: INFO: Pod "pvc-snapshottable-data-tester-9m7tb": Phase="Pending", Reason="", readiness=false. Elapsed: 8.326385003s
Apr 28 22:42:45.406: INFO: Pod "pvc-snapshottable-data-tester-9m7tb": Phase="Succeeded", Reason="", readiness=false. Elapsed: 10.390379782s
STEP: Saw pod success
Apr 28 22:42:45.406: INFO: Pod "pvc-snapshottable-data-tester-9m7tb" satisfied condition "Succeeded or Failed"
Apr 28 22:42:45.534: INFO: Pod pvc-snapshottable-data-tester-9m7tb has the following logs: 
Apr 28 22:42:45.534: INFO: Deleting pod "pvc-snapshottable-data-tester-9m7tb" in namespace "snapshotting-9430"
Apr 28 22:42:45.603: INFO: Wait up to 5m0s for pod "pvc-snapshottable-data-tester-9m7tb" to be fully deleted
STEP: creating a pvc from the snapshot
STEP: starting a pod to use the claim
Apr 28 22:42:59.925: INFO: Running '/usr/local/bin/kubectl --server=https://api-test-cluster-8941-k8s-69l3dm-2056760439.us-west-2.elb.amazonaws.com --kubeconfig=/root/.kube/config --namespace=snapshotting-9430 exec restored-pvc-tester-4zvx6 --namespace=snapshotting-9430 -- cat /mnt/test/data'
... skipping 201 lines ...
Apr 28 22:43:27.749: INFO: Using claimSize:1Gi, test suite supported size:{ 1Mi}, driver(ebs.csi.aws.com) supported size:{ 1Mi} 
STEP: creating a StorageClass provisioning-6673-e2e-sckvjdx
STEP: creating a claim
Apr 28 22:43:27.813: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
STEP: Creating pod pod-subpath-test-dynamicpv-vb9w
STEP: Creating a pod to test subpath
Apr 28 22:43:28.009: INFO: Waiting up to 5m0s for pod "pod-subpath-test-dynamicpv-vb9w" in namespace "provisioning-6673" to be "Succeeded or Failed"
Apr 28 22:43:28.074: INFO: Pod "pod-subpath-test-dynamicpv-vb9w": Phase="Pending", Reason="", readiness=false. Elapsed: 65.356122ms
Apr 28 22:43:30.138: INFO: Pod "pod-subpath-test-dynamicpv-vb9w": Phase="Pending", Reason="", readiness=false. Elapsed: 2.1296309s
Apr 28 22:43:32.203: INFO: Pod "pod-subpath-test-dynamicpv-vb9w": Phase="Pending", Reason="", readiness=false. Elapsed: 4.194444659s
Apr 28 22:43:34.269: INFO: Pod "pod-subpath-test-dynamicpv-vb9w": Phase="Pending", Reason="", readiness=false. Elapsed: 6.260646293s
Apr 28 22:43:36.334: INFO: Pod "pod-subpath-test-dynamicpv-vb9w": Phase="Pending", Reason="", readiness=false. Elapsed: 8.325583632s
Apr 28 22:43:38.399: INFO: Pod "pod-subpath-test-dynamicpv-vb9w": Phase="Pending", Reason="", readiness=false. Elapsed: 10.390177188s
Apr 28 22:43:40.465: INFO: Pod "pod-subpath-test-dynamicpv-vb9w": Phase="Pending", Reason="", readiness=false. Elapsed: 12.456777593s
Apr 28 22:43:42.530: INFO: Pod "pod-subpath-test-dynamicpv-vb9w": Phase="Pending", Reason="", readiness=false. Elapsed: 14.521366768s
Apr 28 22:43:44.595: INFO: Pod "pod-subpath-test-dynamicpv-vb9w": Phase="Succeeded", Reason="", readiness=false. Elapsed: 16.585909345s
STEP: Saw pod success
Apr 28 22:43:44.595: INFO: Pod "pod-subpath-test-dynamicpv-vb9w" satisfied condition "Succeeded or Failed"
Apr 28 22:43:44.658: INFO: Trying to get logs from node ip-172-20-38-81.us-west-2.compute.internal pod pod-subpath-test-dynamicpv-vb9w container test-container-subpath-dynamicpv-vb9w: <nil>
STEP: delete the pod
Apr 28 22:43:44.796: INFO: Waiting for pod pod-subpath-test-dynamicpv-vb9w to disappear
Apr 28 22:43:44.867: INFO: Pod pod-subpath-test-dynamicpv-vb9w no longer exists
STEP: Deleting pod pod-subpath-test-dynamicpv-vb9w
Apr 28 22:43:44.867: INFO: Deleting pod "pod-subpath-test-dynamicpv-vb9w" in namespace "provisioning-6673"
STEP: Creating pod pod-subpath-test-dynamicpv-vb9w
STEP: Creating a pod to test subpath
Apr 28 22:43:44.994: INFO: Waiting up to 5m0s for pod "pod-subpath-test-dynamicpv-vb9w" in namespace "provisioning-6673" to be "Succeeded or Failed"
Apr 28 22:43:45.057: INFO: Pod "pod-subpath-test-dynamicpv-vb9w": Phase="Pending", Reason="", readiness=false. Elapsed: 62.97552ms
Apr 28 22:43:47.121: INFO: Pod "pod-subpath-test-dynamicpv-vb9w": Phase="Succeeded", Reason="", readiness=false. Elapsed: 2.127293629s
STEP: Saw pod success
Apr 28 22:43:47.121: INFO: Pod "pod-subpath-test-dynamicpv-vb9w" satisfied condition "Succeeded or Failed"
Apr 28 22:43:47.185: INFO: Trying to get logs from node ip-172-20-38-81.us-west-2.compute.internal pod pod-subpath-test-dynamicpv-vb9w container test-container-subpath-dynamicpv-vb9w: <nil>
STEP: delete the pod
Apr 28 22:43:47.346: INFO: Waiting for pod pod-subpath-test-dynamicpv-vb9w to disappear
Apr 28 22:43:47.409: INFO: Pod pod-subpath-test-dynamicpv-vb9w no longer exists
STEP: Deleting pod pod-subpath-test-dynamicpv-vb9w
Apr 28 22:43:47.409: INFO: Deleting pod "pod-subpath-test-dynamicpv-vb9w" in namespace "provisioning-6673"
... skipping 30 lines ...

S [SKIPPING] in Spec Setup (BeforeEach) [0.001 seconds]
External Storage [Driver: ebs.csi.aws.com]
/home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/external/external.go:175
  [Testpattern: Inline-volume (default fs)] subPath
  /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should fail if subpath directory is outside the volume [Slow][LinuxOnly] [BeforeEach]
    /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:240

    Driver "ebs.csi.aws.com" does not support volume type "InlineVolume" - skipping

    /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/external/external.go:255
------------------------------
... skipping 567 lines ...

    Driver "ebs.csi.aws.com" does not support cloning - skipping

    /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/provisioning.go:269
------------------------------
External Storage [Driver: ebs.csi.aws.com] [Testpattern: Dynamic PV (default fs)] subPath 
  should fail if non-existent subpath is outside the volume [Slow][LinuxOnly]
  /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:267

[BeforeEach] [Testpattern: Dynamic PV (default fs)] subPath
  /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:51
[BeforeEach] [Testpattern: Dynamic PV (default fs)] subPath
  /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:185
STEP: Creating a kubernetes client
Apr 28 22:44:05.208: INFO: >>> kubeConfig: /root/.kube/config
STEP: Building a namespace api object, basename provisioning
STEP: Waiting for a default service account to be provisioned in namespace
[It] should fail if non-existent subpath is outside the volume [Slow][LinuxOnly]
  /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:267
Apr 28 22:44:05.524: INFO: Creating resource for dynamic PV
Apr 28 22:44:05.524: INFO: Using claimSize:1Gi, test suite supported size:{ 1Mi}, driver(ebs.csi.aws.com) supported size:{ 1Mi} 
STEP: creating a StorageClass provisioning-2742-e2e-scj8pnk
STEP: creating a claim
Apr 28 22:44:05.588: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
STEP: Creating pod pod-subpath-test-dynamicpv-zq6k
STEP: Checking for subpath error in container status
Apr 28 22:44:19.911: INFO: Deleting pod "pod-subpath-test-dynamicpv-zq6k" in namespace "provisioning-2742"
Apr 28 22:44:19.982: INFO: Wait up to 5m0s for pod "pod-subpath-test-dynamicpv-zq6k" to be fully deleted
STEP: Deleting pod
Apr 28 22:44:26.111: INFO: Deleting pod "pod-subpath-test-dynamicpv-zq6k" in namespace "provisioning-2742"
STEP: Deleting pvc
Apr 28 22:44:26.300: INFO: Deleting PersistentVolumeClaim "ebs.csi.aws.compkqml"
... skipping 10 lines ...

• [SLOW TEST:31.565 seconds]
External Storage [Driver: ebs.csi.aws.com]
/home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/external/external.go:175
  [Testpattern: Dynamic PV (default fs)] subPath
  /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should fail if non-existent subpath is outside the volume [Slow][LinuxOnly]
    /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:267
------------------------------
S
------------------------------
[BeforeEach] [Testpattern: Dynamic PV (ntfs)][Feature:Windows] provisioning
  /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:51
... skipping 127 lines ...
Apr 28 22:44:37.548: INFO: Using claimSize:1Gi, test suite supported size:{ 1Mi}, driver(ebs.csi.aws.com) supported size:{ 1Mi} 
STEP: creating a StorageClass provisioning-8999-e2e-scdmwfq
STEP: creating a claim
Apr 28 22:44:37.612: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
STEP: Creating pod pod-subpath-test-dynamicpv-25cx
STEP: Creating a pod to test subpath
Apr 28 22:44:37.810: INFO: Waiting up to 5m0s for pod "pod-subpath-test-dynamicpv-25cx" in namespace "provisioning-8999" to be "Succeeded or Failed"
Apr 28 22:44:37.873: INFO: Pod "pod-subpath-test-dynamicpv-25cx": Phase="Pending", Reason="", readiness=false. Elapsed: 63.587761ms
Apr 28 22:44:39.938: INFO: Pod "pod-subpath-test-dynamicpv-25cx": Phase="Pending", Reason="", readiness=false. Elapsed: 2.127872152s
Apr 28 22:44:42.002: INFO: Pod "pod-subpath-test-dynamicpv-25cx": Phase="Pending", Reason="", readiness=false. Elapsed: 4.192633626s
Apr 28 22:44:44.068: INFO: Pod "pod-subpath-test-dynamicpv-25cx": Phase="Pending", Reason="", readiness=false. Elapsed: 6.258317459s
Apr 28 22:44:46.133: INFO: Pod "pod-subpath-test-dynamicpv-25cx": Phase="Pending", Reason="", readiness=false. Elapsed: 8.32272994s
Apr 28 22:44:48.198: INFO: Pod "pod-subpath-test-dynamicpv-25cx": Phase="Pending", Reason="", readiness=false. Elapsed: 10.387853033s
Apr 28 22:44:50.262: INFO: Pod "pod-subpath-test-dynamicpv-25cx": Phase="Pending", Reason="", readiness=false. Elapsed: 12.451783309s
Apr 28 22:44:52.326: INFO: Pod "pod-subpath-test-dynamicpv-25cx": Phase="Pending", Reason="", readiness=false. Elapsed: 14.516228006s
Apr 28 22:44:54.390: INFO: Pod "pod-subpath-test-dynamicpv-25cx": Phase="Succeeded", Reason="", readiness=false. Elapsed: 16.58053329s
STEP: Saw pod success
Apr 28 22:44:54.390: INFO: Pod "pod-subpath-test-dynamicpv-25cx" satisfied condition "Succeeded or Failed"
Apr 28 22:44:54.453: INFO: Trying to get logs from node ip-172-20-38-81.us-west-2.compute.internal pod pod-subpath-test-dynamicpv-25cx container test-container-subpath-dynamicpv-25cx: <nil>
STEP: delete the pod
Apr 28 22:44:54.589: INFO: Waiting for pod pod-subpath-test-dynamicpv-25cx to disappear
Apr 28 22:44:54.652: INFO: Pod pod-subpath-test-dynamicpv-25cx no longer exists
STEP: Deleting pod pod-subpath-test-dynamicpv-25cx
Apr 28 22:44:54.652: INFO: Deleting pod "pod-subpath-test-dynamicpv-25cx" in namespace "provisioning-8999"
... skipping 98 lines ...
    Verify if offline PVC expansion works
    /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/volume_expand.go:174
------------------------------
SSSS
------------------------------
External Storage [Driver: ebs.csi.aws.com] [Testpattern: Dynamic PV (default fs)] subPath 
  should fail if subpath file is outside the volume [Slow][LinuxOnly]
  /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:256

[BeforeEach] [Testpattern: Dynamic PV (default fs)] subPath
  /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:51
[BeforeEach] [Testpattern: Dynamic PV (default fs)] subPath
  /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:185
STEP: Creating a kubernetes client
Apr 28 22:45:10.425: INFO: >>> kubeConfig: /root/.kube/config
STEP: Building a namespace api object, basename provisioning
STEP: Waiting for a default service account to be provisioned in namespace
[It] should fail if subpath file is outside the volume [Slow][LinuxOnly]
  /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:256
Apr 28 22:45:10.741: INFO: Creating resource for dynamic PV
Apr 28 22:45:10.741: INFO: Using claimSize:1Gi, test suite supported size:{ 1Mi}, driver(ebs.csi.aws.com) supported size:{ 1Mi} 
STEP: creating a StorageClass provisioning-6746-e2e-sct4sj7
STEP: creating a claim
Apr 28 22:45:10.805: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
STEP: Creating pod pod-subpath-test-dynamicpv-mhkh
STEP: Checking for subpath error in container status
Apr 28 22:45:25.129: INFO: Deleting pod "pod-subpath-test-dynamicpv-mhkh" in namespace "provisioning-6746"
Apr 28 22:45:25.196: INFO: Wait up to 5m0s for pod "pod-subpath-test-dynamicpv-mhkh" to be fully deleted
STEP: Deleting pod
Apr 28 22:45:35.324: INFO: Deleting pod "pod-subpath-test-dynamicpv-mhkh" in namespace "provisioning-6746"
STEP: Deleting pvc
Apr 28 22:45:35.516: INFO: Deleting PersistentVolumeClaim "ebs.csi.aws.comtghj9"
... skipping 9 lines ...

• [SLOW TEST:30.482 seconds]
External Storage [Driver: ebs.csi.aws.com]
/home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/external/external.go:175
  [Testpattern: Dynamic PV (default fs)] subPath
  /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should fail if subpath file is outside the volume [Slow][LinuxOnly]
    /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:256
------------------------------
SSSSSSS
------------------------------
External Storage [Driver: ebs.csi.aws.com] [Testpattern: Dynamic PV (default fs)(allowExpansion)] volume-expand 
  should resize volume when PVC is edited while pod is using it
... skipping 417 lines ...
Apr 28 22:46:36.768: INFO: Using claimSize:1Gi, test suite supported size:{ 1Gi}, driver(ebs.csi.aws.com) supported size:{ 1Gi} 
STEP: creating a StorageClass volume-expand-2282-e2e-scndzsn
STEP: creating a claim
Apr 28 22:46:36.829: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
STEP: Expanding non-expandable pvc
Apr 28 22:46:36.953: INFO: currentPvcSize {{1073741824 0} {<nil>} 1Gi BinarySI}, newSize {{2147483648 0} {<nil>}  BinarySI}
Apr 28 22:46:37.079: INFO: Error updating pvc ebs.csi.aws.com7zxmf: PersistentVolumeClaim "ebs.csi.aws.com7zxmf" is invalid: spec: Forbidden: spec is immutable after creation except resources.requests for bound claims
  core.PersistentVolumeClaimSpec{
  	AccessModes: {"ReadWriteOnce"},
  	Selector:    nil,
  	Resources: core.ResourceRequirements{
  		Limits: nil,
- 		Requests: core.ResourceList{
... skipping 5 lines ...
  	},
  	VolumeName:       "",
  	StorageClassName: &"volume-expand-2282-e2e-scndzsn",
  	... // 2 identical fields
  }

Apr 28 22:46:39.202: INFO: Error updating pvc ebs.csi.aws.com7zxmf: PersistentVolumeClaim "ebs.csi.aws.com7zxmf" is invalid: spec: Forbidden: spec is immutable after creation except resources.requests for bound claims
  core.PersistentVolumeClaimSpec{
  	AccessModes: {"ReadWriteOnce"},
  	Selector:    nil,
  	Resources: core.ResourceRequirements{
  		Limits: nil,
- 		Requests: core.ResourceList{
... skipping 5 lines ...
  	},
  	VolumeName:       "",
  	StorageClassName: &"volume-expand-2282-e2e-scndzsn",
  	... // 2 identical fields
  }

Apr 28 22:46:41.203: INFO: Error updating pvc ebs.csi.aws.com7zxmf: PersistentVolumeClaim "ebs.csi.aws.com7zxmf" is invalid: spec: Forbidden: spec is immutable after creation except resources.requests for bound claims
  core.PersistentVolumeClaimSpec{
  	AccessModes: {"ReadWriteOnce"},
  	Selector:    nil,
  	Resources: core.ResourceRequirements{
  		Limits: nil,
- 		Requests: core.ResourceList{
... skipping 5 lines ...
  	},
  	VolumeName:       "",
  	StorageClassName: &"volume-expand-2282-e2e-scndzsn",
  	... // 2 identical fields
  }

Apr 28 22:46:43.202: INFO: Error updating pvc ebs.csi.aws.com7zxmf: PersistentVolumeClaim "ebs.csi.aws.com7zxmf" is invalid: spec: Forbidden: spec is immutable after creation except resources.requests for bound claims
  core.PersistentVolumeClaimSpec{
  	AccessModes: {"ReadWriteOnce"},
  	Selector:    nil,
  	Resources: core.ResourceRequirements{
  		Limits: nil,
- 		Requests: core.ResourceList{
... skipping 5 lines ...
  	},
  	VolumeName:       "",
  	StorageClassName: &"volume-expand-2282-e2e-scndzsn",
  	... // 2 identical fields
  }

Apr 28 22:46:45.202: INFO: Error updating pvc ebs.csi.aws.com7zxmf: PersistentVolumeClaim "ebs.csi.aws.com7zxmf" is invalid: spec: Forbidden: spec is immutable after creation except resources.requests for bound claims
  core.PersistentVolumeClaimSpec{
  	AccessModes: {"ReadWriteOnce"},
  	Selector:    nil,
  	Resources: core.ResourceRequirements{
  		Limits: nil,
- 		Requests: core.ResourceList{
... skipping 5 lines ...
  	},
  	VolumeName:       "",
  	StorageClassName: &"volume-expand-2282-e2e-scndzsn",
  	... // 2 identical fields
  }

Apr 28 22:46:47.207: INFO: Error updating pvc ebs.csi.aws.com7zxmf: PersistentVolumeClaim "ebs.csi.aws.com7zxmf" is invalid: spec: Forbidden: spec is immutable after creation except resources.requests for bound claims
  core.PersistentVolumeClaimSpec{
  	AccessModes: {"ReadWriteOnce"},
  	Selector:    nil,
  	Resources: core.ResourceRequirements{
  		Limits: nil,
- 		Requests: core.ResourceList{
... skipping 5 lines ...
  	},
  	VolumeName:       "",
  	StorageClassName: &"volume-expand-2282-e2e-scndzsn",
  	... // 2 identical fields
  }

Apr 28 22:46:49.202: INFO: Error updating pvc ebs.csi.aws.com7zxmf: PersistentVolumeClaim "ebs.csi.aws.com7zxmf" is invalid: spec: Forbidden: spec is immutable after creation except resources.requests for bound claims
  core.PersistentVolumeClaimSpec{
  	AccessModes: {"ReadWriteOnce"},
  	Selector:    nil,
  	Resources: core.ResourceRequirements{
  		Limits: nil,
- 		Requests: core.ResourceList{
... skipping 5 lines ...
  	},
  	VolumeName:       "",
  	StorageClassName: &"volume-expand-2282-e2e-scndzsn",
  	... // 2 identical fields
  }

Apr 28 22:46:51.206: INFO: Error updating pvc ebs.csi.aws.com7zxmf: PersistentVolumeClaim "ebs.csi.aws.com7zxmf" is invalid: spec: Forbidden: spec is immutable after creation except resources.requests for bound claims
  core.PersistentVolumeClaimSpec{
  	AccessModes: {"ReadWriteOnce"},
  	Selector:    nil,
  	Resources: core.ResourceRequirements{
  		Limits: nil,
- 		Requests: core.ResourceList{
... skipping 5 lines ...
  	},
  	VolumeName:       "",
  	StorageClassName: &"volume-expand-2282-e2e-scndzsn",
  	... // 2 identical fields
  }

Apr 28 22:46:53.201: INFO: Error updating pvc ebs.csi.aws.com7zxmf: PersistentVolumeClaim "ebs.csi.aws.com7zxmf" is invalid: spec: Forbidden: spec is immutable after creation except resources.requests for bound claims
  core.PersistentVolumeClaimSpec{
  	AccessModes: {"ReadWriteOnce"},
  	Selector:    nil,
  	Resources: core.ResourceRequirements{
  		Limits: nil,
- 		Requests: core.ResourceList{
... skipping 5 lines ...
  	},
  	VolumeName:       "",
  	StorageClassName: &"volume-expand-2282-e2e-scndzsn",
  	... // 2 identical fields
  }

Apr 28 22:46:55.203: INFO: Error updating pvc ebs.csi.aws.com7zxmf: PersistentVolumeClaim "ebs.csi.aws.com7zxmf" is invalid: spec: Forbidden: spec is immutable after creation except resources.requests for bound claims
  core.PersistentVolumeClaimSpec{
  	AccessModes: {"ReadWriteOnce"},
  	Selector:    nil,
  	Resources: core.ResourceRequirements{
  		Limits: nil,
- 		Requests: core.ResourceList{
... skipping 5 lines ...
  	},
  	VolumeName:       "",
  	StorageClassName: &"volume-expand-2282-e2e-scndzsn",
  	... // 2 identical fields
  }

Apr 28 22:46:57.204: INFO: Error updating pvc ebs.csi.aws.com7zxmf: PersistentVolumeClaim "ebs.csi.aws.com7zxmf" is invalid: spec: Forbidden: spec is immutable after creation except resources.requests for bound claims
  core.PersistentVolumeClaimSpec{
  	AccessModes: {"ReadWriteOnce"},
  	Selector:    nil,
  	Resources: core.ResourceRequirements{
  		Limits: nil,
- 		Requests: core.ResourceList{
... skipping 5 lines ...
  	},
  	VolumeName:       "",
  	StorageClassName: &"volume-expand-2282-e2e-scndzsn",
  	... // 2 identical fields
  }

Apr 28 22:46:59.201: INFO: Error updating pvc ebs.csi.aws.com7zxmf: PersistentVolumeClaim "ebs.csi.aws.com7zxmf" is invalid: spec: Forbidden: spec is immutable after creation except resources.requests for bound claims
  core.PersistentVolumeClaimSpec{
  	AccessModes: {"ReadWriteOnce"},
  	Selector:    nil,
  	Resources: core.ResourceRequirements{
  		Limits: nil,
- 		Requests: core.ResourceList{
... skipping 5 lines ...
  	},
  	VolumeName:       "",
  	StorageClassName: &"volume-expand-2282-e2e-scndzsn",
  	... // 2 identical fields
  }

Apr 28 22:47:01.202: INFO: Error updating pvc ebs.csi.aws.com7zxmf: PersistentVolumeClaim "ebs.csi.aws.com7zxmf" is invalid: spec: Forbidden: spec is immutable after creation except resources.requests for bound claims
  core.PersistentVolumeClaimSpec{
  	AccessModes: {"ReadWriteOnce"},
  	Selector:    nil,
  	Resources: core.ResourceRequirements{
  		Limits: nil,
- 		Requests: core.ResourceList{
... skipping 5 lines ...
  	},
  	VolumeName:       "",
  	StorageClassName: &"volume-expand-2282-e2e-scndzsn",
  	... // 2 identical fields
  }

Apr 28 22:47:03.204: INFO: Error updating pvc ebs.csi.aws.com7zxmf: PersistentVolumeClaim "ebs.csi.aws.com7zxmf" is invalid: spec: Forbidden: spec is immutable after creation except resources.requests for bound claims
  core.PersistentVolumeClaimSpec{
  	AccessModes: {"ReadWriteOnce"},
  	Selector:    nil,
  	Resources: core.ResourceRequirements{
  		Limits: nil,
- 		Requests: core.ResourceList{
... skipping 5 lines ...
  	},
  	VolumeName:       "",
  	StorageClassName: &"volume-expand-2282-e2e-scndzsn",
  	... // 2 identical fields
  }

Apr 28 22:47:05.202: INFO: Error updating pvc ebs.csi.aws.com7zxmf: PersistentVolumeClaim "ebs.csi.aws.com7zxmf" is invalid: spec: Forbidden: spec is immutable after creation except resources.requests for bound claims
  core.PersistentVolumeClaimSpec{
  	AccessModes: {"ReadWriteOnce"},
  	Selector:    nil,
  	Resources: core.ResourceRequirements{
  		Limits: nil,
- 		Requests: core.ResourceList{
... skipping 5 lines ...
  	},
  	VolumeName:       "",
  	StorageClassName: &"volume-expand-2282-e2e-scndzsn",
  	... // 2 identical fields
  }

Apr 28 22:47:07.205: INFO: Error updating pvc ebs.csi.aws.com7zxmf: PersistentVolumeClaim "ebs.csi.aws.com7zxmf" is invalid: spec: Forbidden: spec is immutable after creation except resources.requests for bound claims
  core.PersistentVolumeClaimSpec{
  	AccessModes: {"ReadWriteOnce"},
  	Selector:    nil,
  	Resources: core.ResourceRequirements{
  		Limits: nil,
- 		Requests: core.ResourceList{
... skipping 5 lines ...
  	},
  	VolumeName:       "",
  	StorageClassName: &"volume-expand-2282-e2e-scndzsn",
  	... // 2 identical fields
  }

Apr 28 22:47:07.327: INFO: Error updating pvc ebs.csi.aws.com7zxmf: PersistentVolumeClaim "ebs.csi.aws.com7zxmf" is invalid: spec: Forbidden: spec is immutable after creation except resources.requests for bound claims
  core.PersistentVolumeClaimSpec{
  	AccessModes: {"ReadWriteOnce"},
  	Selector:    nil,
  	Resources: core.ResourceRequirements{
  		Limits: nil,
- 		Requests: core.ResourceList{
... skipping 36 lines ...

S [SKIPPING] in Spec Setup (BeforeEach) [0.001 seconds]
External Storage [Driver: ebs.csi.aws.com]
/home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/external/external.go:175
  [Testpattern: Dynamic PV (ntfs)][Feature:Windows] subPath
  /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should fail if subpath with backstepping is outside the volume [Slow][LinuxOnly] [BeforeEach]
    /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:278

    Driver ebs.csi.aws.com doesn't support ntfs -- skipping

    /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:121
------------------------------
S
------------------------------
External Storage [Driver: ebs.csi.aws.com] [Testpattern: Dynamic PV (block volmode)] volumeMode 
  should fail to use a volume in a pod with mismatched mode [Slow]
  /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/volumemode.go:296

[BeforeEach] [Testpattern: Dynamic PV (block volmode)] volumeMode
  /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:51
[BeforeEach] [Testpattern: Dynamic PV (block volmode)] volumeMode
  /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:185
STEP: Creating a kubernetes client
Apr 28 22:46:51.074: INFO: >>> kubeConfig: /root/.kube/config
STEP: Building a namespace api object, basename volumemode
STEP: Waiting for a default service account to be provisioned in namespace
[It] should fail to use a volume in a pod with mismatched mode [Slow]
  /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/volumemode.go:296
Apr 28 22:46:51.401: INFO: Creating resource for dynamic PV
Apr 28 22:46:51.401: INFO: Using claimSize:1Gi, test suite supported size:{ 1Mi}, driver(ebs.csi.aws.com) supported size:{ 1Mi} 
STEP: creating a StorageClass volumemode-7843-e2e-sc7ttgd
STEP: creating a claim
STEP: Creating pod
STEP: Waiting for the pod to fail
Apr 28 22:46:57.852: INFO: Deleting pod "pod-f230b8d8-7aec-4bb8-808f-f10b44ac3d08" in namespace "volumemode-7843"
Apr 28 22:46:57.915: INFO: Wait up to 5m0s for pod "pod-f230b8d8-7aec-4bb8-808f-f10b44ac3d08" to be fully deleted
STEP: Deleting pvc
Apr 28 22:47:06.158: INFO: Deleting PersistentVolumeClaim "ebs.csi.aws.com8sh59"
Apr 28 22:47:06.221: INFO: Waiting up to 5m0s for PersistentVolume pvc-51fe1c7f-e2fa-4230-9fbc-9ebe8491b452 to get deleted
Apr 28 22:47:06.284: INFO: PersistentVolume pvc-51fe1c7f-e2fa-4230-9fbc-9ebe8491b452 found and phase=Released (62.382689ms)
... skipping 7 lines ...

• [SLOW TEST:20.461 seconds]
External Storage [Driver: ebs.csi.aws.com]
/home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/external/external.go:175
  [Testpattern: Dynamic PV (block volmode)] volumeMode
  /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should fail to use a volume in a pod with mismatched mode [Slow]
    /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/volumemode.go:296
------------------------------
[BeforeEach] [Testpattern: Generic Ephemeral-volume (default fs) (immediate-binding)] ephemeral
  /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:51
[BeforeEach] [Testpattern: Generic Ephemeral-volume (default fs) (immediate-binding)] ephemeral
  /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:185
... skipping 31 lines ...

S [SKIPPING] in Spec Setup (BeforeEach) [0.001 seconds]
External Storage [Driver: ebs.csi.aws.com]
/home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/external/external.go:175
  [Testpattern: Pre-provisioned PV (filesystem volmode)] volumeMode
  /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should fail to use a volume in a pod with mismatched mode [Slow] [BeforeEach]
    /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/volumemode.go:296

    Driver "ebs.csi.aws.com" does not support volume type "PreprovisionedPV" - skipping

    /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/external/external.go:255
------------------------------
... skipping 27 lines ...

S [SKIPPING] in Spec Setup (BeforeEach) [0.001 seconds]
External Storage [Driver: ebs.csi.aws.com]
/home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/external/external.go:175
  [Testpattern: Dynamic PV (ntfs)][Feature:Windows] subPath
  /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should fail if subpath directory is outside the volume [Slow][LinuxOnly] [BeforeEach]
    /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:240

    Driver ebs.csi.aws.com doesn't support ntfs -- skipping

    /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:121
------------------------------
... skipping 224 lines ...
Apr 28 22:46:51.905: INFO: Using claimSize:1Gi, test suite supported size:{ 1Mi}, driver(ebs.csi.aws.com) supported size:{ 1Mi} 
STEP: creating a StorageClass provisioning-6431-e2e-scpcvdm
STEP: creating a claim
Apr 28 22:46:51.969: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
STEP: Creating pod pod-subpath-test-dynamicpv-bvnn
STEP: Creating a pod to test subpath
Apr 28 22:46:52.161: INFO: Waiting up to 5m0s for pod "pod-subpath-test-dynamicpv-bvnn" in namespace "provisioning-6431" to be "Succeeded or Failed"
Apr 28 22:46:52.223: INFO: Pod "pod-subpath-test-dynamicpv-bvnn": Phase="Pending", Reason="", readiness=false. Elapsed: 61.639487ms
Apr 28 22:46:54.286: INFO: Pod "pod-subpath-test-dynamicpv-bvnn": Phase="Pending", Reason="", readiness=false. Elapsed: 2.124504259s
Apr 28 22:46:56.350: INFO: Pod "pod-subpath-test-dynamicpv-bvnn": Phase="Pending", Reason="", readiness=false. Elapsed: 4.189040535s
Apr 28 22:46:58.412: INFO: Pod "pod-subpath-test-dynamicpv-bvnn": Phase="Pending", Reason="", readiness=false. Elapsed: 6.251384672s
Apr 28 22:47:00.475: INFO: Pod "pod-subpath-test-dynamicpv-bvnn": Phase="Pending", Reason="", readiness=false. Elapsed: 8.314111588s
Apr 28 22:47:02.538: INFO: Pod "pod-subpath-test-dynamicpv-bvnn": Phase="Pending", Reason="", readiness=false. Elapsed: 10.376759111s
Apr 28 22:47:04.600: INFO: Pod "pod-subpath-test-dynamicpv-bvnn": Phase="Pending", Reason="", readiness=false. Elapsed: 12.438849097s
Apr 28 22:47:06.662: INFO: Pod "pod-subpath-test-dynamicpv-bvnn": Phase="Pending", Reason="", readiness=false. Elapsed: 14.501000512s
Apr 28 22:47:08.727: INFO: Pod "pod-subpath-test-dynamicpv-bvnn": Phase="Pending", Reason="", readiness=false. Elapsed: 16.565493326s
Apr 28 22:47:10.789: INFO: Pod "pod-subpath-test-dynamicpv-bvnn": Phase="Pending", Reason="", readiness=false. Elapsed: 18.62836647s
Apr 28 22:47:12.852: INFO: Pod "pod-subpath-test-dynamicpv-bvnn": Phase="Pending", Reason="", readiness=false. Elapsed: 20.691243092s
Apr 28 22:47:14.915: INFO: Pod "pod-subpath-test-dynamicpv-bvnn": Phase="Succeeded", Reason="", readiness=false. Elapsed: 22.753499975s
STEP: Saw pod success
Apr 28 22:47:14.915: INFO: Pod "pod-subpath-test-dynamicpv-bvnn" satisfied condition "Succeeded or Failed"
Apr 28 22:47:14.976: INFO: Trying to get logs from node ip-172-20-38-81.us-west-2.compute.internal pod pod-subpath-test-dynamicpv-bvnn container test-container-volume-dynamicpv-bvnn: <nil>
STEP: delete the pod
Apr 28 22:47:15.127: INFO: Waiting for pod pod-subpath-test-dynamicpv-bvnn to disappear
Apr 28 22:47:15.188: INFO: Pod pod-subpath-test-dynamicpv-bvnn no longer exists
STEP: Deleting pod pod-subpath-test-dynamicpv-bvnn
Apr 28 22:47:15.188: INFO: Deleting pod "pod-subpath-test-dynamicpv-bvnn" in namespace "provisioning-6431"
... skipping 50 lines ...

S [SKIPPING] in Spec Setup (BeforeEach) [0.001 seconds]
External Storage [Driver: ebs.csi.aws.com]
/home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/external/external.go:175
  [Testpattern: Dynamic PV (ntfs)][Feature:Windows] subPath
  /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should fail if non-existent subpath is outside the volume [Slow][LinuxOnly] [BeforeEach]
    /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:267

    Driver ebs.csi.aws.com doesn't support ntfs -- skipping

    /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:121
------------------------------
... skipping 580 lines ...

S [SKIPPING] in Spec Setup (BeforeEach) [0.001 seconds]
External Storage [Driver: ebs.csi.aws.com]
/home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/external/external.go:175
  [Testpattern: Pre-provisioned PV (block volmode)] volumeMode
  /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should fail to use a volume in a pod with mismatched mode [Slow] [BeforeEach]
    /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/volumemode.go:296

    Driver "ebs.csi.aws.com" does not support volume type "PreprovisionedPV" - skipping

    /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/external/external.go:255
------------------------------
... skipping 131 lines ...
Apr 28 22:50:17.711: INFO: Using claimSize:1Gi, test suite supported size:{ 1Mi}, driver(ebs.csi.aws.com) supported size:{ 1Mi} 
STEP: creating a StorageClass provisioning-2344-e2e-scdh4x9
STEP: creating a claim
Apr 28 22:50:17.772: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
STEP: Creating pod pod-subpath-test-dynamicpv-vwr4
STEP: Creating a pod to test multi_subpath
Apr 28 22:50:17.963: INFO: Waiting up to 5m0s for pod "pod-subpath-test-dynamicpv-vwr4" in namespace "provisioning-2344" to be "Succeeded or Failed"
Apr 28 22:50:18.024: INFO: Pod "pod-subpath-test-dynamicpv-vwr4": Phase="Pending", Reason="", readiness=false. Elapsed: 60.873819ms
Apr 28 22:50:20.086: INFO: Pod "pod-subpath-test-dynamicpv-vwr4": Phase="Pending", Reason="", readiness=false. Elapsed: 2.122768911s
Apr 28 22:50:22.147: INFO: Pod "pod-subpath-test-dynamicpv-vwr4": Phase="Pending", Reason="", readiness=false. Elapsed: 4.184284167s
Apr 28 22:50:24.210: INFO: Pod "pod-subpath-test-dynamicpv-vwr4": Phase="Pending", Reason="", readiness=false. Elapsed: 6.246857387s
Apr 28 22:50:26.271: INFO: Pod "pod-subpath-test-dynamicpv-vwr4": Phase="Pending", Reason="", readiness=false. Elapsed: 8.307886766s
Apr 28 22:50:28.332: INFO: Pod "pod-subpath-test-dynamicpv-vwr4": Phase="Pending", Reason="", readiness=false. Elapsed: 10.369469126s
Apr 28 22:50:30.398: INFO: Pod "pod-subpath-test-dynamicpv-vwr4": Phase="Pending", Reason="", readiness=false. Elapsed: 12.434809276s
Apr 28 22:50:32.460: INFO: Pod "pod-subpath-test-dynamicpv-vwr4": Phase="Pending", Reason="", readiness=false. Elapsed: 14.496889137s
Apr 28 22:50:34.522: INFO: Pod "pod-subpath-test-dynamicpv-vwr4": Phase="Succeeded", Reason="", readiness=false. Elapsed: 16.559204993s
STEP: Saw pod success
Apr 28 22:50:34.522: INFO: Pod "pod-subpath-test-dynamicpv-vwr4" satisfied condition "Succeeded or Failed"
Apr 28 22:50:34.583: INFO: Trying to get logs from node ip-172-20-38-81.us-west-2.compute.internal pod pod-subpath-test-dynamicpv-vwr4 container test-container-subpath-dynamicpv-vwr4: <nil>
STEP: delete the pod
Apr 28 22:50:34.714: INFO: Waiting for pod pod-subpath-test-dynamicpv-vwr4 to disappear
Apr 28 22:50:34.774: INFO: Pod pod-subpath-test-dynamicpv-vwr4 no longer exists
STEP: Deleting pod
Apr 28 22:50:34.774: INFO: Deleting pod "pod-subpath-test-dynamicpv-vwr4" in namespace "provisioning-2344"
... skipping 308 lines ...
Apr 28 22:49:53.042: INFO: Using claimSize:1Gi, test suite supported size:{ 1Mi}, driver(ebs.csi.aws.com) supported size:{ 1Mi} 
STEP: creating a StorageClass provisioning-7218-e2e-scfbmht
STEP: creating a claim
Apr 28 22:49:53.105: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
STEP: Creating pod pod-subpath-test-dynamicpv-bbrj
STEP: Creating a pod to test atomic-volume-subpath
Apr 28 22:49:53.297: INFO: Waiting up to 5m0s for pod "pod-subpath-test-dynamicpv-bbrj" in namespace "provisioning-7218" to be "Succeeded or Failed"
Apr 28 22:49:53.358: INFO: Pod "pod-subpath-test-dynamicpv-bbrj": Phase="Pending", Reason="", readiness=false. Elapsed: 61.774301ms
Apr 28 22:49:55.420: INFO: Pod "pod-subpath-test-dynamicpv-bbrj": Phase="Pending", Reason="", readiness=false. Elapsed: 2.123413373s
Apr 28 22:49:57.483: INFO: Pod "pod-subpath-test-dynamicpv-bbrj": Phase="Pending", Reason="", readiness=false. Elapsed: 4.186191921s
Apr 28 22:49:59.545: INFO: Pod "pod-subpath-test-dynamicpv-bbrj": Phase="Pending", Reason="", readiness=false. Elapsed: 6.248301649s
Apr 28 22:50:01.609: INFO: Pod "pod-subpath-test-dynamicpv-bbrj": Phase="Pending", Reason="", readiness=false. Elapsed: 8.311992186s
Apr 28 22:50:03.671: INFO: Pod "pod-subpath-test-dynamicpv-bbrj": Phase="Pending", Reason="", readiness=false. Elapsed: 10.374618894s
... skipping 9 lines ...
Apr 28 22:50:24.303: INFO: Pod "pod-subpath-test-dynamicpv-bbrj": Phase="Running", Reason="", readiness=true. Elapsed: 31.006643395s
Apr 28 22:50:26.365: INFO: Pod "pod-subpath-test-dynamicpv-bbrj": Phase="Running", Reason="", readiness=true. Elapsed: 33.068433104s
Apr 28 22:50:28.427: INFO: Pod "pod-subpath-test-dynamicpv-bbrj": Phase="Running", Reason="", readiness=true. Elapsed: 35.130363499s
Apr 28 22:50:30.490: INFO: Pod "pod-subpath-test-dynamicpv-bbrj": Phase="Running", Reason="", readiness=true. Elapsed: 37.192948693s
Apr 28 22:50:32.553: INFO: Pod "pod-subpath-test-dynamicpv-bbrj": Phase="Succeeded", Reason="", readiness=false. Elapsed: 39.256279544s
STEP: Saw pod success
Apr 28 22:50:32.553: INFO: Pod "pod-subpath-test-dynamicpv-bbrj" satisfied condition "Succeeded or Failed"
Apr 28 22:50:32.615: INFO: Trying to get logs from node ip-172-20-38-81.us-west-2.compute.internal pod pod-subpath-test-dynamicpv-bbrj container test-container-subpath-dynamicpv-bbrj: <nil>
STEP: delete the pod
Apr 28 22:50:32.772: INFO: Waiting for pod pod-subpath-test-dynamicpv-bbrj to disappear
Apr 28 22:50:32.833: INFO: Pod pod-subpath-test-dynamicpv-bbrj no longer exists
STEP: Deleting pod pod-subpath-test-dynamicpv-bbrj
Apr 28 22:50:32.833: INFO: Deleting pod "pod-subpath-test-dynamicpv-bbrj" in namespace "provisioning-7218"
... skipping 107 lines ...

    /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/external/external.go:255
------------------------------
SS
------------------------------
External Storage [Driver: ebs.csi.aws.com] [Testpattern: Dynamic PV (filesystem volmode)] volumeMode 
  should fail to use a volume in a pod with mismatched mode [Slow]
  /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/volumemode.go:296

[BeforeEach] [Testpattern: Dynamic PV (filesystem volmode)] volumeMode
  /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:51
[BeforeEach] [Testpattern: Dynamic PV (filesystem volmode)] volumeMode
  /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:185
STEP: Creating a kubernetes client
Apr 28 22:50:55.937: INFO: >>> kubeConfig: /root/.kube/config
STEP: Building a namespace api object, basename volumemode
STEP: Waiting for a default service account to be provisioned in namespace
[It] should fail to use a volume in a pod with mismatched mode [Slow]
  /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/volumemode.go:296
Apr 28 22:50:56.261: INFO: Creating resource for dynamic PV
Apr 28 22:50:56.261: INFO: Using claimSize:1Gi, test suite supported size:{ 1Mi}, driver(ebs.csi.aws.com) supported size:{ 1Mi} 
STEP: creating a StorageClass volumemode-17-e2e-scdsr58
STEP: creating a claim
STEP: Creating pod
STEP: Waiting for the pod to fail
Apr 28 22:51:02.715: INFO: Deleting pod "pod-824d4f4f-3e36-4a65-8124-87b2736f10c7" in namespace "volumemode-17"
Apr 28 22:51:02.781: INFO: Wait up to 5m0s for pod "pod-824d4f4f-3e36-4a65-8124-87b2736f10c7" to be fully deleted
STEP: Deleting pvc
Apr 28 22:51:07.039: INFO: Deleting PersistentVolumeClaim "ebs.csi.aws.comtdznj"
Apr 28 22:51:07.109: INFO: Waiting up to 5m0s for PersistentVolume pvc-3c6ebe2a-93d0-4b8e-a29f-2d0d2c8ddde2 to get deleted
Apr 28 22:51:07.172: INFO: PersistentVolume pvc-3c6ebe2a-93d0-4b8e-a29f-2d0d2c8ddde2 found and phase=Released (63.395046ms)
... skipping 8 lines ...

• [SLOW TEST:21.574 seconds]
External Storage [Driver: ebs.csi.aws.com]
/home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/external/external.go:175
  [Testpattern: Dynamic PV (filesystem volmode)] volumeMode
  /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should fail to use a volume in a pod with mismatched mode [Slow]
    /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/volumemode.go:296
------------------------------
[BeforeEach] [Testpattern: Pre-provisioned PV (block volmode)] volumeMode
  /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:51
Apr 28 22:51:17.513: INFO: Driver "ebs.csi.aws.com" does not support volume type "PreprovisionedPV" - skipping
[AfterEach] [Testpattern: Pre-provisioned PV (block volmode)] volumeMode
... skipping 114 lines ...
Apr 28 22:50:51.205: INFO: Using claimSize:1Gi, test suite supported size:{ 1Mi}, driver(ebs.csi.aws.com) supported size:{ 1Mi} 
STEP: creating a StorageClass provisioning-7864-e2e-sc79txr
STEP: creating a claim
Apr 28 22:50:51.267: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
STEP: Creating pod pod-subpath-test-dynamicpv-nzcb
STEP: Creating a pod to test subpath
Apr 28 22:50:51.452: INFO: Waiting up to 5m0s for pod "pod-subpath-test-dynamicpv-nzcb" in namespace "provisioning-7864" to be "Succeeded or Failed"
Apr 28 22:50:51.513: INFO: Pod "pod-subpath-test-dynamicpv-nzcb": Phase="Pending", Reason="", readiness=false. Elapsed: 60.294697ms
Apr 28 22:50:53.575: INFO: Pod "pod-subpath-test-dynamicpv-nzcb": Phase="Pending", Reason="", readiness=false. Elapsed: 2.122742485s
Apr 28 22:50:55.637: INFO: Pod "pod-subpath-test-dynamicpv-nzcb": Phase="Pending", Reason="", readiness=false. Elapsed: 4.184466264s
Apr 28 22:50:57.699: INFO: Pod "pod-subpath-test-dynamicpv-nzcb": Phase="Pending", Reason="", readiness=false. Elapsed: 6.246330088s
Apr 28 22:50:59.760: INFO: Pod "pod-subpath-test-dynamicpv-nzcb": Phase="Pending", Reason="", readiness=false. Elapsed: 8.307443272s
Apr 28 22:51:01.821: INFO: Pod "pod-subpath-test-dynamicpv-nzcb": Phase="Pending", Reason="", readiness=false. Elapsed: 10.368401427s
Apr 28 22:51:03.891: INFO: Pod "pod-subpath-test-dynamicpv-nzcb": Phase="Pending", Reason="", readiness=false. Elapsed: 12.438067439s
Apr 28 22:51:05.954: INFO: Pod "pod-subpath-test-dynamicpv-nzcb": Phase="Succeeded", Reason="", readiness=false. Elapsed: 14.501973045s
STEP: Saw pod success
Apr 28 22:51:05.955: INFO: Pod "pod-subpath-test-dynamicpv-nzcb" satisfied condition "Succeeded or Failed"
Apr 28 22:51:06.015: INFO: Trying to get logs from node ip-172-20-38-81.us-west-2.compute.internal pod pod-subpath-test-dynamicpv-nzcb container test-container-subpath-dynamicpv-nzcb: <nil>
STEP: delete the pod
Apr 28 22:51:06.146: INFO: Waiting for pod pod-subpath-test-dynamicpv-nzcb to disappear
Apr 28 22:51:06.207: INFO: Pod pod-subpath-test-dynamicpv-nzcb no longer exists
STEP: Deleting pod pod-subpath-test-dynamicpv-nzcb
Apr 28 22:51:06.207: INFO: Deleting pod "pod-subpath-test-dynamicpv-nzcb" in namespace "provisioning-7864"
... skipping 337 lines ...

S [SKIPPING] in Spec Setup (BeforeEach) [0.001 seconds]
External Storage [Driver: ebs.csi.aws.com]
/home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/external/external.go:175
  [Testpattern: Inline-volume (default fs)] subPath
  /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should fail if subpath file is outside the volume [Slow][LinuxOnly] [BeforeEach]
    /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:256

    Driver "ebs.csi.aws.com" does not support volume type "InlineVolume" - skipping

    /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/external/external.go:255
------------------------------
... skipping 65 lines ...

S [SKIPPING] in Spec Setup (BeforeEach) [0.001 seconds]
External Storage [Driver: ebs.csi.aws.com]
/home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/external/external.go:175
  [Testpattern: Dynamic PV (immediate binding)] topology
  /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should fail to schedule a pod which has topologies that conflict with AllowedTopologies [BeforeEach]
    /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/topology.go:192

    Driver "ebs.csi.aws.com" does not support topology - skipping

    /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/topology.go:92
------------------------------
... skipping 37 lines ...
Apr 28 22:50:55.164: INFO: Creating resource for dynamic PV
Apr 28 22:50:55.164: INFO: Using claimSize:1Gi, test suite supported size:{ 1Mi}, driver(ebs.csi.aws.com) supported size:{ 1Mi} 
STEP: creating a StorageClass snapshotting-2657-e2e-sczkmnb
STEP: creating a claim
Apr 28 22:50:55.225: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
STEP: [init] starting a pod to use the claim
Apr 28 22:50:55.411: INFO: Waiting up to 15m0s for pod "pvc-snapshottable-tester-vp5r7" in namespace "snapshotting-2657" to be "Succeeded or Failed"
Apr 28 22:50:55.484: INFO: Pod "pvc-snapshottable-tester-vp5r7": Phase="Pending", Reason="", readiness=false. Elapsed: 73.291262ms
Apr 28 22:50:57.547: INFO: Pod "pvc-snapshottable-tester-vp5r7": Phase="Pending", Reason="", readiness=false. Elapsed: 2.135746367s
Apr 28 22:50:59.611: INFO: Pod "pvc-snapshottable-tester-vp5r7": Phase="Pending", Reason="", readiness=false. Elapsed: 4.199613337s
Apr 28 22:51:01.672: INFO: Pod "pvc-snapshottable-tester-vp5r7": Phase="Pending", Reason="", readiness=false. Elapsed: 6.261392826s
Apr 28 22:51:03.734: INFO: Pod "pvc-snapshottable-tester-vp5r7": Phase="Pending", Reason="", readiness=false. Elapsed: 8.32331563s
Apr 28 22:51:05.795: INFO: Pod "pvc-snapshottable-tester-vp5r7": Phase="Pending", Reason="", readiness=false. Elapsed: 10.384050369s
Apr 28 22:51:07.856: INFO: Pod "pvc-snapshottable-tester-vp5r7": Phase="Pending", Reason="", readiness=false. Elapsed: 12.445147614s
Apr 28 22:51:09.918: INFO: Pod "pvc-snapshottable-tester-vp5r7": Phase="Succeeded", Reason="", readiness=false. Elapsed: 14.506690353s
STEP: Saw pod success
Apr 28 22:51:09.918: INFO: Pod "pvc-snapshottable-tester-vp5r7" satisfied condition "Succeeded or Failed"
Apr 28 22:51:10.040: INFO: Pod pvc-snapshottable-tester-vp5r7 has the following logs: 
Apr 28 22:51:10.040: INFO: Deleting pod "pvc-snapshottable-tester-vp5r7" in namespace "snapshotting-2657"
Apr 28 22:51:10.107: INFO: Wait up to 5m0s for pod "pvc-snapshottable-tester-vp5r7" to be fully deleted
Apr 28 22:51:10.166: INFO: Waiting up to timeout=5m0s for PersistentVolumeClaims [ebs.csi.aws.com5w6x4] to have phase Bound
Apr 28 22:51:10.227: INFO: PersistentVolumeClaim ebs.csi.aws.com5w6x4 found and phase=Bound (60.195732ms)
STEP: [init] checking the claim
... skipping 30 lines ...
[It] should check snapshot fields, check restore correctly works after modifying source data, check deletion
  /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/snapshottable.go:243
STEP: checking the snapshot
STEP: checking the SnapshotContent
STEP: Modifying source data test
STEP: modifying the data in the source PVC
Apr 28 22:51:52.150: INFO: Waiting up to 15m0s for pod "pvc-snapshottable-data-tester-gpxng" in namespace "snapshotting-2657" to be "Succeeded or Failed"
Apr 28 22:51:52.211: INFO: Pod "pvc-snapshottable-data-tester-gpxng": Phase="Pending", Reason="", readiness=false. Elapsed: 60.238918ms
Apr 28 22:51:54.272: INFO: Pod "pvc-snapshottable-data-tester-gpxng": Phase="Pending", Reason="", readiness=false. Elapsed: 2.121751055s
Apr 28 22:51:56.334: INFO: Pod "pvc-snapshottable-data-tester-gpxng": Phase="Pending", Reason="", readiness=false. Elapsed: 4.183264138s
Apr 28 22:51:58.396: INFO: Pod "pvc-snapshottable-data-tester-gpxng": Phase="Pending", Reason="", readiness=false. Elapsed: 6.245389246s
Apr 28 22:52:00.458: INFO: Pod "pvc-snapshottable-data-tester-gpxng": Phase="Pending", Reason="", readiness=false. Elapsed: 8.307176156s
Apr 28 22:52:02.519: INFO: Pod "pvc-snapshottable-data-tester-gpxng": Phase="Succeeded", Reason="", readiness=false. Elapsed: 10.36867524s
STEP: Saw pod success
Apr 28 22:52:02.519: INFO: Pod "pvc-snapshottable-data-tester-gpxng" satisfied condition "Succeeded or Failed"
Apr 28 22:52:02.643: INFO: Pod pvc-snapshottable-data-tester-gpxng has the following logs: 
Apr 28 22:52:02.643: INFO: Deleting pod "pvc-snapshottable-data-tester-gpxng" in namespace "snapshotting-2657"
Apr 28 22:52:02.713: INFO: Wait up to 5m0s for pod "pvc-snapshottable-data-tester-gpxng" to be fully deleted
STEP: creating a pvc from the snapshot
STEP: starting a pod to use the claim
Apr 28 22:52:25.019: INFO: Running '/usr/local/bin/kubectl --server=https://api-test-cluster-8941-k8s-69l3dm-2056760439.us-west-2.elb.amazonaws.com --kubeconfig=/root/.kube/config --namespace=snapshotting-2657 exec restored-pvc-tester-pr2kk --namespace=snapshotting-2657 -- cat /mnt/test/data'
... skipping 77 lines ...

S [SKIPPING] in Spec Setup (BeforeEach) [0.001 seconds]
External Storage [Driver: ebs.csi.aws.com]
/home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/external/external.go:175
  [Testpattern: Pre-provisioned PV (default fs)] subPath
  /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should fail if subpath file is outside the volume [Slow][LinuxOnly] [BeforeEach]
    /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:256

    Driver "ebs.csi.aws.com" does not support volume type "PreprovisionedPV" - skipping

    /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/external/external.go:255
------------------------------
... skipping 63 lines ...
    should support restarting containers using directory as subpath [Slow]
    /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:320
------------------------------
SSSSSSS
------------------------------
External Storage [Driver: ebs.csi.aws.com] [Testpattern: Dynamic PV (default fs)] subPath 
  should fail if subpath with backstepping is outside the volume [Slow][LinuxOnly]
  /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:278

[BeforeEach] [Testpattern: Dynamic PV (default fs)] subPath
  /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:51
[BeforeEach] [Testpattern: Dynamic PV (default fs)] subPath
  /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:185
STEP: Creating a kubernetes client
Apr 28 22:52:40.974: INFO: >>> kubeConfig: /root/.kube/config
STEP: Building a namespace api object, basename provisioning
STEP: Waiting for a default service account to be provisioned in namespace
[It] should fail if subpath with backstepping is outside the volume [Slow][LinuxOnly]
  /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:278
Apr 28 22:52:41.294: INFO: Creating resource for dynamic PV
Apr 28 22:52:41.294: INFO: Using claimSize:1Gi, test suite supported size:{ 1Mi}, driver(ebs.csi.aws.com) supported size:{ 1Mi} 
STEP: creating a StorageClass provisioning-6032-e2e-scj4w2l
STEP: creating a claim
Apr 28 22:52:41.360: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
STEP: Creating pod pod-subpath-test-dynamicpv-ptrn
STEP: Checking for subpath error in container status
Apr 28 22:52:57.687: INFO: Deleting pod "pod-subpath-test-dynamicpv-ptrn" in namespace "provisioning-6032"
Apr 28 22:52:57.753: INFO: Wait up to 5m0s for pod "pod-subpath-test-dynamicpv-ptrn" to be fully deleted
STEP: Deleting pod
Apr 28 22:53:05.883: INFO: Deleting pod "pod-subpath-test-dynamicpv-ptrn" in namespace "provisioning-6032"
STEP: Deleting pvc
Apr 28 22:53:06.078: INFO: Deleting PersistentVolumeClaim "ebs.csi.aws.comnztt6"
... skipping 11 lines ...

• [SLOW TEST:40.681 seconds]
External Storage [Driver: ebs.csi.aws.com]
/home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/external/external.go:175
  [Testpattern: Dynamic PV (default fs)] subPath
  /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should fail if subpath with backstepping is outside the volume [Slow][LinuxOnly]
    /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:278
------------------------------
S
------------------------------
[BeforeEach] [Testpattern: Inline-volume (default fs)] subPath
  /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:51
... skipping 4 lines ...

S [SKIPPING] in Spec Setup (BeforeEach) [0.001 seconds]
External Storage [Driver: ebs.csi.aws.com]
/home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/external/external.go:175
  [Testpattern: Inline-volume (default fs)] subPath
  /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should fail if non-existent subpath is outside the volume [Slow][LinuxOnly] [BeforeEach]
    /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:267

    Driver "ebs.csi.aws.com" does not support volume type "InlineVolume" - skipping

    /home/prow/go/src/github.com/kubernetes-sigs/aws-ebs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/external/external.go:255
------------------------------
... skipping 49 lines ...
Apr 28 22:53:12.571: INFO: In creating storage class object and pvc objects for driver - sc: &StorageClass{ObjectMeta:{provisioning-4332-e2e-sczdtgt      0 0001-01-01 00:00:00 +0000 UTC <nil> <nil> map[] map[] [] []  []},Provisioner:ebs.csi.aws.com,Parameters:map[string]string{},ReclaimPolicy:nil,MountOptions:[],AllowVolumeExpansion:nil,VolumeBindingMode:*WaitForFirstConsumer,AllowedTopologies:[]TopologySelectorTerm{},}, pvc: &PersistentVolumeClaim{ObjectMeta:{ pvc- provisioning-4332    0 0001-01-01 00:00:00 +0000 UTC <nil> <nil> map[] map[] [] []  []},Spec:PersistentVolumeClaimSpec{AccessModes:[ReadWriteOnce],Resources:ResourceRequirements{Limits:ResourceList{},Requests:ResourceList{storage: {{1073741824 0} {<nil>} 1Gi BinarySI},},},VolumeName:,Selector:nil,StorageClassName:*provisioning-4332-e2e-sczdtgt,VolumeMode:nil,DataSource:nil,},Status:PersistentVolumeClaimStatus{Phase:,AccessModes:[],Capacity:ResourceList{},Conditions:[]PersistentVolumeClaimCondition{},},}, src-pvc: &PersistentVolumeClaim{ObjectMeta:{ pvc- provisioning-4332    0 0001-01-01 00:00:00 +0000 UTC <nil> <nil> map[] map[] [] []  []},Spec:PersistentVolumeClaimSpec{AccessModes:[ReadWriteOnce],Resources:ResourceRequirements{Limits:ResourceList{},Requests:ResourceList{storage: {{1073741824 0} {<nil>} 1Gi BinarySI},},},VolumeName:,Selector:nil,StorageClassName:*provisioning-4332-e2e-sczdtgt,VolumeMode:nil,DataSource:nil,},Status:PersistentVolumeClaimStatus{Phase:,AccessModes:[],Capacity:ResourceList{},Conditions:[]PersistentVolumeClaimCondition{},},}
STEP: Creating a StorageClass
STEP: creating claim=&PersistentVolumeClaim{ObjectMeta:{ pvc- provisioning-4332    0 0001-01-01 00:00:00 +0000 UTC <nil> <nil> map[] map[] [] []  []},Spec:PersistentVolumeClaimSpec{AccessModes:[ReadWriteOnce],Resources:ResourceRequirements{Limits:ResourceList{},Requests:ResourceList{storage: {{1073741824 0} {<nil>} 1Gi BinarySI},},},VolumeName:,Selector:nil,StorageClassName:*provisioning-4332-e2e-sczdtgt,VolumeMode:nil,DataSource:nil,},Status:PersistentVolumeClaimStatus{Phase:,AccessModes:[],Capacity:ResourceList{},Conditions:[]PersistentVolumeClaimCondition{},},}
STEP: creating a pod referring to the class=&StorageClass{ObjectMeta:{provisioning-4332-e2e-sczdtgt    ee858244-9e11-4b40-940f-b5b61fd688ff 6247 0 2021-04-28 22:53:12 +0000 UTC <nil> <nil> map[] map[] [] []  [{e2e-kubernetes.test Update storage.k8s.io/v1 2021-04-28 22:53:12 +0000 UTC FieldsV1 {"f:mountOptions":{},"f:provisioner":{},"f:reclaimPolicy":{},"f:volumeBindingMode":{}}}]},Provisioner:ebs.csi.aws.com,Parameters:map[string]string{},ReclaimPolicy:*Delete,MountOptions:[dirsync],AllowVolumeExpansion:nil,VolumeBindingMode:*WaitForFirstConsumer,AllowedTopologies:[]TopologySelectorTerm{},} claim=&PersistentVolumeClaim{ObjectMeta:{pvc-rpw4l pvc- provisioning-4332  bdd55c30-3f6e-487f-a2f2-620981f4178e 6248 0 2021-04-28 22:53:12 +0000 UTC <nil> <nil> map[] map[] [] [kubernetes.io/pvc-protection]  [{e2e-kubernetes.test Update v1 2021-04-28 22:53:12 +0000 UTC FieldsV1 {"f:metadata":{"f:generateName":{}},"f:spec":{"f:accessModes":{},"f:resources":{"f:requests":{".":{},"f:storage":{}}},"f:storageClassName":{},"f:volumeMode":{}},"f:status":{"f:phase":{}}}}]},Spec:PersistentVolumeClaimSpec{AccessModes:[ReadWriteOnce],Resources:ResourceRequirements{Limits:ResourceList{},Requests:ResourceList{storage: {{1073741824 0} {<nil>} 1Gi BinarySI},},},VolumeName:,Selector:nil,StorageClassName:*provisioning-4332-e2e-sczdtgt,VolumeMode:*Filesystem,DataSource:nil,},Status:PersistentVolumeClaimStatus{Phase:Pending,AccessModes:[],Capacity:ResourceList{},Conditions:[]PersistentVolumeClaimCondition{},},}
STEP: Deleting pod pod-78a5b8a2-eae7-4047-8396-fdc60f171a7d in namespace provisioning-4332
STEP: checking the created volume is writable on node {Name: Selector:map[] Affinity:nil}
Apr 28 22:53:35.246: INFO: Waiting up to 15m0s for pod "pvc-volume-tester-writer-zgdzs" in namespace "provisioning-4332" to be "Succeeded or Failed"
Apr 28 22:53:35.307: INFO: Pod "pvc-volume-tester-writer-zgdzs": Phase="Pending", Reason="", readiness=false. Elapsed: 60.623736ms
Apr 28 22:53:37.369: INFO: Pod "pvc-volume-tester-writer-zgdzs": Phase="Succeeded", Reason="", readiness=false. Elapsed: 2.122797516s
STEP: Saw pod success
Apr 28 22:53:37.369: INFO: Pod "pvc-volume-tester-writer-zgdzs" satisfied condition "Succeeded or Failed"
Apr 28 22:53:37.491: INFO: Pod pvc-volume-tester-writer-zgdzs has the following logs: 
Apr 28 22:53:37.491: INFO: Deleting pod "pvc-volume-tester-writer-zgdzs" in namespace "provisioning-4332"
Apr 28 22:53:37.560: INFO: Wait up to 5m0s for pod "pvc-volume-tester-writer-zgdzs" to be fully deleted
STEP: checking the created volume has the correct mount options, is readable and retains data on the same node "ip-172-20-38-81.us-west-2.compute.internal"
Apr 28 22:53:37.809: INFO: Waiting up to 15m0s for pod "pvc-volume-tester-reader-m8vkj" in namespace "provisioning-4332" to be "Succeeded or Failed"
Apr 28 22:53:37.870: INFO: Pod "pvc-volume-tester-reader-m8vkj": Phase="Pending", Reason="", readiness=false. Elapsed: 60.335192ms
Apr 28 22:53:39.931: INFO: Pod "pvc-volume-tester-reader-m8vkj": Phase="Succeeded", Reason="", readiness=false. Elapsed: 2.121192859s
STEP: Saw pod success
Apr 28 22:53:39.931: INFO: Pod "pvc-volume-tester-reader-m8vkj" satisfied condition "Succeeded or Failed"
Apr 28 22:53:40.062: INFO: Pod pvc-volume-tester-reader-m8vkj has the following logs: hello world

Apr 28 22:53:40.062: INFO: Deleting pod "pvc-volume-tester-reader-m8vkj" in namespace "provisioning-4332"
Apr 28 22:53:40.131: INFO: Wait up to 5m0s for pod "pvc-volume-tester-reader-m8vkj" to be fully deleted
Apr 28 22:53:40.198: INFO: Waiting up to timeout=5m0s for PersistentVolumeClaims [pvc-rpw4l] to have phase Bound
Apr 28 22:53:40.258: INFO: PersistentVolumeClaim pvc-rpw4l found and phase=Bound (60.200787ms)
... skipping 28 lines ...