[0KRunning with gitlab-runner 13.0.0-rc2 (926834bc)
[0;m[0K on docker-auto-scale fa6cab46
[0;msection_start:1589920218: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:c814ba3a41a3de0a9a23b7d0bb36f64257b12aef5103b4ce1d5f1bfc3033aad3 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-5ddce430cad0d60d-docker-0 probably didn't start properly.
Health check error:
service "runner-fa6cab46-project-4422333-concurrent-0-5ddce430cad0d60d-docker-0-wait-for-service" timeout
Health check container logs:
Service container logs:
2020-05-19T20:31:30.372187718Z time="2020-05-19T20:31:30.341988849Z" level=info msg="Starting up"
2020-05-19T20:31:30.372248043Z time="2020-05-19T20:31:30.344104985Z" level=warning msg="could not change group /var/run/docker.sock to docker: group docker not found"
2020-05-19T20:31:30.372252588Z time="2020-05-19T20:31:30.344374596Z" level=warning msg="[!] DON'T BIND ON ANY IP ADDRESS WITHOUT setting --tlsverify IF YOU DON'T KNOW WHAT YOU'RE DOING [!]"
2020-05-19T20:31:30.372263385Z time="2020-05-19T20:31:30.345400671Z" level=info msg="libcontainerd: started new containerd process" pid=18
2020-05-19T20:31:30.372268061Z time="2020-05-19T20:31:30.345437207Z" level=info msg="parsed scheme: \"unix\"" module=grpc
2020-05-19T20:31:30.372271567Z time="2020-05-19T20:31:30.345445557Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc
2020-05-19T20:31:30.372275086Z time="2020-05-19T20:31:30.345462907Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 <nil>}] <nil>}" module=grpc
2020-05-19T20:31:30.372279245Z time="2020-05-19T20:31:30.345471444Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc
2020-05-19T20:31:30.393050962Z time="2020-05-19T20:31:30.383578811Z" level=info msg="starting containerd" revision=7ad184331fa3e55e52b890ea95e65ba581ae3429 version=v1.2.13
2020-05-19T20:31:30.393121662Z time="2020-05-19T20:31:30.383907654Z" level=info msg="loading plugin "io.containerd.content.v1.content"..." type=io.containerd.content.v1
2020-05-19T20:31:30.393127428Z time="2020-05-19T20:31:30.384831311Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.btrfs"..." type=io.containerd.snapshotter.v1
2020-05-19T20:31:30.393132230Z time="2020-05-19T20:31:30.386099564Z" 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-05-19T20:31:30.393138910Z time="2020-05-19T20:31:30.386117365Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.aufs"..." type=io.containerd.snapshotter.v1
2020-05-19T20:31:30.453778717Z time="2020-05-19T20:31:30.421729818Z" 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-05-19T20:31:30.453812278Z time="2020-05-19T20:31:30.421769775Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.native"..." type=io.containerd.snapshotter.v1
2020-05-19T20:31:30.453817130Z time="2020-05-19T20:31:30.421912533Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.overlayfs"..." type=io.containerd.snapshotter.v1
2020-05-19T20:31:30.453820821Z time="2020-05-19T20:31:30.422109018Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.zfs"..." type=io.containerd.snapshotter.v1
2020-05-19T20:31:30.453824234Z time="2020-05-19T20:31:30.422391257Z" level=info msg="skip loading plugin "io.containerd.snapshotter.v1.zfs"..." type=io.containerd.snapshotter.v1
2020-05-19T20:31:30.453827575Z time="2020-05-19T20:31:30.422400868Z" level=info msg="loading plugin "io.containerd.metadata.v1.bolt"..." type=io.containerd.metadata.v1
2020-05-19T20:31:30.453840529Z time="2020-05-19T20:31:30.422446125Z" 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-05-19T20:31:30.453844391Z time="2020-05-19T20:31:30.422466721Z" 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-05-19T20:31:30.453848117Z time="2020-05-19T20:31:30.422472405Z" 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-05-19T20:31:30.453851965Z time="2020-05-19T20:31:30.431215440Z" level=info msg="loading plugin "io.containerd.differ.v1.walking"..." type=io.containerd.differ.v1
2020-05-19T20:31:30.453856255Z time="2020-05-19T20:31:30.431245661Z" level=info msg="loading plugin "io.containerd.gc.v1.scheduler"..." type=io.containerd.gc.v1
2020-05-19T20:31:30.453859441Z time="2020-05-19T20:31:30.431292273Z" level=info msg="loading plugin "io.containerd.service.v1.containers-service"..." type=io.containerd.service.v1
2020-05-19T20:31:30.453862784Z time="2020-05-19T20:31:30.431304821Z" level=info msg="loading plugin "io.containerd.service.v1.content-service"..." type=io.containerd.service.v1
2020-05-19T20:31:30.453865970Z time="2020-05-19T20:31:30.431315516Z" level=info msg="loading plugin "io.containerd.service.v1.diff-service"..." type=io.containerd.service.v1
2020-05-19T20:31:30.453869227Z time="2020-05-19T20:31:30.431327191Z" level=info msg="loading plugin "io.containerd.service.v1.images-service"..." type=io.containerd.service.v1
2020-05-19T20:31:30.453878979Z time="2020-05-19T20:31:30.431350852Z" level=info msg="loading plugin "io.containerd.service.v1.leases-service"..." type=io.containerd.service.v1
2020-05-19T20:31:30.453882290Z time="2020-05-19T20:31:30.431362859Z" level=info msg="loading plugin "io.containerd.service.v1.namespaces-service"..." type=io.containerd.service.v1
2020-05-19T20:31:30.453885529Z time="2020-05-19T20:31:30.431373108Z" level=info msg="loading plugin "io.containerd.service.v1.snapshots-service"..." type=io.containerd.service.v1
2020-05-19T20:31:30.453888883Z time="2020-05-19T20:31:30.431386054Z" level=info msg="loading plugin "io.containerd.runtime.v1.linux"..." type=io.containerd.runtime.v1
2020-05-19T20:31:30.453892088Z time="2020-05-19T20:31:30.431620689Z" level=info msg="loading plugin "io.containerd.runtime.v2.task"..." type=io.containerd.runtime.v2
2020-05-19T20:31:30.453895324Z time="2020-05-19T20:31:30.431780711Z" level=info msg="loading plugin "io.containerd.monitor.v1.cgroups"..." type=io.containerd.monitor.v1
2020-05-19T20:31:30.453898436Z time="2020-05-19T20:31:30.432218810Z" level=info msg="loading plugin "io.containerd.service.v1.tasks-service"..." type=io.containerd.service.v1
2020-05-19T20:31:30.453901775Z time="2020-05-19T20:31:30.432259190Z" level=info msg="loading plugin "io.containerd.internal.v1.restart"..." type=io.containerd.internal.v1
2020-05-19T20:31:30.453908112Z time="2020-05-19T20:31:30.432309509Z" level=info msg="loading plugin "io.containerd.grpc.v1.containers"..." type=io.containerd.grpc.v1
2020-05-19T20:31:30.453911402Z time="2020-05-19T20:31:30.432333851Z" level=info msg="loading plugin "io.containerd.grpc.v1.content"..." type=io.containerd.grpc.v1
2020-05-19T20:31:30.453914832Z time="2020-05-19T20:31:30.432344404Z" level=info msg="loading plugin "io.containerd.grpc.v1.diff"..." type=io.containerd.grpc.v1
2020-05-19T20:31:30.453918080Z time="2020-05-19T20:31:30.432355673Z" level=info msg="loading plugin "io.containerd.grpc.v1.events"..." type=io.containerd.grpc.v1
2020-05-19T20:31:30.453921262Z time="2020-05-19T20:31:30.432365577Z" level=info msg="loading plugin "io.containerd.grpc.v1.healthcheck"..." type=io.containerd.grpc.v1
2020-05-19T20:31:30.453924405Z time="2020-05-19T20:31:30.432375944Z" level=info msg="loading plugin "io.containerd.grpc.v1.images"..." type=io.containerd.grpc.v1
2020-05-19T20:31:30.453928772Z time="2020-05-19T20:31:30.432385506Z" level=info msg="loading plugin "io.containerd.grpc.v1.leases"..." type=io.containerd.grpc.v1
2020-05-19T20:31:30.453932007Z time="2020-05-19T20:31:30.432405696Z" level=info msg="loading plugin "io.containerd.grpc.v1.namespaces"..." type=io.containerd.grpc.v1
2020-05-19T20:31:30.453935179Z time="2020-05-19T20:31:30.432416185Z" level=info msg="loading plugin "io.containerd.internal.v1.opt"..." type=io.containerd.internal.v1
2020-05-19T20:31:30.453938428Z time="2020-05-19T20:31:30.432724430Z" level=info msg="loading plugin "io.containerd.grpc.v1.snapshots"..." type=io.containerd.grpc.v1
2020-05-19T20:31:30.455103662Z time="2020-05-19T20:31:30.432740259Z" level=info msg="loading plugin "io.containerd.grpc.v1.tasks"..." type=io.containerd.grpc.v1
2020-05-19T20:31:30.455109676Z time="2020-05-19T20:31:30.432750939Z" level=info msg="loading plugin "io.containerd.grpc.v1.version"..." type=io.containerd.grpc.v1
2020-05-19T20:31:30.455113312Z time="2020-05-19T20:31:30.432760172Z" level=info msg="loading plugin "io.containerd.grpc.v1.introspection"..." type=io.containerd.grpc.v1
2020-05-19T20:31:30.455116765Z time="2020-05-19T20:31:30.433028612Z" level=info msg=serving... address="/var/run/docker/containerd/containerd-debug.sock"
2020-05-19T20:31:30.455120238Z time="2020-05-19T20:31:30.433104101Z" level=info msg=serving... address="/var/run/docker/containerd/containerd.sock"
2020-05-19T20:31:30.455123421Z time="2020-05-19T20:31:30.433114580Z" level=info msg="containerd successfully booted in 0.050186s"
2020-05-19T20:31:30.455126457Z time="2020-05-19T20:31:30.441346705Z" level=info msg="Setting the storage driver from the $DOCKER_DRIVER environment variable (overlay2)"
2020-05-19T20:31:30.455129818Z time="2020-05-19T20:31:30.441549596Z" level=info msg="parsed scheme: \"unix\"" module=grpc
2020-05-19T20:31:30.455135567Z time="2020-05-19T20:31:30.441563455Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc
2020-05-19T20:31:30.455139027Z time="2020-05-19T20:31:30.441601562Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 <nil>}] <nil>}" module=grpc
2020-05-19T20:31:30.455158972Z time="2020-05-19T20:31:30.441610769Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc
2020-05-19T20:31:30.455180230Z time="2020-05-19T20:31:30.454216730Z" level=info msg="parsed scheme: \"unix\"" module=grpc
2020-05-19T20:31:30.455183916Z time="2020-05-19T20:31:30.454236441Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc
2020-05-19T20:31:30.455187143Z time="2020-05-19T20:31:30.454254304Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 <nil>}] <nil>}" module=grpc
2020-05-19T20:31:30.455190748Z time="2020-05-19T20:31:30.454264547Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc
2020-05-19T20:31:30.530617765Z time="2020-05-19T20:31:30.530497220Z" level=info msg="Loading containers: start."
2020-05-19T20:31:30.552735804Z time="2020-05-19T20:31:30.552593416Z" 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-05-19T20:31:30.655058875Z time="2020-05-19T20:31:30.653499768Z" 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-05-19T20:31:30.733071310Z time="2020-05-19T20:31:30.731494175Z" level=info msg="Loading containers: done."
2020-05-19T20:31:30.759155173Z time="2020-05-19T20:31:30.758704315Z" level=info msg="Docker daemon" commit=afacb8b7f0 graphdriver(s)=overlay2 version=19.03.8
2020-05-19T20:31:30.759204850Z time="2020-05-19T20:31:30.758882628Z" level=info msg="Daemon has completed initialization"
2020-05-19T20:31:30.807252043Z time="2020-05-19T20:31:30.807028365Z" level=info msg="API listen on [::]:2375"
2020-05-19T20:31:30.807291349Z time="2020-05-19T20:31:30.807119650Z" 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:5cfd4d13e0a8e4b9681447772c9df4864ac5d935abced4535f2ff670a73f2939 for docker:19.03.8 ...
[0;msection_end:1589920321:prepare_executor
[0Ksection_start:1589920321:prepare_script
[0K[0K[36;1mPreparing environment[0;m
[0;mRunning on runner-fa6cab46-project-4422333-concurrent-0 via runner-fa6cab46-stg-srm-1589920218-5108ddfd...
section_end:1589920323:prepare_script
[0Ksection_start:1589920323: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://ci-api.gstg.gitlab.net/gitlab-org/monitor/monitor-sandbox
* [new ref] refs/pipelines/12775753 -> refs/pipelines/12775753
* [new branch] master -> origin/master
[32;1mChecking out 095035c5 as master...[0;m
[32;1mSkipping Git submodules setup[0;m
section_end:1589920324:get_sources
[0Ksection_start:1589920324:restore_cache
[0K[0K[36;1mRestoring cache[0;m
[0;msection_end:1589920326:restore_cache
[0Ksection_start:1589920326:download_artifacts
[0K[0K[36;1mDownloading artifacts[0;m
[0;msection_end:1589920327:download_artifacts
[0Ksection_start:1589920327: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:1589920587:build_script
[0Ksection_start:1589920587:after_script
[0K[0K[36;1mRunning after_script[0;m
[0;msection_end:1589920591:after_script
[0Ksection_start:1589920591:archive_cache
[0K[0K[36;1mSaving cache[0;m
[0;msection_end:1589920593:archive_cache
[0Ksection_start:1589920593: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=37223771 responseStatus[0;m=201 Created token[0;m=en6n8j4d
section_end:1589920595:upload_artifacts_on_success
[0K[32;1mJob succeeded
[0;m