[0KRunning with gitlab-runner 12.9.0 (4c96e5ad)
[0;m[0K on docker-auto-scale fa6cab46
[0;msection_start:1586197645:prepare_executor
[0K[0K[36;1mPreparing the "docker+machine" executor[0;m
[0;m[0KUsing Docker executor with image docker:19.03.5 ...
[0;m[0KStarting service docker:19.03.5-dind ...
[0;m[0KPulling docker image docker:19.03.5-dind ...
[0;m[0KUsing docker image sha256:8489eeb24a264b6bcdb17f3da00140cebe92ee36bd22365f37d07d59390df4ee for docker:19.03.5-dind ...
[0;m[0KWaiting for services to be up and running...
[0;m
[0;33m*** WARNING:[0;m Service runner-fa6cab46-project-4422333-concurrent-0-docker-0 probably didn't start properly.
Health check error:
service "runner-fa6cab46-project-4422333-concurrent-0-docker-0-wait-for-service" timeout
Health check container logs:
Service container logs:
2020-04-06T18:28:37.134877976Z time="2020-04-06T18:28:37.105060384Z" level=info msg="Starting up"
2020-04-06T18:28:37.134921592Z time="2020-04-06T18:28:37.106216298Z" level=warning msg="could not change group /var/run/docker.sock to docker: group docker not found"
2020-04-06T18:28:37.134926357Z time="2020-04-06T18:28:37.106384919Z" 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:28:37.134929890Z time="2020-04-06T18:28:37.107197024Z" level=info msg="libcontainerd: started new containerd process" pid=19
2020-04-06T18:28:37.134933293Z time="2020-04-06T18:28:37.107226298Z" level=info msg="parsed scheme: \"unix\"" module=grpc
2020-04-06T18:28:37.134936703Z time="2020-04-06T18:28:37.107233942Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc
2020-04-06T18:28:37.134940160Z time="2020-04-06T18:28:37.107251217Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 <nil>}] <nil>}" module=grpc
2020-04-06T18:28:37.134944367Z time="2020-04-06T18:28:37.107260154Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc
2020-04-06T18:28:37.152778468Z time="2020-04-06T18:28:37.144902823Z" level=info msg="starting containerd" revision=b34a5c8af56e510852c35414db4c1f4fa6172339 version=v1.2.10
2020-04-06T18:28:37.152799492Z time="2020-04-06T18:28:37.145210526Z" level=info msg="loading plugin "io.containerd.content.v1.content"..." type=io.containerd.content.v1
2020-04-06T18:28:37.152810668Z time="2020-04-06T18:28:37.145283190Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.btrfs"..." type=io.containerd.snapshotter.v1
2020-04-06T18:28:37.152815157Z time="2020-04-06T18:28:37.145483223Z" 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:28:37.152821172Z time="2020-04-06T18:28:37.145494630Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.aufs"..." type=io.containerd.snapshotter.v1
2020-04-06T18:28:37.167950069Z time="2020-04-06T18:28:37.166009324Z" 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:28:37.167972510Z time="2020-04-06T18:28:37.166036677Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.native"..." type=io.containerd.snapshotter.v1
2020-04-06T18:28:37.167977655Z time="2020-04-06T18:28:37.166168340Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.overlayfs"..." type=io.containerd.snapshotter.v1
2020-04-06T18:28:37.167982163Z time="2020-04-06T18:28:37.166320812Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.zfs"..." type=io.containerd.snapshotter.v1
2020-04-06T18:28:37.167986338Z time="2020-04-06T18:28:37.166566424Z" level=info msg="skip loading plugin "io.containerd.snapshotter.v1.zfs"..." type=io.containerd.snapshotter.v1
2020-04-06T18:28:37.167990528Z time="2020-04-06T18:28:37.166577413Z" level=info msg="loading plugin "io.containerd.metadata.v1.bolt"..." type=io.containerd.metadata.v1
2020-04-06T18:28:37.168006150Z time="2020-04-06T18:28:37.166629517Z" 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:28:37.168011411Z time="2020-04-06T18:28:37.166640470Z" 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:28:37.168015825Z time="2020-04-06T18:28:37.166647193Z" 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:28:37.210925771Z time="2020-04-06T18:28:37.192385364Z" level=info msg="loading plugin "io.containerd.differ.v1.walking"..." type=io.containerd.differ.v1
2020-04-06T18:28:37.210945599Z time="2020-04-06T18:28:37.192416279Z" level=info msg="loading plugin "io.containerd.gc.v1.scheduler"..." type=io.containerd.gc.v1
2020-04-06T18:28:37.210949984Z time="2020-04-06T18:28:37.192444348Z" level=info msg="loading plugin "io.containerd.service.v1.containers-service"..." type=io.containerd.service.v1
2020-04-06T18:28:37.210961477Z time="2020-04-06T18:28:37.192455892Z" level=info msg="loading plugin "io.containerd.service.v1.content-service"..." type=io.containerd.service.v1
2020-04-06T18:28:37.210965250Z time="2020-04-06T18:28:37.192465858Z" level=info msg="loading plugin "io.containerd.service.v1.diff-service"..." type=io.containerd.service.v1
2020-04-06T18:28:37.210968916Z time="2020-04-06T18:28:37.192476284Z" level=info msg="loading plugin "io.containerd.service.v1.images-service"..." type=io.containerd.service.v1
2020-04-06T18:28:37.210972256Z time="2020-04-06T18:28:37.192487825Z" level=info msg="loading plugin "io.containerd.service.v1.leases-service"..." type=io.containerd.service.v1
2020-04-06T18:28:37.210975410Z time="2020-04-06T18:28:37.192498204Z" level=info msg="loading plugin "io.containerd.service.v1.namespaces-service"..." type=io.containerd.service.v1
2020-04-06T18:28:37.210978660Z time="2020-04-06T18:28:37.192508223Z" level=info msg="loading plugin "io.containerd.service.v1.snapshots-service"..." type=io.containerd.service.v1
2020-04-06T18:28:37.210981984Z time="2020-04-06T18:28:37.192519677Z" level=info msg="loading plugin "io.containerd.runtime.v1.linux"..." type=io.containerd.runtime.v1
2020-04-06T18:28:37.210985167Z time="2020-04-06T18:28:37.192804324Z" level=info msg="loading plugin "io.containerd.runtime.v2.task"..." type=io.containerd.runtime.v2
2020-04-06T18:28:37.210988338Z time="2020-04-06T18:28:37.192911210Z" level=info msg="loading plugin "io.containerd.monitor.v1.cgroups"..." type=io.containerd.monitor.v1
2020-04-06T18:28:37.210991515Z time="2020-04-06T18:28:37.193217965Z" level=info msg="loading plugin "io.containerd.service.v1.tasks-service"..." type=io.containerd.service.v1
2020-04-06T18:28:37.210994720Z time="2020-04-06T18:28:37.193241678Z" level=info msg="loading plugin "io.containerd.internal.v1.restart"..." type=io.containerd.internal.v1
2020-04-06T18:28:37.211007401Z time="2020-04-06T18:28:37.193277834Z" level=info msg="loading plugin "io.containerd.grpc.v1.containers"..." type=io.containerd.grpc.v1
2020-04-06T18:28:37.211010949Z time="2020-04-06T18:28:37.193289511Z" level=info msg="loading plugin "io.containerd.grpc.v1.content"..." type=io.containerd.grpc.v1
2020-04-06T18:28:37.211014104Z time="2020-04-06T18:28:37.193300006Z" level=info msg="loading plugin "io.containerd.grpc.v1.diff"..." type=io.containerd.grpc.v1
2020-04-06T18:28:37.211017244Z time="2020-04-06T18:28:37.193309584Z" level=info msg="loading plugin "io.containerd.grpc.v1.events"..." type=io.containerd.grpc.v1
2020-04-06T18:28:37.211020419Z time="2020-04-06T18:28:37.193319005Z" level=info msg="loading plugin "io.containerd.grpc.v1.healthcheck"..." type=io.containerd.grpc.v1
2020-04-06T18:28:37.211023652Z time="2020-04-06T18:28:37.193328713Z" level=info msg="loading plugin "io.containerd.grpc.v1.images"..." type=io.containerd.grpc.v1
2020-04-06T18:28:37.211026738Z time="2020-04-06T18:28:37.193337883Z" level=info msg="loading plugin "io.containerd.grpc.v1.leases"..." type=io.containerd.grpc.v1
2020-04-06T18:28:37.211029937Z time="2020-04-06T18:28:37.193356136Z" level=info msg="loading plugin "io.containerd.grpc.v1.namespaces"..." type=io.containerd.grpc.v1
2020-04-06T18:28:37.211033233Z time="2020-04-06T18:28:37.193365849Z" level=info msg="loading plugin "io.containerd.internal.v1.opt"..." type=io.containerd.internal.v1
2020-04-06T18:28:37.211036358Z time="2020-04-06T18:28:37.193626609Z" level=info msg="loading plugin "io.containerd.grpc.v1.snapshots"..." type=io.containerd.grpc.v1
2020-04-06T18:28:37.211039606Z time="2020-04-06T18:28:37.193641297Z" level=info msg="loading plugin "io.containerd.grpc.v1.tasks"..." type=io.containerd.grpc.v1
2020-04-06T18:28:37.211042701Z time="2020-04-06T18:28:37.193652326Z" level=info msg="loading plugin "io.containerd.grpc.v1.version"..." type=io.containerd.grpc.v1
2020-04-06T18:28:37.211045914Z time="2020-04-06T18:28:37.193662424Z" level=info msg="loading plugin "io.containerd.grpc.v1.introspection"..." type=io.containerd.grpc.v1
2020-04-06T18:28:37.211049488Z time="2020-04-06T18:28:37.193924590Z" level=info msg=serving... address="/var/run/docker/containerd/containerd-debug.sock"
2020-04-06T18:28:37.211052834Z time="2020-04-06T18:28:37.193997495Z" level=info msg=serving... address="/var/run/docker/containerd/containerd.sock"
2020-04-06T18:28:37.211056119Z time="2020-04-06T18:28:37.194007447Z" level=info msg="containerd successfully booted in 0.049701s"
2020-04-06T18:28:37.211059540Z time="2020-04-06T18:28:37.208565212Z" level=info msg="Setting the storage driver from the $DOCKER_DRIVER environment variable (overlay2)"
2020-04-06T18:28:37.211109084Z time="2020-04-06T18:28:37.209930744Z" level=info msg="parsed scheme: \"unix\"" module=grpc
2020-04-06T18:28:37.211114207Z time="2020-04-06T18:28:37.209946066Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc
2020-04-06T18:28:37.211117751Z time="2020-04-06T18:28:37.209970877Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 <nil>}] <nil>}" module=grpc
2020-04-06T18:28:37.211125317Z time="2020-04-06T18:28:37.209981410Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc
2020-04-06T18:28:37.223037975Z time="2020-04-06T18:28:37.222950236Z" level=info msg="parsed scheme: \"unix\"" module=grpc
2020-04-06T18:28:37.223117951Z time="2020-04-06T18:28:37.223068509Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc
2020-04-06T18:28:37.223203796Z time="2020-04-06T18:28:37.223155987Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 <nil>}] <nil>}" module=grpc
2020-04-06T18:28:37.223265116Z time="2020-04-06T18:28:37.223226898Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc
2020-04-06T18:28:37.279318483Z time="2020-04-06T18:28:37.277801881Z" level=info msg="Loading containers: start."
2020-04-06T18:28:37.303245448Z time="2020-04-06T18:28:37.303115329Z" 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:28:37.406350790Z time="2020-04-06T18:28:37.403911949Z" 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:28:37.478790113Z time="2020-04-06T18:28:37.478358844Z" level=info msg="Loading containers: done."
2020-04-06T18:28:37.499420385Z time="2020-04-06T18:28:37.499044146Z" level=info msg="Docker daemon" commit=633a0ea838 graphdriver(s)=overlay2 version=19.03.5
2020-04-06T18:28:37.499449697Z time="2020-04-06T18:28:37.499192288Z" level=info msg="Daemon has completed initialization"
2020-04-06T18:28:37.544538765Z time="2020-04-06T18:28:37.544324327Z" level=info msg="API listen on [::]:2375"
2020-04-06T18:28:37.544564157Z time="2020-04-06T18:28:37.544396512Z" level=info msg="API listen on /var/run/docker.sock"
[0;33m*********[0;m
[0KPulling docker image docker:19.03.5 ...
[0;m[0KUsing docker image sha256:31c774f62a9b520060d72c3c1901facdfdfd0fc4ae7c5e817cdaf6acd456432c for docker:19.03.5 ...
[0;msection_end:1586197748:prepare_executor
[0Ksection_start:1586197748:prepare_script
[0K[0K[36;1mPreparing environment[0;m
[0;mRunning on runner-fa6cab46-project-4422333-concurrent-0 via runner-fa6cab46-stg-srm-1586197645-ec4cd6a4...
section_end:1586197750:prepare_script
[0Ksection_start:1586197750:get_sources
[0K[0K[36;1mGetting source from Git repository[0;m
[0;m[32;1m$ eval "$CI_PRE_CLONE_SCRIPT"[0;m
[32;1mFetching changes with git depth set to 50...[0;m
Initialized empty Git repository in /builds/gitlab-org/monitor/monitor-sandbox/.git/
[32;1mCreated fresh repository.[0;m
From https://staging.gitlab.com/gitlab-org/monitor/monitor-sandbox
* [new ref] refs/pipelines/12741991 -> refs/pipelines/12741991
* [new branch] master -> origin/master
[32;1mChecking out ad5f0afe as master...[0;m
[32;1mSkipping Git submodules setup[0;m
section_end:1586197751:get_sources
[0Ksection_start:1586197751:restore_cache
[0K[0K[36;1mRestoring cache[0;m
[0;msection_end:1586197753:restore_cache
[0Ksection_start:1586197753:download_artifacts
[0K[0K[36;1mDownloading artifacts[0;m
[0;msection_end:1586197754:download_artifacts
[0Ksection_start:1586197754:build_script
[0K[0K[36;1mRunning before_script and script[0;m
[0;m[32;1m$ if ! docker info &>/dev/null; then # collapsed multi-line command[0;m
[32;1m$ docker pull --quiet "$CODE_QUALITY_IMAGE"[0;m
registry.gitlab.com/gitlab-org/ci-cd/codequality:0.85.9
[32;1m$ docker run --env SOURCE_CODE="$PWD" --volume "$PWD":/code --volume /var/run/docker.sock:/var/run/docker.sock "$CODE_QUALITY_IMAGE" /code[0;m
section_end:1586198022:build_script
[0Ksection_start:1586198022:after_script
[0K[0K[36;1mRunning after_script[0;m
[0;msection_end:1586198025:after_script
[0Ksection_start:1586198025:archive_cache
[0K[0K[36;1mSaving cache[0;m
[0;msection_end:1586198027:archive_cache
[0Ksection_start:1586198027:upload_artifacts_on_success
[0K[0K[36;1mUploading artifacts for successful job[0;m
[0;m[32;1mUploading artifacts...[0;m
gl-code-quality-report.json: found 1 matching files[0;m
Uploading artifacts to coordinator... ok [0;m id[0;m=37141740 responseStatus[0;m=201 Created token[0;m=jYwgSvRE
section_end:1586198030:upload_artifacts_on_success
[0K[32;1mJob succeeded
[0;m