Console Output

18:35:16 [2020-02-28T18:35:16.292Z] + docker run --rm -t --privileged -v /home/jenkins/workspace/moby_PR-40478/bundles:/go/src/github.com/docker/docker/bundles --name docker-pr3 -e DOCKER_EXPERIMENTAL -e DOCKER_GITCOMMIT=ce1ceeb25768cd402c662973fd1ae3caeee1ab05 -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:ce1ceeb25768cd402c662973fd1ae3caeee1ab05 hack/make.sh dynbinary test-integration
18:35:16 [2020-02-28T18:35:16.292Z] 
18:35:16 [2020-02-28T18:35:16.292Z] Removing bundles/
18:35:16 [2020-02-28T18:35:16.292Z] 
18:35:16 [2020-02-28T18:35:16.292Z] ---> Making bundle: dynbinary (in bundles/dynbinary)
18:35:16 [2020-02-28T18:35:16.292Z] Building: bundles/dynbinary-daemon/dockerd-dev
18:35:16 [2020-02-28T18:35:16.292Z] GOOS="" GOARCH="" GOARM=""
18:36:15 [2020-02-28T18:36:15.025Z] Created binary: bundles/dynbinary-daemon/dockerd-dev
18:36:15 [2020-02-28T18:36:15.025Z] 
18:36:15 [2020-02-28T18:36:15.025Z] ---> Making bundle: test-integration (in bundles/test-integration)
18:36:15 [2020-02-28T18:36:15.025Z] SCRIPTDIR=/go/src/github.com/docker/docker/hack
18:36:15 [2020-02-28T18:36:15.025Z] HOSTNAME=6a35d11b6d8c
18:36:15 [2020-02-28T18:36:15.025Z] TESTDEBUG=0
18:36:15 [2020-02-28T18:36:15.025Z] DEST=bundles/test-integration
18:36:15 [2020-02-28T18:36:15.025Z] PWD=/go/src/github.com/docker/docker
18:36:15 [2020-02-28T18:36:15.025Z] DOCKER_GITCOMMIT=ce1ceeb25768cd402c662973fd1ae3caeee1ab05
18:36:15 [2020-02-28T18:36:15.025Z] container=docker
18:36:15 [2020-02-28T18:36:15.025Z] HOME=/root
18:36:15 [2020-02-28T18:36:15.025Z] GOLANG_VERSION=1.13.8
18:36:15 [2020-02-28T18:36:15.025Z] VALIDATE_REPO=https://github.com/moby/moby.git
18:36:15 [2020-02-28T18:36:15.025Z] VALIDATE_BRANCH=master
18:36:15 [2020-02-28T18:36:15.025Z] TERM=xterm
18:36:15 [2020-02-28T18:36:15.025Z] DOCKER_PKG=github.com/docker/docker
18:36:15 [2020-02-28T18:36:15.025Z] SHLVL=1
18:36:15 [2020-02-28T18:36:15.025Z] TIMEOUT=120m
18:36:15 [2020-02-28T18:36:15.025Z] DOCKER_BUILDTAGS=apparmor seccomp selinux journald
18:36:15 [2020-02-28T18:36:15.025Z] DOCKER_GRAPHDRIVER=overlay2
18:36:15 [2020-02-28T18:36:15.025Z] GO111MODULE=off
18:36:15 [2020-02-28T18:36:15.025Z] DOCKER_EXPERIMENTAL=1
18:36:15 [2020-02-28T18:36:15.025Z] TEST_SKIP_INTEGRATION_CLI=1
18:36:15 [2020-02-28T18:36:15.025Z] PATH=/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
18:36:15 [2020-02-28T18:36:15.025Z] MAKEDIR=/go/src/github.com/docker/docker/hack/make
18:36:15 [2020-02-28T18:36:15.025Z] GOPATH=/go
18:36:15 [2020-02-28T18:36:15.025Z] PKG_CONFIG=pkg-config
18:36:15 [2020-02-28T18:36:15.025Z] _=/usr/bin/env
18:36:15 [2020-02-28T18:36:15.025Z] Building test suite binary /go/src/github.com/docker/docker/integration/build/test.main
18:36:38 [2020-02-28T18:36:38.881Z] Building test suite binary /go/src/github.com/docker/docker/integration/config/test.main
18:36:39 [2020-02-28T18:36:39.655Z] Building test suite binary /go/src/github.com/docker/docker/integration/container/test.main
18:36:42 [2020-02-28T18:36:42.034Z] Building test suite binary /go/src/github.com/docker/docker/integration/image/test.main
18:37:01 [2020-02-28T18:37:01.944Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/test.main
18:37:01 [2020-02-28T18:37:01.945Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/ipvlan/test.main
18:37:02 [2020-02-28T18:37:02.315Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/macvlan/test.main
18:37:03 [2020-02-28T18:37:03.076Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/test.main
18:37:03 [2020-02-28T18:37:03.450Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/authz/test.main
18:37:05 [2020-02-28T18:37:05.260Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/common/test.main
18:37:06 [2020-02-28T18:37:06.016Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/graphdriver/test.main
18:37:07 [2020-02-28T18:37:07.548Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/logging/test.main
18:37:09 [2020-02-28T18:37:09.979Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/logging/cmd/discard/test.main
18:37:10 [2020-02-28T18:37:10.348Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/volumes/test.main
18:37:11 [2020-02-28T18:37:11.606Z] Building test suite binary /go/src/github.com/docker/docker/integration/secret/test.main
18:37:12 [2020-02-28T18:37:12.875Z] Building test suite binary /go/src/github.com/docker/docker/integration/service/test.main
18:37:14 [2020-02-28T18:37:14.681Z] Building test suite binary /go/src/github.com/docker/docker/integration/session/test.main
18:37:15 [2020-02-28T18:37:15.469Z] Building test suite binary /go/src/github.com/docker/docker/integration/system/test.main
18:37:16 [2020-02-28T18:37:16.730Z] Building test suite binary /go/src/github.com/docker/docker/integration/volume/test.main
18:37:17 [2020-02-28T18:37:17.500Z] ---> Making bundle: .integration-daemon-start (in bundles/test-integration)
18:37:17 [2020-02-28T18:37:17.500Z] Using test binary docker
18:37:17 [2020-02-28T18:37:17.500Z] # DOCKER_EXPERIMENTAL is set: starting daemon with experimental features enabled! 
18:37:17 [2020-02-28T18:37:17.500Z] +++ /etc/init.d/apparmor start
18:37:17 [2020-02-28T18:37:17.500Z] Starting: AppArmor: already loaded with profiles.: Skipped. ... (warning).
18:37:17 [2020-02-28T18:37:17.500Z] Starting dockerd
18:37:17 [2020-02-28T18:37:17.500Z] INFO: Waiting for daemon to start...
18:37:17 [2020-02-28T18:37:17.500Z] +++ 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
18:37:20 [2020-02-28T18:37:20.639Z] .
18:37:20 [2020-02-28T18:37:20.639Z] ---> Making bundle: .integration-daemon-setup (in bundles/test-integration)
18:37:20 [2020-02-28T18:37:20.639Z] ---> Making bundle: .ensure-emptyfs (in bundles/test-integration)
18:37:20 [2020-02-28T18:37:20.639Z] Error: No such image: emptyfs
18:37:20 [2020-02-28T18:37:20.639Z] ++++ tar -cC bundles/test-integration/emptyfs .
18:37:20 [2020-02-28T18:37:20.639Z] ++++ docker load
18:37:20 [2020-02-28T18:37:20.639Z] Running integration-test (iteration 1)
18:37:20 [2020-02-28T18:37:20.639Z] Running /go/src/github.com/docker/docker/integration/build (s390x.integration.build) flags=-test.v -test.timeout=120m 
18:37:20 [2020-02-28T18:37:20.639Z] ++ 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
18:37:20 [2020-02-28T18:37:20.639Z] ++ set -e
18:37:20 [2020-02-28T18:37:20.639Z] ++ '[' -n 0 ']'
18:37:20 [2020-02-28T18:37:20.639Z] ++ set -x
18:37:20 [2020-02-28T18:37:20.640Z] ++ 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
18:37:29 [2020-02-28T18:37:29.945Z] Loaded image: buildpack-deps:jessie
18:37:29 [2020-02-28T18:37:29.945Z] Loaded image: busybox:latest
18:37:29 [2020-02-28T18:37:29.945Z] Loaded image: busybox:glibc
18:37:29 [2020-02-28T18:37:29.945Z] Loaded image: debian:jessie
18:37:29 [2020-02-28T18:37:29.945Z] Loaded image: hello-world:latest
18:37:29 [2020-02-28T18:37:29.945Z] INFO: Testing against a local daemon
18:37:29 [2020-02-28T18:37:29.945Z] === RUN   TestCgroupNamespacesBuild
18:37:32 [2020-02-28T18:37:32.045Z] --- PASS: TestCgroupNamespacesBuild (1.72s)
18:37:32 [2020-02-28T18:37:32.045Z] === RUN   TestCgroupNamespacesBuildDaemonHostMode
18:37:34 [2020-02-28T18:37:34.027Z] --- PASS: TestCgroupNamespacesBuildDaemonHostMode (1.98s)
18:37:34 [2020-02-28T18:37:34.027Z] === RUN   TestBuildWithSession
18:37:34 [2020-02-28T18:37:34.027Z] --- SKIP: TestBuildWithSession (0.00s)
18:37:34 [2020-02-28T18:37:34.027Z]     build_session_test.go:25: TODO: BuildKit
18:37:34 [2020-02-28T18:37:34.027Z] === RUN   TestBuildSquashParent
18:37:41 [2020-02-28T18:37:41.606Z] --- PASS: TestBuildSquashParent (6.86s)
18:37:41 [2020-02-28T18:37:41.606Z] === RUN   TestBuildWithRemoveAndForceRemove
18:37:41 [2020-02-28T18:37:41.606Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
18:37:41 [2020-02-28T18:37:41.606Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
18:37:41 [2020-02-28T18:37:41.606Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_remove
18:37:41 [2020-02-28T18:37:41.606Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_remove
18:37:41 [2020-02-28T18:37:41.606Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
18:37:41 [2020-02-28T18:37:41.606Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
18:37:41 [2020-02-28T18:37:41.606Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
18:37:41 [2020-02-28T18:37:41.606Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
18:37:41 [2020-02-28T18:37:41.606Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_remove
18:37:41 [2020-02-28T18:37:41.606Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_remove
18:37:41 [2020-02-28T18:37:41.606Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
18:37:41 [2020-02-28T18:37:41.606Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
18:37:41 [2020-02-28T18:37:41.606Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
18:37:41 [2020-02-28T18:37:41.606Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
18:37:43 [2020-02-28T18:37:43.479Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_remove
18:37:43 [2020-02-28T18:37:43.479Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
18:37:46 [2020-02-28T18:37:46.603Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
18:37:46 [2020-02-28T18:37:46.603Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_remove
18:37:48 [2020-02-28T18:37:48.991Z] --- PASS: TestBuildWithRemoveAndForceRemove (0.01s)
18:37:48 [2020-02-28T18:37:48.991Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal (2.89s)
18:37:48 [2020-02-28T18:37:48.991Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove (2.94s)
18:37:48 [2020-02-28T18:37:48.991Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_remove (2.64s)
18:37:48 [2020-02-28T18:37:48.991Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal (2.67s)
18:37:48 [2020-02-28T18:37:48.991Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove (2.40s)
18:37:48 [2020-02-28T18:37:48.991Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_remove (2.38s)
18:37:48 [2020-02-28T18:37:48.991Z] === RUN   TestBuildMultiStageCopy
18:37:48 [2020-02-28T18:37:48.991Z] === RUN   TestBuildMultiStageCopy/copy_to_root
18:37:51 [2020-02-28T18:37:51.366Z] === RUN   TestBuildMultiStageCopy/copy_to_newdir
18:37:51 [2020-02-28T18:37:51.714Z] === RUN   TestBuildMultiStageCopy/copy_to_newdir_nested
18:37:52 [2020-02-28T18:37:52.079Z] === RUN   TestBuildMultiStageCopy/copy_to_existingdir
18:37:52 [2020-02-28T18:37:52.832Z] === RUN   TestBuildMultiStageCopy/copy_to_newsubdir
18:37:53 [2020-02-28T18:37:53.625Z] --- PASS: TestBuildMultiStageCopy (4.88s)
18:37:53 [2020-02-28T18:37:53.625Z]     --- PASS: TestBuildMultiStageCopy/copy_to_root (2.42s)
18:37:53 [2020-02-28T18:37:53.625Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newdir (0.55s)
18:37:53 [2020-02-28T18:37:53.625Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newdir_nested (0.48s)
18:37:53 [2020-02-28T18:37:53.625Z]     --- PASS: TestBuildMultiStageCopy/copy_to_existingdir (0.86s)
18:37:53 [2020-02-28T18:37:53.625Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newsubdir (0.57s)
18:37:53 [2020-02-28T18:37:53.625Z] === RUN   TestBuildMultiStageParentConfig
18:37:54 [2020-02-28T18:37:54.847Z] --- PASS: TestBuildMultiStageParentConfig (1.37s)
18:37:54 [2020-02-28T18:37:54.847Z] === RUN   TestBuildLabelWithTargets
18:37:57 [2020-02-28T18:37:57.231Z] --- PASS: TestBuildLabelWithTargets (2.37s)
18:37:57 [2020-02-28T18:37:57.231Z] === RUN   TestBuildWithEmptyLayers
18:37:58 [2020-02-28T18:37:58.445Z] --- PASS: TestBuildWithEmptyLayers (1.02s)
18:37:58 [2020-02-28T18:37:58.445Z] === RUN   TestBuildMultiStageOnBuild
18:38:01 [2020-02-28T18:38:01.589Z] --- PASS: TestBuildMultiStageOnBuild (3.06s)
18:38:01 [2020-02-28T18:38:01.589Z] === RUN   TestBuildUncleanTarFilenames
18:38:02 [2020-02-28T18:38:02.986Z] --- PASS: TestBuildUncleanTarFilenames (1.46s)
18:38:02 [2020-02-28T18:38:02.986Z] === RUN   TestBuildMultiStageLayerLeak
18:38:06 [2020-02-28T18:38:06.178Z] --- PASS: TestBuildMultiStageLayerLeak (3.12s)
18:38:06 [2020-02-28T18:38:06.178Z] === RUN   TestBuildWithHugeFile
18:38:34 [2020-02-28T18:38:34.706Z] --- PASS: TestBuildWithHugeFile (27.73s)
18:38:34 [2020-02-28T18:38:34.706Z] === RUN   TestBuildWithEmptyDockerfile
18:38:34 [2020-02-28T18:38:34.706Z] === RUN   TestBuildWithEmptyDockerfile/empty-dockerfile
18:38:34 [2020-02-28T18:38:34.706Z] === PAUSE TestBuildWithEmptyDockerfile/empty-dockerfile
18:38:34 [2020-02-28T18:38:34.706Z] === RUN   TestBuildWithEmptyDockerfile/empty-lines-dockerfile
18:38:34 [2020-02-28T18:38:34.706Z] === PAUSE TestBuildWithEmptyDockerfile/empty-lines-dockerfile
18:38:34 [2020-02-28T18:38:34.706Z] === RUN   TestBuildWithEmptyDockerfile/comment-only-dockerfile
18:38:34 [2020-02-28T18:38:34.706Z] === PAUSE TestBuildWithEmptyDockerfile/comment-only-dockerfile
18:38:34 [2020-02-28T18:38:34.706Z] === CONT  TestBuildWithEmptyDockerfile/empty-dockerfile
18:38:34 [2020-02-28T18:38:34.706Z] === CONT  TestBuildWithEmptyDockerfile/comment-only-dockerfile
18:38:34 [2020-02-28T18:38:34.706Z] === CONT  TestBuildWithEmptyDockerfile/empty-lines-dockerfile
18:38:34 [2020-02-28T18:38:34.706Z] --- PASS: TestBuildWithEmptyDockerfile (0.16s)
18:38:34 [2020-02-28T18:38:34.706Z]     --- PASS: TestBuildWithEmptyDockerfile/empty-dockerfile (0.27s)
18:38:34 [2020-02-28T18:38:34.706Z]     --- PASS: TestBuildWithEmptyDockerfile/comment-only-dockerfile (0.27s)
18:38:34 [2020-02-28T18:38:34.706Z]     --- PASS: TestBuildWithEmptyDockerfile/empty-lines-dockerfile (0.11s)
18:38:34 [2020-02-28T18:38:34.706Z] === RUN   TestBuildPreserveOwnership
18:38:34 [2020-02-28T18:38:34.706Z] === RUN   TestBuildPreserveOwnership/copy_from
18:38:38 [2020-02-28T18:38:38.638Z] === RUN   TestBuildPreserveOwnership/copy_from_chowned
18:38:40 [2020-02-28T18:38:40.393Z] --- PASS: TestBuildPreserveOwnership (5.91s)
18:38:40 [2020-02-28T18:38:40.393Z]     --- PASS: TestBuildPreserveOwnership/copy_from (3.91s)
18:38:40 [2020-02-28T18:38:40.393Z]     --- PASS: TestBuildPreserveOwnership/copy_from_chowned (1.99s)
18:38:40 [2020-02-28T18:38:40.393Z] === RUN   TestBuildPlatformInvalid
18:38:40 [2020-02-28T18:38:40.393Z] --- PASS: TestBuildPlatformInvalid (0.12s)
18:38:40 [2020-02-28T18:38:40.393Z] PASS
18:38:40 [2020-02-28T18:38:40.393Z] 
18:38:40 [2020-02-28T18:38:40.393Z] === Skipped
18:38:40 [2020-02-28T18:38:40.393Z] === SKIP: s390x.integration.build TestBuildWithSession (0.00s)
18:38:40 [2020-02-28T18:38:40.393Z]     build_session_test.go:25: TODO: BuildKit
18:38:40 [2020-02-28T18:38:40.393Z] 
18:38:40 [2020-02-28T18:38:40.393Z] 
18:38:40 [2020-02-28T18:38:40.393Z] DONE 32 tests, 1 skipped in 79.757s
18:38:40 [2020-02-28T18:38:40.393Z] Running /go/src/github.com/docker/docker/integration/config (s390x.integration.config) flags=-test.v -test.timeout=120m 
18:38:40 [2020-02-28T18:38:40.393Z] ++ 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
18:38:40 [2020-02-28T18:38:40.393Z] ++ set -e
18:38:40 [2020-02-28T18:38:40.393Z] ++ '[' -n 0 ']'
18:38:40 [2020-02-28T18:38:40.393Z] ++ set -x
18:38:40 [2020-02-28T18:38:40.393Z] ++ 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
18:38:40 [2020-02-28T18:38:40.743Z] INFO: Testing against a local daemon
18:38:40 [2020-02-28T18:38:40.743Z] === RUN   TestConfigList
18:38:43 [2020-02-28T18:38:43.850Z] --- PASS: TestConfigList (2.83s)
18:38:43 [2020-02-28T18:38:43.850Z] === RUN   TestConfigsCreateAndDelete
18:38:46 [2020-02-28T18:38:46.228Z] --- PASS: TestConfigsCreateAndDelete (2.73s)
18:38:46 [2020-02-28T18:38:46.228Z] === RUN   TestConfigsUpdate
18:38:49 [2020-02-28T18:38:49.332Z] --- PASS: TestConfigsUpdate (2.74s)
18:38:49 [2020-02-28T18:38:49.332Z] === RUN   TestTemplatedConfig
18:38:53 [2020-02-28T18:38:53.395Z] --- PASS: TestTemplatedConfig (3.85s)
18:38:53 [2020-02-28T18:38:53.395Z] === RUN   TestConfigInspect
18:38:55 [2020-02-28T18:38:55.858Z] --- PASS: TestConfigInspect (2.92s)
18:38:55 [2020-02-28T18:38:55.858Z] === RUN   TestConfigCreateWithLabels
18:38:58 [2020-02-28T18:38:58.979Z] --- PASS: TestConfigCreateWithLabels (2.97s)
18:38:58 [2020-02-28T18:38:58.979Z] === RUN   TestConfigCreateResolve
18:39:01 [2020-02-28T18:39:01.361Z] --- PASS: TestConfigCreateResolve (2.81s)
18:39:01 [2020-02-28T18:39:01.361Z] === RUN   TestConfigDaemonLibtrustID
18:39:02 [2020-02-28T18:39:02.120Z] --- PASS: TestConfigDaemonLibtrustID (0.68s)
18:39:02 [2020-02-28T18:39:02.120Z] PASS
18:39:02 [2020-02-28T18:39:02.120Z] 
18:39:02 [2020-02-28T18:39:02.120Z] DONE 8 tests in 21.698s
18:39:02 [2020-02-28T18:39:02.120Z] Running /go/src/github.com/docker/docker/integration/container (s390x.integration.container) flags=-test.v -test.timeout=120m 
18:39:02 [2020-02-28T18:39:02.120Z] ++ 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
18:39:02 [2020-02-28T18:39:02.120Z] ++ set -e
18:39:02 [2020-02-28T18:39:02.120Z] ++ '[' -n 0 ']'
18:39:02 [2020-02-28T18:39:02.120Z] ++ set -x
18:39:02 [2020-02-28T18:39:02.120Z] ++ 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
18:39:02 [2020-02-28T18:39:02.952Z] INFO: Testing against a local daemon
18:39:02 [2020-02-28T18:39:02.952Z] === RUN   TestCheckpoint
18:39:02 [2020-02-28T18:39:02.952Z] --- SKIP: TestCheckpoint (0.00s)
18:39:02 [2020-02-28T18:39:02.952Z]     checkpoint_test.go:33: TestCheckpoint is broken; see https://github.com/moby/moby/issues/38963
18:39:02 [2020-02-28T18:39:02.952Z] === RUN   TestContainerInvalidJSON
18:39:02 [2020-02-28T18:39:02.952Z] === RUN   TestContainerInvalidJSON//containers/foobar/copy
18:39:02 [2020-02-28T18:39:02.952Z] === PAUSE TestContainerInvalidJSON//containers/foobar/copy
18:39:02 [2020-02-28T18:39:02.952Z] === RUN   TestContainerInvalidJSON//containers/foobar/exec
18:39:02 [2020-02-28T18:39:02.952Z] === PAUSE TestContainerInvalidJSON//containers/foobar/exec
18:39:02 [2020-02-28T18:39:02.952Z] === RUN   TestContainerInvalidJSON//exec/foobar/start
18:39:02 [2020-02-28T18:39:02.952Z] === PAUSE TestContainerInvalidJSON//exec/foobar/start
18:39:02 [2020-02-28T18:39:02.952Z] === CONT  TestContainerInvalidJSON//containers/foobar/copy
18:39:02 [2020-02-28T18:39:02.952Z] === CONT  TestContainerInvalidJSON//exec/foobar/start
18:39:02 [2020-02-28T18:39:02.952Z] === CONT  TestContainerInvalidJSON//containers/foobar/exec
18:39:02 [2020-02-28T18:39:02.952Z] --- PASS: TestContainerInvalidJSON (0.02s)
18:39:02 [2020-02-28T18:39:02.952Z]     --- PASS: TestContainerInvalidJSON//containers/foobar/copy (0.00s)
18:39:02 [2020-02-28T18:39:02.952Z]     --- PASS: TestContainerInvalidJSON//containers/foobar/exec (0.00s)
18:39:02 [2020-02-28T18:39:02.952Z]     --- PASS: TestContainerInvalidJSON//exec/foobar/start (0.00s)
18:39:02 [2020-02-28T18:39:02.952Z] === RUN   TestCopyFromContainerPathDoesNotExist
18:39:02 [2020-02-28T18:39:02.952Z] --- PASS: TestCopyFromContainerPathDoesNotExist (0.16s)
18:39:02 [2020-02-28T18:39:02.952Z] === RUN   TestCopyFromContainerPathIsNotDir
18:39:02 [2020-02-28T18:39:02.952Z] --- PASS: TestCopyFromContainerPathIsNotDir (0.13s)
18:39:02 [2020-02-28T18:39:02.952Z] === RUN   TestCopyToContainerPathDoesNotExist
18:39:03 [2020-02-28T18:39:03.374Z] --- PASS: TestCopyToContainerPathDoesNotExist (0.13s)
18:39:03 [2020-02-28T18:39:03.374Z] === RUN   TestCopyToContainerPathIsNotDir
18:39:03 [2020-02-28T18:39:03.374Z] --- PASS: TestCopyToContainerPathIsNotDir (0.13s)
18:39:03 [2020-02-28T18:39:03.374Z] === RUN   TestCopyFromContainer
18:39:05 [2020-02-28T18:39:05.176Z] === RUN   TestCopyFromContainer//
18:39:05 [2020-02-28T18:39:05.176Z] === RUN   TestCopyFromContainer//bar/root
18:39:05 [2020-02-28T18:39:05.542Z] === RUN   TestCopyFromContainer//bar/root/
18:39:05 [2020-02-28T18:39:05.542Z] === RUN   TestCopyFromContainer/bar/quux
18:39:05 [2020-02-28T18:39:05.542Z] === RUN   TestCopyFromContainer/bar/quux/
18:39:05 [2020-02-28T18:39:05.542Z] === RUN   TestCopyFromContainer/bar/quux/baz
18:39:05 [2020-02-28T18:39:05.898Z] === RUN   TestCopyFromContainer/bar/filesymlink
18:39:05 [2020-02-28T18:39:05.898Z] === RUN   TestCopyFromContainer/bar/dirsymlink
18:39:05 [2020-02-28T18:39:05.898Z] === RUN   TestCopyFromContainer/bar/dirsymlink/
18:39:05 [2020-02-28T18:39:05.898Z] === RUN   TestCopyFromContainer/bar/notarget
18:39:06 [2020-02-28T18:39:06.261Z] --- PASS: TestCopyFromContainer (2.87s)
18:39:06 [2020-02-28T18:39:06.261Z]     --- PASS: TestCopyFromContainer// (0.07s)
18:39:06 [2020-02-28T18:39:06.261Z]     --- PASS: TestCopyFromContainer//bar/root (0.13s)
18:39:06 [2020-02-28T18:39:06.261Z]     --- PASS: TestCopyFromContainer//bar/root/ (0.06s)
18:39:06 [2020-02-28T18:39:06.261Z]     --- PASS: TestCopyFromContainer/bar/quux (0.10s)
18:39:06 [2020-02-28T18:39:06.261Z]     --- PASS: TestCopyFromContainer/bar/quux/ (0.06s)
18:39:06 [2020-02-28T18:39:06.261Z]     --- PASS: TestCopyFromContainer/bar/quux/baz (0.09s)
18:39:06 [2020-02-28T18:39:06.261Z]     --- PASS: TestCopyFromContainer/bar/filesymlink (0.07s)
18:39:06 [2020-02-28T18:39:06.261Z]     --- PASS: TestCopyFromContainer/bar/dirsymlink (0.07s)
18:39:06 [2020-02-28T18:39:06.261Z]     --- PASS: TestCopyFromContainer/bar/dirsymlink/ (0.07s)
18:39:06 [2020-02-28T18:39:06.261Z]     --- PASS: TestCopyFromContainer/bar/notarget (0.08s)
18:39:06 [2020-02-28T18:39:06.261Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist
18:39:06 [2020-02-28T18:39:06.261Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
18:39:06 [2020-02-28T18:39:06.261Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
18:39:06 [2020-02-28T18:39:06.261Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
18:39:06 [2020-02-28T18:39:06.261Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
18:39:06 [2020-02-28T18:39:06.261Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/digest
18:39:06 [2020-02-28T18:39:06.261Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/digest
18:39:06 [2020-02-28T18:39:06.261Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
18:39:06 [2020-02-28T18:39:06.261Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/digest
18:39:06 [2020-02-28T18:39:06.261Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
18:39:06 [2020-02-28T18:39:06.261Z] --- PASS: TestCreateFailsWhenIdentifierDoesNotExist (0.01s)
18:39:06 [2020-02-28T18:39:06.261Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/digest (0.00s)
18:39:06 [2020-02-28T18:39:06.261Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag (0.00s)
18:39:06 [2020-02-28T18:39:06.261Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag (0.00s)
18:39:06 [2020-02-28T18:39:06.261Z] === RUN   TestCreateLinkToNonExistingContainer
18:39:06 [2020-02-28T18:39:06.261Z] --- PASS: TestCreateLinkToNonExistingContainer (0.08s)
18:39:06 [2020-02-28T18:39:06.261Z] === RUN   TestCreateWithInvalidEnv
18:39:06 [2020-02-28T18:39:06.261Z] === RUN   TestCreateWithInvalidEnv/0
18:39:06 [2020-02-28T18:39:06.261Z] === PAUSE TestCreateWithInvalidEnv/0
18:39:06 [2020-02-28T18:39:06.261Z] === RUN   TestCreateWithInvalidEnv/1
18:39:06 [2020-02-28T18:39:06.261Z] === PAUSE TestCreateWithInvalidEnv/1
18:39:06 [2020-02-28T18:39:06.261Z] === RUN   TestCreateWithInvalidEnv/2
18:39:06 [2020-02-28T18:39:06.261Z] === PAUSE TestCreateWithInvalidEnv/2
18:39:06 [2020-02-28T18:39:06.261Z] === CONT  TestCreateWithInvalidEnv/0
18:39:06 [2020-02-28T18:39:06.261Z] === CONT  TestCreateWithInvalidEnv/2
18:39:06 [2020-02-28T18:39:06.261Z] === CONT  TestCreateWithInvalidEnv/1
18:39:06 [2020-02-28T18:39:06.261Z] --- PASS: TestCreateWithInvalidEnv (0.01s)
18:39:06 [2020-02-28T18:39:06.261Z]     --- PASS: TestCreateWithInvalidEnv/2 (0.00s)
18:39:06 [2020-02-28T18:39:06.261Z]     --- PASS: TestCreateWithInvalidEnv/1 (0.00s)
18:39:06 [2020-02-28T18:39:06.261Z]     --- PASS: TestCreateWithInvalidEnv/0 (0.01s)
18:39:06 [2020-02-28T18:39:06.261Z] === RUN   TestCreateTmpfsMountsTarget
18:39:06 [2020-02-28T18:39:06.261Z] --- PASS: TestCreateTmpfsMountsTarget (0.01s)
18:39:06 [2020-02-28T18:39:06.261Z] === RUN   TestCreateWithCustomMaskedPaths
18:39:09 [2020-02-28T18:39:09.343Z] --- PASS: TestCreateWithCustomMaskedPaths (2.72s)
18:39:09 [2020-02-28T18:39:09.344Z] === RUN   TestCreateWithCapabilities
18:39:09 [2020-02-28T18:39:09.344Z] === RUN   TestCreateWithCapabilities/no_capabilities
18:39:09 [2020-02-28T18:39:09.344Z] === PAUSE TestCreateWithCapabilities/no_capabilities
18:39:09 [2020-02-28T18:39:09.344Z] === RUN   TestCreateWithCapabilities/empty_capabilities
18:39:09 [2020-02-28T18:39:09.344Z] === PAUSE TestCreateWithCapabilities/empty_capabilities
18:39:09 [2020-02-28T18:39:09.344Z] === RUN   TestCreateWithCapabilities/valid_capabilities
18:39:09 [2020-02-28T18:39:09.344Z] === PAUSE TestCreateWithCapabilities/valid_capabilities
18:39:09 [2020-02-28T18:39:09.344Z] === RUN   TestCreateWithCapabilities/invalid_capabilities
18:39:09 [2020-02-28T18:39:09.344Z] === PAUSE TestCreateWithCapabilities/invalid_capabilities
18:39:09 [2020-02-28T18:39:09.344Z] === RUN   TestCreateWithCapabilities/duplicate_capabilities
18:39:09 [2020-02-28T18:39:09.344Z] === PAUSE TestCreateWithCapabilities/duplicate_capabilities
18:39:09 [2020-02-28T18:39:09.344Z] === RUN   TestCreateWithCapabilities/capabilities_API_v1.39
18:39:09 [2020-02-28T18:39:09.344Z] === PAUSE TestCreateWithCapabilities/capabilities_API_v1.39
18:39:09 [2020-02-28T18:39:09.344Z] === RUN   TestCreateWithCapabilities/empty_capadd
18:39:09 [2020-02-28T18:39:09.344Z] === PAUSE TestCreateWithCapabilities/empty_capadd
18:39:09 [2020-02-28T18:39:09.344Z] === RUN   TestCreateWithCapabilities/empty_capdrop
18:39:09 [2020-02-28T18:39:09.344Z] === PAUSE TestCreateWithCapabilities/empty_capdrop
18:39:09 [2020-02-28T18:39:09.344Z] === RUN   TestCreateWithCapabilities/capadd_capdrop
18:39:09 [2020-02-28T18:39:09.344Z] === PAUSE TestCreateWithCapabilities/capadd_capdrop
18:39:09 [2020-02-28T18:39:09.344Z] === RUN   TestCreateWithCapabilities/conflict_with_capadd
18:39:09 [2020-02-28T18:39:09.344Z] === PAUSE TestCreateWithCapabilities/conflict_with_capadd
18:39:09 [2020-02-28T18:39:09.344Z] === RUN   TestCreateWithCapabilities/conflict_with_capdrop
18:39:09 [2020-02-28T18:39:09.344Z] === PAUSE TestCreateWithCapabilities/conflict_with_capdrop
18:39:09 [2020-02-28T18:39:09.344Z] === CONT  TestCreateWithCapabilities/no_capabilities
18:39:09 [2020-02-28T18:39:09.344Z] === CONT  TestCreateWithCapabilities/empty_capadd
18:39:09 [2020-02-28T18:39:09.344Z] === CONT  TestCreateWithCapabilities/conflict_with_capdrop
18:39:09 [2020-02-28T18:39:09.344Z] === CONT  TestCreateWithCapabilities/conflict_with_capadd
18:39:09 [2020-02-28T18:39:09.344Z] === CONT  TestCreateWithCapabilities/capadd_capdrop
18:39:09 [2020-02-28T18:39:09.344Z] === CONT  TestCreateWithCapabilities/empty_capdrop
18:39:09 [2020-02-28T18:39:09.344Z] === CONT  TestCreateWithCapabilities/invalid_capabilities
18:39:09 [2020-02-28T18:39:09.344Z] === CONT  TestCreateWithCapabilities/capabilities_API_v1.39
18:39:09 [2020-02-28T18:39:09.344Z] === CONT  TestCreateWithCapabilities/duplicate_capabilities
18:39:09 [2020-02-28T18:39:09.344Z] === CONT  TestCreateWithCapabilities/valid_capabilities
18:39:09 [2020-02-28T18:39:09.344Z] === CONT  TestCreateWithCapabilities/empty_capabilities
18:39:09 [2020-02-28T18:39:09.344Z] --- PASS: TestCreateWithCapabilities (0.01s)
18:39:09 [2020-02-28T18:39:09.344Z]     --- PASS: TestCreateWithCapabilities/empty_capadd (0.07s)
18:39:09 [2020-02-28T18:39:09.344Z]     --- PASS: TestCreateWithCapabilities/no_capabilities (0.07s)
18:39:09 [2020-02-28T18:39:09.344Z]     --- PASS: TestCreateWithCapabilities/conflict_with_capdrop (0.00s)
18:39:09 [2020-02-28T18:39:09.344Z]     --- PASS: TestCreateWithCapabilities/conflict_with_capadd (0.00s)
18:39:09 [2020-02-28T18:39:09.344Z]     --- PASS: TestCreateWithCapabilities/empty_capdrop (0.07s)
18:39:09 [2020-02-28T18:39:09.344Z]     --- PASS: TestCreateWithCapabilities/capadd_capdrop (0.07s)
18:39:09 [2020-02-28T18:39:09.344Z]     --- PASS: TestCreateWithCapabilities/invalid_capabilities (0.00s)
18:39:09 [2020-02-28T18:39:09.344Z]     --- PASS: TestCreateWithCapabilities/capabilities_API_v1.39 (0.06s)
18:39:09 [2020-02-28T18:39:09.344Z]     --- PASS: TestCreateWithCapabilities/duplicate_capabilities (0.08s)
18:39:09 [2020-02-28T18:39:09.344Z]     --- PASS: TestCreateWithCapabilities/valid_capabilities (0.17s)
18:39:09 [2020-02-28T18:39:09.344Z]     --- PASS: TestCreateWithCapabilities/empty_capabilities (0.16s)
18:39:09 [2020-02-28T18:39:09.344Z] === RUN   TestCreateWithCustomReadonlyPaths
18:39:12 [2020-02-28T18:39:12.472Z] --- PASS: TestCreateWithCustomReadonlyPaths (2.91s)
18:39:12 [2020-02-28T18:39:12.472Z] === RUN   TestCreateWithInvalidHealthcheckParams
18:39:12 [2020-02-28T18:39:12.472Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
18:39:12 [2020-02-28T18:39:12.472Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
18:39:12 [2020-02-28T18:39:12.472Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
18:39:12 [2020-02-28T18:39:12.472Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
18:39:12 [2020-02-28T18:39:12.472Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
18:39:12 [2020-02-28T18:39:12.472Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
18:39:12 [2020-02-28T18:39:12.472Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
18:39:12 [2020-02-28T18:39:12.472Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
18:39:12 [2020-02-28T18:39:12.473Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
18:39:12 [2020-02-28T18:39:12.473Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
18:39:12 [2020-02-28T18:39:12.473Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
18:39:12 [2020-02-28T18:39:12.473Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
18:39:12 [2020-02-28T18:39:12.473Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
18:39:12 [2020-02-28T18:39:12.473Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
18:39:12 [2020-02-28T18:39:12.473Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
18:39:12 [2020-02-28T18:39:12.473Z] --- PASS: TestCreateWithInvalidHealthcheckParams (0.01s)
18:39:12 [2020-02-28T18:39:12.473Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s (0.01s)
18:39:12 [2020-02-28T18:39:12.473Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0 (0.01s)
18:39:12 [2020-02-28T18:39:12.473Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms (0.01s)
18:39:12 [2020-02-28T18:39:12.473Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms (0.01s)
18:39:12 [2020-02-28T18:39:12.473Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms (0.00s)
18:39:12 [2020-02-28T18:39:12.473Z] === RUN   TestCreateTmpfsOverrideAnonymousVolume
18:39:13 [2020-02-28T18:39:13.222Z] --- PASS: TestCreateTmpfsOverrideAnonymousVolume (0.80s)
18:39:13 [2020-02-28T18:39:13.222Z] === RUN   TestContainerStartOnDaemonRestart
18:39:13 [2020-02-28T18:39:13.222Z] === PAUSE TestContainerStartOnDaemonRestart
18:39:13 [2020-02-28T18:39:13.222Z] === RUN   TestDaemonRestartIpcMode
18:39:13 [2020-02-28T18:39:13.222Z] === PAUSE TestDaemonRestartIpcMode
18:39:13 [2020-02-28T18:39:13.222Z] === RUN   TestDaemonHostGatewayIP
18:39:13 [2020-02-28T18:39:13.222Z] === PAUSE TestDaemonHostGatewayIP
18:39:13 [2020-02-28T18:39:13.222Z] === RUN   TestDiff
18:39:13 [2020-02-28T18:39:13.993Z] --- PASS: TestDiff (0.90s)
18:39:13 [2020-02-28T18:39:13.993Z] === RUN   TestExecWithCloseStdin
18:39:15 [2020-02-28T18:39:15.206Z] --- PASS: TestExecWithCloseStdin (1.14s)
18:39:15 [2020-02-28T18:39:15.206Z] === RUN   TestExec
18:39:16 [2020-02-28T18:39:16.429Z] --- PASS: TestExec (1.13s)
18:39:16 [2020-02-28T18:39:16.429Z] === RUN   TestExecUser
18:39:17 [2020-02-28T18:39:17.652Z] --- PASS: TestExecUser (1.12s)
18:39:17 [2020-02-28T18:39:17.652Z] === RUN   TestExportContainerAndImportImage
18:39:18 [2020-02-28T18:39:18.868Z] --- PASS: TestExportContainerAndImportImage (1.37s)
18:39:18 [2020-02-28T18:39:18.868Z] === RUN   TestExportContainerAfterDaemonRestart
18:39:20 [2020-02-28T18:39:20.779Z] --- PASS: TestExportContainerAfterDaemonRestart (1.74s)
18:39:20 [2020-02-28T18:39:20.779Z] === RUN   TestHealthCheckWorkdir
18:39:22 [2020-02-28T18:39:22.005Z] --- PASS: TestHealthCheckWorkdir (1.21s)
18:39:22 [2020-02-28T18:39:22.005Z] === RUN   TestHealthKillContainer
18:39:25 [2020-02-28T18:39:25.075Z] --- PASS: TestHealthKillContainer (3.09s)
18:39:25 [2020-02-28T18:39:25.075Z] === RUN   TestInspectCpusetInConfigPre120
18:39:25 [2020-02-28T18:39:25.821Z] --- PASS: TestInspectCpusetInConfigPre120 (0.89s)
18:39:25 [2020-02-28T18:39:25.821Z] === RUN   TestIpcModeNone
18:39:27 [2020-02-28T18:39:27.033Z] --- PASS: TestIpcModeNone (1.04s)
18:39:27 [2020-02-28T18:39:27.033Z] === RUN   TestIpcModePrivate
18:39:27 [2020-02-28T18:39:27.789Z] --- PASS: TestIpcModePrivate (0.99s)
18:39:27 [2020-02-28T18:39:27.789Z]     ipcmode_linux_test.go:90: [testIpcPrivateShareable] ipcmode: private, ipcdev: 0:64, shared: false, mustBeShared: false
18:39:27 [2020-02-28T18:39:27.789Z] === RUN   TestIpcModeShareable
18:39:28 [2020-02-28T18:39:28.556Z] --- PASS: TestIpcModeShareable (0.95s)
18:39:28 [2020-02-28T18:39:28.556Z]     ipcmode_linux_test.go:90: [testIpcPrivateShareable] ipcmode: shareable, ipcdev: 0:58, shared: true, mustBeShared: true
18:39:28 [2020-02-28T18:39:28.556Z] === RUN   TestAPIIpcModeShareableAndContainer
18:39:31 [2020-02-28T18:39:31.832Z] --- PASS: TestAPIIpcModeShareableAndContainer (2.94s)
18:39:31 [2020-02-28T18:39:31.832Z] === RUN   TestAPIIpcModeHost
18:39:32 [2020-02-28T18:39:32.581Z] --- PASS: TestAPIIpcModeHost (0.82s)
18:39:32 [2020-02-28T18:39:32.581Z] === RUN   TestDaemonIpcModeShareable
18:39:34 [2020-02-28T18:39:34.338Z] --- PASS: TestDaemonIpcModeShareable (1.75s)
18:39:34 [2020-02-28T18:39:34.338Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:66, shared: true, mustBeShared: true
18:39:34 [2020-02-28T18:39:34.338Z] === RUN   TestDaemonIpcModePrivate
18:39:36 [2020-02-28T18:39:36.092Z] --- PASS: TestDaemonIpcModePrivate (1.76s)
18:39:36 [2020-02-28T18:39:36.092Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:72, shared: false, mustBeShared: false
18:39:36 [2020-02-28T18:39:36.093Z] === RUN   TestDaemonIpcModePrivateFromConfig
18:39:37 [2020-02-28T18:39:37.845Z] --- PASS: TestDaemonIpcModePrivateFromConfig (1.67s)
18:39:37 [2020-02-28T18:39:37.845Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:72, shared: false, mustBeShared: false
18:39:37 [2020-02-28T18:39:37.845Z] === RUN   TestDaemonIpcModeShareableFromConfig
18:39:39 [2020-02-28T18:39:39.594Z] --- PASS: TestDaemonIpcModeShareableFromConfig (1.77s)
18:39:39 [2020-02-28T18:39:39.594Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:66, shared: true, mustBeShared: true
18:39:39 [2020-02-28T18:39:39.594Z] === RUN   TestIpcModeOlderClient
18:39:39 [2020-02-28T18:39:39.594Z] === PAUSE TestIpcModeOlderClient
18:39:39 [2020-02-28T18:39:39.594Z] === RUN   TestKillContainerInvalidSignal
18:39:40 [2020-02-28T18:39:40.340Z] --- PASS: TestKillContainerInvalidSignal (0.87s)
18:39:40 [2020-02-28T18:39:40.340Z] === RUN   TestKillContainer
18:39:40 [2020-02-28T18:39:40.340Z] === RUN   TestKillContainer/no_signal
18:39:41 [2020-02-28T18:39:41.088Z] === RUN   TestKillContainer/non_killing_signal
18:39:41 [2020-02-28T18:39:41.834Z] === RUN   TestKillContainer/killing_signal
18:39:43 [2020-02-28T18:39:43.042Z] --- PASS: TestKillContainer (2.57s)
18:39:43 [2020-02-28T18:39:43.042Z]     --- PASS: TestKillContainer/no_signal (0.85s)
18:39:43 [2020-02-28T18:39:43.042Z]     --- PASS: TestKillContainer/non_killing_signal (0.55s)
18:39:43 [2020-02-28T18:39:43.042Z]     --- PASS: TestKillContainer/killing_signal (0.81s)
18:39:43 [2020-02-28T18:39:43.042Z] === RUN   TestKillWithStopSignalAndRestartPolicies
18:39:43 [2020-02-28T18:39:43.042Z] === RUN   TestKillWithStopSignalAndRestartPolicies/same-signal-disables-restart-policy
18:39:43 [2020-02-28T18:39:43.788Z] === RUN   TestKillWithStopSignalAndRestartPolicies/different-signal-keep-restart-policy
18:39:44 [2020-02-28T18:39:44.831Z] --- PASS: TestKillWithStopSignalAndRestartPolicies (1.67s)
18:39:44 [2020-02-28T18:39:44.831Z]     --- PASS: TestKillWithStopSignalAndRestartPolicies/same-signal-disables-restart-policy (0.76s)
18:39:44 [2020-02-28T18:39:44.831Z]     --- PASS: TestKillWithStopSignalAndRestartPolicies/different-signal-keep-restart-policy (0.61s)
18:39:44 [2020-02-28T18:39:44.831Z] === RUN   TestKillStoppedContainer
18:39:44 [2020-02-28T18:39:44.831Z] --- PASS: TestKillStoppedContainer (0.10s)
18:39:44 [2020-02-28T18:39:44.831Z] === RUN   TestKillStoppedContainerAPIPre120
18:39:44 [2020-02-28T18:39:44.831Z] --- PASS: TestKillStoppedContainerAPIPre120 (0.10s)
18:39:44 [2020-02-28T18:39:44.831Z] === RUN   TestKillDifferentUserContainer
18:39:45 [2020-02-28T18:39:45.648Z] --- PASS: TestKillDifferentUserContainer (0.84s)
18:39:45 [2020-02-28T18:39:45.648Z] === RUN   TestInspectOomKilledTrue
18:39:45 [2020-02-28T18:39:45.648Z] --- SKIP: TestInspectOomKilledTrue (0.01s)
18:39:45 [2020-02-28T18:39:45.648Z]     kill_test.go:151: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
18:39:45 [2020-02-28T18:39:45.648Z] === RUN   TestInspectOomKilledFalse
18:39:45 [2020-02-28T18:39:45.648Z] --- SKIP: TestInspectOomKilledFalse (0.00s)
18:39:45 [2020-02-28T18:39:45.648Z]     kill_test.go:169: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
18:39:45 [2020-02-28T18:39:45.648Z] === RUN   TestLinksEtcHostsContentMatch
18:39:46 [2020-02-28T18:39:46.033Z] --- PASS: TestLinksEtcHostsContentMatch (0.61s)
18:39:46 [2020-02-28T18:39:46.033Z] === RUN   TestLinksContainerNames
18:39:47 [2020-02-28T18:39:47.779Z] --- PASS: TestLinksContainerNames (1.47s)
18:39:47 [2020-02-28T18:39:47.780Z] === RUN   TestLogsFollowTailEmpty
18:39:48 [2020-02-28T18:39:48.528Z] --- PASS: TestLogsFollowTailEmpty (0.89s)
18:39:48 [2020-02-28T18:39:48.528Z] === RUN   TestContainerNetworkMountsNoChown
18:39:49 [2020-02-28T18:39:49.278Z] --- PASS: TestContainerNetworkMountsNoChown (0.82s)
18:39:49 [2020-02-28T18:39:49.278Z] === RUN   TestMountDaemonRoot
18:39:49 [2020-02-28T18:39:49.278Z] === RUN   TestMountDaemonRoot/default
18:39:49 [2020-02-28T18:39:49.278Z] === PAUSE TestMountDaemonRoot/default
18:39:49 [2020-02-28T18:39:49.278Z] === RUN   TestMountDaemonRoot/private
18:39:49 [2020-02-28T18:39:49.278Z] === PAUSE TestMountDaemonRoot/private
18:39:49 [2020-02-28T18:39:49.278Z] === RUN   TestMountDaemonRoot/rprivate
18:39:49 [2020-02-28T18:39:49.278Z] === PAUSE TestMountDaemonRoot/rprivate
18:39:49 [2020-02-28T18:39:49.278Z] === RUN   TestMountDaemonRoot/slave
18:39:49 [2020-02-28T18:39:49.278Z] === PAUSE TestMountDaemonRoot/slave
18:39:49 [2020-02-28T18:39:49.278Z] === RUN   TestMountDaemonRoot/rslave
18:39:49 [2020-02-28T18:39:49.278Z] === PAUSE TestMountDaemonRoot/rslave
18:39:49 [2020-02-28T18:39:49.278Z] === RUN   TestMountDaemonRoot/shared
18:39:49 [2020-02-28T18:39:49.278Z] === PAUSE TestMountDaemonRoot/shared
18:39:49 [2020-02-28T18:39:49.278Z] === RUN   TestMountDaemonRoot/rshared
18:39:49 [2020-02-28T18:39:49.278Z] === PAUSE TestMountDaemonRoot/rshared
18:39:49 [2020-02-28T18:39:49.278Z] === CONT  TestMountDaemonRoot/default
18:39:49 [2020-02-28T18:39:49.278Z] === RUN   TestMountDaemonRoot/default/bind_root
18:39:49 [2020-02-28T18:39:49.278Z] === PAUSE TestMountDaemonRoot/default/bind_root
18:39:49 [2020-02-28T18:39:49.278Z] === RUN   TestMountDaemonRoot/default/bind_subpath
18:39:49 [2020-02-28T18:39:49.278Z] === PAUSE TestMountDaemonRoot/default/bind_subpath
18:39:49 [2020-02-28T18:39:49.278Z] === RUN   TestMountDaemonRoot/default/mount_root
18:39:49 [2020-02-28T18:39:49.278Z] === PAUSE TestMountDaemonRoot/default/mount_root
18:39:49 [2020-02-28T18:39:49.278Z] === RUN   TestMountDaemonRoot/default/mount_subpath
18:39:49 [2020-02-28T18:39:49.278Z] === PAUSE TestMountDaemonRoot/default/mount_subpath
18:39:49 [2020-02-28T18:39:49.278Z] === CONT  TestMountDaemonRoot/default/bind_root
18:39:49 [2020-02-28T18:39:49.278Z] === CONT  TestMountDaemonRoot/rshared
18:39:49 [2020-02-28T18:39:49.278Z] === RUN   TestMountDaemonRoot/rshared/bind_subpath
18:39:49 [2020-02-28T18:39:49.278Z] === PAUSE TestMountDaemonRoot/rshared/bind_subpath
18:39:49 [2020-02-28T18:39:49.278Z] === RUN   TestMountDaemonRoot/rshared/mount_root
18:39:49 [2020-02-28T18:39:49.278Z] === PAUSE TestMountDaemonRoot/rshared/mount_root
18:39:49 [2020-02-28T18:39:49.278Z] === RUN   TestMountDaemonRoot/rshared/mount_subpath
18:39:49 [2020-02-28T18:39:49.278Z] === PAUSE TestMountDaemonRoot/rshared/mount_subpath
18:39:49 [2020-02-28T18:39:49.278Z] === RUN   TestMountDaemonRoot/rshared/bind_root
18:39:49 [2020-02-28T18:39:49.278Z] === PAUSE TestMountDaemonRoot/rshared/bind_root
18:39:49 [2020-02-28T18:39:49.278Z] === CONT  TestMountDaemonRoot/rshared/bind_subpath
18:39:49 [2020-02-28T18:39:49.643Z] === CONT  TestMountDaemonRoot/shared
18:39:49 [2020-02-28T18:39:49.643Z] === RUN   TestMountDaemonRoot/shared/bind_root
18:39:49 [2020-02-28T18:39:49.643Z] === PAUSE TestMountDaemonRoot/shared/bind_root
18:39:49 [2020-02-28T18:39:49.643Z] === RUN   TestMountDaemonRoot/shared/bind_subpath
18:39:49 [2020-02-28T18:39:49.643Z] === PAUSE TestMountDaemonRoot/shared/bind_subpath
18:39:49 [2020-02-28T18:39:49.643Z] === RUN   TestMountDaemonRoot/shared/mount_root
18:39:49 [2020-02-28T18:39:49.643Z] === PAUSE TestMountDaemonRoot/shared/mount_root
18:39:49 [2020-02-28T18:39:49.643Z] === RUN   TestMountDaemonRoot/shared/mount_subpath
18:39:49 [2020-02-28T18:39:49.643Z] === PAUSE TestMountDaemonRoot/shared/mount_subpath
18:39:49 [2020-02-28T18:39:49.643Z] === CONT  TestMountDaemonRoot/rslave
18:39:49 [2020-02-28T18:39:49.643Z] === RUN   TestMountDaemonRoot/rslave/mount_root
18:39:49 [2020-02-28T18:39:49.643Z] === PAUSE TestMountDaemonRoot/rslave/mount_root
18:39:49 [2020-02-28T18:39:49.643Z] === RUN   TestMountDaemonRoot/rslave/mount_subpath
18:39:49 [2020-02-28T18:39:49.643Z] === PAUSE TestMountDaemonRoot/rslave/mount_subpath
18:39:49 [2020-02-28T18:39:49.643Z] === RUN   TestMountDaemonRoot/rslave/bind_root
18:39:49 [2020-02-28T18:39:49.643Z] === PAUSE TestMountDaemonRoot/rslave/bind_root
18:39:49 [2020-02-28T18:39:49.643Z] === RUN   TestMountDaemonRoot/rslave/bind_subpath
18:39:49 [2020-02-28T18:39:49.643Z] === PAUSE TestMountDaemonRoot/rslave/bind_subpath
18:39:49 [2020-02-28T18:39:49.643Z] === CONT  TestMountDaemonRoot/slave
18:39:49 [2020-02-28T18:39:49.643Z] === RUN   TestMountDaemonRoot/slave/bind_root
18:39:49 [2020-02-28T18:39:49.643Z] === PAUSE TestMountDaemonRoot/slave/bind_root
18:39:49 [2020-02-28T18:39:49.643Z] === RUN   TestMountDaemonRoot/slave/bind_subpath
18:39:49 [2020-02-28T18:39:49.643Z] === PAUSE TestMountDaemonRoot/slave/bind_subpath
18:39:49 [2020-02-28T18:39:49.643Z] === RUN   TestMountDaemonRoot/slave/mount_root
18:39:49 [2020-02-28T18:39:49.643Z] === PAUSE TestMountDaemonRoot/slave/mount_root
18:39:49 [2020-02-28T18:39:49.643Z] === RUN   TestMountDaemonRoot/slave/mount_subpath
18:39:49 [2020-02-28T18:39:49.643Z] === PAUSE TestMountDaemonRoot/slave/mount_subpath
18:39:49 [2020-02-28T18:39:49.643Z] === CONT  TestMountDaemonRoot/rprivate
18:39:49 [2020-02-28T18:39:49.643Z] === RUN   TestMountDaemonRoot/rprivate/bind_root
18:39:49 [2020-02-28T18:39:49.643Z] === PAUSE TestMountDaemonRoot/rprivate/bind_root
18:39:49 [2020-02-28T18:39:49.643Z] === RUN   TestMountDaemonRoot/rprivate/bind_subpath
18:39:49 [2020-02-28T18:39:49.643Z] === PAUSE TestMountDaemonRoot/rprivate/bind_subpath
18:39:49 [2020-02-28T18:39:49.643Z] === RUN   TestMountDaemonRoot/rprivate/mount_root
18:39:49 [2020-02-28T18:39:49.643Z] === PAUSE TestMountDaemonRoot/rprivate/mount_root
18:39:49 [2020-02-28T18:39:49.643Z] === RUN   TestMountDaemonRoot/rprivate/mount_subpath
18:39:49 [2020-02-28T18:39:49.643Z] === PAUSE TestMountDaemonRoot/rprivate/mount_subpath
18:39:49 [2020-02-28T18:39:49.643Z] === CONT  TestMountDaemonRoot/private
18:39:49 [2020-02-28T18:39:49.643Z] === RUN   TestMountDaemonRoot/private/bind_root
18:39:49 [2020-02-28T18:39:49.643Z] === PAUSE TestMountDaemonRoot/private/bind_root
18:39:49 [2020-02-28T18:39:49.643Z] === RUN   TestMountDaemonRoot/private/bind_subpath
18:39:49 [2020-02-28T18:39:49.643Z] === PAUSE TestMountDaemonRoot/private/bind_subpath
18:39:49 [2020-02-28T18:39:49.643Z] === RUN   TestMountDaemonRoot/private/mount_root
18:39:49 [2020-02-28T18:39:49.643Z] === PAUSE TestMountDaemonRoot/private/mount_root
18:39:49 [2020-02-28T18:39:49.643Z] === RUN   TestMountDaemonRoot/private/mount_subpath
18:39:49 [2020-02-28T18:39:49.643Z] === PAUSE TestMountDaemonRoot/private/mount_subpath
18:39:49 [2020-02-28T18:39:49.643Z] === CONT  TestMountDaemonRoot/default/mount_subpath
18:39:49 [2020-02-28T18:39:49.643Z] === CONT  TestMountDaemonRoot/default/mount_root
18:39:49 [2020-02-28T18:39:49.643Z] === CONT  TestMountDaemonRoot/default/bind_subpath
18:39:49 [2020-02-28T18:39:49.643Z] === CONT  TestMountDaemonRoot/rshared/bind_root
18:39:49 [2020-02-28T18:39:49.643Z] === CONT  TestMountDaemonRoot/rshared/mount_subpath
18:39:49 [2020-02-28T18:39:49.643Z] === CONT  TestMountDaemonRoot/rshared/mount_root
18:39:49 [2020-02-28T18:39:49.643Z] === CONT  TestMountDaemonRoot/shared/bind_root
18:39:49 [2020-02-28T18:39:49.643Z] === CONT  TestMountDaemonRoot/rslave/mount_root
18:39:49 [2020-02-28T18:39:49.643Z] === CONT  TestMountDaemonRoot/shared/mount_subpath
18:39:49 [2020-02-28T18:39:49.643Z] === CONT  TestMountDaemonRoot/shared/mount_root
18:39:49 [2020-02-28T18:39:49.997Z] === CONT  TestMountDaemonRoot/shared/bind_subpath
18:39:49 [2020-02-28T18:39:49.997Z] === CONT  TestMountDaemonRoot/slave/bind_root
18:39:49 [2020-02-28T18:39:49.997Z] === CONT  TestMountDaemonRoot/rslave/bind_subpath
18:39:49 [2020-02-28T18:39:49.997Z] === CONT  TestMountDaemonRoot/rslave/bind_root
18:39:49 [2020-02-28T18:39:49.997Z] === CONT  TestMountDaemonRoot/rslave/mount_subpath
18:39:49 [2020-02-28T18:39:49.997Z] === CONT  TestMountDaemonRoot/rprivate/bind_root
18:39:49 [2020-02-28T18:39:49.997Z] === CONT  TestMountDaemonRoot/slave/mount_subpath
18:39:49 [2020-02-28T18:39:49.997Z] === CONT  TestMountDaemonRoot/slave/mount_root
18:39:49 [2020-02-28T18:39:49.997Z] === CONT  TestMountDaemonRoot/slave/bind_subpath
18:39:49 [2020-02-28T18:39:49.997Z] === CONT  TestMountDaemonRoot/private/bind_root
18:39:49 [2020-02-28T18:39:49.997Z] === CONT  TestMountDaemonRoot/rprivate/mount_subpath
18:39:49 [2020-02-28T18:39:49.997Z] === CONT  TestMountDaemonRoot/rprivate/mount_root
18:39:49 [2020-02-28T18:39:49.997Z] === CONT  TestMountDaemonRoot/rprivate/bind_subpath
18:39:49 [2020-02-28T18:39:49.997Z] === CONT  TestMountDaemonRoot/private/mount_subpath
18:39:49 [2020-02-28T18:39:49.997Z] === CONT  TestMountDaemonRoot/private/mount_root
18:39:50 [2020-02-28T18:39:50.393Z] === CONT  TestMountDaemonRoot/private/bind_subpath
18:39:50 [2020-02-28T18:39:50.393Z] --- PASS: TestMountDaemonRoot (0.02s)
18:39:50 [2020-02-28T18:39:50.393Z]     --- PASS: TestMountDaemonRoot/default (0.00s)
18:39:50 [2020-02-28T18:39:50.393Z]         --- PASS: TestMountDaemonRoot/default/bind_root (0.09s)
18:39:50 [2020-02-28T18:39:50.393Z]         --- PASS: TestMountDaemonRoot/default/mount_root (0.07s)
18:39:50 [2020-02-28T18:39:50.393Z]         --- PASS: TestMountDaemonRoot/default/mount_subpath (0.10s)
18:39:50 [2020-02-28T18:39:50.393Z]         --- PASS: TestMountDaemonRoot/default/bind_subpath (0.09s)
18:39:50 [2020-02-28T18:39:50.393Z]     --- PASS: TestMountDaemonRoot/rshared (0.00s)
18:39:50 [2020-02-28T18:39:50.393Z]         --- PASS: TestMountDaemonRoot/rshared/bind_subpath (0.06s)
18:39:50 [2020-02-28T18:39:50.393Z]         --- PASS: TestMountDaemonRoot/rshared/bind_root (0.07s)
18:39:50 [2020-02-28T18:39:50.393Z]         --- PASS: TestMountDaemonRoot/rshared/mount_subpath (0.06s)
18:39:50 [2020-02-28T18:39:50.393Z]         --- PASS: TestMountDaemonRoot/rshared/mount_root (0.09s)
18:39:50 [2020-02-28T18:39:50.393Z]     --- PASS: TestMountDaemonRoot/shared (0.00s)
18:39:50 [2020-02-28T18:39:50.393Z]         --- PASS: TestMountDaemonRoot/shared/bind_root (0.04s)
18:39:50 [2020-02-28T18:39:50.393Z]         --- PASS: TestMountDaemonRoot/shared/mount_subpath (0.04s)
18:39:50 [2020-02-28T18:39:50.393Z]         --- PASS: TestMountDaemonRoot/shared/mount_root (0.03s)
18:39:50 [2020-02-28T18:39:50.393Z]         --- PASS: TestMountDaemonRoot/shared/bind_subpath (0.03s)
18:39:50 [2020-02-28T18:39:50.393Z]     --- PASS: TestMountDaemonRoot/rslave (0.00s)
18:39:50 [2020-02-28T18:39:50.393Z]         --- PASS: TestMountDaemonRoot/rslave/mount_root (0.07s)
18:39:50 [2020-02-28T18:39:50.393Z]         --- PASS: TestMountDaemonRoot/rslave/bind_subpath (0.08s)
18:39:50 [2020-02-28T18:39:50.393Z]         --- PASS: TestMountDaemonRoot/rslave/bind_root (0.11s)
18:39:50 [2020-02-28T18:39:50.393Z]         --- PASS: TestMountDaemonRoot/rslave/mount_subpath (0.09s)
18:39:50 [2020-02-28T18:39:50.393Z]     --- PASS: TestMountDaemonRoot/slave (0.00s)
18:39:50 [2020-02-28T18:39:50.393Z]         --- PASS: TestMountDaemonRoot/slave/bind_root (0.03s)
18:39:50 [2020-02-28T18:39:50.393Z]         --- PASS: TestMountDaemonRoot/slave/mount_root (0.04s)
18:39:50 [2020-02-28T18:39:50.393Z]         --- PASS: TestMountDaemonRoot/slave/mount_subpath (0.04s)
18:39:50 [2020-02-28T18:39:50.393Z]         --- PASS: TestMountDaemonRoot/slave/bind_subpath (0.04s)
18:39:50 [2020-02-28T18:39:50.393Z]     --- PASS: TestMountDaemonRoot/rprivate (0.00s)
18:39:50 [2020-02-28T18:39:50.393Z]         --- PASS: TestMountDaemonRoot/rprivate/bind_root (0.06s)
18:39:50 [2020-02-28T18:39:50.393Z]         --- PASS: TestMountDaemonRoot/rprivate/mount_subpath (0.02s)
18:39:50 [2020-02-28T18:39:50.393Z]         --- PASS: TestMountDaemonRoot/rprivate/mount_root (0.05s)
18:39:50 [2020-02-28T18:39:50.393Z]         --- PASS: TestMountDaemonRoot/rprivate/bind_subpath (0.05s)
18:39:50 [2020-02-28T18:39:50.393Z]     --- PASS: TestMountDaemonRoot/private (0.00s)
18:39:50 [2020-02-28T18:39:50.393Z]         --- PASS: TestMountDaemonRoot/private/bind_root (0.03s)
18:39:50 [2020-02-28T18:39:50.393Z]         --- PASS: TestMountDaemonRoot/private/mount_root (0.04s)
18:39:50 [2020-02-28T18:39:50.393Z]         --- PASS: TestMountDaemonRoot/private/mount_subpath (0.05s)
18:39:50 [2020-02-28T18:39:50.393Z]         --- PASS: TestMountDaemonRoot/private/bind_subpath (0.03s)
18:39:50 [2020-02-28T18:39:50.393Z] === RUN   TestContainerBindMountNonRecursive
18:39:52 [2020-02-28T18:39:52.199Z] --- PASS: TestContainerBindMountNonRecursive (1.76s)
18:39:52 [2020-02-28T18:39:52.199Z] === RUN   TestNetworkNat
18:39:52 [2020-02-28T18:39:52.963Z] --- PASS: TestNetworkNat (0.83s)
18:39:52 [2020-02-28T18:39:52.963Z] === RUN   TestNetworkLocalhostTCPNat
18:39:53 [2020-02-28T18:39:53.725Z] --- PASS: TestNetworkLocalhostTCPNat (0.92s)
18:39:53 [2020-02-28T18:39:53.725Z] === RUN   TestNetworkLoopbackNat
18:39:55 [2020-02-28T18:39:55.132Z] --- PASS: TestNetworkLoopbackNat (1.05s)
18:39:55 [2020-02-28T18:39:55.132Z] === RUN   TestPause
18:39:56 [2020-02-28T18:39:56.071Z] --- PASS: TestPause (1.01s)
18:39:56 [2020-02-28T18:39:56.071Z] === RUN   TestPauseFailsOnWindowsServerContainers
18:39:56 [2020-02-28T18:39:56.071Z] --- SKIP: TestPauseFailsOnWindowsServerContainers (0.00s)
18:39:56 [2020-02-28T18:39:56.071Z]     pause_test.go:54: testEnv.DaemonInfo.OSType != "windows" || testEnv.DaemonInfo.Isolation != "process"
18:39:56 [2020-02-28T18:39:56.071Z] === RUN   TestPauseStopPausedContainer
18:39:56 [2020-02-28T18:39:56.835Z] --- PASS: TestPauseStopPausedContainer (0.94s)
18:39:56 [2020-02-28T18:39:56.835Z] === RUN   TestPsFilter
18:39:56 [2020-02-28T18:39:56.835Z] --- PASS: TestPsFilter (0.25s)
18:39:56 [2020-02-28T18:39:56.835Z] === RUN   TestRemoveContainerWithRemovedVolume
18:39:57 [2020-02-28T18:39:57.583Z] --- PASS: TestRemoveContainerWithRemovedVolume (0.76s)
18:39:57 [2020-02-28T18:39:57.583Z] === RUN   TestRemoveContainerWithVolume
18:39:58 [2020-02-28T18:39:58.830Z] --- PASS: TestRemoveContainerWithVolume (0.83s)
18:39:58 [2020-02-28T18:39:58.830Z] === RUN   TestRemoveContainerRunning
18:39:59 [2020-02-28T18:39:59.579Z] --- PASS: TestRemoveContainerRunning (0.89s)
18:39:59 [2020-02-28T18:39:59.579Z] === RUN   TestRemoveContainerForceRemoveRunning
18:40:00 [2020-02-28T18:40:00.336Z] --- PASS: TestRemoveContainerForceRemoveRunning (0.91s)
18:40:00 [2020-02-28T18:40:00.336Z] === RUN   TestRemoveInvalidContainer
18:40:00 [2020-02-28T18:40:00.336Z] --- PASS: TestRemoveInvalidContainer (0.01s)
18:40:00 [2020-02-28T18:40:00.336Z] === RUN   TestRenameLinkedContainer
18:40:04 [2020-02-28T18:40:04.250Z] --- PASS: TestRenameLinkedContainer (3.29s)
18:40:04 [2020-02-28T18:40:04.250Z] === RUN   TestRenameStoppedContainer
18:40:04 [2020-02-28T18:40:04.620Z] --- PASS: TestRenameStoppedContainer (0.85s)
18:40:04 [2020-02-28T18:40:04.620Z] === RUN   TestRenameRunningContainerAndReuse
18:40:06 [2020-02-28T18:40:06.386Z] --- PASS: TestRenameRunningContainerAndReuse (1.70s)
18:40:06 [2020-02-28T18:40:06.386Z] === RUN   TestRenameInvalidName
18:40:07 [2020-02-28T18:40:07.151Z] --- PASS: TestRenameInvalidName (0.94s)
18:40:07 [2020-02-28T18:40:07.151Z] === RUN   TestRenameAnonymousContainer
18:40:10 [2020-02-28T18:40:10.309Z] --- PASS: TestRenameAnonymousContainer (2.81s)
18:40:10 [2020-02-28T18:40:10.309Z] === RUN   TestRenameContainerWithSameName
18:40:10 [2020-02-28T18:40:10.691Z] --- PASS: TestRenameContainerWithSameName (0.81s)
18:40:10 [2020-02-28T18:40:10.691Z] === RUN   TestRenameContainerWithLinkedContainer
18:40:12 [2020-02-28T18:40:12.432Z] --- PASS: TestRenameContainerWithLinkedContainer (1.62s)
18:40:12 [2020-02-28T18:40:12.432Z] === RUN   TestResize
18:40:13 [2020-02-28T18:40:13.197Z] --- PASS: TestResize (0.98s)
18:40:13 [2020-02-28T18:40:13.198Z] === RUN   TestResizeWithInvalidSize
18:40:14 [2020-02-28T18:40:14.424Z] --- PASS: TestResizeWithInvalidSize (0.97s)
18:40:14 [2020-02-28T18:40:14.424Z] === RUN   TestResizeWhenContainerNotStarted
18:40:15 [2020-02-28T18:40:15.217Z] --- PASS: TestResizeWhenContainerNotStarted (0.87s)
18:40:15 [2020-02-28T18:40:15.217Z] === RUN   TestDaemonRestartKillContainers
18:40:15 [2020-02-28T18:40:15.217Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
18:40:15 [2020-02-28T18:40:15.217Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
18:40:15 [2020-02-28T18:40:15.217Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
18:40:15 [2020-02-28T18:40:15.217Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
18:40:15 [2020-02-28T18:40:15.217Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
18:40:15 [2020-02-28T18:40:15.217Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
18:40:15 [2020-02-28T18:40:15.217Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
18:40:15 [2020-02-28T18:40:15.217Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
18:40:15 [2020-02-28T18:40:15.217Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
18:40:15 [2020-02-28T18:40:15.217Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
18:40:15 [2020-02-28T18:40:15.217Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
18:40:15 [2020-02-28T18:40:15.217Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
18:40:15 [2020-02-28T18:40:15.217Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
18:40:15 [2020-02-28T18:40:15.217Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
18:40:15 [2020-02-28T18:40:15.217Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
18:40:15 [2020-02-28T18:40:15.217Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
18:40:15 [2020-02-28T18:40:15.217Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
18:40:15 [2020-02-28T18:40:15.217Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
18:40:15 [2020-02-28T18:40:15.217Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
18:40:15 [2020-02-28T18:40:15.218Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
18:40:15 [2020-02-28T18:40:15.218Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
18:40:15 [2020-02-28T18:40:15.218Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
18:40:15 [2020-02-28T18:40:15.218Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
18:40:15 [2020-02-28T18:40:15.218Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
18:40:15 [2020-02-28T18:40:15.218Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
18:40:15 [2020-02-28T18:40:15.218Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
18:40:17 [2020-02-28T18:40:17.629Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
18:40:17 [2020-02-28T18:40:17.629Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
18:40:18 [2020-02-28T18:40:18.888Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
18:40:18 [2020-02-28T18:40:18.888Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
18:40:20 [2020-02-28T18:40:20.666Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
18:40:20 [2020-02-28T18:40:20.666Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
18:40:22 [2020-02-28T18:40:22.688Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
18:40:23 [2020-02-28T18:40:23.046Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
18:40:25 [2020-02-28T18:40:25.459Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
18:40:25 [2020-02-28T18:40:25.829Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
18:40:27 [2020-02-28T18:40:27.631Z] --- PASS: TestDaemonRestartKillContainers (0.00s)
18:40:27 [2020-02-28T18:40:27.631Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon (2.27s)
18:40:27 [2020-02-28T18:40:27.631Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon (2.32s)
18:40:27 [2020-02-28T18:40:27.631Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon (1.45s)
18:40:27 [2020-02-28T18:40:27.631Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon (1.44s)
18:40:27 [2020-02-28T18:40:27.631Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon (1.48s)
18:40:27 [2020-02-28T18:40:27.631Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon (1.48s)
18:40:27 [2020-02-28T18:40:27.631Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon (2.31s)
18:40:27 [2020-02-28T18:40:27.631Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon (2.54s)
18:40:27 [2020-02-28T18:40:27.631Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon (2.69s)
18:40:27 [2020-02-28T18:40:27.631Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon (2.71s)
18:40:27 [2020-02-28T18:40:27.631Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon (1.88s)
18:40:27 [2020-02-28T18:40:27.631Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon (2.31s)
18:40:27 [2020-02-28T18:40:27.631Z] === RUN   TestCgroupNamespacesRun
18:40:29 [2020-02-28T18:40:29.390Z] --- PASS: TestCgroupNamespacesRun (1.65s)
18:40:29 [2020-02-28T18:40:29.390Z] === RUN   TestCgroupNamespacesRunPrivileged
18:40:31 [2020-02-28T18:40:31.152Z] --- PASS: TestCgroupNamespacesRunPrivileged (1.63s)
18:40:31 [2020-02-28T18:40:31.152Z] === RUN   TestCgroupNamespacesRunDaemonHostMode
18:40:32 [2020-02-28T18:40:32.904Z] --- PASS: TestCgroupNamespacesRunDaemonHostMode (1.69s)
18:40:32 [2020-02-28T18:40:32.904Z] === RUN   TestCgroupNamespacesRunHostMode
18:40:34 [2020-02-28T18:40:34.847Z] --- PASS: TestCgroupNamespacesRunHostMode (1.81s)
18:40:34 [2020-02-28T18:40:34.847Z] === RUN   TestCgroupNamespacesRunPrivateMode
18:40:36 [2020-02-28T18:40:36.152Z] --- PASS: TestCgroupNamespacesRunPrivateMode (1.76s)
18:40:36 [2020-02-28T18:40:36.152Z] === RUN   TestCgroupNamespacesRunPrivilegedAndPrivate
18:40:37 [2020-02-28T18:40:37.402Z] --- PASS: TestCgroupNamespacesRunPrivilegedAndPrivate (0.84s)
18:40:37 [2020-02-28T18:40:37.402Z] === RUN   TestCgroupNamespacesRunInvalidMode
18:40:38 [2020-02-28T18:40:38.329Z] --- PASS: TestCgroupNamespacesRunInvalidMode (0.86s)
18:40:38 [2020-02-28T18:40:38.329Z] === RUN   TestCgroupNamespacesRunOlderClient
18:40:40 [2020-02-28T18:40:40.110Z] --- PASS: TestCgroupNamespacesRunOlderClient (1.82s)
18:40:40 [2020-02-28T18:40:40.110Z] === RUN   TestKernelTCPMemory
18:40:40 [2020-02-28T18:40:40.861Z] --- PASS: TestKernelTCPMemory (1.00s)
18:40:40 [2020-02-28T18:40:40.861Z] === RUN   TestNISDomainname
18:40:42 [2020-02-28T18:40:42.079Z] --- PASS: TestNISDomainname (1.11s)
18:40:42 [2020-02-28T18:40:42.079Z] === RUN   TestHostnameDnsResolution
18:40:43 [2020-02-28T18:40:43.386Z] --- PASS: TestHostnameDnsResolution (1.25s)
18:40:43 [2020-02-28T18:40:43.386Z] === RUN   TestStats
18:40:46 [2020-02-28T18:40:46.476Z] --- PASS: TestStats (2.84s)
18:40:46 [2020-02-28T18:40:46.476Z] === RUN   TestStopContainerWithTimeout
18:40:46 [2020-02-28T18:40:46.476Z] === RUN   TestStopContainerWithTimeout/0
18:40:46 [2020-02-28T18:40:46.476Z] === PAUSE TestStopContainerWithTimeout/0
18:40:46 [2020-02-28T18:40:46.476Z] === RUN   TestStopContainerWithTimeout/1
18:40:46 [2020-02-28T18:40:46.476Z] === PAUSE TestStopContainerWithTimeout/1
18:40:46 [2020-02-28T18:40:46.476Z] === RUN   TestStopContainerWithTimeout/3
18:40:46 [2020-02-28T18:40:46.476Z] === PAUSE TestStopContainerWithTimeout/3
18:40:46 [2020-02-28T18:40:46.476Z] === RUN   TestStopContainerWithTimeout/-1
18:40:46 [2020-02-28T18:40:46.476Z] === PAUSE TestStopContainerWithTimeout/-1
18:40:46 [2020-02-28T18:40:46.476Z] === CONT  TestStopContainerWithTimeout/0
18:40:46 [2020-02-28T18:40:46.476Z] === CONT  TestStopContainerWithTimeout/-1
18:40:47 [2020-02-28T18:40:47.259Z] === CONT  TestStopContainerWithTimeout/3
18:40:49 [2020-02-28T18:40:49.019Z] === CONT  TestStopContainerWithTimeout/1
18:40:50 [2020-02-28T18:40:50.776Z] --- PASS: TestStopContainerWithTimeout (0.01s)
18:40:50 [2020-02-28T18:40:50.776Z]     --- PASS: TestStopContainerWithTimeout/0 (1.08s)
18:40:50 [2020-02-28T18:40:50.776Z]     --- PASS: TestStopContainerWithTimeout/-1 (3.00s)
18:40:50 [2020-02-28T18:40:50.776Z]     --- PASS: TestStopContainerWithTimeout/3 (2.96s)
18:40:50 [2020-02-28T18:40:50.776Z]     --- PASS: TestStopContainerWithTimeout/1 (1.93s)
18:40:50 [2020-02-28T18:40:50.776Z] === RUN   TestDeleteDevicemapper
18:40:50 [2020-02-28T18:40:50.776Z] --- SKIP: TestDeleteDevicemapper (0.01s)
18:40:50 [2020-02-28T18:40:50.776Z]     stop_linux_test.go:74: testEnv.DaemonInfo.Driver != "devicemapper"
18:40:50 [2020-02-28T18:40:50.776Z] === RUN   TestStopContainerWithRestartPolicyAlways
18:40:54 [2020-02-28T18:40:54.742Z] --- PASS: TestStopContainerWithRestartPolicyAlways (3.20s)
18:40:54 [2020-02-28T18:40:54.743Z] === RUN   TestUpdateMemory
18:40:54 [2020-02-28T18:40:54.743Z] --- SKIP: TestUpdateMemory (0.00s)
18:40:54 [2020-02-28T18:40:54.743Z]     update_linux_test.go:23: !testEnv.DaemonInfo.SwapLimit
18:40:54 [2020-02-28T18:40:54.743Z] === RUN   TestUpdateCPUQuota
18:40:55 [2020-02-28T18:40:55.512Z] --- PASS: TestUpdateCPUQuota (1.21s)
18:40:55 [2020-02-28T18:40:55.512Z] === RUN   TestUpdatePidsLimit
18:40:55 [2020-02-28T18:40:55.512Z] === RUN   TestUpdatePidsLimit/update_from_none
18:40:55 [2020-02-28T18:40:55.872Z] === RUN   TestUpdatePidsLimit/no_change
18:40:56 [2020-02-28T18:40:56.227Z] === RUN   TestUpdatePidsLimit/update_lower
18:40:56 [2020-02-28T18:40:56.589Z] === RUN   TestUpdatePidsLimit/update_on_old_api_ignores_value
18:40:56 [2020-02-28T18:40:56.958Z] === RUN   TestUpdatePidsLimit/unset_limit_with_zero
18:40:57 [2020-02-28T18:40:57.319Z] === RUN   TestUpdatePidsLimit/unset_limit_with_minus_one
18:40:57 [2020-02-28T18:40:57.672Z] === RUN   TestUpdatePidsLimit/unset_limit_with_minus_two
18:40:58 [2020-02-28T18:40:58.906Z] --- PASS: TestUpdatePidsLimit (3.72s)
18:40:58 [2020-02-28T18:40:58.906Z]     --- PASS: TestUpdatePidsLimit/update_from_none (0.37s)
18:40:58 [2020-02-28T18:40:58.906Z]     --- PASS: TestUpdatePidsLimit/no_change (0.41s)
18:40:58 [2020-02-28T18:40:58.906Z]     --- PASS: TestUpdatePidsLimit/update_lower (0.35s)
18:40:58 [2020-02-28T18:40:58.906Z]     --- PASS: TestUpdatePidsLimit/update_on_old_api_ignores_value (0.43s)
18:40:58 [2020-02-28T18:40:58.906Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_zero (0.37s)
18:40:58 [2020-02-28T18:40:58.906Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_minus_one (0.38s)
18:40:58 [2020-02-28T18:40:58.906Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_minus_two (0.36s)
18:40:58 [2020-02-28T18:40:58.906Z] === RUN   TestUpdateRestartPolicy
18:41:12 [2020-02-28T18:41:12.556Z] --- PASS: TestUpdateRestartPolicy (12.74s)
18:41:12 [2020-02-28T18:41:12.556Z] === RUN   TestUpdateRestartWithAutoRemove
18:41:12 [2020-02-28T18:41:12.556Z] --- PASS: TestUpdateRestartWithAutoRemove (0.88s)
18:41:12 [2020-02-28T18:41:12.556Z] === RUN   TestWaitNonBlocked
18:41:12 [2020-02-28T18:41:12.556Z] === RUN   TestWaitNonBlocked/wait-nonblocking-exit-0
18:41:12 [2020-02-28T18:41:12.556Z] === PAUSE TestWaitNonBlocked/wait-nonblocking-exit-0
18:41:12 [2020-02-28T18:41:12.556Z] === RUN   TestWaitNonBlocked/wait-nonblocking-exit-random
18:41:12 [2020-02-28T18:41:12.556Z] === PAUSE TestWaitNonBlocked/wait-nonblocking-exit-random
18:41:12 [2020-02-28T18:41:12.556Z] === CONT  TestWaitNonBlocked/wait-nonblocking-exit-0
18:41:12 [2020-02-28T18:41:12.556Z] === CONT  TestWaitNonBlocked/wait-nonblocking-exit-random
18:41:13 [2020-02-28T18:41:13.773Z] --- PASS: TestWaitNonBlocked (0.03s)
18:41:13 [2020-02-28T18:41:13.773Z]     --- PASS: TestWaitNonBlocked/wait-nonblocking-exit-random (0.96s)
18:41:13 [2020-02-28T18:41:13.773Z]     --- PASS: TestWaitNonBlocked/wait-nonblocking-exit-0 (1.02s)
18:41:13 [2020-02-28T18:41:13.773Z] === RUN   TestWaitBlocked
18:41:13 [2020-02-28T18:41:13.773Z] === RUN   TestWaitBlocked/test-wait-blocked-exit-zero
18:41:13 [2020-02-28T18:41:13.773Z] === PAUSE TestWaitBlocked/test-wait-blocked-exit-zero
18:41:13 [2020-02-28T18:41:13.773Z] === RUN   TestWaitBlocked/test-wait-blocked-exit-random
18:41:13 [2020-02-28T18:41:13.773Z] === PAUSE TestWaitBlocked/test-wait-blocked-exit-random
18:41:13 [2020-02-28T18:41:13.774Z] === CONT  TestWaitBlocked/test-wait-blocked-exit-zero
18:41:13 [2020-02-28T18:41:13.774Z] === CONT  TestWaitBlocked/test-wait-blocked-exit-random
18:41:15 [2020-02-28T18:41:15.057Z] --- PASS: TestWaitBlocked (0.01s)
18:41:15 [2020-02-28T18:41:15.057Z]     --- PASS: TestWaitBlocked/test-wait-blocked-exit-random (1.23s)
18:41:15 [2020-02-28T18:41:15.057Z]     --- PASS: TestWaitBlocked/test-wait-blocked-exit-zero (1.23s)
18:41:15 [2020-02-28T18:41:15.057Z] === CONT  TestContainerStartOnDaemonRestart
18:41:15 [2020-02-28T18:41:15.057Z] === CONT  TestIpcModeOlderClient
18:41:15 [2020-02-28T18:41:15.057Z] --- PASS: TestIpcModeOlderClient (0.19s)
18:41:15 [2020-02-28T18:41:15.057Z] === CONT  TestDaemonHostGatewayIP
18:41:18 [2020-02-28T18:41:18.380Z] --- PASS: TestContainerStartOnDaemonRestart (2.87s)
18:41:18 [2020-02-28T18:41:18.380Z] === CONT  TestDaemonRestartIpcMode
18:41:19 [2020-02-28T18:41:19.251Z] --- PASS: TestDaemonHostGatewayIP (3.85s)
18:41:21 [2020-02-28T18:41:21.702Z] --- PASS: TestDaemonRestartIpcMode (3.52s)
18:41:21 [2020-02-28T18:41:21.702Z] PASS
18:41:21 [2020-02-28T18:41:21.702Z] 
18:41:21 [2020-02-28T18:41:21.702Z] === Skipped
18:41:21 [2020-02-28T18:41:21.702Z] === SKIP: s390x.integration.container TestCheckpoint (0.00s)
18:41:21 [2020-02-28T18:41:21.702Z]     checkpoint_test.go:33: TestCheckpoint is broken; see https://github.com/moby/moby/issues/38963
18:41:21 [2020-02-28T18:41:21.702Z] 
18:41:21 [2020-02-28T18:41:21.702Z] === SKIP: s390x.integration.container TestInspectOomKilledTrue (0.01s)
18:41:21 [2020-02-28T18:41:21.702Z]     kill_test.go:151: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
18:41:21 [2020-02-28T18:41:21.702Z] 
18:41:21 [2020-02-28T18:41:21.702Z] === SKIP: s390x.integration.container TestInspectOomKilledFalse (0.00s)
18:41:21 [2020-02-28T18:41:21.702Z]     kill_test.go:169: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
18:41:21 [2020-02-28T18:41:21.702Z] 
18:41:21 [2020-02-28T18:41:21.702Z] === SKIP: s390x.integration.container TestPauseFailsOnWindowsServerContainers (0.00s)
18:41:21 [2020-02-28T18:41:21.702Z]     pause_test.go:54: testEnv.DaemonInfo.OSType != "windows" || testEnv.DaemonInfo.Isolation != "process"
18:41:21 [2020-02-28T18:41:21.702Z] 
18:41:21 [2020-02-28T18:41:21.702Z] === SKIP: s390x.integration.container TestDeleteDevicemapper (0.01s)
18:41:21 [2020-02-28T18:41:21.702Z]     stop_linux_test.go:74: testEnv.DaemonInfo.Driver != "devicemapper"
18:41:21 [2020-02-28T18:41:21.702Z] 
18:41:21 [2020-02-28T18:41:21.702Z] === SKIP: s390x.integration.container TestUpdateMemory (0.00s)
18:41:21 [2020-02-28T18:41:21.702Z]     update_linux_test.go:23: !testEnv.DaemonInfo.SwapLimit
18:41:21 [2020-02-28T18:41:21.702Z] 
18:41:21 [2020-02-28T18:41:21.702Z] 
18:41:21 [2020-02-28T18:41:21.702Z] DONE 199 tests, 6 skipped in 139.245s
18:41:21 [2020-02-28T18:41:21.702Z] Running /go/src/github.com/docker/docker/integration/image (s390x.integration.image) flags=-test.v -test.timeout=120m 
18:41:21 [2020-02-28T18:41:21.702Z] ++ 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
18:41:21 [2020-02-28T18:41:21.702Z] ++ set -e
18:41:21 [2020-02-28T18:41:21.702Z] ++ '[' -n 0 ']'
18:41:21 [2020-02-28T18:41:21.702Z] ++ set -x
18:41:21 [2020-02-28T18:41:21.702Z] ++ 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
18:41:21 [2020-02-28T18:41:21.702Z] INFO: Testing against a local daemon
18:41:21 [2020-02-28T18:41:21.702Z] === RUN   TestCommitInheritsEnv
18:41:22 [2020-02-28T18:41:22.085Z] --- PASS: TestCommitInheritsEnv (0.48s)
18:41:22 [2020-02-28T18:41:22.085Z] === RUN   TestImportExtremelyLargeImageWorks
18:41:22 [2020-02-28T18:41:22.085Z] === PAUSE TestImportExtremelyLargeImageWorks
18:41:22 [2020-02-28T18:41:22.085Z] === RUN   TestImagesFilterMultiReference
18:41:22 [2020-02-28T18:41:22.085Z] --- PASS: TestImagesFilterMultiReference (0.04s)
18:41:22 [2020-02-28T18:41:22.085Z] === RUN   TestImagePullPlatformInvalid
18:41:22 [2020-02-28T18:41:22.085Z] --- PASS: TestImagePullPlatformInvalid (0.01s)
18:41:22 [2020-02-28T18:41:22.085Z] === RUN   TestRemoveImageOrphaning
18:41:22 [2020-02-28T18:41:22.909Z] --- PASS: TestRemoveImageOrphaning (0.47s)
18:41:22 [2020-02-28T18:41:22.909Z] === RUN   TestRemoveImageGarbageCollector
18:41:22 [2020-02-28T18:41:22.909Z] --- SKIP: TestRemoveImageGarbageCollector (0.01s)
18:41:22 [2020-02-28T18:41:22.909Z]     remove_unix_test.go:36: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
18:41:22 [2020-02-28T18:41:22.909Z] === RUN   TestTagUnprefixedRepoByNameOrName
18:41:22 [2020-02-28T18:41:22.909Z] --- PASS: TestTagUnprefixedRepoByNameOrName (0.05s)
18:41:22 [2020-02-28T18:41:22.909Z] === RUN   TestTagInvalidReference
18:41:22 [2020-02-28T18:41:22.909Z] --- PASS: TestTagInvalidReference (0.01s)
18:41:22 [2020-02-28T18:41:22.909Z] === RUN   TestTagValidPrefixedRepo
18:41:22 [2020-02-28T18:41:22.909Z] --- PASS: TestTagValidPrefixedRepo (0.03s)
18:41:22 [2020-02-28T18:41:22.909Z] === RUN   TestTagExistedNameWithoutForce
18:41:22 [2020-02-28T18:41:22.909Z] --- PASS: TestTagExistedNameWithoutForce (0.03s)
18:41:22 [2020-02-28T18:41:22.909Z] === RUN   TestTagOfficialNames
18:41:22 [2020-02-28T18:41:22.909Z] --- PASS: TestTagOfficialNames (0.03s)
18:41:22 [2020-02-28T18:41:22.909Z] === RUN   TestTagMatchesDigest
18:41:22 [2020-02-28T18:41:22.909Z] --- PASS: TestTagMatchesDigest (0.02s)
18:41:22 [2020-02-28T18:41:22.909Z] === CONT  TestImportExtremelyLargeImageWorks
18:43:02 [2020-02-28T18:43:02.152Z] --- PASS: TestImportExtremelyLargeImageWorks (88.35s)
18:43:02 [2020-02-28T18:43:02.152Z] PASS
18:43:02 [2020-02-28T18:43:02.152Z] 
18:43:02 [2020-02-28T18:43:02.152Z] === Skipped
18:43:02 [2020-02-28T18:43:02.152Z] === SKIP: s390x.integration.image TestRemoveImageGarbageCollector (0.01s)
18:43:02 [2020-02-28T18:43:02.152Z]     remove_unix_test.go:36: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
18:43:02 [2020-02-28T18:43:02.152Z] 
18:43:02 [2020-02-28T18:43:02.152Z] 
18:43:02 [2020-02-28T18:43:02.152Z] DONE 12 tests, 1 skipped in 89.796s
18:43:02 [2020-02-28T18:43:02.152Z] Running /go/src/github.com/docker/docker/integration/network (s390x.integration.network) flags=-test.v -test.timeout=120m 
18:43:02 [2020-02-28T18:43:02.152Z] ++ 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
18:43:02 [2020-02-28T18:43:02.152Z] ++ set -e
18:43:02 [2020-02-28T18:43:02.152Z] ++ '[' -n 0 ']'
18:43:02 [2020-02-28T18:43:02.152Z] ++ set -x
18:43:02 [2020-02-28T18:43:02.152Z] ++ 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
18:43:02 [2020-02-28T18:43:02.152Z] INFO: Testing against a local daemon
18:43:02 [2020-02-28T18:43:02.152Z] === RUN   TestNetworkCreateDelete
18:43:02 [2020-02-28T18:43:02.152Z] --- PASS: TestNetworkCreateDelete (0.11s)
18:43:02 [2020-02-28T18:43:02.152Z] === RUN   TestDockerNetworkDeletePreferID
18:43:02 [2020-02-28T18:43:02.152Z] --- PASS: TestDockerNetworkDeletePreferID (0.33s)
18:43:02 [2020-02-28T18:43:02.152Z] === RUN   TestInspectNetwork
18:43:02 [2020-02-28T18:43:02.152Z] === RUN   TestInspectNetwork/full_network_id
18:43:02 [2020-02-28T18:43:02.152Z] === RUN   TestInspectNetwork/partial_network_id
18:43:02 [2020-02-28T18:43:02.152Z] === RUN   TestInspectNetwork/network_name
18:43:02 [2020-02-28T18:43:02.152Z] === RUN   TestInspectNetwork/network_name_and_swarm_scope
18:43:02 [2020-02-28T18:43:02.152Z] --- PASS: TestInspectNetwork (8.20s)
18:43:02 [2020-02-28T18:43:02.152Z]     --- PASS: TestInspectNetwork/full_network_id (0.01s)
18:43:02 [2020-02-28T18:43:02.152Z]     --- PASS: TestInspectNetwork/partial_network_id (0.00s)
18:43:02 [2020-02-28T18:43:02.152Z]     --- PASS: TestInspectNetwork/network_name (0.00s)
18:43:02 [2020-02-28T18:43:02.152Z]     --- PASS: TestInspectNetwork/network_name_and_swarm_scope (0.00s)
18:43:02 [2020-02-28T18:43:02.152Z] === RUN   TestRunContainerWithBridgeNone
18:43:02 [2020-02-28T18:43:02.511Z] --- PASS: TestRunContainerWithBridgeNone (2.38s)
18:43:02 [2020-02-28T18:43:02.511Z] === RUN   TestNetworkInvalidJSON
18:43:02 [2020-02-28T18:43:02.511Z] === RUN   TestNetworkInvalidJSON//networks/create
18:43:02 [2020-02-28T18:43:02.511Z] === PAUSE TestNetworkInvalidJSON//networks/create
18:43:02 [2020-02-28T18:43:02.511Z] === RUN   TestNetworkInvalidJSON//networks/bridge/connect
18:43:02 [2020-02-28T18:43:02.511Z] === PAUSE TestNetworkInvalidJSON//networks/bridge/connect
18:43:02 [2020-02-28T18:43:02.511Z] === RUN   TestNetworkInvalidJSON//networks/bridge/disconnect
18:43:02 [2020-02-28T18:43:02.511Z] === PAUSE TestNetworkInvalidJSON//networks/bridge/disconnect
18:43:02 [2020-02-28T18:43:02.511Z] === CONT  TestNetworkInvalidJSON//networks/create
18:43:02 [2020-02-28T18:43:02.511Z] === CONT  TestNetworkInvalidJSON//networks/bridge/disconnect
18:43:02 [2020-02-28T18:43:02.511Z] === CONT  TestNetworkInvalidJSON//networks/bridge/connect
18:43:02 [2020-02-28T18:43:02.511Z] --- PASS: TestNetworkInvalidJSON (0.01s)
18:43:02 [2020-02-28T18:43:02.511Z]     --- PASS: TestNetworkInvalidJSON//networks/create (0.00s)
18:43:02 [2020-02-28T18:43:02.511Z]     --- PASS: TestNetworkInvalidJSON//networks/bridge/disconnect (0.00s)
18:43:02 [2020-02-28T18:43:02.511Z]     --- PASS: TestNetworkInvalidJSON//networks/bridge/connect (0.00s)
18:43:02 [2020-02-28T18:43:02.511Z] === RUN   TestDaemonRestartWithLiveRestore
18:43:03 [2020-02-28T18:43:03.721Z] --- PASS: TestDaemonRestartWithLiveRestore (1.04s)
18:43:03 [2020-02-28T18:43:03.721Z] === RUN   TestDaemonDefaultNetworkPools
18:43:04 [2020-02-28T18:43:04.084Z] --- PASS: TestDaemonDefaultNetworkPools (0.76s)
18:43:04 [2020-02-28T18:43:04.084Z] === RUN   TestDaemonRestartWithExistingNetwork
18:43:05 [2020-02-28T18:43:05.300Z] --- PASS: TestDaemonRestartWithExistingNetwork (1.14s)
18:43:05 [2020-02-28T18:43:05.300Z] === RUN   TestDaemonRestartWithExistingNetworkWithDefaultPoolRange
18:43:06 [2020-02-28T18:43:06.517Z] --- PASS: TestDaemonRestartWithExistingNetworkWithDefaultPoolRange (1.17s)
18:43:06 [2020-02-28T18:43:06.517Z] === RUN   TestDaemonWithBipAndDefaultNetworkPool
18:43:07 [2020-02-28T18:43:07.298Z] --- PASS: TestDaemonWithBipAndDefaultNetworkPool (0.59s)
18:43:07 [2020-02-28T18:43:07.298Z] === RUN   TestServiceWithPredefinedNetwork
18:43:09 [2020-02-28T18:43:09.940Z] --- PASS: TestServiceWithPredefinedNetwork (2.93s)
18:43:09 [2020-02-28T18:43:09.940Z] === RUN   TestServiceRemoveKeepsIngressNetwork
18:43:09 [2020-02-28T18:43:09.940Z] --- SKIP: TestServiceRemoveKeepsIngressNetwork (0.00s)
18:43:09 [2020-02-28T18:43:09.940Z]     service_test.go:230: FLAKY_TEST
18:43:09 [2020-02-28T18:43:09.940Z] === RUN   TestServiceWithDataPathPortInit
18:43:29 [2020-02-28T18:43:29.424Z] --- PASS: TestServiceWithDataPathPortInit (16.21s)
18:43:29 [2020-02-28T18:43:29.424Z] === RUN   TestServiceWithDefaultAddressPoolInit
18:43:35 [2020-02-28T18:43:35.554Z] --- PASS: TestServiceWithDefaultAddressPoolInit (8.38s)
18:43:35 [2020-02-28T18:43:35.554Z]     service_test.go:418: TestServiceWithDefaultAddressPoolInit: NetworkInspect: {Name:sthiraTestServiceWithDefaultAddressPoolInit ID:ci8t7lcnp7dtjzhv2kp9jn1ib Created:2020-02-28 18:43:27.731428757 +0000 UTC Scope:swarm Driver:overlay EnableIPv6:false IPAM:{Driver:default Options:map[] Config:[{Subnet:20.20.1.0/24 IPRange: Gateway:20.20.1.1 AuxAddress:map[]}]} Internal:false Attachable:false Ingress:false ConfigFrom:{Network:} ConfigOnly:false Containers:map[2c7d0d8d149070820ec0c4fb9a2e67e643143a2ad8a64e62b68125aeee63e672:{Name:TestServiceTestServiceWithDefaultAddressPoolInit.1.ctfhoeung1cox9iopaoldn4zd EndpointID:50543ba09b6dd4efc9cf89eb79f7ffb5f3d699bed04084ad4fc51047644c911e MacAddress:02:42:14:14:01:03 IPv4Address:20.20.1.3/24 IPv6Address:} lb-sthiraTestServiceWithDefaultAddressPoolInit:{Name:sthiraTestServiceWithDefaultAddressPoolInit-endpoint EndpointID:50b6cba5d453bdfca7904be2d8ba31e8c518bb69b278bb00169ec05b6bd29bf7 MacAddress:02:42:14:14:01:04 IPv4Address:20.20.1.4/24 IPv6Address:}] Options:map[com.docker.network.driver.overlay.vxlanid_list:4097] Labels:map[] Peers:[{Name:e0c73b2c4af0 IP:127.0.0.1}] Services:map[TestServiceTestServiceWithDefaultAddressPoolInit:{VIP:20.20.1.2 Ports:[] LocalLBIndex:256 Tasks:[{Name:TestServiceTestServiceWithDefaultAddressPoolInit.1.ctfhoeung1cox9iopaoldn4zd EndpointID:50543ba09b6dd4efc9cf89eb79f7ffb5f3d699bed04084ad4fc51047644c911e EndpointIP:20.20.1.3 Info:map[Host IP:127.0.0.1]}]}]}
18:43:35 [2020-02-28T18:43:35.554Z] PASS
18:43:35 [2020-02-28T18:43:35.554Z] 
18:43:35 [2020-02-28T18:43:35.554Z] === Skipped
18:43:35 [2020-02-28T18:43:35.554Z] === SKIP: s390x.integration.network TestServiceRemoveKeepsIngressNetwork (0.00s)
18:43:35 [2020-02-28T18:43:35.554Z]     service_test.go:230: FLAKY_TEST
18:43:35 [2020-02-28T18:43:35.554Z] 
18:43:35 [2020-02-28T18:43:35.554Z] 
18:43:35 [2020-02-28T18:43:35.554Z] DONE 21 tests, 1 skipped in 43.483s
18:43:35 [2020-02-28T18:43:35.554Z] Running /go/src/github.com/docker/docker/integration/network/ipvlan (s390x.integration.network.ipvlan) flags=-test.v -test.timeout=120m 
18:43:35 [2020-02-28T18:43:35.554Z] ++ 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
18:43:35 [2020-02-28T18:43:35.554Z] ++ set -e
18:43:35 [2020-02-28T18:43:35.554Z] ++ '[' -n 0 ']'
18:43:35 [2020-02-28T18:43:35.554Z] ++ set -x
18:43:35 [2020-02-28T18:43:35.554Z] ++ 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
18:43:35 [2020-02-28T18:43:35.554Z] INFO: Testing against a local daemon
18:43:35 [2020-02-28T18:43:35.554Z] === RUN   TestDockerNetworkIpvlanPersistance
18:43:35 [2020-02-28T18:43:35.554Z] --- SKIP: TestDockerNetworkIpvlanPersistance (0.01s)
18:43:35 [2020-02-28T18:43:35.554Z]     ipvlan_test.go:26: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
18:43:35 [2020-02-28T18:43:35.554Z] === RUN   TestDockerNetworkIpvlan
18:43:35 [2020-02-28T18:43:35.554Z] --- SKIP: TestDockerNetworkIpvlan (0.00s)
18:43:35 [2020-02-28T18:43:35.554Z]     ipvlan_test.go:53: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
18:43:35 [2020-02-28T18:43:35.554Z] PASS
18:43:35 [2020-02-28T18:43:35.554Z] 
18:43:35 [2020-02-28T18:43:35.554Z] === Skipped
18:43:35 [2020-02-28T18:43:35.554Z] === SKIP: s390x.integration.network.ipvlan TestDockerNetworkIpvlanPersistance (0.01s)
18:43:35 [2020-02-28T18:43:35.554Z]     ipvlan_test.go:26: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
18:43:35 [2020-02-28T18:43:35.554Z] 
18:43:35 [2020-02-28T18:43:35.555Z] === SKIP: s390x.integration.network.ipvlan TestDockerNetworkIpvlan (0.00s)
18:43:35 [2020-02-28T18:43:35.555Z]     ipvlan_test.go:53: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
18:43:35 [2020-02-28T18:43:35.555Z] 
18:43:35 [2020-02-28T18:43:35.555Z] 
18:43:35 [2020-02-28T18:43:35.555Z] DONE 2 tests, 2 skipped in 0.163s
18:43:35 [2020-02-28T18:43:35.555Z] Running /go/src/github.com/docker/docker/integration/network/macvlan (s390x.integration.network.macvlan) flags=-test.v -test.timeout=120m 
18:43:35 [2020-02-28T18:43:35.555Z] ++ 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
18:43:35 [2020-02-28T18:43:35.555Z] ++ set -e
18:43:35 [2020-02-28T18:43:35.555Z] ++ '[' -n 0 ']'
18:43:35 [2020-02-28T18:43:35.555Z] ++ set -x
18:43:35 [2020-02-28T18:43:35.555Z] ++ 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
18:43:35 [2020-02-28T18:43:35.555Z] INFO: Testing against a local daemon
18:43:35 [2020-02-28T18:43:35.555Z] === RUN   TestDockerNetworkMacvlanPersistance
18:43:36 [2020-02-28T18:43:36.314Z] --- PASS: TestDockerNetworkMacvlanPersistance (1.39s)
18:43:36 [2020-02-28T18:43:36.314Z] === RUN   TestDockerNetworkMacvlan
18:43:37 [2020-02-28T18:43:37.121Z] === RUN   TestDockerNetworkMacvlan/Subinterface
18:43:37 [2020-02-28T18:43:37.879Z] === RUN   TestDockerNetworkMacvlan/OverlapParent
18:43:39 [2020-02-28T18:43:39.218Z] === RUN   TestDockerNetworkMacvlan/NilParent
18:43:41 [2020-02-28T18:43:41.745Z] === RUN   TestDockerNetworkMacvlan/InternalMode
18:43:45 [2020-02-28T18:43:45.696Z] === RUN   TestDockerNetworkMacvlan/MultiSubnet
18:43:49 [2020-02-28T18:43:49.681Z] === RUN   TestDockerNetworkMacvlan/Addressing
18:43:50 [2020-02-28T18:43:50.906Z] --- PASS: TestDockerNetworkMacvlan (14.63s)
18:43:50 [2020-02-28T18:43:50.906Z]     --- PASS: TestDockerNetworkMacvlan/Subinterface (0.06s)
18:43:50 [2020-02-28T18:43:50.906Z]     --- PASS: TestDockerNetworkMacvlan/OverlapParent (0.11s)
18:43:50 [2020-02-28T18:43:50.906Z]     --- PASS: TestDockerNetworkMacvlan/NilParent (1.31s)
18:43:50 [2020-02-28T18:43:50.906Z]     --- PASS: TestDockerNetworkMacvlan/InternalMode (2.14s)
18:43:50 [2020-02-28T18:43:50.906Z]     --- PASS: TestDockerNetworkMacvlan/MultiSubnet (3.05s)
18:43:50 [2020-02-28T18:43:50.906Z]     --- PASS: TestDockerNetworkMacvlan/Addressing (0.81s)
18:43:50 [2020-02-28T18:43:50.906Z] PASS
18:43:50 [2020-02-28T18:43:50.906Z] 
18:43:50 [2020-02-28T18:43:50.906Z] DONE 8 tests in 16.119s
18:43:50 [2020-02-28T18:43:50.906Z] Running /go/src/github.com/docker/docker/integration/plugin (s390x.integration.plugin) flags=-test.v -test.timeout=120m 
18:43:50 [2020-02-28T18:43:50.907Z] ++ 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
18:43:50 [2020-02-28T18:43:50.907Z] ++ set -e
18:43:50 [2020-02-28T18:43:50.907Z] ++ '[' -n 0 ']'
18:43:50 [2020-02-28T18:43:50.907Z] ++ set -x
18:43:50 [2020-02-28T18:43:50.907Z] ++ 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
18:43:51 [2020-02-28T18:43:51.302Z] testing: warning: no tests to run
18:43:51 [2020-02-28T18:43:51.302Z] PASS
18:43:51 [2020-02-28T18:43:51.302Z] 
18:43:51 [2020-02-28T18:43:51.302Z] DONE 0 tests in 0.070s
18:43:51 [2020-02-28T18:43:51.302Z] Running /go/src/github.com/docker/docker/integration/plugin/authz (s390x.integration.plugin.authz) flags=-test.v -test.timeout=120m 
18:43:51 [2020-02-28T18:43:51.303Z] ++ 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
18:43:51 [2020-02-28T18:43:51.303Z] ++ set -e
18:43:51 [2020-02-28T18:43:51.303Z] ++ '[' -n 0 ']'
18:43:51 [2020-02-28T18:43:51.303Z] ++ set -x
18:43:51 [2020-02-28T18:43:51.303Z] ++ 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
18:43:51 [2020-02-28T18:43:51.303Z] INFO: Testing against a local daemon
18:43:51 [2020-02-28T18:43:51.303Z] === RUN   TestAuthZPluginAllowRequest
18:43:52 [2020-02-28T18:43:52.905Z] --- PASS: TestAuthZPluginAllowRequest (1.74s)
18:43:52 [2020-02-28T18:43:52.905Z] === RUN   TestAuthZPluginTLS
18:43:53 [2020-02-28T18:43:53.646Z] --- PASS: TestAuthZPluginTLS (0.54s)
18:43:53 [2020-02-28T18:43:53.646Z] === RUN   TestAuthZPluginDenyRequest
18:43:53 [2020-02-28T18:43:53.997Z] --- PASS: TestAuthZPluginDenyRequest (0.53s)
18:43:53 [2020-02-28T18:43:53.997Z] === RUN   TestAuthZPluginAPIDenyResponse
18:43:54 [2020-02-28T18:43:54.741Z] --- PASS: TestAuthZPluginAPIDenyResponse (0.53s)
18:43:54 [2020-02-28T18:43:54.741Z] === RUN   TestAuthZPluginDenyResponse
18:43:55 [2020-02-28T18:43:55.093Z] --- PASS: TestAuthZPluginDenyResponse (0.55s)
18:43:55 [2020-02-28T18:43:55.093Z] === RUN   TestAuthZPluginAllowEventStream
18:43:56 [2020-02-28T18:43:56.829Z] --- PASS: TestAuthZPluginAllowEventStream (1.59s)
18:43:56 [2020-02-28T18:43:56.829Z] === RUN   TestAuthZPluginErrorResponse
18:43:57 [2020-02-28T18:43:57.194Z] --- PASS: TestAuthZPluginErrorResponse (0.54s)
18:43:57 [2020-02-28T18:43:57.194Z] === RUN   TestAuthZPluginErrorRequest
18:43:57 [2020-02-28T18:43:57.964Z] --- PASS: TestAuthZPluginErrorRequest (0.53s)
18:43:57 [2020-02-28T18:43:57.964Z] === RUN   TestAuthZPluginEnsureNoDuplicatePluginRegistration
18:43:58 [2020-02-28T18:43:58.314Z] --- PASS: TestAuthZPluginEnsureNoDuplicatePluginRegistration (0.53s)
18:43:58 [2020-02-28T18:43:58.314Z] === RUN   TestAuthZPluginEnsureLoadImportWorking
18:44:00 [2020-02-28T18:44:00.715Z] --- PASS: TestAuthZPluginEnsureLoadImportWorking (1.91s)
18:44:00 [2020-02-28T18:44:00.715Z] === RUN   TestAuthzPluginEnsureContainerCopyToFrom
18:44:02 [2020-02-28T18:44:02.464Z] --- PASS: TestAuthzPluginEnsureContainerCopyToFrom (2.13s)
18:44:02 [2020-02-28T18:44:02.464Z] === RUN   TestAuthZPluginHeader
18:44:03 [2020-02-28T18:44:03.239Z] --- PASS: TestAuthZPluginHeader (0.86s)
18:44:03 [2020-02-28T18:44:03.239Z] === RUN   TestAuthZPluginV2AllowNonVolumeRequest
18:44:03 [2020-02-28T18:44:03.239Z] --- SKIP: TestAuthZPluginV2AllowNonVolumeRequest (0.01s)
18:44:03 [2020-02-28T18:44:03.239Z]     authz_plugin_v2_test.go:43: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
18:44:03 [2020-02-28T18:44:03.239Z] === RUN   TestAuthZPluginV2Disable
18:44:03 [2020-02-28T18:44:03.239Z] --- SKIP: TestAuthZPluginV2Disable (0.00s)
18:44:03 [2020-02-28T18:44:03.239Z]     authz_plugin_v2_test.go:65: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
18:44:03 [2020-02-28T18:44:03.239Z] === RUN   TestAuthZPluginV2RejectVolumeRequests
18:44:03 [2020-02-28T18:44:03.239Z] --- SKIP: TestAuthZPluginV2RejectVolumeRequests (0.00s)
18:44:03 [2020-02-28T18:44:03.239Z]     authz_plugin_v2_test.go:91: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
18:44:03 [2020-02-28T18:44:03.239Z] === RUN   TestAuthZPluginV2BadManifestFailsDaemonStart
18:44:03 [2020-02-28T18:44:03.239Z] --- SKIP: TestAuthZPluginV2BadManifestFailsDaemonStart (0.00s)
18:44:03 [2020-02-28T18:44:03.239Z]     authz_plugin_v2_test.go:126: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
18:44:03 [2020-02-28T18:44:03.239Z] === RUN   TestAuthZPluginV2NonexistentFailsDaemonStart
18:44:22 [2020-02-28T18:44:22.810Z] --- PASS: TestAuthZPluginV2NonexistentFailsDaemonStart (16.75s)
18:44:22 [2020-02-28T18:44:22.810Z] PASS
18:44:22 [2020-02-28T18:44:22.810Z] 
18:44:22 [2020-02-28T18:44:22.810Z] === Skipped
18:44:22 [2020-02-28T18:44:22.810Z] === SKIP: s390x.integration.plugin.authz TestAuthZPluginV2AllowNonVolumeRequest (0.01s)
18:44:22 [2020-02-28T18:44:22.810Z]     authz_plugin_v2_test.go:43: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
18:44:22 [2020-02-28T18:44:22.810Z] 
18:44:22 [2020-02-28T18:44:22.810Z] === SKIP: s390x.integration.plugin.authz TestAuthZPluginV2Disable (0.00s)
18:44:22 [2020-02-28T18:44:22.810Z]     authz_plugin_v2_test.go:65: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
18:44:22 [2020-02-28T18:44:22.810Z] 
18:44:22 [2020-02-28T18:44:22.810Z] === SKIP: s390x.integration.plugin.authz TestAuthZPluginV2RejectVolumeRequests (0.00s)
18:44:22 [2020-02-28T18:44:22.810Z]     authz_plugin_v2_test.go:91: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
18:44:22 [2020-02-28T18:44:22.810Z] 
18:44:22 [2020-02-28T18:44:22.810Z] === SKIP: s390x.integration.plugin.authz TestAuthZPluginV2BadManifestFailsDaemonStart (0.00s)
18:44:22 [2020-02-28T18:44:22.810Z]     authz_plugin_v2_test.go:126: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
18:44:22 [2020-02-28T18:44:22.810Z] 
18:44:22 [2020-02-28T18:44:22.810Z] 
18:44:22 [2020-02-28T18:44:22.810Z] DONE 17 tests, 4 skipped in 28.916s
18:44:22 [2020-02-28T18:44:22.810Z] Running /go/src/github.com/docker/docker/integration/plugin/common (s390x.integration.plugin.common) flags=-test.v -test.timeout=120m 
18:44:22 [2020-02-28T18:44:22.810Z] ++ 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
18:44:22 [2020-02-28T18:44:22.810Z] ++ set -e
18:44:22 [2020-02-28T18:44:22.810Z] ++ '[' -n 0 ']'
18:44:22 [2020-02-28T18:44:22.810Z] ++ set -x
18:44:22 [2020-02-28T18:44:22.810Z] ++ 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
18:44:22 [2020-02-28T18:44:22.810Z] INFO: Testing against a local daemon
18:44:22 [2020-02-28T18:44:22.810Z] === RUN   TestPluginInvalidJSON
18:44:22 [2020-02-28T18:44:22.810Z] === RUN   TestPluginInvalidJSON//plugins/foobar/set
18:44:22 [2020-02-28T18:44:22.810Z] === PAUSE TestPluginInvalidJSON//plugins/foobar/set
18:44:22 [2020-02-28T18:44:22.810Z] === CONT  TestPluginInvalidJSON//plugins/foobar/set
18:44:22 [2020-02-28T18:44:22.810Z] --- PASS: TestPluginInvalidJSON (0.02s)
18:44:22 [2020-02-28T18:44:22.810Z]     --- PASS: TestPluginInvalidJSON//plugins/foobar/set (0.00s)
18:44:22 [2020-02-28T18:44:22.810Z] PASS
18:44:22 [2020-02-28T18:44:22.810Z] 
18:44:22 [2020-02-28T18:44:22.810Z] DONE 2 tests in 0.338s
18:44:22 [2020-02-28T18:44:22.810Z] Running /go/src/github.com/docker/docker/integration/plugin/graphdriver (s390x.integration.plugin.graphdriver) flags=-test.v -test.timeout=120m 
18:44:22 [2020-02-28T18:44:22.810Z] ++ 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
18:44:22 [2020-02-28T18:44:22.810Z] ++ set -e
18:44:22 [2020-02-28T18:44:22.810Z] ++ '[' -n 0 ']'
18:44:22 [2020-02-28T18:44:22.810Z] ++ set -x
18:44:22 [2020-02-28T18:44:22.810Z] ++ 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
18:44:22 [2020-02-28T18:44:22.810Z] INFO: Testing against a local daemon
18:44:22 [2020-02-28T18:44:22.810Z] === RUN   TestExternalGraphDriver
18:44:22 [2020-02-28T18:44:22.810Z] === RUN   TestExternalGraphDriver/json
18:44:22 [2020-02-28T18:44:22.810Z] === RUN   TestExternalGraphDriver/spec
18:44:25 [2020-02-28T18:44:25.190Z] === RUN   TestExternalGraphDriver/pull
18:44:26 [2020-02-28T18:44:26.966Z] --- PASS: TestExternalGraphDriver (6.16s)
18:44:26 [2020-02-28T18:44:26.966Z]     --- PASS: TestExternalGraphDriver/json (1.98s)
18:44:26 [2020-02-28T18:44:26.966Z]     --- PASS: TestExternalGraphDriver/spec (2.06s)
18:44:26 [2020-02-28T18:44:26.966Z]     --- PASS: TestExternalGraphDriver/pull (1.99s)
18:44:26 [2020-02-28T18:44:26.966Z] === RUN   TestGraphdriverPluginV2
18:44:26 [2020-02-28T18:44:26.966Z] --- SKIP: TestGraphdriverPluginV2 (0.06s)
18:44:26 [2020-02-28T18:44:26.966Z]     external_test.go:410: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
18:44:26 [2020-02-28T18:44:26.966Z] PASS
18:44:26 [2020-02-28T18:44:26.966Z] 
18:44:26 [2020-02-28T18:44:26.966Z] === Skipped
18:44:26 [2020-02-28T18:44:26.966Z] === SKIP: s390x.integration.plugin.graphdriver TestGraphdriverPluginV2 (0.06s)
18:44:26 [2020-02-28T18:44:26.966Z]     external_test.go:410: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
18:44:26 [2020-02-28T18:44:26.966Z] 
18:44:26 [2020-02-28T18:44:26.966Z] 
18:44:26 [2020-02-28T18:44:26.966Z] DONE 5 tests, 1 skipped in 6.531s
18:44:26 [2020-02-28T18:44:26.966Z] Running /go/src/github.com/docker/docker/integration/plugin/logging (s390x.integration.plugin.logging) flags=-test.v -test.timeout=120m 
18:44:26 [2020-02-28T18:44:26.966Z] ++ 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
18:44:26 [2020-02-28T18:44:26.966Z] ++ set -e
18:44:26 [2020-02-28T18:44:26.966Z] ++ '[' -n 0 ']'
18:44:26 [2020-02-28T18:44:26.966Z] ++ set -x
18:44:26 [2020-02-28T18:44:26.966Z] ++ 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
18:44:26 [2020-02-28T18:44:26.966Z] INFO: Testing against a local daemon
18:44:26 [2020-02-28T18:44:26.966Z] === RUN   TestContinueAfterPluginCrash
18:44:26 [2020-02-28T18:44:26.966Z] === PAUSE TestContinueAfterPluginCrash
18:44:26 [2020-02-28T18:44:26.966Z] === RUN   TestReadPluginNoRead
18:44:26 [2020-02-28T18:44:26.966Z] === PAUSE TestReadPluginNoRead
18:44:26 [2020-02-28T18:44:26.966Z] === RUN   TestDaemonStartWithLogOpt
18:44:26 [2020-02-28T18:44:26.966Z] === PAUSE TestDaemonStartWithLogOpt
18:44:26 [2020-02-28T18:44:26.966Z] === CONT  TestContinueAfterPluginCrash
18:44:26 [2020-02-28T18:44:26.966Z] === CONT  TestDaemonStartWithLogOpt
18:44:38 [2020-02-28T18:44:38.276Z] --- PASS: TestDaemonStartWithLogOpt (9.82s)
18:44:38 [2020-02-28T18:44:38.276Z] === CONT  TestReadPluginNoRead
18:44:40 [2020-02-28T18:44:40.044Z] === RUN   TestReadPluginNoRead/default
18:44:41 [2020-02-28T18:44:41.802Z] === RUN   TestReadPluginNoRead/disabled_caching
18:44:41 [2020-02-28T18:44:41.802Z] --- PASS: TestContinueAfterPluginCrash (14.69s)
18:44:43 [2020-02-28T18:44:43.542Z] === RUN   TestReadPluginNoRead/explicitly_enabled_caching
18:44:45 [2020-02-28T18:44:45.285Z] --- PASS: TestReadPluginNoRead (8.30s)
18:44:45 [2020-02-28T18:44:45.285Z]     --- PASS: TestReadPluginNoRead/default (1.93s)
18:44:45 [2020-02-28T18:44:45.285Z]     --- PASS: TestReadPluginNoRead/disabled_caching (1.77s)
18:44:45 [2020-02-28T18:44:45.285Z]     --- PASS: TestReadPluginNoRead/explicitly_enabled_caching (1.71s)
18:44:45 [2020-02-28T18:44:45.285Z]     read_test.go:91: [da05af897eadf] daemon is not started
18:44:45 [2020-02-28T18:44:45.285Z] PASS
18:44:45 [2020-02-28T18:44:45.285Z] 
18:44:45 [2020-02-28T18:44:45.285Z] DONE 6 tests in 18.333s
18:44:45 [2020-02-28T18:44:45.285Z] Running /go/src/github.com/docker/docker/integration/plugin/logging/cmd/discard (s390x.integration.plugin.logging.cmd.discard) flags=-test.v -test.timeout=120m 
18:44:45 [2020-02-28T18:44:45.285Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-logging-cmd-discard-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-logging-cmd-discard-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.plugin.logging.cmd.discard -t ./test.main -test.v -test.timeout=120m
18:44:45 [2020-02-28T18:44:45.285Z] ++ set -e
18:44:45 [2020-02-28T18:44:45.285Z] ++ '[' -n 0 ']'
18:44:45 [2020-02-28T18:44:45.285Z] ++ set -x
18:44:45 [2020-02-28T18:44:45.285Z] ++ 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-cmd-discard-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-logging-cmd-discard-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.plugin.logging.cmd.discard -t ./test.main -test.v -test.timeout=120m
18:44:45 [2020-02-28T18:44:45.285Z] testing: warning: no tests to run
18:44:45 [2020-02-28T18:44:45.285Z] PASS
18:44:45 [2020-02-28T18:44:45.285Z] 
18:44:45 [2020-02-28T18:44:45.285Z] DONE 0 tests in 0.087s
18:44:45 [2020-02-28T18:44:45.285Z] Running /go/src/github.com/docker/docker/integration/plugin/volumes (s390x.integration.plugin.volumes) flags=-test.v -test.timeout=120m 
18:44:45 [2020-02-28T18:44:45.285Z] ++ 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
18:44:45 [2020-02-28T18:44:45.285Z] ++ set -e
18:44:45 [2020-02-28T18:44:45.285Z] ++ '[' -n 0 ']'
18:44:45 [2020-02-28T18:44:45.285Z] ++ set -x
18:44:45 [2020-02-28T18:44:45.285Z] ++ 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
18:44:45 [2020-02-28T18:44:45.640Z] INFO: Testing against a local daemon
18:44:45 [2020-02-28T18:44:45.640Z] === RUN   TestPluginWithDevMounts
18:44:45 [2020-02-28T18:44:45.640Z] === PAUSE TestPluginWithDevMounts
18:44:45 [2020-02-28T18:44:45.640Z] === CONT  TestPluginWithDevMounts
18:44:47 [2020-02-28T18:44:47.396Z] --- PASS: TestPluginWithDevMounts (1.88s)
18:44:47 [2020-02-28T18:44:47.396Z] PASS
18:44:47 [2020-02-28T18:44:47.396Z] 
18:44:47 [2020-02-28T18:44:47.396Z] DONE 1 tests in 2.031s
18:44:47 [2020-02-28T18:44:47.396Z] Running /go/src/github.com/docker/docker/integration/secret (s390x.integration.secret) flags=-test.v -test.timeout=120m 
18:44:47 [2020-02-28T18:44:47.396Z] ++ 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
18:44:47 [2020-02-28T18:44:47.396Z] ++ set -e
18:44:47 [2020-02-28T18:44:47.396Z] ++ '[' -n 0 ']'
18:44:47 [2020-02-28T18:44:47.396Z] ++ set -x
18:44:47 [2020-02-28T18:44:47.396Z] ++ 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
18:44:47 [2020-02-28T18:44:47.396Z] INFO: Testing against a local daemon
18:44:47 [2020-02-28T18:44:47.396Z] === RUN   TestSecretInspect
18:44:49 [2020-02-28T18:44:49.761Z] --- PASS: TestSecretInspect (2.41s)
18:44:49 [2020-02-28T18:44:49.761Z] === RUN   TestSecretList
18:44:53 [2020-02-28T18:44:53.059Z] --- PASS: TestSecretList (2.43s)
18:44:53 [2020-02-28T18:44:53.059Z] === RUN   TestSecretsCreateAndDelete
18:44:55 [2020-02-28T18:44:55.442Z] --- PASS: TestSecretsCreateAndDelete (2.93s)
18:44:55 [2020-02-28T18:44:55.442Z] === RUN   TestSecretsUpdate
18:44:58 [2020-02-28T18:44:58.536Z] --- PASS: TestSecretsUpdate (2.87s)
18:44:58 [2020-02-28T18:44:58.536Z] === RUN   TestTemplatedSecret
18:45:01 [2020-02-28T18:45:01.632Z] --- PASS: TestTemplatedSecret (3.55s)
18:45:01 [2020-02-28T18:45:01.632Z] === RUN   TestSecretCreateResolve
18:45:04 [2020-02-28T18:45:04.701Z] --- PASS: TestSecretCreateResolve (2.73s)
18:45:04 [2020-02-28T18:45:04.701Z] PASS
18:45:04 [2020-02-28T18:45:04.701Z] 
18:45:04 [2020-02-28T18:45:04.701Z] DONE 6 tests in 17.031s
18:45:04 [2020-02-28T18:45:04.701Z] Running /go/src/github.com/docker/docker/integration/service (s390x.integration.service) flags=-test.v -test.timeout=120m 
18:45:04 [2020-02-28T18:45:04.701Z] ++ 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
18:45:04 [2020-02-28T18:45:04.701Z] ++ set -e
18:45:04 [2020-02-28T18:45:04.701Z] ++ '[' -n 0 ']'
18:45:04 [2020-02-28T18:45:04.701Z] ++ set -x
18:45:04 [2020-02-28T18:45:04.701Z] ++ 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
18:45:04 [2020-02-28T18:45:04.701Z] INFO: Testing against a local daemon
18:45:04 [2020-02-28T18:45:04.701Z] === RUN   TestServiceCreateInit
18:45:04 [2020-02-28T18:45:04.701Z] === RUN   TestServiceCreateInit/daemonInitDisabled
18:45:09 [2020-02-28T18:45:09.798Z] === RUN   TestServiceCreateInit/daemonInitEnabled
18:45:13 [2020-02-28T18:45:13.736Z] --- PASS: TestServiceCreateInit (9.24s)
18:45:13 [2020-02-28T18:45:13.737Z]     --- PASS: TestServiceCreateInit/daemonInitDisabled (4.46s)
18:45:13 [2020-02-28T18:45:13.737Z]     --- PASS: TestServiceCreateInit/daemonInitEnabled (4.76s)
18:45:13 [2020-02-28T18:45:13.737Z] === RUN   TestCreateServiceMultipleTimes
18:45:33 [2020-02-28T18:45:33.364Z] --- PASS: TestCreateServiceMultipleTimes (16.72s)
18:45:33 [2020-02-28T18:45:33.364Z] === RUN   TestCreateServiceConflict
18:45:33 [2020-02-28T18:45:33.364Z] --- PASS: TestCreateServiceConflict (2.69s)
18:45:33 [2020-02-28T18:45:33.364Z] === RUN   TestCreateServiceMaxReplicas
18:45:37 [2020-02-28T18:45:37.472Z] --- PASS: TestCreateServiceMaxReplicas (3.37s)
18:45:37 [2020-02-28T18:45:37.472Z] === RUN   TestCreateWithDuplicateNetworkNames
18:45:50 [2020-02-28T18:45:50.914Z] --- PASS: TestCreateWithDuplicateNetworkNames (14.30s)
18:45:50 [2020-02-28T18:45:50.914Z] === RUN   TestCreateServiceSecretFileMode
18:45:54 [2020-02-28T18:45:54.851Z] --- PASS: TestCreateServiceSecretFileMode (3.26s)
18:45:54 [2020-02-28T18:45:54.851Z] === RUN   TestCreateServiceConfigFileMode
18:45:57 [2020-02-28T18:45:57.246Z] --- PASS: TestCreateServiceConfigFileMode (3.20s)
18:45:57 [2020-02-28T18:45:57.246Z] === RUN   TestCreateServiceSysctls
18:46:01 [2020-02-28T18:46:01.357Z] --- PASS: TestCreateServiceSysctls (4.06s)
18:46:01 [2020-02-28T18:46:01.357Z] === RUN   TestCreateServiceCapabilities
18:46:04 [2020-02-28T18:46:04.412Z] --- PASS: TestCreateServiceCapabilities (3.03s)
18:46:04 [2020-02-28T18:46:04.412Z] === RUN   TestInspect
18:46:07 [2020-02-28T18:46:07.687Z] --- PASS: TestInspect (3.34s)
18:46:07 [2020-02-28T18:46:07.688Z] === RUN   TestCreateJob
18:46:12 [2020-02-28T18:46:12.610Z] --- PASS: TestCreateJob (4.05s)
18:46:12 [2020-02-28T18:46:12.610Z] === RUN   TestReplicatedJob
18:46:20 [2020-02-28T18:46:20.246Z] --- PASS: TestReplicatedJob (7.19s)
18:46:20 [2020-02-28T18:46:20.246Z] === RUN   TestUpdateReplicatedJob
18:46:23 [2020-02-28T18:46:23.348Z] --- PASS: TestUpdateReplicatedJob (4.14s)
18:46:23 [2020-02-28T18:46:23.348Z] === RUN   TestServiceListWithStatuses
18:46:23 [2020-02-28T18:46:23.348Z] --- SKIP: TestServiceListWithStatuses (0.02s)
18:46:23 [2020-02-28T18:46:23.348Z]     list_test.go:34: versions.LessThan(testEnv.DaemonInfo.ServerVersion, "1.41")
18:46:23 [2020-02-28T18:46:23.348Z] === RUN   TestDockerNetworkConnectAlias
18:46:29 [2020-02-28T18:46:29.486Z] --- PASS: TestDockerNetworkConnectAlias (5.78s)
18:46:29 [2020-02-28T18:46:29.486Z] === RUN   TestDockerNetworkReConnect
18:46:34 [2020-02-28T18:46:34.415Z] --- PASS: TestDockerNetworkReConnect (4.87s)
18:46:34 [2020-02-28T18:46:34.415Z] === RUN   TestServicePlugin
18:46:34 [2020-02-28T18:46:34.415Z] --- SKIP: TestServicePlugin (0.01s)
18:46:34 [2020-02-28T18:46:34.415Z]     plugin_test.go:28: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
18:46:34 [2020-02-28T18:46:34.415Z] === RUN   TestServiceUpdateLabel
18:46:36 [2020-02-28T18:46:36.844Z] --- PASS: TestServiceUpdateLabel (3.11s)
18:46:36 [2020-02-28T18:46:36.844Z] === RUN   TestServiceUpdateSecrets
18:46:52 [2020-02-28T18:46:52.973Z] --- PASS: TestServiceUpdateSecrets (15.58s)
18:46:52 [2020-02-28T18:46:52.973Z] === RUN   TestServiceUpdateConfigs
18:47:09 [2020-02-28T18:47:09.071Z] --- PASS: TestServiceUpdateConfigs (15.43s)
18:47:09 [2020-02-28T18:47:09.071Z] === RUN   TestServiceUpdateNetwork
18:47:22 [2020-02-28T18:47:22.514Z] --- PASS: TestServiceUpdateNetwork (14.26s)
18:47:22 [2020-02-28T18:47:22.514Z] PASS
18:47:22 [2020-02-28T18:47:22.514Z] 
18:47:22 [2020-02-28T18:47:22.514Z] === Skipped
18:47:22 [2020-02-28T18:47:22.514Z] === SKIP: s390x.integration.service TestServiceListWithStatuses (0.02s)
18:47:22 [2020-02-28T18:47:22.514Z]     list_test.go:34: versions.LessThan(testEnv.DaemonInfo.ServerVersion, "1.41")
18:47:22 [2020-02-28T18:47:22.514Z] 
18:47:22 [2020-02-28T18:47:22.514Z] === SKIP: s390x.integration.service TestServicePlugin (0.01s)
18:47:22 [2020-02-28T18:47:22.514Z]     plugin_test.go:28: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
18:47:22 [2020-02-28T18:47:22.514Z] 
18:47:22 [2020-02-28T18:47:22.514Z] 
18:47:22 [2020-02-28T18:47:22.514Z] DONE 23 tests, 2 skipped in 137.822s
18:47:22 [2020-02-28T18:47:22.514Z] Running /go/src/github.com/docker/docker/integration/session (s390x.integration.session) flags=-test.v -test.timeout=120m 
18:47:22 [2020-02-28T18:47:22.514Z] ++ 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
18:47:22 [2020-02-28T18:47:22.514Z] ++ set -e
18:47:22 [2020-02-28T18:47:22.514Z] ++ '[' -n 0 ']'
18:47:22 [2020-02-28T18:47:22.514Z] ++ set -x
18:47:22 [2020-02-28T18:47:22.514Z] ++ 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
18:47:22 [2020-02-28T18:47:22.514Z] INFO: Testing against a local daemon
18:47:22 [2020-02-28T18:47:22.514Z] === RUN   TestSessionCreate
18:47:22 [2020-02-28T18:47:22.514Z] --- PASS: TestSessionCreate (0.02s)
18:47:22 [2020-02-28T18:47:22.514Z] === RUN   TestSessionCreateWithBadUpgrade
18:47:22 [2020-02-28T18:47:22.514Z] --- PASS: TestSessionCreateWithBadUpgrade (0.02s)
18:47:22 [2020-02-28T18:47:22.514Z] PASS
18:47:22 [2020-02-28T18:47:22.514Z] 
18:47:22 [2020-02-28T18:47:22.514Z] DONE 2 tests in 0.252s
18:47:22 [2020-02-28T18:47:22.514Z] Running /go/src/github.com/docker/docker/integration/system (s390x.integration.system) flags=-test.v -test.timeout=120m 
18:47:22 [2020-02-28T18:47:22.514Z] ++ 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
18:47:22 [2020-02-28T18:47:22.514Z] ++ set -e
18:47:22 [2020-02-28T18:47:22.514Z] ++ '[' -n 0 ']'
18:47:22 [2020-02-28T18:47:22.514Z] ++ set -x
18:47:22 [2020-02-28T18:47:22.514Z] ++ 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
18:47:22 [2020-02-28T18:47:22.880Z] INFO: Testing against a local daemon
18:47:22 [2020-02-28T18:47:22.880Z] === RUN   TestCgroupDriverSystemdMemoryLimit
18:47:22 [2020-02-28T18:47:22.880Z] --- SKIP: TestCgroupDriverSystemdMemoryLimit (0.01s)
18:47:22 [2020-02-28T18:47:22.880Z]     cgroupdriver_systemd_test.go:32: !hasSystemd()
18:47:22 [2020-02-28T18:47:22.880Z] === RUN   TestEventsExecDie
18:47:23 [2020-02-28T18:47:23.626Z] --- PASS: TestEventsExecDie (0.85s)
18:47:23 [2020-02-28T18:47:23.626Z] === RUN   TestEventsBackwardsCompatible
18:47:23 [2020-02-28T18:47:23.626Z] --- PASS: TestEventsBackwardsCompatible (0.08s)
18:47:23 [2020-02-28T18:47:23.626Z] === RUN   TestInfoBinaryCommits
18:47:23 [2020-02-28T18:47:23.626Z] --- PASS: TestInfoBinaryCommits (0.03s)
18:47:23 [2020-02-28T18:47:23.626Z] === RUN   TestInfoAPIVersioned
18:47:23 [2020-02-28T18:47:23.626Z] --- PASS: TestInfoAPIVersioned (0.01s)
18:47:23 [2020-02-28T18:47:23.626Z] === RUN   TestInfoDiscoveryBackend
18:47:24 [2020-02-28T18:47:24.371Z] --- PASS: TestInfoDiscoveryBackend (0.52s)
18:47:24 [2020-02-28T18:47:24.371Z] === RUN   TestInfoDiscoveryInvalidAdvertise
18:47:25 [2020-02-28T18:47:25.112Z] --- PASS: TestInfoDiscoveryInvalidAdvertise (1.00s)
18:47:25 [2020-02-28T18:47:25.112Z] === RUN   TestInfoDiscoveryAdvertiseInterfaceName
18:47:25 [2020-02-28T18:47:25.857Z] --- PASS: TestInfoDiscoveryAdvertiseInterfaceName (0.52s)
18:47:25 [2020-02-28T18:47:25.857Z] === RUN   TestInfoAPI
18:47:25 [2020-02-28T18:47:25.857Z] --- PASS: TestInfoAPI (0.02s)
18:47:25 [2020-02-28T18:47:25.857Z] === RUN   TestInfoAPIWarnings
18:47:26 [2020-02-28T18:47:26.207Z] --- PASS: TestInfoAPIWarnings (0.52s)
18:47:26 [2020-02-28T18:47:26.207Z] === RUN   TestInfoDebug
18:47:26 [2020-02-28T18:47:26.950Z] --- PASS: TestInfoDebug (0.52s)
18:47:26 [2020-02-28T18:47:26.950Z] === RUN   TestInfoInsecureRegistries
18:47:27 [2020-02-28T18:47:27.297Z] --- PASS: TestInfoInsecureRegistries (0.52s)
18:47:27 [2020-02-28T18:47:27.297Z] === RUN   TestInfoRegistryMirrors
18:47:27 [2020-02-28T18:47:27.646Z] --- PASS: TestInfoRegistryMirrors (0.52s)
18:47:27 [2020-02-28T18:47:27.646Z] === RUN   TestLoginFailsWithBadCredentials
18:47:28 [2020-02-28T18:47:28.012Z] --- PASS: TestLoginFailsWithBadCredentials (0.30s)
18:47:28 [2020-02-28T18:47:28.012Z] === RUN   TestPingCacheHeaders
18:47:28 [2020-02-28T18:47:28.012Z] --- PASS: TestPingCacheHeaders (0.02s)
18:47:28 [2020-02-28T18:47:28.012Z] === RUN   TestPingGet
18:47:28 [2020-02-28T18:47:28.012Z] --- PASS: TestPingGet (0.02s)
18:47:28 [2020-02-28T18:47:28.012Z] === RUN   TestPingHead
18:47:28 [2020-02-28T18:47:28.012Z] --- PASS: TestPingHead (0.02s)
18:47:28 [2020-02-28T18:47:28.012Z] === RUN   TestVersion
18:47:28 [2020-02-28T18:47:28.385Z] --- PASS: TestVersion (0.04s)
18:47:28 [2020-02-28T18:47:28.385Z] PASS
18:47:28 [2020-02-28T18:47:28.385Z] 
18:47:28 [2020-02-28T18:47:28.385Z] === Skipped
18:47:28 [2020-02-28T18:47:28.385Z] === SKIP: s390x.integration.system TestCgroupDriverSystemdMemoryLimit (0.01s)
18:47:28 [2020-02-28T18:47:28.385Z]     cgroupdriver_systemd_test.go:32: !hasSystemd()
18:47:28 [2020-02-28T18:47:28.385Z] 
18:47:28 [2020-02-28T18:47:28.385Z] 
18:47:28 [2020-02-28T18:47:28.385Z] DONE 18 tests, 1 skipped in 5.686s
18:47:28 [2020-02-28T18:47:28.385Z] Running /go/src/github.com/docker/docker/integration/volume (s390x.integration.volume) flags=-test.v -test.timeout=120m 
18:47:28 [2020-02-28T18:47:28.385Z] ++ 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
18:47:28 [2020-02-28T18:47:28.385Z] ++ set -e
18:47:28 [2020-02-28T18:47:28.385Z] ++ '[' -n 0 ']'
18:47:28 [2020-02-28T18:47:28.385Z] ++ set -x
18:47:28 [2020-02-28T18:47:28.385Z] ++ 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
18:47:28 [2020-02-28T18:47:28.385Z] INFO: Testing against a local daemon
18:47:28 [2020-02-28T18:47:28.385Z] === RUN   TestVolumesCreateAndList
18:47:28 [2020-02-28T18:47:28.385Z] --- PASS: TestVolumesCreateAndList (0.02s)
18:47:28 [2020-02-28T18:47:28.385Z] === RUN   TestVolumesRemove
18:47:28 [2020-02-28T18:47:28.385Z] --- PASS: TestVolumesRemove (0.10s)
18:47:28 [2020-02-28T18:47:28.385Z] === RUN   TestVolumesInspect
18:47:28 [2020-02-28T18:47:28.385Z] --- PASS: TestVolumesInspect (0.01s)
18:47:28 [2020-02-28T18:47:28.385Z] === RUN   TestVolumesInvalidJSON
18:47:28 [2020-02-28T18:47:28.385Z] === RUN   TestVolumesInvalidJSON//volumes/create
18:47:28 [2020-02-28T18:47:28.385Z] === PAUSE TestVolumesInvalidJSON//volumes/create
18:47:28 [2020-02-28T18:47:28.385Z] === CONT  TestVolumesInvalidJSON//volumes/create
18:47:28 [2020-02-28T18:47:28.385Z] --- PASS: TestVolumesInvalidJSON (0.01s)
18:47:28 [2020-02-28T18:47:28.385Z]     --- PASS: TestVolumesInvalidJSON//volumes/create (0.00s)
18:47:28 [2020-02-28T18:47:28.385Z] PASS
18:47:28 [2020-02-28T18:47:28.385Z] 
18:47:28 [2020-02-28T18:47:28.385Z] DONE 5 tests in 0.259s
18:47:28 [2020-02-28T18:47:28.385Z] ---> Making bundle: .integration-daemon-stop (in bundles/test-integration)
18:47:28 [2020-02-28T18:47:28.790Z] ++++ cat bundles/test-integration/docker.pid
18:47:28 [2020-02-28T18:47:28.790Z] +++ kill 11663
18:47:30 [2020-02-28T18:47:30.130Z] +++ /etc/init.d/apparmor stop
18:47:30 [2020-02-28T18:47:30.130Z] Leaving: AppArmorNo profiles have been unloaded.
18:47:30 [2020-02-28T18:47:30.130Z] 
18:47:30 [2020-02-28T18:47:30.130Z] Unloading profiles will leave already running processes permanently
18:47:30 [2020-02-28T18:47:30.130Z] unconfined, which can lead to unexpected situations.
18:47:30 [2020-02-28T18:47:30.130Z] 
18:47:30 [2020-02-28T18:47:30.130Z] To set a process to complain mode, use the command line tool
18:47:30 [2020-02-28T18:47:30.130Z] 'aa-complain'. To really tear down all profiles, run 'aa-teardown'."
18:47:30 [2020-02-28T18:47:30.130Z] +++ true
18:47:30 [2020-02-28T18:47:30.130Z]