[0KRunning with gitlab-runner 12.9.0 (4c96e5ad)
[0;m[0K on docker-auto-scale fa6cab46
[0;msection_start:1587038510:prepare_executor
[0K[0K[36;1mPreparing the "docker+machine" executor[0;m
[0;m[0KUsing Docker executor with image docker:19.03.8 ...
[0;m[0KStarting service docker:19.03.8-dind ...
[0;m[0KPulling docker image docker:19.03.8-dind ...
[0;m[0KUsing docker image sha256:a6e51fd179fb849f4ec6faee318101d32830103f5615215716bd686c56afaea1 for docker:19.03.8-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-16T12:02:58.825237977Z time="2020-04-16T12:02:58.819682891Z" level=info msg="Starting up"
2020-04-16T12:02:58.825289489Z time="2020-04-16T12:02:58.820856325Z" level=warning msg="could not change group /var/run/docker.sock to docker: group docker not found"
2020-04-16T12:02:58.825294387Z time="2020-04-16T12:02:58.821054635Z" level=warning msg="[!] DON'T BIND ON ANY IP ADDRESS WITHOUT setting --tlsverify IF YOU DON'T KNOW WHAT YOU'RE DOING [!]"
2020-04-16T12:02:58.825297842Z time="2020-04-16T12:02:58.821907341Z" level=info msg="libcontainerd: started new containerd process" pid=18
2020-04-16T12:02:58.825301129Z time="2020-04-16T12:02:58.821941005Z" level=info msg="parsed scheme: \"unix\"" module=grpc
2020-04-16T12:02:58.825304422Z time="2020-04-16T12:02:58.821948876Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc
2020-04-16T12:02:58.825307944Z time="2020-04-16T12:02:58.821965452Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 <nil>}] <nil>}" module=grpc
2020-04-16T12:02:58.825312427Z time="2020-04-16T12:02:58.821973664Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc
2020-04-16T12:02:58.909427893Z time="2020-04-16T12:02:58.874455195Z" level=info msg="starting containerd" revision=7ad184331fa3e55e52b890ea95e65ba581ae3429 version=v1.2.13
2020-04-16T12:02:58.909451392Z time="2020-04-16T12:02:58.874794996Z" level=info msg="loading plugin "io.containerd.content.v1.content"..." type=io.containerd.content.v1
2020-04-16T12:02:58.909455854Z time="2020-04-16T12:02:58.874871127Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.btrfs"..." type=io.containerd.snapshotter.v1
2020-04-16T12:02:58.909459661Z time="2020-04-16T12:02:58.875079557Z" 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-16T12:02:58.909465014Z time="2020-04-16T12:02:58.875092348Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.aufs"..." type=io.containerd.snapshotter.v1
2020-04-16T12:02:58.909468565Z time="2020-04-16T12:02:58.882604120Z" 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-16T12:02:58.909472539Z time="2020-04-16T12:02:58.882626685Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.native"..." type=io.containerd.snapshotter.v1
2020-04-16T12:02:58.909475957Z time="2020-04-16T12:02:58.882732008Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.overlayfs"..." type=io.containerd.snapshotter.v1
2020-04-16T12:02:58.909479192Z time="2020-04-16T12:02:58.882864398Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.zfs"..." type=io.containerd.snapshotter.v1
2020-04-16T12:02:58.909482377Z time="2020-04-16T12:02:58.883129605Z" level=info msg="skip loading plugin "io.containerd.snapshotter.v1.zfs"..." type=io.containerd.snapshotter.v1
2020-04-16T12:02:58.909485629Z time="2020-04-16T12:02:58.883139870Z" level=info msg="loading plugin "io.containerd.metadata.v1.bolt"..." type=io.containerd.metadata.v1
2020-04-16T12:02:58.909499818Z time="2020-04-16T12:02:58.883193041Z" 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-16T12:02:58.909503881Z time="2020-04-16T12:02:58.883200593Z" 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-16T12:02:58.909507514Z time="2020-04-16T12:02:58.883206309Z" 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-16T12:02:58.909511346Z time="2020-04-16T12:02:58.890213069Z" level=info msg="loading plugin "io.containerd.differ.v1.walking"..." type=io.containerd.differ.v1
2020-04-16T12:02:58.909514717Z time="2020-04-16T12:02:58.890240808Z" level=info msg="loading plugin "io.containerd.gc.v1.scheduler"..." type=io.containerd.gc.v1
2020-04-16T12:02:58.909517931Z time="2020-04-16T12:02:58.890273743Z" level=info msg="loading plugin "io.containerd.service.v1.containers-service"..." type=io.containerd.service.v1
2020-04-16T12:02:58.909521147Z time="2020-04-16T12:02:58.890285231Z" level=info msg="loading plugin "io.containerd.service.v1.content-service"..." type=io.containerd.service.v1
2020-04-16T12:02:58.909524375Z time="2020-04-16T12:02:58.890295248Z" level=info msg="loading plugin "io.containerd.service.v1.diff-service"..." type=io.containerd.service.v1
2020-04-16T12:02:58.909527621Z time="2020-04-16T12:02:58.890306466Z" level=info msg="loading plugin "io.containerd.service.v1.images-service"..." type=io.containerd.service.v1
2020-04-16T12:02:58.909530779Z time="2020-04-16T12:02:58.890318780Z" level=info msg="loading plugin "io.containerd.service.v1.leases-service"..." type=io.containerd.service.v1
2020-04-16T12:02:58.909533904Z time="2020-04-16T12:02:58.890329519Z" level=info msg="loading plugin "io.containerd.service.v1.namespaces-service"..." type=io.containerd.service.v1
2020-04-16T12:02:58.909537154Z time="2020-04-16T12:02:58.890339337Z" level=info msg="loading plugin "io.containerd.service.v1.snapshots-service"..." type=io.containerd.service.v1
2020-04-16T12:02:58.909540653Z time="2020-04-16T12:02:58.890351718Z" level=info msg="loading plugin "io.containerd.runtime.v1.linux"..." type=io.containerd.runtime.v1
2020-04-16T12:02:58.909544214Z time="2020-04-16T12:02:58.890538046Z" level=info msg="loading plugin "io.containerd.runtime.v2.task"..." type=io.containerd.runtime.v2
2020-04-16T12:02:58.909547458Z time="2020-04-16T12:02:58.890638098Z" level=info msg="loading plugin "io.containerd.monitor.v1.cgroups"..." type=io.containerd.monitor.v1
2020-04-16T12:02:58.909550642Z time="2020-04-16T12:02:58.890954258Z" level=info msg="loading plugin "io.containerd.service.v1.tasks-service"..." type=io.containerd.service.v1
2020-04-16T12:02:58.909553895Z time="2020-04-16T12:02:58.890978565Z" level=info msg="loading plugin "io.containerd.internal.v1.restart"..." type=io.containerd.internal.v1
2020-04-16T12:02:58.909560378Z time="2020-04-16T12:02:58.891040204Z" level=info msg="loading plugin "io.containerd.grpc.v1.containers"..." type=io.containerd.grpc.v1
2020-04-16T12:02:58.909563651Z time="2020-04-16T12:02:58.891055746Z" level=info msg="loading plugin "io.containerd.grpc.v1.content"..." type=io.containerd.grpc.v1
2020-04-16T12:02:58.909566720Z time="2020-04-16T12:02:58.891067098Z" level=info msg="loading plugin "io.containerd.grpc.v1.diff"..." type=io.containerd.grpc.v1
2020-04-16T12:02:58.909570031Z time="2020-04-16T12:02:58.891078895Z" level=info msg="loading plugin "io.containerd.grpc.v1.events"..." type=io.containerd.grpc.v1
2020-04-16T12:02:58.909573173Z time="2020-04-16T12:02:58.891088695Z" level=info msg="loading plugin "io.containerd.grpc.v1.healthcheck"..." type=io.containerd.grpc.v1
2020-04-16T12:02:58.909576328Z time="2020-04-16T12:02:58.891098571Z" level=info msg="loading plugin "io.containerd.grpc.v1.images"..." type=io.containerd.grpc.v1
2020-04-16T12:02:58.909579441Z time="2020-04-16T12:02:58.891108012Z" level=info msg="loading plugin "io.containerd.grpc.v1.leases"..." type=io.containerd.grpc.v1
2020-04-16T12:02:58.909582537Z time="2020-04-16T12:02:58.891116771Z" level=info msg="loading plugin "io.containerd.grpc.v1.namespaces"..." type=io.containerd.grpc.v1
2020-04-16T12:02:58.909585682Z time="2020-04-16T12:02:58.891128206Z" level=info msg="loading plugin "io.containerd.internal.v1.opt"..." type=io.containerd.internal.v1
2020-04-16T12:02:58.909588819Z time="2020-04-16T12:02:58.891380183Z" level=info msg="loading plugin "io.containerd.grpc.v1.snapshots"..." type=io.containerd.grpc.v1
2020-04-16T12:02:58.909591981Z time="2020-04-16T12:02:58.891394611Z" level=info msg="loading plugin "io.containerd.grpc.v1.tasks"..." type=io.containerd.grpc.v1
2020-04-16T12:02:58.909595418Z time="2020-04-16T12:02:58.891404063Z" level=info msg="loading plugin "io.containerd.grpc.v1.version"..." type=io.containerd.grpc.v1
2020-04-16T12:02:58.909598724Z time="2020-04-16T12:02:58.891413776Z" level=info msg="loading plugin "io.containerd.grpc.v1.introspection"..." type=io.containerd.grpc.v1
2020-04-16T12:02:58.909601946Z time="2020-04-16T12:02:58.891617464Z" level=info msg=serving... address="/var/run/docker/containerd/containerd-debug.sock"
2020-04-16T12:02:58.909605077Z time="2020-04-16T12:02:58.891678505Z" level=info msg=serving... address="/var/run/docker/containerd/containerd.sock"
2020-04-16T12:02:58.909608165Z time="2020-04-16T12:02:58.891687989Z" level=info msg="containerd successfully booted in 0.037202s"
2020-04-16T12:02:58.909611206Z time="2020-04-16T12:02:58.906866008Z" level=info msg="Setting the storage driver from the $DOCKER_DRIVER environment variable (overlay2)"
2020-04-16T12:02:58.909614412Z time="2020-04-16T12:02:58.907091392Z" level=info msg="parsed scheme: \"unix\"" module=grpc
2020-04-16T12:02:58.909617736Z time="2020-04-16T12:02:58.907112972Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc
2020-04-16T12:02:58.909621215Z time="2020-04-16T12:02:58.907130445Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 <nil>}] <nil>}" module=grpc
2020-04-16T12:02:58.909627875Z time="2020-04-16T12:02:58.907140252Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc
2020-04-16T12:02:58.919373484Z time="2020-04-16T12:02:58.913297597Z" level=info msg="parsed scheme: \"unix\"" module=grpc
2020-04-16T12:02:58.919394901Z time="2020-04-16T12:02:58.913316506Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc
2020-04-16T12:02:58.919399429Z time="2020-04-16T12:02:58.913335612Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 <nil>}] <nil>}" module=grpc
2020-04-16T12:02:58.919403862Z time="2020-04-16T12:02:58.913344520Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc
2020-04-16T12:02:58.988402517Z time="2020-04-16T12:02:58.986971343Z" level=info msg="Loading containers: start."
2020-04-16T12:02:59.016607249Z time="2020-04-16T12:02:59.016471456Z" 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-16T12:02:59.118148110Z time="2020-04-16T12:02:59.116929915Z" 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-16T12:02:59.200253473Z time="2020-04-16T12:02:59.198801338Z" level=info msg="Loading containers: done."
2020-04-16T12:02:59.217737229Z time="2020-04-16T12:02:59.217342843Z" level=info msg="Docker daemon" commit=afacb8b7f0 graphdriver(s)=overlay2 version=19.03.8
2020-04-16T12:02:59.217755901Z time="2020-04-16T12:02:59.217483182Z" level=info msg="Daemon has completed initialization"
2020-04-16T12:02:59.249287425Z time="2020-04-16T12:02:59.249089480Z" level=info msg="API listen on [::]:2375"
2020-04-16T12:02:59.249312528Z time="2020-04-16T12:02:59.249164695Z" level=info msg="API listen on /var/run/docker.sock"
[0;33m*********[0;m
[0KPulling docker image docker:19.03.8 ...
[0;m[0KUsing docker image sha256:61b2e482e9de9ca3939dce4c90810c89fa7e7450f774590967c2908cba857ddd for docker:19.03.8 ...
[0;msection_end:1587038610:prepare_executor
[0Ksection_start:1587038610:prepare_script
[0K[0K[36;1mPreparing environment[0;m
[0;mRunning on runner-fa6cab46-project-4422333-concurrent-0 via runner-fa6cab46-stg-srm-1587038510-886b8e71...
section_end:1587038611:prepare_script
[0Ksection_start:1587038611: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/12750472 -> refs/pipelines/12750472
* [new branch] master -> origin/master
[32;1mChecking out a666adff as master...[0;m
[32;1mSkipping Git submodules setup[0;m
section_end:1587038613:get_sources
[0Ksection_start:1587038613:restore_cache
[0K[0K[36;1mRestoring cache[0;m
[0;msection_end:1587038614:restore_cache
[0Ksection_start:1587038614:download_artifacts
[0K[0K[36;1mDownloading artifacts[0;m
[0;msection_end:1587038616:download_artifacts
[0Ksection_start:1587038616: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:1587038875:build_script
[0Ksection_start:1587038875:after_script
[0K[0K[36;1mRunning after_script[0;m
[0;msection_end:1587038878:after_script
[0Ksection_start:1587038878:archive_cache
[0K[0K[36;1mSaving cache[0;m
[0;msection_end:1587038881:archive_cache
[0Ksection_start:1587038881: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=37160319 responseStatus[0;m=201 Created token[0;m=eM2X_krH
section_end:1587038883:upload_artifacts_on_success
[0K[32;1mJob succeeded
[0;m