[0KRunning with gitlab-runner 13.0.0-rc2 (926834bc)
[0;m[0K on docker-auto-scale fa6cab46
[0;msection_start:1589901003:prepare_executor
[0K[0K[36;1mPreparing the "docker+machine" executor[0;m
[0;m[0KUsing Docker executor with image registry.gitlab.com/gitlab-org/cluster-integration/auto-build-image:v0.2.2 ...
[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-d33c2caf7f79cb09-docker-0 probably didn't start properly.
Health check error:
service "runner-fa6cab46-project-4422333-concurrent-0-d33c2caf7f79cb09-docker-0-wait-for-service" timeout
Health check container logs:
Service container logs:
2020-05-19T15:11:10.942565857Z time="2020-05-19T15:11:10.912775443Z" level=info msg="Starting up"
2020-05-19T15:11:10.942635797Z time="2020-05-19T15:11:10.913950444Z" level=warning msg="could not change group /var/run/docker.sock to docker: group docker not found"
2020-05-19T15:11:10.942640774Z time="2020-05-19T15:11:10.914159921Z" level=warning msg="[!] DON'T BIND ON ANY IP ADDRESS WITHOUT setting --tlsverify IF YOU DON'T KNOW WHAT YOU'RE DOING [!]"
2020-05-19T15:11:10.942644211Z time="2020-05-19T15:11:10.914940525Z" level=info msg="libcontainerd: started new containerd process" pid=19
2020-05-19T15:11:10.942647523Z time="2020-05-19T15:11:10.914974115Z" level=info msg="parsed scheme: \"unix\"" module=grpc
2020-05-19T15:11:10.942650913Z time="2020-05-19T15:11:10.914981892Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc
2020-05-19T15:11:10.942654421Z time="2020-05-19T15:11:10.914998651Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 <nil>}] <nil>}" module=grpc
2020-05-19T15:11:10.942658543Z time="2020-05-19T15:11:10.915007061Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc
2020-05-19T15:11:10.958419916Z time="2020-05-19T15:11:10.950558226Z" level=info msg="starting containerd" revision=7ad184331fa3e55e52b890ea95e65ba581ae3429 version=v1.2.13
2020-05-19T15:11:10.958449858Z time="2020-05-19T15:11:10.950863552Z" level=info msg="loading plugin "io.containerd.content.v1.content"..." type=io.containerd.content.v1
2020-05-19T15:11:10.958454567Z time="2020-05-19T15:11:10.950937092Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.btrfs"..." type=io.containerd.snapshotter.v1
2020-05-19T15:11:10.958458951Z time="2020-05-19T15:11:10.951127341Z" 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-19T15:11:10.958465066Z time="2020-05-19T15:11:10.951139274Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.aufs"..." type=io.containerd.snapshotter.v1
2020-05-19T15:11:11.020395825Z time="2020-05-19T15:11:10.986887892Z" 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-19T15:11:11.020415563Z time="2020-05-19T15:11:10.986914452Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.native"..." type=io.containerd.snapshotter.v1
2020-05-19T15:11:11.020428591Z time="2020-05-19T15:11:10.987025069Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.overlayfs"..." type=io.containerd.snapshotter.v1
2020-05-19T15:11:11.020432295Z time="2020-05-19T15:11:10.987159160Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.zfs"..." type=io.containerd.snapshotter.v1
2020-05-19T15:11:11.020435919Z time="2020-05-19T15:11:10.987448434Z" level=info msg="skip loading plugin "io.containerd.snapshotter.v1.zfs"..." type=io.containerd.snapshotter.v1
2020-05-19T15:11:11.020439393Z time="2020-05-19T15:11:10.987458599Z" level=info msg="loading plugin "io.containerd.metadata.v1.bolt"..." type=io.containerd.metadata.v1
2020-05-19T15:11:11.020451772Z time="2020-05-19T15:11:10.987509725Z" 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-19T15:11:11.020455767Z time="2020-05-19T15:11:10.987516920Z" 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-19T15:11:11.020459586Z time="2020-05-19T15:11:10.987525128Z" 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-19T15:11:11.020463226Z time="2020-05-19T15:11:10.995868778Z" level=info msg="loading plugin "io.containerd.differ.v1.walking"..." type=io.containerd.differ.v1
2020-05-19T15:11:11.020467556Z time="2020-05-19T15:11:10.995898477Z" level=info msg="loading plugin "io.containerd.gc.v1.scheduler"..." type=io.containerd.gc.v1
2020-05-19T15:11:11.020470967Z time="2020-05-19T15:11:10.995923966Z" level=info msg="loading plugin "io.containerd.service.v1.containers-service"..." type=io.containerd.service.v1
2020-05-19T15:11:11.020474239Z time="2020-05-19T15:11:10.995936095Z" level=info msg="loading plugin "io.containerd.service.v1.content-service"..." type=io.containerd.service.v1
2020-05-19T15:11:11.020477522Z time="2020-05-19T15:11:10.995946794Z" level=info msg="loading plugin "io.containerd.service.v1.diff-service"..." type=io.containerd.service.v1
2020-05-19T15:11:11.020480700Z time="2020-05-19T15:11:10.995957843Z" level=info msg="loading plugin "io.containerd.service.v1.images-service"..." type=io.containerd.service.v1
2020-05-19T15:11:11.020487447Z time="2020-05-19T15:11:10.995969383Z" level=info msg="loading plugin "io.containerd.service.v1.leases-service"..." type=io.containerd.service.v1
2020-05-19T15:11:11.020490705Z time="2020-05-19T15:11:10.995980221Z" level=info msg="loading plugin "io.containerd.service.v1.namespaces-service"..." type=io.containerd.service.v1
2020-05-19T15:11:11.020493981Z time="2020-05-19T15:11:10.995989876Z" level=info msg="loading plugin "io.containerd.service.v1.snapshots-service"..." type=io.containerd.service.v1
2020-05-19T15:11:11.020497279Z time="2020-05-19T15:11:10.996001816Z" level=info msg="loading plugin "io.containerd.runtime.v1.linux"..." type=io.containerd.runtime.v1
2020-05-19T15:11:11.020500431Z time="2020-05-19T15:11:10.996256954Z" level=info msg="loading plugin "io.containerd.runtime.v2.task"..." type=io.containerd.runtime.v2
2020-05-19T15:11:11.020503614Z time="2020-05-19T15:11:10.996391292Z" level=info msg="loading plugin "io.containerd.monitor.v1.cgroups"..." type=io.containerd.monitor.v1
2020-05-19T15:11:11.020506759Z time="2020-05-19T15:11:10.996697241Z" level=info msg="loading plugin "io.containerd.service.v1.tasks-service"..." type=io.containerd.service.v1
2020-05-19T15:11:11.020510054Z time="2020-05-19T15:11:10.996723006Z" level=info msg="loading plugin "io.containerd.internal.v1.restart"..." type=io.containerd.internal.v1
2020-05-19T15:11:11.020516766Z time="2020-05-19T15:11:10.996758908Z" level=info msg="loading plugin "io.containerd.grpc.v1.containers"..." type=io.containerd.grpc.v1
2020-05-19T15:11:11.020520161Z time="2020-05-19T15:11:10.996769834Z" level=info msg="loading plugin "io.containerd.grpc.v1.content"..." type=io.containerd.grpc.v1
2020-05-19T15:11:11.020526030Z time="2020-05-19T15:11:10.996779860Z" level=info msg="loading plugin "io.containerd.grpc.v1.diff"..." type=io.containerd.grpc.v1
2020-05-19T15:11:11.020529461Z time="2020-05-19T15:11:10.996790071Z" level=info msg="loading plugin "io.containerd.grpc.v1.events"..." type=io.containerd.grpc.v1
2020-05-19T15:11:11.020532670Z time="2020-05-19T15:11:10.996799940Z" level=info msg="loading plugin "io.containerd.grpc.v1.healthcheck"..." type=io.containerd.grpc.v1
2020-05-19T15:11:11.020535941Z time="2020-05-19T15:11:10.996809947Z" level=info msg="loading plugin "io.containerd.grpc.v1.images"..." type=io.containerd.grpc.v1
2020-05-19T15:11:11.020539032Z time="2020-05-19T15:11:10.996819009Z" level=info msg="loading plugin "io.containerd.grpc.v1.leases"..." type=io.containerd.grpc.v1
2020-05-19T15:11:11.020542141Z time="2020-05-19T15:11:10.996827867Z" level=info msg="loading plugin "io.containerd.grpc.v1.namespaces"..." type=io.containerd.grpc.v1
2020-05-19T15:11:11.020545273Z time="2020-05-19T15:11:10.996837540Z" level=info msg="loading plugin "io.containerd.internal.v1.opt"..." type=io.containerd.internal.v1
2020-05-19T15:11:11.020548522Z time="2020-05-19T15:11:10.997071104Z" level=info msg="loading plugin "io.containerd.grpc.v1.snapshots"..." type=io.containerd.grpc.v1
2020-05-19T15:11:11.020551619Z time="2020-05-19T15:11:10.997084504Z" level=info msg="loading plugin "io.containerd.grpc.v1.tasks"..." type=io.containerd.grpc.v1
2020-05-19T15:11:11.020558239Z time="2020-05-19T15:11:10.997094508Z" level=info msg="loading plugin "io.containerd.grpc.v1.version"..." type=io.containerd.grpc.v1
2020-05-19T15:11:11.020561434Z time="2020-05-19T15:11:10.997103659Z" level=info msg="loading plugin "io.containerd.grpc.v1.introspection"..." type=io.containerd.grpc.v1
2020-05-19T15:11:11.020564654Z time="2020-05-19T15:11:10.997440004Z" level=info msg=serving... address="/var/run/docker/containerd/containerd-debug.sock"
2020-05-19T15:11:11.020567816Z time="2020-05-19T15:11:10.997540516Z" level=info msg=serving... address="/var/run/docker/containerd/containerd.sock"
2020-05-19T15:11:11.020570936Z time="2020-05-19T15:11:10.997550828Z" level=info msg="containerd successfully booted in 0.047634s"
2020-05-19T15:11:11.020573999Z time="2020-05-19T15:11:11.020270203Z" level=info msg="Setting the storage driver from the $DOCKER_DRIVER environment variable (overlay2)"
2020-05-19T15:11:11.024031497Z time="2020-05-19T15:11:11.023954817Z" level=info msg="parsed scheme: \"unix\"" module=grpc
2020-05-19T15:11:11.024114307Z time="2020-05-19T15:11:11.024064279Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc
2020-05-19T15:11:11.024228069Z time="2020-05-19T15:11:11.024176518Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 <nil>}] <nil>}" module=grpc
2020-05-19T15:11:11.024394130Z time="2020-05-19T15:11:11.024260822Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc
2020-05-19T15:11:11.055892426Z time="2020-05-19T15:11:11.054285468Z" level=info msg="parsed scheme: \"unix\"" module=grpc
2020-05-19T15:11:11.055909068Z time="2020-05-19T15:11:11.054438762Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc
2020-05-19T15:11:11.055913640Z time="2020-05-19T15:11:11.054483128Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 <nil>}] <nil>}" module=grpc
2020-05-19T15:11:11.055918259Z time="2020-05-19T15:11:11.054499999Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc
2020-05-19T15:11:11.108064613Z time="2020-05-19T15:11:11.107941678Z" level=info msg="Loading containers: start."
2020-05-19T15:11:11.134432629Z time="2020-05-19T15:11:11.132649982Z" 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-19T15:11:11.234470665Z time="2020-05-19T15:11:11.233092555Z" 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-19T15:11:11.304427434Z time="2020-05-19T15:11:11.303510738Z" level=info msg="Loading containers: done."
2020-05-19T15:11:11.339384715Z time="2020-05-19T15:11:11.338162102Z" level=info msg="Docker daemon" commit=afacb8b7f0 graphdriver(s)=overlay2 version=19.03.8
2020-05-19T15:11:11.340662892Z time="2020-05-19T15:11:11.338354854Z" level=info msg="Daemon has completed initialization"
2020-05-19T15:11:11.375756276Z time="2020-05-19T15:11:11.375398730Z" level=info msg="API listen on [::]:2375"
2020-05-19T15:11:11.375782991Z time="2020-05-19T15:11:11.375475857Z" level=info msg="API listen on /var/run/docker.sock"
[0;33m*********[0;m
[0KPulling docker image registry.gitlab.com/gitlab-org/cluster-integration/auto-build-image:v0.2.2 ...
[0;m[0KUsing docker image sha256:a9a470e7a925ecfd27cfbb60e98c0915f02a3eb8a81f15fb6b11af1baca21e63 for registry.gitlab.com/gitlab-org/cluster-integration/auto-build-image:v0.2.2 ...
[0;msection_end:1589901108:prepare_executor
[0Ksection_start:1589901108:prepare_script
[0K[0K[36;1mPreparing environment[0;m
[0;mRunning on runner-fa6cab46-project-4422333-concurrent-0 via runner-fa6cab46-stg-srm-1589901003-bcc81758...
section_end:1589901113:prepare_script
[0Ksection_start:1589901113: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/12775630 -> refs/pipelines/12775630
* [new branch] master -> origin/master
[32;1mChecking out 095035c5 as master...[0;m
[32;1mSkipping Git submodules setup[0;m
section_end:1589901115:get_sources
[0Ksection_start:1589901115:restore_cache
[0K[0K[36;1mRestoring cache[0;m
[0;msection_end:1589901116:restore_cache
[0Ksection_start:1589901116:download_artifacts
[0K[0K[36;1mDownloading artifacts[0;m
[0;msection_end:1589901118:download_artifacts
[0Ksection_start:1589901118:build_script
[0K[0K[36;1mRunning before_script and script[0;m
[0;m[32;1m$ if [[ -z "$CI_COMMIT_TAG" ]]; then # collapsed multi-line command[0;m
[32;1m$ /build/build.sh[0;m
Logging to GitLab Container Registry with CI credentials...
WARNING! Your password will be stored unencrypted in /root/.docker/config.json.
Configure a credential helper to remove this warning. See
https://docs.docker.com/engine/reference/commandline/login/#credentials-store
Login Succeeded
Building Dockerfile-based application...
d94b49097fe078dfb3f04e6a6e8c515840bfba9b: Pulling from gitlab-org/monitor/monitor-sandbox/master
a073c86ecf9e: Pulling fs layer
db7179d8c6cd: Pulling fs layer
66b9cfaecc8c: Pulling fs layer
a4d4613b850e: Pulling fs layer
5fb493aa739b: Pulling fs layer
8b7e2ad468ac: Pulling fs layer
aad75df1fcf5: Pulling fs layer
a4d4613b850e: Waiting
5fb493aa739b: Waiting
8b7e2ad468ac: Waiting
aad75df1fcf5: Waiting
66b9cfaecc8c: Verifying Checksum
66b9cfaecc8c: Download complete
a073c86ecf9e: Verifying Checksum
a073c86ecf9e: Download complete
a4d4613b850e: Verifying Checksum
a4d4613b850e: Download complete
a073c86ecf9e: Pull complete
5fb493aa739b: Verifying Checksum
5fb493aa739b: Download complete
aad75df1fcf5: Verifying Checksum
aad75df1fcf5: Download complete
db7179d8c6cd: Verifying Checksum
db7179d8c6cd: Download complete
8b7e2ad468ac: Verifying Checksum
8b7e2ad468ac: Download complete
db7179d8c6cd: Pull complete
66b9cfaecc8c: Pull complete
a4d4613b850e: Pull complete
5fb493aa739b: Pull complete
8b7e2ad468ac: Pull complete
aad75df1fcf5: Pull complete
Digest: sha256:b37cce00829b920213db529f4391569c47dd0b499d28992917c613a7d7b363c4
Status: Downloaded newer image for registry.staging.gitlab.com/gitlab-org/monitor/monitor-sandbox/master:d94b49097fe078dfb3f04e6a6e8c515840bfba9b
registry.staging.gitlab.com/gitlab-org/monitor/monitor-sandbox/master:d94b49097fe078dfb3f04e6a6e8c515840bfba9b
Sending build context to Docker daemon 129kB
Step 1/10 : FROM node:8.11-alpine
8.11-alpine: Pulling from library/node
a073c86ecf9e: Already exists
db7179d8c6cd: Already exists
66b9cfaecc8c: Already exists
Digest: sha256:1c38d992f89ae389450bc69799a0f2b7d1f9f2e6c445080a4648448e6449e8e4
Status: Downloaded newer image for node:8.11-alpine
---> 8adf3c3eb26c
Step 2/10 : WORKDIR /usr/src/app
---> Using cache
---> 9ffc10101b6d
Step 3/10 : ARG NODE_ENV
---> Using cache
---> 58491792d55b
Step 4/10 : ENV NODE_ENV $NODE_ENV
---> Using cache
---> e163079ca2da
Step 5/10 : COPY package.json /usr/src/app/
---> Using cache
---> 3e0281a9ff8b
Step 6/10 : RUN npm install
---> Using cache
---> 3ac96b57d1bc
Step 7/10 : COPY . /usr/src/app
---> 9a28d18661ed
Step 8/10 : ENV PORT 5000
---> Running in be762c3c4dce
Removing intermediate container be762c3c4dce
---> dc241ae48eb4
Step 9/10 : EXPOSE $PORT
---> Running in d34d026001ae
Removing intermediate container d34d026001ae
---> 31b5c07a1547
Step 10/10 : CMD [ "npm", "start" ]
---> Running in 08f4ab0cc9d6
Removing intermediate container 08f4ab0cc9d6
---> e2e26c366203
[Warning] One or more build-args [BUILDPACK_URL] were not consumed
Successfully built e2e26c366203
Successfully tagged registry.staging.gitlab.com/gitlab-org/monitor/monitor-sandbox/master:095035c511e06b8d6f071c5cc48d9d42d32a66e1
Successfully tagged registry.staging.gitlab.com/gitlab-org/monitor/monitor-sandbox/master:latest
The push refers to repository [registry.staging.gitlab.com/gitlab-org/monitor/monitor-sandbox/master]
d04e16db559a: Preparing
8ddc9e599f93: Preparing
a85ff65fd061: Preparing
eaba38c532c6: Preparing
d35df9c923f8: Preparing
a7d484df787a: Preparing
8dfad2055603: Preparing
a7d484df787a: Waiting
8dfad2055603: Waiting
d35df9c923f8: Layer already exists
a85ff65fd061: Layer already exists
eaba38c532c6: Layer already exists
8ddc9e599f93: Layer already exists
a7d484df787a: Layer already exists
8dfad2055603: Layer already exists
d04e16db559a: Pushed
095035c511e06b8d6f071c5cc48d9d42d32a66e1: digest: sha256:f97564b9b56af29ba2e3b307f3a21815e18c6a070e9802d7ecf74d00ce17f27e size: 1785
The push refers to repository [registry.staging.gitlab.com/gitlab-org/monitor/monitor-sandbox/master]
d04e16db559a: Preparing
8ddc9e599f93: Preparing
a85ff65fd061: Preparing
eaba38c532c6: Preparing
d35df9c923f8: Preparing
a7d484df787a: Preparing
8dfad2055603: Preparing
a7d484df787a: Waiting
8dfad2055603: Waiting
d35df9c923f8: Layer already exists
8ddc9e599f93: Layer already exists
a85ff65fd061: Layer already exists
d04e16db559a: Layer already exists
eaba38c532c6: Layer already exists
a7d484df787a: Layer already exists
8dfad2055603: Layer already exists
latest: digest: sha256:f97564b9b56af29ba2e3b307f3a21815e18c6a070e9802d7ecf74d00ce17f27e size: 1785
section_end:1589901136:build_script
[0Ksection_start:1589901136:after_script
[0K[0K[36;1mRunning after_script[0;m
[0;msection_end:1589901137:after_script
[0Ksection_start:1589901137:archive_cache
[0K[0K[36;1mSaving cache[0;m
[0;msection_end:1589901139:archive_cache
[0Ksection_start:1589901139:upload_artifacts_on_success
[0K[0K[36;1mUploading artifacts for successful job[0;m
[0;msection_end:1589901140:upload_artifacts_on_success
[0K[32;1mJob succeeded
[0;m