Console Output
15:51:08 [2019-10-22T15:51:08.033Z] + docker run --rm -t --privileged -v /home/jenkins/workspace/moby_PR-38401/bundles:/go/src/github.com/docker/docker/bundles --name docker-pr2 -e DOCKER_EXPERIMENTAL -e DOCKER_GITCOMMIT=73a7c369c6abce6117045332cd011c21db003cda -e DOCKER_GRAPHDRIVER -e TESTDEBUG -e TEST_SKIP_INTEGRATION_CLI -e TIMEOUT -e VALIDATE_REPO=https://github.com/moby/moby.git -e VALIDATE_BRANCH=master docker:73a7c369c6abce6117045332cd011c21db003cda hack/make.sh dynbinary test-integration
15:51:08 [2019-10-22T15:51:08.405Z]
15:51:08 [2019-10-22T15:51:08.405Z] Removing bundles/
15:51:08 [2019-10-22T15:51:08.405Z]
15:51:08 [2019-10-22T15:51:08.405Z] ---> Making bundle: dynbinary (in bundles/dynbinary)
15:51:08 [2019-10-22T15:51:08.405Z] Building: bundles/dynbinary-daemon/dockerd-dev
15:51:08 [2019-10-22T15:51:08.405Z] GOOS="" GOARCH="" GOARM=""
15:52:07 [2019-10-22T15:52:07.292Z] Created binary: bundles/dynbinary-daemon/dockerd-dev
15:52:07 [2019-10-22T15:52:07.672Z]
15:52:07 [2019-10-22T15:52:07.672Z] ---> Making bundle: test-integration (in bundles/test-integration)
15:52:08 [2019-10-22T15:52:08.508Z] PKG_CONFIG=pkg-config
15:52:08 [2019-10-22T15:52:08.509Z] GOLANG_VERSION=1.13.3
15:52:08 [2019-10-22T15:52:08.509Z] HOSTNAME=891641c4bd9f
15:52:08 [2019-10-22T15:52:08.509Z] DOCKER_EXPERIMENTAL=1
15:52:08 [2019-10-22T15:52:08.509Z] container=docker
15:52:08 [2019-10-22T15:52:08.509Z] TEST_SKIP_INTEGRATION_CLI=1
15:52:08 [2019-10-22T15:52:08.509Z] GO111MODULE=off
15:52:08 [2019-10-22T15:52:08.509Z] GOPATH=/go
15:52:08 [2019-10-22T15:52:08.509Z] PWD=/go/src/github.com/docker/docker
15:52:08 [2019-10-22T15:52:08.509Z] HOME=/root
15:52:08 [2019-10-22T15:52:08.509Z] VALIDATE_REPO=https://github.com/moby/moby.git
15:52:08 [2019-10-22T15:52:08.509Z] SCRIPTDIR=/go/src/github.com/docker/docker/hack
15:52:08 [2019-10-22T15:52:08.509Z] MAKEDIR=/go/src/github.com/docker/docker/hack/make
15:52:08 [2019-10-22T15:52:08.509Z] DOCKER_GITCOMMIT=73a7c369c6abce6117045332cd011c21db003cda
15:52:08 [2019-10-22T15:52:08.509Z] DOCKER_BUILDTAGS=apparmor seccomp selinux journald
15:52:08 [2019-10-22T15:52:08.509Z] DOCKER_GRAPHDRIVER=overlay2
15:52:08 [2019-10-22T15:52:08.509Z] TERM=xterm
15:52:08 [2019-10-22T15:52:08.509Z] VALIDATE_BRANCH=master
15:52:08 [2019-10-22T15:52:08.509Z] DEST=bundles/test-integration
15:52:08 [2019-10-22T15:52:08.509Z] SHLVL=1
15:52:08 [2019-10-22T15:52:08.509Z] TIMEOUT=120m
15:52:08 [2019-10-22T15:52:08.509Z] PATH=/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
15:52:08 [2019-10-22T15:52:08.509Z] DOCKER_PKG=github.com/docker/docker
15:52:08 [2019-10-22T15:52:08.509Z] TESTDEBUG=0
15:52:08 [2019-10-22T15:52:08.509Z] _=/usr/bin/env
15:52:08 [2019-10-22T15:52:08.509Z] Building test suite binary /go/src/github.com/docker/docker/integration/build/test.main
15:52:42 [2019-10-22T15:52:42.942Z] Building test suite binary /go/src/github.com/docker/docker/integration/config/test.main
15:52:42 [2019-10-22T15:52:42.942Z] Building test suite binary /go/src/github.com/docker/docker/integration/container/test.main
15:52:42 [2019-10-22T15:52:42.942Z] Building test suite binary /go/src/github.com/docker/docker/integration/image/test.main
15:53:02 [2019-10-22T15:53:02.969Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/test.main
15:53:02 [2019-10-22T15:53:02.969Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/ipvlan/test.main
15:53:02 [2019-10-22T15:53:02.969Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/macvlan/test.main
15:53:03 [2019-10-22T15:53:03.344Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/test.main
15:53:03 [2019-10-22T15:53:03.719Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/authz/test.main
15:53:05 [2019-10-22T15:53:05.562Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/common/test.main
15:53:06 [2019-10-22T15:53:06.468Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/graphdriver/test.main
15:53:08 [2019-10-22T15:53:08.346Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/logging/test.main
15:53:10 [2019-10-22T15:53:10.883Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/volumes/test.main
15:53:12 [2019-10-22T15:53:12.741Z] Building test suite binary /go/src/github.com/docker/docker/integration/secret/test.main
15:53:13 [2019-10-22T15:53:13.570Z] Building test suite binary /go/src/github.com/docker/docker/integration/service/test.main
15:53:16 [2019-10-22T15:53:16.032Z] Building test suite binary /go/src/github.com/docker/docker/integration/session/test.main
15:53:16 [2019-10-22T15:53:16.847Z] Building test suite binary /go/src/github.com/docker/docker/integration/system/test.main
15:53:18 [2019-10-22T15:53:18.265Z] Building test suite binary /go/src/github.com/docker/docker/integration/volume/test.main
15:53:19 [2019-10-22T15:53:19.609Z] ---> Making bundle: .integration-daemon-start (in bundles/test-integration)
15:53:19 [2019-10-22T15:53:19.609Z] Using test binary docker
15:53:19 [2019-10-22T15:53:19.609Z] # DOCKER_EXPERIMENTAL is set: starting daemon with experimental features enabled!
15:53:19 [2019-10-22T15:53:19.609Z] +++ /etc/init.d/apparmor start
15:53:19 [2019-10-22T15:53:19.609Z] /etc/init.d/apparmor: 130: /etc/init.d/apparmor: systemd-detect-virt: not found
15:53:19 [2019-10-22T15:53:19.609Z] Starting AppArmor profiles:Warning from stdin (line 1): /sbin/apparmor_parser: cannot use or update cache, disable, or force-complain via stdin
15:53:19 [2019-10-22T15:53:19.609Z] Warning failed to create cache: (null)
15:53:19 [2019-10-22T15:53:19.609Z] .
15:53:19 [2019-10-22T15:53:19.609Z] Starting dockerd
15:53:19 [2019-10-22T15:53:19.609Z] INFO: Waiting for daemon to start...
15:53:19 [2019-10-22T15:53:19.609Z] +++ exec dockerd --debug --host unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock --storage-driver overlay2 --pidfile bundles/test-integration/docker.pid --userland-proxy=true --experimental
15:53:22 [2019-10-22T15:53:22.042Z] .
15:53:22 [2019-10-22T15:53:22.042Z] ---> Making bundle: .integration-daemon-setup (in bundles/test-integration)
15:53:22 [2019-10-22T15:53:22.042Z] ---> Making bundle: .ensure-emptyfs (in bundles/test-integration)
15:53:22 [2019-10-22T15:53:22.042Z] Error: No such image: emptyfs
15:53:22 [2019-10-22T15:53:22.042Z] ++++ tar -cC bundles/test-integration/emptyfs .
15:53:22 [2019-10-22T15:53:22.042Z] ++++ docker load
15:53:22 [2019-10-22T15:53:22.042Z] Running integration-test (iteration 1)
15:53:22 [2019-10-22T15:53:22.042Z] Running /go/src/github.com/docker/docker/integration/build (s390x.integration.build) flags=-test.v -test.timeout=120m
15:53:22 [2019-10-22T15:53:22.042Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-build-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-build-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.build -t ./test.main -test.v -test.timeout=120m
15:53:22 [2019-10-22T15:53:22.042Z] ++ set -e
15:53:22 [2019-10-22T15:53:22.042Z] ++ '[' -n 0 ']'
15:53:22 [2019-10-22T15:53:22.042Z] ++ set -x
15:53:22 [2019-10-22T15:53:22.042Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=s390x DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-build-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-build-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.build -t ./test.main -test.v -test.timeout=120m
15:53:31 [2019-10-22T15:53:31.483Z] Loaded image: buildpack-deps:jessie
15:53:31 [2019-10-22T15:53:31.483Z] Loaded image: busybox:latest
15:53:31 [2019-10-22T15:53:31.483Z] Loaded image: busybox:glibc
15:53:31 [2019-10-22T15:53:31.483Z] Loaded image: debian:jessie
15:53:31 [2019-10-22T15:53:31.483Z] Loaded image: hello-world:latest
15:53:31 [2019-10-22T15:53:31.483Z] INFO: Testing against a local daemon
15:53:31 [2019-10-22T15:53:31.483Z] === RUN TestCgroupNamespacesBuild
15:53:32 [2019-10-22T15:53:32.751Z] --- PASS: TestCgroupNamespacesBuild (1.71s)
15:53:32 [2019-10-22T15:53:32.751Z] build_cgroupns_linux_test.go:42: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesBuild"
15:53:32 [2019-10-22T15:53:32.751Z] === RUN TestCgroupNamespacesBuildDaemonHostMode
15:53:34 [2019-10-22T15:53:34.679Z] --- PASS: TestCgroupNamespacesBuildDaemonHostMode (1.84s)
15:53:34 [2019-10-22T15:53:34.679Z] build_cgroupns_linux_test.go:42: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesBuildDaemonHostMode"
15:53:34 [2019-10-22T15:53:34.679Z] === RUN TestBuildWithSession
15:53:34 [2019-10-22T15:53:34.679Z] --- SKIP: TestBuildWithSession (0.00s)
15:53:34 [2019-10-22T15:53:34.679Z] build_session_test.go:25: TODO: BuildKit
15:53:34 [2019-10-22T15:53:34.679Z] === RUN TestBuildSquashParent
15:53:40 [2019-10-22T15:53:40.891Z] --- PASS: TestBuildSquashParent (5.84s)
15:53:40 [2019-10-22T15:53:40.891Z] === RUN TestBuildWithRemoveAndForceRemove
15:53:40 [2019-10-22T15:53:40.891Z] === RUN TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
15:53:40 [2019-10-22T15:53:40.891Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
15:53:40 [2019-10-22T15:53:40.891Z] === RUN TestBuildWithRemoveAndForceRemove/successful_build_with_remove
15:53:40 [2019-10-22T15:53:40.891Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_remove
15:53:40 [2019-10-22T15:53:40.891Z] === RUN TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
15:53:40 [2019-10-22T15:53:40.891Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
15:53:40 [2019-10-22T15:53:40.891Z] === RUN TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
15:53:40 [2019-10-22T15:53:40.891Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
15:53:40 [2019-10-22T15:53:40.891Z] === RUN TestBuildWithRemoveAndForceRemove/failed_build_with_remove
15:53:40 [2019-10-22T15:53:40.891Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_remove
15:53:40 [2019-10-22T15:53:40.891Z] === RUN TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
15:53:40 [2019-10-22T15:53:40.891Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
15:53:40 [2019-10-22T15:53:40.891Z] === CONT TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
15:53:40 [2019-10-22T15:53:40.891Z] === CONT TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
15:53:43 [2019-10-22T15:53:43.458Z] === CONT TestBuildWithRemoveAndForceRemove/failed_build_with_remove
15:53:43 [2019-10-22T15:53:43.458Z] === CONT TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
15:53:45 [2019-10-22T15:53:45.951Z] === CONT TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
15:53:45 [2019-10-22T15:53:45.951Z] === CONT TestBuildWithRemoveAndForceRemove/successful_build_with_remove
15:53:48 [2019-10-22T15:53:48.424Z] --- PASS: TestBuildWithRemoveAndForceRemove (0.01s)
15:53:48 [2019-10-22T15:53:48.424Z] --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove (2.74s)
15:53:48 [2019-10-22T15:53:48.424Z] --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal (2.80s)
15:53:48 [2019-10-22T15:53:48.424Z] --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_remove (2.44s)
15:53:48 [2019-10-22T15:53:48.424Z] --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal (2.44s)
15:53:48 [2019-10-22T15:53:48.424Z] --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_remove (2.25s)
15:53:48 [2019-10-22T15:53:48.424Z] --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove (2.50s)
15:53:48 [2019-10-22T15:53:48.424Z] === RUN TestBuildMultiStageCopy
15:53:48 [2019-10-22T15:53:48.424Z] === RUN TestBuildMultiStageCopy/copy_to_root
15:53:51 [2019-10-22T15:53:51.017Z] === RUN TestBuildMultiStageCopy/copy_to_newdir
15:53:51 [2019-10-22T15:53:51.383Z] === RUN TestBuildMultiStageCopy/copy_to_newdir_nested
15:53:51 [2019-10-22T15:53:51.748Z] === RUN TestBuildMultiStageCopy/copy_to_existingdir
15:53:52 [2019-10-22T15:53:52.133Z] === RUN TestBuildMultiStageCopy/copy_to_newsubdir
15:53:52 [2019-10-22T15:53:52.907Z] --- PASS: TestBuildMultiStageCopy (4.46s)
15:53:52 [2019-10-22T15:53:52.907Z] --- PASS: TestBuildMultiStageCopy/copy_to_root (2.51s)
15:53:52 [2019-10-22T15:53:52.907Z] --- PASS: TestBuildMultiStageCopy/copy_to_newdir (0.43s)
15:53:52 [2019-10-22T15:53:52.907Z] --- PASS: TestBuildMultiStageCopy/copy_to_newdir_nested (0.45s)
15:53:52 [2019-10-22T15:53:52.907Z] --- PASS: TestBuildMultiStageCopy/copy_to_existingdir (0.50s)
15:53:52 [2019-10-22T15:53:52.907Z] --- PASS: TestBuildMultiStageCopy/copy_to_newsubdir (0.57s)
15:53:52 [2019-10-22T15:53:52.907Z] === RUN TestBuildMultiStageParentConfig
15:53:54 [2019-10-22T15:53:54.230Z] --- PASS: TestBuildMultiStageParentConfig (1.37s)
15:53:54 [2019-10-22T15:53:54.230Z] === RUN TestBuildLabelWithTargets
15:53:56 [2019-10-22T15:53:56.688Z] --- PASS: TestBuildLabelWithTargets (2.09s)
15:53:56 [2019-10-22T15:53:56.688Z] === RUN TestBuildWithEmptyLayers
15:53:57 [2019-10-22T15:53:57.059Z] --- PASS: TestBuildWithEmptyLayers (0.90s)
15:53:57 [2019-10-22T15:53:57.059Z] === RUN TestBuildMultiStageOnBuild
15:54:00 [2019-10-22T15:54:00.228Z] --- PASS: TestBuildMultiStageOnBuild (2.81s)
15:54:00 [2019-10-22T15:54:00.228Z] === RUN TestBuildUncleanTarFilenames
15:54:01 [2019-10-22T15:54:01.155Z] --- PASS: TestBuildUncleanTarFilenames (1.14s)
15:54:01 [2019-10-22T15:54:01.155Z] === RUN TestBuildMultiStageLayerLeak
15:54:04 [2019-10-22T15:54:04.438Z] --- PASS: TestBuildMultiStageLayerLeak (3.16s)
15:54:04 [2019-10-22T15:54:04.438Z] === RUN TestBuildWithHugeFile
15:54:38 [2019-10-22T15:54:38.837Z] --- PASS: TestBuildWithHugeFile (32.40s)
15:54:38 [2019-10-22T15:54:38.837Z] === RUN TestBuildWithEmptyDockerfile
15:54:38 [2019-10-22T15:54:38.837Z] === RUN TestBuildWithEmptyDockerfile/empty-dockerfile
15:54:38 [2019-10-22T15:54:38.837Z] === PAUSE TestBuildWithEmptyDockerfile/empty-dockerfile
15:54:38 [2019-10-22T15:54:38.837Z] === RUN TestBuildWithEmptyDockerfile/empty-lines-dockerfile
15:54:38 [2019-10-22T15:54:38.837Z] === PAUSE TestBuildWithEmptyDockerfile/empty-lines-dockerfile
15:54:38 [2019-10-22T15:54:38.837Z] === RUN TestBuildWithEmptyDockerfile/comment-only-dockerfile
15:54:38 [2019-10-22T15:54:38.837Z] === PAUSE TestBuildWithEmptyDockerfile/comment-only-dockerfile
15:54:38 [2019-10-22T15:54:38.837Z] === CONT TestBuildWithEmptyDockerfile/empty-dockerfile
15:54:38 [2019-10-22T15:54:38.837Z] === CONT TestBuildWithEmptyDockerfile/comment-only-dockerfile
15:54:38 [2019-10-22T15:54:38.837Z] === CONT TestBuildWithEmptyDockerfile/empty-lines-dockerfile
15:54:38 [2019-10-22T15:54:38.837Z] --- PASS: TestBuildWithEmptyDockerfile (0.12s)
15:54:38 [2019-10-22T15:54:38.837Z] --- PASS: TestBuildWithEmptyDockerfile/comment-only-dockerfile (0.16s)
15:54:38 [2019-10-22T15:54:38.837Z] --- PASS: TestBuildWithEmptyDockerfile/empty-dockerfile (0.18s)
15:54:38 [2019-10-22T15:54:38.837Z] --- PASS: TestBuildWithEmptyDockerfile/empty-lines-dockerfile (0.11s)
15:54:38 [2019-10-22T15:54:38.837Z] === RUN TestBuildPreserveOwnership
15:54:38 [2019-10-22T15:54:38.837Z] === RUN TestBuildPreserveOwnership/copy_from
15:54:41 [2019-10-22T15:54:41.393Z] === RUN TestBuildPreserveOwnership/copy_from_chowned
15:54:43 [2019-10-22T15:54:43.199Z] --- PASS: TestBuildPreserveOwnership (6.29s)
15:54:43 [2019-10-22T15:54:43.199Z] --- PASS: TestBuildPreserveOwnership/copy_from (4.20s)
15:54:43 [2019-10-22T15:54:43.199Z] --- PASS: TestBuildPreserveOwnership/copy_from_chowned (2.08s)
15:54:43 [2019-10-22T15:54:43.199Z] === RUN TestBuildPlatformInvalid
15:54:43 [2019-10-22T15:54:43.581Z] --- PASS: TestBuildPlatformInvalid (0.14s)
15:54:43 [2019-10-22T15:54:43.581Z] PASS
15:54:43 [2019-10-22T15:54:43.581Z]
15:54:43 [2019-10-22T15:54:43.581Z] === Skipped
15:54:43 [2019-10-22T15:54:43.581Z] === SKIP: s390x.integration.build TestBuildWithSession (0.00s)
15:54:43 [2019-10-22T15:54:43.581Z] build_session_test.go:25: TODO: BuildKit
15:54:43 [2019-10-22T15:54:43.581Z]
15:54:43 [2019-10-22T15:54:43.581Z]
15:54:43 [2019-10-22T15:54:43.581Z] DONE 32 tests, 1 skipped in 81.632s
15:54:43 [2019-10-22T15:54:43.581Z] Running /go/src/github.com/docker/docker/integration/config (s390x.integration.config) flags=-test.v -test.timeout=120m
15:54:43 [2019-10-22T15:54:43.581Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-config-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-config-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.config -t ./test.main -test.v -test.timeout=120m
15:54:43 [2019-10-22T15:54:43.581Z] ++ set -e
15:54:43 [2019-10-22T15:54:43.581Z] ++ '[' -n 0 ']'
15:54:43 [2019-10-22T15:54:43.581Z] ++ set -x
15:54:43 [2019-10-22T15:54:43.581Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=s390x DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-config-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-config-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.config -t ./test.main -test.v -test.timeout=120m
15:54:43 [2019-10-22T15:54:43.581Z] INFO: Testing against a local daemon
15:54:43 [2019-10-22T15:54:43.581Z] === RUN TestConfigList
15:54:46 [2019-10-22T15:54:46.804Z] --- PASS: TestConfigList (2.81s)
15:54:46 [2019-10-22T15:54:46.804Z] config_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigList"
15:54:46 [2019-10-22T15:54:46.804Z] === RUN TestConfigsCreateAndDelete
15:54:49 [2019-10-22T15:54:49.242Z] --- PASS: TestConfigsCreateAndDelete (2.29s)
15:54:49 [2019-10-22T15:54:49.242Z] config_test.go:112: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigsCreateAndDelete"
15:54:49 [2019-10-22T15:54:49.242Z] === RUN TestConfigsUpdate
15:54:51 [2019-10-22T15:54:51.734Z] --- PASS: TestConfigsUpdate (2.86s)
15:54:51 [2019-10-22T15:54:51.734Z] config_test.go:140: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigsUpdate"
15:54:51 [2019-10-22T15:54:51.734Z] === RUN TestTemplatedConfig
15:54:55 [2019-10-22T15:54:55.841Z] --- PASS: TestTemplatedConfig (3.48s)
15:54:55 [2019-10-22T15:54:55.841Z] config_test.go:192: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestTemplatedConfig"
15:54:55 [2019-10-22T15:54:55.841Z] === RUN TestConfigInspect
15:54:57 [2019-10-22T15:54:57.638Z] --- PASS: TestConfigInspect (2.36s)
15:54:57 [2019-10-22T15:54:57.638Z] config_test.go:326: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigInspect"
15:54:57 [2019-10-22T15:54:57.638Z] === RUN TestConfigCreateWithLabels
15:55:00 [2019-10-22T15:55:00.133Z] --- PASS: TestConfigCreateWithLabels (2.77s)
15:55:00 [2019-10-22T15:55:00.133Z] config_test.go:350: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigCreateWithLabels"
15:55:00 [2019-10-22T15:55:00.133Z] === RUN TestConfigCreateResolve
15:55:03 [2019-10-22T15:55:03.341Z] --- PASS: TestConfigCreateResolve (2.71s)
15:55:03 [2019-10-22T15:55:03.341Z] config_test.go:377: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigCreateResolve"
15:55:03 [2019-10-22T15:55:03.341Z] === RUN TestConfigDaemonLibtrustID
15:55:03 [2019-10-22T15:55:03.717Z] --- PASS: TestConfigDaemonLibtrustID (0.53s)
15:55:03 [2019-10-22T15:55:03.718Z] config_test.go:427: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigDaemonLibtrustID"
15:55:03 [2019-10-22T15:55:03.718Z] PASS
15:55:03 [2019-10-22T15:55:03.718Z]
15:55:03 [2019-10-22T15:55:03.718Z] DONE 8 tests in 19.914s
15:55:03 [2019-10-22T15:55:03.718Z] Running /go/src/github.com/docker/docker/integration/container (s390x.integration.container) flags=-test.v -test.timeout=120m
15:55:03 [2019-10-22T15:55:03.718Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-container-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-container-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.container -t ./test.main -test.v -test.timeout=120m
15:55:03 [2019-10-22T15:55:03.718Z] ++ set -e
15:55:03 [2019-10-22T15:55:03.718Z] ++ '[' -n 0 ']'
15:55:03 [2019-10-22T15:55:03.718Z] ++ set -x
15:55:03 [2019-10-22T15:55:03.718Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=s390x DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-container-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-container-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.container -t ./test.main -test.v -test.timeout=120m
15:55:03 [2019-10-22T15:55:03.718Z] INFO: Testing against a local daemon
15:55:03 [2019-10-22T15:55:03.718Z] === RUN TestCheckpoint
15:55:03 [2019-10-22T15:55:03.718Z] --- SKIP: TestCheckpoint (0.00s)
15:55:03 [2019-10-22T15:55:03.718Z] checkpoint_test.go:33: TestCheckpoint is broken; see https://github.com/moby/moby/issues/38963
15:55:03 [2019-10-22T15:55:03.718Z] === RUN TestContainerInvalidJSON
15:55:03 [2019-10-22T15:55:03.718Z] === RUN TestContainerInvalidJSON//containers/foobar/copy
15:55:03 [2019-10-22T15:55:03.718Z] === PAUSE TestContainerInvalidJSON//containers/foobar/copy
15:55:03 [2019-10-22T15:55:03.718Z] === RUN TestContainerInvalidJSON//containers/foobar/exec
15:55:03 [2019-10-22T15:55:03.718Z] === PAUSE TestContainerInvalidJSON//containers/foobar/exec
15:55:03 [2019-10-22T15:55:03.718Z] === RUN TestContainerInvalidJSON//exec/foobar/start
15:55:03 [2019-10-22T15:55:03.718Z] === PAUSE TestContainerInvalidJSON//exec/foobar/start
15:55:03 [2019-10-22T15:55:03.718Z] === CONT TestContainerInvalidJSON//containers/foobar/copy
15:55:03 [2019-10-22T15:55:03.718Z] === CONT TestContainerInvalidJSON//exec/foobar/start
15:55:03 [2019-10-22T15:55:03.718Z] === CONT TestContainerInvalidJSON//containers/foobar/exec
15:55:03 [2019-10-22T15:55:03.718Z] --- PASS: TestContainerInvalidJSON (0.01s)
15:55:03 [2019-10-22T15:55:03.718Z] --- PASS: TestContainerInvalidJSON//containers/foobar/copy (0.00s)
15:55:03 [2019-10-22T15:55:03.718Z] --- PASS: TestContainerInvalidJSON//exec/foobar/start (0.00s)
15:55:03 [2019-10-22T15:55:03.718Z] --- PASS: TestContainerInvalidJSON//containers/foobar/exec (0.00s)
15:55:03 [2019-10-22T15:55:03.718Z] === RUN TestCopyFromContainerPathDoesNotExist
15:55:03 [2019-10-22T15:55:03.718Z] --- PASS: TestCopyFromContainerPathDoesNotExist (0.11s)
15:55:03 [2019-10-22T15:55:03.718Z] === RUN TestCopyFromContainerPathIsNotDir
15:55:04 [2019-10-22T15:55:04.082Z] --- PASS: TestCopyFromContainerPathIsNotDir (0.14s)
15:55:04 [2019-10-22T15:55:04.082Z] === RUN TestCopyToContainerPathDoesNotExist
15:55:04 [2019-10-22T15:55:04.082Z] --- PASS: TestCopyToContainerPathDoesNotExist (0.11s)
15:55:04 [2019-10-22T15:55:04.082Z] === RUN TestCopyToContainerPathIsNotDir
15:55:04 [2019-10-22T15:55:04.082Z] --- PASS: TestCopyToContainerPathIsNotDir (0.09s)
15:55:04 [2019-10-22T15:55:04.082Z] === RUN TestCopyFromContainer
15:55:05 [2019-10-22T15:55:05.986Z] === RUN TestCopyFromContainer//
15:55:05 [2019-10-22T15:55:05.986Z] === RUN TestCopyFromContainer//bar/root
15:55:06 [2019-10-22T15:55:06.370Z] === RUN TestCopyFromContainer//bar/root/
15:55:06 [2019-10-22T15:55:06.370Z] === RUN TestCopyFromContainer/bar/quux
15:55:06 [2019-10-22T15:55:06.370Z] === RUN TestCopyFromContainer/bar/quux/
15:55:06 [2019-10-22T15:55:06.370Z] === RUN TestCopyFromContainer/bar/quux/baz
15:55:06 [2019-10-22T15:55:06.370Z] === RUN TestCopyFromContainer/bar/filesymlink
15:55:06 [2019-10-22T15:55:06.756Z] === RUN TestCopyFromContainer/bar/dirsymlink
15:55:06 [2019-10-22T15:55:06.756Z] === RUN TestCopyFromContainer/bar/dirsymlink/
15:55:06 [2019-10-22T15:55:06.756Z] === RUN TestCopyFromContainer/bar/notarget
15:55:06 [2019-10-22T15:55:06.756Z] --- PASS: TestCopyFromContainer (2.79s)
15:55:06 [2019-10-22T15:55:06.756Z] --- PASS: TestCopyFromContainer// (0.05s)
15:55:06 [2019-10-22T15:55:06.756Z] --- PASS: TestCopyFromContainer//bar/root (0.11s)
15:55:06 [2019-10-22T15:55:06.756Z] --- PASS: TestCopyFromContainer//bar/root/ (0.07s)
15:55:06 [2019-10-22T15:55:06.756Z] --- PASS: TestCopyFromContainer/bar/quux (0.10s)
15:55:06 [2019-10-22T15:55:06.756Z] --- PASS: TestCopyFromContainer/bar/quux/ (0.07s)
15:55:06 [2019-10-22T15:55:06.756Z] --- PASS: TestCopyFromContainer/bar/quux/baz (0.07s)
15:55:06 [2019-10-22T15:55:06.756Z] --- PASS: TestCopyFromContainer/bar/filesymlink (0.11s)
15:55:06 [2019-10-22T15:55:06.756Z] --- PASS: TestCopyFromContainer/bar/dirsymlink (0.09s)
15:55:06 [2019-10-22T15:55:06.756Z] --- PASS: TestCopyFromContainer/bar/dirsymlink/ (0.09s)
15:55:06 [2019-10-22T15:55:06.756Z] --- PASS: TestCopyFromContainer/bar/notarget (0.08s)
15:55:06 [2019-10-22T15:55:06.756Z] === RUN TestCreateFailsWhenIdentifierDoesNotExist
15:55:06 [2019-10-22T15:55:06.756Z] === RUN TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
15:55:06 [2019-10-22T15:55:06.756Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
15:55:06 [2019-10-22T15:55:06.756Z] === RUN TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
15:55:06 [2019-10-22T15:55:06.756Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
15:55:06 [2019-10-22T15:55:06.756Z] === RUN TestCreateFailsWhenIdentifierDoesNotExist/digest
15:55:06 [2019-10-22T15:55:06.756Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/digest
15:55:06 [2019-10-22T15:55:06.756Z] === CONT TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
15:55:06 [2019-10-22T15:55:06.756Z] === CONT TestCreateFailsWhenIdentifierDoesNotExist/digest
15:55:06 [2019-10-22T15:55:06.756Z] === CONT TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
15:55:06 [2019-10-22T15:55:06.756Z] --- PASS: TestCreateFailsWhenIdentifierDoesNotExist (0.01s)
15:55:06 [2019-10-22T15:55:06.756Z] --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/digest (0.00s)
15:55:06 [2019-10-22T15:55:06.756Z] --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag (0.00s)
15:55:06 [2019-10-22T15:55:06.756Z] --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag (0.00s)
15:55:06 [2019-10-22T15:55:06.756Z] === RUN TestCreateLinkToNonExistingContainer
15:55:07 [2019-10-22T15:55:07.129Z] --- PASS: TestCreateLinkToNonExistingContainer (0.04s)
15:55:07 [2019-10-22T15:55:07.129Z] === RUN TestCreateWithInvalidEnv
15:55:07 [2019-10-22T15:55:07.129Z] === RUN TestCreateWithInvalidEnv/0
15:55:07 [2019-10-22T15:55:07.129Z] === PAUSE TestCreateWithInvalidEnv/0
15:55:07 [2019-10-22T15:55:07.129Z] === RUN TestCreateWithInvalidEnv/1
15:55:07 [2019-10-22T15:55:07.129Z] === PAUSE TestCreateWithInvalidEnv/1
15:55:07 [2019-10-22T15:55:07.129Z] === RUN TestCreateWithInvalidEnv/2
15:55:07 [2019-10-22T15:55:07.129Z] === PAUSE TestCreateWithInvalidEnv/2
15:55:07 [2019-10-22T15:55:07.129Z] === CONT TestCreateWithInvalidEnv/0
15:55:07 [2019-10-22T15:55:07.129Z] === CONT TestCreateWithInvalidEnv/2
15:55:07 [2019-10-22T15:55:07.129Z] === CONT TestCreateWithInvalidEnv/1
15:55:07 [2019-10-22T15:55:07.129Z] --- PASS: TestCreateWithInvalidEnv (0.02s)
15:55:07 [2019-10-22T15:55:07.129Z] --- PASS: TestCreateWithInvalidEnv/2 (0.00s)
15:55:07 [2019-10-22T15:55:07.129Z] --- PASS: TestCreateWithInvalidEnv/0 (0.00s)
15:55:07 [2019-10-22T15:55:07.129Z] --- PASS: TestCreateWithInvalidEnv/1 (0.00s)
15:55:07 [2019-10-22T15:55:07.129Z] === RUN TestCreateTmpfsMountsTarget
15:55:07 [2019-10-22T15:55:07.129Z] --- PASS: TestCreateTmpfsMountsTarget (0.02s)
15:55:07 [2019-10-22T15:55:07.129Z] === RUN TestCreateWithCustomMaskedPaths
15:55:09 [2019-10-22T15:55:09.581Z] --- PASS: TestCreateWithCustomMaskedPaths (2.44s)
15:55:09 [2019-10-22T15:55:09.581Z] === RUN TestCreateWithCapabilities
15:55:09 [2019-10-22T15:55:09.581Z] === RUN TestCreateWithCapabilities/no_capabilities
15:55:09 [2019-10-22T15:55:09.581Z] === PAUSE TestCreateWithCapabilities/no_capabilities
15:55:09 [2019-10-22T15:55:09.581Z] === RUN TestCreateWithCapabilities/empty_capabilities
15:55:09 [2019-10-22T15:55:09.581Z] === PAUSE TestCreateWithCapabilities/empty_capabilities
15:55:09 [2019-10-22T15:55:09.581Z] === RUN TestCreateWithCapabilities/valid_capabilities
15:55:09 [2019-10-22T15:55:09.581Z] === PAUSE TestCreateWithCapabilities/valid_capabilities
15:55:09 [2019-10-22T15:55:09.581Z] === RUN TestCreateWithCapabilities/invalid_capabilities
15:55:09 [2019-10-22T15:55:09.581Z] === PAUSE TestCreateWithCapabilities/invalid_capabilities
15:55:09 [2019-10-22T15:55:09.581Z] === RUN TestCreateWithCapabilities/duplicate_capabilities
15:55:09 [2019-10-22T15:55:09.581Z] === PAUSE TestCreateWithCapabilities/duplicate_capabilities
15:55:09 [2019-10-22T15:55:09.581Z] === RUN TestCreateWithCapabilities/capabilities_API_v1.39
15:55:09 [2019-10-22T15:55:09.581Z] === PAUSE TestCreateWithCapabilities/capabilities_API_v1.39
15:55:09 [2019-10-22T15:55:09.581Z] === RUN TestCreateWithCapabilities/empty_capadd
15:55:09 [2019-10-22T15:55:09.581Z] === PAUSE TestCreateWithCapabilities/empty_capadd
15:55:09 [2019-10-22T15:55:09.581Z] === RUN TestCreateWithCapabilities/empty_capdrop
15:55:09 [2019-10-22T15:55:09.581Z] === PAUSE TestCreateWithCapabilities/empty_capdrop
15:55:09 [2019-10-22T15:55:09.581Z] === RUN TestCreateWithCapabilities/capadd_capdrop
15:55:09 [2019-10-22T15:55:09.581Z] === PAUSE TestCreateWithCapabilities/capadd_capdrop
15:55:09 [2019-10-22T15:55:09.581Z] === RUN TestCreateWithCapabilities/conflict_with_capadd
15:55:09 [2019-10-22T15:55:09.581Z] === PAUSE TestCreateWithCapabilities/conflict_with_capadd
15:55:09 [2019-10-22T15:55:09.581Z] === RUN TestCreateWithCapabilities/conflict_with_capdrop
15:55:09 [2019-10-22T15:55:09.581Z] === PAUSE TestCreateWithCapabilities/conflict_with_capdrop
15:55:09 [2019-10-22T15:55:09.581Z] === CONT TestCreateWithCapabilities/no_capabilities
15:55:09 [2019-10-22T15:55:09.581Z] === CONT TestCreateWithCapabilities/conflict_with_capdrop
15:55:09 [2019-10-22T15:55:09.581Z] === CONT TestCreateWithCapabilities/conflict_with_capadd
15:55:09 [2019-10-22T15:55:09.581Z] === CONT TestCreateWithCapabilities/capadd_capdrop
15:55:09 [2019-10-22T15:55:09.581Z] === CONT TestCreateWithCapabilities/empty_capdrop
15:55:09 [2019-10-22T15:55:09.581Z] === CONT TestCreateWithCapabilities/empty_capadd
15:55:09 [2019-10-22T15:55:09.581Z] === CONT TestCreateWithCapabilities/capabilities_API_v1.39
15:55:09 [2019-10-22T15:55:09.581Z] === CONT TestCreateWithCapabilities/duplicate_capabilities
15:55:09 [2019-10-22T15:55:09.581Z] === CONT TestCreateWithCapabilities/invalid_capabilities
15:55:09 [2019-10-22T15:55:09.581Z] === CONT TestCreateWithCapabilities/valid_capabilities
15:55:09 [2019-10-22T15:55:09.581Z] === CONT TestCreateWithCapabilities/empty_capabilities
15:55:09 [2019-10-22T15:55:09.581Z] --- PASS: TestCreateWithCapabilities (0.02s)
15:55:09 [2019-10-22T15:55:09.581Z] --- PASS: TestCreateWithCapabilities/conflict_with_capdrop (0.00s)
15:55:09 [2019-10-22T15:55:09.581Z] --- PASS: TestCreateWithCapabilities/conflict_with_capadd (0.00s)
15:55:09 [2019-10-22T15:55:09.581Z] --- PASS: TestCreateWithCapabilities/no_capabilities (0.06s)
15:55:09 [2019-10-22T15:55:09.581Z] --- PASS: TestCreateWithCapabilities/capadd_capdrop (0.08s)
15:55:09 [2019-10-22T15:55:09.581Z] --- PASS: TestCreateWithCapabilities/empty_capdrop (0.07s)
15:55:09 [2019-10-22T15:55:09.581Z] --- PASS: TestCreateWithCapabilities/empty_capadd (0.06s)
15:55:09 [2019-10-22T15:55:09.581Z] --- PASS: TestCreateWithCapabilities/capabilities_API_v1.39 (0.05s)
15:55:09 [2019-10-22T15:55:09.581Z] --- PASS: TestCreateWithCapabilities/invalid_capabilities (0.00s)
15:55:09 [2019-10-22T15:55:09.581Z] --- PASS: TestCreateWithCapabilities/duplicate_capabilities (0.06s)
15:55:09 [2019-10-22T15:55:09.581Z] --- PASS: TestCreateWithCapabilities/valid_capabilities (0.07s)
15:55:09 [2019-10-22T15:55:09.581Z] --- PASS: TestCreateWithCapabilities/empty_capabilities (0.07s)
15:55:09 [2019-10-22T15:55:09.581Z] === RUN TestCreateWithCustomReadonlyPaths
15:55:12 [2019-10-22T15:55:12.872Z] --- PASS: TestCreateWithCustomReadonlyPaths (2.65s)
15:55:12 [2019-10-22T15:55:12.872Z] === RUN TestCreateWithInvalidHealthcheckParams
15:55:12 [2019-10-22T15:55:12.872Z] === RUN TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
15:55:12 [2019-10-22T15:55:12.872Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
15:55:12 [2019-10-22T15:55:12.872Z] === RUN TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
15:55:12 [2019-10-22T15:55:12.872Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
15:55:12 [2019-10-22T15:55:12.872Z] === RUN TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
15:55:12 [2019-10-22T15:55:12.872Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
15:55:12 [2019-10-22T15:55:12.872Z] === RUN TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
15:55:12 [2019-10-22T15:55:12.872Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
15:55:12 [2019-10-22T15:55:12.872Z] === RUN TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
15:55:12 [2019-10-22T15:55:12.872Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
15:55:12 [2019-10-22T15:55:12.872Z] === CONT TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
15:55:12 [2019-10-22T15:55:12.872Z] === CONT TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
15:55:12 [2019-10-22T15:55:12.872Z] === CONT TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
15:55:12 [2019-10-22T15:55:12.872Z] === CONT TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
15:55:12 [2019-10-22T15:55:12.872Z] === CONT TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
15:55:12 [2019-10-22T15:55:12.872Z] --- PASS: TestCreateWithInvalidHealthcheckParams (0.01s)
15:55:12 [2019-10-22T15:55:12.872Z] --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0 (0.01s)
15:55:12 [2019-10-22T15:55:12.872Z] --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s (0.01s)
15:55:12 [2019-10-22T15:55:12.872Z] --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms (0.01s)
15:55:12 [2019-10-22T15:55:12.872Z] --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms (0.01s)
15:55:12 [2019-10-22T15:55:12.872Z] --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms (0.01s)
15:55:12 [2019-10-22T15:55:12.872Z] === RUN TestContainerStartOnDaemonRestart
15:55:12 [2019-10-22T15:55:12.872Z] === PAUSE TestContainerStartOnDaemonRestart
15:55:12 [2019-10-22T15:55:12.872Z] === RUN TestDaemonRestartIpcMode
15:55:12 [2019-10-22T15:55:12.872Z] === PAUSE TestDaemonRestartIpcMode
15:55:12 [2019-10-22T15:55:12.872Z] === RUN TestDiff
15:55:13 [2019-10-22T15:55:13.238Z] --- PASS: TestDiff (0.76s)
15:55:13 [2019-10-22T15:55:13.238Z] === RUN TestExecWithCloseStdin
15:55:14 [2019-10-22T15:55:14.492Z] --- PASS: TestExecWithCloseStdin (1.12s)
15:55:14 [2019-10-22T15:55:14.492Z] === RUN TestExec
15:55:15 [2019-10-22T15:55:15.270Z] --- PASS: TestExec (1.04s)
15:55:15 [2019-10-22T15:55:15.270Z] === RUN TestExecUser
15:55:16 [2019-10-22T15:55:16.548Z] --- PASS: TestExecUser (1.04s)
15:55:16 [2019-10-22T15:55:16.548Z] === RUN TestExportContainerAndImportImage
15:55:17 [2019-10-22T15:55:17.466Z] --- PASS: TestExportContainerAndImportImage (1.28s)
15:55:17 [2019-10-22T15:55:17.466Z] === RUN TestExportContainerAfterDaemonRestart
15:55:19 [2019-10-22T15:55:19.259Z] --- PASS: TestExportContainerAfterDaemonRestart (1.51s)
15:55:19 [2019-10-22T15:55:19.259Z] export_test.go:63: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestExportContainerAfterDaemonRestart"
15:55:19 [2019-10-22T15:55:19.259Z] === RUN TestHealthCheckWorkdir
15:55:20 [2019-10-22T15:55:20.516Z] --- PASS: TestHealthCheckWorkdir (1.12s)
15:55:20 [2019-10-22T15:55:20.516Z] === RUN TestHealthKillContainer
15:55:23 [2019-10-22T15:55:23.756Z] --- PASS: TestHealthKillContainer (3.05s)
15:55:23 [2019-10-22T15:55:23.756Z] === RUN TestInspectCpusetInConfigPre120
15:55:24 [2019-10-22T15:55:24.140Z] --- PASS: TestInspectCpusetInConfigPre120 (0.88s)
15:55:24 [2019-10-22T15:55:24.140Z] === RUN TestIpcModeNone
15:55:25 [2019-10-22T15:55:25.380Z] --- PASS: TestIpcModeNone (1.05s)
15:55:25 [2019-10-22T15:55:25.380Z] === RUN TestIpcModePrivate
15:55:26 [2019-10-22T15:55:26.167Z] --- PASS: TestIpcModePrivate (1.06s)
15:55:26 [2019-10-22T15:55:26.167Z] ipcmode_linux_test.go:90: [testIpcPrivateShareable] ipcmode: private, ipcdev: 0:64, shared: false, mustBeShared: false
15:55:26 [2019-10-22T15:55:26.167Z] === RUN TestIpcModeShareable
15:55:27 [2019-10-22T15:55:27.418Z] --- PASS: TestIpcModeShareable (1.04s)
15:55:27 [2019-10-22T15:55:27.418Z] ipcmode_linux_test.go:90: [testIpcPrivateShareable] ipcmode: shareable, ipcdev: 0:58, shared: true, mustBeShared: true
15:55:27 [2019-10-22T15:55:27.418Z] === RUN TestAPIIpcModeShareableAndContainer
15:55:30 [2019-10-22T15:55:30.715Z] --- PASS: TestAPIIpcModeShareableAndContainer (3.26s)
15:55:30 [2019-10-22T15:55:30.715Z] === RUN TestAPIIpcModeHost
15:55:31 [2019-10-22T15:55:31.506Z] --- PASS: TestAPIIpcModeHost (0.84s)
15:55:31 [2019-10-22T15:55:31.506Z] === RUN TestDaemonIpcModeShareable
15:55:33 [2019-10-22T15:55:33.330Z] --- PASS: TestDaemonIpcModeShareable (1.96s)
15:55:33 [2019-10-22T15:55:33.330Z] ipcmode_linux_test.go:230: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModeShareable"
15:55:33 [2019-10-22T15:55:33.330Z] ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:66, shared: true, mustBeShared: true
15:55:33 [2019-10-22T15:55:33.330Z] === RUN TestDaemonIpcModePrivate
15:55:35 [2019-10-22T15:55:35.233Z] --- PASS: TestDaemonIpcModePrivate (1.83s)
15:55:35 [2019-10-22T15:55:35.233Z] ipcmode_linux_test.go:230: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModePrivate"
15:55:35 [2019-10-22T15:55:35.233Z] ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:72, shared: false, mustBeShared: false
15:55:35 [2019-10-22T15:55:35.233Z] === RUN TestDaemonIpcModePrivateFromConfig
15:55:37 [2019-10-22T15:55:37.077Z] --- PASS: TestDaemonIpcModePrivateFromConfig (1.75s)
15:55:37 [2019-10-22T15:55:37.077Z] ipcmode_linux_test.go:230: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModePrivateFromConfig"
15:55:37 [2019-10-22T15:55:37.077Z] ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:72, shared: false, mustBeShared: false
15:55:37 [2019-10-22T15:55:37.077Z] === RUN TestDaemonIpcModeShareableFromConfig
15:55:38 [2019-10-22T15:55:38.910Z] --- PASS: TestDaemonIpcModeShareableFromConfig (1.81s)
15:55:38 [2019-10-22T15:55:38.910Z] ipcmode_linux_test.go:230: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModeShareableFromConfig"
15:55:38 [2019-10-22T15:55:38.910Z] ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:66, shared: true, mustBeShared: true
15:55:38 [2019-10-22T15:55:38.910Z] === RUN TestIpcModeOlderClient
15:55:38 [2019-10-22T15:55:38.910Z] === PAUSE TestIpcModeOlderClient
15:55:38 [2019-10-22T15:55:38.910Z] === RUN TestKillContainerInvalidSignal
15:55:39 [2019-10-22T15:55:39.680Z] --- PASS: TestKillContainerInvalidSignal (0.82s)
15:55:39 [2019-10-22T15:55:39.680Z] === RUN TestKillContainer
15:55:39 [2019-10-22T15:55:39.680Z] === RUN TestKillContainer/no_signal
15:55:40 [2019-10-22T15:55:40.593Z] === RUN TestKillContainer/non_killing_signal
15:55:41 [2019-10-22T15:55:41.424Z] === RUN TestKillContainer/killing_signal
15:55:42 [2019-10-22T15:55:42.210Z] --- PASS: TestKillContainer (2.76s)
15:55:42 [2019-10-22T15:55:42.210Z] --- PASS: TestKillContainer/no_signal (0.96s)
15:55:42 [2019-10-22T15:55:42.210Z] --- PASS: TestKillContainer/non_killing_signal (0.64s)
15:55:42 [2019-10-22T15:55:42.210Z] --- PASS: TestKillContainer/killing_signal (0.75s)
15:55:42 [2019-10-22T15:55:42.210Z] === RUN TestKillWithStopSignalAndRestartPolicies
15:55:42 [2019-10-22T15:55:42.210Z] === RUN TestKillWithStopSignalAndRestartPolicies/same-signal-disables-restart-policy
15:55:43 [2019-10-22T15:55:43.465Z] === RUN TestKillWithStopSignalAndRestartPolicies/different-signal-keep-restart-policy
15:55:44 [2019-10-22T15:55:44.246Z] --- PASS: TestKillWithStopSignalAndRestartPolicies (1.75s)
15:55:44 [2019-10-22T15:55:44.247Z] --- PASS: TestKillWithStopSignalAndRestartPolicies/same-signal-disables-restart-policy (0.84s)
15:55:44 [2019-10-22T15:55:44.247Z] --- PASS: TestKillWithStopSignalAndRestartPolicies/different-signal-keep-restart-policy (0.56s)
15:55:44 [2019-10-22T15:55:44.247Z] === RUN TestKillStoppedContainer
15:55:44 [2019-10-22T15:55:44.247Z] --- PASS: TestKillStoppedContainer (0.10s)
15:55:44 [2019-10-22T15:55:44.247Z] === RUN TestKillStoppedContainerAPIPre120
15:55:44 [2019-10-22T15:55:44.247Z] --- PASS: TestKillStoppedContainerAPIPre120 (0.10s)
15:55:44 [2019-10-22T15:55:44.247Z] === RUN TestKillDifferentUserContainer
15:55:45 [2019-10-22T15:55:45.046Z] --- PASS: TestKillDifferentUserContainer (0.89s)
15:55:45 [2019-10-22T15:55:45.046Z] === RUN TestInspectOomKilledTrue
15:55:45 [2019-10-22T15:55:45.046Z] --- SKIP: TestInspectOomKilledTrue (0.00s)
15:55:45 [2019-10-22T15:55:45.046Z] kill_test.go:151: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
15:55:45 [2019-10-22T15:55:45.046Z] === RUN TestInspectOomKilledFalse
15:55:45 [2019-10-22T15:55:45.046Z] --- SKIP: TestInspectOomKilledFalse (0.00s)
15:55:45 [2019-10-22T15:55:45.046Z] kill_test.go:169: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
15:55:45 [2019-10-22T15:55:45.046Z] === RUN TestLinksEtcHostsContentMatch
15:55:46 [2019-10-22T15:55:46.046Z] --- PASS: TestLinksEtcHostsContentMatch (0.72s)
15:55:46 [2019-10-22T15:55:46.046Z] === RUN TestLinksContainerNames
15:55:47 [2019-10-22T15:55:47.861Z] --- PASS: TestLinksContainerNames (1.66s)
15:55:47 [2019-10-22T15:55:47.861Z] === RUN TestLogsFollowTailEmpty
15:55:48 [2019-10-22T15:55:48.639Z] --- PASS: TestLogsFollowTailEmpty (0.97s)
15:55:48 [2019-10-22T15:55:48.639Z] === RUN TestContainerNetworkMountsNoChown
15:55:49 [2019-10-22T15:55:49.455Z] --- PASS: TestContainerNetworkMountsNoChown (0.87s)
15:55:49 [2019-10-22T15:55:49.456Z] === RUN TestMountDaemonRoot
15:55:49 [2019-10-22T15:55:49.456Z] === RUN TestMountDaemonRoot/default
15:55:49 [2019-10-22T15:55:49.456Z] === PAUSE TestMountDaemonRoot/default
15:55:49 [2019-10-22T15:55:49.456Z] === RUN TestMountDaemonRoot/private
15:55:49 [2019-10-22T15:55:49.456Z] === PAUSE TestMountDaemonRoot/private
15:55:49 [2019-10-22T15:55:49.456Z] === RUN TestMountDaemonRoot/rprivate
15:55:49 [2019-10-22T15:55:49.456Z] === PAUSE TestMountDaemonRoot/rprivate
15:55:49 [2019-10-22T15:55:49.456Z] === RUN TestMountDaemonRoot/slave
15:55:49 [2019-10-22T15:55:49.456Z] === PAUSE TestMountDaemonRoot/slave
15:55:49 [2019-10-22T15:55:49.456Z] === RUN TestMountDaemonRoot/rslave
15:55:49 [2019-10-22T15:55:49.456Z] === PAUSE TestMountDaemonRoot/rslave
15:55:49 [2019-10-22T15:55:49.456Z] === RUN TestMountDaemonRoot/shared
15:55:49 [2019-10-22T15:55:49.456Z] === PAUSE TestMountDaemonRoot/shared
15:55:49 [2019-10-22T15:55:49.456Z] === RUN TestMountDaemonRoot/rshared
15:55:49 [2019-10-22T15:55:49.456Z] === PAUSE TestMountDaemonRoot/rshared
15:55:49 [2019-10-22T15:55:49.456Z] === CONT TestMountDaemonRoot/default
15:55:49 [2019-10-22T15:55:49.456Z] === RUN TestMountDaemonRoot/default/bind_root
15:55:49 [2019-10-22T15:55:49.456Z] === PAUSE TestMountDaemonRoot/default/bind_root
15:55:49 [2019-10-22T15:55:49.456Z] === RUN TestMountDaemonRoot/default/bind_subpath
15:55:49 [2019-10-22T15:55:49.456Z] === PAUSE TestMountDaemonRoot/default/bind_subpath
15:55:49 [2019-10-22T15:55:49.456Z] === RUN TestMountDaemonRoot/default/mount_root
15:55:49 [2019-10-22T15:55:49.456Z] === PAUSE TestMountDaemonRoot/default/mount_root
15:55:49 [2019-10-22T15:55:49.456Z] === RUN TestMountDaemonRoot/default/mount_subpath
15:55:49 [2019-10-22T15:55:49.456Z] === PAUSE TestMountDaemonRoot/default/mount_subpath
15:55:49 [2019-10-22T15:55:49.456Z] === CONT TestMountDaemonRoot/default/bind_root
15:55:49 [2019-10-22T15:55:49.456Z] === CONT TestMountDaemonRoot/rshared
15:55:49 [2019-10-22T15:55:49.456Z] === RUN TestMountDaemonRoot/rshared/bind_root
15:55:49 [2019-10-22T15:55:49.456Z] === PAUSE TestMountDaemonRoot/rshared/bind_root
15:55:49 [2019-10-22T15:55:49.456Z] === RUN TestMountDaemonRoot/rshared/bind_subpath
15:55:49 [2019-10-22T15:55:49.456Z] === PAUSE TestMountDaemonRoot/rshared/bind_subpath
15:55:49 [2019-10-22T15:55:49.456Z] === RUN TestMountDaemonRoot/rshared/mount_root
15:55:49 [2019-10-22T15:55:49.456Z] === PAUSE TestMountDaemonRoot/rshared/mount_root
15:55:49 [2019-10-22T15:55:49.456Z] === RUN TestMountDaemonRoot/rshared/mount_subpath
15:55:49 [2019-10-22T15:55:49.456Z] === PAUSE TestMountDaemonRoot/rshared/mount_subpath
15:55:49 [2019-10-22T15:55:49.456Z] === CONT TestMountDaemonRoot/rshared/bind_root
15:55:49 [2019-10-22T15:55:49.456Z] === CONT TestMountDaemonRoot/shared
15:55:49 [2019-10-22T15:55:49.456Z] === RUN TestMountDaemonRoot/shared/bind_root
15:55:49 [2019-10-22T15:55:49.456Z] === PAUSE TestMountDaemonRoot/shared/bind_root
15:55:49 [2019-10-22T15:55:49.456Z] === RUN TestMountDaemonRoot/shared/bind_subpath
15:55:49 [2019-10-22T15:55:49.456Z] === PAUSE TestMountDaemonRoot/shared/bind_subpath
15:55:49 [2019-10-22T15:55:49.456Z] === RUN TestMountDaemonRoot/shared/mount_root
15:55:49 [2019-10-22T15:55:49.456Z] === PAUSE TestMountDaemonRoot/shared/mount_root
15:55:49 [2019-10-22T15:55:49.456Z] === RUN TestMountDaemonRoot/shared/mount_subpath
15:55:49 [2019-10-22T15:55:49.456Z] === PAUSE TestMountDaemonRoot/shared/mount_subpath
15:55:49 [2019-10-22T15:55:49.456Z] === CONT TestMountDaemonRoot/rslave
15:55:49 [2019-10-22T15:55:49.456Z] === RUN TestMountDaemonRoot/rslave/bind_root
15:55:49 [2019-10-22T15:55:49.456Z] === PAUSE TestMountDaemonRoot/rslave/bind_root
15:55:49 [2019-10-22T15:55:49.456Z] === RUN TestMountDaemonRoot/rslave/bind_subpath
15:55:49 [2019-10-22T15:55:49.456Z] === PAUSE TestMountDaemonRoot/rslave/bind_subpath
15:55:49 [2019-10-22T15:55:49.456Z] === RUN TestMountDaemonRoot/rslave/mount_root
15:55:49 [2019-10-22T15:55:49.456Z] === PAUSE TestMountDaemonRoot/rslave/mount_root
15:55:49 [2019-10-22T15:55:49.456Z] === RUN TestMountDaemonRoot/rslave/mount_subpath
15:55:49 [2019-10-22T15:55:49.456Z] === PAUSE TestMountDaemonRoot/rslave/mount_subpath
15:55:49 [2019-10-22T15:55:49.456Z] === CONT TestMountDaemonRoot/slave
15:55:49 [2019-10-22T15:55:49.456Z] === RUN TestMountDaemonRoot/slave/bind_root
15:55:49 [2019-10-22T15:55:49.456Z] === PAUSE TestMountDaemonRoot/slave/bind_root
15:55:49 [2019-10-22T15:55:49.456Z] === RUN TestMountDaemonRoot/slave/bind_subpath
15:55:49 [2019-10-22T15:55:49.456Z] === PAUSE TestMountDaemonRoot/slave/bind_subpath
15:55:49 [2019-10-22T15:55:49.456Z] === RUN TestMountDaemonRoot/slave/mount_root
15:55:49 [2019-10-22T15:55:49.456Z] === PAUSE TestMountDaemonRoot/slave/mount_root
15:55:49 [2019-10-22T15:55:49.456Z] === RUN TestMountDaemonRoot/slave/mount_subpath
15:55:49 [2019-10-22T15:55:49.456Z] === PAUSE TestMountDaemonRoot/slave/mount_subpath
15:55:49 [2019-10-22T15:55:49.456Z] === CONT TestMountDaemonRoot/rprivate
15:55:49 [2019-10-22T15:55:49.456Z] === RUN TestMountDaemonRoot/rprivate/bind_root
15:55:49 [2019-10-22T15:55:49.456Z] === PAUSE TestMountDaemonRoot/rprivate/bind_root
15:55:49 [2019-10-22T15:55:49.456Z] === RUN TestMountDaemonRoot/rprivate/bind_subpath
15:55:49 [2019-10-22T15:55:49.456Z] === PAUSE TestMountDaemonRoot/rprivate/bind_subpath
15:55:49 [2019-10-22T15:55:49.456Z] === RUN TestMountDaemonRoot/rprivate/mount_root
15:55:49 [2019-10-22T15:55:49.456Z] === PAUSE TestMountDaemonRoot/rprivate/mount_root
15:55:49 [2019-10-22T15:55:49.456Z] === RUN TestMountDaemonRoot/rprivate/mount_subpath
15:55:49 [2019-10-22T15:55:49.456Z] === PAUSE TestMountDaemonRoot/rprivate/mount_subpath
15:55:49 [2019-10-22T15:55:49.456Z] === CONT TestMountDaemonRoot/private
15:55:49 [2019-10-22T15:55:49.456Z] === RUN TestMountDaemonRoot/private/mount_subpath
15:55:49 [2019-10-22T15:55:49.456Z] === PAUSE TestMountDaemonRoot/private/mount_subpath
15:55:49 [2019-10-22T15:55:49.456Z] === RUN TestMountDaemonRoot/private/bind_root
15:55:49 [2019-10-22T15:55:49.456Z] === PAUSE TestMountDaemonRoot/private/bind_root
15:55:49 [2019-10-22T15:55:49.456Z] === RUN TestMountDaemonRoot/private/bind_subpath
15:55:49 [2019-10-22T15:55:49.456Z] === PAUSE TestMountDaemonRoot/private/bind_subpath
15:55:49 [2019-10-22T15:55:49.456Z] === RUN TestMountDaemonRoot/private/mount_root
15:55:49 [2019-10-22T15:55:49.456Z] === PAUSE TestMountDaemonRoot/private/mount_root
15:55:49 [2019-10-22T15:55:49.456Z] === CONT TestMountDaemonRoot/default/mount_subpath
15:55:49 [2019-10-22T15:55:49.456Z] === CONT TestMountDaemonRoot/default/mount_root
15:55:49 [2019-10-22T15:55:49.456Z] === CONT TestMountDaemonRoot/default/bind_subpath
15:55:49 [2019-10-22T15:55:49.456Z] === CONT TestMountDaemonRoot/rshared/mount_subpath
15:55:49 [2019-10-22T15:55:49.826Z] === CONT TestMountDaemonRoot/rshared/mount_root
15:55:49 [2019-10-22T15:55:49.826Z] === CONT TestMountDaemonRoot/rshared/bind_subpath
15:55:49 [2019-10-22T15:55:49.826Z] === CONT TestMountDaemonRoot/shared/bind_root
15:55:49 [2019-10-22T15:55:49.826Z] === CONT TestMountDaemonRoot/rslave/bind_root
15:55:49 [2019-10-22T15:55:49.826Z] === CONT TestMountDaemonRoot/shared/mount_subpath
15:55:49 [2019-10-22T15:55:49.826Z] === CONT TestMountDaemonRoot/shared/mount_root
15:55:49 [2019-10-22T15:55:49.826Z] === CONT TestMountDaemonRoot/shared/bind_subpath
15:55:49 [2019-10-22T15:55:49.826Z] === CONT TestMountDaemonRoot/slave/bind_root
15:55:49 [2019-10-22T15:55:49.826Z] === CONT TestMountDaemonRoot/rslave/mount_subpath
15:55:49 [2019-10-22T15:55:49.826Z] === CONT TestMountDaemonRoot/rslave/mount_root
15:55:49 [2019-10-22T15:55:49.826Z] === CONT TestMountDaemonRoot/rslave/bind_subpath
15:55:50 [2019-10-22T15:55:50.210Z] === CONT TestMountDaemonRoot/rprivate/bind_root
15:55:50 [2019-10-22T15:55:50.210Z] === CONT TestMountDaemonRoot/slave/mount_subpath
15:55:50 [2019-10-22T15:55:50.210Z] === CONT TestMountDaemonRoot/slave/mount_root
15:55:50 [2019-10-22T15:55:50.210Z] === CONT TestMountDaemonRoot/slave/bind_subpath
15:55:50 [2019-10-22T15:55:50.210Z] === CONT TestMountDaemonRoot/private/mount_subpath
15:55:50 [2019-10-22T15:55:50.210Z] === CONT TestMountDaemonRoot/rprivate/mount_subpath
15:55:50 [2019-10-22T15:55:50.210Z] === CONT TestMountDaemonRoot/rprivate/mount_root
15:55:50 [2019-10-22T15:55:50.210Z] === CONT TestMountDaemonRoot/rprivate/bind_subpath
15:55:50 [2019-10-22T15:55:50.210Z] === CONT TestMountDaemonRoot/private/mount_root
15:55:50 [2019-10-22T15:55:50.210Z] === CONT TestMountDaemonRoot/private/bind_subpath
15:55:50 [2019-10-22T15:55:50.210Z] === CONT TestMountDaemonRoot/private/bind_root
15:55:50 [2019-10-22T15:55:50.210Z] --- PASS: TestMountDaemonRoot (0.02s)
15:55:50 [2019-10-22T15:55:50.210Z] --- PASS: TestMountDaemonRoot/default (0.00s)
15:55:50 [2019-10-22T15:55:50.210Z] --- PASS: TestMountDaemonRoot/default/bind_root (0.09s)
15:55:50 [2019-10-22T15:55:50.210Z] --- PASS: TestMountDaemonRoot/default/mount_subpath (0.07s)
15:55:50 [2019-10-22T15:55:50.210Z] --- PASS: TestMountDaemonRoot/default/mount_root (0.07s)
15:55:50 [2019-10-22T15:55:50.210Z] --- PASS: TestMountDaemonRoot/default/bind_subpath (0.07s)
15:55:50 [2019-10-22T15:55:50.210Z] --- PASS: TestMountDaemonRoot/rshared (0.00s)
15:55:50 [2019-10-22T15:55:50.210Z] --- PASS: TestMountDaemonRoot/rshared/bind_root (0.10s)
15:55:50 [2019-10-22T15:55:50.210Z] --- PASS: TestMountDaemonRoot/rshared/mount_subpath (0.07s)
15:55:50 [2019-10-22T15:55:50.210Z] --- PASS: TestMountDaemonRoot/rshared/bind_subpath (0.09s)
15:55:50 [2019-10-22T15:55:50.210Z] --- PASS: TestMountDaemonRoot/rshared/mount_root (0.09s)
15:55:50 [2019-10-22T15:55:50.210Z] --- PASS: TestMountDaemonRoot/shared (0.00s)
15:55:50 [2019-10-22T15:55:50.210Z] --- PASS: TestMountDaemonRoot/shared/bind_root (0.04s)
15:55:50 [2019-10-22T15:55:50.210Z] --- PASS: TestMountDaemonRoot/shared/mount_subpath (0.03s)
15:55:50 [2019-10-22T15:55:50.210Z] --- PASS: TestMountDaemonRoot/shared/bind_subpath (0.04s)
15:55:50 [2019-10-22T15:55:50.210Z] --- PASS: TestMountDaemonRoot/shared/mount_root (0.05s)
15:55:50 [2019-10-22T15:55:50.210Z] --- PASS: TestMountDaemonRoot/rslave (0.00s)
15:55:50 [2019-10-22T15:55:50.210Z] --- PASS: TestMountDaemonRoot/rslave/bind_root (0.07s)
15:55:50 [2019-10-22T15:55:50.210Z] --- PASS: TestMountDaemonRoot/rslave/mount_subpath (0.07s)
15:55:50 [2019-10-22T15:55:50.210Z] --- PASS: TestMountDaemonRoot/rslave/mount_root (0.09s)
15:55:50 [2019-10-22T15:55:50.210Z] --- PASS: TestMountDaemonRoot/rslave/bind_subpath (0.10s)
15:55:50 [2019-10-22T15:55:50.210Z] --- PASS: TestMountDaemonRoot/slave (0.00s)
15:55:50 [2019-10-22T15:55:50.210Z] --- PASS: TestMountDaemonRoot/slave/bind_root (0.04s)
15:55:50 [2019-10-22T15:55:50.210Z] --- PASS: TestMountDaemonRoot/slave/mount_subpath (0.04s)
15:55:50 [2019-10-22T15:55:50.210Z] --- PASS: TestMountDaemonRoot/slave/mount_root (0.04s)
15:55:50 [2019-10-22T15:55:50.210Z] --- PASS: TestMountDaemonRoot/slave/bind_subpath (0.04s)
15:55:50 [2019-10-22T15:55:50.210Z] --- PASS: TestMountDaemonRoot/rprivate (0.00s)
15:55:50 [2019-10-22T15:55:50.210Z] --- PASS: TestMountDaemonRoot/rprivate/bind_root (0.04s)
15:55:50 [2019-10-22T15:55:50.210Z] --- PASS: TestMountDaemonRoot/rprivate/mount_subpath (0.03s)
15:55:50 [2019-10-22T15:55:50.210Z] --- PASS: TestMountDaemonRoot/rprivate/bind_subpath (0.03s)
15:55:50 [2019-10-22T15:55:50.210Z] --- PASS: TestMountDaemonRoot/rprivate/mount_root (0.05s)
15:55:50 [2019-10-22T15:55:50.210Z] --- PASS: TestMountDaemonRoot/private (0.00s)
15:55:50 [2019-10-22T15:55:50.210Z] --- PASS: TestMountDaemonRoot/private/mount_subpath (0.03s)
15:55:50 [2019-10-22T15:55:50.210Z] --- PASS: TestMountDaemonRoot/private/bind_subpath (0.04s)
15:55:50 [2019-10-22T15:55:50.210Z] --- PASS: TestMountDaemonRoot/private/mount_root (0.04s)
15:55:50 [2019-10-22T15:55:50.210Z] --- PASS: TestMountDaemonRoot/private/bind_root (0.04s)
15:55:50 [2019-10-22T15:55:50.210Z] === RUN TestContainerBindMountNonRecursive
15:55:52 [2019-10-22T15:55:52.215Z] --- PASS: TestContainerBindMountNonRecursive (1.92s)
15:55:52 [2019-10-22T15:55:52.215Z] === RUN TestNetworkNat
15:55:53 [2019-10-22T15:55:53.003Z] --- PASS: TestNetworkNat (0.91s)
15:55:53 [2019-10-22T15:55:53.003Z] === RUN TestNetworkLocalhostTCPNat
15:55:54 [2019-10-22T15:55:54.256Z] --- PASS: TestNetworkLocalhostTCPNat (0.92s)
15:55:54 [2019-10-22T15:55:54.256Z] === RUN TestNetworkLoopbackNat
15:55:55 [2019-10-22T15:55:55.053Z] --- PASS: TestNetworkLoopbackNat (1.12s)
15:55:55 [2019-10-22T15:55:55.053Z] === RUN TestPause
15:55:56 [2019-10-22T15:55:56.306Z] --- PASS: TestPause (1.03s)
15:55:56 [2019-10-22T15:55:56.306Z] === RUN TestPauseFailsOnWindowsServerContainers
15:55:56 [2019-10-22T15:55:56.306Z] --- SKIP: TestPauseFailsOnWindowsServerContainers (0.00s)
15:55:56 [2019-10-22T15:55:56.306Z] pause_test.go:54: testEnv.DaemonInfo.OSType != "windows" || testEnv.DaemonInfo.Isolation != "process"
15:55:56 [2019-10-22T15:55:56.306Z] === RUN TestPauseStopPausedContainer
15:55:57 [2019-10-22T15:55:57.199Z] --- PASS: TestPauseStopPausedContainer (0.88s)
15:55:57 [2019-10-22T15:55:57.199Z] === RUN TestPsFilter
15:55:57 [2019-10-22T15:55:57.199Z] --- PASS: TestPsFilter (0.21s)
15:55:57 [2019-10-22T15:55:57.199Z] === RUN TestRemoveContainerWithRemovedVolume
15:55:58 [2019-10-22T15:55:58.091Z] --- PASS: TestRemoveContainerWithRemovedVolume (0.87s)
15:55:58 [2019-10-22T15:55:58.091Z] === RUN TestRemoveContainerWithVolume
15:55:58 [2019-10-22T15:55:58.893Z] --- PASS: TestRemoveContainerWithVolume (0.83s)
15:55:58 [2019-10-22T15:55:58.893Z] === RUN TestRemoveContainerRunning
15:55:59 [2019-10-22T15:55:59.672Z] --- PASS: TestRemoveContainerRunning (0.83s)
15:55:59 [2019-10-22T15:55:59.672Z] === RUN TestRemoveContainerForceRemoveRunning
15:56:00 [2019-10-22T15:56:00.934Z] --- PASS: TestRemoveContainerForceRemoveRunning (0.90s)
15:56:00 [2019-10-22T15:56:00.934Z] === RUN TestRemoveInvalidContainer
15:56:00 [2019-10-22T15:56:00.934Z] --- PASS: TestRemoveInvalidContainer (0.01s)
15:56:00 [2019-10-22T15:56:00.934Z] === RUN TestRenameLinkedContainer
15:56:04 [2019-10-22T15:56:04.209Z] --- PASS: TestRenameLinkedContainer (3.50s)
15:56:04 [2019-10-22T15:56:04.209Z] === RUN TestRenameStoppedContainer
15:56:05 [2019-10-22T15:56:05.006Z] --- PASS: TestRenameStoppedContainer (0.87s)
15:56:05 [2019-10-22T15:56:05.006Z] === RUN TestRenameRunningContainerAndReuse
15:56:06 [2019-10-22T15:56:06.817Z] --- PASS: TestRenameRunningContainerAndReuse (1.80s)
15:56:06 [2019-10-22T15:56:06.817Z] === RUN TestRenameInvalidName
15:56:08 [2019-10-22T15:56:08.085Z] --- PASS: TestRenameInvalidName (0.95s)
15:56:08 [2019-10-22T15:56:08.085Z] === RUN TestRenameAnonymousContainer
15:56:11 [2019-10-22T15:56:11.346Z] --- PASS: TestRenameAnonymousContainer (3.01s)
15:56:11 [2019-10-22T15:56:11.346Z] === RUN TestRenameContainerWithSameName
15:56:11 [2019-10-22T15:56:11.716Z] --- PASS: TestRenameContainerWithSameName (0.75s)
15:56:11 [2019-10-22T15:56:11.716Z] === RUN TestRenameContainerWithLinkedContainer
15:56:13 [2019-10-22T15:56:13.526Z] --- PASS: TestRenameContainerWithLinkedContainer (1.74s)
15:56:13 [2019-10-22T15:56:13.526Z] === RUN TestResize
15:56:14 [2019-10-22T15:56:14.329Z] --- PASS: TestResize (0.95s)
15:56:14 [2019-10-22T15:56:14.329Z] === RUN TestResizeWithInvalidSize
15:56:15 [2019-10-22T15:56:15.190Z] --- PASS: TestResizeWithInvalidSize (0.90s)
15:56:15 [2019-10-22T15:56:15.190Z] === RUN TestResizeWhenContainerNotStarted
15:56:16 [2019-10-22T15:56:16.017Z] --- PASS: TestResizeWhenContainerNotStarted (0.90s)
15:56:16 [2019-10-22T15:56:16.018Z] === RUN TestDaemonRestartKillContainers
15:56:16 [2019-10-22T15:56:16.018Z] === RUN TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
15:56:16 [2019-10-22T15:56:16.018Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
15:56:16 [2019-10-22T15:56:16.018Z] === RUN TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
15:56:16 [2019-10-22T15:56:16.018Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
15:56:16 [2019-10-22T15:56:16.018Z] === RUN TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
15:56:16 [2019-10-22T15:56:16.018Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
15:56:16 [2019-10-22T15:56:16.018Z] === RUN TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
15:56:16 [2019-10-22T15:56:16.018Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
15:56:16 [2019-10-22T15:56:16.018Z] === RUN TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
15:56:16 [2019-10-22T15:56:16.018Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
15:56:16 [2019-10-22T15:56:16.018Z] === RUN TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
15:56:16 [2019-10-22T15:56:16.018Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
15:56:16 [2019-10-22T15:56:16.018Z] === RUN TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
15:56:16 [2019-10-22T15:56:16.018Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
15:56:16 [2019-10-22T15:56:16.018Z] === RUN TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
15:56:16 [2019-10-22T15:56:16.018Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
15:56:16 [2019-10-22T15:56:16.018Z] === RUN TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
15:56:16 [2019-10-22T15:56:16.018Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
15:56:16 [2019-10-22T15:56:16.018Z] === RUN TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
15:56:16 [2019-10-22T15:56:16.018Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
15:56:16 [2019-10-22T15:56:16.018Z] === RUN TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
15:56:16 [2019-10-22T15:56:16.018Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
15:56:16 [2019-10-22T15:56:16.018Z] === RUN TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
15:56:16 [2019-10-22T15:56:16.018Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
15:56:16 [2019-10-22T15:56:16.018Z] === CONT TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
15:56:16 [2019-10-22T15:56:16.018Z] === CONT TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
15:56:18 [2019-10-22T15:56:18.483Z] === CONT TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
15:56:18 [2019-10-22T15:56:18.483Z] === CONT TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
15:56:19 [2019-10-22T15:56:19.773Z] === CONT TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
15:56:19 [2019-10-22T15:56:19.773Z] === CONT TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
15:56:21 [2019-10-22T15:56:21.682Z] === CONT TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
15:56:21 [2019-10-22T15:56:21.682Z] === CONT TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
15:56:24 [2019-10-22T15:56:24.156Z] === CONT TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
15:56:24 [2019-10-22T15:56:24.156Z] === CONT TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
15:56:25 [2019-10-22T15:56:25.987Z] === CONT TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
15:56:26 [2019-10-22T15:56:26.897Z] === CONT TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
15:56:28 [2019-10-22T15:56:28.812Z] --- PASS: TestDaemonRestartKillContainers (0.00s)
15:56:28 [2019-10-22T15:56:28.812Z] --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon (2.32s)
15:56:28 [2019-10-22T15:56:28.812Z] restart_test.go:67: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon"
15:56:28 [2019-10-22T15:56:28.812Z] --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon (2.35s)
15:56:28 [2019-10-22T15:56:28.812Z] restart_test.go:67: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon"
15:56:28 [2019-10-22T15:56:28.812Z] --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon (1.50s)
15:56:28 [2019-10-22T15:56:28.812Z] restart_test.go:67: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon"
15:56:28 [2019-10-22T15:56:28.812Z] --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon (1.55s)
15:56:28 [2019-10-22T15:56:28.812Z] restart_test.go:67: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon"
15:56:28 [2019-10-22T15:56:28.812Z] --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon (1.54s)
15:56:28 [2019-10-22T15:56:28.812Z] restart_test.go:67: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon"
15:56:28 [2019-10-22T15:56:28.812Z] --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon (1.58s)
15:56:28 [2019-10-22T15:56:28.812Z] restart_test.go:67: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon"
15:56:28 [2019-10-22T15:56:28.812Z] --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon (2.27s)
15:56:28 [2019-10-22T15:56:28.812Z] restart_test.go:67: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon"
15:56:28 [2019-10-22T15:56:28.812Z] --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon (2.30s)
15:56:28 [2019-10-22T15:56:28.812Z] restart_test.go:67: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon"
15:56:28 [2019-10-22T15:56:28.812Z] --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon (2.14s)
15:56:28 [2019-10-22T15:56:28.812Z] restart_test.go:67: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon"
15:56:28 [2019-10-22T15:56:28.812Z] --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon (2.87s)
15:56:28 [2019-10-22T15:56:28.812Z] restart_test.go:67: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon"
15:56:28 [2019-10-22T15:56:28.812Z] --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon (2.31s)
15:56:28 [2019-10-22T15:56:28.812Z] restart_test.go:67: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon"
15:56:28 [2019-10-22T15:56:28.813Z] --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon (2.26s)
15:56:28 [2019-10-22T15:56:28.813Z] restart_test.go:67: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon"
15:56:28 [2019-10-22T15:56:28.813Z] === RUN TestCgroupNamespacesRun
15:56:30 [2019-10-22T15:56:30.641Z] --- PASS: TestCgroupNamespacesRun (1.82s)
15:56:30 [2019-10-22T15:56:30.641Z] run_cgroupns_linux_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRun"
15:56:30 [2019-10-22T15:56:30.641Z] === RUN TestCgroupNamespacesRunPrivileged
15:56:32 [2019-10-22T15:56:32.468Z] --- PASS: TestCgroupNamespacesRunPrivileged (1.66s)
15:56:32 [2019-10-22T15:56:32.468Z] run_cgroupns_linux_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunPrivileged"
15:56:32 [2019-10-22T15:56:32.468Z] === RUN TestCgroupNamespacesRunDaemonHostMode
15:56:33 [2019-10-22T15:56:33.849Z] --- PASS: TestCgroupNamespacesRunDaemonHostMode (1.70s)
15:56:33 [2019-10-22T15:56:33.849Z] run_cgroupns_linux_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunDaemonHostMode"
15:56:33 [2019-10-22T15:56:33.849Z] === RUN TestCgroupNamespacesRunHostMode
15:56:35 [2019-10-22T15:56:35.673Z] --- PASS: TestCgroupNamespacesRunHostMode (1.69s)
15:56:35 [2019-10-22T15:56:35.673Z] run_cgroupns_linux_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunHostMode"
15:56:35 [2019-10-22T15:56:35.673Z] === RUN TestCgroupNamespacesRunPrivateMode
15:56:37 [2019-10-22T15:56:37.480Z] --- PASS: TestCgroupNamespacesRunPrivateMode (1.72s)
15:56:37 [2019-10-22T15:56:37.480Z] run_cgroupns_linux_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunPrivateMode"
15:56:37 [2019-10-22T15:56:37.480Z] === RUN TestCgroupNamespacesRunPrivilegedAndPrivate
15:56:38 [2019-10-22T15:56:38.418Z] --- PASS: TestCgroupNamespacesRunPrivilegedAndPrivate (0.88s)
15:56:38 [2019-10-22T15:56:38.418Z] run_cgroupns_linux_test.go:48: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunPrivilegedAndPrivate"
15:56:38 [2019-10-22T15:56:38.418Z] === RUN TestCgroupNamespacesRunInvalidMode
15:56:39 [2019-10-22T15:56:39.211Z] --- PASS: TestCgroupNamespacesRunInvalidMode (0.83s)
15:56:39 [2019-10-22T15:56:39.211Z] run_cgroupns_linux_test.go:48: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunInvalidMode"
15:56:39 [2019-10-22T15:56:39.211Z] === RUN TestCgroupNamespacesRunOlderClient
15:56:41 [2019-10-22T15:56:41.048Z] --- PASS: TestCgroupNamespacesRunOlderClient (1.78s)
15:56:41 [2019-10-22T15:56:41.048Z] run_cgroupns_linux_test.go:139: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunOlderClient"
15:56:41 [2019-10-22T15:56:41.048Z] === RUN TestKernelTCPMemory
15:56:41 [2019-10-22T15:56:41.839Z] --- PASS: TestKernelTCPMemory (1.06s)
15:56:41 [2019-10-22T15:56:41.839Z] === RUN TestNISDomainname
15:56:43 [2019-10-22T15:56:43.650Z] --- PASS: TestNISDomainname (1.30s)
15:56:43 [2019-10-22T15:56:43.650Z] === RUN TestHostnameDnsResolution
15:56:44 [2019-10-22T15:56:44.654Z] --- PASS: TestHostnameDnsResolution (1.29s)
15:56:44 [2019-10-22T15:56:44.654Z] === RUN TestStats
15:56:47 [2019-10-22T15:56:47.086Z] --- PASS: TestStats (2.54s)
15:56:47 [2019-10-22T15:56:47.086Z] === RUN TestStopContainerWithTimeout
15:56:47 [2019-10-22T15:56:47.086Z] === RUN TestStopContainerWithTimeout/0
15:56:47 [2019-10-22T15:56:47.086Z] === PAUSE TestStopContainerWithTimeout/0
15:56:47 [2019-10-22T15:56:47.086Z] === RUN TestStopContainerWithTimeout/1
15:56:47 [2019-10-22T15:56:47.086Z] === PAUSE TestStopContainerWithTimeout/1
15:56:47 [2019-10-22T15:56:47.086Z] === RUN TestStopContainerWithTimeout/3
15:56:47 [2019-10-22T15:56:47.086Z] === PAUSE TestStopContainerWithTimeout/3
15:56:47 [2019-10-22T15:56:47.086Z] === RUN TestStopContainerWithTimeout/-1
15:56:47 [2019-10-22T15:56:47.086Z] === PAUSE TestStopContainerWithTimeout/-1
15:56:47 [2019-10-22T15:56:47.086Z] === CONT TestStopContainerWithTimeout/0
15:56:47 [2019-10-22T15:56:47.086Z] === CONT TestStopContainerWithTimeout/-1
15:56:48 [2019-10-22T15:56:48.345Z] === CONT TestStopContainerWithTimeout/3
15:56:50 [2019-10-22T15:56:50.186Z] === CONT TestStopContainerWithTimeout/1
15:56:52 [2019-10-22T15:56:52.622Z] --- PASS: TestStopContainerWithTimeout (0.01s)
15:56:52 [2019-10-22T15:56:52.622Z] --- PASS: TestStopContainerWithTimeout/0 (0.99s)
15:56:52 [2019-10-22T15:56:52.622Z] --- PASS: TestStopContainerWithTimeout/-1 (3.10s)
15:56:52 [2019-10-22T15:56:52.622Z] --- PASS: TestStopContainerWithTimeout/3 (2.88s)
15:56:52 [2019-10-22T15:56:52.622Z] --- PASS: TestStopContainerWithTimeout/1 (2.01s)
15:56:52 [2019-10-22T15:56:52.622Z] === RUN TestDeleteDevicemapper
15:56:52 [2019-10-22T15:56:52.622Z] --- SKIP: TestDeleteDevicemapper (0.01s)
15:56:52 [2019-10-22T15:56:52.622Z] stop_linux_test.go:74: testEnv.DaemonInfo.Driver != "devicemapper"
15:56:52 [2019-10-22T15:56:52.622Z] === RUN TestStopContainerWithRestartPolicyAlways
15:56:55 [2019-10-22T15:56:55.850Z] --- PASS: TestStopContainerWithRestartPolicyAlways (3.54s)
15:56:55 [2019-10-22T15:56:55.850Z] === RUN TestUpdateMemory
15:56:55 [2019-10-22T15:56:55.850Z] --- SKIP: TestUpdateMemory (0.00s)
15:56:55 [2019-10-22T15:56:55.850Z] update_linux_test.go:23: !testEnv.DaemonInfo.SwapLimit
15:56:55 [2019-10-22T15:56:55.850Z] === RUN TestUpdateCPUQuota
15:56:57 [2019-10-22T15:56:57.349Z] --- PASS: TestUpdateCPUQuota (1.72s)
15:56:57 [2019-10-22T15:56:57.349Z] === RUN TestUpdatePidsLimit
15:56:57 [2019-10-22T15:56:57.349Z] === RUN TestUpdatePidsLimit/update_from_none
15:56:58 [2019-10-22T15:56:58.143Z] === RUN TestUpdatePidsLimit/no_change
15:56:58 [2019-10-22T15:56:58.513Z] === RUN TestUpdatePidsLimit/update_lower
15:56:58 [2019-10-22T15:56:58.890Z] === RUN TestUpdatePidsLimit/update_on_old_api_ignores_value
15:56:59 [2019-10-22T15:56:59.253Z] === RUN TestUpdatePidsLimit/unset_limit_with_zero
15:56:59 [2019-10-22T15:56:59.632Z] === RUN TestUpdatePidsLimit/unset_limit_with_minus_one
15:56:59 [2019-10-22T15:56:59.996Z] === RUN TestUpdatePidsLimit/unset_limit_with_minus_two
15:57:01 [2019-10-22T15:57:01.848Z] --- PASS: TestUpdatePidsLimit (4.20s)
15:57:01 [2019-10-22T15:57:01.848Z] --- PASS: TestUpdatePidsLimit/update_from_none (0.41s)
15:57:01 [2019-10-22T15:57:01.848Z] --- PASS: TestUpdatePidsLimit/no_change (0.42s)
15:57:01 [2019-10-22T15:57:01.848Z] --- PASS: TestUpdatePidsLimit/update_lower (0.40s)
15:57:01 [2019-10-22T15:57:01.848Z] --- PASS: TestUpdatePidsLimit/update_on_old_api_ignores_value (0.45s)
15:57:01 [2019-10-22T15:57:01.848Z] --- PASS: TestUpdatePidsLimit/unset_limit_with_zero (0.44s)
15:57:01 [2019-10-22T15:57:01.848Z] --- PASS: TestUpdatePidsLimit/unset_limit_with_minus_one (0.44s)
15:57:01 [2019-10-22T15:57:01.848Z] --- PASS: TestUpdatePidsLimit/unset_limit_with_minus_two (0.46s)
15:57:01 [2019-10-22T15:57:01.848Z] === RUN TestUpdateRestartPolicy
15:57:15 [2019-10-22T15:57:15.453Z] --- PASS: TestUpdateRestartPolicy (12.85s)
15:57:15 [2019-10-22T15:57:15.453Z] === RUN TestUpdateRestartWithAutoRemove
15:57:15 [2019-10-22T15:57:15.453Z] --- PASS: TestUpdateRestartWithAutoRemove (0.90s)
15:57:15 [2019-10-22T15:57:15.453Z] === RUN TestWaitNonBlocked
15:57:15 [2019-10-22T15:57:15.453Z] === RUN TestWaitNonBlocked/wait-nonblocking-exit-0
15:57:15 [2019-10-22T15:57:15.453Z] === PAUSE TestWaitNonBlocked/wait-nonblocking-exit-0
15:57:15 [2019-10-22T15:57:15.453Z] === RUN TestWaitNonBlocked/wait-nonblocking-exit-random
15:57:15 [2019-10-22T15:57:15.453Z] === PAUSE TestWaitNonBlocked/wait-nonblocking-exit-random
15:57:15 [2019-10-22T15:57:15.453Z] === CONT TestWaitNonBlocked/wait-nonblocking-exit-0
15:57:15 [2019-10-22T15:57:15.453Z] === CONT TestWaitNonBlocked/wait-nonblocking-exit-random
15:57:16 [2019-10-22T15:57:16.933Z] --- PASS: TestWaitNonBlocked (0.01s)
15:57:16 [2019-10-22T15:57:16.933Z] --- PASS: TestWaitNonBlocked/wait-nonblocking-exit-random (1.12s)
15:57:16 [2019-10-22T15:57:16.933Z] --- PASS: TestWaitNonBlocked/wait-nonblocking-exit-0 (1.18s)
15:57:16 [2019-10-22T15:57:16.933Z] === RUN TestWaitBlocked
15:57:16 [2019-10-22T15:57:16.933Z] === RUN TestWaitBlocked/test-wait-blocked-exit-zero
15:57:16 [2019-10-22T15:57:16.933Z] === PAUSE TestWaitBlocked/test-wait-blocked-exit-zero
15:57:16 [2019-10-22T15:57:16.933Z] === RUN TestWaitBlocked/test-wait-blocked-exit-random
15:57:16 [2019-10-22T15:57:16.933Z] === PAUSE TestWaitBlocked/test-wait-blocked-exit-random
15:57:16 [2019-10-22T15:57:16.933Z] === CONT TestWaitBlocked/test-wait-blocked-exit-zero
15:57:16 [2019-10-22T15:57:16.933Z] === CONT TestWaitBlocked/test-wait-blocked-exit-random
15:57:18 [2019-10-22T15:57:18.190Z] --- PASS: TestWaitBlocked (0.01s)
15:57:18 [2019-10-22T15:57:18.190Z] --- PASS: TestWaitBlocked/test-wait-blocked-exit-random (1.33s)
15:57:18 [2019-10-22T15:57:18.190Z] --- PASS: TestWaitBlocked/test-wait-blocked-exit-zero (1.40s)
15:57:18 [2019-10-22T15:57:18.190Z] === CONT TestContainerStartOnDaemonRestart
15:57:18 [2019-10-22T15:57:18.190Z] === CONT TestIpcModeOlderClient
15:57:18 [2019-10-22T15:57:18.190Z] --- PASS: TestIpcModeOlderClient (0.10s)
15:57:18 [2019-10-22T15:57:18.190Z] === CONT TestDaemonRestartIpcMode
15:57:21 [2019-10-22T15:57:21.420Z] --- PASS: TestContainerStartOnDaemonRestart (3.31s)
15:57:21 [2019-10-22T15:57:21.420Z] daemon_linux_test.go:35: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestContainerStartOnDaemonRestart"
15:57:22 [2019-10-22T15:57:22.311Z] --- PASS: TestDaemonRestartIpcMode (4.06s)
15:57:22 [2019-10-22T15:57:22.311Z] daemon_linux_test.go:89: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartIpcMode"
15:57:22 [2019-10-22T15:57:22.311Z] PASS
15:57:22 [2019-10-22T15:57:22.311Z]
15:57:22 [2019-10-22T15:57:22.311Z] === Skipped
15:57:22 [2019-10-22T15:57:22.311Z] === SKIP: s390x.integration.container TestCheckpoint (0.00s)
15:57:22 [2019-10-22T15:57:22.311Z] checkpoint_test.go:33: TestCheckpoint is broken; see https://github.com/moby/moby/issues/38963
15:57:22 [2019-10-22T15:57:22.311Z]
15:57:22 [2019-10-22T15:57:22.311Z] === SKIP: s390x.integration.container TestInspectOomKilledTrue (0.00s)
15:57:22 [2019-10-22T15:57:22.311Z] kill_test.go:151: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
15:57:22 [2019-10-22T15:57:22.311Z]
15:57:22 [2019-10-22T15:57:22.311Z] === SKIP: s390x.integration.container TestInspectOomKilledFalse (0.00s)
15:57:22 [2019-10-22T15:57:22.312Z] kill_test.go:169: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
15:57:22 [2019-10-22T15:57:22.312Z]
15:57:22 [2019-10-22T15:57:22.312Z] === SKIP: s390x.integration.container TestPauseFailsOnWindowsServerContainers (0.00s)
15:57:22 [2019-10-22T15:57:22.312Z] pause_test.go:54: testEnv.DaemonInfo.OSType != "windows" || testEnv.DaemonInfo.Isolation != "process"
15:57:22 [2019-10-22T15:57:22.312Z]
15:57:22 [2019-10-22T15:57:22.312Z] === SKIP: s390x.integration.container TestDeleteDevicemapper (0.01s)
15:57:22 [2019-10-22T15:57:22.312Z] stop_linux_test.go:74: testEnv.DaemonInfo.Driver != "devicemapper"
15:57:22 [2019-10-22T15:57:22.312Z]
15:57:22 [2019-10-22T15:57:22.312Z] === SKIP: s390x.integration.container TestUpdateMemory (0.00s)
15:57:22 [2019-10-22T15:57:22.312Z] update_linux_test.go:23: !testEnv.DaemonInfo.SwapLimit
15:57:22 [2019-10-22T15:57:22.312Z]
15:57:22 [2019-10-22T15:57:22.312Z]
15:57:22 [2019-10-22T15:57:22.312Z] DONE 197 tests, 6 skipped in 138.664s
15:57:22 [2019-10-22T15:57:22.312Z] Running /go/src/github.com/docker/docker/integration/image (s390x.integration.image) flags=-test.v -test.timeout=120m
15:57:22 [2019-10-22T15:57:22.312Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-image-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-image-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.image -t ./test.main -test.v -test.timeout=120m
15:57:22 [2019-10-22T15:57:22.312Z] ++ set -e
15:57:22 [2019-10-22T15:57:22.312Z] ++ '[' -n 0 ']'
15:57:22 [2019-10-22T15:57:22.312Z] ++ set -x
15:57:22 [2019-10-22T15:57:22.312Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=s390x DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-image-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-image-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.image -t ./test.main -test.v -test.timeout=120m
15:57:22 [2019-10-22T15:57:22.312Z] INFO: Testing against a local daemon
15:57:22 [2019-10-22T15:57:22.312Z] === RUN TestCommitInheritsEnv
15:57:22 [2019-10-22T15:57:22.843Z] --- PASS: TestCommitInheritsEnv (0.53s)
15:57:22 [2019-10-22T15:57:22.843Z] === RUN TestImportExtremelyLargeImageWorks
15:57:22 [2019-10-22T15:57:22.843Z] === PAUSE TestImportExtremelyLargeImageWorks
15:57:22 [2019-10-22T15:57:22.843Z] === RUN TestImagesFilterMultiReference
15:57:22 [2019-10-22T15:57:22.843Z] --- PASS: TestImagesFilterMultiReference (0.06s)
15:57:22 [2019-10-22T15:57:22.843Z] === RUN TestImagePullPlatformInvalid
15:57:22 [2019-10-22T15:57:22.843Z] --- PASS: TestImagePullPlatformInvalid (0.03s)
15:57:22 [2019-10-22T15:57:22.843Z] === RUN TestRemoveImageOrphaning
15:57:23 [2019-10-22T15:57:23.650Z] --- PASS: TestRemoveImageOrphaning (0.54s)
15:57:23 [2019-10-22T15:57:23.650Z] === RUN TestRemoveImageGarbageCollector
15:57:23 [2019-10-22T15:57:23.650Z] --- SKIP: TestRemoveImageGarbageCollector (0.00s)
15:57:23 [2019-10-22T15:57:23.650Z] remove_unix_test.go:36: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
15:57:23 [2019-10-22T15:57:23.650Z] === RUN TestTagUnprefixedRepoByNameOrName
15:57:23 [2019-10-22T15:57:23.650Z] --- PASS: TestTagUnprefixedRepoByNameOrName (0.02s)
15:57:23 [2019-10-22T15:57:23.650Z] === RUN TestTagInvalidReference
15:57:23 [2019-10-22T15:57:23.650Z] --- PASS: TestTagInvalidReference (0.01s)
15:57:23 [2019-10-22T15:57:23.650Z] === RUN TestTagValidPrefixedRepo
15:57:23 [2019-10-22T15:57:23.650Z] --- PASS: TestTagValidPrefixedRepo (0.06s)
15:57:23 [2019-10-22T15:57:23.650Z] === RUN TestTagExistedNameWithoutForce
15:57:23 [2019-10-22T15:57:23.650Z] --- PASS: TestTagExistedNameWithoutForce (0.02s)
15:57:23 [2019-10-22T15:57:23.650Z] === RUN TestTagOfficialNames
15:57:23 [2019-10-22T15:57:23.650Z] --- PASS: TestTagOfficialNames (0.04s)
15:57:23 [2019-10-22T15:57:23.650Z] === RUN TestTagMatchesDigest
15:57:23 [2019-10-22T15:57:23.650Z] --- PASS: TestTagMatchesDigest (0.01s)
15:57:23 [2019-10-22T15:57:23.650Z] === CONT TestImportExtremelyLargeImageWorks
15:59:18 [2019-10-22T15:59:18.448Z] --- PASS: TestImportExtremelyLargeImageWorks (106.15s)
15:59:18 [2019-10-22T15:59:18.448Z] import_test.go:26: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestImportExtremelyLargeImageWorks"
15:59:18 [2019-10-22T15:59:18.448Z] PASS
15:59:18 [2019-10-22T15:59:18.448Z]
15:59:18 [2019-10-22T15:59:18.448Z] === Skipped
15:59:18 [2019-10-22T15:59:18.448Z] === SKIP: s390x.integration.image TestRemoveImageGarbageCollector (0.00s)
15:59:18 [2019-10-22T15:59:18.448Z] remove_unix_test.go:36: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
15:59:18 [2019-10-22T15:59:18.448Z]
15:59:18 [2019-10-22T15:59:18.448Z]
15:59:18 [2019-10-22T15:59:18.448Z] DONE 12 tests, 1 skipped in 107.619s
15:59:18 [2019-10-22T15:59:18.448Z] Running /go/src/github.com/docker/docker/integration/network (s390x.integration.network) flags=-test.v -test.timeout=120m
15:59:18 [2019-10-22T15:59:18.448Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-network-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-network-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.network -t ./test.main -test.v -test.timeout=120m
15:59:18 [2019-10-22T15:59:18.448Z] ++ set -e
15:59:18 [2019-10-22T15:59:18.448Z] ++ '[' -n 0 ']'
15:59:18 [2019-10-22T15:59:18.448Z] ++ set -x
15:59:18 [2019-10-22T15:59:18.448Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=s390x DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-network-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-network-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.network -t ./test.main -test.v -test.timeout=120m
15:59:18 [2019-10-22T15:59:18.448Z] INFO: Testing against a local daemon
15:59:18 [2019-10-22T15:59:18.448Z] === RUN TestNetworkCreateDelete
15:59:18 [2019-10-22T15:59:18.448Z] --- PASS: TestNetworkCreateDelete (0.17s)
15:59:18 [2019-10-22T15:59:18.448Z] === RUN TestDockerNetworkDeletePreferID
15:59:18 [2019-10-22T15:59:18.448Z] --- PASS: TestDockerNetworkDeletePreferID (0.34s)
15:59:18 [2019-10-22T15:59:18.448Z] === RUN TestInspectNetwork
15:59:18 [2019-10-22T15:59:18.448Z] === RUN TestInspectNetwork/full_network_id
15:59:18 [2019-10-22T15:59:18.448Z] === RUN TestInspectNetwork/partial_network_id
15:59:18 [2019-10-22T15:59:18.448Z] === RUN TestInspectNetwork/network_name
15:59:18 [2019-10-22T15:59:18.448Z] === RUN TestInspectNetwork/network_name_and_swarm_scope
15:59:18 [2019-10-22T15:59:18.811Z] --- PASS: TestInspectNetwork (8.36s)
15:59:18 [2019-10-22T15:59:18.811Z] inspect_test.go:18: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestInspectNetwork"
15:59:18 [2019-10-22T15:59:18.811Z] --- PASS: TestInspectNetwork/full_network_id (0.00s)
15:59:18 [2019-10-22T15:59:18.811Z] --- PASS: TestInspectNetwork/partial_network_id (0.00s)
15:59:18 [2019-10-22T15:59:18.811Z] --- PASS: TestInspectNetwork/network_name (0.00s)
15:59:18 [2019-10-22T15:59:18.811Z] --- PASS: TestInspectNetwork/network_name_and_swarm_scope (0.00s)
15:59:18 [2019-10-22T15:59:18.811Z] === RUN TestRunContainerWithBridgeNone
15:59:21 [2019-10-22T15:59:21.256Z] --- PASS: TestRunContainerWithBridgeNone (2.61s)
15:59:21 [2019-10-22T15:59:21.256Z] network_test.go:25: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestRunContainerWithBridgeNone"
15:59:21 [2019-10-22T15:59:21.256Z] === RUN TestNetworkInvalidJSON
15:59:21 [2019-10-22T15:59:21.624Z] === RUN TestNetworkInvalidJSON//networks/create
15:59:21 [2019-10-22T15:59:21.624Z] === PAUSE TestNetworkInvalidJSON//networks/create
15:59:21 [2019-10-22T15:59:21.624Z] === RUN TestNetworkInvalidJSON//networks/bridge/connect
15:59:21 [2019-10-22T15:59:21.624Z] === PAUSE TestNetworkInvalidJSON//networks/bridge/connect
15:59:21 [2019-10-22T15:59:21.624Z] === RUN TestNetworkInvalidJSON//networks/bridge/disconnect
15:59:21 [2019-10-22T15:59:21.624Z] === PAUSE TestNetworkInvalidJSON//networks/bridge/disconnect
15:59:21 [2019-10-22T15:59:21.624Z] === CONT TestNetworkInvalidJSON//networks/create
15:59:21 [2019-10-22T15:59:21.624Z] === CONT TestNetworkInvalidJSON//networks/bridge/disconnect
15:59:21 [2019-10-22T15:59:21.624Z] === CONT TestNetworkInvalidJSON//networks/bridge/connect
15:59:21 [2019-10-22T15:59:21.624Z] --- PASS: TestNetworkInvalidJSON (0.02s)
15:59:21 [2019-10-22T15:59:21.624Z] --- PASS: TestNetworkInvalidJSON//networks/create (0.00s)
15:59:21 [2019-10-22T15:59:21.624Z] --- PASS: TestNetworkInvalidJSON//networks/bridge/connect (0.00s)
15:59:21 [2019-10-22T15:59:21.624Z] --- PASS: TestNetworkInvalidJSON//networks/bridge/disconnect (0.00s)
15:59:21 [2019-10-22T15:59:21.624Z] === RUN TestDaemonRestartWithLiveRestore
15:59:22 [2019-10-22T15:59:22.403Z] --- PASS: TestDaemonRestartWithLiveRestore (1.04s)
15:59:22 [2019-10-22T15:59:22.403Z] service_test.go:32: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartWithLiveRestore"
15:59:22 [2019-10-22T15:59:22.403Z] === RUN TestDaemonDefaultNetworkPools
15:59:23 [2019-10-22T15:59:23.178Z] --- PASS: TestDaemonDefaultNetworkPools (0.75s)
15:59:23 [2019-10-22T15:59:23.178Z] service_test.go:57: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonDefaultNetworkPools"
15:59:23 [2019-10-22T15:59:23.178Z] === RUN TestDaemonRestartWithExistingNetwork
15:59:24 [2019-10-22T15:59:24.433Z] --- PASS: TestDaemonRestartWithExistingNetwork (1.14s)
15:59:24 [2019-10-22T15:59:24.433Z] service_test.go:98: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartWithExistingNetwork"
15:59:24 [2019-10-22T15:59:24.433Z] === RUN TestDaemonRestartWithExistingNetworkWithDefaultPoolRange
15:59:25 [2019-10-22T15:59:25.689Z] --- PASS: TestDaemonRestartWithExistingNetworkWithDefaultPoolRange (1.23s)
15:59:25 [2019-10-22T15:59:25.689Z] service_test.go:131: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartWithExistingNetworkWithDefaultPoolRange"
15:59:25 [2019-10-22T15:59:25.689Z] === RUN TestDaemonWithBipAndDefaultNetworkPool
15:59:26 [2019-10-22T15:59:26.054Z] --- PASS: TestDaemonWithBipAndDefaultNetworkPool (0.60s)
15:59:26 [2019-10-22T15:59:26.054Z] service_test.go:181: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonWithBipAndDefaultNetworkPool"
15:59:26 [2019-10-22T15:59:26.054Z] === RUN TestServiceWithPredefinedNetwork
15:59:29 [2019-10-22T15:59:29.411Z] --- PASS: TestServiceWithPredefinedNetwork (2.99s)
15:59:29 [2019-10-22T15:59:29.411Z] service_test.go:203: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithPredefinedNetwork"
15:59:29 [2019-10-22T15:59:29.411Z] === RUN TestServiceRemoveKeepsIngressNetwork
15:59:29 [2019-10-22T15:59:29.411Z] --- SKIP: TestServiceRemoveKeepsIngressNetwork (0.00s)
15:59:29 [2019-10-22T15:59:29.411Z] service_test.go:230: FLAKY_TEST
15:59:29 [2019-10-22T15:59:29.411Z] === RUN TestServiceWithDataPathPortInit
15:59:45 [2019-10-22T15:59:45.829Z] --- PASS: TestServiceWithDataPathPortInit (16.17s)
15:59:45 [2019-10-22T15:59:45.829Z] service_test.go:323: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithDataPathPortInit"
15:59:45 [2019-10-22T15:59:45.829Z] service_test.go:355: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithDataPathPortInit"
15:59:45 [2019-10-22T15:59:45.829Z] === RUN TestServiceWithDefaultAddressPoolInit
15:59:55 [2019-10-22T15:59:55.190Z] --- PASS: TestServiceWithDefaultAddressPoolInit (8.35s)
15:59:55 [2019-10-22T15:59:55.190Z] service_test.go:388: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithDefaultAddressPoolInit"
15:59:55 [2019-10-22T15:59:55.190Z] service_test.go:418: TestServiceWithDefaultAddressPoolInit: NetworkInspect: {Name:sthiraTestServiceWithDefaultAddressPoolInit ID:ym0yl8plq6xg3zxqt0tkn8eej Created:2019-10-22 15:59:46.820143975 +0000 UTC Scope:swarm Driver:overlay EnableIPv6:false IPAM:{Driver:default Options:map[] Config:[{Subnet:20.20.0.0/24 IPRange: Gateway:20.20.0.1 AuxAddress:map[]}]} Internal:false Attachable:false Ingress:false ConfigFrom:{Network:} ConfigOnly:false Containers:map[6b661457ae7615cbc066d9c3da3276a63d0a140415397540d5a69b8c7ee29627:{Name:TestServiceTestServiceWithDefaultAddressPoolInit.1.vzf0mpgx66pm7moppx36tn8x8 EndpointID:ce3902fd3ca54a234f77a2fff43107e7c62e560ffe0b9c1be2f7afc084bb69cd MacAddress:02:42:14:14:00:03 IPv4Address:20.20.0.3/24 IPv6Address:} lb-sthiraTestServiceWithDefaultAddressPoolInit:{Name:sthiraTestServiceWithDefaultAddressPoolInit-endpoint EndpointID:4f8c84bb10377547fd067ab7e2dcfbec6acc67bbd0a94c6bfcc6c69cd2e18dea MacAddress:02:42:14:14:00:04 IPv4Address:20.20.0.4/24 IPv6Address:}] Options:map[com.docker.network.driver.overlay.vxlanid_list:4097] Labels:map[] Peers:[{Name:77b39600363d IP:127.0.0.1}] Services:map[TestServiceTestServiceWithDefaultAddressPoolInit:{VIP:20.20.0.2 Ports:[] LocalLBIndex:256 Tasks:[{Name:TestServiceTestServiceWithDefaultAddressPoolInit.1.vzf0mpgx66pm7moppx36tn8x8 EndpointID:ce3902fd3ca54a234f77a2fff43107e7c62e560ffe0b9c1be2f7afc084bb69cd EndpointIP:20.20.0.3 Info:map[Host IP:127.0.0.1]}]}]}
15:59:55 [2019-10-22T15:59:55.190Z] PASS
15:59:55 [2019-10-22T15:59:55.190Z]
15:59:55 [2019-10-22T15:59:55.190Z] === Skipped
15:59:55 [2019-10-22T15:59:55.190Z] === SKIP: s390x.integration.network TestServiceRemoveKeepsIngressNetwork (0.00s)
15:59:55 [2019-10-22T15:59:55.190Z] service_test.go:230: FLAKY_TEST
15:59:55 [2019-10-22T15:59:55.190Z]
15:59:55 [2019-10-22T15:59:55.191Z]
15:59:55 [2019-10-22T15:59:55.191Z] DONE 21 tests, 1 skipped in 43.844s
15:59:55 [2019-10-22T15:59:55.191Z] Running /go/src/github.com/docker/docker/integration/network/ipvlan (s390x.integration.network.ipvlan) flags=-test.v -test.timeout=120m
15:59:55 [2019-10-22T15:59:55.191Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-network-ipvlan-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-network-ipvlan-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.network.ipvlan -t ./test.main -test.v -test.timeout=120m
15:59:55 [2019-10-22T15:59:55.191Z] ++ set -e
15:59:55 [2019-10-22T15:59:55.191Z] ++ '[' -n 0 ']'
15:59:55 [2019-10-22T15:59:55.191Z] ++ set -x
15:59:55 [2019-10-22T15:59:55.191Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=s390x DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-network-ipvlan-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-network-ipvlan-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.network.ipvlan -t ./test.main -test.v -test.timeout=120m
15:59:55 [2019-10-22T15:59:55.191Z] INFO: Testing against a local daemon
15:59:55 [2019-10-22T15:59:55.191Z] === RUN TestDockerNetworkIpvlanPersistance
15:59:55 [2019-10-22T15:59:55.191Z] --- SKIP: TestDockerNetworkIpvlanPersistance (0.01s)
15:59:55 [2019-10-22T15:59:55.191Z] ipvlan_test.go:26: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
15:59:55 [2019-10-22T15:59:55.191Z] === RUN TestDockerNetworkIpvlan
15:59:55 [2019-10-22T15:59:55.191Z] --- SKIP: TestDockerNetworkIpvlan (0.00s)
15:59:55 [2019-10-22T15:59:55.191Z] ipvlan_test.go:53: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
15:59:55 [2019-10-22T15:59:55.191Z] PASS
15:59:55 [2019-10-22T15:59:55.191Z]
15:59:55 [2019-10-22T15:59:55.191Z] === Skipped
15:59:55 [2019-10-22T15:59:55.191Z] === SKIP: s390x.integration.network.ipvlan TestDockerNetworkIpvlanPersistance (0.01s)
15:59:55 [2019-10-22T15:59:55.191Z] ipvlan_test.go:26: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
15:59:55 [2019-10-22T15:59:55.191Z]
15:59:55 [2019-10-22T15:59:55.191Z] === SKIP: s390x.integration.network.ipvlan TestDockerNetworkIpvlan (0.00s)
15:59:55 [2019-10-22T15:59:55.191Z] ipvlan_test.go:53: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
15:59:55 [2019-10-22T15:59:55.191Z]
15:59:55 [2019-10-22T15:59:55.191Z]
15:59:55 [2019-10-22T15:59:55.191Z] DONE 2 tests, 2 skipped in 0.083s
15:59:55 [2019-10-22T15:59:55.191Z] Running /go/src/github.com/docker/docker/integration/network/macvlan (s390x.integration.network.macvlan) flags=-test.v -test.timeout=120m
15:59:55 [2019-10-22T15:59:55.191Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-network-macvlan-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-network-macvlan-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.network.macvlan -t ./test.main -test.v -test.timeout=120m
15:59:55 [2019-10-22T15:59:55.191Z] ++ set -e
15:59:55 [2019-10-22T15:59:55.191Z] ++ '[' -n 0 ']'
15:59:55 [2019-10-22T15:59:55.191Z] ++ set -x
15:59:55 [2019-10-22T15:59:55.191Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=s390x DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-network-macvlan-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-network-macvlan-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.network.macvlan -t ./test.main -test.v -test.timeout=120m
15:59:55 [2019-10-22T15:59:55.191Z] INFO: Testing against a local daemon
15:59:55 [2019-10-22T15:59:55.191Z] === RUN TestDockerNetworkMacvlanPersistance
15:59:55 [2019-10-22T15:59:55.191Z] --- PASS: TestDockerNetworkMacvlanPersistance (1.39s)
15:59:55 [2019-10-22T15:59:55.191Z] macvlan_test.go:24: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlanPersistance"
15:59:55 [2019-10-22T15:59:55.191Z] === RUN TestDockerNetworkMacvlan
15:59:55 [2019-10-22T15:59:55.989Z] === RUN TestDockerNetworkMacvlan/Subinterface
15:59:57 [2019-10-22T15:59:57.255Z] === RUN TestDockerNetworkMacvlan/OverlapParent
15:59:58 [2019-10-22T15:59:58.150Z] === RUN TestDockerNetworkMacvlan/NilParent
16:00:00 [2019-10-22T16:00:00.609Z] === RUN TestDockerNetworkMacvlan/InternalMode
16:00:04 [2019-10-22T16:00:04.656Z] === RUN TestDockerNetworkMacvlan/MultiSubnet
16:00:09 [2019-10-22T16:00:09.836Z] === RUN TestDockerNetworkMacvlan/Addressing
16:00:10 [2019-10-22T16:00:10.639Z] --- PASS: TestDockerNetworkMacvlan (15.11s)
16:00:10 [2019-10-22T16:00:10.639Z] macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
16:00:10 [2019-10-22T16:00:10.639Z] --- PASS: TestDockerNetworkMacvlan/Subinterface (0.08s)
16:00:10 [2019-10-22T16:00:10.639Z] macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
16:00:10 [2019-10-22T16:00:10.639Z] --- PASS: TestDockerNetworkMacvlan/OverlapParent (0.10s)
16:00:10 [2019-10-22T16:00:10.639Z] macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
16:00:10 [2019-10-22T16:00:10.639Z] --- PASS: TestDockerNetworkMacvlan/NilParent (1.28s)
16:00:10 [2019-10-22T16:00:10.639Z] macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
16:00:10 [2019-10-22T16:00:10.639Z] --- PASS: TestDockerNetworkMacvlan/InternalMode (2.18s)
16:00:10 [2019-10-22T16:00:10.639Z] macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
16:00:10 [2019-10-22T16:00:10.639Z] --- PASS: TestDockerNetworkMacvlan/MultiSubnet (3.09s)
16:00:10 [2019-10-22T16:00:10.639Z] macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
16:00:10 [2019-10-22T16:00:10.639Z] --- PASS: TestDockerNetworkMacvlan/Addressing (0.86s)
16:00:10 [2019-10-22T16:00:10.639Z] PASS
16:00:10 [2019-10-22T16:00:10.639Z]
16:00:10 [2019-10-22T16:00:10.639Z] DONE 8 tests in 16.583s
16:00:10 [2019-10-22T16:00:10.639Z] Running /go/src/github.com/docker/docker/integration/plugin (s390x.integration.plugin) flags=-test.v -test.timeout=120m
16:00:10 [2019-10-22T16:00:10.639Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.plugin -t ./test.main -test.v -test.timeout=120m
16:00:10 [2019-10-22T16:00:10.639Z] ++ set -e
16:00:10 [2019-10-22T16:00:10.639Z] ++ '[' -n 0 ']'
16:00:10 [2019-10-22T16:00:10.639Z] ++ set -x
16:00:10 [2019-10-22T16:00:10.639Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=s390x DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.plugin -t ./test.main -test.v -test.timeout=120m
16:00:10 [2019-10-22T16:00:10.639Z] testing: warning: no tests to run
16:00:10 [2019-10-22T16:00:10.639Z] PASS
16:00:10 [2019-10-22T16:00:10.639Z]
16:00:10 [2019-10-22T16:00:10.639Z] DONE 0 tests in 0.017s
16:00:10 [2019-10-22T16:00:10.639Z] Running /go/src/github.com/docker/docker/integration/plugin/authz (s390x.integration.plugin.authz) flags=-test.v -test.timeout=120m
16:00:10 [2019-10-22T16:00:10.639Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-authz-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-authz-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.plugin.authz -t ./test.main -test.v -test.timeout=120m
16:00:10 [2019-10-22T16:00:10.639Z] ++ set -e
16:00:10 [2019-10-22T16:00:10.639Z] ++ '[' -n 0 ']'
16:00:10 [2019-10-22T16:00:10.639Z] ++ set -x
16:00:10 [2019-10-22T16:00:10.639Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=s390x DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-authz-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-authz-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.plugin.authz -t ./test.main -test.v -test.timeout=120m
16:00:10 [2019-10-22T16:00:10.639Z] INFO: Testing against a local daemon
16:00:10 [2019-10-22T16:00:10.639Z] === RUN TestAuthZPluginAllowRequest
16:00:12 [2019-10-22T16:00:12.466Z] --- PASS: TestAuthZPluginAllowRequest (1.69s)
16:00:12 [2019-10-22T16:00:12.466Z] main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginAllowRequest"
16:00:12 [2019-10-22T16:00:12.466Z] === RUN TestAuthZPluginTLS
16:00:12 [2019-10-22T16:00:12.870Z] --- PASS: TestAuthZPluginTLS (0.55s)
16:00:12 [2019-10-22T16:00:12.870Z] main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginTLS"
16:00:12 [2019-10-22T16:00:12.870Z] === RUN TestAuthZPluginDenyRequest
16:00:13 [2019-10-22T16:00:13.314Z] --- PASS: TestAuthZPluginDenyRequest (0.54s)
16:00:13 [2019-10-22T16:00:13.314Z] main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginDenyRequest"
16:00:13 [2019-10-22T16:00:13.314Z] === RUN TestAuthZPluginAPIDenyResponse
16:00:14 [2019-10-22T16:00:14.104Z] --- PASS: TestAuthZPluginAPIDenyResponse (0.53s)
16:00:14 [2019-10-22T16:00:14.104Z] main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginAPIDenyResponse"
16:00:14 [2019-10-22T16:00:14.104Z] === RUN TestAuthZPluginDenyResponse
16:00:14 [2019-10-22T16:00:14.477Z] --- PASS: TestAuthZPluginDenyResponse (0.54s)
16:00:14 [2019-10-22T16:00:14.477Z] main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginDenyResponse"
16:00:14 [2019-10-22T16:00:14.477Z] === RUN TestAuthZPluginAllowEventStream
16:00:16 [2019-10-22T16:00:16.317Z] --- PASS: TestAuthZPluginAllowEventStream (1.75s)
16:00:16 [2019-10-22T16:00:16.317Z] main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginAllowEventStream"
16:00:16 [2019-10-22T16:00:16.317Z] === RUN TestAuthZPluginErrorResponse
16:00:16 [2019-10-22T16:00:16.684Z] --- PASS: TestAuthZPluginErrorResponse (0.54s)
16:00:16 [2019-10-22T16:00:16.684Z] main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginErrorResponse"
16:00:16 [2019-10-22T16:00:16.684Z] === RUN TestAuthZPluginErrorRequest
16:00:17 [2019-10-22T16:00:17.070Z] --- PASS: TestAuthZPluginErrorRequest (0.54s)
16:00:17 [2019-10-22T16:00:17.070Z] main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginErrorRequest"
16:00:17 [2019-10-22T16:00:17.070Z] === RUN TestAuthZPluginEnsureNoDuplicatePluginRegistration
16:00:17 [2019-10-22T16:00:17.843Z] --- PASS: TestAuthZPluginEnsureNoDuplicatePluginRegistration (0.54s)
16:00:17 [2019-10-22T16:00:17.843Z] main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginEnsureNoDuplicatePluginRegistration"
16:00:17 [2019-10-22T16:00:17.843Z] === RUN TestAuthZPluginEnsureLoadImportWorking
16:00:19 [2019-10-22T16:00:19.691Z] --- PASS: TestAuthZPluginEnsureLoadImportWorking (2.06s)
16:00:19 [2019-10-22T16:00:19.691Z] main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginEnsureLoadImportWorking"
16:00:19 [2019-10-22T16:00:19.691Z] === RUN TestAuthzPluginEnsureContainerCopyToFrom
16:00:22 [2019-10-22T16:00:22.362Z] --- PASS: TestAuthzPluginEnsureContainerCopyToFrom (2.28s)
16:00:22 [2019-10-22T16:00:22.362Z] main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthzPluginEnsureContainerCopyToFrom"
16:00:22 [2019-10-22T16:00:22.362Z] === RUN TestAuthZPluginHeader
16:00:23 [2019-10-22T16:00:23.159Z] --- PASS: TestAuthZPluginHeader (0.84s)
16:00:23 [2019-10-22T16:00:23.159Z] main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginHeader"
16:00:23 [2019-10-22T16:00:23.159Z] === RUN TestAuthZPluginV2AllowNonVolumeRequest
16:00:23 [2019-10-22T16:00:23.159Z] --- SKIP: TestAuthZPluginV2AllowNonVolumeRequest (0.01s)
16:00:23 [2019-10-22T16:00:23.159Z] authz_plugin_v2_test.go:43: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
16:00:23 [2019-10-22T16:00:23.159Z] === RUN TestAuthZPluginV2Disable
16:00:23 [2019-10-22T16:00:23.159Z] --- SKIP: TestAuthZPluginV2Disable (0.00s)
16:00:23 [2019-10-22T16:00:23.159Z] authz_plugin_v2_test.go:65: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
16:00:23 [2019-10-22T16:00:23.159Z] === RUN TestAuthZPluginV2RejectVolumeRequests
16:00:23 [2019-10-22T16:00:23.159Z] --- SKIP: TestAuthZPluginV2RejectVolumeRequests (0.00s)
16:00:23 [2019-10-22T16:00:23.159Z] authz_plugin_v2_test.go:91: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
16:00:23 [2019-10-22T16:00:23.159Z] === RUN TestAuthZPluginV2BadManifestFailsDaemonStart
16:00:23 [2019-10-22T16:00:23.159Z] --- SKIP: TestAuthZPluginV2BadManifestFailsDaemonStart (0.00s)
16:00:23 [2019-10-22T16:00:23.159Z] authz_plugin_v2_test.go:126: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
16:00:23 [2019-10-22T16:00:23.159Z] === RUN TestAuthZPluginV2NonexistentFailsDaemonStart
16:00:42 [2019-10-22T16:00:42.809Z] --- PASS: TestAuthZPluginV2NonexistentFailsDaemonStart (16.84s)
16:00:42 [2019-10-22T16:00:42.809Z] main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginV2NonexistentFailsDaemonStart"
16:00:42 [2019-10-22T16:00:42.809Z] PASS
16:00:42 [2019-10-22T16:00:42.809Z]
16:00:42 [2019-10-22T16:00:42.809Z] === Skipped
16:00:42 [2019-10-22T16:00:42.809Z] === SKIP: s390x.integration.plugin.authz TestAuthZPluginV2AllowNonVolumeRequest (0.01s)
16:00:42 [2019-10-22T16:00:42.809Z] authz_plugin_v2_test.go:43: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
16:00:42 [2019-10-22T16:00:42.809Z]
16:00:42 [2019-10-22T16:00:42.809Z] === SKIP: s390x.integration.plugin.authz TestAuthZPluginV2Disable (0.00s)
16:00:42 [2019-10-22T16:00:42.809Z] authz_plugin_v2_test.go:65: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
16:00:42 [2019-10-22T16:00:42.809Z]
16:00:42 [2019-10-22T16:00:42.809Z] === SKIP: s390x.integration.plugin.authz TestAuthZPluginV2RejectVolumeRequests (0.00s)
16:00:42 [2019-10-22T16:00:42.809Z] authz_plugin_v2_test.go:91: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
16:00:42 [2019-10-22T16:00:42.809Z]
16:00:42 [2019-10-22T16:00:42.809Z] === SKIP: s390x.integration.plugin.authz TestAuthZPluginV2BadManifestFailsDaemonStart (0.00s)
16:00:42 [2019-10-22T16:00:42.809Z] authz_plugin_v2_test.go:126: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
16:00:42 [2019-10-22T16:00:42.809Z]
16:00:42 [2019-10-22T16:00:42.809Z]
16:00:42 [2019-10-22T16:00:42.809Z] DONE 17 tests, 4 skipped in 29.338s
16:00:42 [2019-10-22T16:00:42.809Z] Running /go/src/github.com/docker/docker/integration/plugin/common (s390x.integration.plugin.common) flags=-test.v -test.timeout=120m
16:00:42 [2019-10-22T16:00:42.809Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-common-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-common-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.plugin.common -t ./test.main -test.v -test.timeout=120m
16:00:42 [2019-10-22T16:00:42.809Z] ++ set -e
16:00:42 [2019-10-22T16:00:42.809Z] ++ '[' -n 0 ']'
16:00:42 [2019-10-22T16:00:42.809Z] ++ set -x
16:00:42 [2019-10-22T16:00:42.809Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=s390x DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-common-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-common-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.plugin.common -t ./test.main -test.v -test.timeout=120m
16:00:42 [2019-10-22T16:00:42.809Z] INFO: Testing against a local daemon
16:00:42 [2019-10-22T16:00:42.809Z] === RUN TestPluginInvalidJSON
16:00:42 [2019-10-22T16:00:42.809Z] === RUN TestPluginInvalidJSON//plugins/foobar/set
16:00:42 [2019-10-22T16:00:42.809Z] === PAUSE TestPluginInvalidJSON//plugins/foobar/set
16:00:42 [2019-10-22T16:00:42.809Z] === CONT TestPluginInvalidJSON//plugins/foobar/set
16:00:42 [2019-10-22T16:00:42.809Z] --- PASS: TestPluginInvalidJSON (0.01s)
16:00:42 [2019-10-22T16:00:42.809Z] --- PASS: TestPluginInvalidJSON//plugins/foobar/set (0.00s)
16:00:42 [2019-10-22T16:00:42.809Z] PASS
16:00:42 [2019-10-22T16:00:42.809Z]
16:00:42 [2019-10-22T16:00:42.809Z] DONE 2 tests in 0.086s
16:00:42 [2019-10-22T16:00:42.809Z] Running /go/src/github.com/docker/docker/integration/plugin/graphdriver (s390x.integration.plugin.graphdriver) flags=-test.v -test.timeout=120m
16:00:42 [2019-10-22T16:00:42.809Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-graphdriver-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-graphdriver-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.plugin.graphdriver -t ./test.main -test.v -test.timeout=120m
16:00:42 [2019-10-22T16:00:42.809Z] ++ set -e
16:00:42 [2019-10-22T16:00:42.809Z] ++ '[' -n 0 ']'
16:00:42 [2019-10-22T16:00:42.809Z] ++ set -x
16:00:42 [2019-10-22T16:00:42.809Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=s390x DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-graphdriver-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-graphdriver-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.plugin.graphdriver -t ./test.main -test.v -test.timeout=120m
16:00:42 [2019-10-22T16:00:42.809Z] INFO: Testing against a local daemon
16:00:42 [2019-10-22T16:00:42.809Z] === RUN TestExternalGraphDriver
16:00:42 [2019-10-22T16:00:42.809Z] === RUN TestExternalGraphDriver/json
16:00:42 [2019-10-22T16:00:42.809Z] === RUN TestExternalGraphDriver/spec
16:00:44 [2019-10-22T16:00:44.091Z] === RUN TestExternalGraphDriver/pull
16:00:46 [2019-10-22T16:00:46.599Z] --- PASS: TestExternalGraphDriver (6.51s)
16:00:46 [2019-10-22T16:00:46.599Z] external_test.go:57: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestExternalGraphDriver"
16:00:46 [2019-10-22T16:00:46.599Z] --- PASS: TestExternalGraphDriver/json (2.05s)
16:00:46 [2019-10-22T16:00:46.599Z] --- PASS: TestExternalGraphDriver/spec (2.05s)
16:00:46 [2019-10-22T16:00:46.599Z] --- PASS: TestExternalGraphDriver/pull (2.24s)
16:00:46 [2019-10-22T16:00:46.599Z] === RUN TestGraphdriverPluginV2
16:00:46 [2019-10-22T16:00:46.599Z] --- SKIP: TestGraphdriverPluginV2 (0.07s)
16:00:46 [2019-10-22T16:00:46.599Z] external_test.go:410: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
16:00:46 [2019-10-22T16:00:46.599Z] PASS
16:00:46 [2019-10-22T16:00:46.599Z]
16:00:46 [2019-10-22T16:00:46.599Z] === Skipped
16:00:46 [2019-10-22T16:00:46.599Z] === SKIP: s390x.integration.plugin.graphdriver TestGraphdriverPluginV2 (0.07s)
16:00:46 [2019-10-22T16:00:46.599Z] external_test.go:410: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
16:00:46 [2019-10-22T16:00:46.599Z]
16:00:46 [2019-10-22T16:00:46.599Z]
16:00:46 [2019-10-22T16:00:46.599Z] DONE 5 tests, 1 skipped in 6.663s
16:00:46 [2019-10-22T16:00:46.599Z] Running /go/src/github.com/docker/docker/integration/plugin/logging (s390x.integration.plugin.logging) flags=-test.v -test.timeout=120m
16:00:46 [2019-10-22T16:00:46.599Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-logging-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-logging-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.plugin.logging -t ./test.main -test.v -test.timeout=120m
16:00:46 [2019-10-22T16:00:46.599Z] ++ set -e
16:00:46 [2019-10-22T16:00:46.599Z] ++ '[' -n 0 ']'
16:00:46 [2019-10-22T16:00:46.599Z] ++ set -x
16:00:46 [2019-10-22T16:00:46.599Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=s390x DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-logging-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-logging-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.plugin.logging -t ./test.main -test.v -test.timeout=120m
16:00:46 [2019-10-22T16:00:46.599Z] INFO: Testing against a local daemon
16:00:46 [2019-10-22T16:00:46.599Z] === RUN TestContinueAfterPluginCrash
16:00:46 [2019-10-22T16:00:46.599Z] === PAUSE TestContinueAfterPluginCrash
16:00:46 [2019-10-22T16:00:46.599Z] === RUN TestDaemonStartWithLogOpt
16:00:46 [2019-10-22T16:00:46.599Z] === PAUSE TestDaemonStartWithLogOpt
16:00:46 [2019-10-22T16:00:46.599Z] === CONT TestContinueAfterPluginCrash
16:00:46 [2019-10-22T16:00:46.599Z] === CONT TestDaemonStartWithLogOpt
16:00:58 [2019-10-22T16:00:58.047Z] --- PASS: TestDaemonStartWithLogOpt (10.85s)
16:00:58 [2019-10-22T16:00:58.047Z] validation_test.go:23: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonStartWithLogOpt"
16:01:03 [2019-10-22T16:01:03.076Z] --- PASS: TestContinueAfterPluginCrash (15.80s)
16:01:03 [2019-10-22T16:01:03.076Z] logging_linux_test.go:22: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestContinueAfterPluginCrash"
16:01:03 [2019-10-22T16:01:03.076Z] PASS
16:01:03 [2019-10-22T16:01:03.076Z]
16:01:03 [2019-10-22T16:01:03.076Z] DONE 2 tests in 15.884s
16:01:03 [2019-10-22T16:01:03.076Z] Running /go/src/github.com/docker/docker/integration/plugin/volumes (s390x.integration.plugin.volumes) flags=-test.v -test.timeout=120m
16:01:03 [2019-10-22T16:01:03.076Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-volumes-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-volumes-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.plugin.volumes -t ./test.main -test.v -test.timeout=120m
16:01:03 [2019-10-22T16:01:03.076Z] ++ set -e
16:01:03 [2019-10-22T16:01:03.076Z] ++ '[' -n 0 ']'
16:01:03 [2019-10-22T16:01:03.076Z] ++ set -x
16:01:03 [2019-10-22T16:01:03.076Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=s390x DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-volumes-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-volumes-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.plugin.volumes -t ./test.main -test.v -test.timeout=120m
16:01:03 [2019-10-22T16:01:03.076Z] INFO: Testing against a local daemon
16:01:03 [2019-10-22T16:01:03.076Z] === RUN TestPluginWithDevMounts
16:01:03 [2019-10-22T16:01:03.076Z] === PAUSE TestPluginWithDevMounts
16:01:03 [2019-10-22T16:01:03.076Z] === CONT TestPluginWithDevMounts
16:01:04 [2019-10-22T16:01:04.908Z] --- PASS: TestPluginWithDevMounts (2.03s)
16:01:04 [2019-10-22T16:01:04.908Z] mounts_test.go:23: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestPluginWithDevMounts"
16:01:04 [2019-10-22T16:01:04.908Z] PASS
16:01:04 [2019-10-22T16:01:04.908Z]
16:01:04 [2019-10-22T16:01:04.908Z] DONE 1 tests in 2.138s
16:01:04 [2019-10-22T16:01:04.908Z] Running /go/src/github.com/docker/docker/integration/secret (s390x.integration.secret) flags=-test.v -test.timeout=120m
16:01:04 [2019-10-22T16:01:04.908Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-secret-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-secret-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.secret -t ./test.main -test.v -test.timeout=120m
16:01:04 [2019-10-22T16:01:04.908Z] ++ set -e
16:01:04 [2019-10-22T16:01:04.908Z] ++ '[' -n 0 ']'
16:01:04 [2019-10-22T16:01:04.908Z] ++ set -x
16:01:04 [2019-10-22T16:01:04.908Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=s390x DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-secret-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-secret-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.secret -t ./test.main -test.v -test.timeout=120m
16:01:04 [2019-10-22T16:01:04.908Z] INFO: Testing against a local daemon
16:01:04 [2019-10-22T16:01:04.908Z] === RUN TestSecretInspect
16:01:08 [2019-10-22T16:01:08.208Z] --- PASS: TestSecretInspect (2.93s)
16:01:08 [2019-10-22T16:01:08.208Z] secret_test.go:25: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestSecretInspect"
16:01:08 [2019-10-22T16:01:08.208Z] === RUN TestSecretList
16:01:10 [2019-10-22T16:01:10.658Z] --- PASS: TestSecretList (2.93s)
16:01:10 [2019-10-22T16:01:10.658Z] secret_test.go:48: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestSecretList"
16:01:10 [2019-10-22T16:01:10.658Z] === RUN TestSecretsCreateAndDelete
16:01:14 [2019-10-22T16:01:14.053Z] --- PASS: TestSecretsCreateAndDelete (2.93s)
16:01:14 [2019-10-22T16:01:14.053Z] secret_test.go:125: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestSecretsCreateAndDelete"
16:01:14 [2019-10-22T16:01:14.053Z] === RUN TestSecretsUpdate
16:01:15 [2019-10-22T16:01:15.888Z] --- PASS: TestSecretsUpdate (2.45s)
16:01:15 [2019-10-22T16:01:15.888Z] secret_test.go:172: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestSecretsUpdate"
16:01:15 [2019-10-22T16:01:15.888Z] === RUN TestTemplatedSecret
16:01:20 [2019-10-22T16:01:20.008Z] --- PASS: TestTemplatedSecret (3.48s)
16:01:20 [2019-10-22T16:01:20.008Z] secret_test.go:221: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestTemplatedSecret"
16:01:20 [2019-10-22T16:01:20.008Z] === RUN TestSecretCreateResolve
16:01:22 [2019-10-22T16:01:22.669Z] --- PASS: TestSecretCreateResolve (2.92s)
16:01:22 [2019-10-22T16:01:22.669Z] secret_test.go:342: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestSecretCreateResolve"
16:01:22 [2019-10-22T16:01:22.669Z] PASS
16:01:22 [2019-10-22T16:01:22.669Z]
16:01:22 [2019-10-22T16:01:22.669Z] DONE 6 tests in 17.731s
16:01:22 [2019-10-22T16:01:22.669Z] Running /go/src/github.com/docker/docker/integration/service (s390x.integration.service) flags=-test.v -test.timeout=120m
16:01:22 [2019-10-22T16:01:22.669Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-service-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-service-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.service -t ./test.main -test.v -test.timeout=120m
16:01:22 [2019-10-22T16:01:22.669Z] ++ set -e
16:01:22 [2019-10-22T16:01:22.669Z] ++ '[' -n 0 ']'
16:01:22 [2019-10-22T16:01:22.669Z] ++ set -x
16:01:22 [2019-10-22T16:01:22.669Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=s390x DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-service-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-service-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.service -t ./test.main -test.v -test.timeout=120m
16:01:22 [2019-10-22T16:01:22.669Z] INFO: Testing against a local daemon
16:01:22 [2019-10-22T16:01:22.669Z] === RUN TestServiceCreateInit
16:01:22 [2019-10-22T16:01:22.669Z] === RUN TestServiceCreateInit/daemonInitDisabled
16:01:27 [2019-10-22T16:01:27.777Z] === RUN TestServiceCreateInit/daemonInitEnabled
16:01:33 [2019-10-22T16:01:33.000Z] --- PASS: TestServiceCreateInit (10.38s)
16:01:33 [2019-10-22T16:01:33.000Z] --- PASS: TestServiceCreateInit/daemonInitDisabled (5.06s)
16:01:33 [2019-10-22T16:01:33.000Z] create_test.go:38: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceCreateInit/daemonInitDisabled"
16:01:33 [2019-10-22T16:01:33.000Z] --- PASS: TestServiceCreateInit/daemonInitEnabled (5.31s)
16:01:33 [2019-10-22T16:01:33.000Z] create_test.go:38: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceCreateInit/daemonInitEnabled"
16:01:33 [2019-10-22T16:01:33.000Z] === RUN TestCreateServiceMultipleTimes
16:01:52 [2019-10-22T16:01:52.853Z] --- PASS: TestCreateServiceMultipleTimes (17.53s)
16:01:52 [2019-10-22T16:01:52.853Z] create_test.go:80: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceMultipleTimes"
16:01:52 [2019-10-22T16:01:52.853Z] === RUN TestCreateServiceConflict
16:01:53 [2019-10-22T16:01:53.221Z] --- PASS: TestCreateServiceConflict (2.86s)
16:01:53 [2019-10-22T16:01:53.221Z] create_test.go:129: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceConflict"
16:01:53 [2019-10-22T16:01:53.221Z] === RUN TestCreateServiceMaxReplicas
16:01:57 [2019-10-22T16:01:57.367Z] --- PASS: TestCreateServiceMaxReplicas (3.89s)
16:01:57 [2019-10-22T16:01:57.367Z] create_test.go:150: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceMaxReplicas"
16:01:57 [2019-10-22T16:01:57.367Z] === RUN TestCreateWithDuplicateNetworkNames
16:02:13 [2019-10-22T16:02:13.839Z] --- PASS: TestCreateWithDuplicateNetworkNames (14.22s)
16:02:13 [2019-10-22T16:02:13.839Z] create_test.go:171: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateWithDuplicateNetworkNames"
16:02:13 [2019-10-22T16:02:13.839Z] === RUN TestCreateServiceSecretFileMode
16:02:14 [2019-10-22T16:02:14.619Z] --- PASS: TestCreateServiceSecretFileMode (3.26s)
16:02:14 [2019-10-22T16:02:14.619Z] create_test.go:224: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceSecretFileMode"
16:02:14 [2019-10-22T16:02:14.619Z] === RUN TestCreateServiceConfigFileMode
16:02:17 [2019-10-22T16:02:17.811Z] --- PASS: TestCreateServiceConfigFileMode (3.27s)
16:02:17 [2019-10-22T16:02:17.811Z] create_test.go:288: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceConfigFileMode"
16:02:17 [2019-10-22T16:02:17.811Z] === RUN TestCreateServiceSysctls
16:02:22 [2019-10-22T16:02:22.015Z] --- PASS: TestCreateServiceSysctls (4.25s)
16:02:22 [2019-10-22T16:02:22.015Z] create_test.go:378: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceSysctls"
16:02:22 [2019-10-22T16:02:22.015Z] === RUN TestCreateServiceCapabilities
16:02:26 [2019-10-22T16:02:26.087Z] --- PASS: TestCreateServiceCapabilities (3.40s)
16:02:26 [2019-10-22T16:02:26.087Z] create_test.go:462: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceCapabilities"
16:02:26 [2019-10-22T16:02:26.087Z] === RUN TestInspect
16:02:29 [2019-10-22T16:02:29.368Z] --- PASS: TestInspect (3.71s)
16:02:29 [2019-10-22T16:02:29.368Z] inspect_test.go:23: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestInspect"
16:02:29 [2019-10-22T16:02:29.368Z] === RUN TestServiceListWithStatuses
16:02:29 [2019-10-22T16:02:29.368Z] --- SKIP: TestServiceListWithStatuses (0.00s)
16:02:29 [2019-10-22T16:02:29.368Z] list_test.go:34: versions.LessThan(testEnv.DaemonInfo.ServerVersion, "1.41")
16:02:29 [2019-10-22T16:02:29.368Z] === RUN TestDockerNetworkConnectAlias
16:02:35 [2019-10-22T16:02:35.679Z] --- PASS: TestDockerNetworkConnectAlias (5.96s)
16:02:35 [2019-10-22T16:02:35.679Z] network_test.go:20: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkConnectAlias"
16:02:35 [2019-10-22T16:02:35.679Z] === RUN TestDockerNetworkReConnect
16:02:39 [2019-10-22T16:02:39.883Z] --- PASS: TestDockerNetworkReConnect (4.84s)
16:02:39 [2019-10-22T16:02:39.883Z] network_test.go:82: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkReConnect"
16:02:39 [2019-10-22T16:02:39.883Z] === RUN TestServicePlugin
16:02:39 [2019-10-22T16:02:39.883Z] --- SKIP: TestServicePlugin (0.00s)
16:02:39 [2019-10-22T16:02:39.883Z] plugin_test.go:28: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
16:02:39 [2019-10-22T16:02:39.883Z] === RUN TestServiceUpdateLabel
16:02:43 [2019-10-22T16:02:43.026Z] --- PASS: TestServiceUpdateLabel (2.89s)
16:02:43 [2019-10-22T16:02:43.026Z] update_test.go:21: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateLabel"
16:02:43 [2019-10-22T16:02:43.026Z] === RUN TestServiceUpdateSecrets
16:02:59 [2019-10-22T16:02:59.467Z] --- PASS: TestServiceUpdateSecrets (15.73s)
16:02:59 [2019-10-22T16:02:59.467Z] update_test.go:77: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateSecrets"
16:02:59 [2019-10-22T16:02:59.467Z] === RUN TestServiceUpdateConfigs
16:03:16 [2019-10-22T16:03:16.001Z] --- PASS: TestServiceUpdateConfigs (15.94s)
16:03:16 [2019-10-22T16:03:16.001Z] update_test.go:139: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateConfigs"
16:03:16 [2019-10-22T16:03:16.001Z] === RUN TestServiceUpdateNetwork
16:03:29 [2019-10-22T16:03:29.614Z] --- PASS: TestServiceUpdateNetwork (13.67s)
16:03:29 [2019-10-22T16:03:29.614Z] update_test.go:201: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateNetwork"
16:03:29 [2019-10-22T16:03:29.614Z] PASS
16:03:29 [2019-10-22T16:03:29.614Z]
16:03:29 [2019-10-22T16:03:29.614Z] === Skipped
16:03:29 [2019-10-22T16:03:29.614Z] === SKIP: s390x.integration.service TestServiceListWithStatuses (0.00s)
16:03:29 [2019-10-22T16:03:29.614Z] list_test.go:34: versions.LessThan(testEnv.DaemonInfo.ServerVersion, "1.41")
16:03:29 [2019-10-22T16:03:29.614Z]
16:03:29 [2019-10-22T16:03:29.614Z] === SKIP: s390x.integration.service TestServicePlugin (0.00s)
16:03:29 [2019-10-22T16:03:29.614Z] plugin_test.go:28: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
16:03:29 [2019-10-22T16:03:29.614Z]
16:03:29 [2019-10-22T16:03:29.614Z]
16:03:29 [2019-10-22T16:03:29.614Z] DONE 20 tests, 2 skipped in 125.905s
16:03:29 [2019-10-22T16:03:29.614Z] Running /go/src/github.com/docker/docker/integration/session (s390x.integration.session) flags=-test.v -test.timeout=120m
16:03:29 [2019-10-22T16:03:29.614Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-session-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-session-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.session -t ./test.main -test.v -test.timeout=120m
16:03:29 [2019-10-22T16:03:29.615Z] ++ set -e
16:03:29 [2019-10-22T16:03:29.615Z] ++ '[' -n 0 ']'
16:03:29 [2019-10-22T16:03:29.615Z] ++ set -x
16:03:29 [2019-10-22T16:03:29.615Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=s390x DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-session-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-session-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.session -t ./test.main -test.v -test.timeout=120m
16:03:29 [2019-10-22T16:03:29.615Z] INFO: Testing against a local daemon
16:03:29 [2019-10-22T16:03:29.615Z] === RUN TestSessionCreate
16:03:29 [2019-10-22T16:03:29.615Z] --- PASS: TestSessionCreate (0.04s)
16:03:29 [2019-10-22T16:03:29.615Z] === RUN TestSessionCreateWithBadUpgrade
16:03:29 [2019-10-22T16:03:29.615Z] --- PASS: TestSessionCreateWithBadUpgrade (0.02s)
16:03:29 [2019-10-22T16:03:29.615Z] PASS
16:03:29 [2019-10-22T16:03:29.615Z]
16:03:29 [2019-10-22T16:03:29.615Z] DONE 2 tests in 0.138s
16:03:29 [2019-10-22T16:03:29.615Z] Running /go/src/github.com/docker/docker/integration/system (s390x.integration.system) flags=-test.v -test.timeout=120m
16:03:29 [2019-10-22T16:03:29.615Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-system-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-system-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.system -t ./test.main -test.v -test.timeout=120m
16:03:29 [2019-10-22T16:03:29.615Z] ++ set -e
16:03:29 [2019-10-22T16:03:29.615Z] ++ '[' -n 0 ']'
16:03:29 [2019-10-22T16:03:29.615Z] ++ set -x
16:03:29 [2019-10-22T16:03:29.615Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=s390x DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-system-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-system-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.system -t ./test.main -test.v -test.timeout=120m
16:03:29 [2019-10-22T16:03:29.615Z] INFO: Testing against a local daemon
16:03:29 [2019-10-22T16:03:29.615Z] === RUN TestCgroupDriverSystemdMemoryLimit
16:03:29 [2019-10-22T16:03:29.615Z] --- SKIP: TestCgroupDriverSystemdMemoryLimit (0.01s)
16:03:29 [2019-10-22T16:03:29.615Z] cgroupdriver_systemd_test.go:32: !hasSystemd()
16:03:29 [2019-10-22T16:03:29.615Z] === RUN TestEventsExecDie
16:03:29 [2019-10-22T16:03:29.615Z] --- PASS: TestEventsExecDie (0.97s)
16:03:29 [2019-10-22T16:03:29.615Z] === RUN TestEventsBackwardsCompatible
16:03:29 [2019-10-22T16:03:29.615Z] --- PASS: TestEventsBackwardsCompatible (0.10s)
16:03:29 [2019-10-22T16:03:29.615Z] === RUN TestInfoBinaryCommits
16:03:29 [2019-10-22T16:03:29.615Z] --- PASS: TestInfoBinaryCommits (0.02s)
16:03:29 [2019-10-22T16:03:29.615Z] === RUN TestInfoAPIVersioned
16:03:29 [2019-10-22T16:03:29.615Z] --- PASS: TestInfoAPIVersioned (0.01s)
16:03:29 [2019-10-22T16:03:29.615Z] === RUN TestInfoDiscoveryBackend
16:03:30 [2019-10-22T16:03:30.076Z] --- PASS: TestInfoDiscoveryBackend (0.52s)
16:03:30 [2019-10-22T16:03:30.076Z] info_linux_test.go:61: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestInfoDiscoveryBackend"
16:03:30 [2019-10-22T16:03:30.076Z] === RUN TestInfoDiscoveryInvalidAdvertise
16:03:31 [2019-10-22T16:03:31.388Z] --- PASS: TestInfoDiscoveryInvalidAdvertise (1.00s)
16:03:31 [2019-10-22T16:03:31.388Z] info_linux_test.go:74: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestInfoDiscoveryInvalidAdvertise"
16:03:31 [2019-10-22T16:03:31.388Z] === RUN TestInfoDiscoveryAdvertiseInterfaceName
16:03:31 [2019-10-22T16:03:31.755Z] --- PASS: TestInfoDiscoveryAdvertiseInterfaceName (0.52s)
16:03:31 [2019-10-22T16:03:31.755Z] info_linux_test.go:97: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestInfoDiscoveryAdvertiseInterfaceName"
16:03:31 [2019-10-22T16:03:31.755Z] === RUN TestInfoAPI
16:03:31 [2019-10-22T16:03:31.755Z] --- PASS: TestInfoAPI (0.02s)
16:03:31 [2019-10-22T16:03:31.755Z] === RUN TestInfoAPIWarnings
16:03:32 [2019-10-22T16:03:32.130Z] --- PASS: TestInfoAPIWarnings (0.52s)
16:03:32 [2019-10-22T16:03:32.130Z] info_test.go:51: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestInfoAPIWarnings"
16:03:32 [2019-10-22T16:03:32.130Z] === RUN TestInfoDebug
16:03:32 [2019-10-22T16:03:32.914Z] --- PASS: TestInfoDebug (0.52s)
16:03:32 [2019-10-22T16:03:32.914Z] info_test.go:74: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestInfoDebug"
16:03:32 [2019-10-22T16:03:32.914Z] === RUN TestInfoInsecureRegistries
16:03:33 [2019-10-22T16:03:33.283Z] --- PASS: TestInfoInsecureRegistries (0.53s)
16:03:33 [2019-10-22T16:03:33.283Z] info_test.go:99: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestInfoInsecureRegistries"
16:03:33 [2019-10-22T16:03:33.283Z] === RUN TestInfoRegistryMirrors
16:03:33 [2019-10-22T16:03:33.645Z] --- PASS: TestInfoRegistryMirrors (0.52s)
16:03:33 [2019-10-22T16:03:33.645Z] info_test.go:123: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestInfoRegistryMirrors"
16:03:33 [2019-10-22T16:03:33.645Z] === RUN TestLoginFailsWithBadCredentials
16:03:34 [2019-10-22T16:03:34.455Z] --- PASS: TestLoginFailsWithBadCredentials (0.40s)
16:03:34 [2019-10-22T16:03:34.455Z] === RUN TestPingCacheHeaders
16:03:34 [2019-10-22T16:03:34.455Z] --- PASS: TestPingCacheHeaders (0.03s)
16:03:34 [2019-10-22T16:03:34.455Z] === RUN TestPingGet
16:03:34 [2019-10-22T16:03:34.455Z] --- PASS: TestPingGet (0.02s)
16:03:34 [2019-10-22T16:03:34.455Z] === RUN TestPingHead
16:03:34 [2019-10-22T16:03:34.455Z] --- PASS: TestPingHead (0.02s)
16:03:34 [2019-10-22T16:03:34.455Z] === RUN TestVersion
16:03:34 [2019-10-22T16:03:34.455Z] --- PASS: TestVersion (0.02s)
16:03:34 [2019-10-22T16:03:34.455Z] PASS
16:03:34 [2019-10-22T16:03:34.455Z]
16:03:34 [2019-10-22T16:03:34.455Z] === Skipped
16:03:34 [2019-10-22T16:03:34.455Z] === SKIP: s390x.integration.system TestCgroupDriverSystemdMemoryLimit (0.01s)
16:03:34 [2019-10-22T16:03:34.455Z] cgroupdriver_systemd_test.go:32: !hasSystemd()
16:03:34 [2019-10-22T16:03:34.455Z]
16:03:34 [2019-10-22T16:03:34.455Z]
16:03:34 [2019-10-22T16:03:34.455Z] DONE 18 tests, 1 skipped in 5.854s
16:03:34 [2019-10-22T16:03:34.455Z] Running /go/src/github.com/docker/docker/integration/volume (s390x.integration.volume) flags=-test.v -test.timeout=120m
16:03:34 [2019-10-22T16:03:34.455Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-volume-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-volume-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.volume -t ./test.main -test.v -test.timeout=120m
16:03:34 [2019-10-22T16:03:34.455Z] ++ set -e
16:03:34 [2019-10-22T16:03:34.455Z] ++ '[' -n 0 ']'
16:03:34 [2019-10-22T16:03:34.455Z] ++ set -x
16:03:34 [2019-10-22T16:03:34.455Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=s390x DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-volume-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-volume-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.volume -t ./test.main -test.v -test.timeout=120m
16:03:34 [2019-10-22T16:03:34.455Z] INFO: Testing against a local daemon
16:03:34 [2019-10-22T16:03:34.455Z] === RUN TestVolumesCreateAndList
16:03:34 [2019-10-22T16:03:34.455Z] --- PASS: TestVolumesCreateAndList (0.04s)
16:03:34 [2019-10-22T16:03:34.455Z] === RUN TestVolumesRemove
16:03:34 [2019-10-22T16:03:34.455Z] --- PASS: TestVolumesRemove (0.09s)
16:03:34 [2019-10-22T16:03:34.455Z] === RUN TestVolumesInspect
16:03:34 [2019-10-22T16:03:34.456Z] --- PASS: TestVolumesInspect (0.02s)
16:03:34 [2019-10-22T16:03:34.456Z] === RUN TestVolumesInvalidJSON
16:03:34 [2019-10-22T16:03:34.456Z] === RUN TestVolumesInvalidJSON//volumes/create
16:03:34 [2019-10-22T16:03:34.456Z] === PAUSE TestVolumesInvalidJSON//volumes/create
16:03:34 [2019-10-22T16:03:34.456Z] === CONT TestVolumesInvalidJSON//volumes/create
16:03:34 [2019-10-22T16:03:34.456Z] --- PASS: TestVolumesInvalidJSON (0.01s)
16:03:34 [2019-10-22T16:03:34.456Z] --- PASS: TestVolumesInvalidJSON//volumes/create (0.00s)
16:03:34 [2019-10-22T16:03:34.456Z] PASS
16:03:34 [2019-10-22T16:03:34.456Z]
16:03:34 [2019-10-22T16:03:34.456Z] DONE 5 tests in 0.230s
16:03:34 [2019-10-22T16:03:34.456Z] ---> Making bundle: .integration-daemon-stop (in bundles/test-integration)
16:03:35 [2019-10-22T16:03:35.064Z] ++++ cat bundles/test-integration/docker.pid
16:03:35 [2019-10-22T16:03:35.064Z] +++ kill 11458
16:03:36 [2019-10-22T16:03:36.034Z] +++ /etc/init.d/apparmor stop
16:03:36 [2019-10-22T16:03:36.034Z] Clearing AppArmor profiles cache:.
16:03:36 [2019-10-22T16:03:36.034Z] All profile caches have been cleared, but no profiles have been unloaded.
16:03:36 [2019-10-22T16:03:36.034Z] Unloading profiles will leave already running processes permanently
16:03:36 [2019-10-22T16:03:36.034Z] unconfined, which can lead to unexpected situations.
16:03:36 [2019-10-22T16:03:36.034Z]
16:03:36 [2019-10-22T16:03:36.034Z] To set a process to complain mode, use the command line tool
16:03:36 [2019-10-22T16:03:36.034Z] 'aa-complain'. To really tear down all profiles, run the init script
16:03:36 [2019-10-22T16:03:36.034Z] with the 'teardown' option."
16:03:36 [2019-10-22T16:03:36.403Z]