This job view page is being replaced by Spyglass soon. Check out the new job view.
PRJulienBalestra: controller/discoverer: add readiness check
ResultFAILURE
Tests 1 failed / 5 succeeded
Started2019-08-16 20:17
Elapsed30m46s
Revision8771d8d51527469d0df71a04540289f2e29864d8
Refs 135

Test Failures


Kubernetes Local Volume Provisioner e2e suite [sig-storage] PersistentVolumes-local Local volume provisioner [Serial] should not create local persistent volume for filesystem volume that was not bind mounted 1m0s

go run hack/e2e.go -v --test --test_args='--ginkgo.focus=Kubernetes\sLocal\sVolume\sProvisioner\se2e\ssuite\s\[sig\-storage\]\sPersistentVolumes\-local\s\sLocal\svolume\sprovisioner\s\[Serial\]\sshould\snot\screate\slocal\spersistent\svolume\sfor\sfilesystem\svolume\sthat\swas\snot\sbind\smounted$'
/home/prow/go/src/sigs.k8s.io/sig-storage-local-static-provisioner/test/e2e/e2e_test.go:255
Expected
    <bool>: false
to be true
/home/prow/go/src/sigs.k8s.io/sig-storage-local-static-provisioner/test/e2e/e2e_test.go:272
				
				Click to see stdout/stderrfrom junit_01.xml

Filter through log files


Show 5 Passed Tests

Error lines from build-log.txt

... skipping 269 lines ...
Trying to find master named 'e2e-test-prow-master'
Looking for address 'e2e-test-prow-master-ip'
Using master: e2e-test-prow-master (external IP: 35.193.3.116; internal IP: (not set))
Waiting up to 300 seconds for cluster initialization.

  This will continually check to see if the API for kubernetes is reachable.
  This may time out if there was some uncaught error during start up.

