Skip to content

build: missing newline when printing build details on error #2504

build: missing newline when printing build details on error

build: missing newline when printing build details on error #2504

Triggered via pull request June 28, 2023 23:39
Status Failure
Total duration 7m 9s
Artifacts 2
This run and associated checks have been archived and are scheduled for deletion. Learn more about checks retention

build.yml

on: pull_request
prepare-binaries
5s
prepare-binaries
buildkit-edge
2m 4s
buildkit-edge
Matrix: binaries
Matrix: test
Fit to window
Zoom out
Zoom in

Annotations

12 errors
Failed: tests/TestIntegration: tests/run.go#L266
=== RUN TestIntegration time="2023-06-28T23:45:07Z" level=info msg="trying next host - response was http.StatusNotFound" host="localhost:38455" run.go:266: copied docker.io/amd64/busybox:latest@sha256:0d5a701f0ca53f38723108687add000e1922f812d4187dea7feaee85d2f5a6c5 to local mirror localhost:38455/library/busybox:latest time="2023-06-28T23:45:08Z" level=info msg="trying next host - response was http.StatusNotFound" host="localhost:38455" run.go:266: copied docker.io/amd64/alpine:latest@sha256:c0d488a800e4127c334ad20d61d7bc21b4097540327217dfab52262adc02380c to local mirror localhost:38455/library/alpine:latest time="2023-06-28T23:45:08Z" level=info msg="trying next host - response was http.StatusNotFound" host="localhost:38455" run.go:266: copied docker.io/moby/buildkit:buildx-stable-1 to local mirror localhost:38455/moby/buildkit:buildx-stable-1 --- FAIL: TestIntegration (5.22s)
Failed: tests/TestIntegration/TestBuildDetailsLink/worker=docker: tests/build.go#L216
=== RUN TestIntegration/TestBuildDetailsLink/worker=docker === PAUSE TestIntegration/TestBuildDetailsLink/worker=docker === CONT TestIntegration/TestBuildDetailsLink/worker=docker build.go:216: Error Trace: /src/tests/build.go:216 /src/vendor/github.com/moby/buildkit/util/testutil/integration/run.go:90 /src/vendor/github.com/moby/buildkit/util/testutil/integration/run.go:204 Error: Should be true Test: TestIntegration/TestBuildDetailsLink/worker=docker Messages: expected build details link in output, got "\n" sandbox.go:283: stdout: /usr/bin/dockerd sandbox.go:283: stderr: /usr/bin/dockerd sandbox.go:286: > startCmd 2023-06-28 23:45:31.899154009 +0000 UTC m=+24.230452270 /usr/bin/dockerd --data-root /tmp/integration107015096/dl59s5ht0e38v/root --exec-root /tmp/dxr/dl59s5ht0e38v --pidfile /tmp/integration107015096/dl59s5ht0e38v/docker.pid --containerd-namespace dl59s5ht0e38v --containerd-plugins-namespace dl59s5ht0e38vp --host unix:///tmp/docker-integration/dl59s5ht0e38v.sock --config-file /tmp/integration107015096/daemon.json --userland-proxy=false --debug sandbox.go:286: time="2023-06-28T23:45:31.938560587Z" level=info msg="Starting up" sandbox.go:286: time="2023-06-28T23:45:31.939578596Z" level=warning msg="could not change group /tmp/docker-integration/dl59s5ht0e38v.sock to docker: group docker not found" sandbox.go:286: time="2023-06-28T23:45:31.939798198Z" level=debug msg="Listener created for HTTP on unix (/tmp/docker-integration/dl59s5ht0e38v.sock)" sandbox.go:286: time="2023-06-28T23:45:31.939836499Z" level=info msg="containerd not running, starting managed containerd" sandbox.go:286: time="2023-06-28T23:45:31.940422004Z" level=info msg="started new containerd process" address=/tmp/dxr/dl59s5ht0e38v/containerd/containerd.sock module=libcontainerd pid=7362 sandbox.go:286: time="2023-06-28T23:45:31.955871052Z" level=info msg="starting containerd" revision=1677a17964311325ed1c31e2c0a3589ce6d5c30d version=v1.7.1 sandbox.go:286: time="2023-06-28T23:45:31.972984616Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 sandbox.go:286: time="2023-06-28T23:45:31.973670923Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: can't change directory to '/lib/modules': No such file or directory\\n\"): skip plugin" type=io.containerd.snapshotter.v1 sandbox.go:286: time="2023-06-28T23:45:31.973717023Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 sandbox.go:286: time="2023-06-28T23:45:31.973833424Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 sandbox.go:286: time="2023-06-28T23:45:31.973913525Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 sandbox.go:286: time="2023-06-28T23:45:31.974119927Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 sandbox.go:286: time="2023-06-28T23:45:31.974160028Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" sandbox.go:286: time="2023-06-28T23:45:31.974180128Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 sandbox.go:286: time="2023-06-28T23:45:31.974313529Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /tmp/integration107015096/dl59s5ht0e38v/root/containerd/daemon/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 sandbox.go:286: time="2023-06-28T23:45:31.974346129Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containe
test (docker, ./tests)
Process completed with exit code 1.
Failed: tests/TestIntegration: tests/run.go#L266
=== RUN TestIntegration time="2023-06-28T23:45:29Z" level=info msg="trying next host - response was http.StatusNotFound" host="localhost:43799" run.go:266: copied docker.io/amd64/alpine:latest@sha256:c0d488a800e4127c334ad20d61d7bc21b4097540327217dfab52262adc02380c to local mirror localhost:43799/library/alpine:latest time="2023-06-28T23:45:30Z" level=info msg="trying next host - response was http.StatusNotFound" host="localhost:43799" run.go:266: copied docker.io/moby/buildkit:buildx-stable-1 to local mirror localhost:43799/moby/buildkit:buildx-stable-1 time="2023-06-28T23:45:35Z" level=info msg="trying next host - response was http.StatusNotFound" host="localhost:43799" run.go:266: copied docker.io/amd64/busybox:latest@sha256:0d5a701f0ca53f38723108687add000e1922f812d4187dea7feaee85d2f5a6c5 to local mirror localhost:43799/library/busybox:latest --- FAIL: TestIntegration (8.61s)
Failed: tests/TestIntegration/TestBuildDetailsLink/worker=docker-container: tests/build.go#L216
=== RUN TestIntegration/TestBuildDetailsLink/worker=docker-container === PAUSE TestIntegration/TestBuildDetailsLink/worker=docker-container === CONT TestIntegration/TestBuildDetailsLink/worker=docker-container build.go:216: Error Trace: /src/tests/build.go:216 /src/vendor/github.com/moby/buildkit/util/testutil/integration/run.go:90 /src/vendor/github.com/moby/buildkit/util/testutil/integration/run.go:204 Error: Should be true Test: TestIntegration/TestBuildDetailsLink/worker=docker-container Messages: expected build details link in output, got "\n" --- FAIL: TestIntegration/TestBuildDetailsLink/worker=docker-container (4.04s)
test (docker-container, ./tests)
Process completed with exit code 1.
Failed: tests/TestIntegration: tests/run.go#L266
=== RUN TestIntegration time="2023-06-28T23:45:54Z" level=info msg="trying next host - response was http.StatusNotFound" host="localhost:34543" run.go:266: copied docker.io/amd64/busybox:latest@sha256:0d5a701f0ca53f38723108687add000e1922f812d4187dea7feaee85d2f5a6c5 to local mirror localhost:34543/library/busybox:latest time="2023-06-28T23:45:55Z" level=info msg="trying next host - response was http.StatusNotFound" host="localhost:34543" run.go:266: copied docker.io/amd64/alpine:latest@sha256:c0d488a800e4127c334ad20d61d7bc21b4097540327217dfab52262adc02380c to local mirror localhost:34543/library/alpine:latest time="2023-06-28T23:45:55Z" level=info msg="trying next host - response was http.StatusNotFound" host="localhost:34543" run.go:266: copied docker.io/moby/buildkit:buildx-stable-1 to local mirror localhost:34543/moby/buildkit:buildx-stable-1 --- FAIL: TestIntegration (6.43s)
Failed: tests/TestIntegration/TestBuildDetailsLink/worker=remote: tests/build.go#L216
=== RUN TestIntegration/TestBuildDetailsLink/worker=remote === PAUSE TestIntegration/TestBuildDetailsLink/worker=remote === CONT TestIntegration/TestBuildDetailsLink/worker=remote build.go:216: Error Trace: /src/tests/build.go:216 /src/vendor/github.com/moby/buildkit/util/testutil/integration/run.go:90 /src/vendor/github.com/moby/buildkit/util/testutil/integration/run.go:204 Error: Should be true Test: TestIntegration/TestBuildDetailsLink/worker=remote Messages: expected build details link in output, got "2023/06/28 23:46:07 http2: server connection error from localhost: connection error: PROTOCOL_ERROR\n\n" sandbox.go:283: stderr: /usr/bin/buildkitd --oci-worker=true --containerd-worker=false --oci-worker-gc=false --oci-worker-labels=org.mobyproject.buildkit.worker.sandbox=true --config=/tmp/bktest_config222271739/buildkitd.toml --root /tmp/bktest_buildkitd729099025 --addr unix:///tmp/bktest_buildkitd729099025/buildkitd.sock --debug sandbox.go:286: > startCmd 2023-06-28 23:46:06.806961873 +0000 UTC m=+12.291362198 /usr/bin/buildkitd --oci-worker=true --containerd-worker=false --oci-worker-gc=false --oci-worker-labels=org.mobyproject.buildkit.worker.sandbox=true --config=/tmp/bktest_config222271739/buildkitd.toml --root /tmp/bktest_buildkitd729099025 --addr unix:///tmp/bktest_buildkitd729099025/buildkitd.sock --debug sandbox.go:286: time="2023-06-28T23:46:06Z" level=info msg="auto snapshotter: using overlayfs" sandbox.go:286: time="2023-06-28T23:46:06Z" level=warning msg="using host network as the default" sandbox.go:286: time="2023-06-28T23:46:06Z" level=info msg="found worker \"6x4cdwzo15wu6vpopq0jyd853\", labels=map[org.mobyproject.buildkit.worker.executor:oci org.mobyproject.buildkit.worker.hostname:be14608a96d9 org.mobyproject.buildkit.worker.network:host org.mobyproject.buildkit.worker.oci.process-mode:sandbox org.mobyproject.buildkit.worker.sandbox:true org.mobyproject.buildkit.worker.selinux.enabled:false org.mobyproject.buildkit.worker.snapshotter:overlayfs], platforms=[linux/amd64 linux/amd64/v2 linux/amd64/v3 linux/arm64 linux/riscv64 linux/ppc64le linux/s390x linux/386 linux/mips64le linux/mips64 linux/arm/v7 linux/arm/v6]" sandbox.go:286: time="2023-06-28T23:46:06Z" level=info msg="found 1 workers, default=\"6x4cdwzo15wu6vpopq0jyd853\"" sandbox.go:286: time="2023-06-28T23:46:06Z" level=warning msg="currently, only the default worker can be used." sandbox.go:286: time="2023-06-28T23:46:06Z" level=info msg="running server on /tmp/bktest_buildkitd729099025/buildkitd.sock" sandbox.go:286: time="2023-06-28T23:46:07Z" level=debug msg="session started" spanID=4585619dc0a91271 traceID=deb8acf0eb90f98acef3c289dd0fefa7 sandbox.go:286: time="2023-06-28T23:46:07Z" level=debug msg="session finished: <nil>" spanID=4585619dc0a91271 traceID=deb8acf0eb90f98acef3c289dd0fefa7 sandbox.go:286: time="2023-06-28T23:46:08Z" level=debug msg="session started" spanID=80da2a56e9a0acdc traceID=deb8acf0eb90f98acef3c289dd0fefa7 sandbox.go:286: time="2023-06-28T23:46:08Z" level=debug msg="new ref for local: zccbzjh6pgvks7yw7s3dxrv3p" span="[internal] load build definition from Dockerfile" spanID=a5980d099219fc59 traceID=deb8acf0eb90f98acef3c289dd0fefa7 sandbox.go:286: time="2023-06-28T23:46:08Z" level=debug msg="new ref for local: mgayjm6qbepweuq6jrqeg2mwy" span="[internal] load .dockerignore" spanID=0ee7046b35ea7060 traceID=deb8acf0eb90f98acef3c289dd0fefa7 sandbox.go:286: time="2023-06-28T23:46:08Z" level=debug msg="diffcopy took: 3.510296ms" span="[internal] load build definition from Dockerfile" spanID=5b8f6cea847d8d46 traceID=deb8acf0eb90f98acef3c289dd0fefa7 sandbox.go:286: time="2023-06-28T23:46:08Z" level=debug msg="diffcopy took: 1.592099ms" span="[internal] load .dockerignore" spanID=9e7bdbd39d1e2865 traceID=deb8acf0eb90f98acef3c289dd0fefa7 sandbox.go:286: time="2023-06-28T23:46:08Z" level=debug msg="saved zccbzjh6pgvks7yw7s3dxrv3p as dockerfile:dockerfile:001:
test (remote, ./tests)
Process completed with exit code 1.
Failed: tests/TestIntegration: tests/run.go#L266
=== RUN TestIntegration time="2023-06-28T23:45:53Z" level=info msg="trying next host - response was http.StatusNotFound" host="localhost:41569" run.go:266: copied docker.io/amd64/busybox:latest@sha256:0d5a701f0ca53f38723108687add000e1922f812d4187dea7feaee85d2f5a6c5 to local mirror localhost:41569/library/busybox:latest time="2023-06-28T23:45:53Z" level=info msg="trying next host - response was http.StatusNotFound" host="localhost:41569" run.go:266: copied docker.io/amd64/alpine:latest@sha256:c0d488a800e4127c334ad20d61d7bc21b4097540327217dfab52262adc02380c to local mirror localhost:41569/library/alpine:latest time="2023-06-28T23:45:54Z" level=info msg="trying next host - response was http.StatusNotFound" host="localhost:41569" run.go:266: copied docker.io/moby/buildkit:buildx-stable-1 to local mirror localhost:41569/moby/buildkit:buildx-stable-1 --- FAIL: TestIntegration (6.79s)
Failed: tests/TestIntegration/TestBuildDetailsLink/worker=docker+containerd: tests/build.go#L216
=== RUN TestIntegration/TestBuildDetailsLink/worker=docker+containerd === PAUSE TestIntegration/TestBuildDetailsLink/worker=docker+containerd === CONT TestIntegration/TestBuildDetailsLink/worker=docker+containerd build.go:216: Error Trace: /src/tests/build.go:216 /src/vendor/github.com/moby/buildkit/util/testutil/integration/run.go:90 /src/vendor/github.com/moby/buildkit/util/testutil/integration/run.go:204 Error: Should be true Test: TestIntegration/TestBuildDetailsLink/worker=docker+containerd Messages: expected build details link in output, got "\n" sandbox.go:283: stdout: /usr/bin/dockerd sandbox.go:283: stderr: /usr/bin/dockerd sandbox.go:286: > startCmd 2023-06-28 23:46:19.852918533 +0000 UTC m=+27.238164419 /usr/bin/dockerd --data-root /tmp/integration1462824461/dvq44lnfuixhs/root --exec-root /tmp/dxr/dvq44lnfuixhs --pidfile /tmp/integration1462824461/dvq44lnfuixhs/docker.pid --containerd-namespace dvq44lnfuixhs --containerd-plugins-namespace dvq44lnfuixhsp --host unix:///tmp/docker-integration/dvq44lnfuixhs.sock --config-file /tmp/integration1462824461/daemon.json --userland-proxy=false --debug sandbox.go:286: time="2023-06-28T23:46:19.891827124Z" level=info msg="Starting up" sandbox.go:286: time="2023-06-28T23:46:19.893198720Z" level=warning msg="could not change group /tmp/docker-integration/dvq44lnfuixhs.sock to docker: group docker not found" sandbox.go:286: time="2023-06-28T23:46:19.893486619Z" level=debug msg="Listener created for HTTP on unix (/tmp/docker-integration/dvq44lnfuixhs.sock)" sandbox.go:286: time="2023-06-28T23:46:19.893552119Z" level=info msg="containerd not running, starting managed containerd" sandbox.go:286: time="2023-06-28T23:46:19.894355717Z" level=info msg="started new containerd process" address=/tmp/dxr/dvq44lnfuixhs/containerd/containerd.sock module=libcontainerd pid=7225 sandbox.go:286: time="2023-06-28T23:46:19.912849865Z" level=info msg="starting containerd" revision=1677a17964311325ed1c31e2c0a3589ce6d5c30d version=v1.7.1 sandbox.go:286: time="2023-06-28T23:46:19.931787312Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 sandbox.go:286: time="2023-06-28T23:46:19.932686110Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: can't change directory to '/lib/modules': No such file or directory\\n\"): skip plugin" type=io.containerd.snapshotter.v1 sandbox.go:286: time="2023-06-28T23:46:19.932745210Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 sandbox.go:286: time="2023-06-28T23:46:19.932876209Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 sandbox.go:286: time="2023-06-28T23:46:19.933010509Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 sandbox.go:286: time="2023-06-28T23:46:19.933276208Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 sandbox.go:286: time="2023-06-28T23:46:19.933325508Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" sandbox.go:286: time="2023-06-28T23:46:19.933346808Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 sandbox.go:286: time="2023-06-28T23:46:19.933483608Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /tmp/integration1462824461/dvq44lnfuixhs/root/containerd/daemon/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 sandbox.go:286: time="2023-06-28T23:46:19.933617807Z" level=info msg="loading plugin \"io.co
test (docker\+containerd, ./tests)
Process completed with exit code 1.

Artifacts

Produced during runtime
Name Size
buildx Expired
576 MB
test-reports Expired
1.04 MB