[0KRunning with gitlab-runner 12.8.0 (1b659122) [0;m[0K on pica01-test fyUVS7Hz [0;msection_start:1585888582:prepare_executor [0K[0KUsing Docker executor with image registry.picasoft.net/pica-ci-base ... [0;m[0KStarting service docker:19.03.0-dind ... [0;m[0KPulling docker image docker:19.03.0-dind ... [0;m[0KUsing docker image sha256:fd0c64832f7e46b63a180e6000dbba7ad7a63542c5764841cba73429ba74a39e for docker:19.03.0-dind ... [0;m[0KWaiting for services to be up and running... [0;m [0;33m*** WARNING:[0;m Service runner-fyUVS7Hz-project-1304-concurrent-0-docker-0 probably didn't start properly. Health check error: service "runner-fyUVS7Hz-project-1304-concurrent-0-docker-0-wait-for-service" timeout Health check container logs: Service container logs: 2020-04-03T04:36:39.790015483Z time="2020-04-03T04:36:39.789748155Z" level=info msg="Starting up" 2020-04-03T04:36:39.792573601Z time="2020-04-03T04:36:39.791492052Z" level=warning msg="could not change group /var/run/docker.sock to docker: group docker not found" 2020-04-03T04:36:39.792625998Z time="2020-04-03T04:36:39.792512487Z" level=warning msg="[!] DON'T BIND ON ANY IP ADDRESS WITHOUT setting --tlsverify IF YOU DON'T KNOW WHAT YOU'RE DOING [!]" 2020-04-03T04:36:39.796510577Z time="2020-04-03T04:36:39.795757918Z" level=info msg="libcontainerd: started new containerd process" pid=19 2020-04-03T04:36:39.796527349Z time="2020-04-03T04:36:39.796419391Z" level=info msg="parsed scheme: \"unix\"" module=grpc 2020-04-03T04:36:39.796533184Z time="2020-04-03T04:36:39.796436701Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc 2020-04-03T04:36:39.796627335Z time="2020-04-03T04:36:39.796459402Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 <nil>}] }" module=grpc 2020-04-03T04:36:39.796640033Z time="2020-04-03T04:36:39.796475127Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc 2020-04-03T04:36:39.796722561Z time="2020-04-03T04:36:39.796606034Z" level=info msg="pickfirstBalancer: HandleSubConnStateChange: 0xc0001539b0, CONNECTING" module=grpc 2020-04-03T04:36:39.825573538Z time="2020-04-03T04:36:39.825459152Z" level=info msg="starting containerd" revision=894b81a4b802e4eb2a91d1ce216b8817763c29fb version=v1.2.6 2020-04-03T04:36:39.825964002Z time="2020-04-03T04:36:39.825902317Z" level=info msg="loading plugin "io.containerd.content.v1.content"..." type=io.containerd.content.v1 2020-04-03T04:36:39.826237246Z time="2020-04-03T04:36:39.826144015Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.btrfs"..." type=io.containerd.snapshotter.v1 2020-04-03T04:36:39.826550864Z time="2020-04-03T04:36:39.826478523Z" 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-03T04:36:39.826632827Z time="2020-04-03T04:36:39.826574144Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.aufs"..." type=io.containerd.snapshotter.v1 2020-04-03T04:36:39.845081471Z time="2020-04-03T04:36:39.844627641Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.aufs" error="modprobe aufs failed: "ip: can't find device 'aufs'\naufs 274432 0 \nmodprobe: can't change directory to '/lib/modules': No such file or directory\n": exit status 1" 2020-04-03T04:36:39.845102528Z time="2020-04-03T04:36:39.844666620Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.native"..." type=io.containerd.snapshotter.v1 2020-04-03T04:36:39.845390839Z time="2020-04-03T04:36:39.845319943Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.overlayfs"..." type=io.containerd.snapshotter.v1 2020-04-03T04:36:39.845637164Z time="2020-04-03T04:36:39.845552240Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.zfs"..." type=io.containerd.snapshotter.v1 2020-04-03T04:36:39.846026677Z time="2020-04-03T04:36:39.845938760Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.zfs" error="path /var/lib/docker/containerd/daemon/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter" 2020-04-03T04:36:39.846047599Z time="2020-04-03T04:36:39.845975725Z" level=info msg="loading plugin "io.containerd.metadata.v1.bolt"..." type=io.containerd.metadata.v1 2020-04-03T04:36:39.846132667Z time="2020-04-03T04:36:39.846048903Z" 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-03T04:36:39.846147730Z time="2020-04-03T04:36:39.846062128Z" level=warning msg="could not use snapshotter aufs in metadata plugin" error="modprobe aufs failed: "ip: can't find device 'aufs'\naufs 274432 0 \nmodprobe: can't change directory to '/lib/modules': No such file or directory\n": exit status 1" 2020-04-03T04:36:39.846154644Z time="2020-04-03T04:36:39.846071654Z" 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" 2020-04-03T04:36:39.869307033Z time="2020-04-03T04:36:39.869004893Z" level=info msg="loading plugin "io.containerd.differ.v1.walking"..." type=io.containerd.differ.v1 2020-04-03T04:36:39.869326365Z time="2020-04-03T04:36:39.869054465Z" level=info msg="loading plugin "io.containerd.gc.v1.scheduler"..." type=io.containerd.gc.v1 2020-04-03T04:36:39.869332366Z time="2020-04-03T04:36:39.869110597Z" level=info msg="loading plugin "io.containerd.service.v1.containers-service"..." type=io.containerd.service.v1 2020-04-03T04:36:39.869337392Z time="2020-04-03T04:36:39.869127819Z" level=info msg="loading plugin "io.containerd.service.v1.content-service"..." type=io.containerd.service.v1 2020-04-03T04:36:39.869342360Z time="2020-04-03T04:36:39.869139240Z" level=info msg="loading plugin "io.containerd.service.v1.diff-service"..." type=io.containerd.service.v1 2020-04-03T04:36:39.869347333Z time="2020-04-03T04:36:39.869154867Z" level=info msg="loading plugin "io.containerd.service.v1.images-service"..." type=io.containerd.service.v1 2020-04-03T04:36:39.869352543Z time="2020-04-03T04:36:39.869179987Z" level=info msg="loading plugin "io.containerd.service.v1.leases-service"..." type=io.containerd.service.v1 2020-04-03T04:36:39.869357309Z time="2020-04-03T04:36:39.869193882Z" level=info msg="loading plugin "io.containerd.service.v1.namespaces-service"..." type=io.containerd.service.v1 2020-04-03T04:36:39.869362192Z time="2020-04-03T04:36:39.869206319Z" level=info msg="loading plugin "io.containerd.service.v1.snapshots-service"..." type=io.containerd.service.v1 2020-04-03T04:36:39.869367048Z time="2020-04-03T04:36:39.869252415Z" level=info msg="loading plugin "io.containerd.runtime.v1.linux"..." type=io.containerd.runtime.v1 2020-04-03T04:36:39.869591517Z time="2020-04-03T04:36:39.869503548Z" level=info msg="loading plugin "io.containerd.runtime.v2.task"..." type=io.containerd.runtime.v2 2020-04-03T04:36:39.869722337Z time="2020-04-03T04:36:39.869626245Z" level=info msg="loading plugin "io.containerd.monitor.v1.cgroups"..." type=io.containerd.monitor.v1 2020-04-03T04:36:39.871326601Z time="2020-04-03T04:36:39.870919732Z" level=info msg="loading plugin "io.containerd.service.v1.tasks-service"..." type=io.containerd.service.v1 2020-04-03T04:36:39.871340147Z time="2020-04-03T04:36:39.870974389Z" level=info msg="loading plugin "io.containerd.internal.v1.restart"..." type=io.containerd.internal.v1 2020-04-03T04:36:39.871359533Z time="2020-04-03T04:36:39.871031410Z" level=info msg="loading plugin "io.containerd.grpc.v1.containers"..." type=io.containerd.grpc.v1 2020-04-03T04:36:39.871364618Z time="2020-04-03T04:36:39.871073453Z" level=info msg="loading plugin "io.containerd.grpc.v1.content"..." type=io.containerd.grpc.v1 2020-04-03T04:36:39.871384808Z time="2020-04-03T04:36:39.871099982Z" level=info msg="loading plugin "io.containerd.grpc.v1.diff"..." type=io.containerd.grpc.v1 2020-04-03T04:36:39.871391397Z time="2020-04-03T04:36:39.871146015Z" level=info msg="loading plugin "io.containerd.grpc.v1.events"..." type=io.containerd.grpc.v1 2020-04-03T04:36:39.871396381Z time="2020-04-03T04:36:39.871158106Z" level=info msg="loading plugin "io.containerd.grpc.v1.healthcheck"..." type=io.containerd.grpc.v1 2020-04-03T04:36:39.871401089Z time="2020-04-03T04:36:39.871178941Z" level=info msg="loading plugin "io.containerd.grpc.v1.images"..." type=io.containerd.grpc.v1 2020-04-03T04:36:39.871405609Z time="2020-04-03T04:36:39.871195357Z" level=info msg="loading plugin "io.containerd.grpc.v1.leases"..." type=io.containerd.grpc.v1 2020-04-03T04:36:39.871410090Z time="2020-04-03T04:36:39.871211227Z" level=info msg="loading plugin "io.containerd.grpc.v1.namespaces"..." type=io.containerd.grpc.v1 2020-04-03T04:36:39.871414648Z time="2020-04-03T04:36:39.871243032Z" level=info msg="loading plugin "io.containerd.internal.v1.opt"..." type=io.containerd.internal.v1 2020-04-03T04:36:39.871803741Z time="2020-04-03T04:36:39.871479983Z" level=info msg="loading plugin "io.containerd.grpc.v1.snapshots"..." type=io.containerd.grpc.v1 2020-04-03T04:36:39.872244528Z time="2020-04-03T04:36:39.871528303Z" level=info msg="loading plugin "io.containerd.grpc.v1.tasks"..." type=io.containerd.grpc.v1 2020-04-03T04:36:39.872292185Z time="2020-04-03T04:36:39.871540289Z" level=info msg="loading plugin "io.containerd.grpc.v1.version"..." type=io.containerd.grpc.v1 2020-04-03T04:36:39.872299502Z time="2020-04-03T04:36:39.871572355Z" level=info msg="loading plugin "io.containerd.grpc.v1.introspection"..." type=io.containerd.grpc.v1 2020-04-03T04:36:39.872496213Z time="2020-04-03T04:36:39.872155334Z" level=info msg=serving... address="/var/run/docker/containerd/containerd-debug.sock" 2020-04-03T04:36:39.872505687Z time="2020-04-03T04:36:39.872241662Z" level=info msg=serving... address="/var/run/docker/containerd/containerd.sock" 2020-04-03T04:36:39.872510818Z time="2020-04-03T04:36:39.872256790Z" level=info msg="containerd successfully booted in 0.047432s" 2020-04-03T04:36:39.878140101Z time="2020-04-03T04:36:39.877986184Z" level=info msg="pickfirstBalancer: HandleSubConnStateChange: 0xc0001539b0, READY" module=grpc 2020-04-03T04:36:39.880596987Z time="2020-04-03T04:36:39.880460087Z" level=info msg="Setting the storage driver from the $DOCKER_DRIVER environment variable (overlay2)" 2020-04-03T04:36:39.880938742Z time="2020-04-03T04:36:39.880866712Z" level=info msg="parsed scheme: \"unix\"" module=grpc 2020-04-03T04:36:39.880964328Z time="2020-04-03T04:36:39.880884543Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc 2020-04-03T04:36:39.880970338Z time="2020-04-03T04:36:39.880904234Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 <nil>}] }" module=grpc 2020-04-03T04:36:39.880994512Z time="2020-04-03T04:36:39.880933916Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc 2020-04-03T04:36:39.881428854Z time="2020-04-03T04:36:39.881292871Z" level=info msg="pickfirstBalancer: HandleSubConnStateChange: 0xc0007927f0, CONNECTING" module=grpc 2020-04-03T04:36:39.882210803Z time="2020-04-03T04:36:39.882112377Z" level=info msg="pickfirstBalancer: HandleSubConnStateChange: 0xc0007927f0, READY" module=grpc 2020-04-03T04:36:39.882223647Z time="2020-04-03T04:36:39.881662433Z" level=info msg="blockingPicker: the picked transport is not ready, loop back to repick" module=grpc 2020-04-03T04:36:39.882910059Z time="2020-04-03T04:36:39.882775251Z" level=info msg="parsed scheme: \"unix\"" module=grpc 2020-04-03T04:36:39.882920650Z time="2020-04-03T04:36:39.882795674Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc 2020-04-03T04:36:39.883003518Z time="2020-04-03T04:36:39.882811869Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 <nil>}] }" module=grpc 2020-04-03T04:36:39.883097903Z time="2020-04-03T04:36:39.882961448Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc 2020-04-03T04:36:39.883228999Z time="2020-04-03T04:36:39.883141418Z" level=info msg="pickfirstBalancer: HandleSubConnStateChange: 0xc0006c0bc0, CONNECTING" module=grpc 2020-04-03T04:36:39.883296861Z time="2020-04-03T04:36:39.883158373Z" level=info msg="blockingPicker: the picked transport is not ready, loop back to repick" module=grpc 2020-04-03T04:36:39.883651644Z time="2020-04-03T04:36:39.883585688Z" level=info msg="pickfirstBalancer: HandleSubConnStateChange: 0xc0006c0bc0, READY" module=grpc 2020-04-03T04:36:39.997722481Z time="2020-04-03T04:36:39.997558644Z" level=warning msg="Your kernel does not support swap memory limit" 2020-04-03T04:36:39.997742491Z time="2020-04-03T04:36:39.997633084Z" level=warning msg="Your kernel does not support cgroup rt period" 2020-04-03T04:36:39.997747959Z time="2020-04-03T04:36:39.997671554Z" level=warning msg="Your kernel does not support cgroup rt runtime" 2020-04-03T04:36:40.004650193Z time="2020-04-03T04:36:40.001381521Z" level=info msg="Loading containers: start." 2020-04-03T04:36:40.034453777Z time="2020-04-03T04:36:40.034280220Z" level=warning msg="Running modprobe bridge br_netfilter failed with message: ip: can't find device 'bridge'\nbridge 188416 1 br_netfilter\nstp 16384 1 bridge\nllc 16384 2 bridge,stp\nip: can't find device 'br_netfilter'\nbr_netfilter 24576 0 \nbridge 188416 1 br_netfilter\nmodprobe: can't change directory to '/lib/modules': No such file or directory\n, error: exit status 1" 2020-04-03T04:36:40.047659830Z time="2020-04-03T04:36:40.046254331Z" level=warning msg="Running modprobe nf_nat failed with message: `ip: can't find device 'nf_nat'\nnf_nat_ipv4 16384 3 iptable_nat,ipt_MASQUERADE,nft_chain_nat_ipv4\nnf_nat 36864 2 xt_nat,nf_nat_ipv4\nnf_conntrack 172032 6 xt_nat,xt_conntrack,ipt_MASQUERADE,nf_conntrack_netlink,nf_nat_ipv4,nf_nat\nlibcrc32c 16384 4 btrfs,xfs,nf_nat,nf_conntrack\nmodprobe: can't change directory to '/lib/modules': No such file or directory`, error: exit status 1" 2020-04-03T04:36:40.067295103Z time="2020-04-03T04:36:40.064566922Z" level=warning msg="Running modprobe xt_conntrack failed with message: `ip: can't find device 'xt_conntrack'\nxt_conntrack 16384 3 \nnf_conntrack 172032 6 xt_nat,xt_conntrack,ipt_MASQUERADE,nf_conntrack_netlink,nf_nat_ipv4,nf_nat\nx_tables 45056 8 iptable_filter,xt_nat,xt_tcpudp,xt_conntrack,ipt_MASQUERADE,xt_addrtype,nft_compat,ip_tables\nmodprobe: can't change directory to '/lib/modules': No such file or directory`, error: exit status 1" 2020-04-03T04:36:40.251764547Z time="2020-04-03T04:36:40.250927145Z" 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-03T04:36:40.330427734Z time="2020-04-03T04:36:40.330295904Z" level=info msg="Loading containers: done." 2020-04-03T04:36:40.374984204Z time="2020-04-03T04:36:40.374795575Z" level=info msg="Docker daemon" commit=aeac9490dc graphdriver(s)=overlay2 version=19.03.0 2020-04-03T04:36:40.375052245Z time="2020-04-03T04:36:40.374942017Z" level=info msg="Daemon has completed initialization" 2020-04-03T04:36:40.428821921Z time="2020-04-03T04:36:40.428668192Z" level=info msg="API listen on /var/run/docker.sock" 2020-04-03T04:36:40.428854897Z time="2020-04-03T04:36:40.428690830Z" level=info msg="API listen on [::]:2375" [0;33m*********[0;m [0KAuthenticating with credentials from $DOCKER_AUTH_CONFIG [0;m[0KPulling docker image registry.picasoft.net/pica-ci-base ... [0;m[0KUsing docker image sha256:31f9b58ca7552cdd0ba64e295952a2bef4a246425c48d8ee557bea136107806e for registry.picasoft.net/pica-ci-base ... [0;msection_end:1585888646:prepare_executor [0Ksection_start:1585888646:prepare_script [0KRunning on runner-fyUVS7Hz-project-1304-concurrent-0 via pica01-test... section_end:1585888649:prepare_script [0Ksection_start:1585888649:get_sources [0K[32;1mFetching changes...[0;m Initialized empty Git repository in /builds/picasoft/projets/dockerfiles/.git/ [32;1mCreated fresh repository.[0;m From https://gitlab.utc.fr/picasoft/projets/dockerfiles * [new ref] refs/pipelines/59174 -> refs/pipelines/59174 * [new branch] acme-copy-certs-dev -> origin/acme-copy-certs-dev * [new branch] dev-ci -> origin/dev-ci * [new branch] dev-lufi -> origin/dev-lufi * [new branch] dev-sympa -> origin/dev-sympa * [new branch] master -> origin/master * [new branch] patch-1 -> origin/patch-1 * [new branch] pica-openldap-dev -> origin/pica-openldap-dev * [new branch] tx-services-p19-guillaume -> origin/tx-services-p19-guillaume * [new branch] tx-services-p19-liam -> origin/tx-services-p19-liam * [new tag] MTA-SASL-poc -> MTA-SASL-poc * [new tag] pica-mail-auth_plaintext -> pica-mail-auth_plaintext * [new tag] v1.0.0 -> v1.0.0 * [new tag] v1.0.1 -> v1.0.1 [32;1mChecking out 9f548720 as master...[0;m [32;1mSkipping Git submodules setup[0;m section_end:1585888654:get_sources [0Ksection_start:1585888654:restore_cache [0K[32;1mChecking cache for default-1...[0;m No URL provided, cache will not be downloaded from shared cache server. Instead a local version of cache will be extracted.[0;m [32;1mSuccessfully extracted cache[0;m section_end:1585888655:restore_cache [0Ksection_start:1585888655:download_artifacts [0Ksection_end:1585888657:download_artifacts [0Ksection_start:1585888657:build_script [0K[0KAuthenticating with credentials from $DOCKER_AUTH_CONFIG [0;m[32;1m$ chmod +x ./get-modified-image.sh[0;m [32;1m$ ./get-modified-image.sh[0;m cat: can't open '/docker-compose.yml': No such file or directory BusyBox v1.30.1 (2019-06-12 17:51:55 UTC) multi-call binary. Usage: grep [-HhnlLoqvsriwFE] [-m N] [-A/B/C N] PATTERN/-e PATTERN.../-f FILE [FILE]... Search for PATTERN in FILEs (or stdin) -H Add 'filename:' prefix -h Do not add 'filename:' prefix -n Add 'line_no:' prefix -l Show only names of files that match -L Show only names of files that don't match -c Show only count of matching lines -o Show only the matching part of line -q Quiet. Return 0 if PATTERN is found, 1 otherwise -v Select non-matching lines -s Suppress open and read errors -r Recurse -i Ignore case -w Match whole words only -x Match whole lines only -F PATTERN is a literal (not regexp) -E PATTERN is an extended regexp -m N Match up to N times per file -A N Print N lines of trailing context -B N Print N lines of leading context -C N Same as '-A N -B N' -e PTRN Pattern to match -f FILE Read pattern from file section_end:1585888658:build_script [0Ksection_start:1585888658:after_script [0Ksection_end:1585888659:after_script [0Ksection_start:1585888659:upload_artifacts_on_failure [0Ksection_end:1585888661:upload_artifacts_on_failure [0K[31;1mERROR: Job failed: exit code 1 [0;m