[0KRunning with gitlab-runner 12.9.0 (4c96e5ad)
[0;m[0K on docker-auto-scale 72989761
[0;msection_start:1586198508: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-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:43:50.374476968Z time="2020-04-06T18:43:50.374283098Z" level=info msg="Starting up"
2020-04-06T18:43:50.389817761Z time="2020-04-06T18:43:50.389693888Z" level=warning msg="could not change group /var/run/docker.sock to docker: group docker not found"
2020-04-06T18:43:50.391529890Z time="2020-04-06T18:43:50.391435096Z" 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:43:50.410860942Z time="2020-04-06T18:43:50.400874974Z" level=info msg="libcontainerd: started new containerd process" pid=22
2020-04-06T18:43:50.410885666Z time="2020-04-06T18:43:50.400921162Z" level=info msg="parsed scheme: \"unix\"" module=grpc
2020-04-06T18:43:50.410890232Z time="2020-04-06T18:43:50.400929589Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc
2020-04-06T18:43:50.410895650Z time="2020-04-06T18:43:50.400948867Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 <nil>}] <nil>}" module=grpc
2020-04-06T18:43:50.410900661Z time="2020-04-06T18:43:50.400958107Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc
2020-04-06T18:43:50.449958429Z time="2020-04-06T18:43:50.447693791Z" level=info msg="starting containerd" revision=b34a5c8af56e510852c35414db4c1f4fa6172339 version=v1.2.10
2020-04-06T18:43:50.449991346Z time="2020-04-06T18:43:50.448015287Z" level=info msg="loading plugin "io.containerd.content.v1.content"..." type=io.containerd.content.v1
2020-04-06T18:43:50.449996119Z time="2020-04-06T18:43:50.448089621Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.btrfs"..." type=io.containerd.snapshotter.v1
2020-04-06T18:43:50.450000762Z time="2020-04-06T18:43:50.448268422Z" 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:43:50.450006488Z time="2020-04-06T18:43:50.448279568Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.aufs"..." type=io.containerd.snapshotter.v1
2020-04-06T18:43:50.512761316Z time="2020-04-06T18:43:50.460370056Z" 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:43:50.512800379Z time="2020-04-06T18:43:50.460476374Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.native"..." type=io.containerd.snapshotter.v1
2020-04-06T18:43:50.512805096Z time="2020-04-06T18:43:50.460619729Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.overlayfs"..." type=io.containerd.snapshotter.v1
2020-04-06T18:43:50.512808656Z time="2020-04-06T18:43:50.460817410Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.zfs"..." type=io.containerd.snapshotter.v1
2020-04-06T18:43:50.512812194Z time="2020-04-06T18:43:50.461060940Z" level=info msg="skip loading plugin "io.containerd.snapshotter.v1.zfs"..." type=io.containerd.snapshotter.v1
2020-04-06T18:43:50.512815794Z time="2020-04-06T18:43:50.461072186Z" level=info msg="loading plugin "io.containerd.metadata.v1.bolt"..." type=io.containerd.metadata.v1
2020-04-06T18:43:50.512833872Z time="2020-04-06T18:43:50.461122763Z" 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:43:50.512839320Z time="2020-04-06T18:43:50.461130781Z" 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:43:50.512843082Z time="2020-04-06T18:43:50.461137250Z" 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:43:50.512921776Z time="2020-04-06T18:43:50.487988486Z" level=info msg="loading plugin "io.containerd.differ.v1.walking"..." type=io.containerd.differ.v1
2020-04-06T18:43:50.512927611Z time="2020-04-06T18:43:50.488022340Z" level=info msg="loading plugin "io.containerd.gc.v1.scheduler"..." type=io.containerd.gc.v1
2020-04-06T18:43:50.512930991Z time="2020-04-06T18:43:50.488053873Z" level=info msg="loading plugin "io.containerd.service.v1.containers-service"..." type=io.containerd.service.v1
2020-04-06T18:43:50.512934305Z time="2020-04-06T18:43:50.488065756Z" level=info msg="loading plugin "io.containerd.service.v1.content-service"..." type=io.containerd.service.v1
2020-04-06T18:43:50.512937483Z time="2020-04-06T18:43:50.488075867Z" level=info msg="loading plugin "io.containerd.service.v1.diff-service"..." type=io.containerd.service.v1
2020-04-06T18:43:50.512940636Z time="2020-04-06T18:43:50.488088360Z" level=info msg="loading plugin "io.containerd.service.v1.images-service"..." type=io.containerd.service.v1
2020-04-06T18:43:50.512944005Z time="2020-04-06T18:43:50.488100719Z" level=info msg="loading plugin "io.containerd.service.v1.leases-service"..." type=io.containerd.service.v1
2020-04-06T18:43:50.512947214Z time="2020-04-06T18:43:50.488111934Z" level=info msg="loading plugin "io.containerd.service.v1.namespaces-service"..." type=io.containerd.service.v1
2020-04-06T18:43:50.512950478Z time="2020-04-06T18:43:50.488121649Z" level=info msg="loading plugin "io.containerd.service.v1.snapshots-service"..." type=io.containerd.service.v1
2020-04-06T18:43:50.512953816Z time="2020-04-06T18:43:50.488133965Z" level=info msg="loading plugin "io.containerd.runtime.v1.linux"..." type=io.containerd.runtime.v1
2020-04-06T18:43:50.512957358Z time="2020-04-06T18:43:50.488356579Z" level=info msg="loading plugin "io.containerd.runtime.v2.task"..." type=io.containerd.runtime.v2
2020-04-06T18:43:50.512960755Z time="2020-04-06T18:43:50.488460001Z" level=info msg="loading plugin "io.containerd.monitor.v1.cgroups"..." type=io.containerd.monitor.v1
2020-04-06T18:43:50.512964042Z time="2020-04-06T18:43:50.488816340Z" level=info msg="loading plugin "io.containerd.service.v1.tasks-service"..." type=io.containerd.service.v1
2020-04-06T18:43:50.512975914Z time="2020-04-06T18:43:50.488842367Z" level=info msg="loading plugin "io.containerd.internal.v1.restart"..." type=io.containerd.internal.v1
2020-04-06T18:43:50.512983956Z time="2020-04-06T18:43:50.488874647Z" level=info msg="loading plugin "io.containerd.grpc.v1.containers"..." type=io.containerd.grpc.v1
2020-04-06T18:43:50.512987288Z time="2020-04-06T18:43:50.488889271Z" level=info msg="loading plugin "io.containerd.grpc.v1.content"..." type=io.containerd.grpc.v1
2020-04-06T18:43:50.512990461Z time="2020-04-06T18:43:50.488900157Z" level=info msg="loading plugin "io.containerd.grpc.v1.diff"..." type=io.containerd.grpc.v1
2020-04-06T18:43:50.512993618Z time="2020-04-06T18:43:50.488909921Z" level=info msg="loading plugin "io.containerd.grpc.v1.events"..." type=io.containerd.grpc.v1
2020-04-06T18:43:50.512996764Z time="2020-04-06T18:43:50.488919471Z" level=info msg="loading plugin "io.containerd.grpc.v1.healthcheck"..." type=io.containerd.grpc.v1
2020-04-06T18:43:50.512999947Z time="2020-04-06T18:43:50.488929735Z" level=info msg="loading plugin "io.containerd.grpc.v1.images"..." type=io.containerd.grpc.v1
2020-04-06T18:43:50.513003075Z time="2020-04-06T18:43:50.488938777Z" level=info msg="loading plugin "io.containerd.grpc.v1.leases"..." type=io.containerd.grpc.v1
2020-04-06T18:43:50.513006177Z time="2020-04-06T18:43:50.488947763Z" level=info msg="loading plugin "io.containerd.grpc.v1.namespaces"..." type=io.containerd.grpc.v1
2020-04-06T18:43:50.513009330Z time="2020-04-06T18:43:50.488957021Z" level=info msg="loading plugin "io.containerd.internal.v1.opt"..." type=io.containerd.internal.v1
2020-04-06T18:43:50.513012555Z time="2020-04-06T18:43:50.489204410Z" level=info msg="loading plugin "io.containerd.grpc.v1.snapshots"..." type=io.containerd.grpc.v1
2020-04-06T18:43:50.513015743Z time="2020-04-06T18:43:50.489219122Z" level=info msg="loading plugin "io.containerd.grpc.v1.tasks"..." type=io.containerd.grpc.v1
2020-04-06T18:43:50.513018881Z time="2020-04-06T18:43:50.489231402Z" level=info msg="loading plugin "io.containerd.grpc.v1.version"..." type=io.containerd.grpc.v1
2020-04-06T18:43:50.513022031Z time="2020-04-06T18:43:50.489243336Z" level=info msg="loading plugin "io.containerd.grpc.v1.introspection"..." type=io.containerd.grpc.v1
2020-04-06T18:43:50.513025249Z time="2020-04-06T18:43:50.489465072Z" level=info msg=serving... address="/var/run/docker/containerd/containerd-debug.sock"
2020-04-06T18:43:50.513028432Z time="2020-04-06T18:43:50.489523603Z" level=info msg=serving... address="/var/run/docker/containerd/containerd.sock"
2020-04-06T18:43:50.513031583Z time="2020-04-06T18:43:50.489532319Z" level=info msg="containerd successfully booted in 0.042472s"
2020-04-06T18:43:50.513034984Z time="2020-04-06T18:43:50.505408661Z" level=info msg="Setting the storage driver from the $DOCKER_DRIVER environment variable (overlay2)"
2020-04-06T18:43:50.513038232Z time="2020-04-06T18:43:50.506137487Z" level=info msg="parsed scheme: \"unix\"" module=grpc
2020-04-06T18:43:50.513041519Z time="2020-04-06T18:43:50.506158317Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc
2020-04-06T18:43:50.513044896Z time="2020-04-06T18:43:50.506184778Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 <nil>}] <nil>}" module=grpc
2020-04-06T18:43:50.513051707Z time="2020-04-06T18:43:50.506202008Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc
2020-04-06T18:43:50.529881957Z time="2020-04-06T18:43:50.528899492Z" level=info msg="parsed scheme: \"unix\"" module=grpc
2020-04-06T18:43:50.529905191Z time="2020-04-06T18:43:50.529031464Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc
2020-04-06T18:43:50.529910944Z time="2020-04-06T18:43:50.529060193Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 <nil>}] <nil>}" module=grpc
2020-04-06T18:43:50.529915630Z time="2020-04-06T18:43:50.529071430Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc
2020-04-06T18:43:50.593316874Z time="2020-04-06T18:43:50.591829733Z" level=info msg="Loading containers: start."
2020-04-06T18:43:50.622723842Z time="2020-04-06T18:43:50.622232159Z" 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:43:50.748816322Z time="2020-04-06T18:43:50.747138405Z" 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:43:50.831017193Z time="2020-04-06T18:43:50.828642860Z" level=info msg="Loading containers: done."
2020-04-06T18:43:50.851108976Z time="2020-04-06T18:43:50.850688879Z" level=info msg="Docker daemon" commit=633a0ea838 graphdriver(s)=overlay2 version=19.03.5
2020-04-06T18:43:50.851160032Z time="2020-04-06T18:43:50.850853831Z" level=info msg="Daemon has completed initialization"
2020-04-06T18:43:50.899578470Z time="2020-04-06T18:43:50.899317725Z" level=info msg="API listen on [::]:2375"
2020-04-06T18:43:50.899617415Z time="2020-04-06T18:43:50.899450288Z" 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:1586198661:prepare_executor
[0Ksection_start:1586198661:prepare_script
[0K[0K[36;1mPreparing environment[0;m
[0;mRunning on runner-72989761-project-4422333-concurrent-0 via runner-72989761-stg-srm-1586198508-2f515ec5...
section_end:1586198663:prepare_script
[0Ksection_start:1586198663: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/12742034 -> refs/pipelines/12742034
* [new branch] master -> origin/master
[32;1mChecking out a666adff as master...[0;m
[32;1mSkipping Git submodules setup[0;m
section_end:1586198664:get_sources
[0Ksection_start:1586198664:restore_cache
[0K[0K[36;1mRestoring cache[0;m
[0;msection_end:1586198666:restore_cache
[0Ksection_start:1586198666:download_artifacts
[0K[0K[36;1mDownloading artifacts[0;m
[0;msection_end:1586198667:download_artifacts
[0Ksection_start:1586198667: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:1586198937:build_script
[0Ksection_start:1586198937:after_script
[0K[0K[36;1mRunning after_script[0;m
[0;msection_end:1586198941:after_script
[0Ksection_start:1586198941:archive_cache
[0K[0K[36;1mSaving cache[0;m
[0;msection_end:1586198943:archive_cache
[0Ksection_start:1586198943: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=37141841 responseStatus[0;m=201 Created token[0;m=enBMjBGM
section_end:1586198947:upload_artifacts_on_success
[0K[32;1mJob succeeded
[0;m