This job view page is being replaced by Spyglass soon. Check out the new job view.
ResultFAILURE
Tests 1 failed / 6 succeeded
Started2019-07-18 23:00
Elapsed26m46s
Revision
Buildergke-prow-ssd-pool-1a225945-v0k1
links{u'resultstore': {u'url': u'https://source.cloud.google.com/results/invocations/5c310316-7133-4684-bb9a-453da8aa3701/targets/test'}}
podaa389ddc-a9af-11e9-a872-ea55029f82d3
resultstorehttps://source.cloud.google.com/results/invocations/5c310316-7133-4684-bb9a-453da8aa3701/targets/test
infra-commita83154b41
job-versionv1.16.0-alpha.1.65+477304cdbdafed
podaa389ddc-a9af-11e9-a872-ea55029f82d3
repogithub.com/containerd/cri
repo-commitb5e9d132614e2c68ced73553bf8956196fda419b
repos{u'github.com/containerd/cri': u'master'}
revisionv1.16.0-alpha.1.65+477304cdbdafed

Test Failures


Up 9m41s

error during ./hack/e2e-internal/e2e-up.sh: exit status 2
				from junit_runner.xml

Filter through log files | View test history on testgrid


Show 6 Passed Tests

Error lines from build-log.txt

... skipping 371 lines ...
W0718 23:06:07.632] NODE_NAMES=e2e-4ba5595f17-d39c0-minion-group-fr0n e2e-4ba5595f17-d39c0-minion-group-jdq8 e2e-4ba5595f17-d39c0-minion-group-pf9d e2e-4ba5595f17-d39c0-minion-group-qgmq
W0718 23:06:07.633] Trying to find master named 'e2e-4ba5595f17-d39c0-master'
W0718 23:06:07.633] Looking for address 'e2e-4ba5595f17-d39c0-master-ip'
I0718 23:06:08.705] Waiting up to 300 seconds for cluster initialization.
I0718 23:06:08.705] 
I0718 23:06:08.705]   This will continually check to see if the API for kubernetes is reachable.
I0718 23:06:08.705]   This may time out if there was some uncaught error during start up.
I0718 23:06:08.706] 
I0718 23:11:09.033] ..................................................................................................................................................Checking for custom logdump instances, if any
I0718 23:11:09.040] Sourcing kube-util.sh
W0718 23:11:09.141] Using master: e2e-4ba5595f17-d39c0-master (external IP: 34.83.124.220)
W0718 23:11:09.141] Cluster failed to initialize within 300 seconds.
W0718 23:11:09.142] Last output from querying API server follows:
W0718 23:11:09.142] -----------------------------------------------------
W0718 23:11:09.142]   % Total    % Received % Xferd  Average Speed   Time    Time     Time  Current
W0718 23:11:09.142]                                  Dload  Upload   Total   Spent    Left  Speed
W0718 23:11:09.143] 
  0     0    0     0    0     0      0      0 --:--:-- --:--:-- --:--:--     0curl: (7) Failed to connect to 34.83.124.220 port 443: Connection refused
