This job view page is being replaced by Spyglass soon. Check out the new job view.
PRBenTheElder: upgrade to go1.12.1
ResultFAILURE
Tests 1 failed / 19 succeeded
Started2019-03-15 22:44
Elapsed41m47s
Revision
Buildergke-prow-containerd-pool-99179761-d3mr
Refs master:df2094b3
75413:650ffe20
podb34a73b5-4773-11e9-82d4-0a580a6c0fcd
infra-commit7df5b975d
job-versionv1.15.0-alpha.0.1233+369b24b3bb2a20
podb34a73b5-4773-11e9-82d4-0a580a6c0fcd
repok8s.io/kubernetes
repo-commit369b24b3bb2a203b05f6d912908ae488cd5a9313
repos{u'k8s.io/kubernetes': u'master:df2094b3d728bd58c5f23b41add109e32fc7c301,75413:650ffe2085df42be6755985a926c48de4cd36f0e', u'k8s.io/perf-tests': u'master', u'k8s.io/release': u'master'}
revisionv1.15.0-alpha.0.1233+369b24b3bb2a20

Test Failures


ClusterLoaderV2 50s

error during /go/src/k8s.io/perf-tests/run-e2e.sh cluster-loader2 --nodes=500 --provider=kubemark --report-dir=/workspace/_artifacts --testconfig=testing/density/config.yaml --testconfig=testing/load/config.yaml --testoverrides=./testing/load/kubemark/500_nodes/override.yaml: exit status 255
				from junit_runner.xml

Filter through log files | View test history on testgrid


Show 19 Passed Tests

Error lines from build-log.txt

