This job view page is being replaced by Spyglass soon. Check out the new job view.
ResultFAILURE
Tests 1 failed / 5 succeeded
Started2019-09-11 07:40
Elapsed25m38s
Revision
Buildergke-prow-ssd-pool-1a225945-qczk
links{u'resultstore': {u'url': u'https://source.cloud.google.com/results/invocations/4979ff7c-474f-4bef-ae93-4a638fe4f3c6/targets/test'}}
pod4ce68ffc-d467-11e9-9d26-329cee23a2e0
resultstorehttps://source.cloud.google.com/results/invocations/4979ff7c-474f-4bef-ae93-4a638fe4f3c6/targets/test
infra-commit0708557a1
job-versionv1.17.0-alpha.0.1226+5823cfce76780e
pod4ce68ffc-d467-11e9-9d26-329cee23a2e0
revisionv1.17.0-alpha.0.1226+5823cfce76780e

Test Failures


Up 20m31s

waiting for ready nodes timed out
				from junit_runner.xml

Filter through log files | View test history on testgrid


Show 5 Passed Tests

Error lines from build-log.txt

... skipping 12 lines ...
I0911 07:40:20.777] process 45 exited with code 0 after 0.0m
I0911 07:40:20.778] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0911 07:40:20.778] Root: /workspace
I0911 07:40:20.779] cd to /workspace
I0911 07:40:20.779] Configure environment...
I0911 07:40:20.779] Call:  git show -s --format=format:%ct HEAD
W0911 07:40:20.784] fatal: Not a git repository (or any of the parent directories): .git
I0911 07:40:20.785] process 57 exited with code 128 after 0.0m
W0911 07:40:20.785] Unable to print commit date for HEAD
I0911 07:40:20.786] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0911 07:40:21.360] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0911 07:40:21.425] process 58 exited with code 0 after 0.0m
I0911 07:40:21.426] Call:  gcloud config get-value account
... skipping 701 lines ...
I0911 07:41:22.508]  * read about installing addons at: https://github.com/kubernetes/kops/blob/master/docs/addons.md.
I0911 07:41:22.509] 
W0911 07:41:22.609] 2019/09/11 07:41:22 process.go:155: Step '/workspace/kops update cluster e2e-kops-aws.test-cncf-aws.k8s.io --yes' finished in 21.933044527s
W0911 07:41:22.611] 2019/09/11 07:41:22 process.go:153: Running: kubectl get nodes -ojson
W0911 07:41:23.074] Unable to connect to the server: dial tcp: lookup api.e2e-kops-aws.test-cncf-aws.k8s.io on 10.63.240.10:53: no such host
W0911 07:41:23.085] 2019/09/11 07:41:23 process.go:155: Step 'kubectl get nodes -ojson' finished in 550.010435ms
W0911 07:41:23.086] 2019/09/11 07:41:23 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 07:41:23.086] 2019/09/11 07:41:23 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 07:41:53.086] 2019/09/11 07:41:53 process.go:153: Running: kubectl get nodes -ojson
W0911 07:43:23.340] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 07:43:23.344] 2019/09/11 07:43:23 process.go:155: Step 'kubectl get nodes -ojson' finished in 1m30.258258489s
W0911 07:43:23.344] 2019/09/11 07:43:23 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 07:43:23.345] 2019/09/11 07:43:23 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 07:43:53.345] 2019/09/11 07:43:53 process.go:153: Running: kubectl get nodes -ojson
W0911 07:43:53.523] Unable to connect to the server: dial tcp: lookup api.e2e-kops-aws.test-cncf-aws.k8s.io on 10.63.240.10:53: no such host
W0911 07:43:53.527] 2019/09/11 07:43:53 process.go:155: Step 'kubectl get nodes -ojson' finished in 182.767822ms
W0911 07:43:53.528] 2019/09/11 07:43:53 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 07:43:53.529] 2019/09/11 07:43:53 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 07:44:23.530] 2019/09/11 07:44:23 process.go:153: Running: kubectl get nodes -ojson
W0911 07:44:23.731] Unable to connect to the server: dial tcp: lookup api.e2e-kops-aws.test-cncf-aws.k8s.io on 10.63.240.10:53: no such host
W0911 07:44:23.738] 2019/09/11 07:44:23 process.go:155: Step 'kubectl get nodes -ojson' finished in 208.027207ms
W0911 07:44:23.738] 2019/09/11 07:44:23 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 07:44:23.738] 2019/09/11 07:44:23 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 07:44:53.738] 2019/09/11 07:44:53 process.go:153: Running: kubectl get nodes -ojson
W0911 07:44:53.998] Unable to connect to the server: dial tcp: lookup api.e2e-kops-aws.test-cncf-aws.k8s.io on 10.63.240.10:53: no such host
W0911 07:44:53.999] 2019/09/11 07:44:53 process.go:155: Step 'kubectl get nodes -ojson' finished in 260.351941ms
W0911 07:44:53.999] 2019/09/11 07:44:53 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 07:44:53.999] 2019/09/11 07:44:53 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 07:45:24.000] 2019/09/11 07:45:23 process.go:153: Running: kubectl get nodes -ojson
W0911 07:45:54.410] Unable to connect to the server: dial tcp: lookup api.e2e-kops-aws.test-cncf-aws.k8s.io on 10.63.240.10:53: no such host
W0911 07:45:54.417] 2019/09/11 07:45:54 process.go:155: Step 'kubectl get nodes -ojson' finished in 30.41774989s
W0911 07:45:54.418] 2019/09/11 07:45:54 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 07:45:54.420] 2019/09/11 07:45:54 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 07:46:24.419] 2019/09/11 07:46:24 process.go:153: Running: kubectl get nodes -ojson
W0911 07:48:54.586] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 07:48:54.595] 2019/09/11 07:48:54 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.175967829s
W0911 07:48:54.595] 2019/09/11 07:48:54 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 07:48:54.596] 2019/09/11 07:48:54 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 07:49:24.596] 2019/09/11 07:49:24 process.go:153: Running: kubectl get nodes -ojson
W0911 07:51:55.010] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 07:51:55.023] 2019/09/11 07:51:55 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.427523419s
W0911 07:51:55.024] 2019/09/11 07:51:55 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 07:51:55.025] 2019/09/11 07:51:55 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 07:52:25.024] 2019/09/11 07:52:25 process.go:153: Running: kubectl get nodes -ojson
W0911 07:54:55.185] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 07:54:55.189] 2019/09/11 07:54:55 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.165737253s
W0911 07:54:55.190] 2019/09/11 07:54:55 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 07:54:55.190] 2019/09/11 07:54:55 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 07:55:25.191] 2019/09/11 07:55:25 process.go:153: Running: kubectl get nodes -ojson
W0911 07:57:55.455] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 07:57:55.466] 2019/09/11 07:57:55 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.274986056s
W0911 07:57:55.467] 2019/09/11 07:57:55 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 07:57:55.468] 2019/09/11 07:57:55 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 07:58:25.468] 2019/09/11 07:58:25 process.go:153: Running: kubectl get nodes -ojson
W0911 08:00:56.063] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 08:00:56.069] 2019/09/11 08:00:56 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.601392776s
W0911 08:00:56.070] 2019/09/11 08:00:56 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 08:00:56.071] 2019/09/11 08:00:56 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 08:01:26.073] 2019/09/11 08:01:26 process.go:153: Running: /workspace/kops toolbox dump --name e2e-kops-aws.test-cncf-aws.k8s.io -ojson
W0911 08:01:33.407] 2019/09/11 08:01:33 process.go:155: Step '/workspace/kops toolbox dump --name e2e-kops-aws.test-cncf-aws.k8s.io -ojson' finished in 7.334730396s
W0911 08:01:33.412] 2019/09/11 08:01:33 process.go:153: Running: kubectl get nodes -ojson
W0911 08:04:03.605] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 08:04:03.619] 2019/09/11 08:04:03 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.195436319s
W0911 08:04:03.619] 2019/09/11 08:04:03 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 08:04:03.620] 2019/09/11 08:04:03 dump.go:89: Failed to get nodes for dumping via kubectl: error during kubectl get nodes -ojson: exit status 1
W0911 08:04:03.620] 2019/09/11 08:04:03 dump.go:123: dumping node not registered in kubernetes: 35.158.108.52
W0911 08:04:03.620] 2019/09/11 08:04:03 dump.go:157: Dumping node 35.158.108.52
W0911 08:04:04.748] 2019/09/11 08:04:04 dump.go:358: Running SSH command: sudo journalctl --output=short-precise -k
W0911 08:04:05.226] 2019/09/11 08:04:05 dump.go:358: Running SSH command: sudo journalctl --output=short-precise
W0911 08:04:08.636] 2019/09/11 08:04:08 dump.go:358: Running SSH command: sudo systemctl list-units -t service --no-pager --no-legend --all
W0911 08:04:08.864] 2019/09/11 08:04:08 dump.go:358: Running SSH command: sudo journalctl --output=cat -u kubelet.service
... skipping 168 lines ...
W0911 08:05:45.006]     check_env(env, self.command, *args)
W0911 08:05:45.006]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env
W0911 08:05:45.006]     subprocess.check_call(cmd, env=env)
W0911 08:05:45.006]   File "/usr/lib/python2.7/subprocess.py", line 186, in check_call
W0911 08:05:45.006]     raise CalledProcessError(retcode, cmd)
W0911 08:05:45.007] subprocess.CalledProcessError: Command '('/workspace/kops-e2e-runner.sh', '--dump=/workspace/_artifacts', '--gcp-service-account=/etc/service-account/service-account.json', '--up', '--down', '--test', '--provider=aws', '--cluster=e2e-kops-aws.test-cncf-aws.k8s.io', '--gcp-network=e2e-kops-aws.test-cncf-aws.k8s.io', '--extract=ci/latest', '--ginkgo-parallel', '--test_args=--ginkgo.flakeAttempts=2 --ginkgo.skip=\\[Slow\\]|\\[Serial\\]|\\[Disruptive\\]|\\[Flaky\\]|\\[Feature:.+\\]|\\[HPA\\]|Dashboard|Services.*functioning.*NodePort', '--timeout=120m', '--kops-cluster=e2e-kops-aws.test-cncf-aws.k8s.io', '--kops-zones=eu-central-1c', '--kops-state=s3://k8s-kops-prow/', '--kops-nodes=4', '--kops-ssh-key=/workspace/.ssh/kube_aws_rsa', '--kops-ssh-user=admin')' returned non-zero exit status 1
E0911 08:05:45.007] Command failed
I0911 08:05:45.008] process 260 exited with code 1 after 25.4m
E0911 08:05:45.008] FAIL: ci-kubernetes-e2e-kops-aws
I0911 08:05:45.008] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0911 08:05:45.657] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0911 08:05:45.720] process 631 exited with code 0 after 0.0m
I0911 08:05:45.720] Call:  gcloud config get-value account
I0911 08:05:46.078] process 643 exited with code 0 after 0.0m
I0911 08:05:46.078] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0911 08:05:46.078] Upload result and artifacts...
I0911 08:05:46.079] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1171689862789599233
I0911 08:05:46.079] Call:  gsutil ls gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1171689862789599233/artifacts
W0911 08:05:47.286] CommandException: One or more URLs matched no objects.
E0911 08:05:47.466] Command failed
I0911 08:05:47.466] process 655 exited with code 1 after 0.0m
W0911 08:05:47.466] Remote dir gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1171689862789599233/artifacts not exist yet
I0911 08:05:47.466] Call:  gsutil -m -q -o GSUtil:use_magicfile=True cp -r -c -z log,txt,xml /workspace/_artifacts gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1171689862789599233/artifacts
I0911 08:05:53.141] process 797 exited with code 0 after 0.1m
I0911 08:05:53.142] Call:  git rev-parse HEAD
W0911 08:05:53.174] fatal: Not a git repository (or any of the parent directories): .git
E0911 08:05:53.175] Command failed
I0911 08:05:53.175] process 1436 exited with code 128 after 0.0m
I0911 08:05:53.175] Call:  git rev-parse HEAD
I0911 08:05:53.187] process 1437 exited with code 0 after 0.0m
I0911 08:05:53.190] Call:  gsutil stat gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json
I0911 08:05:54.560] process 1438 exited with code 0 after 0.0m
I0911 08:05:54.561] Call:  gsutil -q cat 'gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json#1568187311026885'
... skipping 8 lines ...