W0718 23:11:09.143] -----------------------------------------------------
W0718 23:11:09.143] 2019/07/18 23:11:09 process.go:155: Step './hack/e2e-internal/e2e-up.sh' finished in 9m41.843818063s
W0718 23:11:09.144] 2019/07/18 23:11:09 e2e.go:522: Dumping logs locally to: /workspace/_artifacts
W0718 23:11:09.144] 2019/07/18 23:11:09 process.go:153: Running: ./cluster/log-dump/log-dump.sh /workspace/_artifacts
W0718 23:11:09.186] Trying to find master named 'e2e-4ba5595f17-d39c0-master'
W0718 23:11:09.186] Looking for address 'e2e-4ba5595f17-d39c0-master-ip'
... skipping 10 lines ...
W0718 23:11:53.402] scp: /var/log/glbc.log*: No such file or directory
W0718 23:11:53.403] scp: /var/log/cluster-autoscaler.log*: No such file or directory
W0718 23:11:53.403] scp: /var/log/kube-addon-manager.log*: No such file or directory
W0718 23:11:53.403] scp: /var/log/fluentd.log*: No such file or directory
W0718 23:11:53.404] scp: /var/log/kubelet.cov*: No such file or directory
W0718 23:11:53.404] scp: /var/log/startupscript.log*: No such file or directory
W0718 23:11:53.410] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
I0718 23:11:53.537] Dumping logs from nodes locally to '/workspace/_artifacts'
I0718 23:11:53.537] Detecting nodes in the cluster
I0718 23:12:36.183] Changing logfiles to be world-readable for download
I0718 23:12:36.222] Changing logfiles to be world-readable for download
I0718 23:12:36.309] Changing logfiles to be world-readable for download
I0718 23:12:36.681] Changing logfiles to be world-readable for download
... skipping 10 lines ...
W0718 23:12:41.303] 
W0718 23:12:41.303] Specify --start=41802 in the next get-serial-port-output invocation to get only the new output starting from here.
W0718 23:12:42.580] scp: /var/log/fluentd.log*: No such file or directory
W0718 23:12:42.581] scp: /var/log/node-problem-detector.log*: No such file or directory
W0718 23:12:42.582] scp: /var/log/kubelet.cov*: No such file or directory
W0718 23:12:42.582] scp: /var/log/startupscript.log*: No such file or directory
W0718 23:12:42.587] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W0718 23:12:42.590] scp: /var/log/fluentd.log*: No such file or directory
W0718 23:12:42.591] scp: /var/log/node-problem-detector.log*: No such file or directory
W0718 23:12:42.591] scp: /var/log/kubelet.cov*: No such file or directory
W0718 23:12:42.591] scp: /var/log/startupscript.log*: No such file or directory
W0718 23:12:42.596] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W0718 23:12:42.829] scp: /var/log/fluentd.log*: No such file or directory
W0718 23:12:42.830] scp: /var/log/node-problem-detector.log*: No such file or directory
W0718 23:12:42.830] scp: /var/log/kubelet.cov*: No such file or directory
W0718 23:12:42.830] scp: /var/log/startupscript.log*: No such file or directory
W0718 23:12:42.834] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W0718 23:12:43.102] scp: /var/log/fluentd.log*: No such file or directory
W0718 23:12:43.103] scp: /var/log/node-problem-detector.log*: No such file or directory
W0718 23:12:43.103] scp: /var/log/kubelet.cov*: No such file or directory
W0718 23:12:43.103] scp: /var/log/startupscript.log*: No such file or directory
W0718 23:12:43.109] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W0718 23:12:46.902] INSTANCE_GROUPS=e2e-4ba5595f17-d39c0-minion-group
W0718 23:12:46.902] NODE_NAMES=e2e-4ba5595f17-d39c0-minion-group-fr0n e2e-4ba5595f17-d39c0-minion-group-jdq8 e2e-4ba5595f17-d39c0-minion-group-pf9d e2e-4ba5595f17-d39c0-minion-group-qgmq
I0718 23:12:47.977] Failures for e2e-4ba5595f17-d39c0-minion-group
W0718 23:12:48.937] 2019/07/18 23:12:48 process.go:155: Step './cluster/log-dump/log-dump.sh /workspace/_artifacts' finished in 1m39.907354918s
W0718 23:12:48.938] 2019/07/18 23:12:48 process.go:153: Running: ./hack/e2e-internal/e2e-down.sh
W0718 23:12:49.001] Project: k8s-jkns-e2e-gce-gci-slow
... skipping 12 lines ...
W0718 23:12:54.773] NODE_NAMES=e2e-4ba5595f17-d39c0-minion-group-fr0n e2e-4ba5595f17-d39c0-minion-group-jdq8 e2e-4ba5595f17-d39c0-minion-group-pf9d e2e-4ba5595f17-d39c0-minion-group-qgmq
W0718 23:12:57.430] Deleting Managed Instance Group...
W0718 23:15:55.653] .....................................Deleted [https://www.googleapis.com/compute/v1/projects/k8s-jkns-e2e-gce-gci-slow/zones/us-west1-b/instanceGroupManagers/e2e-4ba5595f17-d39c0-minion-group].
W0718 23:15:55.654] done.
W0718 23:16:05.459] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-jkns-e2e-gce-gci-slow/global/instanceTemplates/e2e-4ba5595f17-d39c0-minion-template].
W0718 23:16:16.474] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-jkns-e2e-gce-gci-slow/global/instanceTemplates/e2e-4ba5595f17-d39c0-windows-node-template].
I0718 23:16:21.755] {"message":"Internal Server Error"}Removing etcd replica, name: e2e-4ba5595f17-d39c0-master, port: 2379, result: 0
I0718 23:16:23.446] {"message":"Internal Server Error"}Removing etcd replica, name: e2e-4ba5595f17-d39c0-master, port: 4002, result: 0
W0718 23:16:30.786] Updated [https://www.googleapis.com/compute/v1/projects/k8s-jkns-e2e-gce-gci-slow/zones/us-west1-b/instances/e2e-4ba5595f17-d39c0-master].
W0718 23:19:24.952] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-jkns-e2e-gce-gci-slow/zones/us-west1-b/instances/e2e-4ba5595f17-d39c0-master].
W0718 23:19:49.180] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-jkns-e2e-gce-gci-slow/global/firewalls/e2e-4ba5595f17-d39c0-master-https].
W0718 23:23:20.694] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-jkns-e2e-gce-gci-slow/global/firewalls/e2e-4ba5595f17-d39c0-minion-all].
W0718 23:23:25.761] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-jkns-e2e-gce-gci-slow/global/firewalls/e2e-4ba5595f17-d39c0-master-etcd].
W0718 23:23:38.580] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-jkns-e2e-gce-gci-slow/regions/us-west1/addresses/e2e-4ba5595f17-d39c0-master-ip].
... skipping 18 lines ...
I0718 23:26:39.113] Cleared config for k8s-jkns-e2e-gce-gci-slow_e2e-4ba5595f17-d39c0 from /workspace/.kube/config
I0718 23:26:39.113] Done
W0718 23:26:39.213] W0718 23:26:39.106105   10024 loader.go:223] Config not found: /workspace/.kube/config
W0718 23:26:39.214] W0718 23:26:39.106371   10024 loader.go:223] Config not found: /workspace/.kube/config
W0718 23:26:39.214] 2019/07/18 23:26:39 process.go:155: Step './hack/e2e-internal/e2e-down.sh' finished in 13m50.177103585s
W0718 23:26:39.214] 2019/07/18 23:26:39 process.go:96: Saved XML output to /workspace/_artifacts/junit_runner.xml.
W0718 23:26:43.355] 2019/07/18 23:26:43 main.go:316: Something went wrong: starting e2e cluster: error during ./hack/e2e-internal/e2e-up.sh: exit status 2
W0718 23:26:43.356] Traceback (most recent call last):
W0718 23:26:43.357]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 778, in <module>
W0718 23:26:43.365]     main(parse_args())
W0718 23:26:43.365]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 626, in main
W0718 23:26:43.365]     mode.start(runner_args)
W0718 23:26:43.365]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 262, in start
W0718 23:26:43.365]     check_env(env, self.command, *args)
W0718 23:26:43.366]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env
W0718 23:26:43.366]     subprocess.check_call(cmd, env=env)
W0718 23:26:43.366]   File "/usr/lib/python2.7/subprocess.py", line 186, in check_call
W0718 23:26:43.366]     raise CalledProcessError(retcode, cmd)
W0718 23:26:43.366] subprocess.CalledProcessError: Command '('kubetest', '--dump=/workspace/_artifacts', '--gcp-service-account=/etc/service-account/service-account.json', '--up', '--down', '--test', '--provider=gce', '--cluster=e2e-4ba5595f17-d39c0', '--gcp-network=e2e-4ba5595f17-d39c0', '--check-leaked-resources', '--extract=ci/latest', '--gcp-node-image=gci', '--gcp-nodes=4', '--gcp-zone=us-west1-b', '--ginkgo-parallel=30', '--test_args=--ginkgo.skip=\\[Slow\\]|\\[Serial\\]|\\[Disruptive\\]|\\[Flaky\\]|\\[Feature:.+\\] --minStartupPods=8', '--timeout=50m')' returned non-zero exit status 1
E0718 23:26:43.381] Command failed
I0718 23:26:43.381] process 276 exited with code 1 after 26.4m
E0718 23:26:43.381] FAIL: ci-cri-containerd-e2e-gci-gce-ip-alias
I0718 23:26:43.382] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0718 23:26:45.628] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0718 23:26:45.679] process 10034 exited with code 0 after 0.0m
I0718 23:26:45.679] Call:  gcloud config get-value account
I0718 23:26:45.996] process 10046 exited with code 0 after 0.0m
I0718 23:26:45.997] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0718 23:26:45.997] Upload result and artifacts...
I0718 23:26:45.997] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/logs/ci-cri-containerd-e2e-gci-gce-ip-alias/1151990016713429000
I0718 23:26:45.998] Call:  gsutil ls gs://kubernetes-jenkins/logs/ci-cri-containerd-e2e-gci-gce-ip-alias/1151990016713429000/artifacts
W0718 23:26:47.034] CommandException: One or more URLs matched no objects.
E0718 23:26:47.162] Command failed
I0718 23:26:47.163] process 10058 exited with code 1 after 0.0m
W0718 23:26:47.163] Remote dir gs://kubernetes-jenkins/logs/ci-cri-containerd-e2e-gci-gce-ip-alias/1151990016713429000/artifacts not exist yet
I0718 23:26:47.164] Call:  gsutil -m -q -o GSUtil:use_magicfile=True cp -r -c -z log,txt,xml /workspace/_artifacts gs://kubernetes-jenkins/logs/ci-cri-containerd-e2e-gci-gce-ip-alias/1151990016713429000/artifacts
I0718 23:26:49.937] process 10200 exited with code 0 after 0.0m
I0718 23:26:49.938] Call:  git rev-parse HEAD
I0718 23:26:49.943] process 10859 exited with code 0 after 0.0m
... skipping 13 lines ...