This job view page is being replaced by Spyglass soon. Check out the new job view.
ResultFAILURE
Tests 1 failed / 5 succeeded
Started2019-09-15 18:44
Elapsed26m39s
Revision
Buildergke-prow-ssd-pool-1a225945-m2ml
links{u'resultstore': {u'url': u'https://source.cloud.google.com/results/invocations/c895da10-c0b4-4a88-a34b-4f651ccc9f63/targets/test'}}
podc165096e-d7e8-11e9-9f18-22ab134e4c57
resultstorehttps://source.cloud.google.com/results/invocations/c895da10-c0b4-4a88-a34b-4f651ccc9f63/targets/test
infra-commite1cbc3ccd
job-versionv1.17.0-alpha.0.1440+ba07527278ef2c
podc165096e-d7e8-11e9-9f18-22ab134e4c57
revisionv1.17.0-alpha.0.1440+ba07527278ef2c

Test Failures


Up 20m34s

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 ...
I0915 18:44:12.693] process 44 exited with code 0 after 0.0m
I0915 18:44:12.693] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0915 18:44:12.693] Root: /workspace
I0915 18:44:12.694] cd to /workspace
I0915 18:44:12.694] Configure environment...
I0915 18:44:12.694] Call:  git show -s --format=format:%ct HEAD
W0915 18:44:12.699] fatal: Not a git repository (or any of the parent directories): .git
I0915 18:44:12.700] process 56 exited with code 128 after 0.0m
W0915 18:44:12.700] Unable to print commit date for HEAD
I0915 18:44:12.701] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0915 18:44:13.294] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0915 18:44:13.348] process 57 exited with code 0 after 0.0m
I0915 18:44:13.349] Call:  gcloud config get-value account
... skipping 701 lines ...
I0915 18:45:17.409]  * read about installing addons at: https://github.com/kubernetes/kops/blob/master/docs/addons.md.
I0915 18:45:17.410] 
W0915 18:45:17.510] 2019/09/15 18:45:17 process.go:155: Step '/workspace/kops update cluster e2e-kops-aws.test-cncf-aws.k8s.io --yes' finished in 23.794994755s
W0915 18:45:17.511] 2019/09/15 18:45:17 process.go:153: Running: kubectl get nodes -ojson
W0915 18:45:17.764] 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
W0915 18:45:17.768] 2019/09/15 18:45:17 process.go:155: Step 'kubectl get nodes -ojson' finished in 354.084648ms
W0915 18:45:17.768] 2019/09/15 18:45:17 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0915 18:45:17.769] 2019/09/15 18:45:17 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0915 18:45:47.768] 2019/09/15 18:45:47 process.go:153: Running: kubectl get nodes -ojson
W0915 18:45:47.933] 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
W0915 18:45:47.936] 2019/09/15 18:45:47 process.go:155: Step 'kubectl get nodes -ojson' finished in 168.423102ms
W0915 18:45:47.937] 2019/09/15 18:45:47 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0915 18:45:47.937] 2019/09/15 18:45:47 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0915 18:46:17.937] 2019/09/15 18:46:17 process.go:153: Running: kubectl get nodes -ojson
W0915 18:46:18.079] 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
W0915 18:46:18.082] 2019/09/15 18:46:18 process.go:155: Step 'kubectl get nodes -ojson' finished in 144.979308ms
W0915 18:46:18.082] 2019/09/15 18:46:18 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0915 18:46:18.082] 2019/09/15 18:46:18 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0915 18:46:48.083] 2019/09/15 18:46:48 process.go:153: Running: kubectl get nodes -ojson
W0915 18:46:48.226] 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
W0915 18:46:48.229] 2019/09/15 18:46:48 process.go:155: Step 'kubectl get nodes -ojson' finished in 147.331676ms
W0915 18:46:48.230] 2019/09/15 18:46:48 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0915 18:46:48.230] 2019/09/15 18:46:48 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0915 18:47:18.230] 2019/09/15 18:47:18 process.go:153: Running: kubectl get nodes -ojson
W0915 18:47:18.387] 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
W0915 18:47:18.388] 2019/09/15 18:47:18 process.go:155: Step 'kubectl get nodes -ojson' finished in 158.293039ms
W0915 18:47:18.388] 2019/09/15 18:47:18 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0915 18:47:18.389] 2019/09/15 18:47:18 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0915 18:47:48.388] 2019/09/15 18:47:48 process.go:153: Running: kubectl get nodes -ojson
W0915 18:48:18.527] 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
W0915 18:48:18.529] 2019/09/15 18:48:18 process.go:155: Step 'kubectl get nodes -ojson' finished in 30.141040953s
W0915 18:48:18.530] 2019/09/15 18:48:18 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0915 18:48:18.530] 2019/09/15 18:48:18 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0915 18:48:48.530] 2019/09/15 18:48:48 process.go:153: Running: kubectl get nodes -ojson
W0915 18:48:48.677] 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
W0915 18:48:48.680] 2019/09/15 18:48:48 process.go:155: Step 'kubectl get nodes -ojson' finished in 149.746315ms
W0915 18:48:48.681] 2019/09/15 18:48:48 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0915 18:48:48.681] 2019/09/15 18:48:48 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0915 18:49:18.681] 2019/09/15 18:49:18 process.go:153: Running: kubectl get nodes -ojson
W0915 18:49:18.840] 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
W0915 18:49:18.844] 2019/09/15 18:49:18 process.go:155: Step 'kubectl get nodes -ojson' finished in 163.063693ms
W0915 18:49:18.844] 2019/09/15 18:49:18 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0915 18:49:18.845] 2019/09/15 18:49:18 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0915 18:49:48.844] 2019/09/15 18:49:48 process.go:153: Running: kubectl get nodes -ojson
W0915 18:49:48.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
W0915 18:49:49.001] 2019/09/15 18:49:49 process.go:155: Step 'kubectl get nodes -ojson' finished in 156.862082ms
W0915 18:49:49.001] 2019/09/15 18:49:49 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0915 18:49:49.002] 2019/09/15 18:49:49 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0915 18:50:19.003] 2019/09/15 18:50:19 process.go:153: Running: kubectl get nodes -ojson
W0915 18:52:49.080] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0915 18:52:49.080] 2019/09/15 18:52:49 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.077398341s
W0915 18:52:49.080] 2019/09/15 18:52:49 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0915 18:52:49.080] 2019/09/15 18:52:49 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0915 18:53:19.080] 2019/09/15 18:53:19 process.go:153: Running: kubectl get nodes -ojson
W0915 18:55:49.157] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0915 18:55:49.160] 2019/09/15 18:55:49 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.079552063s
W0915 18:55:49.160] 2019/09/15 18:55:49 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0915 18:55:49.161] 2019/09/15 18:55:49 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0915 18:56:19.160] 2019/09/15 18:56:19 process.go:153: Running: kubectl get nodes -ojson
W0915 18:58:49.257] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0915 18:58:49.261] 2019/09/15 18:58:49 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.099849539s
W0915 18:58:49.262] 2019/09/15 18:58:49 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0915 18:58:49.262] 2019/09/15 18:58:49 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0915 18:59:19.260] 2019/09/15 18:59:19 process.go:153: Running: kubectl get nodes -ojson
W0915 19:01:49.340] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0915 19:01:49.343] 2019/09/15 19:01:49 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.083093575s
W0915 19:01:49.344] 2019/09/15 19:01:49 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0915 19:01:49.344] 2019/09/15 19:01:49 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0915 19:02:19.344] 2019/09/15 19:02:19 process.go:153: Running: kubectl get nodes -ojson
W0915 19:04:49.429] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0915 19:04:49.430] 2019/09/15 19:04:49 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.085551315s
W0915 19:04:49.430] 2019/09/15 19:04:49 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0915 19:04:49.430] 2019/09/15 19:04:49 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0915 19:05:19.430] 2019/09/15 19:05:19 process.go:153: Running: /workspace/kops toolbox dump --name e2e-kops-aws.test-cncf-aws.k8s.io -ojson
W0915 19:05:29.074] 2019/09/15 19:05:29 process.go:155: Step '/workspace/kops toolbox dump --name e2e-kops-aws.test-cncf-aws.k8s.io -ojson' finished in 9.644139483s
W0915 19:05:29.077] 2019/09/15 19:05:29 process.go:153: Running: kubectl get nodes -ojson
W0915 19:07:59.159] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0915 19:07:59.160] 2019/09/15 19:07:59 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.082577602s
W0915 19:07:59.160] 2019/09/15 19:07:59 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0915 19:07:59.160] 2019/09/15 19:07:59 dump.go:89: Failed to get nodes for dumping via kubectl: error during kubectl get nodes -ojson: exit status 1
W0915 19:07:59.160] 2019/09/15 19:07:59 dump.go:123: dumping node not registered in kubernetes: 13.229.235.73
W0915 19:07:59.161] 2019/09/15 19:07:59 dump.go:157: Dumping node 13.229.235.73
W0915 19:08:01.131] 2019/09/15 19:08:01 dump.go:358: Running SSH command: sudo journalctl --output=short-precise -k
W0915 19:08:01.909] 2019/09/15 19:08:01 dump.go:358: Running SSH command: sudo journalctl --output=short-precise
W0915 19:08:06.805] 2019/09/15 19:08:06 dump.go:358: Running SSH command: sudo systemctl list-units -t service --no-pager --no-legend --all
W0915 19:08:07.199] 2019/09/15 19:08:07 dump.go:358: Running SSH command: sudo journalctl --output=cat -u kubelet.service
... skipping 200 lines ...
W0915 19:10:40.244]     check_env(env, self.command, *args)
W0915 19:10:40.244]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env
W0915 19:10:40.244]     subprocess.check_call(cmd, env=env)
W0915 19:10:40.244]   File "/usr/lib/python2.7/subprocess.py", line 186, in check_call
W0915 19:10:40.244]     raise CalledProcessError(retcode, cmd)
W0915 19:10:40.245] 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=ap-southeast-1a', '--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
E0915 19:10:40.245] Command failed
I0915 19:10:40.245] process 259 exited with code 1 after 26.4m
E0915 19:10:40.246] FAIL: ci-kubernetes-e2e-kops-aws
I0915 19:10:40.246] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0915 19:10:40.769] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0915 19:10:40.823] process 655 exited with code 0 after 0.0m
I0915 19:10:40.823] Call:  gcloud config get-value account
I0915 19:10:41.153] process 667 exited with code 0 after 0.0m
I0915 19:10:41.154] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0915 19:10:41.154] Upload result and artifacts...
I0915 19:10:41.154] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1173306485887733760
I0915 19:10:41.155] Call:  gsutil ls gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1173306485887733760/artifacts
W0915 19:10:42.230] CommandException: One or more URLs matched no objects.
E0915 19:10:42.365] Command failed
I0915 19:10:42.365] process 679 exited with code 1 after 0.0m
W0915 19:10:42.365] Remote dir gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1173306485887733760/artifacts not exist yet
I0915 19:10:42.366] 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/1173306485887733760/artifacts
I0915 19:10:46.308] process 821 exited with code 0 after 0.1m
I0915 19:10:46.309] Call:  git rev-parse HEAD
W0915 19:10:46.314] fatal: Not a git repository (or any of the parent directories): .git
E0915 19:10:46.315] Command failed
I0915 19:10:46.315] process 1460 exited with code 128 after 0.0m
I0915 19:10:46.315] Call:  git rev-parse HEAD
I0915 19:10:46.320] process 1461 exited with code 0 after 0.0m
I0915 19:10:46.321] Call:  gsutil stat gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json
I0915 19:10:47.477] process 1462 exited with code 0 after 0.0m
I0915 19:10:47.478] Call:  gsutil -q cat 'gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json#1568572818372195'
... skipping 8 lines ...