pull-aws-efs-csi-driver-external-test-eks #1540578717208678400 Results

Test Failures

EFS CSI Suite [efs-csi] EFS CSI [Driver: efs.csi.aws.com] should successfully mount a single pod when ReadWriteOncePod is used statically 3.06s

go run hack/e2e.go -v --test --test_args='--ginkgo.focus=EFS\sCSI\sSuite\s\[efs\-csi\]\sEFS\sCSI\s\[Driver\:\sefs\.csi\.aws\.com\]\sshould\ssuccessfully\smount\sa\ssingle\spod\swhen\sReadWriteOncePod\sis\sused\sstatically$'

/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:393
creating efs pvc & pv
Unexpected error:
    <*errors.StatusError | 0xc0009868c0>: {
        ErrStatus: {
            TypeMeta: {Kind: "", APIVersion: ""},
            ListMeta: {
                SelfLink: "",
                ResourceVersion: "",
                Continue: "",
                RemainingItemCount: nil,
            },
            Status: "Failure",
            Message: "PersistentVolume \"efs-8231\" is invalid: spec.accessModes: Unsupported value: \"ReadWriteOncePod\": supported values: \"ReadOnlyMany\", \"ReadWriteMany\", \"ReadWriteOnce\"",
            Reason: "Invalid",
            Details: {
                Name: "efs-8231",
                Group: "",
                Kind: "PersistentVolume",
                UID: "",
                Causes: [
                    {
                        Type: "FieldValueNotSupported",
                        Message: "Unsupported value: \"ReadWriteOncePod\": supported values: \"ReadOnlyMany\", \"ReadWriteMany\", \"ReadWriteOnce\"",
                        Field: "spec.accessModes",
                    },
                ],
                RetryAfterSeconds: 0,
            },
            Code: 422,
        },
    }
    PersistentVolume "efs-8231" is invalid: spec.accessModes: Unsupported value: "ReadWriteOncePod": supported values: "ReadOnlyMany", "ReadWriteMany", "ReadWriteOnce"
occurred
/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:396
				[BeforeEach] [efs-csi] EFS CSI
  /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:221
[BeforeEach] [efs-csi] EFS CSI
  /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:185
