Running with gitlab-runner 12.9.0 (4c96e5ad)
  on docker-auto-scale 72989761
section_start:1586197880:prepare_executor
Preparing the "docker+machine" executor
Using Docker executor with image docker:19.03.5 ...
Starting service docker:19.03.5-dind ...
Pulling docker image docker:19.03.5-dind ...
Using docker image sha256:8489eeb24a264b6bcdb17f3da00140cebe92ee36bd22365f37d07d59390df4ee for docker:19.03.5-dind ...
Waiting for services to be up and running...

*** WARNING: Service runner-72989761-project-4422333-concurrent-0-docker-0 probably didn't start properly.

Health check error:
service "runner-72989761-project-4422333-concurrent-0-docker-0-wait-for-service" timeout

Health check container logs:


Service container logs:
2020-04-06T18:32:27.941248337Z time="2020-04-06T18:32:27.939331032Z" level=info msg="Starting up"
2020-04-06T18:32:27.956843069Z time="2020-04-06T18:32:27.947924687Z" level=warning msg="could not change group /var/run/docker.sock to docker: group docker not found"
2020-04-06T18:32:27.956870263Z time="2020-04-06T18:32:27.948212586Z" level=warning msg="[!] DON'T BIND ON ANY IP ADDRESS WITHOUT setting --tlsverify IF YOU DON'T KNOW WHAT YOU'RE DOING [!]"
2020-04-06T18:32:27.956884663Z time="2020-04-06T18:32:27.951174740Z" level=info msg="libcontainerd: started new containerd process" pid=19
2020-04-06T18:32:27.956888495Z time="2020-04-06T18:32:27.951209064Z" level=info msg="parsed scheme: \"unix\"" module=grpc
2020-04-06T18:32:27.956892174Z time="2020-04-06T18:32:27.951216934Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc
2020-04-06T18:32:27.956895742Z time="2020-04-06T18:32:27.951241077Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0  <nil>}] <nil>}" module=grpc
2020-04-06T18:32:27.956899871Z time="2020-04-06T18:32:27.951251611Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc
2020-04-06T18:32:27.999728373Z time="2020-04-06T18:32:27.985807171Z" level=info msg="starting containerd" revision=b34a5c8af56e510852c35414db4c1f4fa6172339 version=v1.2.10 
2020-04-06T18:32:27.999754298Z time="2020-04-06T18:32:27.986121795Z" level=info msg="loading plugin "io.containerd.content.v1.content"..." type=io.containerd.content.v1 
2020-04-06T18:32:27.999758727Z time="2020-04-06T18:32:27.986194876Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.btrfs"..." type=io.containerd.snapshotter.v1 
2020-04-06T18:32:27.999765369Z time="2020-04-06T18:32:27.986371018Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.btrfs" error="path /var/lib/docker/containerd/daemon/io.containerd.snapshotter.v1.btrfs must be a btrfs filesystem to be used with the btrfs snapshotter" 
2020-04-06T18:32:27.999772523Z time="2020-04-06T18:32:27.986384195Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.aufs"..." type=io.containerd.snapshotter.v1 
2020-04-06T18:32:28.066968044Z time="2020-04-06T18:32:28.031884303Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.aufs" error="modprobe aufs failed: "ip: can't find device 'aufs'\nmodprobe: can't change directory to '/lib/modules': No such file or directory\n": exit status 1" 
2020-04-06T18:32:28.066990650Z time="2020-04-06T18:32:28.031912997Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.native"..." type=io.containerd.snapshotter.v1 
2020-04-06T18:32:28.066995249Z time="2020-04-06T18:32:28.032050256Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.overlayfs"..." type=io.containerd.snapshotter.v1 
2020-04-06T18:32:28.066998795Z time="2020-04-06T18:32:28.032194716Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.zfs"..." type=io.containerd.snapshotter.v1 
2020-04-06T18:32:28.067002243Z time="2020-04-06T18:32:28.032422365Z" level=info msg="skip loading plugin "io.containerd.snapshotter.v1.zfs"..." type=io.containerd.snapshotter.v1 
2020-04-06T18:32:28.067005706Z time="2020-04-06T18:32:28.032523510Z" level=info msg="loading plugin "io.containerd.metadata.v1.bolt"..." type=io.containerd.metadata.v1 
2020-04-06T18:32:28.067016826Z time="2020-04-06T18:32:28.032571814Z" level=warning msg="could not use snapshotter btrfs in metadata plugin" error="path /var/lib/docker/containerd/daemon/io.containerd.snapshotter.v1.btrfs must be a btrfs filesystem to be used with the btrfs snapshotter" 
2020-04-06T18:32:28.067020660Z time="2020-04-06T18:32:28.032588530Z" level=warning msg="could not use snapshotter aufs in metadata plugin" error="modprobe aufs failed: "ip: can't find device 'aufs'\nmodprobe: can't change directory to '/lib/modules': No such file or directory\n": exit status 1" 
2020-04-06T18:32:28.067024506Z time="2020-04-06T18:32:28.032596140Z" level=warning msg="could not use snapshotter zfs in metadata plugin" error="path /var/lib/docker/containerd/daemon/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" 
2020-04-06T18:32:28.067028177Z time="2020-04-06T18:32:28.062976504Z" level=info msg="loading plugin "io.containerd.differ.v1.walking"..." type=io.containerd.differ.v1 
2020-04-06T18:32:28.067031993Z time="2020-04-06T18:32:28.063012781Z" level=info msg="loading plugin "io.containerd.gc.v1.scheduler"..." type=io.containerd.gc.v1 
2020-04-06T18:32:28.067035229Z time="2020-04-06T18:32:28.063042397Z" level=info msg="loading plugin "io.containerd.service.v1.containers-service"..." type=io.containerd.service.v1 
2020-04-06T18:32:28.067038518Z time="2020-04-06T18:32:28.063054362Z" level=info msg="loading plugin "io.containerd.service.v1.content-service"..." type=io.containerd.service.v1 
2020-04-06T18:32:28.067041840Z time="2020-04-06T18:32:28.063064362Z" level=info msg="loading plugin "io.containerd.service.v1.diff-service"..." type=io.containerd.service.v1 
2020-04-06T18:32:28.067045041Z time="2020-04-06T18:32:28.063075422Z" level=info msg="loading plugin "io.containerd.service.v1.images-service"..." type=io.containerd.service.v1 
2020-04-06T18:32:28.067048217Z time="2020-04-06T18:32:28.063092490Z" level=info msg="loading plugin "io.containerd.service.v1.leases-service"..." type=io.containerd.service.v1 
2020-04-06T18:32:28.067051365Z time="2020-04-06T18:32:28.063103664Z" level=info msg="loading plugin "io.containerd.service.v1.namespaces-service"..." type=io.containerd.service.v1 
2020-04-06T18:32:28.067054660Z time="2020-04-06T18:32:28.063113529Z" level=info msg="loading plugin "io.containerd.service.v1.snapshots-service"..." type=io.containerd.service.v1 
2020-04-06T18:32:28.067057843Z time="2020-04-06T18:32:28.063125461Z" level=info msg="loading plugin "io.containerd.runtime.v1.linux"..." type=io.containerd.runtime.v1 
2020-04-06T18:32:28.067061043Z time="2020-04-06T18:32:28.063354071Z" level=info msg="loading plugin "io.containerd.runtime.v2.task"..." type=io.containerd.runtime.v2 
2020-04-06T18:32:28.067064315Z time="2020-04-06T18:32:28.063478690Z" level=info msg="loading plugin "io.containerd.monitor.v1.cgroups"..." type=io.containerd.monitor.v1 
2020-04-06T18:32:28.067067508Z time="2020-04-06T18:32:28.063791080Z" level=info msg="loading plugin "io.containerd.service.v1.tasks-service"..." type=io.containerd.service.v1 
2020-04-06T18:32:28.067070688Z time="2020-04-06T18:32:28.063816468Z" level=info msg="loading plugin "io.containerd.internal.v1.restart"..." type=io.containerd.internal.v1 
2020-04-06T18:32:28.067076693Z time="2020-04-06T18:32:28.063851009Z" level=info msg="loading plugin "io.containerd.grpc.v1.containers"..." type=io.containerd.grpc.v1 
2020-04-06T18:32:28.067086625Z time="2020-04-06T18:32:28.063871102Z" level=info msg="loading plugin "io.containerd.grpc.v1.content"..." type=io.containerd.grpc.v1 
2020-04-06T18:32:28.067090217Z time="2020-04-06T18:32:28.063882375Z" level=info msg="loading plugin "io.containerd.grpc.v1.diff"..." type=io.containerd.grpc.v1 
2020-04-06T18:32:28.067093439Z time="2020-04-06T18:32:28.063892385Z" level=info msg="loading plugin "io.containerd.grpc.v1.events"..." type=io.containerd.grpc.v1 
2020-04-06T18:32:28.067096602Z time="2020-04-06T18:32:28.063902689Z" level=info msg="loading plugin "io.containerd.grpc.v1.healthcheck"..." type=io.containerd.grpc.v1 
2020-04-06T18:32:28.067099747Z time="2020-04-06T18:32:28.063913824Z" level=info msg="loading plugin "io.containerd.grpc.v1.images"..." type=io.containerd.grpc.v1 
2020-04-06T18:32:28.067102956Z time="2020-04-06T18:32:28.063924477Z" level=info msg="loading plugin "io.containerd.grpc.v1.leases"..." type=io.containerd.grpc.v1 
2020-04-06T18:32:28.067106056Z time="2020-04-06T18:32:28.063934433Z" level=info msg="loading plugin "io.containerd.grpc.v1.namespaces"..." type=io.containerd.grpc.v1 
2020-04-06T18:32:28.067109203Z time="2020-04-06T18:32:28.063944383Z" level=info msg="loading plugin "io.containerd.internal.v1.opt"..." type=io.containerd.internal.v1 
2020-04-06T18:32:28.067112388Z time="2020-04-06T18:32:28.064212697Z" level=info msg="loading plugin "io.containerd.grpc.v1.snapshots"..." type=io.containerd.grpc.v1 
2020-04-06T18:32:28.067115602Z time="2020-04-06T18:32:28.064227545Z" level=info msg="loading plugin "io.containerd.grpc.v1.tasks"..." type=io.containerd.grpc.v1 
2020-04-06T18:32:28.067118757Z time="2020-04-06T18:32:28.064238351Z" level=info msg="loading plugin "io.containerd.grpc.v1.version"..." type=io.containerd.grpc.v1 
2020-04-06T18:32:28.067121878Z time="2020-04-06T18:32:28.064248327Z" level=info msg="loading plugin "io.containerd.grpc.v1.introspection"..." type=io.containerd.grpc.v1 
2020-04-06T18:32:28.067125097Z time="2020-04-06T18:32:28.064643196Z" level=info msg=serving... address="/var/run/docker/containerd/containerd-debug.sock" 
2020-04-06T18:32:28.067128341Z time="2020-04-06T18:32:28.064708542Z" level=info msg=serving... address="/var/run/docker/containerd/containerd.sock" 
2020-04-06T18:32:28.067131440Z time="2020-04-06T18:32:28.064718451Z" level=info msg="containerd successfully booted in 0.080522s" 
2020-04-06T18:32:28.071848177Z time="2020-04-06T18:32:28.071651968Z" level=info msg="Setting the storage driver from the $DOCKER_DRIVER environment variable (overlay2)"
2020-04-06T18:32:28.072383400Z time="2020-04-06T18:32:28.072310697Z" level=info msg="parsed scheme: \"unix\"" module=grpc
2020-04-06T18:32:28.072511983Z time="2020-04-06T18:32:28.072453883Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc
2020-04-06T18:32:28.072601801Z time="2020-04-06T18:32:28.072550425Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0  <nil>}] <nil>}" module=grpc
2020-04-06T18:32:28.072676922Z time="2020-04-06T18:32:28.072640795Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc
2020-04-06T18:32:28.083932395Z time="2020-04-06T18:32:28.083809246Z" level=info msg="parsed scheme: \"unix\"" module=grpc
2020-04-06T18:32:28.084031116Z time="2020-04-06T18:32:28.083991090Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc
2020-04-06T18:32:28.084149256Z time="2020-04-06T18:32:28.084085623Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0  <nil>}] <nil>}" module=grpc
2020-04-06T18:32:28.084234782Z time="2020-04-06T18:32:28.084178500Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc
2020-04-06T18:32:28.158477858Z time="2020-04-06T18:32:28.136244241Z" level=info msg="Loading containers: start."
2020-04-06T18:32:28.158496190Z time="2020-04-06T18:32:28.149900728Z" level=warning msg="Running modprobe bridge br_netfilter failed with message: ip: can't find device 'bridge'\nbridge                167936  1 br_netfilter\nstp                    16384  1 bridge\nllc                    16384  2 bridge,stp\nip: can't find device 'br_netfilter'\nbr_netfilter           24576  0 \nbridge                167936  1 br_netfilter\nmodprobe: can't change directory to '/lib/modules': No such file or directory\n, error: exit status 1"
2020-04-06T18:32:28.269581812Z time="2020-04-06T18:32:28.268503505Z" level=info msg="Default bridge (docker0) is assigned with an IP address 172.18.0.0/16. Daemon option --bip can be used to set a preferred IP address"
2020-04-06T18:32:28.334557922Z time="2020-04-06T18:32:28.333625281Z" level=info msg="Loading containers: done."
2020-04-06T18:32:28.358951425Z time="2020-04-06T18:32:28.355689343Z" level=info msg="Docker daemon" commit=633a0ea838 graphdriver(s)=overlay2 version=19.03.5
2020-04-06T18:32:28.358983322Z time="2020-04-06T18:32:28.355839830Z" level=info msg="Daemon has completed initialization"
2020-04-06T18:32:28.424538379Z time="2020-04-06T18:32:28.424265012Z" level=info msg="API listen on [::]:2375"
2020-04-06T18:32:28.424577650Z time="2020-04-06T18:32:28.424353782Z" level=info msg="API listen on /var/run/docker.sock"

*********

Pulling docker image docker:19.03.5 ...
Using docker image sha256:31c774f62a9b520060d72c3c1901facdfdfd0fc4ae7c5e817cdaf6acd456432c for docker:19.03.5 ...
section_end:1586197979:prepare_executor
section_start:1586197979:prepare_script
Preparing environment
Running on runner-72989761-project-4422333-concurrent-0 via runner-72989761-stg-srm-1586197880-79b0015f...
section_end:1586197981:prepare_script
section_start:1586197981:get_sources
Getting source from Git repository
$ eval "$CI_PRE_CLONE_SCRIPT"
Fetching changes with git depth set to 50...
Initialized empty Git repository in /builds/gitlab-org/monitor/monitor-sandbox/.git/
Created fresh repository.
fatal: unable to access 'https://staging.gitlab.com/gitlab-org/monitor/monitor-sandbox.git/': The requested URL returned error: 500
section_end:1586198004:get_sources
section_start:1586198004:upload_artifacts_on_failure
Uploading artifacts for failed job
Uploading artifacts...
WARNING: gl-code-quality-report.json: no matching files 
ERROR: No files to upload                          
section_end:1586198006:upload_artifacts_on_failure
ERROR: Job failed: exit code 1