This job view page is being replaced by Spyglass soon. Check out the new job view.
ResultFAILURE
Tests 1 failed / 5 succeeded
Started2019-07-12 06:02
Elapsed25m26s
Revision
Buildergke-prow-ssd-pool-1a225945-8wl3
links{u'resultstore': {u'url': u'https://source.cloud.google.com/results/invocations/87e0bb53-f041-4e42-a687-8729e99aec91/targets/test'}}
pod990a2c7e-a46a-11e9-8217-96c43017ab5b
resultstorehttps://source.cloud.google.com/results/invocations/87e0bb53-f041-4e42-a687-8729e99aec91/targets/test
infra-commit04c2406cc
job-versionv1.16.0-alpha.0.2185+de091d102f7d17
pod990a2c7e-a46a-11e9-8217-96c43017ab5b
revisionv1.16.0-alpha.0.2185+de091d102f7d17

Test Failures


Up 20m29s

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 ...
I0712 06:02:57.979] process 50 exited with code 0 after 0.0m
I0712 06:02:57.980] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0712 06:02:57.980] Root: /workspace
I0712 06:02:57.980] cd to /workspace
I0712 06:02:57.980] Configure environment...
I0712 06:02:57.980] Call:  git show -s --format=format:%ct HEAD
W0712 06:02:57.984] fatal: Not a git repository (or any of the parent directories): .git
I0712 06:02:57.985] process 62 exited with code 128 after 0.0m
W0712 06:02:57.985] Unable to print commit date for HEAD
I0712 06:02:57.986] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0712 06:02:58.505] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0712 06:02:58.561] process 63 exited with code 0 after 0.0m
I0712 06:02:58.562] Call:  gcloud config get-value account
... skipping 696 lines ...
I0712 06:03:59.753]  * read about installing addons at: https://github.com/kubernetes/kops/blob/master/docs/addons.md.
I0712 06:03:59.753] 
W0712 06:03:59.854] 2019/07/12 06:03:59 process.go:155: Step '/workspace/kops update cluster e2e-kops-aws.test-cncf-aws.k8s.io --yes' finished in 21.224092246s
W0712 06:03:59.855] 2019/07/12 06:03:59 process.go:153: Running: kubectl get nodes -ojson
W0712 06:03:59.993] 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
W0712 06:03:59.998] 2019/07/12 06:03:59 process.go:155: Step 'kubectl get nodes -ojson' finished in 236.37581ms
W0712 06:03:59.998] 2019/07/12 06:03:59 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0712 06:03:59.999] 2019/07/12 06:03:59 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0712 06:04:29.999] 2019/07/12 06:04:29 process.go:153: Running: kubectl get nodes -ojson
W0712 06:05:00.154] 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
W0712 06:05:00.156] 2019/07/12 06:05:00 process.go:155: Step 'kubectl get nodes -ojson' finished in 30.157825269s
W0712 06:05:00.157] 2019/07/12 06:05:00 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0712 06:05:00.157] 2019/07/12 06:05:00 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0712 06:05:30.159] 2019/07/12 06:05:30 process.go:153: Running: kubectl get nodes -ojson
W0712 06:06:30.329] 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
W0712 06:06:30.332] 2019/07/12 06:06:30 process.go:155: Step 'kubectl get nodes -ojson' finished in 1m0.17507469s
W0712 06:06:30.332] 2019/07/12 06:06:30 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0712 06:06:30.332] 2019/07/12 06:06:30 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0712 06:07:00.333] 2019/07/12 06:07:00 process.go:153: Running: kubectl get nodes -ojson
W0712 06:07:00.503] 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
W0712 06:07:00.505] 2019/07/12 06:07:00 process.go:155: Step 'kubectl get nodes -ojson' finished in 172.940662ms
W0712 06:07:00.505] 2019/07/12 06:07:00 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0712 06:07:00.506] 2019/07/12 06:07:00 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0712 06:07:30.506] 2019/07/12 06:07:30 process.go:153: Running: kubectl get nodes -ojson
W0712 06:08:30.652] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0712 06:08:30.655] 2019/07/12 06:08:30 process.go:155: Step 'kubectl get nodes -ojson' finished in 1m0.149204355s
W0712 06:08:30.656] 2019/07/12 06:08:30 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0712 06:08:30.656] 2019/07/12 06:08:30 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0712 06:09:00.658] 2019/07/12 06:09:00 process.go:153: Running: kubectl get nodes -ojson
W0712 06:11:30.751] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0712 06:11:30.753] 2019/07/12 06:11:30 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.095336593s
W0712 06:11:30.753] 2019/07/12 06:11:30 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0712 06:11:30.754] 2019/07/12 06:11:30 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0712 06:12:00.757] 2019/07/12 06:12:00 process.go:153: Running: kubectl get nodes -ojson
W0712 06:14:30.847] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0712 06:14:30.848] 2019/07/12 06:14:30 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.090428791s
W0712 06:14:30.848] 2019/07/12 06:14:30 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0712 06:14:30.848] 2019/07/12 06:14:30 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0712 06:15:00.848] 2019/07/12 06:15:00 process.go:153: Running: kubectl get nodes -ojson
W0712 06:17:30.940] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0712 06:17:30.945] 2019/07/12 06:17:30 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.096301797s
W0712 06:17:30.945] 2019/07/12 06:17:30 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0712 06:17:30.946] 2019/07/12 06:17:30 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0712 06:18:00.946] 2019/07/12 06:18:00 process.go:153: Running: kubectl get nodes -ojson
W0712 06:20:31.185] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0712 06:20:31.188] 2019/07/12 06:20:31 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.242198326s
W0712 06:20:31.188] 2019/07/12 06:20:31 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0712 06:20:31.188] 2019/07/12 06:20:31 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0712 06:21:01.188] 2019/07/12 06:21:01 process.go:153: Running: kubectl get nodes -ojson
W0712 06:23:31.274] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0712 06:23:31.277] 2019/07/12 06:23:31 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.088499574s
W0712 06:23:31.277] 2019/07/12 06:23:31 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0712 06:23:31.277] 2019/07/12 06:23:31 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0712 06:24:01.281] 2019/07/12 06:24:01 process.go:153: Running: /workspace/kops toolbox dump --name e2e-kops-aws.test-cncf-aws.k8s.io -ojson
W0712 06:24:09.375] 2019/07/12 06:24:09 process.go:155: Step '/workspace/kops toolbox dump --name e2e-kops-aws.test-cncf-aws.k8s.io -ojson' finished in 8.094420558s
W0712 06:24:09.380] 2019/07/12 06:24:09 process.go:153: Running: kubectl get nodes -ojson
W0712 06:26:39.472] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0712 06:26:39.478] 2019/07/12 06:26:39 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.098085701s
W0712 06:26:39.479] 2019/07/12 06:26:39 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0712 06:26:39.479] 2019/07/12 06:26:39 dump.go:89: Failed to get nodes for dumping via kubectl: error during kubectl get nodes -ojson: exit status 1
W0712 06:26:39.479] 2019/07/12 06:26:39 dump.go:123: dumping node not registered in kubernetes: 3.113.18.155
W0712 06:26:39.480] 2019/07/12 06:26:39 dump.go:157: Dumping node 3.113.18.155
W0712 06:26:40.822] 2019/07/12 06:26:40 dump.go:358: Running SSH command: sudo journalctl --output=short-precise -k
W0712 06:26:41.590] 2019/07/12 06:26:41 dump.go:358: Running SSH command: sudo journalctl --output=short-precise
W0712 06:26:45.241] 2019/07/12 06:26:45 dump.go:358: Running SSH command: sudo systemctl list-units -t service --no-pager --no-legend --all
W0712 06:26:45.506] 2019/07/12 06:26:45 dump.go:358: Running SSH command: sudo journalctl --output=cat -u kubelet.service
... skipping 158 lines ...
W0712 06:28:13.471]     check_env(env, self.command, *args)
W0712 06:28:13.471]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env
W0712 06:28:13.471]     subprocess.check_call(cmd, env=env)
W0712 06:28:13.471]   File "/usr/lib/python2.7/subprocess.py", line 186, in check_call
W0712 06:28:13.472]     raise CalledProcessError(retcode, cmd)
W0712 06:28:13.472] 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-northeast-1d', '--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
E0712 06:28:13.472] Command failed
I0712 06:28:13.472] process 265 exited with code 1 after 25.2m
E0712 06:28:13.473] FAIL: ci-kubernetes-e2e-kops-aws
I0712 06:28:13.473] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0712 06:28:13.986] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0712 06:28:14.051] process 636 exited with code 0 after 0.0m
I0712 06:28:14.052] Call:  gcloud config get-value account
I0712 06:28:14.392] process 648 exited with code 0 after 0.0m
I0712 06:28:14.393] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0712 06:28:14.393] Upload result and artifacts...
I0712 06:28:14.393] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1149559702598717441
I0712 06:28:14.393] Call:  gsutil ls gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1149559702598717441/artifacts
W0712 06:28:15.495] CommandException: One or more URLs matched no objects.
E0712 06:28:15.650] Command failed
I0712 06:28:15.650] process 660 exited with code 1 after 0.0m
W0712 06:28:15.651] Remote dir gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1149559702598717441/artifacts not exist yet
I0712 06:28:15.651] 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/1149559702598717441/artifacts
I0712 06:28:19.749] process 802 exited with code 0 after 0.1m
I0712 06:28:19.750] Call:  git rev-parse HEAD
W0712 06:28:19.754] fatal: Not a git repository (or any of the parent directories): .git
E0712 06:28:19.755] Command failed
I0712 06:28:19.755] process 1441 exited with code 128 after 0.0m
I0712 06:28:19.756] Call:  git rev-parse HEAD
I0712 06:28:19.760] process 1442 exited with code 0 after 0.0m
I0712 06:28:19.761] Call:  gsutil stat gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json
I0712 06:28:20.870] process 1443 exited with code 0 after 0.0m
I0712 06:28:20.872] Call:  gsutil -q cat 'gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json#1562911062597252'
... skipping 8 lines ...