[0KRunning with gitlab-runner 13.0.0 (c127439c)
[0;m[0K on docker-auto-scale fa6cab46
[0;msection_start:1590657891: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-550c3ab66dadd6a2-docker-0 probably didn't start properly.
Health check error:
service "runner-fa6cab46-project-4422333-concurrent-0-550c3ab66dadd6a2-docker-0-wait-for-service" timeout
Health check container logs:
Service container logs:
2020-05-28T09:25:59.314334756Z time="2020-05-28T09:25:59.284224213Z" level=info msg="Starting up"
2020-05-28T09:25:59.314400492Z time="2020-05-28T09:25:59.285358786Z" level=warning msg="could not change group /var/run/docker.sock to docker: group docker not found"
2020-05-28T09:25:59.314405422Z time="2020-05-28T09:25:59.285549027Z" level=warning msg="[!] DON'T BIND ON ANY IP ADDRESS WITHOUT setting --tlsverify IF YOU DON'T KNOW WHAT YOU'RE DOING [!]"
2020-05-28T09:25:59.314409121Z time="2020-05-28T09:25:59.286347887Z" level=info msg="libcontainerd: started new containerd process" pid=20
2020-05-28T09:25:59.314412601Z time="2020-05-28T09:25:59.286396004Z" level=info msg="parsed scheme: \"unix\"" module=grpc
2020-05-28T09:25:59.314416456Z time="2020-05-28T09:25:59.286403806Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc
2020-05-28T09:25:59.314419993Z time="2020-05-28T09:25:59.286420076Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 <nil>}] <nil>}" module=grpc
2020-05-28T09:25:59.314424277Z time="2020-05-28T09:25:59.286428455Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc
2020-05-28T09:25:59.324820306Z time="2020-05-28T09:25:59.322620567Z" level=info msg="starting containerd" revision=7ad184331fa3e55e52b890ea95e65ba581ae3429 version=v1.2.13
2020-05-28T09:25:59.324838678Z time="2020-05-28T09:25:59.322949918Z" level=info msg="loading plugin "io.containerd.content.v1.content"..." type=io.containerd.content.v1
2020-05-28T09:25:59.324843035Z time="2020-05-28T09:25:59.323036258Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.btrfs"..." type=io.containerd.snapshotter.v1
2020-05-28T09:25:59.324856008Z time="2020-05-28T09:25:59.323362153Z" 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-28T09:25:59.324862644Z time="2020-05-28T09:25:59.323381351Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.aufs"..." type=io.containerd.snapshotter.v1
2020-05-28T09:25:59.337146663Z time="2020-05-28T09:25:59.334610403Z" 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-28T09:25:59.340201269Z time="2020-05-28T09:25:59.334641660Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.native"..." type=io.containerd.snapshotter.v1
2020-05-28T09:25:59.340226521Z time="2020-05-28T09:25:59.334765316Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.overlayfs"..." type=io.containerd.snapshotter.v1
2020-05-28T09:25:59.340231352Z time="2020-05-28T09:25:59.334901259Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.zfs"..." type=io.containerd.snapshotter.v1
2020-05-28T09:25:59.340235086Z time="2020-05-28T09:25:59.335105400Z" level=info msg="skip loading plugin "io.containerd.snapshotter.v1.zfs"..." type=io.containerd.snapshotter.v1
2020-05-28T09:25:59.340238818Z time="2020-05-28T09:25:59.335113951Z" level=info msg="loading plugin "io.containerd.metadata.v1.bolt"..." type=io.containerd.metadata.v1
2020-05-28T09:25:59.340250662Z time="2020-05-28T09:25:59.335151236Z" 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-28T09:25:59.340255082Z time="2020-05-28T09:25:59.335160037Z" 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-28T09:25:59.340258917Z time="2020-05-28T09:25:59.335165442Z" 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-28T09:25:59.388051757Z time="2020-05-28T09:25:59.362545407Z" level=info msg="loading plugin "io.containerd.differ.v1.walking"..." type=io.containerd.differ.v1
2020-05-28T09:25:59.388071807Z time="2020-05-28T09:25:59.362584156Z" level=info msg="loading plugin "io.containerd.gc.v1.scheduler"..." type=io.containerd.gc.v1
2020-05-28T09:25:59.388076498Z time="2020-05-28T09:25:59.362610948Z" level=info msg="loading plugin "io.containerd.service.v1.containers-service"..." type=io.containerd.service.v1
2020-05-28T09:25:59.388080234Z time="2020-05-28T09:25:59.362622824Z" level=info msg="loading plugin "io.containerd.service.v1.content-service"..." type=io.containerd.service.v1
2020-05-28T09:25:59.388084071Z time="2020-05-28T09:25:59.362633329Z" level=info msg="loading plugin "io.containerd.service.v1.diff-service"..." type=io.containerd.service.v1
2020-05-28T09:25:59.388087644Z time="2020-05-28T09:25:59.362644182Z" level=info msg="loading plugin "io.containerd.service.v1.images-service"..." type=io.containerd.service.v1
2020-05-28T09:25:59.388091177Z time="2020-05-28T09:25:59.362654978Z" level=info msg="loading plugin "io.containerd.service.v1.leases-service"..." type=io.containerd.service.v1
2020-05-28T09:25:59.388094497Z time="2020-05-28T09:25:59.362665426Z" level=info msg="loading plugin "io.containerd.service.v1.namespaces-service"..." type=io.containerd.service.v1
2020-05-28T09:25:59.388097994Z time="2020-05-28T09:25:59.362675167Z" level=info msg="loading plugin "io.containerd.service.v1.snapshots-service"..." type=io.containerd.service.v1
2020-05-28T09:25:59.388101342Z time="2020-05-28T09:25:59.362687719Z" level=info msg="loading plugin "io.containerd.runtime.v1.linux"..." type=io.containerd.runtime.v1
2020-05-28T09:25:59.388104817Z time="2020-05-28T09:25:59.362879971Z" level=info msg="loading plugin "io.containerd.runtime.v2.task"..." type=io.containerd.runtime.v2
2020-05-28T09:25:59.388108151Z time="2020-05-28T09:25:59.362977979Z" level=info msg="loading plugin "io.containerd.monitor.v1.cgroups"..." type=io.containerd.monitor.v1
2020-05-28T09:25:59.388111574Z time="2020-05-28T09:25:59.363309057Z" level=info msg="loading plugin "io.containerd.service.v1.tasks-service"..." type=io.containerd.service.v1
2020-05-28T09:25:59.388114940Z time="2020-05-28T09:25:59.363334628Z" level=info msg="loading plugin "io.containerd.internal.v1.restart"..." type=io.containerd.internal.v1
2020-05-28T09:25:59.388134600Z time="2020-05-28T09:25:59.363368664Z" level=info msg="loading plugin "io.containerd.grpc.v1.containers"..." type=io.containerd.grpc.v1
2020-05-28T09:25:59.388138398Z time="2020-05-28T09:25:59.363381390Z" level=info msg="loading plugin "io.containerd.grpc.v1.content"..." type=io.containerd.grpc.v1
2020-05-28T09:25:59.388141823Z time="2020-05-28T09:25:59.363391147Z" level=info msg="loading plugin "io.containerd.grpc.v1.diff"..." type=io.containerd.grpc.v1
2020-05-28T09:25:59.388145231Z time="2020-05-28T09:25:59.363400555Z" level=info msg="loading plugin "io.containerd.grpc.v1.events"..." type=io.containerd.grpc.v1
2020-05-28T09:25:59.388148579Z time="2020-05-28T09:25:59.363409672Z" level=info msg="loading plugin "io.containerd.grpc.v1.healthcheck"..." type=io.containerd.grpc.v1
2020-05-28T09:25:59.388151982Z time="2020-05-28T09:25:59.363419813Z" level=info msg="loading plugin "io.containerd.grpc.v1.images"..." type=io.containerd.grpc.v1
2020-05-28T09:25:59.388155535Z time="2020-05-28T09:25:59.363430164Z" level=info msg="loading plugin "io.containerd.grpc.v1.leases"..." type=io.containerd.grpc.v1
2020-05-28T09:25:59.388158897Z time="2020-05-28T09:25:59.363460238Z" level=info msg="loading plugin "io.containerd.grpc.v1.namespaces"..." type=io.containerd.grpc.v1
2020-05-28T09:25:59.388162361Z time="2020-05-28T09:25:59.363471740Z" level=info msg="loading plugin "io.containerd.internal.v1.opt"..." type=io.containerd.internal.v1
2020-05-28T09:25:59.388165752Z time="2020-05-28T09:25:59.363708765Z" level=info msg="loading plugin "io.containerd.grpc.v1.snapshots"..." type=io.containerd.grpc.v1
2020-05-28T09:25:59.388169211Z time="2020-05-28T09:25:59.363722594Z" level=info msg="loading plugin "io.containerd.grpc.v1.tasks"..." type=io.containerd.grpc.v1
2020-05-28T09:25:59.388172508Z time="2020-05-28T09:25:59.363732446Z" level=info msg="loading plugin "io.containerd.grpc.v1.version"..." type=io.containerd.grpc.v1
2020-05-28T09:25:59.388175899Z time="2020-05-28T09:25:59.363742183Z" level=info msg="loading plugin "io.containerd.grpc.v1.introspection"..." type=io.containerd.grpc.v1
2020-05-28T09:25:59.388179306Z time="2020-05-28T09:25:59.363934419Z" level=info msg=serving... address="/var/run/docker/containerd/containerd-debug.sock"
2020-05-28T09:25:59.388182730Z time="2020-05-28T09:25:59.363989035Z" level=info msg=serving... address="/var/run/docker/containerd/containerd.sock"
2020-05-28T09:25:59.388186034Z time="2020-05-28T09:25:59.364000124Z" level=info msg="containerd successfully booted in 0.042092s"
2020-05-28T09:25:59.388189627Z time="2020-05-28T09:25:59.380955531Z" level=info msg="Setting the storage driver from the $DOCKER_DRIVER environment variable (overlay2)"
2020-05-28T09:25:59.388193131Z time="2020-05-28T09:25:59.382632431Z" level=info msg="parsed scheme: \"unix\"" module=grpc
2020-05-28T09:25:59.388196652Z time="2020-05-28T09:25:59.382659496Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc
2020-05-28T09:25:59.388200241Z time="2020-05-28T09:25:59.382678589Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 <nil>}] <nil>}" module=grpc
2020-05-28T09:25:59.388206838Z time="2020-05-28T09:25:59.382707265Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc
2020-05-28T09:25:59.391481581Z time="2020-05-28T09:25:59.389706336Z" level=info msg="parsed scheme: \"unix\"" module=grpc
2020-05-28T09:25:59.392593984Z time="2020-05-28T09:25:59.389725867Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc
2020-05-28T09:25:59.392605357Z time="2020-05-28T09:25:59.389752880Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 <nil>}] <nil>}" module=grpc
2020-05-28T09:25:59.392610237Z time="2020-05-28T09:25:59.389763615Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc
2020-05-28T09:25:59.460559964Z time="2020-05-28T09:25:59.460122464Z" level=info msg="Loading containers: start."
2020-05-28T09:25:59.479686799Z time="2020-05-28T09:25:59.479562004Z" 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-28T09:25:59.576208679Z time="2020-05-28T09:25:59.573931121Z" 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-28T09:25:59.649758699Z time="2020-05-28T09:25:59.648002853Z" level=info msg="Loading containers: done."
2020-05-28T09:25:59.664320105Z time="2020-05-28T09:25:59.663972341Z" level=info msg="Docker daemon" commit=afacb8b7f0 graphdriver(s)=overlay2 version=19.03.8
2020-05-28T09:25:59.664338250Z time="2020-05-28T09:25:59.664109571Z" level=info msg="Daemon has completed initialization"
2020-05-28T09:25:59.696343450Z time="2020-05-28T09:25:59.696121579Z" level=info msg="API listen on [::]:2375"
2020-05-28T09:25:59.696369034Z time="2020-05-28T09:25:59.696199142Z" 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:1590657996:prepare_executor
[0Ksection_start:1590657996:prepare_script
[0K[0K[36;1mPreparing environment[0;m
[0;mRunning on runner-fa6cab46-project-4422333-concurrent-0 via runner-fa6cab46-stg-srm-1590657891-fe58071b...
section_end:1590658001:prepare_script
[0Ksection_start:1590658001: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/12778258 -> refs/pipelines/12778258
* [new branch] master -> origin/master
[32;1mChecking out 1628bb31 as master...[0;m
[32;1mSkipping Git submodules setup[0;m
section_end:1590658003:get_sources
[0Ksection_start:1590658003:restore_cache
[0K[0K[36;1mRestoring cache[0;m
[0;msection_end:1590658004:restore_cache
[0Ksection_start:1590658004:download_artifacts
[0K[0K[36;1mDownloading artifacts[0;m
[0;msection_end:1590658006:download_artifacts
[0Ksection_start:1590658006: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...
fc8a8b6eab8e311da328b6b746c9df9a3b4da710: 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
eedb53e41e40: Pulling fs layer
a4d4613b850e: Waiting
5fb493aa739b: Waiting
8b7e2ad468ac: Waiting
eedb53e41e40: Waiting
a073c86ecf9e: Verifying Checksum
a073c86ecf9e: Download complete
66b9cfaecc8c: Verifying Checksum
66b9cfaecc8c: Download complete
a073c86ecf9e: Pull complete
a4d4613b850e: Verifying Checksum
a4d4613b850e: Download complete
5fb493aa739b: Verifying Checksum
5fb493aa739b: Download complete
db7179d8c6cd: Verifying Checksum
db7179d8c6cd: Download complete
eedb53e41e40: Verifying Checksum
eedb53e41e40: Download complete
8b7e2ad468ac: Verifying Checksum
8b7e2ad468ac: Download complete
db7179d8c6cd: Pull complete
66b9cfaecc8c: Pull complete
a4d4613b850e: Pull complete
5fb493aa739b: Pull complete
8b7e2ad468ac: Pull complete
eedb53e41e40: Pull complete
Digest: sha256:f575c0dcb1e17a00dc1cf8f5cc1f1cbc697467e2a647b146051161edddea46f0
Status: Downloaded newer image for registry.staging.gitlab.com/gitlab-org/monitor/monitor-sandbox/master:fc8a8b6eab8e311da328b6b746c9df9a3b4da710
registry.staging.gitlab.com/gitlab-org/monitor/monitor-sandbox/master:fc8a8b6eab8e311da328b6b746c9df9a3b4da710
Sending build context to Docker daemon 136.7kB
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
---> c95d85f2278e
Step 8/10 : ENV PORT 5000
---> Running in 1645f915aed8
Removing intermediate container 1645f915aed8
---> 79e75575dcf9
Step 9/10 : EXPOSE $PORT
---> Running in 914bc7b71720
Removing intermediate container 914bc7b71720
---> 486efc66de41
Step 10/10 : CMD [ "npm", "start" ]
---> Running in 45a15b885943
Removing intermediate container 45a15b885943
---> cd6ba7d3ad09
[Warning] One or more build-args [BUILDPACK_URL] were not consumed
Successfully built cd6ba7d3ad09
Successfully tagged registry.staging.gitlab.com/gitlab-org/monitor/monitor-sandbox/master:1628bb31e7f7c52a2cccdf8903fecad548b68629
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]
676cca0e166e: Preparing
8ddc9e599f93: Preparing
a85ff65fd061: Preparing
eaba38c532c6: Preparing
d35df9c923f8: Preparing
a7d484df787a: Preparing
8dfad2055603: Preparing
a7d484df787a: Waiting
8dfad2055603: Waiting
eaba38c532c6: Layer already exists
a85ff65fd061: Layer already exists
8ddc9e599f93: Layer already exists
d35df9c923f8: Layer already exists
a7d484df787a: Layer already exists
8dfad2055603: Layer already exists
676cca0e166e: Pushed
1628bb31e7f7c52a2cccdf8903fecad548b68629: digest: sha256:364ba717ce675f419e7f204765169b26d3eae4b70c856c7803ad531a7ac136a3 size: 1785
The push refers to repository [registry.staging.gitlab.com/gitlab-org/monitor/monitor-sandbox/master]
676cca0e166e: Preparing
8ddc9e599f93: Preparing
a85ff65fd061: Preparing
eaba38c532c6: Preparing
d35df9c923f8: Preparing
a7d484df787a: Preparing
8dfad2055603: Preparing
a7d484df787a: Waiting
8dfad2055603: Waiting
eaba38c532c6: Layer already exists
676cca0e166e: Layer already exists
a85ff65fd061: Layer already exists
d35df9c923f8: Layer already exists
8ddc9e599f93: Layer already exists
a7d484df787a: Layer already exists
8dfad2055603: Layer already exists
latest: digest: sha256:364ba717ce675f419e7f204765169b26d3eae4b70c856c7803ad531a7ac136a3 size: 1785
section_end:1590658026:build_script
[0Ksection_start:1590658026:after_script
[0K[0K[36;1mRunning after_script[0;m
[0;msection_end:1590658027:after_script
[0Ksection_start:1590658027:archive_cache
[0K[0K[36;1mSaving cache[0;m
[0;msection_end:1590658029:archive_cache
[0Ksection_start:1590658029:upload_artifacts_on_success
[0K[0K[36;1mUploading artifacts for successful job[0;m
[0;msection_end:1590658030:upload_artifacts_on_success
[0K[32;1mJob succeeded
[0;m