... skipping 1165 lines ...
W0315 23:07:35.469] Trying to find master named 'e2e-75413-ac87c-master'
W0315 23:07:35.469] Looking for address 'e2e-75413-ac87c-master-ip'
W0315 23:07:36.279] Using master: e2e-75413-ac87c-master (external IP: 35.237.101.121)
I0315 23:07:36.379] Waiting up to 300 seconds for cluster initialization.
I0315 23:07:36.379] 
I0315 23:07:36.380]   This will continually check to see if the API for kubernetes is reachable.
I0315 23:07:36.380]   This may time out if there was some uncaught error during start up.
I0315 23:07:36.380] 
I0315 23:07:53.907] ....Kubernetes cluster created.
I0315 23:07:54.051] Cluster "k8s-presubmit-scale_e2e-75413-ac87c" set.
I0315 23:07:54.196] User "k8s-presubmit-scale_e2e-75413-ac87c" set.
I0315 23:07:54.351] Context "k8s-presubmit-scale_e2e-75413-ac87c" created.
I0315 23:07:54.499] Switched to context "k8s-presubmit-scale_e2e-75413-ac87c".
... skipping 22 lines ...
I0315 23:08:36.377] e2e-75413-ac87c-minion-group-5p8m   Ready                      <none>   13s   v1.15.0-alpha.0.1233+369b24b3bb2a20
I0315 23:08:36.377] e2e-75413-ac87c-minion-group-gctk   Ready                      <none>   14s   v1.15.0-alpha.0.1233+369b24b3bb2a20
I0315 23:08:36.378] e2e-75413-ac87c-minion-group-gqhv   Ready                      <none>   15s   v1.15.0-alpha.0.1233+369b24b3bb2a20
I0315 23:08:36.378] e2e-75413-ac87c-minion-group-q47v   Ready                      <none>   15s   v1.15.0-alpha.0.1233+369b24b3bb2a20
I0315 23:08:36.378] e2e-75413-ac87c-minion-group-ww2w   Ready                      <none>   16s   v1.15.0-alpha.0.1233+369b24b3bb2a20
I0315 23:08:36.701] Validate output:
I0315 23:08:37.005] NAME                 STATUS    MESSAGE             ERROR
I0315 23:08:37.005] controller-manager   Healthy   ok                  
I0315 23:08:37.005] scheduler            Healthy   ok                  
I0315 23:08:37.006] etcd-1               Healthy   {"health":"true"}   
I0315 23:08:37.006] etcd-0               Healthy   {"health":"true"}   
I0315 23:08:37.010] Cluster validation succeeded
W0315 23:08:37.111] Done, listing cluster services:
... skipping 60 lines ...
W0315 23:09:03.314] 2019/03/15 23:09:03 process.go:155: Step './hack/e2e-internal/e2e-up.sh' finished in 4m22.405650622s
W0315 23:09:03.314] 2019/03/15 23:09:03 process.go:153: Running: ./cluster/kubectl.sh --match-server-version=false version
W0315 23:09:03.616] 2019/03/15 23:09:03 process.go:155: Step './cluster/kubectl.sh --match-server-version=false version' finished in 316.120238ms
W0315 23:09:03.617] 2019/03/15 23:09:03 process.go:153: Running: ./cluster/kubectl.sh --match-server-version=false get nodes -oyaml
W0315 23:09:04.022] 2019/03/15 23:09:04 process.go:155: Step './cluster/kubectl.sh --match-server-version=false get nodes -oyaml' finished in 405.238329ms
W0315 23:09:04.022] 2019/03/15 23:09:04 process.go:153: Running: ./test/kubemark/stop-kubemark.sh
W0315 23:09:05.569] ERROR: (gcloud.compute.instances.delete) Could not fetch resource:
W0315 23:09:05.570]  - The resource 'projects/k8s-presubmit-scale/zones/us-east1-b/instances/e2e-75413-ac87c-kubemark-master' was not found
W0315 23:09:05.570] 
W0315 23:09:06.501] ERROR: (gcloud.compute.disks.delete) Could not fetch resource:
W0315 23:09:06.502]  - The resource 'projects/k8s-presubmit-scale/zones/us-east1-b/disks/e2e-75413-ac87c-kubemark-master-pd' was not found
W0315 23:09:06.502] 
W0315 23:09:08.390] ERROR: (gcloud.compute.addresses.delete) Could not fetch resource:
W0315 23:09:08.390]  - The resource 'projects/k8s-presubmit-scale/regions/us-east1/addresses/e2e-75413-ac87c-kubemark-master-ip' was not found
W0315 23:09:08.390] 
W0315 23:09:09.167] ERROR: (gcloud.compute.firewall-rules.delete) Could not fetch resource:
W0315 23:09:09.167]  - The resource 'projects/k8s-presubmit-scale/global/firewalls/e2e-75413-ac87c-kubemark-master-https' was not found
W0315 23:09:09.167] 
W0315 23:09:09.246] 2019/03/15 23:09:09 process.go:155: Step './test/kubemark/stop-kubemark.sh' finished in 5.22414575s
W0315 23:09:09.246] 2019/03/15 23:09:09 process.go:153: Running: ./hack/e2e-internal/e2e-status.sh
W0315 23:09:09.314] Project: k8s-presubmit-scale
W0315 23:09:09.314] Network Project: k8s-presubmit-scale
W0315 23:09:09.315] Zone: us-east1-b
I0315 23:09:09.734] Client Version: version.Info{Major:"1", Minor:"15+", GitVersion:"v1.15.0-alpha.0.1233+369b24b3bb2a20", GitCommit:"369b24b3bb2a203b05f6d912908ae488cd5a9313", GitTreeState:"clean", BuildDate:"2019-03-15T19:40:58Z", GoVersion:"go1.12.1", Compiler:"gc", Platform:"linux/amd64"}
I0315 23:09:09.735] Server Version: version.Info{Major:"1", Minor:"15+", GitVersion:"v1.15.0-alpha.0.1233+369b24b3bb2a20", GitCommit:"369b24b3bb2a203b05f6d912908ae488cd5a9313", GitTreeState:"clean", BuildDate:"2019-03-15T19:40:58Z", GoVersion:"go1.12.1", Compiler:"gc", Platform:"linux/amd64"}
W0315 23:09:09.836] 2019/03/15 23:09:09 process.go:155: Step './hack/e2e-internal/e2e-status.sh' finished in 494.855544ms
W0315 23:09:09.836] 2019/03/15 23:09:09 process.go:153: Running: ./test/kubemark/start-kubemark.sh
W0315 23:09:11.045] ERROR: (gcloud.compute.addresses.describe) Could not fetch resource:
W0315 23:09:11.046]  - The resource 'projects/k8s-presubmit-scale/regions/us-east1/addresses/e2e-75413-ac87c-kubemark-master-ip' was not found
W0315 23:09:11.046] 
I0315 23:09:24.619] Created [https://www.googleapis.com/compute/v1/projects/k8s-presubmit-scale/regions/us-east1/addresses/e2e-75413-ac87c-kubemark-master-ip].
I0315 23:09:24.944] Succeeded to gcloud compute addresses.
I0315 23:09:25.779] Generating certs for alternate-names: IP:35.231.32.239,IP:10.0.0.1,DNS:kubernetes,DNS:kubernetes.default,DNS:kubernetes.default.svc,DNS:kubernetes.default.svc.cluster.local,DNS:e2e-75413-ac87c-kubemark-master
I0315 23:09:27.897] Generated PKI authentication data for kubemark.
... skipping 660 lines ...
W0315 23:14:42.381] I0315 23:14:42.381650   88759 prometheus.go:145] Applying /go/src/k8s.io/perf-tests/clusterloader2/pkg/prometheus/manifests/prometheus-roleSpecificNamespaces.yaml
W0315 23:14:42.503] I0315 23:14:42.502771   88759 prometheus.go:145] Applying /go/src/k8s.io/perf-tests/clusterloader2/pkg/prometheus/manifests/prometheus-service.yaml
W0315 23:14:42.548] I0315 23:14:42.548284   88759 prometheus.go:145] Applying /go/src/k8s.io/perf-tests/clusterloader2/pkg/prometheus/manifests/prometheus-serviceAccount.yaml
W0315 23:14:42.589] I0315 23:14:42.588777   88759 prometheus.go:145] Applying /go/src/k8s.io/perf-tests/clusterloader2/pkg/prometheus/manifests/prometheus-serviceMonitor.yaml
W0315 23:14:42.630] I0315 23:14:42.630334   88759 prometheus.go:172] Exposing kube-apiserver metrics in kubemark cluster
W0315 23:14:42.827] I0315 23:14:42.827518   88759 prometheus.go:145] Applying /go/src/k8s.io/perf-tests/clusterloader2/pkg/prometheus/manifests/kubemark/kube-apiserver-endpoints.yaml
W0315 23:14:42.828] F0315 23:14:42.828673   88759 clusterloader.go:203] Error while setting up prometheus stack: unmarshaling error: yaml: line 14: could not find expected ':'
W0315 23:14:42.829] goroutine 1 [running]:
W0315 23:14:42.829] k8s.io/perf-tests/clusterloader2/vendor/k8s.io/klog.stacks(0xc000897c00, 0xc0004ae000, 0x9c, 0x1b7)
W0315 23:14:42.829] 	/go/src/k8s.io/perf-tests/clusterloader2/vendor/k8s.io/klog/klog.go:830 +0xb1
W0315 23:14:42.830] k8s.io/perf-tests/clusterloader2/vendor/k8s.io/klog.(*loggingT).output(0x25b5be0, 0xc000000003, 0xc0003d1ab0, 0x2528909, 0x10, 0xcb, 0x0)
W0315 23:14:42.830] 	/go/src/k8s.io/perf-tests/clusterloader2/vendor/k8s.io/klog/klog.go:781 +0x25e
W0315 23:14:42.830] k8s.io/perf-tests/clusterloader2/vendor/k8s.io/klog.(*loggingT).printf(0x25b5be0, 0x3, 0x16175e4, 0x2b, 0xc0008f3d50, 0x1, 0x1)
... skipping 34 lines ...
W0315 23:15:16.166] scp: /var/log/kube-apiserver-audit.log*: No such file or directory
W0315 23:15:16.468] scp: /var/log/glbc.log*: No such file or directory
W0315 23:15:16.468] scp: /var/log/cluster-autoscaler.log*: No such file or directory
W0315 23:15:16.542] scp: /var/log/fluentd.log*: No such file or directory
W0315 23:15:16.542] scp: /var/log/kubelet.cov*: No such file or directory
W0315 23:15:16.543] scp: /var/log/startupscript.log*: No such file or directory
W0315 23:15:16.643] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W0315 23:15:16.731] 2019/03/15 23:15:16 process.go:155: Step './test/kubemark/master-log-dump.sh /workspace/_artifacts' finished in 33.843328094s
W0315 23:15:16.732] 2019/03/15 23:15:16 process.go:153: Running: ./test/kubemark/stop-kubemark.sh
I0315 23:15:16.832] Skipping dumping of node logs
W0315 23:15:17.372] scp: /var/log/cluster-autoscaler.log*: No such file or directory
W0315 23:15:17.447] scp: /var/log/fluentd.log*: No such file or directory
W0315 23:15:17.447] scp: /var/log/kubelet.cov*: No such file or directory
W0315 23:15:17.447] scp: /var/log/startupscript.log*: No such file or directory
W0315 23:15:17.452] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
I0315 23:15:17.552] Dumping logs from nodes locally to '/workspace/_artifacts'
I0315 23:15:17.553] Detecting nodes in the cluster
I0315 23:15:54.056] Changing logfiles to be world-readable for download
I0315 23:15:55.266] Changing logfiles to be world-readable for download
I0315 23:15:55.419] Changing logfiles to be world-readable for download
I0315 23:15:55.592] Changing logfiles to be world-readable for download
... skipping 41 lines ...
W0315 23:16:02.031] scp: /var/log/kubelet.cov*: No such file or directory
W0315 23:16:02.176] scp: /var/log/fluentd.log*: No such file or directory
W0315 23:16:02.177] scp: /var/log/node-problem-detector.log*: No such file or directory
W0315 23:16:02.177] scp: /var/log/kubelet.cov*: No such file or directory
W0315 23:16:15.660] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-presubmit-scale/zones/us-east1-b/instances/e2e-75413-ac87c-kubemark-master].
W0315 23:16:15.716] scp: /var/log/startupscript.log*: No such file or directory
W0315 23:16:15.722] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W0315 23:16:15.940] scp: /var/log/startupscript.log*: No such file or directory
W0315 23:16:15.944] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W0315 23:16:16.449] scp: /var/log/startupscript.log*: No such file or directory
W0315 23:16:16.454] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W0315 23:16:16.980] scp: /var/log/startupscript.log*: No such file or directory
W0315 23:16:16.984] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W0315 23:16:17.652] scp: /var/log/startupscript.log*: No such file or directory
W0315 23:16:17.657] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W0315 23:16:20.030] scp: /var/log/startupscript.log*: No such file or directory
W0315 23:16:20.035] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W0315 23:16:20.257] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-presubmit-scale/zones/us-east1-b/disks/e2e-75413-ac87c-kubemark-master-pd].
W0315 23:16:20.293] scp: /var/log/startupscript.log*: No such file or directory
W0315 23:16:20.298] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W0315 23:16:23.421] INSTANCE_GROUPS=e2e-75413-ac87c-minion-group
W0315 23:16:23.422] NODE_NAMES=e2e-75413-ac87c-minion-group-1dmz e2e-75413-ac87c-minion-group-3k8x e2e-75413-ac87c-minion-group-5p8m e2e-75413-ac87c-minion-group-gctk e2e-75413-ac87c-minion-group-gqhv e2e-75413-ac87c-minion-group-q47v e2e-75413-ac87c-minion-group-ww2w
I0315 23:16:24.333] Failures for e2e-75413-ac87c-minion-group
W0315 23:16:25.879] 2019/03/15 23:16:25 process.go:155: Step './cluster/log-dump/log-dump.sh /workspace/_artifacts' finished in 1m42.991175732s
W0315 23:16:25.879] 2019/03/15 23:16:25 process.go:153: Running: ./hack/e2e-internal/e2e-down.sh
W0315 23:16:25.933] Project: k8s-presubmit-scale
... skipping 17 lines ...
W0315 23:16:51.249] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-presubmit-scale/global/firewalls/e2e-75413-ac87c-kubemark-master-https].
W0315 23:16:51.433] .2019/03/15 23:16:51 process.go:155: Step './test/kubemark/stop-kubemark.sh' finished in 1m34.701798107s
W0315 23:19:46.318] ....................................Deleted [https://www.googleapis.com/compute/v1/projects/k8s-presubmit-scale/zones/us-east1-b/instanceGroupManagers/e2e-75413-ac87c-minion-group].
W0315 23:19:46.319] done.
W0315 23:19:55.467] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-presubmit-scale/global/instanceTemplates/e2e-75413-ac87c-minion-template].
W0315 23:20:01.889] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-presubmit-scale/global/instanceTemplates/e2e-75413-ac87c-windows-node-template].
I0315 23:20:13.991] {"message":"Internal Server Error"}Removing etcd replica, name: e2e-75413-ac87c-master, port: 2379, result: 0
I0315 23:20:15.529] {"message":"Internal Server Error"}Removing etcd replica, name: e2e-75413-ac87c-master, port: 4002, result: 0
W0315 23:20:22.105] Updated [https://www.googleapis.com/compute/v1/projects/k8s-presubmit-scale/zones/us-east1-b/instances/e2e-75413-ac87c-master].
W0315 23:22:57.307] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-presubmit-scale/zones/us-east1-b/instances/e2e-75413-ac87c-master].
W0315 23:23:24.250] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-presubmit-scale/global/firewalls/e2e-75413-ac87c-master-https].
W0315 23:23:24.975] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-presubmit-scale/global/firewalls/e2e-75413-ac87c-master-etcd].
W0315 23:23:26.056] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-presubmit-scale/global/firewalls/e2e-75413-ac87c-minion-all].
W0315 23:23:39.352] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-presubmit-scale/regions/us-east1/addresses/e2e-75413-ac87c-master-ip].
... skipping 9 lines ...
I0315 23:25:21.468] Property "users.k8s-presubmit-scale_e2e-75413-ac87c-basic-auth" unset.
I0315 23:25:21.600] Property "contexts.k8s-presubmit-scale_e2e-75413-ac87c" unset.
I0315 23:25:21.604] Cleared config for k8s-presubmit-scale_e2e-75413-ac87c from /go/src/k8s.io/kubernetes/kubernetes/test/kubemark/resources/kubeconfig.kubemark
I0315 23:25:21.604] Done
W0315 23:25:21.705] 2019/03/15 23:25:21 process.go:155: Step './hack/e2e-internal/e2e-down.sh' finished in 8m55.727188602s
W0315 23:25:21.705] 2019/03/15 23:25:21 process.go:96: Saved XML output to /workspace/_artifacts/junit_runner.xml.
W0315 23:25:21.705] 2019/03/15 23:25:21 main.go:307: Something went wrong: encountered 1 errors: [error during /go/src/k8s.io/perf-tests/run-e2e.sh cluster-loader2 --nodes=500 --provider=kubemark --report-dir=/workspace/_artifacts --testconfig=testing/density/config.yaml --testconfig=testing/load/config.yaml --testoverrides=./testing/load/kubemark/500_nodes/override.yaml: exit status 255]
W0315 23:25:21.706] Traceback (most recent call last):
W0315 23:25:21.706]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 764, in <module>
W0315 23:25:21.712]     main(parse_args())
W0315 23:25:21.712]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 615, in main
W0315 23:25:21.713]     mode.start(runner_args)
W0315 23:25:21.713]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 262, in start
W0315 23:25:21.713]     check_env(env, self.command, *args)
W0315 23:25:21.713]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env
W0315 23:25:21.713]     subprocess.check_call(cmd, env=env)
W0315 23:25:21.713]   File "/usr/lib/python2.7/subprocess.py", line 186, in check_call
W0315 23:25:21.769]     raise CalledProcessError(retcode, cmd)
W0315 23:25:21.770] subprocess.CalledProcessError: Command '('kubetest', '--dump=/workspace/_artifacts', '--gcp-service-account=/etc/service-account/service-account.json', '--build=bazel', '--stage=gs://kubernetes-release-pull/ci/pull-kubernetes-kubemark-e2e-gce-big', '--up', '--down', '--provider=gce', '--cluster=e2e-75413-ac87c', '--gcp-network=e2e-75413-ac87c', '--extract=local', '--gcp-master-size=n1-standard-4', '--gcp-node-size=n1-standard-8', '--gcp-nodes=7', '--gcp-project=k8s-presubmit-scale', '--gcp-zone=us-east1-b', '--kubemark', '--kubemark-nodes=500', '--test_args=--ginkgo.focus=xxxx', '--test-cmd=/go/src/k8s.io/perf-tests/run-e2e.sh', '--test-cmd-args=cluster-loader2', '--test-cmd-args=--nodes=500', '--test-cmd-args=--provider=kubemark', '--test-cmd-args=--report-dir=/workspace/_artifacts', '--test-cmd-args=--testconfig=testing/density/config.yaml', '--test-cmd-args=--testconfig=testing/load/config.yaml', '--test-cmd-args=--testoverrides=./testing/load/kubemark/500_nodes/override.yaml', '--test-cmd-name=ClusterLoaderV2', '--timeout=100m')' returned non-zero exit status 1
E0315 23:25:21.781] Command failed
I0315 23:25:21.781] process 740 exited with code 1 after 40.2m
E0315 23:25:21.781] FAIL: pull-kubernetes-kubemark-e2e-gce-big
I0315 23:25:21.782] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0315 23:25:22.358] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0315 23:25:22.464] process 92968 exited with code 0 after 0.0m
I0315 23:25:22.464] Call:  gcloud config get-value account
I0315 23:25:22.940] process 92980 exited with code 0 after 0.0m
I0315 23:25:22.941] Will upload results to gs://kubernetes-jenkins/pr-logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0315 23:25:22.941] Upload result and artifacts...
I0315 23:25:22.941] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/pr-logs/pull/75413/pull-kubernetes-kubemark-e2e-gce-big/41509
I0315 23:25:22.941] Call:  gsutil ls gs://kubernetes-jenkins/pr-logs/pull/75413/pull-kubernetes-kubemark-e2e-gce-big/41509/artifacts
W0315 23:25:23.935] CommandException: One or more URLs matched no objects.
E0315 23:25:24.070] Command failed
I0315 23:25:24.071] process 92992 exited with code 1 after 0.0m
W0315 23:25:24.071] Remote dir gs://kubernetes-jenkins/pr-logs/pull/75413/pull-kubernetes-kubemark-e2e-gce-big/41509/artifacts not exist yet
I0315 23:25:24.071] Call:  gsutil -m -q -o GSUtil:use_magicfile=True cp -r -c -z log,txt,xml /workspace/_artifacts gs://kubernetes-jenkins/pr-logs/pull/75413/pull-kubernetes-kubemark-e2e-gce-big/41509/artifacts
I0315 23:25:39.834] process 93134 exited with code 0 after 0.3m
I0315 23:25:39.835] Call:  git rev-parse HEAD
I0315 23:25:39.839] process 95336 exited with code 0 after 0.0m
... skipping 21 lines ...