�[1mSTEP�[0m: Creating a kubernetes client
Jun 25 06:43:20.700: INFO: >>> kubeConfig: /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/hack/e2e/csi-test-artifacts/test-cluster-32760.k8s.local.eksctl.kubeconfig
�[1mSTEP�[0m: Building a namespace api object, basename efs
�[1mSTEP�[0m: Binding the e2e-test-privileged-psp PodSecurityPolicy to the default service account in efs-8231
�[1mSTEP�[0m: Waiting for a default service account to be provisioned in namespace
[It] should successfully mount a single pod when ReadWriteOncePod is used statically
  /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:393
[AfterEach] [efs-csi] EFS CSI
  /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:186
�[1mSTEP�[0m: Collecting events from namespace "efs-8231".
�[1mSTEP�[0m: Found 0 events.
Jun 25 06:43:21.933: INFO: POD  NODE  PHASE  GRACE  CONDITIONS
Jun 25 06:43:21.933: INFO: 
Jun 25 06:43:22.065: INFO: 
Logging node info for node ip-192-168-13-184.us-west-2.compute.internal
Jun 25 06:43:22.134: INFO: Node Info: &Node{ObjectMeta:{ip-192-168-13-184.us-west-2.compute.internal    10d7d3d6-d59e-43e5-9009-fe01f48cfbac 5493 0 2022-06-25 06:32:40 +0000 UTC <nil> <nil> map[alpha.eksctl.io/cluster-name:test-cluster-32760-k8s-local alpha.eksctl.io/nodegroup-name:ng-41c85649 beta.kubernetes.io/arch:amd64 beta.kubernetes.io/instance-type:c5.large beta.kubernetes.io/os:linux eks.amazonaws.com/capacityType:ON_DEMAND eks.amazonaws.com/nodegroup:ng-41c85649 eks.amazonaws.com/nodegroup-image:ami-00c62627bb6cd7755 eks.amazonaws.com/sourceLaunchTemplateId:lt-0cea3bd32040e9d0c eks.amazonaws.com/sourceLaunchTemplateVersion:1 failure-domain.beta.kubernetes.io/region:us-west-2 failure-domain.beta.kubernetes.io/zone:us-west-2a kubernetes.io/arch:amd64 kubernetes.io/hostname:ip-192-168-13-184.us-west-2.compute.internal kubernetes.io/os:linux node.kubernetes.io/instance-type:c5.large topology.kubernetes.io/region:us-west-2 topology.kubernetes.io/zone:us-west-2a] map[csi.volume.kubernetes.io/nodeid:{"efs.csi.aws.com":"i-0ea17e8507ed49c8d"} node.alpha.kubernetes.io/ttl:0 volumes.kubernetes.io/controller-managed-attach-detach:true] [] []  [{kube-controller-manager Update v1 2022-06-25 06:32:40 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{"f:node.alpha.kubernetes.io/ttl":{}}}} } {kubelet Update v1 2022-06-25 06:38:59 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{"f:csi.volume.kubernetes.io/nodeid":{}}},"f:status":{"f:conditions":{"k:{\"type\":\"DiskPressure\"}":{"f:lastHeartbeatTime":{}},"k:{\"type\":\"MemoryPressure\"}":{"f:lastHeartbeatTime":{}},"k:{\"type\":\"PIDPressure\"}":{"f:lastHeartbeatTime":{}},"k:{\"type\":\"Ready\"}":{"f:lastHeartbeatTime":{},"f:lastTransitionTime":{},"f:message":{},"f:reason":{},"f:status":{}}},"f:images":{}}} status}]},Spec:NodeSpec{PodCIDR:,DoNotUseExternalID:,ProviderID:aws:///us-west-2a/i-0ea17e8507ed49c8d,Unschedulable:false,Taints:[]Taint{},ConfigSource:nil,PodCIDRs:[],},Status:NodeStatus{Capacity:ResourceList{attachable-volumes-aws-ebs: {{25 0} {<nil>} 25 DecimalSI},cpu: {{2 0} {<nil>} 2 DecimalSI},ephemeral-storage: {{85886742528 0} {<nil>} 83873772Ki BinarySI},hugepages-1Gi: {{0 0} {<nil>} 0 DecimalSI},hugepages-2Mi: {{0 0} {<nil>} 0 DecimalSI},memory: {{3871838208 0} {<nil>} 3781092Ki BinarySI},pods: {{29 0} {<nil>} 29 DecimalSI},},Allocatable:ResourceList{attachable-volumes-aws-ebs: {{25 0} {<nil>} 25 DecimalSI},cpu: {{1930 -3} {<nil>} 1930m DecimalSI},ephemeral-storage: {{76224326324 0} {<nil>} 76224326324 DecimalSI},hugepages-1Gi: {{0 0} {<nil>} 0 DecimalSI},hugepages-2Mi: {{0 0} {<nil>} 0 DecimalSI},memory: {{3165097984 0} {<nil>} 3090916Ki BinarySI},pods: {{29 0} {<nil>} 29 DecimalSI},},Phase:,Conditions:[]NodeCondition{NodeCondition{Type:MemoryPressure,Status:False,LastHeartbeatTime:2022-06-25 06:40:42 +0000 UTC,LastTransitionTime:2022-06-25 06:32:38 +0000 UTC,Reason:KubeletHasSufficientMemory,Message:kubelet has sufficient memory available,},NodeCondition{Type:DiskPressure,Status:False,LastHeartbeatTime:2022-06-25 06:40:42 +0000 UTC,LastTransitionTime:2022-06-25 06:32:38 +0000 UTC,Reason:KubeletHasNoDiskPressure,Message:kubelet has no disk pressure,},NodeCondition{Type:PIDPressure,Status:False,LastHeartbeatTime:2022-06-25 06:40:42 +0000 UTC,LastTransitionTime:2022-06-25 06:32:38 +0000 UTC,Reason:KubeletHasSufficientPID,Message:kubelet has sufficient PID available,},NodeCondition{Type:Ready,Status:True,LastHeartbeatTime:2022-06-25 06:40:42 +0000 UTC,LastTransitionTime:2022-06-25 06:33:00 +0000 UTC,Reason:KubeletReady,Message:kubelet is posting ready status,},},Addresses:[]NodeAddress{NodeAddress{Type:InternalIP,Address:192.168.13.184,},NodeAddress{Type:ExternalIP,Address:54.188.3.15,},NodeAddress{Type:Hostname,Address:ip-192-168-13-184.us-west-2.compute.internal,},NodeAddress{Type:InternalDNS,Address:ip-192-168-13-184.us-west-2.compute.internal,},NodeAddress{Type:ExternalDNS,Address:ec2-54-188-3-15.us-west-2.compute.amazonaws.com,},},DaemonEndpoints:NodeDaemonEndpoints{KubeletEndpoint:DaemonEndpoint{Port:10250,},},NodeInfo:NodeSystemInfo{MachineID:ec2b20377d81bc9eeb310d5ada0bfcbd,SystemUUID:ec2b2037-7d81-bc9e-eb31-0d5ada0bfcbd,BootID:db73f9ce-3df3-4469-a531-10b248361580,KernelVersion:5.4.196-108.356.amzn2.x86_64,OSImage:Amazon Linux 2,ContainerRuntimeVersion:docker://20.10.13,KubeletVersion:v1.22.9-eks-810597c,KubeProxyVersion:v1.22.9-eks-810597c,OperatingSystem:linux,Architecture:amd64,},Images:[]ContainerImage{ContainerImage{Names:[607362164682.dkr.ecr.us-west-2.amazonaws.com/aws-efs-csi-driver@sha256:567c597353d2a078ed5421699e1da580f001174679c06e9e07c3e8f75b0953ef 607362164682.dkr.ecr.us-west-2.amazonaws.com/aws-efs-csi-driver:32760],SizeBytes:1176225756,},ContainerImage{Names:[602401143452.dkr.ecr.us-west-2.amazonaws.com/amazon-k8s-cni@sha256:3b6db8b6fb23424366ef91d7e9e818e42291316fa81c00c2c75dcafa614340c5 602401143452.dkr.ecr.us-west-2.amazonaws.com/amazon-k8s-cni:v1.10.1-eksbuild.1],SizeBytes:302003068,},ContainerImage{Names:[602401143452.dkr.ecr.us-west-2.amazonaws.com/amazon-k8s-cni-init@sha256:6c70af7bf257712105a89a896b2afb86c86ace865d32eb73765bf29163a08c56 602401143452.dkr.ecr.us-west-2.amazonaws.com/amazon-k8s-cni-init:v1.10.1-eksbuild.1],SizeBytes:276136949,},ContainerImage{Names:[k8s.gcr.io/e2e-test-images/agnhost@sha256:758db666ac7028534dba72e7e9bb1e57bb81b8196f976f7a5cc351ef8b3529e1 k8s.gcr.io/e2e-test-images/agnhost:2.32],SizeBytes:125930239,},ContainerImage{Names:[602401143452.dkr.ecr.us-west-2.amazonaws.com/eks/kube-proxy@sha256:c8abb4b8efc94090458f34e5f456791d9f7f57b5c99517b6b4e197305c1f10f6 602401143452.dkr.ecr.us-west-2.amazonaws.com/eks/kube-proxy:v1.22.6-eksbuild.1],SizeBytes:103649146,},ContainerImage{Names:[public.ecr.aws/eks-distro/kubernetes-csi/external-provisioner@sha256:74531d40b0707cfe446e80806424a86b881e619b3548d5d0c637dbec4e7161ba public.ecr.aws/eks-distro/kubernetes-csi/external-provisioner:v3.1.1-eks-1-22-8],SizeBytes:46298839,},ContainerImage{Names:[public.ecr.aws/eks-distro/kubernetes-csi/node-driver-registrar@sha256:9919ae098c036f9a52ebca6129ab6aec0864d011eff882b88fd53b5f81097dba public.ecr.aws/eks-distro/kubernetes-csi/node-driver-registrar:v2.5.1-eks-1-22-8],SizeBytes:18754300,},ContainerImage{Names:[public.ecr.aws/eks-distro/kubernetes-csi/livenessprobe@sha256:2c26159cf8e3d5c0c559f82e16928be70e53617a8a012bfb07cecc8722af2cae public.ecr.aws/eks-distro/kubernetes-csi/livenessprobe:v2.7.0-eks-1-22-8],SizeBytes:17370477,},ContainerImage{Names:[k8s.gcr.io/e2e-test-images/busybox@sha256:39e1e963e5310e9c313bad51523be012ede7b35bb9316517d19089a010356592 k8s.gcr.io/e2e-test-images/busybox:1.29-1],SizeBytes:1154361,},ContainerImage{Names:[602401143452.dkr.ecr.us-west-2.amazonaws.com/eks/pause@sha256:1cb4ab85a3480446f9243178395e6bee7350f0d71296daeb6a9fdd221e23aea6 602401143452.dkr.ecr.us-west-2.amazonaws.com/eks/pause:3.1-eksbuild.1],SizeBytes:682696,},},VolumesInUse:[],VolumesAttached:[]AttachedVolume{},Config:nil,},}
Jun 25 06:43:22.135: INFO: 
Logging kubelet events for node ip-192-168-13-184.us-west-2.compute.internal
Jun 25 06:43:22.205: INFO: 
Logging pods the kubelet thinks is on node ip-192-168-13-184.us-west-2.compute.internal
Jun 25 06:43:22.360: INFO: aws-node-qln6x started at 2022-06-25 06:32:41 +0000 UTC (1+1 container statuses recorded)
Jun 25 06:43:22.360: INFO: 	Init container aws-vpc-cni-init ready: true, restart count 0
Jun 25 06:43:22.360: INFO: 	Container aws-node ready: true, restart count 0
Jun 25 06:43:22.360: INFO: kube-proxy-ltsvn started at 2022-06-25 06:32:41 +0000 UTC (0+1 container statuses recorded)
Jun 25 06:43:22.360: INFO: 	Container kube-proxy ready: true, restart count 0
Jun 25 06:43:22.360: INFO: efs-csi-node-6s4jv started at 2022-06-25 06:38:57 +0000 UTC (0+3 container statuses recorded)
Jun 25 06:43:22.360: INFO: 	Container csi-driver-registrar ready: true, restart count 0
Jun 25 06:43:22.360: INFO: 	Container efs-plugin ready: true, restart count 0
Jun 25 06:43:22.360: INFO: 	Container liveness-probe ready: true, restart count 0
Jun 25 06:43:22.360: INFO: efs-csi-controller-96794b79b-fflxs started at 2022-06-25 06:35:20 +0000 UTC (0+3 container statuses recorded)
Jun 25 06:43:22.360: INFO: 	Container csi-provisioner ready: true, restart count 0
Jun 25 06:43:22.360: INFO: 	Container efs-plugin ready: true, restart count 0
Jun 25 06:43:22.360: INFO: 	Container liveness-probe ready: true, restart count 0
Jun 25 06:43:22.678: INFO: 
Latency metrics for node ip-192-168-13-184.us-west-2.compute.internal
Jun 25 06:43:22.678: INFO: 
Logging node info for node ip-192-168-37-190.us-west-2.compute.internal
Jun 25 06:43:22.746: INFO: Node Info: &Node{ObjectMeta:{ip-192-168-37-190.us-west-2.compute.internal    921d8dff-06be-497d-a3eb-c03143baba5b 5200 0 2022-06-25 06:32:40 +0000 UTC <nil> <nil> map[alpha.eksctl.io/cluster-name:test-cluster-32760-k8s-local alpha.eksctl.io/nodegroup-name:ng-41c85649 beta.kubernetes.io/arch:amd64 beta.kubernetes.io/instance-type:c5.large beta.kubernetes.io/os:linux eks.amazonaws.com/capacityType:ON_DEMAND eks.amazonaws.com/nodegroup:ng-41c85649 eks.amazonaws.com/nodegroup-image:ami-00c62627bb6cd7755 eks.amazonaws.com/sourceLaunchTemplateId:lt-0cea3bd32040e9d0c eks.amazonaws.com/sourceLaunchTemplateVersion:1 failure-domain.beta.kubernetes.io/region:us-west-2 failure-domain.beta.kubernetes.io/zone:us-west-2b kubernetes.io/arch:amd64 kubernetes.io/hostname:ip-192-168-37-190.us-west-2.compute.internal kubernetes.io/os:linux node.kubernetes.io/instance-type:c5.large topology.kubernetes.io/region:us-west-2 topology.kubernetes.io/zone:us-west-2b] map[csi.volume.kubernetes.io/nodeid:{"efs.csi.aws.com":"i-0acda4cdbe0a36d03"} node.alpha.kubernetes.io/ttl:0 volumes.kubernetes.io/controller-managed-attach-detach:true] [] []  [{kube-controller-manager Update v1 2022-06-25 06:32:40 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{"f:node.alpha.kubernetes.io/ttl":{}}}} } {kubelet Update v1 2022-06-25 06:35:42 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{"f:csi.volume.kubernetes.io/nodeid":{}}},"f:status":{"f:conditions":{"k:{\"type\":\"DiskPressure\"}":{"f:lastHeartbeatTime":{}},"k:{\"type\":\"MemoryPressure\"}":{"f:lastHeartbeatTime":{}},"k:{\"type\":\"PIDPressure\"}":{"f:lastHeartbeatTime":{}},"k:{\"type\":\"Ready\"}":{"f:lastHeartbeatTime":{},"f:lastTransitionTime":{},"f:message":{},"f:reason":{},"f:status":{}}},"f:images":{}}} status}]},Spec:NodeSpec{PodCIDR:,DoNotUseExternalID:,ProviderID:aws:///us-west-2b/i-0acda4cdbe0a36d03,Unschedulable:false,Taints:[]Taint{},ConfigSource:nil,PodCIDRs:[],},Status:NodeStatus{Capacity:ResourceList{attachable-volumes-aws-ebs: {{25 0} {<nil>} 25 DecimalSI},cpu: {{2 0} {<nil>} 2 DecimalSI},ephemeral-storage: {{85886742528 0} {<nil>} 83873772Ki BinarySI},hugepages-1Gi: {{0 0} {<nil>} 0 DecimalSI},hugepages-2Mi: {{0 0} {<nil>} 0 DecimalSI},memory: {{3901198336 0} {<nil>} 3809764Ki BinarySI},pods: {{29 0} {<nil>} 29 DecimalSI},},Allocatable:ResourceList{attachable-volumes-aws-ebs: {{25 0} {<nil>} 25 DecimalSI},cpu: {{1930 -3} {<nil>} 1930m DecimalSI},ephemeral-storage: {{76224326324 0} {<nil>} 76224326324 DecimalSI},hugepages-1Gi: {{0 0} {<nil>} 0 DecimalSI},hugepages-2Mi: {{0 0} {<nil>} 0 DecimalSI},memory: {{3194458112 0} {<nil>} 3119588Ki BinarySI},pods: {{29 0} {<nil>} 29 DecimalSI},},Phase:,Conditions:[]NodeCondition{NodeCondition{Type:MemoryPressure,Status:False,LastHeartbeatTime:2022-06-25 06:40:12 +0000 UTC,LastTransitionTime:2022-06-25 06:32:39 +0000 UTC,Reason:KubeletHasSufficientMemory,Message:kubelet has sufficient memory available,},NodeCondition{Type:DiskPressure,Status:False,LastHeartbeatTime:2022-06-25 06:40:12 +0000 UTC,LastTransitionTime:2022-06-25 06:32:39 +0000 UTC,Reason:KubeletHasNoDiskPressure,Message:kubelet has no disk pressure,},NodeCondition{Type:PIDPressure,Status:False,LastHeartbeatTime:2022-06-25 06:40:12 +0000 UTC,LastTransitionTime:2022-06-25 06:32:39 +0000 UTC,Reason:KubeletHasSufficientPID,Message:kubelet has sufficient PID available,},NodeCondition{Type:Ready,Status:True,LastHeartbeatTime:2022-06-25 06:40:12 +0000 UTC,LastTransitionTime:2022-06-25 06:33:01 +0000 UTC,Reason:KubeletReady,Message:kubelet is posting ready status,},},Addresses:[]NodeAddress{NodeAddress{Type:InternalIP,Address:192.168.37.190,},NodeAddress{Type:ExternalIP,Address:34.222.252.209,},NodeAddress{Type:Hostname,Address:ip-192-168-37-190.us-west-2.compute.internal,},NodeAddress{Type:InternalDNS,Address:ip-192-168-37-190.us-west-2.compute.internal,},NodeAddress{Type:ExternalDNS,Address:ec2-34-222-252-209.us-west-2.compute.amazonaws.com,},},DaemonEndpoints:NodeDaemonEndpoints{KubeletEndpoint:DaemonEndpoint{Port:10250,},},NodeInfo:NodeSystemInfo{MachineID:ec28fefc1a3bc27457d084613c78b2a7,SystemUUID:ec28fefc-1a3b-c274-57d0-84613c78b2a7,BootID:e1b59c2a-2867-447a-aed5-2e39ee480e01,KernelVersion:5.4.196-108.356.amzn2.x86_64,OSImage:Amazon Linux 2,ContainerRuntimeVersion:docker://20.10.13,KubeletVersion:v1.22.9-eks-810597c,KubeProxyVersion:v1.22.9-eks-810597c,OperatingSystem:linux,Architecture:amd64,},Images:[]ContainerImage{ContainerImage{Names:[607362164682.dkr.ecr.us-west-2.amazonaws.com/aws-efs-csi-driver@sha256:567c597353d2a078ed5421699e1da580f001174679c06e9e07c3e8f75b0953ef 607362164682.dkr.ecr.us-west-2.amazonaws.com/aws-efs-csi-driver:32760],SizeBytes:1176225756,},ContainerImage{Names:[602401143452.dkr.ecr.us-west-2.amazonaws.com/amazon-k8s-cni@sha256:3b6db8b6fb23424366ef91d7e9e818e42291316fa81c00c2c75dcafa614340c5 602401143452.dkr.ecr.us-west-2.amazonaws.com/amazon-k8s-cni:v1.10.1-eksbuild.1],SizeBytes:302003068,},ContainerImage{Names:[602401143452.dkr.ecr.us-west-2.amazonaws.com/amazon-k8s-cni-init@sha256:6c70af7bf257712105a89a896b2afb86c86ace865d32eb73765bf29163a08c56 602401143452.dkr.ecr.us-west-2.amazonaws.com/amazon-k8s-cni-init:v1.10.1-eksbuild.1],SizeBytes:276136949,},ContainerImage{Names:[k8s.gcr.io/e2e-test-images/jessie-dnsutils@sha256:702a992280fb7c3303e84a5801acbb4c9c7fcf48cffe0e9c8be3f0c60f74cf89 k8s.gcr.io/e2e-test-images/jessie-dnsutils:1.4],SizeBytes:253371792,},ContainerImage{Names:[602401143452.dkr.ecr.us-west-2.amazonaws.com/eks/kube-proxy@sha256:c8abb4b8efc94090458f34e5f456791d9f7f57b5c99517b6b4e197305c1f10f6 602401143452.dkr.ecr.us-west-2.amazonaws.com/eks/kube-proxy:v1.22.6-eksbuild.1],SizeBytes:103649146,},ContainerImage{Names:[public.ecr.aws/eks-distro/kubernetes-csi/external-provisioner@sha256:74531d40b0707cfe446e80806424a86b881e619b3548d5d0c637dbec4e7161ba public.ecr.aws/eks-distro/kubernetes-csi/external-provisioner:v3.1.1-eks-1-22-8],SizeBytes:46298839,},ContainerImage{Names:[public.ecr.aws/eks-distro/kubernetes-csi/node-driver-registrar@sha256:9919ae098c036f9a52ebca6129ab6aec0864d011eff882b88fd53b5f81097dba public.ecr.aws/eks-distro/kubernetes-csi/node-driver-registrar:v2.5.1-eks-1-22-8],SizeBytes:18754300,},ContainerImage{Names:[public.ecr.aws/eks-distro/kubernetes-csi/livenessprobe@sha256:2c26159cf8e3d5c0c559f82e16928be70e53617a8a012bfb07cecc8722af2cae public.ecr.aws/eks-distro/kubernetes-csi/livenessprobe:v2.7.0-eks-1-22-8],SizeBytes:17370477,},ContainerImage{Names:[k8s.gcr.io/e2e-test-images/busybox@sha256:39e1e963e5310e9c313bad51523be012ede7b35bb9316517d19089a010356592 k8s.gcr.io/e2e-test-images/busybox:1.29-1],SizeBytes:1154361,},ContainerImage{Names:[602401143452.dkr.ecr.us-west-2.amazonaws.com/eks/pause@sha256:1cb4ab85a3480446f9243178395e6bee7350f0d71296daeb6a9fdd221e23aea6 602401143452.dkr.ecr.us-west-2.amazonaws.com/eks/pause:3.1-eksbuild.1],SizeBytes:682696,},},VolumesInUse:[],VolumesAttached:[]AttachedVolume{},Config:nil,},}
Jun 25 06:43:22.746: INFO: 
Logging kubelet events for node ip-192-168-37-190.us-west-2.compute.internal
Jun 25 06:43:22.819: INFO: 
Logging pods the kubelet thinks is on node ip-192-168-37-190.us-west-2.compute.internal
Jun 25 06:43:22.888: INFO: kube-proxy-5hj6b started at 2022-06-25 06:32:40 +0000 UTC (0+1 container statuses recorded)
Jun 25 06:43:22.888: INFO: 	Container kube-proxy ready: true, restart count 0
Jun 25 06:43:22.888: INFO: aws-node-b55bx started at 2022-06-25 06:32:40 +0000 UTC (1+1 container statuses recorded)
Jun 25 06:43:22.888: INFO: 	Init container aws-vpc-cni-init ready: true, restart count 0
Jun 25 06:43:22.888: INFO: 	Container aws-node ready: true, restart count 0
Jun 25 06:43:22.888: INFO: efs-csi-node-hbts7 started at 2022-06-25 06:35:20 +0000 UTC (0+3 container statuses recorded)
Jun 25 06:43:22.888: INFO: 	Container csi-driver-registrar ready: true, restart count 0
Jun 25 06:43:22.888: INFO: 	Container efs-plugin ready: true, restart count 0
Jun 25 06:43:22.888: INFO: 	Container liveness-probe ready: true, restart count 0
Jun 25 06:43:22.888: INFO: efs-csi-controller-96794b79b-9wfkn started at 2022-06-25 06:35:20 +0000 UTC (0+3 container statuses recorded)
Jun 25 06:43:22.888: INFO: 	Container csi-provisioner ready: true, restart count 0
Jun 25 06:43:22.888: INFO: 	Container efs-plugin ready: true, restart count 0
Jun 25 06:43:22.888: INFO: 	Container liveness-probe ready: true, restart count 0
Jun 25 06:43:23.124: INFO: 
Latency metrics for node ip-192-168-37-190.us-west-2.compute.internal
Jun 25 06:43:23.125: INFO: 
Logging node info for node ip-192-168-73-74.us-west-2.compute.internal
Jun 25 06:43:23.192: INFO: Node Info: &Node{ObjectMeta:{ip-192-168-73-74.us-west-2.compute.internal    117c692f-82aa-4400-9539-e81a715a7325 7027 0 2022-06-25 06:32:37 +0000 UTC <nil> <nil> map[alpha.eksctl.io/cluster-name:test-cluster-32760-k8s-local alpha.eksctl.io/nodegroup-name:ng-41c85649 beta.kubernetes.io/arch:amd64 beta.kubernetes.io/instance-type:c5.large beta.kubernetes.io/os:linux eks.amazonaws.com/capacityType:ON_DEMAND eks.amazonaws.com/nodegroup:ng-41c85649 eks.amazonaws.com/nodegroup-image:ami-00c62627bb6cd7755 eks.amazonaws.com/sourceLaunchTemplateId:lt-0cea3bd32040e9d0c eks.amazonaws.com/sourceLaunchTemplateVersion:1 failure-domain.beta.kubernetes.io/region:us-west-2 failure-domain.beta.kubernetes.io/zone:us-west-2c kubernetes.io/arch:amd64 kubernetes.io/hostname:ip-192-168-73-74.us-west-2.compute.internal kubernetes.io/os:linux node.kubernetes.io/instance-type:c5.large topology.kubernetes.io/region:us-west-2 topology.kubernetes.io/zone:us-west-2c] map[csi.volume.kubernetes.io/nodeid:{"efs.csi.aws.com":"i-0ef9f2f112292fe49"} node.alpha.kubernetes.io/ttl:0 volumes.kubernetes.io/controller-managed-attach-detach:true] [] []  [{kube-controller-manager Update v1 2022-06-25 06:32:37 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{"f:node.alpha.kubernetes.io/ttl":{}}}} } {kubelet Update v1 2022-06-25 06:32:37 +0000 UTC FieldsV1 {"f:status":{"f:allocatable":{"f:ephemeral-storage":{}},"f:capacity":{"f:ephemeral-storage":{}}}} } {kubelet Update v1 2022-06-25 06:35:41 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{"f:csi.volume.kubernetes.io/nodeid":{}}},"f:status":{"f:conditions":{"k:{\"type\":\"DiskPressure\"}":{"f:lastHeartbeatTime":{}},"k:{\"type\":\"MemoryPressure\"}":{"f:lastHeartbeatTime":{}},"k:{\"type\":\"PIDPressure\"}":{"f:lastHeartbeatTime":{}},"k:{\"type\":\"Ready\"}":{"f:lastHeartbeatTime":{},"f:lastTransitionTime":{},"f:message":{},"f:reason":{},"f:status":{}}},"f:images":{}}} status}]},Spec:NodeSpec{PodCIDR:,DoNotUseExternalID:,ProviderID:aws:///us-west-2c/i-0ef9f2f112292fe49,Unschedulable:false,Taints:[]Taint{},ConfigSource:nil,PodCIDRs:[],},Status:NodeStatus{Capacity:ResourceList{attachable-volumes-aws-ebs: {{25 0} {<nil>} 25 DecimalSI},cpu: {{2 0} {<nil>} 2 DecimalSI},ephemeral-storage: {{85886742528 0} {<nil>} 83873772Ki BinarySI},hugepages-1Gi: {{0 0} {<nil>} 0 DecimalSI},hugepages-2Mi: {{0 0} {<nil>} 0 DecimalSI},memory: {{3871838208 0} {<nil>} 3781092Ki BinarySI},pods: {{29 0} {<nil>} 29 DecimalSI},},Allocatable:ResourceList{attachable-volumes-aws-ebs: {{25 0} {<nil>} 25 DecimalSI},cpu: {{1930 -3} {<nil>} 1930m DecimalSI},ephemeral-storage: {{76224326324 0} {<nil>} 76224326324 DecimalSI},hugepages-1Gi: {{0 0} {<nil>} 0 DecimalSI},hugepages-2Mi: {{0 0} {<nil>} 0 DecimalSI},memory: {{3165097984 0} {<nil>} 3090916Ki BinarySI},pods: {{29 0} {<nil>} 29 DecimalSI},},Phase:,Conditions:[]NodeCondition{NodeCondition{Type:MemoryPressure,Status:False,LastHeartbeatTime:2022-06-25 06:42:39 +0000 UTC,LastTransitionTime:2022-06-25 06:32:35 +0000 UTC,Reason:KubeletHasSufficientMemory,Message:kubelet has sufficient memory available,},NodeCondition{Type:DiskPressure,Status:False,LastHeartbeatTime:2022-06-25 06:42:39 +0000 UTC,LastTransitionTime:2022-06-25 06:32:35 +0000 UTC,Reason:KubeletHasNoDiskPressure,Message:kubelet has no disk pressure,},NodeCondition{Type:PIDPressure,Status:False,LastHeartbeatTime:2022-06-25 06:42:39 +0000 UTC,LastTransitionTime:2022-06-25 06:32:35 +0000 UTC,Reason:KubeletHasSufficientPID,Message:kubelet has sufficient PID available,},NodeCondition{Type:Ready,Status:True,LastHeartbeatTime:2022-06-25 06:42:39 +0000 UTC,LastTransitionTime:2022-06-25 06:32:57 +0000 UTC,Reason:KubeletReady,Message:kubelet is posting ready status,},},Addresses:[]NodeAddress{NodeAddress{Type:InternalIP,Address:192.168.73.74,},NodeAddress{Type:ExternalIP,Address:34.210.45.243,},NodeAddress{Type:Hostname,Address:ip-192-168-73-74.us-west-2.compute.internal,},NodeAddress{Type:InternalDNS,Address:ip-192-168-73-74.us-west-2.compute.internal,},NodeAddress{Type:ExternalDNS,Address:ec2-34-210-45-243.us-west-2.compute.amazonaws.com,},},DaemonEndpoints:NodeDaemonEndpoints{KubeletEndpoint:DaemonEndpoint{Port:10250,},},NodeInfo:NodeSystemInfo{MachineID:ec209662741e743d5ee21e71ed01cbe6,SystemUUID:ec209662-741e-743d-5ee2-1e71ed01cbe6,BootID:8c76a12c-3c13-483b-9067-361d6d35ac63,KernelVersion:5.4.196-108.356.amzn2.x86_64,OSImage:Amazon Linux 2,ContainerRuntimeVersion:docker://20.10.13,KubeletVersion:v1.22.9-eks-810597c,KubeProxyVersion:v1.22.9-eks-810597c,OperatingSystem:linux,Architecture:amd64,},Images:[]ContainerImage{ContainerImage{Names:[607362164682.dkr.ecr.us-west-2.amazonaws.com/aws-efs-csi-driver@sha256:567c597353d2a078ed5421699e1da580f001174679c06e9e07c3e8f75b0953ef 607362164682.dkr.ecr.us-west-2.amazonaws.com/aws-efs-csi-driver:32760],SizeBytes:1176225756,},ContainerImage{Names:[602401143452.dkr.ecr.us-west-2.amazonaws.com/amazon-k8s-cni@sha256:3b6db8b6fb23424366ef91d7e9e818e42291316fa81c00c2c75dcafa614340c5 602401143452.dkr.ecr.us-west-2.amazonaws.com/amazon-k8s-cni:v1.10.1-eksbuild.1],SizeBytes:302003068,},ContainerImage{Names:[602401143452.dkr.ecr.us-west-2.amazonaws.com/amazon-k8s-cni-init@sha256:6c70af7bf257712105a89a896b2afb86c86ace865d32eb73765bf29163a08c56 602401143452.dkr.ecr.us-west-2.amazonaws.com/amazon-k8s-cni-init:v1.10.1-eksbuild.1],SizeBytes:276136949,},ContainerImage{Names:[k8s.gcr.io/e2e-test-images/agnhost@sha256:758db666ac7028534dba72e7e9bb1e57bb81b8196f976f7a5cc351ef8b3529e1 k8s.gcr.io/e2e-test-images/agnhost:2.32],SizeBytes:125930239,},ContainerImage{Names:[602401143452.dkr.ecr.us-west-2.amazonaws.com/eks/kube-proxy@sha256:c8abb4b8efc94090458f34e5f456791d9f7f57b5c99517b6b4e197305c1f10f6 602401143452.dkr.ecr.us-west-2.amazonaws.com/eks/kube-proxy:v1.22.6-eksbuild.1],SizeBytes:103649146,},ContainerImage{Names:[602401143452.dkr.ecr.us-west-2.amazonaws.com/eks/coredns@sha256:09c4a9684cc63dc17565b656b57797498b4a5d5e10f4286ce5ad6ff7435d7f3d 602401143452.dkr.ecr.us-west-2.amazonaws.com/eks/coredns:v1.8.7-eksbuild.1],SizeBytes:48975754,},ContainerImage{Names:[public.ecr.aws/eks-distro/kubernetes-csi/node-driver-registrar@sha256:9919ae098c036f9a52ebca6129ab6aec0864d011eff882b88fd53b5f81097dba public.ecr.aws/eks-distro/kubernetes-csi/node-driver-registrar:v2.5.1-eks-1-22-8],SizeBytes:18754300,},ContainerImage{Names:[public.ecr.aws/eks-distro/kubernetes-csi/livenessprobe@sha256:2c26159cf8e3d5c0c559f82e16928be70e53617a8a012bfb07cecc8722af2cae public.ecr.aws/eks-distro/kubernetes-csi/livenessprobe:v2.7.0-eks-1-22-8],SizeBytes:17370477,},ContainerImage{Names:[k8s.gcr.io/e2e-test-images/nginx@sha256:503b7abb89e57383eba61cc8a9cb0b495ea575c516108f7d972a6ff6e1ab3c9b k8s.gcr.io/e2e-test-images/nginx:1.14-1],SizeBytes:16032814,},ContainerImage{Names:[k8s.gcr.io/e2e-test-images/busybox@sha256:39e1e963e5310e9c313bad51523be012ede7b35bb9316517d19089a010356592 k8s.gcr.io/e2e-test-images/busybox:1.29-1],SizeBytes:1154361,},ContainerImage{Names:[602401143452.dkr.ecr.us-west-2.amazonaws.com/eks/pause@sha256:1cb4ab85a3480446f9243178395e6bee7350f0d71296daeb6a9fdd221e23aea6 602401143452.dkr.ecr.us-west-2.amazonaws.com/eks/pause:3.1-eksbuild.1],SizeBytes:682696,},},VolumesInUse:[],VolumesAttached:[]AttachedVolume{},Config:nil,},}
Jun 25 06:43:23.192: INFO: 
Logging kubelet events for node ip-192-168-73-74.us-west-2.compute.internal
Jun 25 06:43:23.263: INFO: 
Logging pods the kubelet thinks is on node ip-192-168-73-74.us-west-2.compute.internal
Jun 25 06:43:23.347: INFO: kube-proxy-9xmsp started at 2022-06-25 06:32:37 +0000 UTC (0+1 container statuses recorded)
Jun 25 06:43:23.348: INFO: 	Container kube-proxy ready: true, restart count 0
Jun 25 06:43:23.348: INFO: aws-node-tsbmm started at 2022-06-25 06:32:37 +0000 UTC (1+1 container statuses recorded)
Jun 25 06:43:23.348: INFO: 	Init container aws-vpc-cni-init ready: true, restart count 0
Jun 25 06:43:23.348: INFO: 	Container aws-node ready: true, restart count 0
Jun 25 06:43:23.348: INFO: coredns-657694c6f4-4xjgf started at 2022-06-25 06:32:57 +0000 UTC (0+1 container statuses recorded)
Jun 25 06:43:23.348: INFO: 	Container coredns ready: true, restart count 0
Jun 25 06:43:23.348: INFO: coredns-657694c6f4-j96kd started at 2022-06-25 06:32:57 +0000 UTC (0+1 container statuses recorded)
Jun 25 06:43:23.348: INFO: 	Container coredns ready: true, restart count 0
Jun 25 06:43:23.348: INFO: efs-csi-node-szrsb started at 2022-06-25 06:35:20 +0000 UTC (0+3 container statuses recorded)
Jun 25 06:43:23.348: INFO: 	Container csi-driver-registrar ready: true, restart count 0
Jun 25 06:43:23.348: INFO: 	Container efs-plugin ready: true, restart count 0
Jun 25 06:43:23.348: INFO: 	Container liveness-probe ready: true, restart count 0
Jun 25 06:43:23.600: INFO: 
Latency metrics for node ip-192-168-73-74.us-west-2.compute.internal
Jun 25 06:43:23.600: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
�[1mSTEP�[0m: Destroying namespace "efs-8231" for this suite.

				Click to see stdout/stderrfrom junit_04.xml

Filter through log files | View test history on testgrid

Show 154 Skipped Tests

Error lines from build-log.txt

Raw build-log.txt

... skipping 269 lines ...
#0 3.402 --> Processing Dependency: libperl.so()(64bit) for package: 4:perl-5.16.3-299.amzn2.0.1.x86_64
#0 3.402 ---> Package perl-File-Temp.noarch 0:0.23.01-3.amzn2 will be installed
#0 3.404 ---> Package perl-Getopt-Long.noarch 0:2.40-3.amzn2 will be installed
#0 3.405 --> Processing Dependency: perl(Pod::Usage) >= 1.14 for package: perl-Getopt-Long-2.40-3.amzn2.noarch
#0 3.406 --> Processing Dependency: perl(Text::ParseWords) for package: perl-Getopt-Long-2.40-3.amzn2.noarch
#0 3.407 ---> Package perl-Git.noarch 0:2.32.0-1.amzn2.0.1 will be installed
#0 3.409 --> Processing Dependency: perl(Error) for package: perl-Git-2.32.0-1.amzn2.0.1.noarch
#0 3.410 ---> Package perl-PathTools.x86_64 0:3.40-5.amzn2.0.2 will be installed
#0 3.411 ---> Package perl-TermReadKey.x86_64 0:2.30-20.amzn2.0.2 will be installed
#0 3.412 ---> Package perl-Thread-Queue.noarch 0:3.02-2.amzn2 will be installed
#0 3.413 ---> Package perl-threads.x86_64 0:1.87-4.amzn2.0.2 will be installed
#0 3.415 ---> Package pkgconfig.x86_64 1:0.27.1-4.amzn2.0.2 will be installed
#0 3.418 ---> Package system-rpm-config.noarch 0:9.1.0-76.amzn2.0.14 will be installed
... skipping 15 lines ...
#0 3.489 --> Processing Dependency: openssh = 7.4p1-22.amzn2.0.1 for package: openssh-clients-7.4p1-22.amzn2.0.1.x86_64
#0 3.492 --> Processing Dependency: fipscheck-lib(x86-64) >= 1.3.0 for package: openssh-clients-7.4p1-22.amzn2.0.1.x86_64
#0 3.495 --> Processing Dependency: libfipscheck.so.1()(64bit) for package: openssh-clients-7.4p1-22.amzn2.0.1.x86_64
#0 3.495 --> Processing Dependency: libedit.so.0()(64bit) for package: openssh-clients-7.4p1-22.amzn2.0.1.x86_64
#0 3.497 ---> Package pcre2.x86_64 0:10.23-2.amzn2.0.2 will be installed
#0 3.499 ---> Package perl-Carp.noarch 0:1.26-244.amzn2 will be installed
#0 3.499 ---> Package perl-Error.noarch 1:0.17020-2.amzn2 will be installed
#0 3.500 ---> Package perl-Exporter.noarch 0:5.68-3.amzn2 will be installed
#10 3.501 ---> Package perl-File-Path.noarch 0:2.09-2.amzn2 will be installed
#10 3.502 ---> Package perl-Filter.x86_64 0:1.49-3.amzn2.0.2 will be installed
#10 3.504 ---> Package perl-Pod-Simple.noarch 1:3.28-4.amzn2 will be installed
#10 3.507 --> Processing Dependency: perl(Pod::Escapes) >= 1.04 for package: 1:perl-Pod-Simple-3.28-4.amzn2.noarch
#10 3.509 --> Processing Dependency: perl(Encode) for package: 1:perl-Pod-Simple-3.28-4.amzn2.noarch
... skipping 169 lines ...
#10 3.955  pam                       x86_64 1.1.8-23.amzn2.0.1           amzn2-core 715 k
#10 3.955  patch                     x86_64 2.7.1-12.amzn2.0.2           amzn2-core 110 k
#10 3.955  pcre2                     x86_64 10.23-2.amzn2.0.2            amzn2-core 209 k
#10 3.955  perl                      x86_64 4:5.16.3-299.amzn2.0.1       amzn2-core 8.0 M
#10 3.955  perl-Carp                 noarch 1.26-244.amzn2               amzn2-core  19 k
#10 3.955  perl-Encode               x86_64 2.51-7.amzn2.0.2             amzn2-core 1.5 M
#10 3.955  perl-Error                noarch 1:0.17020-2.amzn2            amzn2-core  32 k
#10 3.956  perl-Exporter             noarch 5.68-3.amzn2                 amzn2-core  29 k
#10 3.956  perl-File-Path            noarch 2.09-2.amzn2                 amzn2-core  27 k
#10 3.956  perl-File-Temp            noarch 0.23.01-3.amzn2              amzn2-core  56 k
#10 3.956  perl-Filter               x86_64 1.49-3.amzn2.0.2             amzn2-core  76 k
#10 3.956  perl-Getopt-Long          noarch 2.40-3.amzn2                 amzn2-core  56 k
#10 3.956  perl-Git                  noarch 2.32.0-1.amzn2.0.1           amzn2-core  43 k
... skipping 91 lines ...
#10 9.756   Installing : 1:perl-Pod-Simple-3.28-4.amzn2.noarch                      34/88 
#10 9.810   Installing : perl-Getopt-Long-2.40-3.amzn2.noarch                       35/88 
#10 9.954   Installing : 4:perl-libs-5.16.3-299.amzn2.0.1.x86_64                    36/88 
#10 11.68   Installing : 4:perl-5.16.3-299.amzn2.0.1.x86_64                         37/88 
#10 11.75   Installing : perl-Thread-Queue-3.02-2.amzn2.noarch                      38/88 
#10 11.79   Installing : perl-TermReadKey-2.30-20.amzn2.0.2.x86_64                  39/88 
#10 11.84   Installing : 1:perl-Error-0.17020-2.amzn2.noarch                        40/88 
#10 11.87   Installing : fipscheck-lib-1.4.1-6.amzn2.0.2.x86_64                     41/88 
#10 11.91   Installing : fipscheck-1.4.1-6.amzn2.0.2.x86_64                         42/88 
#10 11.95   Installing : dwz-0.11-3.amzn2.0.3.x86_64                                43/88 
#10 11.98   Installing : 1:pkgconfig-0.27.1-4.amzn2.0.2.x86_64                      44/88 
#10 12.05   Installing : pcre2-10.23-2.amzn2.0.2.x86_64                             45/88 
#10 12.12   Installing : libsmartcols-2.30.2-2.amzn2.0.7.x86_64                     46/88 
... skipping 33 lines ...
#0 0.442 CGO_ENABLED=0 GOOS=linux GOARCH=amd64 go build -mod=vendor -ldflags "-X github.com/kubernetes-sigs/aws-efs-csi-driver/pkg/driver.driverVersion=v1.4.0 -X github.com/kubernetes-sigs/aws-efs-csi-driver/pkg/driver.gitCommit=ac61af6d9336d7aac7d1eac6bd027a850bd40782 -X github.com/kubernetes-sigs/aws-efs-csi-driver/pkg/driver.buildDate=2022-06-25T06:13:47Z -X github.com/kubernetes-sigs/aws-efs-csi-driver/pkg/driver.efsClientSource=k8s" -o bin/aws-efs-csi-driver ./cmd/
#14 ...

#10 [linux-amazon 3/7] RUN if [ "github" = "yum" ];     then echo "Installing efs-utils from Amazon Linux 2 yum repo" &&          yum -y install amazon-efs-utils-1.31.1-1.amzn2.noarch;     else echo "Installing efs-utils from github using the latest git tag" &&          yum -y install git rpm-build make &&          git clone https://github.com/aws/efs-utils &&          cd efs-utils &&          git checkout $(git describe --tags $(git rev-list --tags --max-count=1)) &&          make rpm && yum -y install build/amazon-efs-utils*rpm &&          cd .. && rm -rf efs-utils &&          yum clean all;     fi
#10 16.89   Installing : 1:dbus-libs-1.10.24-7.amzn2.x86_64                         76/88 
#10 18.32   Installing : systemd-219-78.amzn2.0.18.x86_64                           77/88 
#10 18.84 Failed to get D-Bus connection: Operation not permitted
#10 18.88   Installing : elfutils-default-yama-scope-0.176-2.amzn2.noarch           78/88 
#10 19.04   Installing : 1:dbus-1.10.24-7.amzn2.x86_64                              79/88 
#10 19.12   Installing : elfutils-0.176-2.amzn2.x86_64                              80/88 
#10 19.28   Installing : openssh-7.4p1-22.amzn2.0.1.x86_64                          81/88 
#10 19.45   Installing : openssh-clients-7.4p1-22.amzn2.0.1.x86_64                  82/88 
#10 20.69   Installing : git-core-2.32.0-1.amzn2.0.1.x86_64                         83/88 
... skipping 55 lines ...
#10 22.46   Verifying  : perl-File-Temp-0.23.01-3.amzn2.noarch                      51/88 
#10 22.47   Verifying  : perl-srpm-macros-1-8.amzn2.0.1.noarch                      52/88 
#10 22.49   Verifying  : pam-1.1.8-23.amzn2.0.1.x86_64                              53/88 
#10 22.50   Verifying  : xz-5.2.2-1.amzn2.0.3.x86_64                                54/88 
#10 22.51   Verifying  : ustr-1.0.4-16.amzn2.0.3.x86_64                             55/88 
#10 22.52   Verifying  : less-458-9.amzn2.0.2.x86_64                                56/88 
#10 22.54   Verifying  : 1:perl-Error-0.17020-2.amzn2.noarch                        57/88 
#10 22.55   Verifying  : perl-Pod-Usage-1.63-3.amzn2.noarch                         58/88 
#10 22.57   Verifying  : unzip-6.0-43.amzn2.x86_64                                  59/88 
#10 22.58   Verifying  : 1:perl-parent-0.225-244.amzn2.0.1.noarch                   60/88 
#10 22.61   Verifying  : perl-Pod-Perldoc-3.20-4.amzn2.noarch                       61/88 
#10 22.63   Verifying  : 2:tar-1.26-35.amzn2.x86_64                                 62/88 
#10 22.64   Verifying  : zip-3.0-11.amzn2.0.2.x86_64                                63/88 
... skipping 69 lines ...
#10 23.19   pam.x86_64 0:1.1.8-23.amzn2.0.1                                               
#10 23.19   patch.x86_64 0:2.7.1-12.amzn2.0.2                                             
#10 23.19   pcre2.x86_64 0:10.23-2.amzn2.0.2                                              
#10 23.19   perl.x86_64 4:5.16.3-299.amzn2.0.1                                            
#10 23.19   perl-Carp.noarch 0:1.26-244.amzn2                                             
#10 23.19   perl-Encode.x86_64 0:2.51-7.amzn2.0.2                                         
#10 23.19   perl-Error.noarch 1:0.17020-2.amzn2                                           
#10 23.19   perl-Exporter.noarch 0:5.68-3.amzn2                                           
#10 23.19   perl-File-Path.noarch 0:2.09-2.amzn2                                          
#10 23.19   perl-File-Temp.noarch 0:0.23.01-3.amzn2                                       
#10 23.19   perl-Filter.x86_64 0:1.49-3.amzn2.0.2                                         
#10 23.19   perl-Getopt-Long.noarch 0:2.40-3.amzn2                                        
#10 23.19   perl-Git.noarch 0:2.32.0-1.amzn2.0.1                                          
... skipping 566 lines ...
| o=++.  S        |
|=.o+=o .         |
|+O *+oo          |
|o.@.*+           |
|o==Boo.          |
+----[SHA256]-----+
Error: unable to describe control plane "test-cluster-32760-k8s-local": operation error EKS: DescribeCluster, https response error StatusCode: 404, RequestID: a3fc666c-1307-413b-a042-74ecf5dff6f7, ResourceNotFoundException: No cluster found for name: test-cluster-32760-k8s-local.
###
## Creating cluster test-cluster-32760-k8s-local with /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/hack/e2e/csi-test-artifacts/test-cluster-32760.k8s.local.eksctl.yaml (dry run)
#
###
## Patching cluster test-cluster-32760-k8s-local with ./hack/eksctl-patch.yaml
#
... skipping 130 lines ...
Random Seed: [1m1656138947[0m - Will randomize all specs
Will run [1m190[0m specs

Running in parallel across [1m4[0m nodes

[1mSTEP[0m: Creating EFS filesystem in region "us-west-2" for cluster "test-cluster-32760-k8s-local"
error getting kops node security group id: no security groups found with filters [{
    Name: "tag:Name",
    Values: ["nodes.test-cluster-32760-k8s-local"]
  }]
error getting kops node subnet ids: no subnets found with filters [{
    Name: "tag-key",
    Values: ["kubernetes.io/cluster/test-cluster-32760-k8s-local"]
  }]
[1mSTEP[0m: Created EFS filesystem "fs-0a41b65cb7e961369" in region "us-west-2" for cluster "test-cluster-32760-k8s-local"


... skipping 95 lines ...
[efs-csi] EFS CSI
[90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:220[0m
  [Driver: efs.csi.aws.com]
  [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:228[0m
    [Testpattern: Inline-volume (default fs)] subPath
    [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50[0m
      [36m[1mshould fail if non-existent subpath is outside the volume [Slow][LinuxOnly] [BeforeEach][0m
      [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:267[0m

      [36mDriver efs.csi.aws.com doesn't support InlineVolume -- skipping[0m

      /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:116
[90m------------------------------[0m
... skipping 312 lines ...
[efs-csi] EFS CSI
[90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:220[0m
  [Driver: efs.csi.aws.com]
  [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:228[0m
    [Testpattern: Pre-provisioned PV (default fs)] subPath
    [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50[0m
      [36m[1mshould fail if subpath file is outside the volume [Slow][LinuxOnly] [BeforeEach][0m
      [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:256[0m

      [36mDriver supports dynamic provisioning, skipping PreprovisionedPV pattern[0m

      /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:244
[90m------------------------------[0m
... skipping 368 lines ...
[1mSTEP[0m: Binding the e2e-test-privileged-psp PodSecurityPolicy to the default service account in efs-1847
[1mSTEP[0m: Waiting for a default service account to be provisioned in namespace
[It] should mount without option tls when encryptInTransit set false
  /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:373
[1mSTEP[0m: Creating efs pvc & pv
[1mSTEP[0m: Creating pod to mount pvc "efs-1847" and run "mount && mount | grep /mnt/volume1 | grep fs-0a41b65cb7e961369"
Jun 25 06:38:40.302: INFO: Waiting up to 5m0s for pod "pvc-tester-cljrg" in namespace "efs-1847" to be "Succeeded or Failed"
Jun 25 06:38:40.371: INFO: Pod "pvc-tester-cljrg": Phase="Pending", Reason="", readiness=false. Elapsed: 68.946764ms
Jun 25 06:38:42.439: INFO: Pod "pvc-tester-cljrg": Phase="Pending", Reason="", readiness=false. Elapsed: 2.137237289s
Jun 25 06:38:44.506: INFO: Pod "pvc-tester-cljrg": Phase="Pending", Reason="", readiness=false. Elapsed: 4.204001602s
Jun 25 06:38:46.573: INFO: Pod "pvc-tester-cljrg": Phase="Pending", Reason="", readiness=false. Elapsed: 6.271411949s
Jun 25 06:38:48.642: INFO: Pod "pvc-tester-cljrg": Phase="Pending", Reason="", readiness=false. Elapsed: 8.340201927s
Jun 25 06:38:50.710: INFO: Pod "pvc-tester-cljrg": Phase="Pending", Reason="", readiness=false. Elapsed: 10.408120823s
... skipping 7 lines ...
Jun 25 06:39:07.263: INFO: Pod "pvc-tester-cljrg": Phase="Pending", Reason="", readiness=false. Elapsed: 26.961098584s
Jun 25 06:39:09.332: INFO: Pod "pvc-tester-cljrg": Phase="Pending", Reason="", readiness=false. Elapsed: 29.030162786s
Jun 25 06:39:11.399: INFO: Pod "pvc-tester-cljrg": Phase="Pending", Reason="", readiness=false. Elapsed: 31.097276615s
Jun 25 06:39:13.468: INFO: Pod "pvc-tester-cljrg": Phase="Pending", Reason="", readiness=false. Elapsed: 33.166000698s
Jun 25 06:39:15.535: INFO: Pod "pvc-tester-cljrg": Phase="Succeeded", Reason="", readiness=false. Elapsed: 35.23303643s
[1mSTEP[0m: Saw pod success
Jun 25 06:39:15.535: INFO: Pod "pvc-tester-cljrg" satisfied condition "Succeeded or Failed"
Jun 25 06:39:15.663: INFO: pod "pvc-tester-cljrg" logs:
 overlay on / type overlay (rw,relatime,lowerdir=/var/lib/docker/overlay2/l/GN4BJOG7BRI7XEUWQQMZK56RIE:/var/lib/docker/overlay2/l/4JTGW7G6AYC7UTSYVOWWGKQWJX,upperdir=/var/lib/docker/overlay2/a56daf2ab1f71177dc294954c7111b888fd843b484fa62fef0ca9e1279ec9d01/diff,workdir=/var/lib/docker/overlay2/a56daf2ab1f71177dc294954c7111b888fd843b484fa62fef0ca9e1279ec9d01/work)
proc on /proc type proc (rw,nosuid,nodev,noexec,relatime)
tmpfs on /dev type tmpfs (rw,nosuid,size=65536k,mode=755)
devpts on /dev/pts type devpts (rw,nosuid,noexec,relatime,gid=5,mode=620,ptmxmode=666)
sysfs on /sys type sysfs (ro,nosuid,nodev,noexec,relatime)
... skipping 69 lines ...
[efs-csi] EFS CSI
[90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:220[0m
  [Driver: efs.csi.aws.com]
  [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:228[0m
    [Testpattern: Dynamic PV (ntfs)][Feature:Windows] subPath
    [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50[0m
      [36m[1mshould fail if subpath with backstepping is outside the volume [Slow][LinuxOnly] [BeforeEach][0m
      [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:278[0m

      [36mDriver efs.csi.aws.com doesn't support ntfs -- skipping[0m

      /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:121
[90m------------------------------[0m
... skipping 11 lines ...
[1mSTEP[0m: Binding the e2e-test-privileged-psp PodSecurityPolicy to the default service account in efs-2451
[1mSTEP[0m: Waiting for a default service account to be provisioned in namespace
[It] should mount with option tls when encryptInTransit set true
  /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:368
[1mSTEP[0m: Creating efs pvc & pv
[1mSTEP[0m: Creating pod to mount pvc "efs-2451" and run "mount && mount | grep /mnt/volume1 | grep 127.0.0.1"
Jun 25 06:39:14.233: INFO: Waiting up to 5m0s for pod "pvc-tester-7swq7" in namespace "efs-2451" to be "Succeeded or Failed"
Jun 25 06:39:14.300: INFO: Pod "pvc-tester-7swq7": Phase="Pending", Reason="", readiness=false. Elapsed: 66.932032ms
Jun 25 06:39:16.366: INFO: Pod "pvc-tester-7swq7": Phase="Pending", Reason="", readiness=false. Elapsed: 2.132858741s
Jun 25 06:39:18.433: INFO: Pod "pvc-tester-7swq7": Phase="Pending", Reason="", readiness=false. Elapsed: 4.199477831s
Jun 25 06:39:20.501: INFO: Pod "pvc-tester-7swq7": Phase="Pending", Reason="", readiness=false. Elapsed: 6.267923744s
Jun 25 06:39:22.568: INFO: Pod "pvc-tester-7swq7": Phase="Pending", Reason="", readiness=false. Elapsed: 8.334955517s
Jun 25 06:39:24.635: INFO: Pod "pvc-tester-7swq7": Phase="Pending", Reason="", readiness=false. Elapsed: 10.402018531s
Jun 25 06:39:26.703: INFO: Pod "pvc-tester-7swq7": Phase="Pending", Reason="", readiness=false. Elapsed: 12.469748717s
Jun 25 06:39:28.771: INFO: Pod "pvc-tester-7swq7": Phase="Succeeded", Reason="", readiness=false. Elapsed: 14.537499227s
[1mSTEP[0m: Saw pod success
Jun 25 06:39:28.771: INFO: Pod "pvc-tester-7swq7" satisfied condition "Succeeded or Failed"
Jun 25 06:39:28.853: INFO: pod "pvc-tester-7swq7" logs:
 overlay on / type overlay (rw,relatime,lowerdir=/var/lib/docker/overlay2/l/XJMCGM5RJV2BLYVZYBJVIOTD3X:/var/lib/docker/overlay2/l/MI5KSAZMXEOHPNJH46DYYEGVZ2,upperdir=/var/lib/docker/overlay2/6239aa70263b5a0d7ef7afd94a84e0d50a294dc29f55dcbc064e0b92af77034f/diff,workdir=/var/lib/docker/overlay2/6239aa70263b5a0d7ef7afd94a84e0d50a294dc29f55dcbc064e0b92af77034f/work)
proc on /proc type proc (rw,nosuid,nodev,noexec,relatime)
tmpfs on /dev type tmpfs (rw,nosuid,size=65536k,mode=755)
devpts on /dev/pts type devpts (rw,nosuid,noexec,relatime,gid=5,mode=620,ptmxmode=666)
sysfs on /sys type sysfs (ro,nosuid,nodev,noexec,relatime)
... skipping 370 lines ...
[1mSTEP[0m: Binding the e2e-test-privileged-psp PodSecurityPolicy to the default service account in efs-3237
[1mSTEP[0m: Waiting for a default service account to be provisioned in namespace
[It] should mount different paths on same volume on same node
  /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:235
[1mSTEP[0m: Creating efs pvc & pv with no subpath
[1mSTEP[0m: Creating pod to make subpaths /a and /b
Jun 25 06:38:45.708: INFO: Waiting up to 5m0s for pod "pvc-tester-jwzz4" in namespace "efs-3237" to be "Succeeded or Failed"
Jun 25 06:38:45.773: INFO: Pod "pvc-tester-jwzz4": Phase="Pending", Reason="", readiness=false. Elapsed: 64.804891ms
Jun 25 06:38:47.842: INFO: Pod "pvc-tester-jwzz4": Phase="Pending", Reason="", readiness=false. Elapsed: 2.133298021s
Jun 25 06:38:49.906: INFO: Pod "pvc-tester-jwzz4": Phase="Pending", Reason="", readiness=false. Elapsed: 4.197815633s
Jun 25 06:38:51.973: INFO: Pod "pvc-tester-jwzz4": Phase="Pending", Reason="", readiness=false. Elapsed: 6.264330244s
Jun 25 06:38:54.038: INFO: Pod "pvc-tester-jwzz4": Phase="Pending", Reason="", readiness=false. Elapsed: 8.329576866s
Jun 25 06:38:56.104: INFO: Pod "pvc-tester-jwzz4": Phase="Pending", Reason="", readiness=false. Elapsed: 10.396001614s
... skipping 7 lines ...
Jun 25 06:39:12.629: INFO: Pod "pvc-tester-jwzz4": Phase="Pending", Reason="", readiness=false. Elapsed: 26.92098898s
Jun 25 06:39:14.695: INFO: Pod "pvc-tester-jwzz4": Phase="Pending", Reason="", readiness=false. Elapsed: 28.986665283s
Jun 25 06:39:16.761: INFO: Pod "pvc-tester-jwzz4": Phase="Pending", Reason="", readiness=false. Elapsed: 31.052699545s
Jun 25 06:39:18.825: INFO: Pod "pvc-tester-jwzz4": Phase="Pending", Reason="", readiness=false. Elapsed: 33.116903254s
Jun 25 06:39:20.903: INFO: Pod "pvc-tester-jwzz4": Phase="Succeeded", Reason="", readiness=false. Elapsed: 35.194562959s
[1mSTEP[0m: Saw pod success
Jun 25 06:39:20.903: INFO: Pod "pvc-tester-jwzz4" satisfied condition "Succeeded or Failed"
[1mSTEP[0m: Creating efs pvc & pv with subpath /a
[1mSTEP[0m: Creating efs pvc & pv with subpath /b
[1mSTEP[0m: Creating pod to mount subpaths /a and /b
[AfterEach] [efs-csi] EFS CSI
  /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:186
Jun 25 06:39:45.599: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
... skipping 125 lines ...
  /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:185
[1mSTEP[0m: Creating a kubernetes client
Jun 25 06:39:47.667: INFO: >>> kubeConfig: /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/hack/e2e/csi-test-artifacts/test-cluster-32760.k8s.local.eksctl.kubeconfig
[1mSTEP[0m: Building a namespace api object, basename volumemode
[1mSTEP[0m: Binding the e2e-test-privileged-psp PodSecurityPolicy to the default service account in volumemode-2605
[1mSTEP[0m: 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-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/volumemode.go:296
Jun 25 06:39:48.586: INFO: Driver "efs.csi.aws.com" does not provide raw block - skipping
[AfterEach] [Testpattern: Dynamic PV (filesystem volmode)] volumeMode
  /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:186
Jun 25 06:39:48.587: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
[1mSTEP[0m: Destroying namespace "volumemode-2605" for this suite.
... skipping 7 lines ...
[efs-csi] EFS CSI
[90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:220[0m
  [Driver: efs.csi.aws.com]
  [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:228[0m
    [Testpattern: Dynamic PV (filesystem volmode)] volumeMode
    [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50[0m
      [36m[1mshould fail to use a volume in a pod with mismatched mode [Slow] [It][0m
      [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/volumemode.go:296[0m

      [36mDriver "efs.csi.aws.com" does not provide raw block - skipping[0m

      /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/volumes.go:113
[90m------------------------------[0m
... skipping 295 lines ...
[efs-csi] EFS CSI
[90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:220[0m
  [Driver: efs.csi.aws.com]
  [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:228[0m
    [Testpattern: Dynamic PV (ntfs)][Feature:Windows] subPath
    [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50[0m
      [36m[1mshould fail if subpath file is outside the volume [Slow][LinuxOnly] [BeforeEach][0m
      [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:256[0m

      [36mDriver efs.csi.aws.com doesn't support ntfs -- skipping[0m

      /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:121
[90m------------------------------[0m
... skipping 225 lines ...
[efs-csi] EFS CSI
[90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:220[0m
  [Driver: efs.csi.aws.com]
  [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:228[0m
    [Testpattern: Inline-volume (default fs)] subPath
    [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50[0m
      [36m[1mshould fail if subpath file is outside the volume [Slow][LinuxOnly] [BeforeEach][0m
      [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:256[0m

      [36mDriver efs.csi.aws.com doesn't support InlineVolume -- skipping[0m

      /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:116
[90m------------------------------[0m
... skipping 208 lines ...
[efs-csi] EFS CSI
[90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:220[0m
  [Driver: efs.csi.aws.com]
  [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:228[0m
    [Testpattern: Pre-provisioned PV (default fs)] subPath
    [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50[0m
      [36m[1mshould fail if subpath with backstepping is outside the volume [Slow][LinuxOnly] [BeforeEach][0m
      [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:278[0m

      [36mDriver supports dynamic provisioning, skipping PreprovisionedPV pattern[0m

      /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:244
[90m------------------------------[0m
... skipping 197 lines ...
[1mSTEP[0m: creating a claim
Jun 25 06:40:12.308: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
Jun 25 06:40:12.379: INFO: Waiting up to timeout=5m0s for PersistentVolumeClaims [efs.csi.aws.compfcnv] to have phase Bound
Jun 25 06:40:12.447: INFO: PersistentVolumeClaim efs.csi.aws.compfcnv found but phase is Pending instead of Bound.
Jun 25 06:40:14.511: INFO: PersistentVolumeClaim efs.csi.aws.compfcnv found and phase=Bound (2.131334391s)
[1mSTEP[0m: Creating pod to format volume volume-prep-provisioning-8778
Jun 25 06:40:14.718: INFO: Waiting up to 5m0s for pod "volume-prep-provisioning-8778" in namespace "provisioning-8778" to be "Succeeded or Failed"
Jun 25 06:40:14.782: INFO: Pod "volume-prep-provisioning-8778": Phase="Pending", Reason="", readiness=false. Elapsed: 63.757974ms
Jun 25 06:40:16.847: INFO: Pod "volume-prep-provisioning-8778": Phase="Pending", Reason="", readiness=false. Elapsed: 2.128846655s
Jun 25 06:40:18.912: INFO: Pod "volume-prep-provisioning-8778": Phase="Pending", Reason="", readiness=false. Elapsed: 4.193765223s
Jun 25 06:40:20.976: INFO: Pod "volume-prep-provisioning-8778": Phase="Succeeded", Reason="", readiness=false. Elapsed: 6.257689272s
[1mSTEP[0m: Saw pod success
Jun 25 06:40:20.976: INFO: Pod "volume-prep-provisioning-8778" satisfied condition "Succeeded or Failed"
Jun 25 06:40:20.976: INFO: Deleting pod "volume-prep-provisioning-8778" in namespace "provisioning-8778"
Jun 25 06:40:21.107: INFO: Wait up to 5m0s for pod "volume-prep-provisioning-8778" to be fully deleted
[1mSTEP[0m: Creating pod pod-subpath-test-dynamicpv-l6lk
[1mSTEP[0m: Checking for subpath error in container status
Jun 25 06:40:25.376: INFO: Deleting pod "pod-subpath-test-dynamicpv-l6lk" in namespace "provisioning-8778"
Jun 25 06:40:25.451: INFO: Wait up to 5m0s for pod "pod-subpath-test-dynamicpv-l6lk" to be fully deleted
[1mSTEP[0m: Deleting pod
Jun 25 06:40:27.583: INFO: Deleting pod "pod-subpath-test-dynamicpv-l6lk" in namespace "provisioning-8778"
[1mSTEP[0m: Deleting pvc
Jun 25 06:40:27.647: INFO: Deleting PersistentVolumeClaim "efs.csi.aws.compfcnv"
... skipping 45 lines ...
[efs-csi] EFS CSI
[90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:220[0m
  [Driver: efs.csi.aws.com]
  [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:228[0m
    [Testpattern: Dynamic PV (ntfs)][Feature:Windows] subPath
    [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50[0m
      [36m[1mshould fail if non-existent subpath is outside the volume [Slow][LinuxOnly] [BeforeEach][0m
      [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:267[0m

      [36mDriver efs.csi.aws.com doesn't support ntfs -- skipping[0m

      /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:121
[90m------------------------------[0m
... skipping 142 lines ...

      [36mFilesystem volume case should be covered by block volume case -- skipping[0m

      /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/multivolume.go:247
[90m------------------------------[0m
[0m[efs-csi] EFS CSI[0m [90m[Driver: efs.csi.aws.com][0m [0m[Testpattern: Pre-provisioned PV (block volmode)] volumeMode[0m 
  [1mshould fail to create pod by failing to mount volume [Slow][0m
  [37m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/volumemode.go:197[0m

[BeforeEach] [efs-csi] EFS CSI
  /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:221
[BeforeEach] [efs-csi] EFS CSI
  /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:185
... skipping 8 lines ...
  /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:185
[1mSTEP[0m: Creating a kubernetes client
Jun 25 06:38:49.461: INFO: >>> kubeConfig: /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/hack/e2e/csi-test-artifacts/test-cluster-32760.k8s.local.eksctl.kubeconfig
[1mSTEP[0m: Building a namespace api object, basename volumemode
[1mSTEP[0m: Binding the e2e-test-privileged-psp PodSecurityPolicy to the default service account in volumemode-2888
[1mSTEP[0m: Waiting for a default service account to be provisioned in namespace
[It] should fail to create pod by failing to mount volume [Slow]
  /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/volumemode.go:197
[1mSTEP[0m: Creating sc
[1mSTEP[0m: Creating pv and pvc
Jun 25 06:38:50.945: INFO: Waiting for PV pv6qrd4 to bind to PVC pvc-q4vpf
Jun 25 06:38:50.945: INFO: Waiting up to timeout=3m0s for PersistentVolumeClaims [pvc-q4vpf] to have phase Bound
Jun 25 06:38:51.012: INFO: PersistentVolumeClaim pvc-q4vpf found and phase=Bound (67.389136ms)
... skipping 20 lines ...
[efs-csi] EFS CSI
[90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:220[0m
  [Driver: efs.csi.aws.com]
  [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:228[0m
    [Testpattern: Pre-provisioned PV (block volmode)] volumeMode
    [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50[0m
      should fail to create pod by failing to mount volume [Slow]
      [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/volumemode.go:197[0m
[90m------------------------------[0m
[BeforeEach] [efs-csi] EFS CSI
  /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:221
[BeforeEach] [efs-csi] EFS CSI
  /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:185
... skipping 75 lines ...
[1mSTEP[0m: Binding the e2e-test-privileged-psp PodSecurityPolicy to the default service account in efs-1224
[1mSTEP[0m: Waiting for a default service account to be provisioned in namespace
[It] should mount with option tls when encryptInTransit unset
  /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:364
[1mSTEP[0m: Creating efs pvc & pv
[1mSTEP[0m: Creating pod to mount pvc "efs-1224" and run "mount && mount | grep /mnt/volume1 | grep 127.0.0.1"
Jun 25 06:40:41.409: INFO: Waiting up to 5m0s for pod "pvc-tester-nqjf2" in namespace "efs-1224" to be "Succeeded or Failed"
Jun 25 06:40:41.471: INFO: Pod "pvc-tester-nqjf2": Phase="Pending", Reason="", readiness=false. Elapsed: 62.545946ms
Jun 25 06:40:43.536: INFO: Pod "pvc-tester-nqjf2": Phase="Pending", Reason="", readiness=false. Elapsed: 2.127088058s
Jun 25 06:40:45.600: INFO: Pod "pvc-tester-nqjf2": Phase="Pending", Reason="", readiness=false. Elapsed: 4.190984177s
Jun 25 06:40:47.665: INFO: Pod "pvc-tester-nqjf2": Phase="Pending", Reason="", readiness=false. Elapsed: 6.256467591s
Jun 25 06:40:49.730: INFO: Pod "pvc-tester-nqjf2": Phase="Pending", Reason="", readiness=false. Elapsed: 8.320916374s
Jun 25 06:40:51.793: INFO: Pod "pvc-tester-nqjf2": Phase="Pending", Reason="", readiness=false. Elapsed: 10.384179455s
... skipping 9 lines ...
Jun 25 06:41:12.462: INFO: Pod "pvc-tester-nqjf2": Phase="Pending", Reason="", readiness=false. Elapsed: 31.05360266s
Jun 25 06:41:14.527: INFO: Pod "pvc-tester-nqjf2": Phase="Pending", Reason="", readiness=false. Elapsed: 33.117706779s
Jun 25 06:41:16.591: INFO: Pod "pvc-tester-nqjf2": Phase="Pending", Reason="", readiness=false. Elapsed: 35.181748586s
Jun 25 06:41:18.654: INFO: Pod "pvc-tester-nqjf2": Phase="Pending", Reason="", readiness=false. Elapsed: 37.245103542s
Jun 25 06:41:20.717: INFO: Pod "pvc-tester-nqjf2": Phase="Succeeded", Reason="", readiness=false. Elapsed: 39.307927037s
[1mSTEP[0m: Saw pod success
Jun 25 06:41:20.717: INFO: Pod "pvc-tester-nqjf2" satisfied condition "Succeeded or Failed"
Jun 25 06:41:20.797: INFO: pod "pvc-tester-nqjf2" logs:
 overlay on / type overlay (rw,relatime,lowerdir=/var/lib/docker/overlay2/l/7UCSZLTPUN6LNCPBOTBD3GA33X:/var/lib/docker/overlay2/l/4JTGW7G6AYC7UTSYVOWWGKQWJX,upperdir=/var/lib/docker/overlay2/c88fd44660775b8dd631df389f79777f719ca74c640fe014092a57543b3bdb32/diff,workdir=/var/lib/docker/overlay2/c88fd44660775b8dd631df389f79777f719ca74c640fe014092a57543b3bdb32/work)
proc on /proc type proc (rw,nosuid,nodev,noexec,relatime)
tmpfs on /dev type tmpfs (rw,nosuid,size=65536k,mode=755)
devpts on /dev/pts type devpts (rw,nosuid,noexec,relatime,gid=5,mode=620,ptmxmode=666)
sysfs on /sys type sysfs (ro,nosuid,nodev,noexec,relatime)
... skipping 145 lines ...

      [36mDriver efs.csi.aws.com doesn't support ext4 -- skipping[0m

      /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:121
[90m------------------------------[0m
[0m[efs-csi] EFS CSI[0m [90m[Driver: efs.csi.aws.com][0m [0m[Testpattern: Dynamic PV (default fs)] subPath[0m 
  [1mshould fail if subpath with backstepping is outside the volume [Slow][LinuxOnly][0m
  [37m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:278[0m

[BeforeEach] [efs-csi] EFS CSI
  /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:221
[BeforeEach] [efs-csi] EFS CSI
  /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:185
... skipping 8 lines ...
  /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:185
[1mSTEP[0m: Creating a kubernetes client
Jun 25 06:41:25.449: INFO: >>> kubeConfig: /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/hack/e2e/csi-test-artifacts/test-cluster-32760.k8s.local.eksctl.kubeconfig
[1mSTEP[0m: Building a namespace api object, basename provisioning
[1mSTEP[0m: Binding the e2e-test-privileged-psp PodSecurityPolicy to the default service account in provisioning-9474
[1mSTEP[0m: 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-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:278
Jun 25 06:41:26.587: INFO: Creating resource for dynamic PV
Jun 25 06:41:26.587: INFO: Using claimSize:1Mi, test suite supported size:{ 1Mi}, driver(efs.csi.aws.com) supported size:{ 1Mi} 
[1mSTEP[0m: creating a StorageClass 
[1mSTEP[0m: creating a claim
Jun 25 06:41:26.787: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
Jun 25 06:41:26.861: INFO: Waiting up to timeout=5m0s for PersistentVolumeClaims [efs.csi.aws.comrj9qq] to have phase Bound
Jun 25 06:41:26.927: INFO: PersistentVolumeClaim efs.csi.aws.comrj9qq found but phase is Pending instead of Bound.
Jun 25 06:41:28.995: INFO: PersistentVolumeClaim efs.csi.aws.comrj9qq found and phase=Bound (2.133437867s)
[1mSTEP[0m: Creating pod pod-subpath-test-dynamicpv-sgz7
[1mSTEP[0m: Checking for subpath error in container status
Jun 25 06:41:33.337: INFO: Deleting pod "pod-subpath-test-dynamicpv-sgz7" in namespace "provisioning-9474"
Jun 25 06:41:33.409: INFO: Wait up to 5m0s for pod "pod-subpath-test-dynamicpv-sgz7" to be fully deleted
[1mSTEP[0m: Deleting pod
Jun 25 06:41:35.543: INFO: Deleting pod "pod-subpath-test-dynamicpv-sgz7" in namespace "provisioning-9474"
[1mSTEP[0m: Deleting pvc
Jun 25 06:41:35.608: INFO: Deleting PersistentVolumeClaim "efs.csi.aws.comrj9qq"
... skipping 15 lines ...
[efs-csi] EFS CSI
[90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:220[0m
  [Driver: efs.csi.aws.com]
  [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:228[0m
    [Testpattern: Dynamic PV (default fs)] subPath
    [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50[0m
      should fail if subpath with backstepping is outside the volume [Slow][LinuxOnly]
      [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:278[0m
[90m------------------------------[0m
[0m[efs-csi] EFS CSI[0m [90m[Driver: efs.csi.aws.com][0m [0m[Testpattern: Dynamic PV (filesystem volmode)] multiVolume [Slow][0m 
  [1mshould access to two volumes with the same volume mode and retain data across pod recreation on different node[0m
  [37m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/multivolume.go:165[0m

... skipping 470 lines ...
Jun 25 06:41:48.905: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
Jun 25 06:41:48.975: INFO: Waiting up to timeout=5m0s for PersistentVolumeClaims [efs.csi.aws.comwqtr7] to have phase Bound
Jun 25 06:41:49.039: INFO: PersistentVolumeClaim efs.csi.aws.comwqtr7 found but phase is Pending instead of Bound.
Jun 25 06:41:51.108: INFO: PersistentVolumeClaim efs.csi.aws.comwqtr7 found and phase=Bound (2.132540498s)
[1mSTEP[0m: Creating pod pod-subpath-test-dynamicpv-lqjr
[1mSTEP[0m: Creating a pod to test subpath
Jun 25 06:41:51.308: INFO: Waiting up to 5m0s for pod "pod-subpath-test-dynamicpv-lqjr" in namespace "provisioning-6137" to be "Succeeded or Failed"
Jun 25 06:41:51.413: INFO: Pod "pod-subpath-test-dynamicpv-lqjr": Phase="Pending", Reason="", readiness=false. Elapsed: 104.655222ms
Jun 25 06:41:53.476: INFO: Pod "pod-subpath-test-dynamicpv-lqjr": Phase="Pending", Reason="", readiness=false. Elapsed: 2.168249678s
Jun 25 06:41:55.540: INFO: Pod "pod-subpath-test-dynamicpv-lqjr": Phase="Pending", Reason="", readiness=false. Elapsed: 4.231398066s
Jun 25 06:41:57.604: INFO: Pod "pod-subpath-test-dynamicpv-lqjr": Phase="Succeeded", Reason="", readiness=false. Elapsed: 6.296216358s
[1mSTEP[0m: Saw pod success
Jun 25 06:41:57.604: INFO: Pod "pod-subpath-test-dynamicpv-lqjr" satisfied condition "Succeeded or Failed"
Jun 25 06:41:57.668: INFO: Trying to get logs from node ip-192-168-13-184.us-west-2.compute.internal pod pod-subpath-test-dynamicpv-lqjr container test-container-volume-dynamicpv-lqjr: <nil>
[1mSTEP[0m: delete the pod
Jun 25 06:41:57.865: INFO: Waiting for pod pod-subpath-test-dynamicpv-lqjr to disappear
Jun 25 06:41:57.927: INFO: Pod pod-subpath-test-dynamicpv-lqjr no longer exists
[1mSTEP[0m: Deleting pod pod-subpath-test-dynamicpv-lqjr
Jun 25 06:41:57.927: INFO: Deleting pod "pod-subpath-test-dynamicpv-lqjr" in namespace "provisioning-6137"
... skipping 530 lines ...
Jun 25 06:42:20.723: INFO: PersistentVolumeClaim pvc-b6z5l found but phase is Pending instead of Bound.
Jun 25 06:42:22.795: INFO: PersistentVolumeClaim pvc-b6z5l found and phase=Bound (14.535362968s)
Jun 25 06:42:22.795: INFO: Waiting up to 3m0s for PersistentVolume efs.csi.aws.com-nn4q4 to have phase Bound
Jun 25 06:42:22.860: INFO: PersistentVolume efs.csi.aws.com-nn4q4 found and phase=Bound (64.538333ms)
[1mSTEP[0m: Creating pod exec-volume-test-preprovisionedpv-fm46
[1mSTEP[0m: Creating a pod to test exec-volume-test
Jun 25 06:42:23.064: INFO: Waiting up to 5m0s for pod "exec-volume-test-preprovisionedpv-fm46" in namespace "volume-1528" to be "Succeeded or Failed"
Jun 25 06:42:23.130: INFO: Pod "exec-volume-test-preprovisionedpv-fm46": Phase="Pending", Reason="", readiness=false. Elapsed: 65.598607ms
Jun 25 06:42:25.196: INFO: Pod "exec-volume-test-preprovisionedpv-fm46": Phase="Pending", Reason="", readiness=false. Elapsed: 2.131206294s
Jun 25 06:42:27.262: INFO: Pod "exec-volume-test-preprovisionedpv-fm46": Phase="Pending", Reason="", readiness=false. Elapsed: 4.197973162s
Jun 25 06:42:29.329: INFO: Pod "exec-volume-test-preprovisionedpv-fm46": Phase="Succeeded", Reason="", readiness=false. Elapsed: 6.26421461s
[1mSTEP[0m: Saw pod success
Jun 25 06:42:29.329: INFO: Pod "exec-volume-test-preprovisionedpv-fm46" satisfied condition "Succeeded or Failed"
Jun 25 06:42:29.394: INFO: Trying to get logs from node ip-192-168-73-74.us-west-2.compute.internal pod exec-volume-test-preprovisionedpv-fm46 container exec-container-preprovisionedpv-fm46: <nil>
[1mSTEP[0m: delete the pod
Jun 25 06:42:29.595: INFO: Waiting for pod exec-volume-test-preprovisionedpv-fm46 to disappear
Jun 25 06:42:29.658: INFO: Pod exec-volume-test-preprovisionedpv-fm46 no longer exists
[1mSTEP[0m: Deleting pod exec-volume-test-preprovisionedpv-fm46
Jun 25 06:42:29.658: INFO: Deleting pod "exec-volume-test-preprovisionedpv-fm46" in namespace "volume-1528"
... skipping 239 lines ...
  /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:185
[1mSTEP[0m: Creating a kubernetes client
Jun 25 06:42:34.615: INFO: >>> kubeConfig: /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/hack/e2e/csi-test-artifacts/test-cluster-32760.k8s.local.eksctl.kubeconfig
[1mSTEP[0m: Building a namespace api object, basename volumemode
[1mSTEP[0m: Binding the e2e-test-privileged-psp PodSecurityPolicy to the default service account in volumemode-3231
[1mSTEP[0m: 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-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/volumemode.go:296
Jun 25 06:42:35.561: INFO: Driver "efs.csi.aws.com" does not provide raw block - skipping
[AfterEach] [Testpattern: Pre-provisioned PV (filesystem volmode)] volumeMode
  /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:186
Jun 25 06:42:35.561: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
[1mSTEP[0m: Destroying namespace "volumemode-3231" for this suite.
... skipping 7 lines ...
[efs-csi] EFS CSI
[90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:220[0m
  [Driver: efs.csi.aws.com]
  [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:228[0m
    [Testpattern: Pre-provisioned PV (filesystem volmode)] volumeMode
    [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50[0m
      [36m[1mshould fail to use a volume in a pod with mismatched mode [Slow] [It][0m
      [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/volumemode.go:296[0m

      [36mDriver "efs.csi.aws.com" does not provide raw block - skipping[0m

      /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/volumes.go:113
[90m------------------------------[0m
... skipping 46 lines ...
  /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:185
[1mSTEP[0m: Creating a kubernetes client
Jun 25 06:42:38.029: INFO: >>> kubeConfig: /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/hack/e2e/csi-test-artifacts/test-cluster-32760.k8s.local.eksctl.kubeconfig
[1mSTEP[0m: Building a namespace api object, basename volumemode
[1mSTEP[0m: Binding the e2e-test-privileged-psp PodSecurityPolicy to the default service account in volumemode-4657
[1mSTEP[0m: 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-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/volumemode.go:296
Jun 25 06:42:38.985: INFO: Driver "efs.csi.aws.com" does not provide raw block - skipping
[AfterEach] [Testpattern: Pre-provisioned PV (block volmode)] volumeMode
  /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:186
Jun 25 06:42:38.986: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
[1mSTEP[0m: Destroying namespace "volumemode-4657" for this suite.
... skipping 7 lines ...
[efs-csi] EFS CSI
[90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:220[0m
  [Driver: efs.csi.aws.com]
  [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:228[0m
    [Testpattern: Pre-provisioned PV (block volmode)] volumeMode
    [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50[0m
      [36m[1mshould fail to use a volume in a pod with mismatched mode [Slow] [It][0m
      [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/volumemode.go:296[0m

      [36mDriver "efs.csi.aws.com" does not provide raw block - skipping[0m

      /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/volumes.go:113
[90m------------------------------[0m
... skipping 12 lines ...
  /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:185
[1mSTEP[0m: Creating a kubernetes client
Jun 25 06:42:40.327: INFO: >>> kubeConfig: /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/hack/e2e/csi-test-artifacts/test-cluster-32760.k8s.local.eksctl.kubeconfig
[1mSTEP[0m: Building a namespace api object, basename volumemode
[1mSTEP[0m: Binding the e2e-test-privileged-psp PodSecurityPolicy to the default service account in volumemode-870
[1mSTEP[0m: 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-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/volumemode.go:296
Jun 25 06:42:41.249: INFO: Driver "efs.csi.aws.com" does not provide raw block - skipping
[AfterEach] [Testpattern: Dynamic PV (block volmode)] volumeMode
  /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:186
Jun 25 06:42:41.250: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
[1mSTEP[0m: Destroying namespace "volumemode-870" for this suite.
... skipping 7 lines ...
[efs-csi] EFS CSI
[90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:220[0m
  [Driver: efs.csi.aws.com]
  [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:228[0m
    [Testpattern: Dynamic PV (block volmode)] volumeMode
    [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50[0m
      [36m[1mshould fail to use a volume in a pod with mismatched mode [Slow] [It][0m
      [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/volumemode.go:296[0m

      [36mDriver "efs.csi.aws.com" does not provide raw block - skipping[0m

      /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/volumes.go:113
[90m------------------------------[0m
... skipping 62 lines ...
Jun 25 06:42:28.433: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
Jun 25 06:42:28.503: INFO: Waiting up to timeout=5m0s for PersistentVolumeClaims [efs.csi.aws.comjksh9] to have phase Bound
Jun 25 06:42:28.565: INFO: PersistentVolumeClaim efs.csi.aws.comjksh9 found but phase is Pending instead of Bound.
Jun 25 06:42:30.628: INFO: PersistentVolumeClaim efs.csi.aws.comjksh9 found and phase=Bound (2.125482867s)
[1mSTEP[0m: Creating pod pod-subpath-test-dynamicpv-pmkk
[1mSTEP[0m: Creating a pod to test subpath
Jun 25 06:42:30.832: INFO: Waiting up to 5m0s for pod "pod-subpath-test-dynamicpv-pmkk" in namespace "provisioning-9819" to be "Succeeded or Failed"
Jun 25 06:42:30.935: INFO: Pod "pod-subpath-test-dynamicpv-pmkk": Phase="Pending", Reason="", readiness=false. Elapsed: 103.298352ms
Jun 25 06:42:32.998: INFO: Pod "pod-subpath-test-dynamicpv-pmkk": Phase="Pending", Reason="", readiness=false. Elapsed: 2.165680263s
Jun 25 06:42:35.065: INFO: Pod "pod-subpath-test-dynamicpv-pmkk": Phase="Pending", Reason="", readiness=false. Elapsed: 4.232635734s
Jun 25 06:42:37.128: INFO: Pod "pod-subpath-test-dynamicpv-pmkk": Phase="Succeeded", Reason="", readiness=false. Elapsed: 6.296038583s
[1mSTEP[0m: Saw pod success
Jun 25 06:42:37.128: INFO: Pod "pod-subpath-test-dynamicpv-pmkk" satisfied condition "Succeeded or Failed"
Jun 25 06:42:37.191: INFO: Trying to get logs from node ip-192-168-73-74.us-west-2.compute.internal pod pod-subpath-test-dynamicpv-pmkk container test-container-subpath-dynamicpv-pmkk: <nil>
[1mSTEP[0m: delete the pod
Jun 25 06:42:37.396: INFO: Waiting for pod pod-subpath-test-dynamicpv-pmkk to disappear
Jun 25 06:42:37.461: INFO: Pod pod-subpath-test-dynamicpv-pmkk no longer exists
[1mSTEP[0m: Deleting pod pod-subpath-test-dynamicpv-pmkk
Jun 25 06:42:37.461: INFO: Deleting pod "pod-subpath-test-dynamicpv-pmkk" in namespace "provisioning-9819"
... skipping 135 lines ...
Jun 25 06:42:34.592: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
Jun 25 06:42:34.671: INFO: Waiting up to timeout=5m0s for PersistentVolumeClaims [efs.csi.aws.com7qdv8] to have phase Bound
Jun 25 06:42:34.750: INFO: PersistentVolumeClaim efs.csi.aws.com7qdv8 found but phase is Pending instead of Bound.
Jun 25 06:42:36.826: INFO: PersistentVolumeClaim efs.csi.aws.com7qdv8 found and phase=Bound (2.15509347s)
[1mSTEP[0m: Creating pod exec-volume-test-dynamicpv-2mrh
[1mSTEP[0m: Creating a pod to test exec-volume-test
Jun 25 06:42:37.038: INFO: Waiting up to 5m0s for pod "exec-volume-test-dynamicpv-2mrh" in namespace "volume-5844" to be "Succeeded or Failed"
Jun 25 06:42:37.108: INFO: Pod "exec-volume-test-dynamicpv-2mrh": Phase="Pending", Reason="", readiness=false. Elapsed: 70.107606ms
Jun 25 06:42:39.173: INFO: Pod "exec-volume-test-dynamicpv-2mrh": Phase="Pending", Reason="", readiness=false. Elapsed: 2.135504137s
Jun 25 06:42:41.239: INFO: Pod "exec-volume-test-dynamicpv-2mrh": Phase="Succeeded", Reason="", readiness=false. Elapsed: 4.201647231s
[1mSTEP[0m: Saw pod success
Jun 25 06:42:41.240: INFO: Pod "exec-volume-test-dynamicpv-2mrh" satisfied condition "Succeeded or Failed"
Jun 25 06:42:41.306: INFO: Trying to get logs from node ip-192-168-73-74.us-west-2.compute.internal pod exec-volume-test-dynamicpv-2mrh container exec-container-dynamicpv-2mrh: <nil>
[1mSTEP[0m: delete the pod
Jun 25 06:42:41.460: INFO: Waiting for pod exec-volume-test-dynamicpv-2mrh to disappear
Jun 25 06:42:41.527: INFO: Pod exec-volume-test-dynamicpv-2mrh no longer exists
[1mSTEP[0m: Deleting pod exec-volume-test-dynamicpv-2mrh
Jun 25 06:42:41.527: INFO: Deleting pod "exec-volume-test-dynamicpv-2mrh" in namespace "volume-5844"
... skipping 55 lines ...

      [36mDriver efs.csi.aws.com doesn't support Block -- skipping[0m

      /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/multivolume.go:82
[90m------------------------------[0m
[0m[efs-csi] EFS CSI[0m [90m[Driver: efs.csi.aws.com][0m [0m[Testpattern: Dynamic PV (default fs)] subPath[0m 
  [1mshould fail if subpath file is outside the volume [Slow][LinuxOnly][0m
  [37m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:256[0m

[BeforeEach] [efs-csi] EFS CSI
  /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:221
[BeforeEach] [efs-csi] EFS CSI
  /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:185
... skipping 8 lines ...
  /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:185
[1mSTEP[0m: Creating a kubernetes client
Jun 25 06:42:32.102: INFO: >>> kubeConfig: /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/hack/e2e/csi-test-artifacts/test-cluster-32760.k8s.local.eksctl.kubeconfig
[1mSTEP[0m: Building a namespace api object, basename provisioning
[1mSTEP[0m: Binding the e2e-test-privileged-psp PodSecurityPolicy to the default service account in provisioning-3018
[1mSTEP[0m: 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-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:256
Jun 25 06:42:33.240: INFO: Creating resource for dynamic PV
Jun 25 06:42:33.240: INFO: Using claimSize:1Mi, test suite supported size:{ 1Mi}, driver(efs.csi.aws.com) supported size:{ 1Mi} 
[1mSTEP[0m: creating a StorageClass 
[1mSTEP[0m: creating a claim
Jun 25 06:42:33.437: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
Jun 25 06:42:33.507: INFO: Waiting up to timeout=5m0s for PersistentVolumeClaims [efs.csi.aws.comqhw4f] to have phase Bound
Jun 25 06:42:33.571: INFO: PersistentVolumeClaim efs.csi.aws.comqhw4f found but phase is Pending instead of Bound.
Jun 25 06:42:35.637: INFO: PersistentVolumeClaim efs.csi.aws.comqhw4f found and phase=Bound (2.129541513s)
[1mSTEP[0m: Creating pod pod-subpath-test-dynamicpv-skdg
[1mSTEP[0m: Checking for subpath error in container status
Jun 25 06:42:39.998: INFO: Deleting pod "pod-subpath-test-dynamicpv-skdg" in namespace "provisioning-3018"
Jun 25 06:42:40.074: INFO: Wait up to 5m0s for pod "pod-subpath-test-dynamicpv-skdg" to be fully deleted
[1mSTEP[0m: Deleting pod
Jun 25 06:42:42.209: INFO: Deleting pod "pod-subpath-test-dynamicpv-skdg" in namespace "provisioning-3018"
[1mSTEP[0m: Deleting pvc
Jun 25 06:42:42.273: INFO: Deleting PersistentVolumeClaim "efs.csi.aws.comqhw4f"
... skipping 15 lines ...
[efs-csi] EFS CSI
[90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:220[0m
  [Driver: efs.csi.aws.com]
  [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:228[0m
    [Testpattern: Dynamic PV (default fs)] subPath
    [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50[0m
      should fail if subpath file is outside the volume [Slow][LinuxOnly]
      [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:256[0m
[90m------------------------------[0m
[BeforeEach] [efs-csi] EFS CSI
  /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:221
[BeforeEach] [efs-csi] EFS CSI
  /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:185
... skipping 85 lines ...
[efs-csi] EFS CSI
[90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:220[0m
  [Driver: efs.csi.aws.com]
  [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:228[0m
    [Testpattern: Dynamic PV (ntfs)][Feature:Windows] subPath
    [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50[0m
      [36m[1mshould fail if subpath directory is outside the volume [Slow][LinuxOnly] [BeforeEach][0m
      [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:240[0m

      [36mDriver efs.csi.aws.com doesn't support ntfs -- skipping[0m

      /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:121
[90m------------------------------[0m
... skipping 292 lines ...
[efs-csi] EFS CSI
[90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:220[0m
  [Driver: efs.csi.aws.com]
  [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:228[0m
    [Testpattern: Pre-provisioned PV (default fs)] subPath
    [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50[0m
      [36m[1mshould fail if non-existent subpath is outside the volume [Slow][LinuxOnly] [BeforeEach][0m
      [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:267[0m

      [36mDriver supports dynamic provisioning, skipping PreprovisionedPV pattern[0m

      /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:244
[90m------------------------------[0m
... skipping 62 lines ...
    [Testpattern: Dynamic PV (default fs)] subPath
    [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50[0m
      should be able to unmount after the subpath directory is deleted [LinuxOnly]
      [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:445[0m
[90m------------------------------[0m
[0m[efs-csi] EFS CSI[0m [90m[Driver: efs.csi.aws.com][0m [0m[Testpattern: Dynamic PV (default fs)] subPath[0m 
  [1mshould fail if non-existent subpath is outside the volume [Slow][LinuxOnly][0m
  [37m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:267[0m

[BeforeEach] [efs-csi] EFS CSI
  /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:221
[BeforeEach] [efs-csi] EFS CSI
  /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:185
... skipping 8 lines ...
  /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:185
[1mSTEP[0m: Creating a kubernetes client
Jun 25 06:42:48.807: INFO: >>> kubeConfig: /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/hack/e2e/csi-test-artifacts/test-cluster-32760.k8s.local.eksctl.kubeconfig
[1mSTEP[0m: Building a namespace api object, basename provisioning
[1mSTEP[0m: Binding the e2e-test-privileged-psp PodSecurityPolicy to the default service account in provisioning-1602
[1mSTEP[0m: 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-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:267
Jun 25 06:42:49.944: INFO: Creating resource for dynamic PV
Jun 25 06:42:49.944: INFO: Using claimSize:1Mi, test suite supported size:{ 1Mi}, driver(efs.csi.aws.com) supported size:{ 1Mi} 
[1mSTEP[0m: creating a StorageClass 
[1mSTEP[0m: creating a claim
Jun 25 06:42:50.154: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
Jun 25 06:42:50.228: INFO: Waiting up to timeout=5m0s for PersistentVolumeClaims [efs.csi.aws.comngpb7] to have phase Bound
Jun 25 06:42:50.294: INFO: PersistentVolumeClaim efs.csi.aws.comngpb7 found but phase is Pending instead of Bound.
Jun 25 06:42:52.362: INFO: PersistentVolumeClaim efs.csi.aws.comngpb7 found and phase=Bound (2.133722994s)
[1mSTEP[0m: Creating pod pod-subpath-test-dynamicpv-f92c
[1mSTEP[0m: Checking for subpath error in container status
Jun 25 06:42:56.729: INFO: Deleting pod "pod-subpath-test-dynamicpv-f92c" in namespace "provisioning-1602"
Jun 25 06:42:56.799: INFO: Wait up to 5m0s for pod "pod-subpath-test-dynamicpv-f92c" to be fully deleted
[1mSTEP[0m: Deleting pod
Jun 25 06:42:58.929: INFO: Deleting pod "pod-subpath-test-dynamicpv-f92c" in namespace "provisioning-1602"
[1mSTEP[0m: Deleting pvc
Jun 25 06:42:58.996: INFO: Deleting PersistentVolumeClaim "efs.csi.aws.comngpb7"
... skipping 15 lines ...
[efs-csi] EFS CSI
[90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:220[0m
  [Driver: efs.csi.aws.com]
  [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:228[0m
    [Testpattern: Dynamic PV (default fs)] subPath
    [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50[0m
      should fail if non-existent subpath is outside the volume [Slow][LinuxOnly]
      [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:267[0m
[90m------------------------------[0m
[BeforeEach] [efs-csi] EFS CSI
  /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:221
[BeforeEach] [efs-csi] EFS CSI
  /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:185
... skipping 58 lines ...
Jun 25 06:43:00.172: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
Jun 25 06:43:00.261: INFO: Waiting up to timeout=5m0s for PersistentVolumeClaims [efs.csi.aws.com8pbxw] to have phase Bound
Jun 25 06:43:00.326: INFO: PersistentVolumeClaim efs.csi.aws.com8pbxw found but phase is Pending instead of Bound.
Jun 25 06:43:02.389: INFO: PersistentVolumeClaim efs.csi.aws.com8pbxw found and phase=Bound (2.128369908s)
[1mSTEP[0m: Creating pod pod-subpath-test-dynamicpv-l669
[1mSTEP[0m: Creating a pod to test subpath
Jun 25 06:43:02.642: INFO: Waiting up to 5m0s for pod "pod-subpath-test-dynamicpv-l669" in namespace "provisioning-7962" to be "Succeeded or Failed"
Jun 25 06:43:02.705: INFO: Pod "pod-subpath-test-dynamicpv-l669": Phase="Pending", Reason="", readiness=false. Elapsed: 63.379936ms
Jun 25 06:43:04.769: INFO: Pod "pod-subpath-test-dynamicpv-l669": Phase="Pending", Reason="", readiness=false. Elapsed: 2.12715293s
Jun 25 06:43:06.833: INFO: Pod "pod-subpath-test-dynamicpv-l669": Phase="Pending", Reason="", readiness=false. Elapsed: 4.191667821s
Jun 25 06:43:08.900: INFO: Pod "pod-subpath-test-dynamicpv-l669": Phase="Succeeded", Reason="", readiness=false. Elapsed: 6.258485953s
[1mSTEP[0m: Saw pod success
Jun 25 06:43:08.900: INFO: Pod "pod-subpath-test-dynamicpv-l669" satisfied condition "Succeeded or Failed"
Jun 25 06:43:08.964: INFO: Trying to get logs from node ip-192-168-73-74.us-west-2.compute.internal pod pod-subpath-test-dynamicpv-l669 container test-container-subpath-dynamicpv-l669: <nil>
[1mSTEP[0m: delete the pod
Jun 25 06:43:09.182: INFO: Waiting for pod pod-subpath-test-dynamicpv-l669 to disappear
Jun 25 06:43:09.245: INFO: Pod pod-subpath-test-dynamicpv-l669 no longer exists
[1mSTEP[0m: Deleting pod pod-subpath-test-dynamicpv-l669
Jun 25 06:43:09.246: INFO: Deleting pod "pod-subpath-test-dynamicpv-l669" in namespace "provisioning-7962"
... skipping 292 lines ...
  [Driver: efs.csi.aws.com]
  [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:234[0m
    [91m[1mshould successfully mount a single pod when ReadWriteOncePod is used statically [It][0m
    [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:393[0m

    [91mcreating efs pvc & pv
    Unexpected error:
        <*errors.StatusError | 0xc0009868c0>: {
            ErrStatus: {
                TypeMeta: {Kind: "", APIVersion: ""},
                ListMeta: {
                    SelfLink: "",
                    ResourceVersion: "",
... skipping 267 lines ...
Jun 25 06:43:08.158: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
Jun 25 06:43:08.230: INFO: Waiting up to timeout=5m0s for PersistentVolumeClaims [efs.csi.aws.com872f7] to have phase Bound
Jun 25 06:43:08.295: INFO: PersistentVolumeClaim efs.csi.aws.com872f7 found but phase is Pending instead of Bound.
Jun 25 06:43:10.361: INFO: PersistentVolumeClaim efs.csi.aws.com872f7 found and phase=Bound (2.131088458s)
[1mSTEP[0m: Creating pod pod-subpath-test-dynamicpv-mtbn
[1mSTEP[0m: Creating a pod to test subpath
Jun 25 06:43:10.568: INFO: Waiting up to 5m0s for pod "pod-subpath-test-dynamicpv-mtbn" in namespace "provisioning-440" to be "Succeeded or Failed"
Jun 25 06:43:10.675: INFO: Pod "pod-subpath-test-dynamicpv-mtbn": Phase="Pending", Reason="", readiness=false. Elapsed: 107.225249ms
Jun 25 06:43:12.740: INFO: Pod "pod-subpath-test-dynamicpv-mtbn": Phase="Pending", Reason="", readiness=false. Elapsed: 2.172619985s
Jun 25 06:43:14.805: INFO: Pod "pod-subpath-test-dynamicpv-mtbn": Phase="Pending", Reason="", readiness=false. Elapsed: 4.236922016s
Jun 25 06:43:16.871: INFO: Pod "pod-subpath-test-dynamicpv-mtbn": Phase="Succeeded", Reason="", readiness=false. Elapsed: 6.303523571s
[1mSTEP[0m: Saw pod success
Jun 25 06:43:16.871: INFO: Pod "pod-subpath-test-dynamicpv-mtbn" satisfied condition "Succeeded or Failed"
Jun 25 06:43:16.937: INFO: Trying to get logs from node ip-192-168-73-74.us-west-2.compute.internal pod pod-subpath-test-dynamicpv-mtbn container test-container-subpath-dynamicpv-mtbn: <nil>
[1mSTEP[0m: delete the pod
Jun 25 06:43:17.139: INFO: Waiting for pod pod-subpath-test-dynamicpv-mtbn to disappear
Jun 25 06:43:17.203: INFO: Pod pod-subpath-test-dynamicpv-mtbn no longer exists
[1mSTEP[0m: Deleting pod pod-subpath-test-dynamicpv-mtbn
Jun 25 06:43:17.204: INFO: Deleting pod "pod-subpath-test-dynamicpv-mtbn" in namespace "provisioning-440"
[1mSTEP[0m: Creating pod pod-subpath-test-dynamicpv-mtbn
[1mSTEP[0m: Creating a pod to test subpath
Jun 25 06:43:17.347: INFO: Waiting up to 5m0s for pod "pod-subpath-test-dynamicpv-mtbn" in namespace "provisioning-440" to be "Succeeded or Failed"
Jun 25 06:43:17.412: INFO: Pod "pod-subpath-test-dynamicpv-mtbn": Phase="Pending", Reason="", readiness=false. Elapsed: 64.729633ms
Jun 25 06:43:19.480: INFO: Pod "pod-subpath-test-dynamicpv-mtbn": Phase="Pending", Reason="", readiness=false. Elapsed: 2.13314614s
Jun 25 06:43:21.554: INFO: Pod "pod-subpath-test-dynamicpv-mtbn": Phase="Succeeded", Reason="", readiness=false. Elapsed: 4.207115538s
[1mSTEP[0m: Saw pod success
Jun 25 06:43:21.554: INFO: Pod "pod-subpath-test-dynamicpv-mtbn" satisfied condition "Succeeded or Failed"
Jun 25 06:43:21.621: INFO: Trying to get logs from node ip-192-168-73-74.us-west-2.compute.internal pod pod-subpath-test-dynamicpv-mtbn container test-container-subpath-dynamicpv-mtbn: <nil>
[1mSTEP[0m: delete the pod
Jun 25 06:43:21.823: INFO: Waiting for pod pod-subpath-test-dynamicpv-mtbn to disappear
Jun 25 06:43:21.886: INFO: Pod pod-subpath-test-dynamicpv-mtbn no longer exists
[1mSTEP[0m: Deleting pod pod-subpath-test-dynamicpv-mtbn
Jun 25 06:43:21.886: INFO: Deleting pod "pod-subpath-test-dynamicpv-mtbn" in namespace "provisioning-440"
... skipping 574 lines ...

      [36mDriver efs.csi.aws.com doesn't support Block -- skipping[0m

      /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/multivolume.go:82
[90m------------------------------[0m
[0m[efs-csi] EFS CSI[0m [90m[Driver: efs.csi.aws.com][0m [0m[Testpattern: Dynamic PV (default fs)] subPath[0m 
  [1mshould fail if subpath directory is outside the volume [Slow][LinuxOnly][0m
  [37m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:240[0m

[BeforeEach] [efs-csi] EFS CSI
  /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:221
[BeforeEach] [efs-csi] EFS CSI
  /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:185
... skipping 8 lines ...
  /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:185
[1mSTEP[0m: Creating a kubernetes client
Jun 25 06:43:47.785: INFO: >>> kubeConfig: /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/hack/e2e/csi-test-artifacts/test-cluster-32760.k8s.local.eksctl.kubeconfig
[1mSTEP[0m: Building a namespace api object, basename provisioning
[1mSTEP[0m: Binding the e2e-test-privileged-psp PodSecurityPolicy to the default service account in provisioning-5682
[1mSTEP[0m: Waiting for a default service account to be provisioned in namespace
[It] should fail if subpath directory is outside the volume [Slow][LinuxOnly]
  /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:240
Jun 25 06:43:48.946: INFO: Creating resource for dynamic PV
Jun 25 06:43:48.946: INFO: Using claimSize:1Mi, test suite supported size:{ 1Mi}, driver(efs.csi.aws.com) supported size:{ 1Mi} 
[1mSTEP[0m: creating a StorageClass 
[1mSTEP[0m: creating a claim
Jun 25 06:43:49.160: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
Jun 25 06:43:49.235: INFO: Waiting up to timeout=5m0s for PersistentVolumeClaims [efs.csi.aws.compb5xl] to have phase Bound
Jun 25 06:43:49.306: INFO: PersistentVolumeClaim efs.csi.aws.compb5xl found but phase is Pending instead of Bound.
Jun 25 06:43:51.375: INFO: PersistentVolumeClaim efs.csi.aws.compb5xl found and phase=Bound (2.139551018s)
[1mSTEP[0m: Creating pod pod-subpath-test-dynamicpv-hstz
[1mSTEP[0m: Checking for subpath error in container status
Jun 25 06:43:55.749: INFO: Deleting pod "pod-subpath-test-dynamicpv-hstz" in namespace "provisioning-5682"
Jun 25 06:43:55.826: INFO: Wait up to 5m0s for pod "pod-subpath-test-dynamicpv-hstz" to be fully deleted
[1mSTEP[0m: Deleting pod
Jun 25 06:43:57.963: INFO: Deleting pod "pod-subpath-test-dynamicpv-hstz" in namespace "provisioning-5682"
[1mSTEP[0m: Deleting pvc
Jun 25 06:43:58.032: INFO: Deleting PersistentVolumeClaim "efs.csi.aws.compb5xl"
... skipping 15 lines ...
[efs-csi] EFS CSI
[90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:220[0m
  [Driver: efs.csi.aws.com]
  [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:228[0m
    [Testpattern: Dynamic PV (default fs)] subPath
    [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50[0m
      should fail if subpath directory is outside the volume [Slow][LinuxOnly]
      [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:240[0m
[90m------------------------------[0m
[BeforeEach] [efs-csi] EFS CSI
  /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:221
[BeforeEach] [efs-csi] EFS CSI
  /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:185
... skipping 262 lines ...
Jun 25 06:43:36.790: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
Jun 25 06:43:36.861: INFO: Waiting up to timeout=5m0s for PersistentVolumeClaims [efs.csi.aws.com879bn] to have phase Bound
Jun 25 06:43:36.925: INFO: PersistentVolumeClaim efs.csi.aws.com879bn found but phase is Pending instead of Bound.
Jun 25 06:43:38.991: INFO: PersistentVolumeClaim efs.csi.aws.com879bn found and phase=Bound (2.130674209s)
[1mSTEP[0m: Creating pod pod-subpath-test-dynamicpv-xktb
[1mSTEP[0m: Creating a pod to test atomic-volume-subpath
Jun 25 06:43:39.201: INFO: Waiting up to 5m0s for pod "pod-subpath-test-dynamicpv-xktb" in namespace "provisioning-4250" to be "Succeeded or Failed"
Jun 25 06:43:39.265: INFO: Pod "pod-subpath-test-dynamicpv-xktb": Phase="Pending", Reason="", readiness=false. Elapsed: 63.726522ms
Jun 25 06:43:41.330: INFO: Pod "pod-subpath-test-dynamicpv-xktb": Phase="Pending", Reason="", readiness=false. Elapsed: 2.128998262s
Jun 25 06:43:43.394: INFO: Pod "pod-subpath-test-dynamicpv-xktb": Phase="Running", Reason="", readiness=true. Elapsed: 4.193368353s
Jun 25 06:43:45.461: INFO: Pod "pod-subpath-test-dynamicpv-xktb": Phase="Running", Reason="", readiness=true. Elapsed: 6.25988246s
Jun 25 06:43:47.528: INFO: Pod "pod-subpath-test-dynamicpv-xktb": Phase="Running", Reason="", readiness=true. Elapsed: 8.327093152s
Jun 25 06:43:49.596: INFO: Pod "pod-subpath-test-dynamicpv-xktb": Phase="Running", Reason="", readiness=true. Elapsed: 10.395015889s
... skipping 3 lines ...
Jun 25 06:43:57.862: INFO: Pod "pod-subpath-test-dynamicpv-xktb": Phase="Running", Reason="", readiness=true. Elapsed: 18.660506093s
Jun 25 06:43:59.930: INFO: Pod "pod-subpath-test-dynamicpv-xktb": Phase="Running", Reason="", readiness=true. Elapsed: 20.72935748s
Jun 25 06:44:01.998: INFO: Pod "pod-subpath-test-dynamicpv-xktb": Phase="Running", Reason="", readiness=true. Elapsed: 22.797306757s
Jun 25 06:44:04.066: INFO: Pod "pod-subpath-test-dynamicpv-xktb": Phase="Running", Reason="", readiness=false. Elapsed: 24.864840246s
Jun 25 06:44:06.134: INFO: Pod "pod-subpath-test-dynamicpv-xktb": Phase="Succeeded", Reason="", readiness=false. Elapsed: 26.932525143s
[1mSTEP[0m: Saw pod success
Jun 25 06:44:06.134: INFO: Pod "pod-subpath-test-dynamicpv-xktb" satisfied condition "Succeeded or Failed"
Jun 25 06:44:06.198: INFO: Trying to get logs from node ip-192-168-73-74.us-west-2.compute.internal pod pod-subpath-test-dynamicpv-xktb container test-container-subpath-dynamicpv-xktb: <nil>
[1mSTEP[0m: delete the pod
Jun 25 06:44:06.355: INFO: Waiting for pod pod-subpath-test-dynamicpv-xktb to disappear
Jun 25 06:44:06.420: INFO: Pod pod-subpath-test-dynamicpv-xktb no longer exists
[1mSTEP[0m: Deleting pod pod-subpath-test-dynamicpv-xktb
Jun 25 06:44:06.420: INFO: Deleting pod "pod-subpath-test-dynamicpv-xktb" in namespace "provisioning-4250"
... skipping 117 lines ...
[efs-csi] EFS CSI
[90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:220[0m
  [Driver: efs.csi.aws.com]
  [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:228[0m
    [Testpattern: Pre-provisioned PV (default fs)] subPath
    [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50[0m
      [36m[1mshould fail if subpath directory is outside the volume [Slow][LinuxOnly] [BeforeEach][0m
      [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:240[0m

      [36mDriver supports dynamic provisioning, skipping PreprovisionedPV pattern[0m

      /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/base.go:244
[90m------------------------------[0m
... skipping 57 lines ...
[efs-csi] EFS CSI
[90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:220[0m
  [Driver: efs.csi.aws.com]
  [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:228[0m
    [Testpattern: Inline-volume (default fs)] subPath
    [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50[0m
      [36m[1mshould fail if subpath with backstepping is outside the volume [Slow][LinuxOnly] [BeforeEach][0m
      [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:278[0m

      [36mDriver efs.csi.aws.com doesn't support InlineVolume -- skipping[0m

      /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:116
[90m------------------------------[0m
... skipping 21 lines ...
[efs-csi] EFS CSI
[90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:220[0m
  [Driver: efs.csi.aws.com]
  [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:228[0m
    [Testpattern: Inline-volume (default fs)] subPath
    [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50[0m
      [36m[1mshould fail if subpath directory is outside the volume [Slow][LinuxOnly] [BeforeEach][0m
      [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:240[0m

      [36mDriver efs.csi.aws.com doesn't support InlineVolume -- skipping[0m

      /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:116
[90m------------------------------[0m
... skipping 249 lines ...
Jun 25 06:44:17.509: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
Jun 25 06:44:17.583: INFO: Waiting up to timeout=5m0s for PersistentVolumeClaims [efs.csi.aws.comp6bfl] to have phase Bound
Jun 25 06:44:17.648: INFO: PersistentVolumeClaim efs.csi.aws.comp6bfl found but phase is Pending instead of Bound.
Jun 25 06:44:19.713: INFO: PersistentVolumeClaim efs.csi.aws.comp6bfl found and phase=Bound (2.129593604s)
[1mSTEP[0m: Creating pod pod-subpath-test-dynamicpv-9lfk
[1mSTEP[0m: Creating a pod to test subpath
Jun 25 06:44:19.956: INFO: Waiting up to 5m0s for pod "pod-subpath-test-dynamicpv-9lfk" in namespace "provisioning-939" to be "Succeeded or Failed"
Jun 25 06:44:20.037: INFO: Pod "pod-subpath-test-dynamicpv-9lfk": Phase="Pending", Reason="", readiness=false. Elapsed: 80.906303ms
Jun 25 06:44:22.099: INFO: Pod "pod-subpath-test-dynamicpv-9lfk": Phase="Pending", Reason="", readiness=false. Elapsed: 2.143287118s
Jun 25 06:44:24.163: INFO: Pod "pod-subpath-test-dynamicpv-9lfk": Phase="Pending", Reason="", readiness=false. Elapsed: 4.206556851s
Jun 25 06:44:26.226: INFO: Pod "pod-subpath-test-dynamicpv-9lfk": Phase="Succeeded", Reason="", readiness=false. Elapsed: 6.269771683s
[1mSTEP[0m: Saw pod success
Jun 25 06:44:26.226: INFO: Pod "pod-subpath-test-dynamicpv-9lfk" satisfied condition "Succeeded or Failed"
Jun 25 06:44:26.289: INFO: Trying to get logs from node ip-192-168-73-74.us-west-2.compute.internal pod pod-subpath-test-dynamicpv-9lfk container test-container-volume-dynamicpv-9lfk: <nil>
[1mSTEP[0m: delete the pod
Jun 25 06:44:26.486: INFO: Waiting for pod pod-subpath-test-dynamicpv-9lfk to disappear
Jun 25 06:44:26.547: INFO: Pod pod-subpath-test-dynamicpv-9lfk no longer exists
[1mSTEP[0m: Deleting pod pod-subpath-test-dynamicpv-9lfk
Jun 25 06:44:26.547: INFO: Deleting pod "pod-subpath-test-dynamicpv-9lfk" in namespace "provisioning-939"
... skipping 56 lines ...
Jun 25 06:44:25.793: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
Jun 25 06:44:25.864: INFO: Waiting up to timeout=5m0s for PersistentVolumeClaims [efs.csi.aws.comtpg8v] to have phase Bound
Jun 25 06:44:25.927: INFO: PersistentVolumeClaim efs.csi.aws.comtpg8v found but phase is Pending instead of Bound.
Jun 25 06:44:27.991: INFO: PersistentVolumeClaim efs.csi.aws.comtpg8v found and phase=Bound (2.126580569s)
[1mSTEP[0m: Creating pod pod-subpath-test-dynamicpv-cn8h
[1mSTEP[0m: Creating a pod to test multi_subpath
Jun 25 06:44:28.206: INFO: Waiting up to 5m0s for pod "pod-subpath-test-dynamicpv-cn8h" in namespace "provisioning-9992" to be "Succeeded or Failed"
Jun 25 06:44:28.308: INFO: Pod "pod-subpath-test-dynamicpv-cn8h": Phase="Pending", Reason="", readiness=false. Elapsed: 102.2492ms
Jun 25 06:44:30.372: INFO: Pod "pod-subpath-test-dynamicpv-cn8h": Phase="Pending", Reason="", readiness=false. Elapsed: 2.165794932s
Jun 25 06:44:32.435: INFO: Pod "pod-subpath-test-dynamicpv-cn8h": Phase="Pending", Reason="", readiness=false. Elapsed: 4.228623806s
Jun 25 06:44:34.499: INFO: Pod "pod-subpath-test-dynamicpv-cn8h": Phase="Succeeded", Reason="", readiness=false. Elapsed: 6.292351512s
[1mSTEP[0m: Saw pod success
Jun 25 06:44:34.499: INFO: Pod "pod-subpath-test-dynamicpv-cn8h" satisfied condition "Succeeded or Failed"
Jun 25 06:44:34.563: INFO: Trying to get logs from node ip-192-168-73-74.us-west-2.compute.internal pod pod-subpath-test-dynamicpv-cn8h container test-container-subpath-dynamicpv-cn8h: <nil>
[1mSTEP[0m: delete the pod
Jun 25 06:44:34.714: INFO: Waiting for pod pod-subpath-test-dynamicpv-cn8h to disappear
Jun 25 06:44:34.780: INFO: Pod pod-subpath-test-dynamicpv-cn8h no longer exists
[1mSTEP[0m: Deleting pod
Jun 25 06:44:34.780: INFO: Deleting pod "pod-subpath-test-dynamicpv-cn8h" in namespace "provisioning-9992"
... skipping 387 lines ...
Jun 25 06:44:34.652: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
Jun 25 06:44:34.731: INFO: Waiting up to timeout=5m0s for PersistentVolumeClaims [efs.csi.aws.comz789q] to have phase Bound
Jun 25 06:44:34.796: INFO: PersistentVolumeClaim efs.csi.aws.comz789q found but phase is Pending instead of Bound.
Jun 25 06:44:36.863: INFO: PersistentVolumeClaim efs.csi.aws.comz789q found and phase=Bound (2.131927853s)
[1mSTEP[0m: Creating pod pod-subpath-test-dynamicpv-4vbr
[1mSTEP[0m: Creating a pod to test subpath
Jun 25 06:44:37.081: INFO: Waiting up to 5m0s for pod "pod-subpath-test-dynamicpv-4vbr" in namespace "provisioning-3656" to be "Succeeded or Failed"
Jun 25 06:44:37.145: INFO: Pod "pod-subpath-test-dynamicpv-4vbr": Phase="Pending", Reason="", readiness=false. Elapsed: 64.634096ms
Jun 25 06:44:39.212: INFO: Pod "pod-subpath-test-dynamicpv-4vbr": Phase="Pending", Reason="", readiness=false. Elapsed: 2.131377318s
Jun 25 06:44:41.280: INFO: Pod "pod-subpath-test-dynamicpv-4vbr": Phase="Pending", Reason="", readiness=false. Elapsed: 4.198955336s
Jun 25 06:44:43.348: INFO: Pod "pod-subpath-test-dynamicpv-4vbr": Phase="Succeeded", Reason="", readiness=false. Elapsed: 6.267232393s
[1mSTEP[0m: Saw pod success
Jun 25 06:44:43.348: INFO: Pod "pod-subpath-test-dynamicpv-4vbr" satisfied condition "Succeeded or Failed"
Jun 25 06:44:43.416: INFO: Trying to get logs from node ip-192-168-73-74.us-west-2.compute.internal pod pod-subpath-test-dynamicpv-4vbr container test-container-subpath-dynamicpv-4vbr: <nil>
[1mSTEP[0m: delete the pod
Jun 25 06:44:43.627: INFO: Waiting for pod pod-subpath-test-dynamicpv-4vbr to disappear
Jun 25 06:44:43.693: INFO: Pod pod-subpath-test-dynamicpv-4vbr no longer exists
[1mSTEP[0m: Deleting pod pod-subpath-test-dynamicpv-4vbr
Jun 25 06:44:43.693: INFO: Deleting pod "pod-subpath-test-dynamicpv-4vbr" in namespace "provisioning-3656"
... skipping 23 lines ...
    [Testpattern: Dynamic PV (default fs)] subPath
    [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50[0m
      should support existing single file [LinuxOnly]
      [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:219[0m
[90m------------------------------[0m
[0m[efs-csi] EFS CSI[0m [90m[Driver: efs.csi.aws.com][0m [0m[Testpattern: Dynamic PV (block volmode)] volumeMode[0m 
  [1mshould fail in binding dynamic provisioned PV to PVC [Slow][LinuxOnly][0m
  [37m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/volumemode.go:258[0m

[BeforeEach] [efs-csi] EFS CSI
  /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:221
[BeforeEach] [efs-csi] EFS CSI
  /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:185
... skipping 8 lines ...
  /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:185
[1mSTEP[0m: Creating a kubernetes client
Jun 25 06:43:01.808: INFO: >>> kubeConfig: /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/hack/e2e/csi-test-artifacts/test-cluster-32760.k8s.local.eksctl.kubeconfig
[1mSTEP[0m: Building a namespace api object, basename volumemode
[1mSTEP[0m: Binding the e2e-test-privileged-psp PodSecurityPolicy to the default service account in volumemode-6611
[1mSTEP[0m: Waiting for a default service account to be provisioned in namespace
[It] should fail in binding dynamic provisioned PV to PVC [Slow][LinuxOnly]
  /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/volumemode.go:258
[1mSTEP[0m: Creating sc
[1mSTEP[0m: Creating pv and pvc
Jun 25 06:48:03.400: INFO: Warning: did not get event about provisioing failed
[1mSTEP[0m: Deleting pvc
Jun 25 06:48:03.528: INFO: Deleting PersistentVolumeClaim "pvc-vwwhr"
[1mSTEP[0m: Deleting sc
[AfterEach] [Testpattern: Dynamic PV (block volmode)] volumeMode
  /home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:186
Jun 25 06:48:03.842: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
... skipping 8 lines ...
[efs-csi] EFS CSI
[90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:220[0m
  [Driver: efs.csi.aws.com]
  [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:228[0m
    [Testpattern: Dynamic PV (block volmode)] volumeMode
    [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50[0m
      should fail in binding dynamic provisioned PV to PVC [Slow][LinuxOnly]
      [90m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/vendor/k8s.io/kubernetes/test/e2e/storage/testsuites/volumemode.go:258[0m
[90m------------------------------[0m
[1mSTEP[0m: Deleting EFS filesystem "fs-0a41b65cb7e961369"
[1mSTEP[0m: Deleted EFS filesystem "fs-0a41b65cb7e961369"



[91m[1mSummarizing 1 Failure:[0m

[91m[1m[Fail] [0m[90m[efs-csi] EFS CSI [0m[0m[Driver: efs.csi.aws.com] [0m[91m[1m[It] should successfully mount a single pod when ReadWriteOncePod is used statically [0m
[37m/home/prow/go/src/github.com/kubernetes-sigs/aws-efs-csi-driver/test/e2e/e2e.go:396[0m

[1m[91mRan 36 of 190 Specs in 676.373 seconds[0m
[1m[91mFAIL![0m -- [32m[1m35 Passed[0m | [91m[1m1 Failed[0m | [33m[1m0 Pending[0m | [36m[1m154 Skipped[0m


Ginkgo ran 1 suite in 12m32.435328424s
Test Suite Failed
+ TEST_PASSED=1
+ set -e
+ set +x
###
## TEST_PASSED: 1
#
... skipping 1015 lines ...
I0625 06:35:39.362818       1 driver.go:128] Starting reaper
I0625 06:35:39.362843       1 driver.go:131] Listening for connections on address: &net.UnixAddr{Name:"/csi/csi.sock", Net:"unix"}
I0625 06:35:41.668223       1 node.go:303] NodeGetInfo: called with args 
I0625 06:38:51.477954       1 node.go:287] NodeGetCapabilities: called with args 
I0625 06:38:51.479438       1 node.go:287] NodeGetCapabilities: called with args 
I0625 06:38:51.480347       1 node.go:54] NodePublishVolume: called with args volume_id:"fs-0a41b65cb7e961369" staging_target_path:"/var/lib/kubelet/plugins/kubernetes.io/csi/volumeDevices/staging/pv6qrd4" target_path:"/var/lib/kubelet/plugins/kubernetes.io/csi/volumeDevices/publish/pv6qrd4/e581b9d3-fb29-472b-bd03-d659dca0e1ba" volume_capability:<block:<> access_mode:<mode:SINGLE_NODE_MULTI_WRITER > > 
E0625 06:38:51.480414       1 driver.go:107] GRPC error: rpc error: code = InvalidArgument desc = Volume capability not supported: only filesystem volumes are supported
I0625 06:38:51.983275       1 node.go:287] NodeGetCapabilities: called with args 
I0625 06:38:51.984375       1 node.go:287] NodeGetCapabilities: called with args 
I0625 06:38:51.985043       1 node.go:54] NodePublishVolume: called with args volume_id:"fs-0a41b65cb7e961369" staging_target_path:"/var/lib/kubelet/plugins/kubernetes.io/csi/volumeDevices/staging/pv6qrd4" target_path:"/var/lib/kubelet/plugins/kubernetes.io/csi/volumeDevices/publish/pv6qrd4/e581b9d3-fb29-472b-bd03-d659dca0e1ba" volume_capability:<block:<> access_mode:<mode:SINGLE_NODE_MULTI_WRITER > > 
E0625 06:38:51.985102       1 driver.go:107] GRPC error: rpc error: code = InvalidArgument desc = Volume capability not supported: only filesystem volumes are supported
I0625 06:38:52.993386       1 node.go:287] NodeGetCapabilities: called with args 
I0625 06:38:52.994250       1 node.go:287] NodeGetCapabilities: called with args 
I0625 06:38:52.994953       1 node.go:54] NodePublishVolume: called with args volume_id:"fs-0a41b65cb7e961369" staging_target_path:"/var/lib/kubelet/plugins/kubernetes.io/csi/volumeDevices/staging/pv6qrd4" target_path:"/var/lib/kubelet/plugins/kubernetes.io/csi/volumeDevices/publish/pv6qrd4/e581b9d3-fb29-472b-bd03-d659dca0e1ba" volume_capability:<block:<> access_mode:<mode:SINGLE_NODE_MULTI_WRITER > > 
E0625 06:38:52.995016       1 driver.go:107] GRPC error: rpc error: code = InvalidArgument desc = Volume capability not supported: only filesystem volumes are supported
I0625 06:38:55.010936       1 node.go:287] NodeGetCapabilities: called with args 
I0625 06:38:55.012275       1 node.go:287] NodeGetCapabilities: called with args 
I0625 06:38:55.013055       1 node.go:54] NodePublishVolume: called with args volume_id:"fs-0a41b65cb7e961369" staging_target_path:"/var/lib/kubelet/plugins/kubernetes.io/csi/volumeDevices/staging/pv6qrd4" target_path:"/var/lib/kubelet/plugins/kubernetes.io/csi/volumeDevices/publish/pv6qrd4/e581b9d3-fb29-472b-bd03-d659dca0e1ba" volume_capability:<block:<> access_mode:<mode:SINGLE_NODE_MULTI_WRITER > > 
E0625 06:38:55.013102       1 driver.go:107] GRPC error: rpc error: code = InvalidArgument desc = Volume capability not supported: only filesystem volumes are supported
I0625 06:38:59.054498       1 node.go:287] NodeGetCapabilities: called with args 
I0625 06:38:59.055827       1 node.go:287] NodeGetCapabilities: called with args 
I0625 06:38:59.056544       1 node.go:54] NodePublishVolume: called with args volume_id:"fs-0a41b65cb7e961369" staging_target_path:"/var/lib/kubelet/plugins/kubernetes.io/csi/volumeDevices/staging/pv6qrd4" target_path:"/var/lib/kubelet/plugins/kubernetes.io/csi/volumeDevices/publish/pv6qrd4/e581b9d3-fb29-472b-bd03-d659dca0e1ba" volume_capability:<block:<> access_mode:<mode:SINGLE_NODE_MULTI_WRITER > > 
E0625 06:38:59.056596       1 driver.go:107] GRPC error: rpc error: code = InvalidArgument desc = Volume capability not supported: only filesystem volumes are supported
I0625 06:39:07.129656       1 node.go:287] NodeGetCapabilities: called with args 
I0625 06:39:07.130746       1 node.go:287] NodeGetCapabilities: called with args 
I0625 06:39:07.131371       1 node.go:54] NodePublishVolume: called with args volume_id:"fs-0a41b65cb7e961369" staging_target_path:"/var/lib/kubelet/plugins/kubernetes.io/csi/volumeDevices/staging/pv6qrd4" target_path:"/var/lib/kubelet/plugins/kubernetes.io/csi/volumeDevices/publish/pv6qrd4/e581b9d3-fb29-472b-bd03-d659dca0e1ba" volume_capability:<block:<> access_mode:<mode:SINGLE_NODE_MULTI_WRITER > > 
E0625 06:39:07.131418       1 driver.go:107] GRPC error: rpc error: code = InvalidArgument desc = Volume capability not supported: only filesystem volumes are supported
I0625 06:39:10.064111       1 node.go:287] NodeGetCapabilities: called with args 
I0625 06:39:10.071834       1 node.go:287] NodeGetCapabilities: called with args 
I0625 06:39:10.072536       1 node.go:287] NodeGetCapabilities: called with args 
I0625 06:39:10.073233       1 node.go:54] NodePublishVolume: called with args volume_id:"fs-0a41b65cb7e961369:/" target_path:"/var/lib/kubelet/pods/474e6e86-d226-4607-af10-b194d9f0e3ef/volumes/kubernetes.io~csi/efs-1847/mount" volume_capability:<mount:<> access_mode:<mode:MULTI_NODE_MULTI_WRITER > > volume_context:<key:"encryptInTransit" value:"false" > 
I0625 06:39:10.073305       1 node.go:175] NodePublishVolume: creating dir /var/lib/kubelet/pods/474e6e86-d226-4607-af10-b194d9f0e3ef/volumes/kubernetes.io~csi/efs-1847/mount
I0625 06:39:10.073354       1 node.go:180] NodePublishVolume: mounting fs-0a41b65cb7e961369:/ at /var/lib/kubelet/pods/474e6e86-d226-4607-af10-b194d9f0e3ef/volumes/kubernetes.io~csi/efs-1847/mount with options []
... skipping 13 lines ...
I0625 06:39:19.766012       1 node.go:224] NodeUnpublishVolume: unmounting /var/lib/kubelet/pods/ac0d798c-0061-4ab9-8dc3-55e42430ed86/volumes/kubernetes.io~csi/efs-3237-root/mount
I0625 06:39:19.781987       1 node.go:229] NodeUnpublishVolume: /var/lib/kubelet/pods/ac0d798c-0061-4ab9-8dc3-55e42430ed86/volumes/kubernetes.io~csi/efs-3237-root/mount unmounted
I0625 06:39:19.865209       1 node.go:287] NodeGetCapabilities: called with args 
I0625 06:39:23.194836       1 node.go:287] NodeGetCapabilities: called with args 
I0625 06:39:23.195861       1 node.go:287] NodeGetCapabilities: called with args 
I0625 06:39:23.196539       1 node.go:54] NodePublishVolume: called with args volume_id:"fs-0a41b65cb7e961369" staging_target_path:"/var/lib/kubelet/plugins/kubernetes.io/csi/volumeDevices/staging/pv6qrd4" target_path:"/var/lib/kubelet/plugins/kubernetes.io/csi/volumeDevices/publish/pv6qrd4/e581b9d3-fb29-472b-bd03-d659dca0e1ba" volume_capability:<block:<> access_mode:<mode:SINGLE_NODE_MULTI_WRITER > > 
E0625 06:39:23.196593       1 driver.go:107] GRPC error: rpc error: code = InvalidArgument desc = Volume capability not supported: only filesystem volumes are supported
I0625 06:39:42.078782       1 node.go:287] NodeGetCapabilities: called with args 
I0625 06:39:42.078782       1 node.go:287] NodeGetCapabilities: called with args 
I0625 06:39:42.084725       1 node.go:287] NodeGetCapabilities: called with args 
I0625 06:39:42.085386       1 node.go:287] NodeGetCapabilities: called with args 
I0625 06:39:42.086162       1 node.go:54] NodePublishVolume: called with args volume_id:"fs-0a41b65cb7e961369:/a" target_path:"/var/lib/kubelet/pods/acbc1ccd-9bd2-4252-94a7-77cd253403cc/volumes/kubernetes.io~csi/efs-3237-a/mount" volume_capability:<mount:<> access_mode:<mode:MULTI_NODE_MULTI_WRITER > > 
I0625 06:39:42.086243       1 node.go:175] NodePublishVolume: creating dir /var/lib/kubelet/pods/acbc1ccd-9bd2-4252-94a7-77cd253403cc/volumes/kubernetes.io~csi/efs-3237-a/mount
... skipping 13 lines ...
I0625 06:39:51.478322       1 node.go:229] NodeUnpublishVolume: /var/lib/kubelet/pods/acbc1ccd-9bd2-4252-94a7-77cd253403cc/volumes/kubernetes.io~csi/efs-3237-a/mount unmounted
I0625 06:39:51.561662       1 node.go:287] NodeGetCapabilities: called with args 
I0625 06:39:51.562775       1 node.go:287] NodeGetCapabilities: called with args 
I0625 06:39:55.289321       1 node.go:287] NodeGetCapabilities: called with args 
I0625 06:39:55.289970       1 node.go:287] NodeGetCapabilities: called with args 
I0625 06:39:55.292665       1 node.go:54] NodePublishVolume: called with args volume_id:"fs-0a41b65cb7e961369" staging_target_path:"/var/lib/kubelet/plugins/kubernetes.io/csi/volumeDevices/staging/pv6qrd4" target_path:"/var/lib/kubelet/plugins/kubernetes.io/csi/volumeDevices/publish/pv6qrd4/e581b9d3-fb29-472b-bd03-d659dca0e1ba" volume_capability:<block:<> access_mode:<mode:SINGLE_NODE_MULTI_WRITER > > 
E0625 06:39:55.292720       1 driver.go:107] GRPC error: rpc error: code = InvalidArgument desc = Volume capability not supported: only filesystem volumes are supported
I0625 06:40:01.736478       1 node.go:287] NodeGetCapabilities: called with args 
I0625 06:40:01.742288       1 node.go:287] NodeGetCapabilities: called with args 
I0625 06:40:01.743215       1 node.go:287] NodeGetCapabilities: called with args 
I0625 06:40:01.743935       1 node.go:54] NodePublishVolume: called with args volume_id:"fs-0a41b65cb7e961369::fsap-02557e34cc0ea4351" target_path:"/var/lib/kubelet/pods/633f1254-9fcd-45d3-b5b0-4362bcaa387d/volumes/kubernetes.io~csi/pvc-f50752d3-1eef-4cbd-9721-de3b60d408df/mount" volume_capability:<mount:<> access_mode:<mode:SINGLE_NODE_MULTI_WRITER > > volume_context:<key:"storage.kubernetes.io/csiProvisionerIdentity" value:"1656138942007-8081-efs.csi.aws.com" > 
I0625 06:40:01.744027       1 node.go:175] NodePublishVolume: creating dir /var/lib/kubelet/pods/633f1254-9fcd-45d3-b5b0-4362bcaa387d/volumes/kubernetes.io~csi/pvc-f50752d3-1eef-4cbd-9721-de3b60d408df/mount
I0625 06:40:01.744095       1 node.go:180] NodePublishVolume: mounting fs-0a41b65cb7e961369:/ at /var/lib/kubelet/pods/633f1254-9fcd-45d3-b5b0-4362bcaa387d/volumes/kubernetes.io~csi/pvc-f50752d3-1eef-4cbd-9721-de3b60d408df/mount with options [accesspoint=fsap-02557e34cc0ea4351 tls]
... skipping 351 lines ...
2022-06-25 06:57:20 [ℹ]  will delete stack "eksctl-test-cluster-32760-k8s-local-cluster"
2022-06-25 06:57:21 [✔]  all cluster resources were deleted
###
## OVERALL_TEST_PASSED: 1
#
###
## FAIL!
#
make: *** [Makefile:131: test-e2e-external-eks] Error 1
+ EXIT_VALUE=2
+ set +o xtrace
Cleaning up after docker in docker.
================================================================================
Cleaning up after docker
Stopping Docker: dockerProgram process in pidfile '/var/run/docker-ssd.pid', 1 process(es), refused to die.
... skipping 3 lines ...

PR	jonathanrainer: Support ReadWriteOncePod
Result	FAILURE
Tests	1 failed / 35 succeeded
Started	2022-06-25 06:12
Elapsed	44m53s
Revision	7bb6b1674152126eca055f764566945f0c38bf1f
Refs	714

kubernetes-sigs/aws-efs-csi-driver PR #714 pull-aws-efs-csi-driver-external-test-eks #1540578717208678400

Test Failures

EFS CSI Suite [efs-csi] EFS CSI [Driver: efs.csi.aws.com] should successfully mount a single pod when ReadWriteOncePod is used statically 3.06s

Passed

Skipped

Error lines from build-log.txt