............Kubernetes cluster created.
Cluster "k8s-jkns-e2e-gke-ubuntu-slow_e2e-test-prow" set.
User "k8s-jkns-e2e-gke-ubuntu-slow_e2e-test-prow" set.
Context "k8s-jkns-e2e-gke-ubuntu-slow_e2e-test-prow" created.
Switched to context "k8s-jkns-e2e-gke-ubuntu-slow_e2e-test-prow".
... skipping 295 lines ...
Fetched 4829 kB in 0s (17.4 MB/s)
Selecting previously unselected package bash.
(Reading database ... 
(Reading database ... 5%
(Reading database ... 10%
(Reading database ... 15%
(Reading database ... 20%
(Reading database ... 25%
(Reading database ... 30%
(Reading database ... 35%
(Reading database ... 40%
(Reading database ... 45%
(Reading database ... 50%
(Reading database ... 55%
(Reading database ... 60%
(Reading database ... 65%
(Reading database ... 70%
(Reading database ... 75%
(Reading database ... 80%
(Reading database ... 85%
(Reading database ... 90%
(Reading database ... 95%
(Reading database ... 100%
(Reading database ... 3938 files and directories currently installed.)
Preparing to unpack .../archives/bash_4.4-5_amd64.deb ...
Unpacking bash (4.4-5) ...
Setting up bash (4.4-5) ...
update-alternatives: error: alternative path /usr/share/man/man7/bash-builtins.7.gz doesn't exist

Selecting previously unselected package e2fslibs:amd64.
(Reading database ... 
(Reading database ... 5%
(Reading database ... 10%
(Reading database ... 15%
(Reading database ... 20%
(Reading database ... 25%
(Reading database ... 30%
(Reading database ... 35%
(Reading database ... 40%
(Reading database ... 45%
(Reading database ... 50%
(Reading database ... 55%
(Reading database ... 60%
(Reading database ... 65%
(Reading database ... 70%
(Reading database ... 75%
(Reading database ... 80%
(Reading database ... 85%
(Reading database ... 90%
(Reading database ... 95%
(Reading database ... 100%
(Reading database ... 4005 files and directories currently installed.)
Preparing to unpack .../e2fslibs_1.43.4-2_amd64.deb ...
Unpacking e2fslibs:amd64 (1.43.4-2) ...
Setting up e2fslibs:amd64 (1.43.4-2) ...
Selecting previously unselected package libblkid1:amd64.
... skipping 495 lines ...
Aug 16 20:33:11.906: INFO: hostexec-e2e-test-prow-minion-group-0bhs      e2e-test-prow-minion-group-0bhs  Running         [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2019-08-16 20:32:19 +0000 UTC  } {Ready True 0001-01-01 00:00:00 +0000 UTC 2019-08-16 20:32:22 +0000 UTC  } {ContainersReady True 0001-01-01 00:00:00 +0000 UTC 2019-08-16 20:32:22 +0000 UTC  } {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2019-08-16 20:32:19 +0000 UTC  }]
Aug 16 20:33:11.906: INFO: hostexec-e2e-test-prow-minion-group-0zsr      e2e-test-prow-minion-group-0zsr  Running         [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2019-08-16 20:32:24 +0000 UTC  } {Ready True 0001-01-01 00:00:00 +0000 UTC 2019-08-16 20:32:26 +0000 UTC  } {ContainersReady True 0001-01-01 00:00:00 +0000 UTC 2019-08-16 20:32:26 +0000 UTC  } {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2019-08-16 20:32:24 +0000 UTC  }]
Aug 16 20:33:11.906: INFO: hostexec-e2e-test-prow-minion-group-b5kz      e2e-test-prow-minion-group-b5kz  Running         [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2019-08-16 20:32:26 +0000 UTC  } {Ready True 0001-01-01 00:00:00 +0000 UTC 2019-08-16 20:32:28 +0000 UTC  } {ContainersReady True 0001-01-01 00:00:00 +0000 UTC 2019-08-16 20:32:28 +0000 UTC  } {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2019-08-16 20:32:26 +0000 UTC  }]
Aug 16 20:33:11.906: INFO: 
Aug 16 20:33:11.910: INFO: 
Logging node info for node e2e-test-prow-master
Aug 16 20:33:11.913: INFO: Node Info: &Node{ObjectMeta:k8s_io_apimachinery_pkg_apis_meta_v1.ObjectMeta{Name:e2e-test-prow-master,GenerateName:,Namespace:,SelfLink:/api/v1/nodes/e2e-test-prow-master,UID:e8da866f-1e61-4f9d-b824-cd5eb1f12e69,ResourceVersion:2129,Generation:0,CreationTimestamp:2019-08-16 20:24:24 +0000 UTC,DeletionTimestamp:<nil>,DeletionGracePeriodSeconds:nil,Labels:map[string]string{beta.kubernetes.io/arch: amd64,beta.kubernetes.io/instance-type: n1-standard-1,beta.kubernetes.io/os: linux,cloud.google.com/metadata-proxy-ready: true,failure-domain.beta.kubernetes.io/region: us-central1,failure-domain.beta.kubernetes.io/zone: us-central1-b,kubernetes.io/arch: amd64,kubernetes.io/hostname: e2e-test-prow-master,kubernetes.io/os: linux,},Annotations:map[string]string{node.alpha.kubernetes.io/ttl: 0,volumes.kubernetes.io/controller-managed-attach-detach: true,},OwnerReferences:[],Finalizers:[],ClusterName:,Initializers:nil,ManagedFields:[],},Spec:NodeSpec{PodCIDR:10.64.1.0/24,DoNotUse_ExternalID:,ProviderID:gce://k8s-jkns-e2e-gke-ubuntu-slow/us-central1-b/e2e-test-prow-master,Unschedulable:true,Taints:[{node-role.kubernetes.io/master  NoSchedule <nil>} {node.kubernetes.io/unschedulable  NoSchedule <nil>}],ConfigSource:nil,},Status:NodeStatus{Capacity:ResourceList{attachable-volumes-gce-pd: {{127 0} {<nil>} 127 DecimalSI},cpu: {{1 0} {<nil>} 1 DecimalSI},ephemeral-storage: {{16684785664 0} {<nil>}  BinarySI},hugepages-2Mi: {{0 0} {<nil>} 0 DecimalSI},memory: {{3878420480 0} {<nil>}  BinarySI},pods: {{110 0} {<nil>} 110 DecimalSI},},Allocatable:ResourceList{attachable-volumes-gce-pd: {{127 0} {<nil>} 127 DecimalSI},cpu: {{1 0} {<nil>} 1 DecimalSI},ephemeral-storage: {{15016307073 0} {<nil>} 15016307073 DecimalSI},hugepages-2Mi: {{0 0} {<nil>} 0 DecimalSI},memory: {{3616276480 0} {<nil>}  BinarySI},pods: {{110 0} {<nil>} 110 DecimalSI},},Phase:,Conditions:[{NetworkUnavailable False 2019-08-16 20:24:53 +0000 UTC 2019-08-16 20:24:53 +0000 UTC RouteCreated RouteController created a route} {MemoryPressure False 2019-08-16 20:33:05 +0000 UTC 2019-08-16 20:24:24 +0000 UTC KubeletHasSufficientMemory kubelet has sufficient memory available} {DiskPressure False 2019-08-16 20:33:05 +0000 UTC 2019-08-16 20:24:24 +0000 UTC KubeletHasNoDiskPressure kubelet has no disk pressure} {PIDPressure False 2019-08-16 20:33:05 +0000 UTC 2019-08-16 20:24:24 +0000 UTC KubeletHasSufficientPID kubelet has sufficient PID available} {Ready True 2019-08-16 20:33:05 +0000 UTC 2019-08-16 20:24:25 +0000 UTC KubeletReady kubelet is posting ready status. AppArmor enabled}],Addresses:[{InternalIP 10.128.0.2} {ExternalIP 35.193.3.116} {InternalDNS e2e-test-prow-master.c.k8s-jkns-e2e-gke-ubuntu-slow.internal} {Hostname e2e-test-prow-master.c.k8s-jkns-e2e-gke-ubuntu-slow.internal}],DaemonEndpoints:NodeDaemonEndpoints{KubeletEndpoint:DaemonEndpoint{Port:10250,},},NodeInfo:NodeSystemInfo{MachineID:0f8aa6b9fba15e68f6a5803fe23e0988,SystemUUID:0F8AA6B9-FBA1-5E68-F6A5-803FE23E0988,BootID:0cc97a65-4b68-4643-9118-77fb5f110d4e,KernelVersion:4.14.94+,OSImage:Container-Optimized OS from Google,ContainerRuntimeVersion:docker://18.9.3,KubeletVersion:v1.17.0-alpha.0.208+8f0d626228cf89,KubeProxyVersion:v1.17.0-alpha.0.208+8f0d626228cf89,OperatingSystem:linux,Architecture:amd64,},Images:[{[k8s.gcr.io/etcd@sha256:02cd751eef4f7dcea7986e58d51903dab39baf4606f636b50891f30190abce2c k8s.gcr.io/etcd:3.3.10-1] 295923553} {[gcr.io/stackdriver-agents/stackdriver-logging-agent@sha256:6c8574a40816676cd908cfa89d16463002b56ca05fa76d0c912e116bc0ab867e gcr.io/stackdriver-agents/stackdriver-logging-agent:1.6.8] 264721247} {[k8s.gcr.io/kube-apiserver-amd64:v1.17.0-alpha.0.208_8f0d626228cf89] 248536353} {[k8s.gcr.io/kube-controller-manager-amd64:v1.17.0-alpha.0.208_8f0d626228cf89] 198060610} {[k8s.gcr.io/kube-scheduler-amd64:v1.17.0-alpha.0.208_8f0d626228cf89] 100320919} {[k8s.gcr.io/kube-addon-manager@sha256:3e315022a842d782a28e729720f21091dde21f1efea28868d65ec595ad871616 k8s.gcr.io/kube-addon-manager:v9.0.2] 83076028} {[k8s.gcr.io/etcd-empty-dir-cleanup@sha256:13e18f320022be5cf7c1c38a6207d02c07d603b52c1dd47b7c69e9324bd3c641 k8s.gcr.io/etcd-empty-dir-cleanup:3.3.10.1] 73958468} {[k8s.gcr.io/ingress-gce-glbc-amd64@sha256:14f14351a03038b238232e60850a9cfa0dffbed0590321ef84216a432accc1ca k8s.gcr.io/ingress-gce-glbc-amd64:v1.2.3] 71797285} {[k8s.gcr.io/prometheus-to-sd@sha256:14666989f40bb7c896c3e775a93c6873e2b791d65bc65579f58a078b7f9a764e k8s.gcr.io/prometheus-to-sd:v0.5.0] 41861013} {[k8s.gcr.io/metadata-proxy@sha256:e914645f22e946bce5165737e1b244e0a296ad1f0f81a9531adc57af2780978a k8s.gcr.io/metadata-proxy:v0.1.12] 11337839} {[k8s.gcr.io/pause@sha256:f78411e19d84a252e53bff71a4407a5686c46983a2c2eeed83929b888179acea k8s.gcr.io/pause:3.1] 742472}],VolumesInUse:[],VolumesAttached:[],Config:&NodeConfigStatus{Assigned:nil,Active:nil,LastKnownGood:nil,Error:,},},}
Aug 16 20:33:11.914: INFO: 
Logging kubelet events for node e2e-test-prow-master
Aug 16 20:33:11.920: INFO: 
Logging pods the kubelet thinks is on node e2e-test-prow-master
Aug 16 20:33:11.932: INFO: kube-controller-manager-e2e-test-prow-master started at 2019-08-16 20:23:27 +0000 UTC (0+1 container statuses recorded)
Aug 16 20:33:11.932: INFO: 	Container kube-controller-manager ready: true, restart count 0
... skipping 18 lines ...
Aug 16 20:33:11.932: INFO: kube-scheduler-e2e-test-prow-master started at 2019-08-16 20:23:28 +0000 UTC (0+1 container statuses recorded)
Aug 16 20:33:11.932: INFO: 	Container kube-scheduler ready: true, restart count 0
Aug 16 20:33:11.982: INFO: 
Latency metrics for node e2e-test-prow-master
Aug 16 20:33:11.982: INFO: 
Logging node info for node e2e-test-prow-minion-group-0bhs
Aug 16 20:33:11.989: INFO: Node Info: &Node{ObjectMeta:k8s_io_apimachinery_pkg_apis_meta_v1.ObjectMeta{Name:e2e-test-prow-minion-group-0bhs,GenerateName:,Namespace:,SelfLink:/api/v1/nodes/e2e-test-prow-minion-group-0bhs,UID:8476071b-5c11-446c-9cf5-22820334d0ec,ResourceVersion:2112,Generation:0,CreationTimestamp:2019-08-16 20:24:30 +0000 UTC,DeletionTimestamp:<nil>,DeletionGracePeriodSeconds:nil,Labels:map[string]string{beta.kubernetes.io/arch: amd64,beta.kubernetes.io/instance-type: n1-standard-2,beta.kubernetes.io/os: linux,cloud.google.com/metadata-proxy-ready: true,failure-domain.beta.kubernetes.io/region: us-central1,failure-domain.beta.kubernetes.io/zone: us-central1-b,kubernetes.io/arch: amd64,kubernetes.io/hostname: e2e-test-prow-minion-group-0bhs,kubernetes.io/os: linux,},Annotations:map[string]string{node.alpha.kubernetes.io/ttl: 0,volumes.kubernetes.io/controller-managed-attach-detach: true,},OwnerReferences:[],Finalizers:[],ClusterName:,Initializers:nil,ManagedFields:[],},Spec:NodeSpec{PodCIDR:10.64.2.0/24,DoNotUse_ExternalID:,ProviderID:gce://k8s-jkns-e2e-gke-ubuntu-slow/us-central1-b/e2e-test-prow-minion-group-0bhs,Unschedulable:false,Taints:[],ConfigSource:nil,},Status:NodeStatus{Capacity:ResourceList{attachable-volumes-gce-pd: {{127 0} {<nil>} 127 DecimalSI},cpu: {{2 0} {<nil>} 2 DecimalSI},ephemeral-storage: {{101241290752 0} {<nil>}  BinarySI},hugepages-2Mi: {{0 0} {<nil>} 0 DecimalSI},memory: {{7841865728 0} {<nil>}  BinarySI},pods: {{110 0} {<nil>} 110 DecimalSI},},Allocatable:ResourceList{attachable-volumes-gce-pd: {{127 0} {<nil>} 127 DecimalSI},cpu: {{2 0} {<nil>} 2 DecimalSI},ephemeral-storage: {{91117161526 0} {<nil>} 91117161526 DecimalSI},hugepages-2Mi: {{0 0} {<nil>} 0 DecimalSI},memory: {{7579721728 0} {<nil>}  BinarySI},pods: {{110 0} {<nil>} 110 DecimalSI},},Phase:,Conditions:[{ReadonlyFilesystem False 2019-08-16 20:32:58 +0000 UTC 2019-08-16 20:23:52 +0000 UTC FilesystemIsNotReadOnly Filesystem is not read-only} {FrequentKubeletRestart False 2019-08-16 20:32:58 +0000 UTC 2019-08-16 20:28:53 +0000 UTC FrequentKubeletRestart kubelet is functioning properly} {FrequentDockerRestart False 2019-08-16 20:32:58 +0000 UTC 2019-08-16 20:28:54 +0000 UTC FrequentDockerRestart docker is functioning properly} {FrequentContainerdRestart False 2019-08-16 20:32:58 +0000 UTC 2019-08-16 20:28:55 +0000 UTC FrequentContainerdRestart containerd is functioning properly} {CorruptDockerOverlay2 False 2019-08-16 20:32:58 +0000 UTC 2019-08-16 20:28:53 +0000 UTC CorruptDockerOverlay2 docker overlay2 is functioning properly} {FrequentUnregisterNetDevice False 2019-08-16 20:32:58 +0000 UTC 2019-08-16 20:28:52 +0000 UTC UnregisterNetDevice node is functioning properly} {KernelDeadlock False 2019-08-16 20:32:58 +0000 UTC 2019-08-16 20:23:52 +0000 UTC KernelHasNoDeadlock kernel has no deadlock} {NetworkUnavailable False 2019-08-16 20:24:53 +0000 UTC 2019-08-16 20:24:53 +0000 UTC RouteCreated RouteController created a route} {MemoryPressure False 2019-08-16 20:33:02 +0000 UTC 2019-08-16 20:24:30 +0000 UTC KubeletHasSufficientMemory kubelet has sufficient memory available} {DiskPressure False 2019-08-16 20:33:02 +0000 UTC 2019-08-16 20:24:30 +0000 UTC KubeletHasNoDiskPressure kubelet has no disk pressure} {PIDPressure False 2019-08-16 20:33:02 +0000 UTC 2019-08-16 20:24:30 +0000 UTC KubeletHasSufficientPID kubelet has sufficient PID available} {Ready True 2019-08-16 20:33:02 +0000 UTC 2019-08-16 20:24:31 +0000 UTC KubeletReady kubelet is posting ready status. AppArmor enabled}],Addresses:[{InternalIP 10.128.0.3} {ExternalIP 34.66.110.206} {InternalDNS e2e-test-prow-minion-group-0bhs.c.k8s-jkns-e2e-gke-ubuntu-slow.internal} {Hostname e2e-test-prow-minion-group-0bhs.c.k8s-jkns-e2e-gke-ubuntu-slow.internal}],DaemonEndpoints:NodeDaemonEndpoints{KubeletEndpoint:DaemonEndpoint{Port:10250,},},NodeInfo:NodeSystemInfo{MachineID:be2acc1fe0e58ffe04023c7631cdd0b0,SystemUUID:BE2ACC1F-E0E5-8FFE-0402-3C7631CDD0B0,BootID:dd018d97-d450-4bb4-92d3-5ca4c00470ca,KernelVersion:4.14.94+,OSImage:Container-Optimized OS from Google,ContainerRuntimeVersion:docker://18.9.3,KubeletVersion:v1.17.0-alpha.0.208+8f0d626228cf89,KubeProxyVersion:v1.17.0-alpha.0.208+8f0d626228cf89,OperatingSystem:linux,Architecture:amd64,},Images:[{[gcr.io/stackdriver-agents/stackdriver-logging-agent@sha256:6c8574a40816676cd908cfa89d16463002b56ca05fa76d0c912e116bc0ab867e gcr.io/stackdriver-agents/stackdriver-logging-agent:1.6.8] 264721247} {[gcr.io/k8s-jkns-e2e-gke-ubuntu-slow/local-volume-provisioner@sha256:2a81ebbb17a50aed50a1008a8cc4daff1c56a22e88efb590e75921161d1de7fc gcr.io/k8s-jkns-e2e-gke-ubuntu-slow/local-volume-provisioner:v2.3.2-50-g2104bd18] 106722791} {[k8s.gcr.io/kube-proxy-amd64:v1.17.0-alpha.0.208_8f0d626228cf89] 99668215} {[k8s.gcr.io/prometheus-to-sd@sha256:14666989f40bb7c896c3e775a93c6873e2b791d65bc65579f58a078b7f9a764e k8s.gcr.io/prometheus-to-sd:v0.5.0] 41861013} {[k8s.gcr.io/metadata-proxy@sha256:e914645f22e946bce5165737e1b244e0a296ad1f0f81a9531adc57af2780978a k8s.gcr.io/metadata-proxy:v0.1.12] 11337839} {[gcr.io/kubernetes-e2e-test-images/hostexec@sha256:90dfe59da029f9e536385037bc64e86cd3d6e55bae613ddbe69e554d79b0639d gcr.io/kubernetes-e2e-test-images/hostexec:1.1] 8490662} {[k8s.gcr.io/pause@sha256:f78411e19d84a252e53bff71a4407a5686c46983a2c2eeed83929b888179acea k8s.gcr.io/pause:3.1] 742472}],VolumesInUse:[],VolumesAttached:[],Config:&NodeConfigStatus{Assigned:nil,Active:nil,LastKnownGood:nil,Error:,},},}
Aug 16 20:33:11.989: INFO: 
Logging kubelet events for node e2e-test-prow-minion-group-0bhs
Aug 16 20:33:11.995: INFO: 
Logging pods the kubelet thinks is on node e2e-test-prow-minion-group-0bhs
Aug 16 20:33:12.003: INFO: kube-proxy-e2e-test-prow-minion-group-0bhs started at 2019-08-16 20:24:30 +0000 UTC (0+1 container statuses recorded)
Aug 16 20:33:12.003: INFO: 	Container kube-proxy ready: true, restart count 0
... skipping 6 lines ...
Aug 16 20:33:12.003: INFO: hostexec-e2e-test-prow-minion-group-0bhs started at 2019-08-16 20:32:19 +0000 UTC (0+1 container statuses recorded)
Aug 16 20:33:12.003: INFO: 	Container hostexec ready: true, restart count 0
Aug 16 20:33:12.037: INFO: 
Latency metrics for node e2e-test-prow-minion-group-0bhs
Aug 16 20:33:12.037: INFO: 
Logging node info for node e2e-test-prow-minion-group-0zsr
Aug 16 20:33:12.040: INFO: Node Info: &Node{ObjectMeta:k8s_io_apimachinery_pkg_apis_meta_v1.ObjectMeta{Name:e2e-test-prow-minion-group-0zsr,GenerateName:,Namespace:,SelfLink:/api/v1/nodes/e2e-test-prow-minion-group-0zsr,UID:21c17a2d-3724-488b-8388-86dacac20ad0,ResourceVersion:2115,Generation:0,CreationTimestamp:2019-08-16 20:24:32 +0000 UTC,DeletionTimestamp:<nil>,DeletionGracePeriodSeconds:nil,Labels:map[string]string{beta.kubernetes.io/arch: amd64,beta.kubernetes.io/instance-type: n1-standard-2,beta.kubernetes.io/os: linux,cloud.google.com/metadata-proxy-ready: true,failure-domain.beta.kubernetes.io/region: us-central1,failure-domain.beta.kubernetes.io/zone: us-central1-b,kubernetes.io/arch: amd64,kubernetes.io/hostname: e2e-test-prow-minion-group-0zsr,kubernetes.io/os: linux,},Annotations:map[string]string{node.alpha.kubernetes.io/ttl: 0,volumes.kubernetes.io/controller-managed-attach-detach: true,},OwnerReferences:[],Finalizers:[],ClusterName:,Initializers:nil,ManagedFields:[],},Spec:NodeSpec{PodCIDR:10.64.3.0/24,DoNotUse_ExternalID:,ProviderID:gce://k8s-jkns-e2e-gke-ubuntu-slow/us-central1-b/e2e-test-prow-minion-group-0zsr,Unschedulable:false,Taints:[],ConfigSource:nil,},Status:NodeStatus{Capacity:ResourceList{attachable-volumes-gce-pd: {{127 0} {<nil>} 127 DecimalSI},cpu: {{2 0} {<nil>} 2 DecimalSI},ephemeral-storage: {{101241290752 0} {<nil>}  BinarySI},hugepages-2Mi: {{0 0} {<nil>} 0 DecimalSI},memory: {{7841865728 0} {<nil>}  BinarySI},pods: {{110 0} {<nil>} 110 DecimalSI},},Allocatable:ResourceList{attachable-volumes-gce-pd: {{127 0} {<nil>} 127 DecimalSI},cpu: {{2 0} {<nil>} 2 DecimalSI},ephemeral-storage: {{91117161526 0} {<nil>} 91117161526 DecimalSI},hugepages-2Mi: {{0 0} {<nil>} 0 DecimalSI},memory: {{7579721728 0} {<nil>}  BinarySI},pods: {{110 0} {<nil>} 110 DecimalSI},},Phase:,Conditions:[{CorruptDockerOverlay2 False 2019-08-16 20:32:58 +0000 UTC 2019-08-16 20:28:53 +0000 UTC CorruptDockerOverlay2 docker overlay2 is functioning properly} {FrequentKubeletRestart False 2019-08-16 20:32:58 +0000 UTC 2019-08-16 20:28:54 +0000 UTC FrequentKubeletRestart kubelet is functioning properly} {FrequentDockerRestart False 2019-08-16 20:32:58 +0000 UTC 2019-08-16 20:28:55 +0000 UTC FrequentDockerRestart docker is functioning properly} {FrequentContainerdRestart False 2019-08-16 20:32:58 +0000 UTC 2019-08-16 20:28:56 +0000 UTC FrequentContainerdRestart containerd is functioning properly} {KernelDeadlock False 2019-08-16 20:32:58 +0000 UTC 2019-08-16 20:23:53 +0000 UTC KernelHasNoDeadlock kernel has no deadlock} {ReadonlyFilesystem False 2019-08-16 20:32:58 +0000 UTC 2019-08-16 20:23:53 +0000 UTC FilesystemIsNotReadOnly Filesystem is not read-only} {FrequentUnregisterNetDevice False 2019-08-16 20:32:58 +0000 UTC 2019-08-16 20:28:54 +0000 UTC UnregisterNetDevice node is functioning properly} {NetworkUnavailable False 2019-08-16 20:24:53 +0000 UTC 2019-08-16 20:24:53 +0000 UTC RouteCreated RouteController created a route} {MemoryPressure False 2019-08-16 20:33:03 +0000 UTC 2019-08-16 20:24:32 +0000 UTC KubeletHasSufficientMemory kubelet has sufficient memory available} {DiskPressure False 2019-08-16 20:33:03 +0000 UTC 2019-08-16 20:24:32 +0000 UTC KubeletHasNoDiskPressure kubelet has no disk pressure} {PIDPressure False 2019-08-16 20:33:03 +0000 UTC 2019-08-16 20:24:32 +0000 UTC KubeletHasSufficientPID kubelet has sufficient PID available} {Ready True 2019-08-16 20:33:03 +0000 UTC 2019-08-16 20:24:32 +0000 UTC KubeletReady kubelet is posting ready status. AppArmor enabled}],Addresses:[{InternalIP 10.128.0.4} {ExternalIP 130.211.206.79} {InternalDNS e2e-test-prow-minion-group-0zsr.c.k8s-jkns-e2e-gke-ubuntu-slow.internal} {Hostname e2e-test-prow-minion-group-0zsr.c.k8s-jkns-e2e-gke-ubuntu-slow.internal}],DaemonEndpoints:NodeDaemonEndpoints{KubeletEndpoint:DaemonEndpoint{Port:10250,},},NodeInfo:NodeSystemInfo{MachineID:2692dbda452bf0478b6b58bf4de36f66,SystemUUID:2692DBDA-452B-F047-8B6B-58BF4DE36F66,BootID:13330340-492a-4f42-a55f-153f19f638ed,KernelVersion:4.14.94+,OSImage:Container-Optimized OS from Google,ContainerRuntimeVersion:docker://18.9.3,KubeletVersion:v1.17.0-alpha.0.208+8f0d626228cf89,KubeProxyVersion:v1.17.0-alpha.0.208+8f0d626228cf89,OperatingSystem:linux,Architecture:amd64,},Images:[{[gcr.io/stackdriver-agents/stackdriver-logging-agent@sha256:6c8574a40816676cd908cfa89d16463002b56ca05fa76d0c912e116bc0ab867e gcr.io/stackdriver-agents/stackdriver-logging-agent:1.6.8] 264721247} {[gcr.io/k8s-jkns-e2e-gke-ubuntu-slow/local-volume-provisioner@sha256:2a81ebbb17a50aed50a1008a8cc4daff1c56a22e88efb590e75921161d1de7fc gcr.io/k8s-jkns-e2e-gke-ubuntu-slow/local-volume-provisioner:v2.3.2-50-g2104bd18] 106722791} {[k8s.gcr.io/kube-proxy-amd64:v1.17.0-alpha.0.208_8f0d626228cf89] 99668215} {[k8s.gcr.io/prometheus-to-sd@sha256:14666989f40bb7c896c3e775a93c6873e2b791d65bc65579f58a078b7f9a764e k8s.gcr.io/prometheus-to-sd:v0.5.0] 41861013} {[k8s.gcr.io/metadata-proxy@sha256:e914645f22e946bce5165737e1b244e0a296ad1f0f81a9531adc57af2780978a k8s.gcr.io/metadata-proxy:v0.1.12] 11337839} {[gcr.io/kubernetes-e2e-test-images/hostexec@sha256:90dfe59da029f9e536385037bc64e86cd3d6e55bae613ddbe69e554d79b0639d gcr.io/kubernetes-e2e-test-images/hostexec:1.1] 8490662} {[k8s.gcr.io/pause@sha256:f78411e19d84a252e53bff71a4407a5686c46983a2c2eeed83929b888179acea k8s.gcr.io/pause:3.1] 742472}],VolumesInUse:[],VolumesAttached:[],Config:&NodeConfigStatus{Assigned:nil,Active:nil,LastKnownGood:nil,Error:,},},}
Aug 16 20:33:12.041: INFO: 
Logging kubelet events for node e2e-test-prow-minion-group-0zsr
Aug 16 20:33:12.048: INFO: 
Logging pods the kubelet thinks is on node e2e-test-prow-minion-group-0zsr
Aug 16 20:33:12.055: INFO: kube-proxy-e2e-test-prow-minion-group-0zsr started at 2019-08-16 20:24:32 +0000 UTC (0+1 container statuses recorded)
Aug 16 20:33:12.056: INFO: 	Container kube-proxy ready: true, restart count 0
... skipping 6 lines ...
Aug 16 20:33:12.057: INFO: hostexec-e2e-test-prow-minion-group-0zsr started at 2019-08-16 20:32:24 +0000 UTC (0+1 container statuses recorded)
Aug 16 20:33:12.057: INFO: 	Container hostexec ready: true, restart count 0
Aug 16 20:33:12.099: INFO: 
Latency metrics for node e2e-test-prow-minion-group-0zsr
Aug 16 20:33:12.099: INFO: 
Logging node info for node e2e-test-prow-minion-group-b5kz
Aug 16 20:33:12.103: INFO: Node Info: &Node{ObjectMeta:k8s_io_apimachinery_pkg_apis_meta_v1.ObjectMeta{Name:e2e-test-prow-minion-group-b5kz,GenerateName:,Namespace:,SelfLink:/api/v1/nodes/e2e-test-prow-minion-group-b5kz,UID:d98a7839-222d-4627-a304-c0f686ef813d,ResourceVersion:2095,Generation:0,CreationTimestamp:2019-08-16 20:24:21 +0000 UTC,DeletionTimestamp:<nil>,DeletionGracePeriodSeconds:nil,Labels:map[string]string{beta.kubernetes.io/arch: amd64,beta.kubernetes.io/instance-type: n1-standard-2,beta.kubernetes.io/os: linux,cloud.google.com/metadata-proxy-ready: true,failure-domain.beta.kubernetes.io/region: us-central1,failure-domain.beta.kubernetes.io/zone: us-central1-b,kubernetes.io/arch: amd64,kubernetes.io/hostname: e2e-test-prow-minion-group-b5kz,kubernetes.io/os: linux,},Annotations:map[string]string{node.alpha.kubernetes.io/ttl: 0,volumes.kubernetes.io/controller-managed-attach-detach: true,},OwnerReferences:[],Finalizers:[],ClusterName:,Initializers:nil,ManagedFields:[],},Spec:NodeSpec{PodCIDR:10.64.0.0/24,DoNotUse_ExternalID:,ProviderID:gce://k8s-jkns-e2e-gke-ubuntu-slow/us-central1-b/e2e-test-prow-minion-group-b5kz,Unschedulable:false,Taints:[],ConfigSource:nil,},Status:NodeStatus{Capacity:ResourceList{attachable-volumes-gce-pd: {{127 0} {<nil>} 127 DecimalSI},cpu: {{2 0} {<nil>} 2 DecimalSI},ephemeral-storage: {{101241290752 0} {<nil>}  BinarySI},hugepages-2Mi: {{0 0} {<nil>} 0 DecimalSI},memory: {{7841865728 0} {<nil>}  BinarySI},pods: {{110 0} {<nil>} 110 DecimalSI},},Allocatable:ResourceList{attachable-volumes-gce-pd: {{127 0} {<nil>} 127 DecimalSI},cpu: {{2 0} {<nil>} 2 DecimalSI},ephemeral-storage: {{91117161526 0} {<nil>} 91117161526 DecimalSI},hugepages-2Mi: {{0 0} {<nil>} 0 DecimalSI},memory: {{7579721728 0} {<nil>}  BinarySI},pods: {{110 0} {<nil>} 110 DecimalSI},},Phase:,Conditions:[{ReadonlyFilesystem False 2019-08-16 20:32:55 +0000 UTC 2019-08-16 20:23:47 +0000 UTC FilesystemIsNotReadOnly Filesystem is not read-only} {FrequentKubeletRestart False 2019-08-16 20:32:55 +0000 UTC 2019-08-16 20:28:48 +0000 UTC FrequentKubeletRestart kubelet is functioning properly} {FrequentDockerRestart False 2019-08-16 20:32:55 +0000 UTC 2019-08-16 20:28:50 +0000 UTC FrequentDockerRestart docker is functioning properly} {FrequentContainerdRestart False 2019-08-16 20:32:55 +0000 UTC 2019-08-16 20:28:51 +0000 UTC FrequentContainerdRestart containerd is functioning properly} {FrequentUnregisterNetDevice False 2019-08-16 20:32:55 +0000 UTC 2019-08-16 20:28:49 +0000 UTC UnregisterNetDevice node is functioning properly} {CorruptDockerOverlay2 False 2019-08-16 20:32:55 +0000 UTC 2019-08-16 20:28:48 +0000 UTC CorruptDockerOverlay2 docker overlay2 is functioning properly} {KernelDeadlock False 2019-08-16 20:32:55 +0000 UTC 2019-08-16 20:23:47 +0000 UTC KernelHasNoDeadlock kernel has no deadlock} {NetworkUnavailable False 2019-08-16 20:24:34 +0000 UTC 2019-08-16 20:24:34 +0000 UTC RouteCreated RouteController created a route} {MemoryPressure False 2019-08-16 20:32:52 +0000 UTC 2019-08-16 20:24:21 +0000 UTC KubeletHasSufficientMemory kubelet has sufficient memory available} {DiskPressure False 2019-08-16 20:32:52 +0000 UTC 2019-08-16 20:24:21 +0000 UTC KubeletHasNoDiskPressure kubelet has no disk pressure} {PIDPressure False 2019-08-16 20:32:52 +0000 UTC 2019-08-16 20:24:21 +0000 UTC KubeletHasSufficientPID kubelet has sufficient PID available} {Ready True 2019-08-16 20:32:52 +0000 UTC 2019-08-16 20:24:21 +0000 UTC KubeletReady kubelet is posting ready status. AppArmor enabled}],Addresses:[{InternalIP 10.128.0.5} {ExternalIP 35.232.207.100} {InternalDNS e2e-test-prow-minion-group-b5kz.c.k8s-jkns-e2e-gke-ubuntu-slow.internal} {Hostname e2e-test-prow-minion-group-b5kz.c.k8s-jkns-e2e-gke-ubuntu-slow.internal}],DaemonEndpoints:NodeDaemonEndpoints{KubeletEndpoint:DaemonEndpoint{Port:10250,},},NodeInfo:NodeSystemInfo{MachineID:d62c745ae77a27388661a669305f24b2,SystemUUID:D62C745A-E77A-2738-8661-A669305F24B2,BootID:f124bd92-a9bc-49cc-be67-f0ad5f5e1dca,KernelVersion:4.14.94+,OSImage:Container-Optimized OS from Google,ContainerRuntimeVersion:docker://18.9.3,KubeletVersion:v1.17.0-alpha.0.208+8f0d626228cf89,KubeProxyVersion:v1.17.0-alpha.0.208+8f0d626228cf89,OperatingSystem:linux,Architecture:amd64,},Images:[{[gcr.io/stackdriver-agents/stackdriver-logging-agent@sha256:6c8574a40816676cd908cfa89d16463002b56ca05fa76d0c912e116bc0ab867e gcr.io/stackdriver-agents/stackdriver-logging-agent:1.6.8] 264721247} {[k8s.gcr.io/kubernetes-dashboard-amd64@sha256:0ae6b69432e78069c5ce2bcde0fe409c5c4d6f0f4d9cd50a17974fea38898747 k8s.gcr.io/kubernetes-dashboard-amd64:v1.10.1] 121711221} {[gcr.io/k8s-jkns-e2e-gke-ubuntu-slow/local-volume-provisioner@sha256:2a81ebbb17a50aed50a1008a8cc4daff1c56a22e88efb590e75921161d1de7fc gcr.io/k8s-jkns-e2e-gke-ubuntu-slow/local-volume-provisioner:v2.3.2-50-g2104bd18] 106722791} {[k8s.gcr.io/kube-proxy-amd64:v1.17.0-alpha.0.208_8f0d626228cf89] 99668215} {[k8s.gcr.io/fluentd-gcp-scaler@sha256:4f28f10fb89506768910b858f7a18ffb996824a16d70d5ac895e49687df9ff58 k8s.gcr.io/fluentd-gcp-scaler:0.5.2] 90498960} {[k8s.gcr.io/heapster-amd64@sha256:9fae0af136ce0cf4f88393b3670f7139ffc464692060c374d2ae748e13144521 k8s.gcr.io/heapster-amd64:v1.6.0-beta.1] 76016169} {[k8s.gcr.io/cluster-proportional-autoscaler-amd64@sha256:0abeb6a79ad5aec10e920110446a97fb75180da8680094acb6715de62507f4b0 k8s.gcr.io/cluster-proportional-autoscaler-amd64:1.6.0] 47668785} {[k8s.gcr.io/event-exporter@sha256:06acf489ab092b4fb49273e426549a52c0fcd1dbcb67e03d5935b5ee1a899c3e k8s.gcr.io/event-exporter:v0.2.5] 47261019} {[k8s.gcr.io/prometheus-to-sd@sha256:14666989f40bb7c896c3e775a93c6873e2b791d65bc65579f58a078b7f9a764e k8s.gcr.io/prometheus-to-sd:v0.5.0] 41861013} {[k8s.gcr.io/coredns@sha256:02382353821b12c21b062c59184e227e001079bb13ebd01f9d3270ba0fcbf1e4 k8s.gcr.io/coredns:1.3.1] 40303560} {[k8s.gcr.io/metrics-server-amd64@sha256:4ca116565ff6a46e582bada50ba3550f95b368db1d2415829241a565a6c38e2a k8s.gcr.io/metrics-server-amd64:v0.3.3] 39933796} {[k8s.gcr.io/addon-resizer@sha256:8075ed6db9baad249d9cf2656c0ecaad8d87133baf20286b1953dfb3fb06e75d k8s.gcr.io/addon-resizer:1.8.5] 35110823} {[k8s.gcr.io/ingress-gce-404-server-with-metrics-amd64@sha256:d83d8a481145d0eb71f8bd71ae236d1c6a931dd3bdcaf80919a8ec4a4d8aff74 k8s.gcr.io/ingress-gce-404-server-with-metrics-amd64:v1.6.0] 13513083} {[k8s.gcr.io/metadata-proxy@sha256:e914645f22e946bce5165737e1b244e0a296ad1f0f81a9531adc57af2780978a k8s.gcr.io/metadata-proxy:v0.1.12] 11337839} {[gcr.io/kubernetes-e2e-test-images/hostexec@sha256:90dfe59da029f9e536385037bc64e86cd3d6e55bae613ddbe69e554d79b0639d gcr.io/kubernetes-e2e-test-images/hostexec:1.1] 8490662} {[k8s.gcr.io/pause@sha256:f78411e19d84a252e53bff71a4407a5686c46983a2c2eeed83929b888179acea k8s.gcr.io/pause:3.1] 742472}],VolumesInUse:[],VolumesAttached:[],Config:&NodeConfigStatus{Assigned:nil,Active:nil,LastKnownGood:nil,Error:,},},}
Aug 16 20:33:12.103: INFO: 
Logging kubelet events for node e2e-test-prow-minion-group-b5kz
Aug 16 20:33:12.115: INFO: 
Logging pods the kubelet thinks is on node e2e-test-prow-minion-group-b5kz
Aug 16 20:33:12.126: INFO: heapster-v1.6.0-beta.1-5f4c9c5bf6-t8ljx started at 2019-08-16 20:24:21 +0000 UTC (0+2 container statuses recorded)
Aug 16 20:33:12.126: INFO: 	Container heapster ready: true, restart count 0
... skipping 918 lines ...
Aug 16 20:37:47.677: INFO: Running AfterSuite actions on all nodes
Aug 16 20:37:47.677: INFO: Running AfterSuite actions on node 1


Summarizing 1 Failure:

[Fail] [sig-storage] PersistentVolumes-local  Local volume provisioner [Serial] [It] should not create local persistent volume for filesystem volume that was not bind mounted 
/home/prow/go/src/sigs.k8s.io/sig-storage-local-static-provisioner/test/e2e/e2e_test.go:272

Ran 6 of 6 Specs in 568.142 seconds
FAIL! -- 5 Passed | 1 Failed | 0 Pending | 0 Skipped
--- FAIL: TestE2E (568.14s)
FAIL
FAIL	sigs.k8s.io/sig-storage-local-static-provisioner/test/e2e	568.421s
2019/08/16 20:37:48 process.go:155: Step 'bash /home/prow/go/src/sigs.k8s.io/sig-storage-local-static-provisioner/hack/run-e2e.sh' finished in 12m24.834505083s
2019/08/16 20:37:48 e2e.go:522: Dumping logs locally to: /logs/artifacts
2019/08/16 20:37:48 process.go:153: Running: ./cluster/log-dump/log-dump.sh /logs/artifacts
Checking for custom logdump instances, if any
Sourcing kube-util.sh
Detecting project
... skipping 9 lines ...

Specify --start=40930 in the next get-serial-port-output invocation to get only the new output starting from here.
scp: /var/log/cluster-autoscaler.log*: No such file or directory
scp: /var/log/fluentd.log*: No such file or directory
scp: /var/log/kubelet.cov*: No such file or directory
scp: /var/log/startupscript.log*: No such file or directory
ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
Dumping logs from nodes locally to '/logs/artifacts'
Detecting nodes in the cluster
Changing logfiles to be world-readable for download
Changing logfiles to be world-readable for download
Changing logfiles to be world-readable for download
Copying 'kube-proxy.log fluentd.log node-problem-detector.log kubelet.cov startupscript.log' from e2e-test-prow-minion-group-0bhs
... skipping 6 lines ...

Specify --start=63425 in the next get-serial-port-output invocation to get only the new output starting from here.
scp: /var/log/fluentd.log*: No such file or directory
scp: /var/log/node-problem-detector.log*: No such file or directory
scp: /var/log/kubelet.cov*: No such file or directory
scp: /var/log/startupscript.log*: No such file or directory
ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
scp: /var/log/fluentd.log*: No such file or directory
scp: /var/log/node-problem-detector.log*: No such file or directory
scp: /var/log/kubelet.cov*: No such file or directory
scp: /var/log/startupscript.log*: No such file or directory
ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
scp: /var/log/fluentd.log*: No such file or directory
scp: /var/log/node-problem-detector.log*: No such file or directory
scp: /var/log/kubelet.cov*: No such file or directory
scp: /var/log/startupscript.log*: No such file or directory
ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
INSTANCE_GROUPS=e2e-test-prow-minion-group
NODE_NAMES=e2e-test-prow-minion-group-0bhs e2e-test-prow-minion-group-0zsr e2e-test-prow-minion-group-b5kz
Failures for e2e-test-prow-minion-group
2019/08/16 20:38:57 process.go:155: Step './cluster/log-dump/log-dump.sh /logs/artifacts' finished in 1m9.507911838s
2019/08/16 20:38:57 process.go:153: Running: ./hack/e2e-internal/e2e-down.sh
Project: k8s-jkns-e2e-gke-ubuntu-slow
... skipping 16 lines ...
..............................................Deleted [https://www.googleapis.com/compute/v1/projects/k8s-jkns-e2e-gke-ubuntu-slow/zones/us-central1-b/instanceGroupManagers/e2e-test-prow-minion-group].
done.
Deleted [https://www.googleapis.com/compute/v1/projects/k8s-jkns-e2e-gke-ubuntu-slow/global/instanceTemplates/e2e-test-prow-minion-template].
Deleted [https://www.googleapis.com/compute/v1/projects/k8s-jkns-e2e-gke-ubuntu-slow/global/instanceTemplates/e2e-test-prow-windows-node-template].

Removing etcd replica, name: e2e-test-prow-master, port: 2379, result: 0
{"message":"Internal Server Error"}Removing etcd replica, name: e2e-test-prow-master, port: 4002, result: 0
Updated [https://www.googleapis.com/compute/v1/projects/k8s-jkns-e2e-gke-ubuntu-slow/zones/us-central1-b/instances/e2e-test-prow-master].
Deleted [https://www.googleapis.com/compute/v1/projects/k8s-jkns-e2e-gke-ubuntu-slow/zones/us-central1-b/instances/e2e-test-prow-master].
Deleted [https://www.googleapis.com/compute/v1/projects/k8s-jkns-e2e-gke-ubuntu-slow/global/firewalls/e2e-test-prow-master-https].
Deleted [https://www.googleapis.com/compute/v1/projects/k8s-jkns-e2e-gke-ubuntu-slow/global/firewalls/e2e-test-prow-master-etcd].
Deleted [https://www.googleapis.com/compute/v1/projects/k8s-jkns-e2e-gke-ubuntu-slow/global/firewalls/e2e-test-prow-minion-all].
{"component":"entrypoint","file":"prow/entrypoint/run.go:163","func":"k8s.io/test-infra/prow/entrypoint.Options.ExecuteProcess","level":"error","msg":"Entrypoint received interrupt: terminated","time":"2019-08-16T20:48:25Z"}