Skip to content

Console Output

22:52:35 [2019-10-17T22:52:35.325Z] + docker run --rm -t --privileged -v /home/jenkins/workspace/moby_PR-39964/bundles:/go/src/github.com/docker/docker/bundles --name docker-pr9 -e DOCKER_EXPERIMENTAL -e DOCKER_GITCOMMIT=75e3238507a4de03612c90c621db5648709126a9 -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:75e3238507a4de03612c90c621db5648709126a9 hack/make.sh dynbinary test-integration
22:52:35 [2019-10-17T22:52:35.325Z] 
22:52:35 [2019-10-17T22:52:35.325Z] Removing bundles/
22:52:35 [2019-10-17T22:52:35.325Z] 
22:52:35 [2019-10-17T22:52:35.325Z] ---> Making bundle: dynbinary (in bundles/dynbinary)
22:52:35 [2019-10-17T22:52:35.325Z] Building: bundles/dynbinary-daemon/dockerd-dev
22:52:35 [2019-10-17T22:52:35.325Z] GOOS="" GOARCH="" GOARM=""
22:53:34 [2019-10-17T22:53:34.184Z] Created binary: bundles/dynbinary-daemon/dockerd-dev
22:53:34 [2019-10-17T22:53:34.184Z] 
22:53:34 [2019-10-17T22:53:34.184Z] ---> Making bundle: test-integration (in bundles/test-integration)
22:53:34 [2019-10-17T22:53:34.574Z] PKG_CONFIG=pkg-config
22:53:34 [2019-10-17T22:53:34.574Z] GOLANG_VERSION=1.13.1
22:53:34 [2019-10-17T22:53:34.574Z] HOSTNAME=41f173415944
22:53:34 [2019-10-17T22:53:34.574Z] DOCKER_EXPERIMENTAL=1
22:53:34 [2019-10-17T22:53:34.574Z] container=docker
22:53:34 [2019-10-17T22:53:34.574Z] TEST_SKIP_INTEGRATION_CLI=1
22:53:34 [2019-10-17T22:53:34.574Z] GO111MODULE=off
22:53:34 [2019-10-17T22:53:34.574Z] GOPATH=/go
22:53:34 [2019-10-17T22:53:34.574Z] PWD=/go/src/github.com/docker/docker
22:53:34 [2019-10-17T22:53:34.574Z] HOME=/root
22:53:34 [2019-10-17T22:53:34.574Z] VALIDATE_REPO=https://github.com/moby/moby.git
22:53:34 [2019-10-17T22:53:34.574Z] SCRIPTDIR=/go/src/github.com/docker/docker/hack
22:53:34 [2019-10-17T22:53:34.574Z] MAKEDIR=/go/src/github.com/docker/docker/hack/make
22:53:34 [2019-10-17T22:53:34.574Z] DOCKER_GITCOMMIT=75e3238507a4de03612c90c621db5648709126a9
22:53:34 [2019-10-17T22:53:34.574Z] DOCKER_BUILDTAGS=apparmor seccomp selinux journald
22:53:34 [2019-10-17T22:53:34.574Z] DOCKER_GRAPHDRIVER=overlay2
22:53:34 [2019-10-17T22:53:34.574Z] TERM=xterm
22:53:34 [2019-10-17T22:53:34.574Z] VALIDATE_BRANCH=master
22:53:34 [2019-10-17T22:53:34.574Z] DEST=bundles/test-integration
22:53:34 [2019-10-17T22:53:34.574Z] SHLVL=1
22:53:34 [2019-10-17T22:53:34.574Z] TIMEOUT=120m
22:53:34 [2019-10-17T22:53:34.574Z] PATH=/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
22:53:34 [2019-10-17T22:53:34.574Z] DOCKER_PKG=github.com/docker/docker
22:53:34 [2019-10-17T22:53:34.574Z] TESTDEBUG=0
22:53:34 [2019-10-17T22:53:34.574Z] _=/usr/bin/env
22:53:34 [2019-10-17T22:53:34.574Z] Building test suite binary /go/src/github.com/docker/docker/integration/build/test.main
22:54:09 [2019-10-17T22:54:09.336Z] Building test suite binary /go/src/github.com/docker/docker/integration/config/test.main
22:54:09 [2019-10-17T22:54:09.336Z] Building test suite binary /go/src/github.com/docker/docker/integration/container/test.main
22:54:09 [2019-10-17T22:54:09.742Z] Building test suite binary /go/src/github.com/docker/docker/integration/image/test.main
22:54:34 [2019-10-17T22:54:34.353Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/test.main
22:54:35 [2019-10-17T22:54:35.733Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/ipvlan/test.main
22:54:37 [2019-10-17T22:54:37.133Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/macvlan/test.main
22:54:38 [2019-10-17T22:54:38.513Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/test.main
22:54:38 [2019-10-17T22:54:38.930Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/authz/test.main
22:54:41 [2019-10-17T22:54:41.268Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/common/test.main
22:54:42 [2019-10-17T22:54:42.702Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/graphdriver/test.main
22:54:44 [2019-10-17T22:54:44.649Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/logging/test.main
22:54:47 [2019-10-17T22:54:47.271Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/volumes/test.main
22:54:49 [2019-10-17T22:54:49.354Z] Building test suite binary /go/src/github.com/docker/docker/integration/secret/test.main
22:54:50 [2019-10-17T22:54:50.746Z] Building test suite binary /go/src/github.com/docker/docker/integration/service/test.main
22:54:53 [2019-10-17T22:54:53.397Z] Building test suite binary /go/src/github.com/docker/docker/integration/session/test.main
22:54:54 [2019-10-17T22:54:54.270Z] Building test suite binary /go/src/github.com/docker/docker/integration/system/test.main
22:54:55 [2019-10-17T22:54:55.611Z] Building test suite binary /go/src/github.com/docker/docker/integration/volume/test.main
22:54:57 [2019-10-17T22:54:57.020Z] ---> Making bundle: .integration-daemon-start (in bundles/test-integration)
22:54:57 [2019-10-17T22:54:57.020Z] Using test binary docker
22:54:57 [2019-10-17T22:54:57.459Z] # DOCKER_EXPERIMENTAL is set: starting daemon with experimental features enabled! 
22:54:57 [2019-10-17T22:54:57.459Z] +++ /etc/init.d/apparmor start
22:54:57 [2019-10-17T22:54:57.459Z] /etc/init.d/apparmor: 130: /etc/init.d/apparmor: systemd-detect-virt: not found
22:54:57 [2019-10-17T22:54:57.459Z] Starting AppArmor profiles:Warning from stdin (line 1): /sbin/apparmor_parser: cannot use or update cache, disable, or force-complain via stdin
22:54:57 [2019-10-17T22:54:57.459Z] Warning failed to create cache: (null)
22:54:57 [2019-10-17T22:54:57.459Z] .
22:54:57 [2019-10-17T22:54:57.459Z] Starting dockerd
22:54:57 [2019-10-17T22:54:57.459Z] INFO: Waiting for daemon to start...
22:54:57 [2019-10-17T22:54:57.459Z] +++ 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
22:54:59 [2019-10-17T22:54:59.652Z] .
22:54:59 [2019-10-17T22:54:59.652Z] ---> Making bundle: .integration-daemon-setup (in bundles/test-integration)
22:54:59 [2019-10-17T22:54:59.652Z] ---> Making bundle: .ensure-emptyfs (in bundles/test-integration)
22:54:59 [2019-10-17T22:54:59.652Z] Error: No such image: emptyfs
22:54:59 [2019-10-17T22:54:59.652Z] ++++ docker load
22:54:59 [2019-10-17T22:54:59.652Z] ++++ tar -cC bundles/test-integration/emptyfs .
22:55:00 [2019-10-17T22:55:00.225Z] Running integration-test (iteration 1)
22:55:00 [2019-10-17T22:55:00.225Z] Running /go/src/github.com/docker/docker/integration/build (s390x.integration.build) flags=-test.v -test.timeout=120m 
22:55:00 [2019-10-17T22:55:00.225Z] ++ 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
22:55:00 [2019-10-17T22:55:00.225Z] ++ set -e
22:55:00 [2019-10-17T22:55:00.225Z] ++ '[' -n 0 ']'
22:55:00 [2019-10-17T22:55:00.225Z] ++ set -x
22:55:00 [2019-10-17T22:55:00.225Z] ++ 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
22:55:12 [2019-10-17T22:55:12.190Z] Loaded image: buildpack-deps:jessie
22:55:12 [2019-10-17T22:55:12.190Z] Loaded image: busybox:latest
22:55:12 [2019-10-17T22:55:12.190Z] Loaded image: busybox:glibc
22:55:12 [2019-10-17T22:55:12.190Z] Loaded image: debian:jessie
22:55:12 [2019-10-17T22:55:12.190Z] Loaded image: hello-world:latest
22:55:12 [2019-10-17T22:55:12.190Z] INFO: Testing against a local daemon
22:55:12 [2019-10-17T22:55:12.190Z] === RUN   TestCgroupNamespacesBuild
22:55:14 [2019-10-17T22:55:14.180Z] --- PASS: TestCgroupNamespacesBuild (1.91s)
22:55:14 [2019-10-17T22:55:14.180Z]     build_cgroupns_linux_test.go:42: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesBuild"
22:55:14 [2019-10-17T22:55:14.180Z] === RUN   TestCgroupNamespacesBuildDaemonHostMode
22:55:15 [2019-10-17T22:55:15.574Z] --- PASS: TestCgroupNamespacesBuildDaemonHostMode (1.83s)
22:55:15 [2019-10-17T22:55:15.574Z]     build_cgroupns_linux_test.go:42: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesBuildDaemonHostMode"
22:55:15 [2019-10-17T22:55:15.574Z] === RUN   TestBuildWithSession
22:55:15 [2019-10-17T22:55:15.574Z] --- SKIP: TestBuildWithSession (0.00s)
22:55:15 [2019-10-17T22:55:15.574Z]     build_session_test.go:25: TODO: BuildKit
22:55:15 [2019-10-17T22:55:15.574Z] === RUN   TestBuildSquashParent
22:55:24 [2019-10-17T22:55:24.004Z] --- PASS: TestBuildSquashParent (7.42s)
22:55:24 [2019-10-17T22:55:24.004Z] === RUN   TestBuildWithRemoveAndForceRemove
22:55:24 [2019-10-17T22:55:24.004Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
22:55:24 [2019-10-17T22:55:24.004Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
22:55:24 [2019-10-17T22:55:24.004Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_remove
22:55:24 [2019-10-17T22:55:24.004Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_remove
22:55:24 [2019-10-17T22:55:24.004Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
22:55:24 [2019-10-17T22:55:24.004Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
22:55:24 [2019-10-17T22:55:24.004Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
22:55:24 [2019-10-17T22:55:24.004Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
22:55:24 [2019-10-17T22:55:24.004Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_remove
22:55:24 [2019-10-17T22:55:24.004Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_remove
22:55:24 [2019-10-17T22:55:24.004Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
22:55:24 [2019-10-17T22:55:24.004Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
22:55:24 [2019-10-17T22:55:24.004Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
22:55:24 [2019-10-17T22:55:24.004Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
22:55:26 [2019-10-17T22:55:26.580Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_remove
22:55:26 [2019-10-17T22:55:26.580Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
22:55:29 [2019-10-17T22:55:29.186Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
22:55:29 [2019-10-17T22:55:29.186Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_remove
22:55:31 [2019-10-17T22:55:31.588Z] --- PASS: TestBuildWithRemoveAndForceRemove (0.01s)
22:55:31 [2019-10-17T22:55:31.588Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal (3.17s)
22:55:31 [2019-10-17T22:55:31.588Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove (3.27s)
22:55:31 [2019-10-17T22:55:31.588Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_remove (2.89s)
22:55:31 [2019-10-17T22:55:31.588Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal (2.89s)
22:55:31 [2019-10-17T22:55:31.588Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove (2.49s)
22:55:31 [2019-10-17T22:55:31.588Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_remove (2.50s)
22:55:31 [2019-10-17T22:55:31.588Z] === RUN   TestBuildMultiStageCopy
22:55:31 [2019-10-17T22:55:31.588Z] === RUN   TestBuildMultiStageCopy/copy_to_root
22:55:34 [2019-10-17T22:55:34.881Z] === RUN   TestBuildMultiStageCopy/copy_to_newdir
22:55:34 [2019-10-17T22:55:34.881Z] === RUN   TestBuildMultiStageCopy/copy_to_newdir_nested
22:55:35 [2019-10-17T22:55:35.273Z] === RUN   TestBuildMultiStageCopy/copy_to_existingdir
22:55:36 [2019-10-17T22:55:36.580Z] === RUN   TestBuildMultiStageCopy/copy_to_newsubdir
22:55:36 [2019-10-17T22:55:36.962Z] --- PASS: TestBuildMultiStageCopy (5.32s)
22:55:36 [2019-10-17T22:55:36.962Z]     --- PASS: TestBuildMultiStageCopy/copy_to_root (2.67s)
22:55:36 [2019-10-17T22:55:36.962Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newdir (0.49s)
22:55:36 [2019-10-17T22:55:36.962Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newdir_nested (0.51s)
22:55:36 [2019-10-17T22:55:36.962Z]     --- PASS: TestBuildMultiStageCopy/copy_to_existingdir (0.91s)
22:55:36 [2019-10-17T22:55:36.963Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newsubdir (0.74s)
22:55:36 [2019-10-17T22:55:36.963Z] === RUN   TestBuildMultiStageParentConfig
22:55:39 [2019-10-17T22:55:39.077Z] --- PASS: TestBuildMultiStageParentConfig (1.59s)
22:55:39 [2019-10-17T22:55:39.077Z] === RUN   TestBuildLabelWithTargets
22:55:41 [2019-10-17T22:55:41.731Z] --- PASS: TestBuildLabelWithTargets (2.77s)
22:55:41 [2019-10-17T22:55:41.731Z] === RUN   TestBuildWithEmptyLayers
22:55:42 [2019-10-17T22:55:42.559Z] --- PASS: TestBuildWithEmptyLayers (1.04s)
22:55:42 [2019-10-17T22:55:42.559Z] === RUN   TestBuildMultiStageOnBuild
22:55:45 [2019-10-17T22:55:45.889Z] --- PASS: TestBuildMultiStageOnBuild (2.99s)
22:55:45 [2019-10-17T22:55:45.889Z] === RUN   TestBuildUncleanTarFilenames
22:55:46 [2019-10-17T22:55:46.717Z] --- PASS: TestBuildUncleanTarFilenames (1.29s)
22:55:46 [2019-10-17T22:55:46.717Z] === RUN   TestBuildMultiStageLayerLeak
22:55:51 [2019-10-17T22:55:51.126Z] --- PASS: TestBuildMultiStageLayerLeak (3.74s)
22:55:51 [2019-10-17T22:55:51.126Z] === RUN   TestBuildWithHugeFile
22:56:33 [2019-10-17T22:56:33.113Z] --- PASS: TestBuildWithHugeFile (40.09s)
22:56:33 [2019-10-17T22:56:33.113Z] === RUN   TestBuildWithEmptyDockerfile
22:56:33 [2019-10-17T22:56:33.113Z] === RUN   TestBuildWithEmptyDockerfile/empty-dockerfile
22:56:33 [2019-10-17T22:56:33.113Z] === PAUSE TestBuildWithEmptyDockerfile/empty-dockerfile
22:56:33 [2019-10-17T22:56:33.113Z] === RUN   TestBuildWithEmptyDockerfile/empty-lines-dockerfile
22:56:33 [2019-10-17T22:56:33.113Z] === PAUSE TestBuildWithEmptyDockerfile/empty-lines-dockerfile
22:56:33 [2019-10-17T22:56:33.113Z] === RUN   TestBuildWithEmptyDockerfile/comment-only-dockerfile
22:56:33 [2019-10-17T22:56:33.113Z] === PAUSE TestBuildWithEmptyDockerfile/comment-only-dockerfile
22:56:33 [2019-10-17T22:56:33.113Z] === CONT  TestBuildWithEmptyDockerfile/empty-dockerfile
22:56:33 [2019-10-17T22:56:33.113Z] === CONT  TestBuildWithEmptyDockerfile/comment-only-dockerfile
22:56:33 [2019-10-17T22:56:33.113Z] === CONT  TestBuildWithEmptyDockerfile/empty-lines-dockerfile
22:56:33 [2019-10-17T22:56:33.113Z] --- PASS: TestBuildWithEmptyDockerfile (0.05s)
22:56:33 [2019-10-17T22:56:33.113Z]     --- PASS: TestBuildWithEmptyDockerfile/comment-only-dockerfile (0.20s)
22:56:33 [2019-10-17T22:56:33.113Z]     --- PASS: TestBuildWithEmptyDockerfile/empty-dockerfile (0.23s)
22:56:33 [2019-10-17T22:56:33.113Z]     --- PASS: TestBuildWithEmptyDockerfile/empty-lines-dockerfile (0.13s)
22:56:33 [2019-10-17T22:56:33.113Z] === RUN   TestBuildPreserveOwnership
22:56:33 [2019-10-17T22:56:33.113Z] === RUN   TestBuildPreserveOwnership/copy_from
22:56:35 [2019-10-17T22:56:35.704Z] === RUN   TestBuildPreserveOwnership/copy_from_chowned
22:56:38 [2019-10-17T22:56:38.376Z] --- PASS: TestBuildPreserveOwnership (6.85s)
22:56:38 [2019-10-17T22:56:38.376Z]     --- PASS: TestBuildPreserveOwnership/copy_from (4.32s)
22:56:38 [2019-10-17T22:56:38.376Z]     --- PASS: TestBuildPreserveOwnership/copy_from_chowned (2.52s)
22:56:38 [2019-10-17T22:56:38.376Z] === RUN   TestBuildPlatformInvalid
22:56:38 [2019-10-17T22:56:38.376Z] --- PASS: TestBuildPlatformInvalid (0.19s)
22:56:38 [2019-10-17T22:56:38.376Z] PASS
22:56:38 [2019-10-17T22:56:38.376Z] 
22:56:38 [2019-10-17T22:56:38.376Z] === Skipped
22:56:38 [2019-10-17T22:56:38.376Z] === SKIP: s390x.integration.build TestBuildWithSession (0.00s)
22:56:38 [2019-10-17T22:56:38.376Z]     build_session_test.go:25: TODO: BuildKit
22:56:38 [2019-10-17T22:56:38.376Z] 
22:56:38 [2019-10-17T22:56:38.376Z] 
22:56:38 [2019-10-17T22:56:38.376Z] DONE 32 tests, 1 skipped in 98.137s
22:56:38 [2019-10-17T22:56:38.376Z] Running /go/src/github.com/docker/docker/integration/config (s390x.integration.config) flags=-test.v -test.timeout=120m 
22:56:38 [2019-10-17T22:56:38.376Z] ++ 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
22:56:38 [2019-10-17T22:56:38.376Z] ++ set -e
22:56:38 [2019-10-17T22:56:38.376Z] ++ '[' -n 0 ']'
22:56:38 [2019-10-17T22:56:38.376Z] ++ set -x
22:56:38 [2019-10-17T22:56:38.376Z] ++ 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
22:56:38 [2019-10-17T22:56:38.376Z] INFO: Testing against a local daemon
22:56:38 [2019-10-17T22:56:38.376Z] === RUN   TestConfigList
22:56:42 [2019-10-17T22:56:42.171Z] --- PASS: TestConfigList (3.88s)
22:56:42 [2019-10-17T22:56:42.171Z]     config_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigList"
22:56:42 [2019-10-17T22:56:42.171Z] === RUN   TestConfigsCreateAndDelete
22:56:45 [2019-10-17T22:56:45.726Z] --- PASS: TestConfigsCreateAndDelete (3.44s)
22:56:45 [2019-10-17T22:56:45.726Z]     config_test.go:112: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigsCreateAndDelete"
22:56:45 [2019-10-17T22:56:45.726Z] === RUN   TestConfigsUpdate
22:56:48 [2019-10-17T22:56:48.352Z] --- PASS: TestConfigsUpdate (2.70s)
22:56:48 [2019-10-17T22:56:48.352Z]     config_test.go:140: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigsUpdate"
22:56:48 [2019-10-17T22:56:48.352Z] === RUN   TestTemplatedConfig
22:56:52 [2019-10-17T22:56:52.642Z] --- PASS: TestTemplatedConfig (3.94s)
22:56:52 [2019-10-17T22:56:52.642Z]     config_test.go:192: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestTemplatedConfig"
22:56:52 [2019-10-17T22:56:52.642Z] === RUN   TestConfigInspect
22:56:55 [2019-10-17T22:56:55.427Z] --- PASS: TestConfigInspect (3.11s)
22:56:55 [2019-10-17T22:56:55.427Z]     config_test.go:326: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigInspect"
22:56:55 [2019-10-17T22:56:55.427Z] === RUN   TestConfigCreateWithLabels
22:56:58 [2019-10-17T22:56:58.949Z] --- PASS: TestConfigCreateWithLabels (3.21s)
22:56:58 [2019-10-17T22:56:58.949Z]     config_test.go:350: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigCreateWithLabels"
22:56:58 [2019-10-17T22:56:58.949Z] === RUN   TestConfigCreateResolve
22:57:01 [2019-10-17T22:57:01.519Z] --- PASS: TestConfigCreateResolve (3.05s)
22:57:01 [2019-10-17T22:57:01.519Z]     config_test.go:377: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigCreateResolve"
22:57:01 [2019-10-17T22:57:01.519Z] === RUN   TestConfigDaemonLibtrustID
22:57:02 [2019-10-17T22:57:02.410Z] --- PASS: TestConfigDaemonLibtrustID (0.57s)
22:57:02 [2019-10-17T22:57:02.410Z]     config_test.go:427: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigDaemonLibtrustID"
22:57:02 [2019-10-17T22:57:02.410Z] PASS
22:57:02 [2019-10-17T22:57:02.410Z] 
22:57:02 [2019-10-17T22:57:02.410Z] DONE 8 tests in 24.026s
22:57:02 [2019-10-17T22:57:02.410Z] Running /go/src/github.com/docker/docker/integration/container (s390x.integration.container) flags=-test.v -test.timeout=120m 
22:57:02 [2019-10-17T22:57:02.410Z] ++ 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
22:57:02 [2019-10-17T22:57:02.410Z] ++ set -e
22:57:02 [2019-10-17T22:57:02.410Z] ++ '[' -n 0 ']'
22:57:02 [2019-10-17T22:57:02.410Z] ++ set -x
22:57:02 [2019-10-17T22:57:02.410Z] ++ 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
22:57:02 [2019-10-17T22:57:02.410Z] INFO: Testing against a local daemon
22:57:02 [2019-10-17T22:57:02.410Z] === RUN   TestCheckpoint
22:57:02 [2019-10-17T22:57:02.410Z] --- SKIP: TestCheckpoint (0.00s)
22:57:02 [2019-10-17T22:57:02.410Z]     checkpoint_test.go:33: TestCheckpoint is broken; see https://github.com/moby/moby/issues/38963
22:57:02 [2019-10-17T22:57:02.410Z] === RUN   TestContainerInvalidJSON
22:57:02 [2019-10-17T22:57:02.410Z] === RUN   TestContainerInvalidJSON//containers/foobar/copy
22:57:02 [2019-10-17T22:57:02.410Z] === PAUSE TestContainerInvalidJSON//containers/foobar/copy
22:57:02 [2019-10-17T22:57:02.410Z] === RUN   TestContainerInvalidJSON//containers/foobar/exec
22:57:02 [2019-10-17T22:57:02.410Z] === PAUSE TestContainerInvalidJSON//containers/foobar/exec
22:57:02 [2019-10-17T22:57:02.410Z] === RUN   TestContainerInvalidJSON//exec/foobar/start
22:57:02 [2019-10-17T22:57:02.410Z] === PAUSE TestContainerInvalidJSON//exec/foobar/start
22:57:02 [2019-10-17T22:57:02.410Z] === CONT  TestContainerInvalidJSON//containers/foobar/copy
22:57:02 [2019-10-17T22:57:02.410Z] === CONT  TestContainerInvalidJSON//exec/foobar/start
22:57:02 [2019-10-17T22:57:02.410Z] === CONT  TestContainerInvalidJSON//containers/foobar/exec
22:57:02 [2019-10-17T22:57:02.410Z] --- PASS: TestContainerInvalidJSON (0.03s)
22:57:02 [2019-10-17T22:57:02.410Z]     --- PASS: TestContainerInvalidJSON//containers/foobar/copy (0.00s)
22:57:02 [2019-10-17T22:57:02.410Z]     --- PASS: TestContainerInvalidJSON//exec/foobar/start (0.00s)
22:57:02 [2019-10-17T22:57:02.410Z]     --- PASS: TestContainerInvalidJSON//containers/foobar/exec (0.00s)
22:57:02 [2019-10-17T22:57:02.410Z] === RUN   TestCopyFromContainerPathDoesNotExist
22:57:02 [2019-10-17T22:57:02.410Z] --- PASS: TestCopyFromContainerPathDoesNotExist (0.12s)
22:57:02 [2019-10-17T22:57:02.410Z] === RUN   TestCopyFromContainerPathIsNotDir
22:57:02 [2019-10-17T22:57:02.410Z] --- PASS: TestCopyFromContainerPathIsNotDir (0.13s)
22:57:02 [2019-10-17T22:57:02.410Z] === RUN   TestCopyToContainerPathDoesNotExist
22:57:02 [2019-10-17T22:57:02.832Z] --- PASS: TestCopyToContainerPathDoesNotExist (0.14s)
22:57:02 [2019-10-17T22:57:02.832Z] === RUN   TestCopyToContainerPathIsNotDir
22:57:02 [2019-10-17T22:57:02.832Z] --- PASS: TestCopyToContainerPathIsNotDir (0.10s)
22:57:02 [2019-10-17T22:57:02.832Z] === RUN   TestCopyFromContainer
22:57:05 [2019-10-17T22:57:05.460Z] === RUN   TestCopyFromContainer//
22:57:05 [2019-10-17T22:57:05.460Z] === RUN   TestCopyFromContainer//bar/root
22:57:05 [2019-10-17T22:57:05.461Z] === RUN   TestCopyFromContainer//bar/root/
22:57:05 [2019-10-17T22:57:05.461Z] === RUN   TestCopyFromContainer/bar/quux
22:57:05 [2019-10-17T22:57:05.461Z] === RUN   TestCopyFromContainer/bar/quux/
22:57:05 [2019-10-17T22:57:05.461Z] === RUN   TestCopyFromContainer/bar/quux/baz
22:57:05 [2019-10-17T22:57:05.461Z] === RUN   TestCopyFromContainer/bar/filesymlink
22:57:05 [2019-10-17T22:57:05.877Z] === RUN   TestCopyFromContainer/bar/dirsymlink
22:57:05 [2019-10-17T22:57:05.877Z] === RUN   TestCopyFromContainer/bar/dirsymlink/
22:57:05 [2019-10-17T22:57:05.877Z] === RUN   TestCopyFromContainer/bar/notarget
22:57:06 [2019-10-17T22:57:06.324Z] --- PASS: TestCopyFromContainer (3.28s)
22:57:06 [2019-10-17T22:57:06.324Z]     --- PASS: TestCopyFromContainer// (0.08s)
22:57:06 [2019-10-17T22:57:06.324Z]     --- PASS: TestCopyFromContainer//bar/root (0.13s)
22:57:06 [2019-10-17T22:57:06.324Z]     --- PASS: TestCopyFromContainer//bar/root/ (0.07s)
22:57:06 [2019-10-17T22:57:06.324Z]     --- PASS: TestCopyFromContainer/bar/quux (0.12s)
22:57:06 [2019-10-17T22:57:06.324Z]     --- PASS: TestCopyFromContainer/bar/quux/ (0.09s)
22:57:06 [2019-10-17T22:57:06.324Z]     --- PASS: TestCopyFromContainer/bar/quux/baz (0.12s)
22:57:06 [2019-10-17T22:57:06.324Z]     --- PASS: TestCopyFromContainer/bar/filesymlink (0.10s)
22:57:06 [2019-10-17T22:57:06.324Z]     --- PASS: TestCopyFromContainer/bar/dirsymlink (0.09s)
22:57:06 [2019-10-17T22:57:06.324Z]     --- PASS: TestCopyFromContainer/bar/dirsymlink/ (0.09s)
22:57:06 [2019-10-17T22:57:06.324Z]     --- PASS: TestCopyFromContainer/bar/notarget (0.12s)
22:57:06 [2019-10-17T22:57:06.324Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist
22:57:06 [2019-10-17T22:57:06.324Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
22:57:06 [2019-10-17T22:57:06.324Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
22:57:06 [2019-10-17T22:57:06.324Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
22:57:06 [2019-10-17T22:57:06.324Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
22:57:06 [2019-10-17T22:57:06.324Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/digest
22:57:06 [2019-10-17T22:57:06.324Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/digest
22:57:06 [2019-10-17T22:57:06.324Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
22:57:06 [2019-10-17T22:57:06.324Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/digest
22:57:06 [2019-10-17T22:57:06.324Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
22:57:06 [2019-10-17T22:57:06.324Z] --- PASS: TestCreateFailsWhenIdentifierDoesNotExist (0.03s)
22:57:06 [2019-10-17T22:57:06.324Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/digest (0.00s)
22:57:06 [2019-10-17T22:57:06.324Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag (0.00s)
22:57:06 [2019-10-17T22:57:06.324Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag (0.01s)
22:57:06 [2019-10-17T22:57:06.324Z] === RUN   TestCreateLinkToNonExistingContainer
22:57:06 [2019-10-17T22:57:06.324Z] --- PASS: TestCreateLinkToNonExistingContainer (0.07s)
22:57:06 [2019-10-17T22:57:06.324Z] === RUN   TestCreateWithInvalidEnv
22:57:06 [2019-10-17T22:57:06.324Z] === RUN   TestCreateWithInvalidEnv/0
22:57:06 [2019-10-17T22:57:06.324Z] === PAUSE TestCreateWithInvalidEnv/0
22:57:06 [2019-10-17T22:57:06.324Z] === RUN   TestCreateWithInvalidEnv/1
22:57:06 [2019-10-17T22:57:06.324Z] === PAUSE TestCreateWithInvalidEnv/1
22:57:06 [2019-10-17T22:57:06.324Z] === RUN   TestCreateWithInvalidEnv/2
22:57:06 [2019-10-17T22:57:06.324Z] === PAUSE TestCreateWithInvalidEnv/2
22:57:06 [2019-10-17T22:57:06.324Z] === CONT  TestCreateWithInvalidEnv/0
22:57:06 [2019-10-17T22:57:06.324Z] === CONT  TestCreateWithInvalidEnv/2
22:57:06 [2019-10-17T22:57:06.324Z] === CONT  TestCreateWithInvalidEnv/1
22:57:06 [2019-10-17T22:57:06.324Z] --- PASS: TestCreateWithInvalidEnv (0.01s)
22:57:06 [2019-10-17T22:57:06.324Z]     --- PASS: TestCreateWithInvalidEnv/2 (0.00s)
22:57:06 [2019-10-17T22:57:06.324Z]     --- PASS: TestCreateWithInvalidEnv/1 (0.00s)
22:57:06 [2019-10-17T22:57:06.324Z]     --- PASS: TestCreateWithInvalidEnv/0 (0.00s)
22:57:06 [2019-10-17T22:57:06.324Z] === RUN   TestCreateTmpfsMountsTarget
22:57:06 [2019-10-17T22:57:06.324Z] --- PASS: TestCreateTmpfsMountsTarget (0.01s)
22:57:06 [2019-10-17T22:57:06.324Z] === RUN   TestCreateWithCustomMaskedPaths
22:57:09 [2019-10-17T22:57:09.757Z] --- PASS: TestCreateWithCustomMaskedPaths (3.07s)
22:57:09 [2019-10-17T22:57:09.757Z] === RUN   TestCreateWithCapabilities
22:57:09 [2019-10-17T22:57:09.757Z] === RUN   TestCreateWithCapabilities/no_capabilities
22:57:09 [2019-10-17T22:57:09.757Z] === PAUSE TestCreateWithCapabilities/no_capabilities
22:57:09 [2019-10-17T22:57:09.757Z] === RUN   TestCreateWithCapabilities/empty_capabilities
22:57:09 [2019-10-17T22:57:09.757Z] === PAUSE TestCreateWithCapabilities/empty_capabilities
22:57:09 [2019-10-17T22:57:09.757Z] === RUN   TestCreateWithCapabilities/valid_capabilities
22:57:09 [2019-10-17T22:57:09.757Z] === PAUSE TestCreateWithCapabilities/valid_capabilities
22:57:09 [2019-10-17T22:57:09.757Z] === RUN   TestCreateWithCapabilities/invalid_capabilities
22:57:09 [2019-10-17T22:57:09.757Z] === PAUSE TestCreateWithCapabilities/invalid_capabilities
22:57:09 [2019-10-17T22:57:09.757Z] === RUN   TestCreateWithCapabilities/duplicate_capabilities
22:57:09 [2019-10-17T22:57:09.757Z] === PAUSE TestCreateWithCapabilities/duplicate_capabilities
22:57:09 [2019-10-17T22:57:09.757Z] === RUN   TestCreateWithCapabilities/capabilities_API_v1.39
22:57:09 [2019-10-17T22:57:09.757Z] === PAUSE TestCreateWithCapabilities/capabilities_API_v1.39
22:57:09 [2019-10-17T22:57:09.757Z] === RUN   TestCreateWithCapabilities/empty_capadd
22:57:09 [2019-10-17T22:57:09.757Z] === PAUSE TestCreateWithCapabilities/empty_capadd
22:57:09 [2019-10-17T22:57:09.757Z] === RUN   TestCreateWithCapabilities/empty_capdrop
22:57:09 [2019-10-17T22:57:09.757Z] === PAUSE TestCreateWithCapabilities/empty_capdrop
22:57:09 [2019-10-17T22:57:09.757Z] === RUN   TestCreateWithCapabilities/capadd_capdrop
22:57:09 [2019-10-17T22:57:09.757Z] === PAUSE TestCreateWithCapabilities/capadd_capdrop
22:57:09 [2019-10-17T22:57:09.757Z] === RUN   TestCreateWithCapabilities/conflict_with_capadd
22:57:09 [2019-10-17T22:57:09.757Z] === PAUSE TestCreateWithCapabilities/conflict_with_capadd
22:57:09 [2019-10-17T22:57:09.757Z] === RUN   TestCreateWithCapabilities/conflict_with_capdrop
22:57:09 [2019-10-17T22:57:09.757Z] === PAUSE TestCreateWithCapabilities/conflict_with_capdrop
22:57:09 [2019-10-17T22:57:09.757Z] === CONT  TestCreateWithCapabilities/no_capabilities
22:57:09 [2019-10-17T22:57:09.757Z] === CONT  TestCreateWithCapabilities/conflict_with_capdrop
22:57:09 [2019-10-17T22:57:09.757Z] === CONT  TestCreateWithCapabilities/conflict_with_capadd
22:57:09 [2019-10-17T22:57:09.757Z] === CONT  TestCreateWithCapabilities/capadd_capdrop
22:57:09 [2019-10-17T22:57:09.757Z] === CONT  TestCreateWithCapabilities/empty_capdrop
22:57:09 [2019-10-17T22:57:09.757Z] === CONT  TestCreateWithCapabilities/empty_capadd
22:57:09 [2019-10-17T22:57:09.757Z] === CONT  TestCreateWithCapabilities/capabilities_API_v1.39
22:57:09 [2019-10-17T22:57:09.757Z] === CONT  TestCreateWithCapabilities/duplicate_capabilities
22:57:09 [2019-10-17T22:57:09.757Z] === CONT  TestCreateWithCapabilities/invalid_capabilities
22:57:09 [2019-10-17T22:57:09.757Z] === CONT  TestCreateWithCapabilities/valid_capabilities
22:57:09 [2019-10-17T22:57:09.757Z] === CONT  TestCreateWithCapabilities/empty_capabilities
22:57:10 [2019-10-17T22:57:10.166Z] --- PASS: TestCreateWithCapabilities (0.01s)
22:57:10 [2019-10-17T22:57:10.166Z]     --- PASS: TestCreateWithCapabilities/conflict_with_capdrop (0.00s)
22:57:10 [2019-10-17T22:57:10.166Z]     --- PASS: TestCreateWithCapabilities/conflict_with_capadd (0.00s)
22:57:10 [2019-10-17T22:57:10.166Z]     --- PASS: TestCreateWithCapabilities/no_capabilities (0.32s)
22:57:10 [2019-10-17T22:57:10.166Z]     --- PASS: TestCreateWithCapabilities/capadd_capdrop (0.32s)
22:57:10 [2019-10-17T22:57:10.166Z]     --- PASS: TestCreateWithCapabilities/empty_capadd (0.06s)
22:57:10 [2019-10-17T22:57:10.166Z]     --- PASS: TestCreateWithCapabilities/empty_capdrop (0.07s)
22:57:10 [2019-10-17T22:57:10.166Z]     --- PASS: TestCreateWithCapabilities/capabilities_API_v1.39 (0.06s)
22:57:10 [2019-10-17T22:57:10.166Z]     --- PASS: TestCreateWithCapabilities/duplicate_capabilities (0.06s)
22:57:10 [2019-10-17T22:57:10.166Z]     --- PASS: TestCreateWithCapabilities/invalid_capabilities (0.00s)
22:57:10 [2019-10-17T22:57:10.166Z]     --- PASS: TestCreateWithCapabilities/empty_capabilities (0.28s)
22:57:10 [2019-10-17T22:57:10.166Z]     --- PASS: TestCreateWithCapabilities/valid_capabilities (0.28s)
22:57:10 [2019-10-17T22:57:10.166Z] === RUN   TestCreateWithCustomReadonlyPaths
22:57:12 [2019-10-17T22:57:12.941Z] --- PASS: TestCreateWithCustomReadonlyPaths (2.95s)
22:57:12 [2019-10-17T22:57:12.941Z] === RUN   TestCreateWithInvalidHealthcheckParams
22:57:12 [2019-10-17T22:57:12.941Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
22:57:12 [2019-10-17T22:57:12.941Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
22:57:12 [2019-10-17T22:57:12.941Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
22:57:12 [2019-10-17T22:57:12.941Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
22:57:12 [2019-10-17T22:57:12.942Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
22:57:12 [2019-10-17T22:57:12.942Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
22:57:12 [2019-10-17T22:57:12.942Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
22:57:12 [2019-10-17T22:57:12.942Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
22:57:12 [2019-10-17T22:57:12.942Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
22:57:12 [2019-10-17T22:57:12.942Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
22:57:12 [2019-10-17T22:57:12.942Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
22:57:12 [2019-10-17T22:57:12.942Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
22:57:12 [2019-10-17T22:57:12.942Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
22:57:12 [2019-10-17T22:57:12.942Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
22:57:12 [2019-10-17T22:57:12.942Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
22:57:12 [2019-10-17T22:57:12.942Z] --- PASS: TestCreateWithInvalidHealthcheckParams (0.01s)
22:57:12 [2019-10-17T22:57:12.942Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms (0.01s)
22:57:12 [2019-10-17T22:57:12.942Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s (0.02s)
22:57:12 [2019-10-17T22:57:12.942Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0 (0.01s)
22:57:12 [2019-10-17T22:57:12.942Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms (0.01s)
22:57:12 [2019-10-17T22:57:12.942Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms (0.01s)
22:57:12 [2019-10-17T22:57:12.942Z] === RUN   TestContainerStartOnDaemonRestart
22:57:12 [2019-10-17T22:57:12.942Z] === PAUSE TestContainerStartOnDaemonRestart
22:57:12 [2019-10-17T22:57:12.942Z] === RUN   TestDaemonRestartIpcMode
22:57:12 [2019-10-17T22:57:12.942Z] === PAUSE TestDaemonRestartIpcMode
22:57:12 [2019-10-17T22:57:12.942Z] === RUN   TestDiff
22:57:14 [2019-10-17T22:57:14.036Z] --- PASS: TestDiff (0.94s)
22:57:14 [2019-10-17T22:57:14.036Z] === RUN   TestExecWithCloseStdin
22:57:15 [2019-10-17T22:57:15.360Z] --- PASS: TestExecWithCloseStdin (1.20s)
22:57:15 [2019-10-17T22:57:15.360Z] === RUN   TestExec
22:57:16 [2019-10-17T22:57:16.250Z] --- PASS: TestExec (1.11s)
22:57:16 [2019-10-17T22:57:16.250Z] === RUN   TestExecUser
22:57:17 [2019-10-17T22:57:17.602Z] --- PASS: TestExecUser (1.18s)
22:57:17 [2019-10-17T22:57:17.602Z] === RUN   TestExportContainerAndImportImage
22:57:18 [2019-10-17T22:57:18.603Z] --- PASS: TestExportContainerAndImportImage (1.32s)
22:57:18 [2019-10-17T22:57:18.603Z] === RUN   TestExportContainerAfterDaemonRestart
22:57:20 [2019-10-17T22:57:20.518Z] --- PASS: TestExportContainerAfterDaemonRestart (1.57s)
22:57:20 [2019-10-17T22:57:20.518Z]     export_test.go:63: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestExportContainerAfterDaemonRestart"
22:57:20 [2019-10-17T22:57:20.518Z] === RUN   TestHealthCheckWorkdir
22:57:21 [2019-10-17T22:57:21.653Z] --- PASS: TestHealthCheckWorkdir (1.34s)
22:57:21 [2019-10-17T22:57:21.653Z] === RUN   TestHealthKillContainer
22:57:25 [2019-10-17T22:57:25.101Z] --- PASS: TestHealthKillContainer (3.12s)
22:57:25 [2019-10-17T22:57:25.102Z] === RUN   TestInspectCpusetInConfigPre120
22:57:26 [2019-10-17T22:57:26.035Z] --- PASS: TestInspectCpusetInConfigPre120 (1.00s)
22:57:26 [2019-10-17T22:57:26.035Z] === RUN   TestIpcModeNone
22:57:26 [2019-10-17T22:57:26.936Z] --- PASS: TestIpcModeNone (1.31s)
22:57:26 [2019-10-17T22:57:26.936Z] === RUN   TestIpcModePrivate
22:57:28 [2019-10-17T22:57:28.268Z] --- PASS: TestIpcModePrivate (1.10s)
22:57:28 [2019-10-17T22:57:28.268Z]     ipcmode_linux_test.go:90: [testIpcPrivateShareable] ipcmode: private, ipcdev: 0:64, shared: false, mustBeShared: false
22:57:28 [2019-10-17T22:57:28.268Z] === RUN   TestIpcModeShareable
22:57:29 [2019-10-17T22:57:29.625Z] --- PASS: TestIpcModeShareable (1.25s)
22:57:29 [2019-10-17T22:57:29.625Z]     ipcmode_linux_test.go:90: [testIpcPrivateShareable] ipcmode: shareable, ipcdev: 0:58, shared: true, mustBeShared: true
22:57:29 [2019-10-17T22:57:29.625Z] === RUN   TestAPIIpcModeShareableAndContainer
22:57:33 [2019-10-17T22:57:33.042Z] --- PASS: TestAPIIpcModeShareableAndContainer (3.37s)
22:57:33 [2019-10-17T22:57:33.042Z] === RUN   TestAPIIpcModeHost
22:57:33 [2019-10-17T22:57:33.435Z] --- PASS: TestAPIIpcModeHost (0.80s)
22:57:33 [2019-10-17T22:57:33.435Z] === RUN   TestDaemonIpcModeShareable
22:57:35 [2019-10-17T22:57:35.552Z] --- PASS: TestDaemonIpcModeShareable (1.93s)
22:57:35 [2019-10-17T22:57:35.552Z]     ipcmode_linux_test.go:230: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModeShareable"
22:57:35 [2019-10-17T22:57:35.552Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:66, shared: true, mustBeShared: true
22:57:35 [2019-10-17T22:57:35.552Z] === RUN   TestDaemonIpcModePrivate
22:57:37 [2019-10-17T22:57:37.455Z] --- PASS: TestDaemonIpcModePrivate (1.89s)
22:57:37 [2019-10-17T22:57:37.455Z]     ipcmode_linux_test.go:230: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModePrivate"
22:57:37 [2019-10-17T22:57:37.455Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:72, shared: false, mustBeShared: false
22:57:37 [2019-10-17T22:57:37.455Z] === RUN   TestDaemonIpcModePrivateFromConfig
22:57:39 [2019-10-17T22:57:39.445Z] --- PASS: TestDaemonIpcModePrivateFromConfig (2.00s)
22:57:39 [2019-10-17T22:57:39.446Z]     ipcmode_linux_test.go:230: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModePrivateFromConfig"
22:57:39 [2019-10-17T22:57:39.446Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:72, shared: false, mustBeShared: false
22:57:39 [2019-10-17T22:57:39.446Z] === RUN   TestDaemonIpcModeShareableFromConfig
22:57:42 [2019-10-17T22:57:42.263Z] --- PASS: TestDaemonIpcModeShareableFromConfig (2.60s)
22:57:42 [2019-10-17T22:57:42.263Z]     ipcmode_linux_test.go:230: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModeShareableFromConfig"
22:57:42 [2019-10-17T22:57:42.263Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:66, shared: true, mustBeShared: true
22:57:42 [2019-10-17T22:57:42.263Z] === RUN   TestIpcModeOlderClient
22:57:42 [2019-10-17T22:57:42.263Z] === PAUSE TestIpcModeOlderClient
22:57:42 [2019-10-17T22:57:42.263Z] === RUN   TestKillContainerInvalidSignal
22:57:43 [2019-10-17T22:57:43.243Z] --- PASS: TestKillContainerInvalidSignal (1.02s)
22:57:43 [2019-10-17T22:57:43.243Z] === RUN   TestKillContainer
22:57:43 [2019-10-17T22:57:43.243Z] === RUN   TestKillContainer/no_signal
22:57:44 [2019-10-17T22:57:44.048Z] === RUN   TestKillContainer/non_killing_signal
22:57:44 [2019-10-17T22:57:44.853Z] === RUN   TestKillContainer/killing_signal
22:57:45 [2019-10-17T22:57:45.672Z] --- PASS: TestKillContainer (2.74s)
22:57:45 [2019-10-17T22:57:45.672Z]     --- PASS: TestKillContainer/no_signal (0.98s)
22:57:45 [2019-10-17T22:57:45.672Z]     --- PASS: TestKillContainer/non_killing_signal (0.62s)
22:57:45 [2019-10-17T22:57:45.672Z]     --- PASS: TestKillContainer/killing_signal (0.76s)
22:57:45 [2019-10-17T22:57:45.672Z] === RUN   TestKillWithStopSignalAndRestartPolicies
22:57:45 [2019-10-17T22:57:45.672Z] === RUN   TestKillWithStopSignalAndRestartPolicies/same-signal-disables-restart-policy
22:57:46 [2019-10-17T22:57:46.979Z] === RUN   TestKillWithStopSignalAndRestartPolicies/different-signal-keep-restart-policy
22:57:47 [2019-10-17T22:57:47.806Z] --- PASS: TestKillWithStopSignalAndRestartPolicies (1.92s)
22:57:47 [2019-10-17T22:57:47.806Z]     --- PASS: TestKillWithStopSignalAndRestartPolicies/same-signal-disables-restart-policy (0.99s)
22:57:47 [2019-10-17T22:57:47.806Z]     --- PASS: TestKillWithStopSignalAndRestartPolicies/different-signal-keep-restart-policy (0.53s)
22:57:47 [2019-10-17T22:57:47.806Z] === RUN   TestKillStoppedContainer
22:57:47 [2019-10-17T22:57:47.806Z] --- PASS: TestKillStoppedContainer (0.10s)
22:57:47 [2019-10-17T22:57:47.806Z] === RUN   TestKillStoppedContainerAPIPre120
22:57:47 [2019-10-17T22:57:47.806Z] --- PASS: TestKillStoppedContainerAPIPre120 (0.09s)
22:57:47 [2019-10-17T22:57:47.806Z] === RUN   TestKillDifferentUserContainer
22:57:48 [2019-10-17T22:57:48.750Z] --- PASS: TestKillDifferentUserContainer (1.02s)
22:57:48 [2019-10-17T22:57:48.750Z] === RUN   TestInspectOomKilledTrue
22:57:48 [2019-10-17T22:57:48.750Z] --- SKIP: TestInspectOomKilledTrue (0.01s)
22:57:48 [2019-10-17T22:57:48.750Z]     kill_test.go:151: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
22:57:48 [2019-10-17T22:57:48.750Z] === RUN   TestInspectOomKilledFalse
22:57:48 [2019-10-17T22:57:48.750Z] --- SKIP: TestInspectOomKilledFalse (0.00s)
22:57:48 [2019-10-17T22:57:48.750Z]     kill_test.go:169: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
22:57:48 [2019-10-17T22:57:48.750Z] === RUN   TestLinksEtcHostsContentMatch
22:57:49 [2019-10-17T22:57:49.602Z] --- PASS: TestLinksEtcHostsContentMatch (0.74s)
22:57:49 [2019-10-17T22:57:49.602Z] === RUN   TestLinksContainerNames
22:57:52 [2019-10-17T22:57:52.931Z] --- PASS: TestLinksContainerNames (2.72s)
22:57:52 [2019-10-17T22:57:52.931Z] === RUN   TestLogsFollowTailEmpty
22:57:53 [2019-10-17T22:57:53.345Z] --- PASS: TestLogsFollowTailEmpty (1.04s)
22:57:53 [2019-10-17T22:57:53.345Z] === RUN   TestContainerNetworkMountsNoChown
22:57:54 [2019-10-17T22:57:54.488Z] --- PASS: TestContainerNetworkMountsNoChown (0.96s)
22:57:54 [2019-10-17T22:57:54.488Z] === RUN   TestMountDaemonRoot
22:57:54 [2019-10-17T22:57:54.488Z] === RUN   TestMountDaemonRoot/default
22:57:54 [2019-10-17T22:57:54.488Z] === PAUSE TestMountDaemonRoot/default
22:57:54 [2019-10-17T22:57:54.488Z] === RUN   TestMountDaemonRoot/private
22:57:54 [2019-10-17T22:57:54.488Z] === PAUSE TestMountDaemonRoot/private
22:57:54 [2019-10-17T22:57:54.488Z] === RUN   TestMountDaemonRoot/rprivate
22:57:54 [2019-10-17T22:57:54.488Z] === PAUSE TestMountDaemonRoot/rprivate
22:57:54 [2019-10-17T22:57:54.488Z] === RUN   TestMountDaemonRoot/slave
22:57:54 [2019-10-17T22:57:54.488Z] === PAUSE TestMountDaemonRoot/slave
22:57:54 [2019-10-17T22:57:54.488Z] === RUN   TestMountDaemonRoot/rslave
22:57:54 [2019-10-17T22:57:54.488Z] === PAUSE TestMountDaemonRoot/rslave
22:57:54 [2019-10-17T22:57:54.488Z] === RUN   TestMountDaemonRoot/shared
22:57:54 [2019-10-17T22:57:54.488Z] === PAUSE TestMountDaemonRoot/shared
22:57:54 [2019-10-17T22:57:54.488Z] === RUN   TestMountDaemonRoot/rshared
22:57:54 [2019-10-17T22:57:54.488Z] === PAUSE TestMountDaemonRoot/rshared
22:57:54 [2019-10-17T22:57:54.488Z] === CONT  TestMountDaemonRoot/default
22:57:54 [2019-10-17T22:57:54.488Z] === RUN   TestMountDaemonRoot/default/bind_subpath
22:57:54 [2019-10-17T22:57:54.488Z] === PAUSE TestMountDaemonRoot/default/bind_subpath
22:57:54 [2019-10-17T22:57:54.488Z] === RUN   TestMountDaemonRoot/default/mount_root
22:57:54 [2019-10-17T22:57:54.488Z] === PAUSE TestMountDaemonRoot/default/mount_root
22:57:54 [2019-10-17T22:57:54.488Z] === RUN   TestMountDaemonRoot/default/mount_subpath
22:57:54 [2019-10-17T22:57:54.488Z] === PAUSE TestMountDaemonRoot/default/mount_subpath
22:57:54 [2019-10-17T22:57:54.488Z] === RUN   TestMountDaemonRoot/default/bind_root
22:57:54 [2019-10-17T22:57:54.488Z] === PAUSE TestMountDaemonRoot/default/bind_root
22:57:54 [2019-10-17T22:57:54.488Z] === CONT  TestMountDaemonRoot/default/bind_subpath
22:57:54 [2019-10-17T22:57:54.488Z] === CONT  TestMountDaemonRoot/rshared
22:57:54 [2019-10-17T22:57:54.488Z] === RUN   TestMountDaemonRoot/rshared/bind_root
22:57:54 [2019-10-17T22:57:54.488Z] === PAUSE TestMountDaemonRoot/rshared/bind_root
22:57:54 [2019-10-17T22:57:54.488Z] === RUN   TestMountDaemonRoot/rshared/bind_subpath
22:57:54 [2019-10-17T22:57:54.488Z] === PAUSE TestMountDaemonRoot/rshared/bind_subpath
22:57:54 [2019-10-17T22:57:54.488Z] === RUN   TestMountDaemonRoot/rshared/mount_root
22:57:54 [2019-10-17T22:57:54.488Z] === PAUSE TestMountDaemonRoot/rshared/mount_root
22:57:54 [2019-10-17T22:57:54.488Z] === RUN   TestMountDaemonRoot/rshared/mount_subpath
22:57:54 [2019-10-17T22:57:54.488Z] === PAUSE TestMountDaemonRoot/rshared/mount_subpath
22:57:54 [2019-10-17T22:57:54.488Z] === CONT  TestMountDaemonRoot/rshared/bind_root
22:57:54 [2019-10-17T22:57:54.488Z] === CONT  TestMountDaemonRoot/shared
22:57:54 [2019-10-17T22:57:54.488Z] === RUN   TestMountDaemonRoot/shared/mount_subpath
22:57:54 [2019-10-17T22:57:54.488Z] === PAUSE TestMountDaemonRoot/shared/mount_subpath
22:57:54 [2019-10-17T22:57:54.488Z] === RUN   TestMountDaemonRoot/shared/bind_root
22:57:54 [2019-10-17T22:57:54.488Z] === PAUSE TestMountDaemonRoot/shared/bind_root
22:57:54 [2019-10-17T22:57:54.488Z] === RUN   TestMountDaemonRoot/shared/bind_subpath
22:57:54 [2019-10-17T22:57:54.488Z] === PAUSE TestMountDaemonRoot/shared/bind_subpath
22:57:54 [2019-10-17T22:57:54.488Z] === RUN   TestMountDaemonRoot/shared/mount_root
22:57:54 [2019-10-17T22:57:54.488Z] === PAUSE TestMountDaemonRoot/shared/mount_root
22:57:54 [2019-10-17T22:57:54.488Z] === CONT  TestMountDaemonRoot/rslave
22:57:54 [2019-10-17T22:57:54.488Z] === RUN   TestMountDaemonRoot/rslave/bind_root
22:57:54 [2019-10-17T22:57:54.488Z] === PAUSE TestMountDaemonRoot/rslave/bind_root
22:57:54 [2019-10-17T22:57:54.488Z] === RUN   TestMountDaemonRoot/rslave/bind_subpath
22:57:54 [2019-10-17T22:57:54.488Z] === PAUSE TestMountDaemonRoot/rslave/bind_subpath
22:57:54 [2019-10-17T22:57:54.488Z] === RUN   TestMountDaemonRoot/rslave/mount_root
22:57:54 [2019-10-17T22:57:54.488Z] === PAUSE TestMountDaemonRoot/rslave/mount_root
22:57:54 [2019-10-17T22:57:54.488Z] === RUN   TestMountDaemonRoot/rslave/mount_subpath
22:57:54 [2019-10-17T22:57:54.488Z] === PAUSE TestMountDaemonRoot/rslave/mount_subpath
22:57:54 [2019-10-17T22:57:54.488Z] === CONT  TestMountDaemonRoot/slave
22:57:54 [2019-10-17T22:57:54.488Z] === RUN   TestMountDaemonRoot/slave/bind_root
22:57:54 [2019-10-17T22:57:54.488Z] === PAUSE TestMountDaemonRoot/slave/bind_root
22:57:54 [2019-10-17T22:57:54.488Z] === RUN   TestMountDaemonRoot/slave/bind_subpath
22:57:54 [2019-10-17T22:57:54.488Z] === PAUSE TestMountDaemonRoot/slave/bind_subpath
22:57:54 [2019-10-17T22:57:54.488Z] === RUN   TestMountDaemonRoot/slave/mount_root
22:57:54 [2019-10-17T22:57:54.488Z] === PAUSE TestMountDaemonRoot/slave/mount_root
22:57:54 [2019-10-17T22:57:54.488Z] === RUN   TestMountDaemonRoot/slave/mount_subpath
22:57:54 [2019-10-17T22:57:54.488Z] === PAUSE TestMountDaemonRoot/slave/mount_subpath
22:57:54 [2019-10-17T22:57:54.488Z] === CONT  TestMountDaemonRoot/rprivate
22:57:54 [2019-10-17T22:57:54.488Z] === RUN   TestMountDaemonRoot/rprivate/bind_root
22:57:54 [2019-10-17T22:57:54.488Z] === PAUSE TestMountDaemonRoot/rprivate/bind_root
22:57:54 [2019-10-17T22:57:54.488Z] === RUN   TestMountDaemonRoot/rprivate/bind_subpath
22:57:54 [2019-10-17T22:57:54.488Z] === PAUSE TestMountDaemonRoot/rprivate/bind_subpath
22:57:54 [2019-10-17T22:57:54.488Z] === RUN   TestMountDaemonRoot/rprivate/mount_root
22:57:54 [2019-10-17T22:57:54.488Z] === PAUSE TestMountDaemonRoot/rprivate/mount_root
22:57:54 [2019-10-17T22:57:54.488Z] === RUN   TestMountDaemonRoot/rprivate/mount_subpath
22:57:54 [2019-10-17T22:57:54.488Z] === PAUSE TestMountDaemonRoot/rprivate/mount_subpath
22:57:54 [2019-10-17T22:57:54.488Z] === CONT  TestMountDaemonRoot/private
22:57:54 [2019-10-17T22:57:54.488Z] === RUN   TestMountDaemonRoot/private/bind_root
22:57:54 [2019-10-17T22:57:54.488Z] === PAUSE TestMountDaemonRoot/private/bind_root
22:57:54 [2019-10-17T22:57:54.488Z] === RUN   TestMountDaemonRoot/private/bind_subpath
22:57:54 [2019-10-17T22:57:54.488Z] === PAUSE TestMountDaemonRoot/private/bind_subpath
22:57:54 [2019-10-17T22:57:54.488Z] === RUN   TestMountDaemonRoot/private/mount_root
22:57:54 [2019-10-17T22:57:54.488Z] === PAUSE TestMountDaemonRoot/private/mount_root
22:57:54 [2019-10-17T22:57:54.488Z] === RUN   TestMountDaemonRoot/private/mount_subpath
22:57:54 [2019-10-17T22:57:54.488Z] === PAUSE TestMountDaemonRoot/private/mount_subpath
22:57:54 [2019-10-17T22:57:54.488Z] === CONT  TestMountDaemonRoot/default/bind_root
22:57:54 [2019-10-17T22:57:54.488Z] === CONT  TestMountDaemonRoot/default/mount_subpath
22:57:54 [2019-10-17T22:57:54.488Z] === CONT  TestMountDaemonRoot/default/mount_root
22:57:54 [2019-10-17T22:57:54.488Z] === CONT  TestMountDaemonRoot/rshared/mount_subpath
22:57:54 [2019-10-17T22:57:54.935Z] === CONT  TestMountDaemonRoot/rshared/mount_root
22:57:54 [2019-10-17T22:57:54.935Z] === CONT  TestMountDaemonRoot/rshared/bind_subpath
22:57:54 [2019-10-17T22:57:54.935Z] === CONT  TestMountDaemonRoot/shared/mount_subpath
22:57:54 [2019-10-17T22:57:54.935Z] === CONT  TestMountDaemonRoot/rslave/bind_root
22:57:54 [2019-10-17T22:57:54.935Z] === CONT  TestMountDaemonRoot/shared/mount_root
22:57:54 [2019-10-17T22:57:54.935Z] === CONT  TestMountDaemonRoot/shared/bind_subpath
22:57:54 [2019-10-17T22:57:54.935Z] === CONT  TestMountDaemonRoot/shared/bind_root
22:57:54 [2019-10-17T22:57:54.935Z] === CONT  TestMountDaemonRoot/slave/bind_root
22:57:54 [2019-10-17T22:57:54.935Z] === CONT  TestMountDaemonRoot/rslave/mount_subpath
22:57:54 [2019-10-17T22:57:54.935Z] === CONT  TestMountDaemonRoot/rslave/mount_root
22:57:54 [2019-10-17T22:57:54.935Z] === CONT  TestMountDaemonRoot/rslave/bind_subpath
22:57:54 [2019-10-17T22:57:54.935Z] === CONT  TestMountDaemonRoot/rprivate/bind_root
22:57:55 [2019-10-17T22:57:55.469Z] === CONT  TestMountDaemonRoot/slave/mount_subpath
22:57:55 [2019-10-17T22:57:55.469Z] === CONT  TestMountDaemonRoot/slave/mount_root
22:57:55 [2019-10-17T22:57:55.469Z] === CONT  TestMountDaemonRoot/slave/bind_subpath
22:57:55 [2019-10-17T22:57:55.469Z] === CONT  TestMountDaemonRoot/private/bind_root
22:57:55 [2019-10-17T22:57:55.469Z] === CONT  TestMountDaemonRoot/rprivate/mount_subpath
22:57:55 [2019-10-17T22:57:55.469Z] === CONT  TestMountDaemonRoot/rprivate/mount_root
22:57:55 [2019-10-17T22:57:55.469Z] === CONT  TestMountDaemonRoot/rprivate/bind_subpath
22:57:55 [2019-10-17T22:57:55.469Z] === CONT  TestMountDaemonRoot/private/mount_subpath
22:57:55 [2019-10-17T22:57:55.469Z] === CONT  TestMountDaemonRoot/private/mount_root
22:57:55 [2019-10-17T22:57:55.469Z] === CONT  TestMountDaemonRoot/private/bind_subpath
22:57:55 [2019-10-17T22:57:55.469Z] --- PASS: TestMountDaemonRoot (0.02s)
22:57:55 [2019-10-17T22:57:55.469Z]     --- PASS: TestMountDaemonRoot/default (0.00s)
22:57:55 [2019-10-17T22:57:55.469Z]         --- PASS: TestMountDaemonRoot/default/bind_subpath (0.10s)
22:57:55 [2019-10-17T22:57:55.469Z]         --- PASS: TestMountDaemonRoot/default/bind_root (0.07s)
22:57:55 [2019-10-17T22:57:55.469Z]         --- PASS: TestMountDaemonRoot/default/mount_subpath (0.07s)
22:57:55 [2019-10-17T22:57:55.469Z]         --- PASS: TestMountDaemonRoot/default/mount_root (0.10s)
22:57:55 [2019-10-17T22:57:55.469Z]     --- PASS: TestMountDaemonRoot/rshared (0.00s)
22:57:55 [2019-10-17T22:57:55.469Z]         --- PASS: TestMountDaemonRoot/rshared/bind_root (0.10s)
22:57:55 [2019-10-17T22:57:55.469Z]         --- PASS: TestMountDaemonRoot/rshared/mount_subpath (0.11s)
22:57:55 [2019-10-17T22:57:55.469Z]         --- PASS: TestMountDaemonRoot/rshared/mount_root (0.10s)
22:57:55 [2019-10-17T22:57:55.469Z]         --- PASS: TestMountDaemonRoot/rshared/bind_subpath (0.09s)
22:57:55 [2019-10-17T22:57:55.469Z]     --- PASS: TestMountDaemonRoot/shared (0.00s)
22:57:55 [2019-10-17T22:57:55.469Z]         --- PASS: TestMountDaemonRoot/shared/mount_subpath (0.02s)
22:57:55 [2019-10-17T22:57:55.470Z]         --- PASS: TestMountDaemonRoot/shared/mount_root (0.07s)
22:57:55 [2019-10-17T22:57:55.470Z]         --- PASS: TestMountDaemonRoot/shared/bind_subpath (0.03s)
22:57:55 [2019-10-17T22:57:55.470Z]         --- PASS: TestMountDaemonRoot/shared/bind_root (0.04s)
22:57:55 [2019-10-17T22:57:55.470Z]     --- PASS: TestMountDaemonRoot/rslave (0.00s)
22:57:55 [2019-10-17T22:57:55.470Z]         --- PASS: TestMountDaemonRoot/rslave/bind_root (0.10s)
22:57:55 [2019-10-17T22:57:55.470Z]         --- PASS: TestMountDaemonRoot/rslave/mount_subpath (0.11s)
22:57:55 [2019-10-17T22:57:55.470Z]         --- PASS: TestMountDaemonRoot/rslave/mount_root (0.09s)
22:57:55 [2019-10-17T22:57:55.470Z]         --- PASS: TestMountDaemonRoot/rslave/bind_subpath (0.10s)
22:57:55 [2019-10-17T22:57:55.470Z]     --- PASS: TestMountDaemonRoot/slave (0.00s)
22:57:55 [2019-10-17T22:57:55.470Z]         --- PASS: TestMountDaemonRoot/slave/bind_root (0.07s)
22:57:55 [2019-10-17T22:57:55.470Z]         --- PASS: TestMountDaemonRoot/slave/mount_subpath (0.04s)
22:57:55 [2019-10-17T22:57:55.470Z]         --- PASS: TestMountDaemonRoot/slave/mount_root (0.03s)
22:57:55 [2019-10-17T22:57:55.470Z]         --- PASS: TestMountDaemonRoot/slave/bind_subpath (0.02s)
22:57:55 [2019-10-17T22:57:55.470Z]     --- PASS: TestMountDaemonRoot/rprivate (0.00s)
22:57:55 [2019-10-17T22:57:55.470Z]         --- PASS: TestMountDaemonRoot/rprivate/bind_root (0.06s)
22:57:55 [2019-10-17T22:57:55.470Z]         --- PASS: TestMountDaemonRoot/rprivate/mount_subpath (0.04s)
22:57:55 [2019-10-17T22:57:55.470Z]         --- PASS: TestMountDaemonRoot/rprivate/mount_root (0.05s)
22:57:55 [2019-10-17T22:57:55.470Z]         --- PASS: TestMountDaemonRoot/rprivate/bind_subpath (0.04s)
22:57:55 [2019-10-17T22:57:55.470Z]     --- PASS: TestMountDaemonRoot/private (0.00s)
22:57:55 [2019-10-17T22:57:55.470Z]         --- PASS: TestMountDaemonRoot/private/bind_root (0.03s)
22:57:55 [2019-10-17T22:57:55.470Z]         --- PASS: TestMountDaemonRoot/private/mount_subpath (0.04s)
22:57:55 [2019-10-17T22:57:55.470Z]         --- PASS: TestMountDaemonRoot/private/mount_root (0.05s)
22:57:55 [2019-10-17T22:57:55.470Z]         --- PASS: TestMountDaemonRoot/private/bind_subpath (0.03s)
22:57:55 [2019-10-17T22:57:55.470Z] === RUN   TestContainerBindMountNonRecursive
22:57:57 [2019-10-17T22:57:57.643Z] --- PASS: TestContainerBindMountNonRecursive (2.02s)
22:57:57 [2019-10-17T22:57:57.643Z] === RUN   TestNetworkNat
22:57:58 [2019-10-17T22:57:58.605Z] --- PASS: TestNetworkNat (1.05s)
22:57:58 [2019-10-17T22:57:58.605Z] === RUN   TestNetworkLocalhostTCPNat
22:57:59 [2019-10-17T22:57:59.413Z] --- PASS: TestNetworkLocalhostTCPNat (0.98s)
22:57:59 [2019-10-17T22:57:59.413Z] === RUN   TestNetworkLoopbackNat
22:58:00 [2019-10-17T22:58:00.725Z] --- PASS: TestNetworkLoopbackNat (1.30s)
22:58:00 [2019-10-17T22:58:00.726Z] === RUN   TestPause
22:58:01 [2019-10-17T22:58:01.824Z] --- PASS: TestPause (1.05s)
22:58:01 [2019-10-17T22:58:01.824Z] === RUN   TestPauseFailsOnWindowsServerContainers
22:58:01 [2019-10-17T22:58:01.824Z] --- SKIP: TestPauseFailsOnWindowsServerContainers (0.00s)
22:58:01 [2019-10-17T22:58:01.824Z]     pause_test.go:54: testEnv.DaemonInfo.OSType != "windows" || testEnv.DaemonInfo.Isolation != "process"
22:58:01 [2019-10-17T22:58:01.824Z] === RUN   TestPauseStopPausedContainer
22:58:02 [2019-10-17T22:58:02.637Z] --- PASS: TestPauseStopPausedContainer (0.91s)
22:58:02 [2019-10-17T22:58:02.637Z] === RUN   TestPsFilter
22:58:03 [2019-10-17T22:58:03.040Z] --- PASS: TestPsFilter (0.28s)
22:58:03 [2019-10-17T22:58:03.040Z] === RUN   TestRemoveContainerWithRemovedVolume
22:58:03 [2019-10-17T22:58:03.882Z] --- PASS: TestRemoveContainerWithRemovedVolume (0.91s)
22:58:03 [2019-10-17T22:58:03.882Z] === RUN   TestRemoveContainerWithVolume
22:58:04 [2019-10-17T22:58:04.769Z] --- PASS: TestRemoveContainerWithVolume (1.01s)
22:58:04 [2019-10-17T22:58:04.769Z] === RUN   TestRemoveContainerRunning
22:58:06 [2019-10-17T22:58:06.102Z] --- PASS: TestRemoveContainerRunning (1.01s)
22:58:06 [2019-10-17T22:58:06.102Z] === RUN   TestRemoveContainerForceRemoveRunning
22:58:06 [2019-10-17T22:58:06.937Z] --- PASS: TestRemoveContainerForceRemoveRunning (0.97s)
22:58:06 [2019-10-17T22:58:06.937Z] === RUN   TestRemoveInvalidContainer
22:58:06 [2019-10-17T22:58:06.937Z] --- PASS: TestRemoveInvalidContainer (0.01s)
22:58:06 [2019-10-17T22:58:06.937Z] === RUN   TestRenameLinkedContainer
22:58:11 [2019-10-17T22:58:11.239Z] --- PASS: TestRenameLinkedContainer (3.75s)
22:58:11 [2019-10-17T22:58:11.239Z] === RUN   TestRenameStoppedContainer
22:58:11 [2019-10-17T22:58:11.681Z] --- PASS: TestRenameStoppedContainer (0.92s)
22:58:11 [2019-10-17T22:58:11.681Z] === RUN   TestRenameRunningContainerAndReuse
22:58:13 [2019-10-17T22:58:13.600Z] --- PASS: TestRenameRunningContainerAndReuse (2.06s)
22:58:13 [2019-10-17T22:58:13.601Z] === RUN   TestRenameInvalidName
22:58:14 [2019-10-17T22:58:14.428Z] --- PASS: TestRenameInvalidName (0.96s)
22:58:14 [2019-10-17T22:58:14.428Z] === RUN   TestRenameAnonymousContainer
22:58:17 [2019-10-17T22:58:17.754Z] --- PASS: TestRenameAnonymousContainer (3.14s)
22:58:17 [2019-10-17T22:58:17.754Z] === RUN   TestRenameContainerWithSameName
22:58:18 [2019-10-17T22:58:18.594Z] --- PASS: TestRenameContainerWithSameName (0.96s)
22:58:18 [2019-10-17T22:58:18.594Z] === RUN   TestRenameContainerWithLinkedContainer
22:58:20 [2019-10-17T22:58:20.515Z] --- PASS: TestRenameContainerWithLinkedContainer (1.80s)
22:58:20 [2019-10-17T22:58:20.515Z] === RUN   TestResize
22:58:21 [2019-10-17T22:58:21.738Z] --- PASS: TestResize (1.10s)
22:58:21 [2019-10-17T22:58:21.738Z] === RUN   TestResizeWithInvalidSize
22:58:22 [2019-10-17T22:58:22.663Z] --- PASS: TestResizeWithInvalidSize (1.14s)
22:58:22 [2019-10-17T22:58:22.663Z] === RUN   TestResizeWhenContainerNotStarted
22:58:23 [2019-10-17T22:58:23.635Z] --- PASS: TestResizeWhenContainerNotStarted (1.14s)
22:58:23 [2019-10-17T22:58:23.635Z] === RUN   TestDaemonRestartKillContainers
22:58:23 [2019-10-17T22:58:23.635Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
22:58:23 [2019-10-17T22:58:23.635Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
22:58:23 [2019-10-17T22:58:23.635Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
22:58:23 [2019-10-17T22:58:23.635Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
22:58:23 [2019-10-17T22:58:23.635Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
22:58:23 [2019-10-17T22:58:23.635Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
22:58:23 [2019-10-17T22:58:23.635Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
22:58:23 [2019-10-17T22:58:23.635Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
22:58:23 [2019-10-17T22:58:23.635Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
22:58:23 [2019-10-17T22:58:23.635Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
22:58:23 [2019-10-17T22:58:23.635Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
22:58:23 [2019-10-17T22:58:23.635Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
22:58:23 [2019-10-17T22:58:23.635Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
22:58:23 [2019-10-17T22:58:23.635Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
22:58:23 [2019-10-17T22:58:23.635Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
22:58:23 [2019-10-17T22:58:23.635Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
22:58:23 [2019-10-17T22:58:23.635Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
22:58:23 [2019-10-17T22:58:23.635Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
22:58:23 [2019-10-17T22:58:23.635Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
22:58:23 [2019-10-17T22:58:23.635Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
22:58:23 [2019-10-17T22:58:23.635Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
22:58:23 [2019-10-17T22:58:23.635Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
22:58:23 [2019-10-17T22:58:23.635Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
22:58:23 [2019-10-17T22:58:23.635Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
22:58:23 [2019-10-17T22:58:23.635Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
22:58:23 [2019-10-17T22:58:23.635Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
22:58:26 [2019-10-17T22:58:26.441Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
22:58:26 [2019-10-17T22:58:26.882Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
22:58:28 [2019-10-17T22:58:28.595Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
22:58:28 [2019-10-17T22:58:28.595Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
22:58:30 [2019-10-17T22:58:30.023Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
22:58:30 [2019-10-17T22:58:30.023Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
22:58:32 [2019-10-17T22:58:32.019Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
22:58:32 [2019-10-17T22:58:32.448Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
22:58:35 [2019-10-17T22:58:35.023Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
22:58:35 [2019-10-17T22:58:35.428Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
22:58:38 [2019-10-17T22:58:38.020Z] --- PASS: TestDaemonRestartKillContainers (0.00s)
22:58:38 [2019-10-17T22:58:38.020Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon (2.84s)
22:58:38 [2019-10-17T22:58:38.020Z]         restart_test.go:67: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon"
22:58:38 [2019-10-17T22:58:38.020Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon (3.06s)
22:58:38 [2019-10-17T22:58:38.020Z]         restart_test.go:67: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon"
22:58:38 [2019-10-17T22:58:38.020Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon (1.59s)
22:58:38 [2019-10-17T22:58:38.020Z]         restart_test.go:67: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon"
22:58:38 [2019-10-17T22:58:38.020Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon (1.69s)
22:58:38 [2019-10-17T22:58:38.020Z]         restart_test.go:67: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon"
22:58:38 [2019-10-17T22:58:38.020Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon (1.52s)
22:58:38 [2019-10-17T22:58:38.020Z]         restart_test.go:67: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon"
22:58:38 [2019-10-17T22:58:38.020Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon (1.55s)
22:58:38 [2019-10-17T22:58:38.020Z]         restart_test.go:67: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon"
22:58:38 [2019-10-17T22:58:38.020Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon (2.47s)
22:58:38 [2019-10-17T22:58:38.020Z]         restart_test.go:67: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon"
22:58:38 [2019-10-17T22:58:38.020Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon (2.53s)
22:58:38 [2019-10-17T22:58:38.020Z]         restart_test.go:67: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon"
22:58:38 [2019-10-17T22:58:38.020Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon (2.03s)
22:58:38 [2019-10-17T22:58:38.020Z]         restart_test.go:67: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon"
22:58:38 [2019-10-17T22:58:38.020Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon (3.02s)
22:58:38 [2019-10-17T22:58:38.020Z]         restart_test.go:67: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon"
22:58:38 [2019-10-17T22:58:38.020Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon (2.54s)
22:58:38 [2019-10-17T22:58:38.020Z]         restart_test.go:67: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon"
22:58:38 [2019-10-17T22:58:38.020Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon (2.50s)
22:58:38 [2019-10-17T22:58:38.020Z]         restart_test.go:67: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon"
22:58:38 [2019-10-17T22:58:38.021Z] === RUN   TestCgroupNamespacesRun
22:58:39 [2019-10-17T22:58:39.972Z] --- PASS: TestCgroupNamespacesRun (2.08s)
22:58:39 [2019-10-17T22:58:39.972Z]     run_cgroupns_linux_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRun"
22:58:39 [2019-10-17T22:58:39.972Z] === RUN   TestCgroupNamespacesRunPrivileged
22:58:41 [2019-10-17T22:58:41.872Z] --- PASS: TestCgroupNamespacesRunPrivileged (1.82s)
22:58:41 [2019-10-17T22:58:41.872Z]     run_cgroupns_linux_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunPrivileged"
22:58:41 [2019-10-17T22:58:41.872Z] === RUN   TestCgroupNamespacesRunDaemonHostMode
22:58:43 [2019-10-17T22:58:43.799Z] --- PASS: TestCgroupNamespacesRunDaemonHostMode (2.20s)
22:58:43 [2019-10-17T22:58:43.799Z]     run_cgroupns_linux_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunDaemonHostMode"
22:58:43 [2019-10-17T22:58:43.799Z] === RUN   TestCgroupNamespacesRunHostMode
22:58:45 [2019-10-17T22:58:45.820Z] --- PASS: TestCgroupNamespacesRunHostMode (1.99s)
22:58:45 [2019-10-17T22:58:45.820Z]     run_cgroupns_linux_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunHostMode"
22:58:45 [2019-10-17T22:58:45.820Z] === RUN   TestCgroupNamespacesRunPrivateMode
22:58:47 [2019-10-17T22:58:47.747Z] --- PASS: TestCgroupNamespacesRunPrivateMode (1.85s)
22:58:47 [2019-10-17T22:58:47.747Z]     run_cgroupns_linux_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunPrivateMode"
22:58:47 [2019-10-17T22:58:47.747Z] === RUN   TestCgroupNamespacesRunPrivilegedAndPrivate
22:58:48 [2019-10-17T22:58:48.694Z] --- PASS: TestCgroupNamespacesRunPrivilegedAndPrivate (0.85s)
22:58:48 [2019-10-17T22:58:48.694Z]     run_cgroupns_linux_test.go:48: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunPrivilegedAndPrivate"
22:58:48 [2019-10-17T22:58:48.694Z] === RUN   TestCgroupNamespacesRunInvalidMode
22:58:49 [2019-10-17T22:58:49.771Z] --- PASS: TestCgroupNamespacesRunInvalidMode (0.98s)
22:58:49 [2019-10-17T22:58:49.771Z]     run_cgroupns_linux_test.go:48: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunInvalidMode"
22:58:49 [2019-10-17T22:58:49.771Z] === RUN   TestCgroupNamespacesRunOlderClient
22:58:51 [2019-10-17T22:58:51.835Z] --- PASS: TestCgroupNamespacesRunOlderClient (2.07s)
22:58:51 [2019-10-17T22:58:51.835Z]     run_cgroupns_linux_test.go:139: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunOlderClient"
22:58:51 [2019-10-17T22:58:51.835Z] === RUN   TestKernelTCPMemory
22:58:52 [2019-10-17T22:58:52.671Z] --- PASS: TestKernelTCPMemory (1.19s)
22:58:52 [2019-10-17T22:58:52.671Z] === RUN   TestNISDomainname
22:58:53 [2019-10-17T22:58:53.983Z] --- PASS: TestNISDomainname (1.17s)
22:58:53 [2019-10-17T22:58:53.983Z] === RUN   TestHostnameDnsResolution
22:58:55 [2019-10-17T22:58:55.272Z] --- PASS: TestHostnameDnsResolution (1.25s)
22:58:55 [2019-10-17T22:58:55.272Z] === RUN   TestStats
22:58:57 [2019-10-17T22:58:57.226Z] --- PASS: TestStats (1.94s)
22:58:57 [2019-10-17T22:58:57.227Z] === RUN   TestStopContainerWithTimeout
22:58:57 [2019-10-17T22:58:57.227Z] === RUN   TestStopContainerWithTimeout/0
22:58:57 [2019-10-17T22:58:57.227Z] === PAUSE TestStopContainerWithTimeout/0
22:58:57 [2019-10-17T22:58:57.227Z] === RUN   TestStopContainerWithTimeout/1
22:58:57 [2019-10-17T22:58:57.227Z] === PAUSE TestStopContainerWithTimeout/1
22:58:57 [2019-10-17T22:58:57.227Z] === RUN   TestStopContainerWithTimeout/3
22:58:57 [2019-10-17T22:58:57.227Z] === PAUSE TestStopContainerWithTimeout/3
22:58:57 [2019-10-17T22:58:57.227Z] === RUN   TestStopContainerWithTimeout/-1
22:58:57 [2019-10-17T22:58:57.227Z] === PAUSE TestStopContainerWithTimeout/-1
22:58:57 [2019-10-17T22:58:57.227Z] === CONT  TestStopContainerWithTimeout/0
22:58:57 [2019-10-17T22:58:57.227Z] === CONT  TestStopContainerWithTimeout/-1
22:58:58 [2019-10-17T22:58:58.784Z] === CONT  TestStopContainerWithTimeout/3
22:59:00 [2019-10-17T22:59:00.644Z] === CONT  TestStopContainerWithTimeout/1
22:59:02 [2019-10-17T22:59:02.528Z] --- PASS: TestStopContainerWithTimeout (0.01s)
22:59:02 [2019-10-17T22:59:02.528Z]     --- PASS: TestStopContainerWithTimeout/0 (1.22s)
22:59:02 [2019-10-17T22:59:02.528Z]     --- PASS: TestStopContainerWithTimeout/-1 (3.27s)
22:59:02 [2019-10-17T22:59:02.528Z]     --- PASS: TestStopContainerWithTimeout/3 (2.86s)
22:59:02 [2019-10-17T22:59:02.528Z]     --- PASS: TestStopContainerWithTimeout/1 (1.99s)
22:59:02 [2019-10-17T22:59:02.528Z] === RUN   TestDeleteDevicemapper
22:59:02 [2019-10-17T22:59:02.528Z] --- SKIP: TestDeleteDevicemapper (0.00s)
22:59:02 [2019-10-17T22:59:02.528Z]     stop_linux_test.go:74: testEnv.DaemonInfo.Driver != "devicemapper"
22:59:02 [2019-10-17T22:59:02.528Z] === RUN   TestStopContainerWithRestartPolicyAlways
22:59:05 [2019-10-17T22:59:05.096Z] --- PASS: TestStopContainerWithRestartPolicyAlways (2.88s)
22:59:05 [2019-10-17T22:59:05.096Z] === RUN   TestUpdateMemory
22:59:05 [2019-10-17T22:59:05.096Z] --- SKIP: TestUpdateMemory (0.00s)
22:59:05 [2019-10-17T22:59:05.096Z]     update_linux_test.go:23: !testEnv.DaemonInfo.SwapLimit
22:59:05 [2019-10-17T22:59:05.096Z] === RUN   TestUpdateCPUQuota
22:59:06 [2019-10-17T22:59:06.993Z] --- PASS: TestUpdateCPUQuota (1.76s)
22:59:06 [2019-10-17T22:59:06.993Z] === RUN   TestUpdatePidsLimit
22:59:06 [2019-10-17T22:59:06.993Z] === RUN   TestUpdatePidsLimit/update_from_none
22:59:07 [2019-10-17T22:59:07.379Z] === RUN   TestUpdatePidsLimit/no_change
22:59:07 [2019-10-17T22:59:07.774Z] === RUN   TestUpdatePidsLimit/update_lower
22:59:08 [2019-10-17T22:59:08.605Z] === RUN   TestUpdatePidsLimit/update_on_old_api_ignores_value
22:59:08 [2019-10-17T22:59:08.605Z] === RUN   TestUpdatePidsLimit/unset_limit_with_zero
22:59:09 [2019-10-17T22:59:09.416Z] === RUN   TestUpdatePidsLimit/unset_limit_with_minus_one
22:59:09 [2019-10-17T22:59:09.791Z] === RUN   TestUpdatePidsLimit/unset_limit_with_minus_two
22:59:11 [2019-10-17T22:59:11.656Z] --- PASS: TestUpdatePidsLimit (4.28s)
22:59:11 [2019-10-17T22:59:11.656Z]     --- PASS: TestUpdatePidsLimit/update_from_none (0.46s)
22:59:11 [2019-10-17T22:59:11.656Z]     --- PASS: TestUpdatePidsLimit/no_change (0.43s)
22:59:11 [2019-10-17T22:59:11.656Z]     --- PASS: TestUpdatePidsLimit/update_lower (0.42s)
22:59:11 [2019-10-17T22:59:11.656Z]     --- PASS: TestUpdatePidsLimit/update_on_old_api_ignores_value (0.42s)
22:59:11 [2019-10-17T22:59:11.656Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_zero (0.46s)
22:59:11 [2019-10-17T22:59:11.656Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_minus_one (0.40s)
22:59:11 [2019-10-17T22:59:11.656Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_minus_two (0.43s)
22:59:11 [2019-10-17T22:59:11.656Z] === RUN   TestUpdateRestartPolicy
22:59:25 [2019-10-17T22:59:25.776Z] --- PASS: TestUpdateRestartPolicy (13.49s)
22:59:25 [2019-10-17T22:59:25.776Z] === RUN   TestUpdateRestartWithAutoRemove
22:59:25 [2019-10-17T22:59:25.776Z] --- PASS: TestUpdateRestartWithAutoRemove (0.89s)
22:59:25 [2019-10-17T22:59:25.776Z] === RUN   TestWaitNonBlocked
22:59:25 [2019-10-17T22:59:25.776Z] === RUN   TestWaitNonBlocked/wait-nonblocking-exit-0
22:59:25 [2019-10-17T22:59:25.776Z] === PAUSE TestWaitNonBlocked/wait-nonblocking-exit-0
22:59:25 [2019-10-17T22:59:25.776Z] === RUN   TestWaitNonBlocked/wait-nonblocking-exit-random
22:59:25 [2019-10-17T22:59:25.776Z] === PAUSE TestWaitNonBlocked/wait-nonblocking-exit-random
22:59:25 [2019-10-17T22:59:25.776Z] === CONT  TestWaitNonBlocked/wait-nonblocking-exit-0
22:59:25 [2019-10-17T22:59:25.776Z] === CONT  TestWaitNonBlocked/wait-nonblocking-exit-random
22:59:26 [2019-10-17T22:59:26.660Z] --- PASS: TestWaitNonBlocked (0.01s)
22:59:26 [2019-10-17T22:59:26.660Z]     --- PASS: TestWaitNonBlocked/wait-nonblocking-exit-0 (1.04s)
22:59:26 [2019-10-17T22:59:26.660Z]     --- PASS: TestWaitNonBlocked/wait-nonblocking-exit-random (1.11s)
22:59:26 [2019-10-17T22:59:26.660Z] === RUN   TestWaitBlocked
22:59:26 [2019-10-17T22:59:26.660Z] === RUN   TestWaitBlocked/test-wait-blocked-exit-zero
22:59:26 [2019-10-17T22:59:26.660Z] === PAUSE TestWaitBlocked/test-wait-blocked-exit-zero
22:59:26 [2019-10-17T22:59:26.660Z] === RUN   TestWaitBlocked/test-wait-blocked-exit-random
22:59:26 [2019-10-17T22:59:26.660Z] === PAUSE TestWaitBlocked/test-wait-blocked-exit-random
22:59:26 [2019-10-17T22:59:26.660Z] === CONT  TestWaitBlocked/test-wait-blocked-exit-zero
22:59:26 [2019-10-17T22:59:26.660Z] === CONT  TestWaitBlocked/test-wait-blocked-exit-random
22:59:28 [2019-10-17T22:59:28.208Z] --- PASS: TestWaitBlocked (0.02s)
22:59:28 [2019-10-17T22:59:28.208Z]     --- PASS: TestWaitBlocked/test-wait-blocked-exit-zero (1.25s)
22:59:28 [2019-10-17T22:59:28.208Z]     --- PASS: TestWaitBlocked/test-wait-blocked-exit-random (1.25s)
22:59:28 [2019-10-17T22:59:28.208Z] === CONT  TestContainerStartOnDaemonRestart
22:59:28 [2019-10-17T22:59:28.208Z] === CONT  TestIpcModeOlderClient
22:59:28 [2019-10-17T22:59:28.208Z] --- PASS: TestIpcModeOlderClient (0.18s)
22:59:28 [2019-10-17T22:59:28.208Z] === CONT  TestDaemonRestartIpcMode
22:59:31 [2019-10-17T22:59:31.473Z] --- PASS: TestContainerStartOnDaemonRestart (3.40s)
22:59:31 [2019-10-17T22:59:31.473Z]     daemon_linux_test.go:35: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestContainerStartOnDaemonRestart"
22:59:32 [2019-10-17T22:59:32.281Z] --- PASS: TestDaemonRestartIpcMode (4.12s)
22:59:32 [2019-10-17T22:59:32.281Z]     daemon_linux_test.go:89: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartIpcMode"
22:59:32 [2019-10-17T22:59:32.281Z] PASS
22:59:32 [2019-10-17T22:59:32.281Z] 
22:59:32 [2019-10-17T22:59:32.281Z] === Skipped
22:59:32 [2019-10-17T22:59:32.281Z] === SKIP: s390x.integration.container TestCheckpoint (0.00s)
22:59:32 [2019-10-17T22:59:32.281Z]     checkpoint_test.go:33: TestCheckpoint is broken; see https://github.com/moby/moby/issues/38963
22:59:32 [2019-10-17T22:59:32.281Z] 
22:59:32 [2019-10-17T22:59:32.281Z] === SKIP: s390x.integration.container TestInspectOomKilledTrue (0.01s)
22:59:32 [2019-10-17T22:59:32.281Z]     kill_test.go:151: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
22:59:32 [2019-10-17T22:59:32.281Z] 
22:59:32 [2019-10-17T22:59:32.281Z] === SKIP: s390x.integration.container TestInspectOomKilledFalse (0.00s)
22:59:32 [2019-10-17T22:59:32.281Z]     kill_test.go:169: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
22:59:32 [2019-10-17T22:59:32.281Z] 
22:59:32 [2019-10-17T22:59:32.281Z] === SKIP: s390x.integration.container TestPauseFailsOnWindowsServerContainers (0.00s)
22:59:32 [2019-10-17T22:59:32.281Z]     pause_test.go:54: testEnv.DaemonInfo.OSType != "windows" || testEnv.DaemonInfo.Isolation != "process"
22:59:32 [2019-10-17T22:59:32.281Z] 
22:59:32 [2019-10-17T22:59:32.281Z] === SKIP: s390x.integration.container TestDeleteDevicemapper (0.00s)
22:59:32 [2019-10-17T22:59:32.281Z]     stop_linux_test.go:74: testEnv.DaemonInfo.Driver != "devicemapper"
22:59:32 [2019-10-17T22:59:32.281Z] 
22:59:32 [2019-10-17T22:59:32.281Z] === SKIP: s390x.integration.container TestUpdateMemory (0.00s)
22:59:32 [2019-10-17T22:59:32.281Z]     update_linux_test.go:23: !testEnv.DaemonInfo.SwapLimit
22:59:32 [2019-10-17T22:59:32.281Z] 
22:59:32 [2019-10-17T22:59:32.281Z] 
22:59:32 [2019-10-17T22:59:32.281Z] DONE 197 tests, 6 skipped in 150.193s
22:59:32 [2019-10-17T22:59:32.281Z] Running /go/src/github.com/docker/docker/integration/image (s390x.integration.image) flags=-test.v -test.timeout=120m 
22:59:32 [2019-10-17T22:59:32.281Z] ++ 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
22:59:32 [2019-10-17T22:59:32.281Z] ++ set -e
22:59:32 [2019-10-17T22:59:32.281Z] ++ '[' -n 0 ']'
22:59:32 [2019-10-17T22:59:32.281Z] ++ set -x
22:59:32 [2019-10-17T22:59:32.281Z] ++ 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
22:59:32 [2019-10-17T22:59:32.675Z] INFO: Testing against a local daemon
22:59:32 [2019-10-17T22:59:32.675Z] === RUN   TestCommitInheritsEnv
22:59:33 [2019-10-17T22:59:33.255Z] --- PASS: TestCommitInheritsEnv (0.57s)
22:59:33 [2019-10-17T22:59:33.255Z] === RUN   TestImportExtremelyLargeImageWorks
22:59:33 [2019-10-17T22:59:33.255Z] === PAUSE TestImportExtremelyLargeImageWorks
22:59:33 [2019-10-17T22:59:33.255Z] === RUN   TestImagesFilterMultiReference
22:59:33 [2019-10-17T22:59:33.255Z] --- PASS: TestImagesFilterMultiReference (0.06s)
22:59:33 [2019-10-17T22:59:33.255Z] === RUN   TestImagePullPlatformInvalid
22:59:33 [2019-10-17T22:59:33.255Z] --- PASS: TestImagePullPlatformInvalid (0.03s)
22:59:33 [2019-10-17T22:59:33.255Z] === RUN   TestRemoveImageOrphaning
22:59:33 [2019-10-17T22:59:33.809Z] --- PASS: TestRemoveImageOrphaning (0.47s)
22:59:33 [2019-10-17T22:59:33.809Z] === RUN   TestRemoveImageGarbageCollector
22:59:33 [2019-10-17T22:59:33.809Z] --- SKIP: TestRemoveImageGarbageCollector (0.00s)
22:59:33 [2019-10-17T22:59:33.809Z]     remove_unix_test.go:36: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:59:33 [2019-10-17T22:59:33.809Z] === RUN   TestTagUnprefixedRepoByNameOrName
22:59:33 [2019-10-17T22:59:33.809Z] --- PASS: TestTagUnprefixedRepoByNameOrName (0.02s)
22:59:33 [2019-10-17T22:59:33.809Z] === RUN   TestTagInvalidReference
22:59:33 [2019-10-17T22:59:33.809Z] --- PASS: TestTagInvalidReference (0.02s)
22:59:33 [2019-10-17T22:59:33.809Z] === RUN   TestTagValidPrefixedRepo
22:59:33 [2019-10-17T22:59:33.809Z] --- PASS: TestTagValidPrefixedRepo (0.07s)
22:59:33 [2019-10-17T22:59:33.809Z] === RUN   TestTagExistedNameWithoutForce
22:59:33 [2019-10-17T22:59:33.809Z] --- PASS: TestTagExistedNameWithoutForce (0.02s)
22:59:33 [2019-10-17T22:59:33.809Z] === RUN   TestTagOfficialNames
22:59:33 [2019-10-17T22:59:33.809Z] --- PASS: TestTagOfficialNames (0.05s)
22:59:33 [2019-10-17T22:59:33.809Z] === RUN   TestTagMatchesDigest
22:59:33 [2019-10-17T22:59:33.809Z] --- PASS: TestTagMatchesDigest (0.02s)
22:59:33 [2019-10-17T22:59:33.809Z] === CONT  TestImportExtremelyLargeImageWorks
23:01:43 [2019-10-17T23:01:43.572Z] --- PASS: TestImportExtremelyLargeImageWorks (117.18s)
23:01:43 [2019-10-17T23:01:43.572Z]     import_test.go:26: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestImportExtremelyLargeImageWorks"
23:01:43 [2019-10-17T23:01:43.572Z] PASS
23:01:43 [2019-10-17T23:01:43.572Z] 
23:01:43 [2019-10-17T23:01:43.572Z] === Skipped
23:01:43 [2019-10-17T23:01:43.572Z] === SKIP: s390x.integration.image TestRemoveImageGarbageCollector (0.00s)
23:01:43 [2019-10-17T23:01:43.572Z]     remove_unix_test.go:36: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
23:01:43 [2019-10-17T23:01:43.572Z] 
23:01:43 [2019-10-17T23:01:43.572Z] 
23:01:43 [2019-10-17T23:01:43.572Z] DONE 12 tests, 1 skipped in 118.648s
23:01:43 [2019-10-17T23:01:43.572Z] Running /go/src/github.com/docker/docker/integration/network (s390x.integration.network) flags=-test.v -test.timeout=120m 
23:01:43 [2019-10-17T23:01:43.572Z] ++ 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
23:01:43 [2019-10-17T23:01:43.572Z] ++ set -e
23:01:43 [2019-10-17T23:01:43.572Z] ++ '[' -n 0 ']'
23:01:43 [2019-10-17T23:01:43.572Z] ++ set -x
23:01:43 [2019-10-17T23:01:43.572Z] ++ 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
23:01:43 [2019-10-17T23:01:43.572Z] INFO: Testing against a local daemon
23:01:43 [2019-10-17T23:01:43.572Z] === RUN   TestNetworkCreateDelete
23:01:43 [2019-10-17T23:01:43.572Z] --- PASS: TestNetworkCreateDelete (0.13s)
23:01:43 [2019-10-17T23:01:43.572Z] === RUN   TestDockerNetworkDeletePreferID
23:01:43 [2019-10-17T23:01:43.573Z] --- PASS: TestDockerNetworkDeletePreferID (0.34s)
23:01:43 [2019-10-17T23:01:43.573Z] === RUN   TestInspectNetwork
23:01:43 [2019-10-17T23:01:43.573Z] === RUN   TestInspectNetwork/full_network_id
23:01:43 [2019-10-17T23:01:43.573Z] === RUN   TestInspectNetwork/partial_network_id
23:01:43 [2019-10-17T23:01:43.573Z] === RUN   TestInspectNetwork/network_name
23:01:43 [2019-10-17T23:01:43.573Z] === RUN   TestInspectNetwork/network_name_and_swarm_scope
23:01:43 [2019-10-17T23:01:43.573Z] --- PASS: TestInspectNetwork (10.05s)
23:01:43 [2019-10-17T23:01:43.573Z]     inspect_test.go:18: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestInspectNetwork"
23:01:43 [2019-10-17T23:01:43.573Z]     --- PASS: TestInspectNetwork/full_network_id (0.00s)
23:01:43 [2019-10-17T23:01:43.573Z]     --- PASS: TestInspectNetwork/partial_network_id (0.00s)
23:01:43 [2019-10-17T23:01:43.573Z]     --- PASS: TestInspectNetwork/network_name (0.00s)
23:01:43 [2019-10-17T23:01:43.573Z]     --- PASS: TestInspectNetwork/network_name_and_swarm_scope (0.00s)
23:01:43 [2019-10-17T23:01:43.573Z] === RUN   TestRunContainerWithBridgeNone
23:01:44 [2019-10-17T23:01:44.396Z] --- PASS: TestRunContainerWithBridgeNone (2.55s)
23:01:44 [2019-10-17T23:01:44.396Z]     network_test.go:25: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestRunContainerWithBridgeNone"
23:01:44 [2019-10-17T23:01:44.396Z] === RUN   TestNetworkInvalidJSON
23:01:44 [2019-10-17T23:01:44.396Z] === RUN   TestNetworkInvalidJSON//networks/create
23:01:44 [2019-10-17T23:01:44.396Z] === PAUSE TestNetworkInvalidJSON//networks/create
23:01:44 [2019-10-17T23:01:44.396Z] === RUN   TestNetworkInvalidJSON//networks/bridge/connect
23:01:44 [2019-10-17T23:01:44.396Z] === PAUSE TestNetworkInvalidJSON//networks/bridge/connect
23:01:44 [2019-10-17T23:01:44.396Z] === RUN   TestNetworkInvalidJSON//networks/bridge/disconnect
23:01:44 [2019-10-17T23:01:44.396Z] === PAUSE TestNetworkInvalidJSON//networks/bridge/disconnect
23:01:44 [2019-10-17T23:01:44.396Z] === CONT  TestNetworkInvalidJSON//networks/create
23:01:44 [2019-10-17T23:01:44.396Z] === CONT  TestNetworkInvalidJSON//networks/bridge/disconnect
23:01:44 [2019-10-17T23:01:44.396Z] === CONT  TestNetworkInvalidJSON//networks/bridge/connect
23:01:44 [2019-10-17T23:01:44.396Z] --- PASS: TestNetworkInvalidJSON (0.02s)
23:01:44 [2019-10-17T23:01:44.396Z]     --- PASS: TestNetworkInvalidJSON//networks/bridge/disconnect (0.00s)
23:01:44 [2019-10-17T23:01:44.396Z]     --- PASS: TestNetworkInvalidJSON//networks/create (0.00s)
23:01:44 [2019-10-17T23:01:44.396Z]     --- PASS: TestNetworkInvalidJSON//networks/bridge/connect (0.00s)
23:01:44 [2019-10-17T23:01:44.396Z] === RUN   TestDaemonRestartWithLiveRestore
23:01:45 [2019-10-17T23:01:45.181Z] --- PASS: TestDaemonRestartWithLiveRestore (1.05s)
23:01:45 [2019-10-17T23:01:45.181Z]     service_test.go:32: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartWithLiveRestore"
23:01:45 [2019-10-17T23:01:45.181Z] === RUN   TestDaemonDefaultNetworkPools
23:01:45 [2019-10-17T23:01:45.971Z] --- PASS: TestDaemonDefaultNetworkPools (0.76s)
23:01:45 [2019-10-17T23:01:45.971Z]     service_test.go:57: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonDefaultNetworkPools"
23:01:45 [2019-10-17T23:01:45.971Z] === RUN   TestDaemonRestartWithExistingNetwork
23:01:47 [2019-10-17T23:01:47.466Z] --- PASS: TestDaemonRestartWithExistingNetwork (1.16s)
23:01:47 [2019-10-17T23:01:47.466Z]     service_test.go:98: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartWithExistingNetwork"
23:01:47 [2019-10-17T23:01:47.466Z] === RUN   TestDaemonRestartWithExistingNetworkWithDefaultPoolRange
23:01:48 [2019-10-17T23:01:48.376Z] --- PASS: TestDaemonRestartWithExistingNetworkWithDefaultPoolRange (1.20s)
23:01:48 [2019-10-17T23:01:48.376Z]     service_test.go:131: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartWithExistingNetworkWithDefaultPoolRange"
23:01:48 [2019-10-17T23:01:48.376Z] === RUN   TestDaemonWithBipAndDefaultNetworkPool
23:01:49 [2019-10-17T23:01:49.197Z] --- PASS: TestDaemonWithBipAndDefaultNetworkPool (0.59s)
23:01:49 [2019-10-17T23:01:49.197Z]     service_test.go:181: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonWithBipAndDefaultNetworkPool"
23:01:49 [2019-10-17T23:01:49.197Z] === RUN   TestServiceWithPredefinedNetwork
23:01:52 [2019-10-17T23:01:52.465Z] --- PASS: TestServiceWithPredefinedNetwork (3.10s)
23:01:52 [2019-10-17T23:01:52.465Z]     service_test.go:203: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithPredefinedNetwork"
23:01:52 [2019-10-17T23:01:52.465Z] === RUN   TestServiceRemoveKeepsIngressNetwork
23:01:52 [2019-10-17T23:01:52.465Z] --- SKIP: TestServiceRemoveKeepsIngressNetwork (0.00s)
23:01:52 [2019-10-17T23:01:52.465Z]     service_test.go:230: FLAKY_TEST
23:01:52 [2019-10-17T23:01:52.465Z] === RUN   TestServiceWithDataPathPortInit
23:02:09 [2019-10-17T23:02:09.018Z] --- PASS: TestServiceWithDataPathPortInit (17.04s)
23:02:09 [2019-10-17T23:02:09.018Z]     service_test.go:323: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithDataPathPortInit"
23:02:09 [2019-10-17T23:02:09.018Z]     service_test.go:355: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithDataPathPortInit"
23:02:09 [2019-10-17T23:02:09.018Z] === RUN   TestServiceWithDefaultAddressPoolInit
23:02:18 [2019-10-17T23:02:18.355Z] --- PASS: TestServiceWithDefaultAddressPoolInit (8.37s)
23:02:18 [2019-10-17T23:02:18.355Z]     service_test.go:388: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithDefaultAddressPoolInit"
23:02:18 [2019-10-17T23:02:18.355Z]     service_test.go:418: TestServiceWithDefaultAddressPoolInit: NetworkInspect: {Name:sthiraTestServiceWithDefaultAddressPoolInit ID:x6qaoumv46qrqi77e7dzfw1ba Created:2019-10-17 23:02:10.564422799 +0000 UTC Scope:swarm Driver:overlay EnableIPv6:false IPAM:{Driver:default Options:map[] Config:[{Subnet:20.20.0.0/24 IPRange: Gateway:20.20.0.1 AuxAddress:map[]}]} Internal:false Attachable:false Ingress:false ConfigFrom:{Network:} ConfigOnly:false Containers:map[bf726d44ab27ba80e8fcd56036131934ceb0aea8ab70260a5830f541c4aeb0d2:{Name:TestServiceTestServiceWithDefaultAddressPoolInit.1.ekdczk44iqtd3y6kqnwp3jjuw EndpointID:1a3f12790a93f12c611cdbe4d6e81fc943013b9d743cb505f737b596838df6e0 MacAddress:02:42:14:14:00:03 IPv4Address:20.20.0.3/24 IPv6Address:} lb-sthiraTestServiceWithDefaultAddressPoolInit:{Name:sthiraTestServiceWithDefaultAddressPoolInit-endpoint EndpointID:172c0ed1464eda1f8900f4f264c123f5a18281efa572614859c2d39e823ec7b8 MacAddress:02:42:14:14:00:04 IPv4Address:20.20.0.4/24 IPv6Address:}] Options:map[com.docker.network.driver.overlay.vxlanid_list:4097] Labels:map[] Peers:[{Name:4d4b4b774115 IP:127.0.0.1}] Services:map[TestServiceTestServiceWithDefaultAddressPoolInit:{VIP:20.20.0.2 Ports:[] LocalLBIndex:256 Tasks:[{Name:TestServiceTestServiceWithDefaultAddressPoolInit.1.ekdczk44iqtd3y6kqnwp3jjuw EndpointID:1a3f12790a93f12c611cdbe4d6e81fc943013b9d743cb505f737b596838df6e0 EndpointIP:20.20.0.3 Info:map[Host IP:127.0.0.1]}]}]}
23:02:18 [2019-10-17T23:02:18.355Z] PASS
23:02:18 [2019-10-17T23:02:18.355Z] 
23:02:18 [2019-10-17T23:02:18.355Z] === Skipped
23:02:18 [2019-10-17T23:02:18.355Z] === SKIP: s390x.integration.network TestServiceRemoveKeepsIngressNetwork (0.00s)
23:02:18 [2019-10-17T23:02:18.355Z]     service_test.go:230: FLAKY_TEST
23:02:18 [2019-10-17T23:02:18.355Z] 
23:02:18 [2019-10-17T23:02:18.355Z] 
23:02:18 [2019-10-17T23:02:18.355Z] DONE 21 tests, 1 skipped in 46.437s
23:02:18 [2019-10-17T23:02:18.355Z] Running /go/src/github.com/docker/docker/integration/network/ipvlan (s390x.integration.network.ipvlan) flags=-test.v -test.timeout=120m 
23:02:18 [2019-10-17T23:02:18.355Z] ++ 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
23:02:18 [2019-10-17T23:02:18.355Z] ++ set -e
23:02:18 [2019-10-17T23:02:18.355Z] ++ '[' -n 0 ']'
23:02:18 [2019-10-17T23:02:18.355Z] ++ set -x
23:02:18 [2019-10-17T23:02:18.355Z] ++ 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
23:02:18 [2019-10-17T23:02:18.355Z] INFO: Testing against a local daemon
23:02:18 [2019-10-17T23:02:18.355Z] === RUN   TestDockerNetworkIpvlanPersistance
23:02:18 [2019-10-17T23:02:18.355Z] --- SKIP: TestDockerNetworkIpvlanPersistance (0.00s)
23:02:18 [2019-10-17T23:02:18.355Z]     ipvlan_test.go:26: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
23:02:18 [2019-10-17T23:02:18.355Z] === RUN   TestDockerNetworkIpvlan
23:02:18 [2019-10-17T23:02:18.355Z] --- SKIP: TestDockerNetworkIpvlan (0.00s)
23:02:18 [2019-10-17T23:02:18.355Z]     ipvlan_test.go:53: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
23:02:18 [2019-10-17T23:02:18.355Z] PASS
23:02:18 [2019-10-17T23:02:18.355Z] 
23:02:18 [2019-10-17T23:02:18.355Z] === Skipped
23:02:18 [2019-10-17T23:02:18.355Z] === SKIP: s390x.integration.network.ipvlan TestDockerNetworkIpvlanPersistance (0.00s)
23:02:18 [2019-10-17T23:02:18.355Z]     ipvlan_test.go:26: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
23:02:18 [2019-10-17T23:02:18.355Z] 
23:02:18 [2019-10-17T23:02:18.355Z] === SKIP: s390x.integration.network.ipvlan TestDockerNetworkIpvlan (0.00s)
23:02:18 [2019-10-17T23:02:18.355Z]     ipvlan_test.go:53: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
23:02:18 [2019-10-17T23:02:18.355Z] 
23:02:18 [2019-10-17T23:02:18.355Z] 
23:02:18 [2019-10-17T23:02:18.355Z] DONE 2 tests, 2 skipped in 0.091s
23:02:18 [2019-10-17T23:02:18.355Z] Running /go/src/github.com/docker/docker/integration/network/macvlan (s390x.integration.network.macvlan) flags=-test.v -test.timeout=120m 
23:02:18 [2019-10-17T23:02:18.355Z] ++ 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
23:02:18 [2019-10-17T23:02:18.355Z] ++ set -e
23:02:18 [2019-10-17T23:02:18.355Z] ++ '[' -n 0 ']'
23:02:18 [2019-10-17T23:02:18.355Z] ++ set -x
23:02:18 [2019-10-17T23:02:18.355Z] ++ 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
23:02:18 [2019-10-17T23:02:18.355Z] INFO: Testing against a local daemon
23:02:18 [2019-10-17T23:02:18.355Z] === RUN   TestDockerNetworkMacvlanPersistance
23:02:19 [2019-10-17T23:02:19.170Z] --- PASS: TestDockerNetworkMacvlanPersistance (1.42s)
23:02:19 [2019-10-17T23:02:19.170Z]     macvlan_test.go:24: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlanPersistance"
23:02:19 [2019-10-17T23:02:19.170Z] === RUN   TestDockerNetworkMacvlan
23:02:19 [2019-10-17T23:02:19.972Z] === RUN   TestDockerNetworkMacvlan/Subinterface
23:02:20 [2019-10-17T23:02:20.755Z] === RUN   TestDockerNetworkMacvlan/OverlapParent
23:02:22 [2019-10-17T23:02:22.028Z] === RUN   TestDockerNetworkMacvlan/NilParent
23:02:24 [2019-10-17T23:02:24.624Z] === RUN   TestDockerNetworkMacvlan/InternalMode
23:02:28 [2019-10-17T23:02:28.721Z] === RUN   TestDockerNetworkMacvlan/MultiSubnet
23:02:33 [2019-10-17T23:02:33.116Z] === RUN   TestDockerNetworkMacvlan/Addressing
23:02:34 [2019-10-17T23:02:34.411Z] --- PASS: TestDockerNetworkMacvlan (15.37s)
23:02:34 [2019-10-17T23:02:34.411Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
23:02:34 [2019-10-17T23:02:34.411Z]     --- PASS: TestDockerNetworkMacvlan/Subinterface (0.08s)
23:02:34 [2019-10-17T23:02:34.411Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
23:02:34 [2019-10-17T23:02:34.411Z]     --- PASS: TestDockerNetworkMacvlan/OverlapParent (0.09s)
23:02:34 [2019-10-17T23:02:34.411Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
23:02:34 [2019-10-17T23:02:34.411Z]     --- PASS: TestDockerNetworkMacvlan/NilParent (1.18s)
23:02:34 [2019-10-17T23:02:34.411Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
23:02:34 [2019-10-17T23:02:34.411Z]     --- PASS: TestDockerNetworkMacvlan/InternalMode (2.22s)
23:02:34 [2019-10-17T23:02:34.411Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
23:02:34 [2019-10-17T23:02:34.411Z]     --- PASS: TestDockerNetworkMacvlan/MultiSubnet (3.27s)
23:02:34 [2019-10-17T23:02:34.411Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
23:02:34 [2019-10-17T23:02:34.411Z]     --- PASS: TestDockerNetworkMacvlan/Addressing (0.96s)
23:02:34 [2019-10-17T23:02:34.411Z] PASS
23:02:34 [2019-10-17T23:02:34.411Z] 
23:02:34 [2019-10-17T23:02:34.411Z] DONE 8 tests in 16.883s
23:02:34 [2019-10-17T23:02:34.411Z] Running /go/src/github.com/docker/docker/integration/plugin (s390x.integration.plugin) flags=-test.v -test.timeout=120m 
23:02:34 [2019-10-17T23:02:34.411Z] ++ 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
23:02:34 [2019-10-17T23:02:34.411Z] ++ set -e
23:02:34 [2019-10-17T23:02:34.411Z] ++ '[' -n 0 ']'
23:02:34 [2019-10-17T23:02:34.411Z] ++ set -x
23:02:34 [2019-10-17T23:02:34.411Z] ++ 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
23:02:34 [2019-10-17T23:02:34.411Z] testing: warning: no tests to run
23:02:34 [2019-10-17T23:02:34.411Z] PASS
23:02:34 [2019-10-17T23:02:34.411Z] 
23:02:34 [2019-10-17T23:02:34.411Z] DONE 0 tests in 0.017s
23:02:34 [2019-10-17T23:02:34.411Z] Running /go/src/github.com/docker/docker/integration/plugin/authz (s390x.integration.plugin.authz) flags=-test.v -test.timeout=120m 
23:02:34 [2019-10-17T23:02:34.411Z] ++ 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
23:02:34 [2019-10-17T23:02:34.411Z] ++ set -e
23:02:34 [2019-10-17T23:02:34.411Z] ++ '[' -n 0 ']'
23:02:34 [2019-10-17T23:02:34.411Z] ++ set -x
23:02:34 [2019-10-17T23:02:34.411Z] ++ 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
23:02:34 [2019-10-17T23:02:34.795Z] INFO: Testing against a local daemon
23:02:34 [2019-10-17T23:02:34.795Z] === RUN   TestAuthZPluginAllowRequest
23:02:36 [2019-10-17T23:02:36.604Z] --- PASS: TestAuthZPluginAllowRequest (1.65s)
23:02:36 [2019-10-17T23:02:36.604Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginAllowRequest"
23:02:36 [2019-10-17T23:02:36.604Z] === RUN   TestAuthZPluginTLS
23:02:36 [2019-10-17T23:02:36.973Z] --- PASS: TestAuthZPluginTLS (0.56s)
23:02:36 [2019-10-17T23:02:36.973Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginTLS"
23:02:36 [2019-10-17T23:02:36.973Z] === RUN   TestAuthZPluginDenyRequest
23:02:37 [2019-10-17T23:02:37.352Z] --- PASS: TestAuthZPluginDenyRequest (0.54s)
23:02:37 [2019-10-17T23:02:37.352Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginDenyRequest"
23:02:37 [2019-10-17T23:02:37.352Z] === RUN   TestAuthZPluginAPIDenyResponse
23:02:38 [2019-10-17T23:02:38.145Z] --- PASS: TestAuthZPluginAPIDenyResponse (0.54s)
23:02:38 [2019-10-17T23:02:38.145Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginAPIDenyResponse"
23:02:38 [2019-10-17T23:02:38.145Z] === RUN   TestAuthZPluginDenyResponse
23:02:38 [2019-10-17T23:02:38.510Z] --- PASS: TestAuthZPluginDenyResponse (0.56s)
23:02:38 [2019-10-17T23:02:38.510Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginDenyResponse"
23:02:38 [2019-10-17T23:02:38.510Z] === RUN   TestAuthZPluginAllowEventStream
23:02:40 [2019-10-17T23:02:40.396Z] --- PASS: TestAuthZPluginAllowEventStream (1.73s)
23:02:40 [2019-10-17T23:02:40.396Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginAllowEventStream"
23:02:40 [2019-10-17T23:02:40.396Z] === RUN   TestAuthZPluginErrorResponse
23:02:40 [2019-10-17T23:02:40.873Z] --- PASS: TestAuthZPluginErrorResponse (0.55s)
23:02:40 [2019-10-17T23:02:40.873Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginErrorResponse"
23:02:40 [2019-10-17T23:02:40.873Z] === RUN   TestAuthZPluginErrorRequest
23:02:41 [2019-10-17T23:02:41.291Z] --- PASS: TestAuthZPluginErrorRequest (0.54s)
23:02:41 [2019-10-17T23:02:41.291Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginErrorRequest"
23:02:41 [2019-10-17T23:02:41.291Z] === RUN   TestAuthZPluginEnsureNoDuplicatePluginRegistration
23:02:41 [2019-10-17T23:02:41.807Z] --- PASS: TestAuthZPluginEnsureNoDuplicatePluginRegistration (0.54s)
23:02:41 [2019-10-17T23:02:41.807Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginEnsureNoDuplicatePluginRegistration"
23:02:41 [2019-10-17T23:02:41.807Z] === RUN   TestAuthZPluginEnsureLoadImportWorking
23:02:44 [2019-10-17T23:02:44.304Z] --- PASS: TestAuthZPluginEnsureLoadImportWorking (2.16s)
23:02:44 [2019-10-17T23:02:44.304Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginEnsureLoadImportWorking"
23:02:44 [2019-10-17T23:02:44.304Z] === RUN   TestAuthzPluginEnsureContainerCopyToFrom
23:02:46 [2019-10-17T23:02:46.138Z] --- PASS: TestAuthzPluginEnsureContainerCopyToFrom (2.28s)
23:02:46 [2019-10-17T23:02:46.138Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthzPluginEnsureContainerCopyToFrom"
23:02:46 [2019-10-17T23:02:46.138Z] === RUN   TestAuthZPluginHeader
23:02:47 [2019-10-17T23:02:47.403Z] --- PASS: TestAuthZPluginHeader (0.89s)
23:02:47 [2019-10-17T23:02:47.403Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginHeader"
23:02:47 [2019-10-17T23:02:47.403Z] === RUN   TestAuthZPluginV2AllowNonVolumeRequest
23:02:47 [2019-10-17T23:02:47.403Z] --- SKIP: TestAuthZPluginV2AllowNonVolumeRequest (0.00s)
23:02:47 [2019-10-17T23:02:47.403Z]     authz_plugin_v2_test.go:43: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
23:02:47 [2019-10-17T23:02:47.403Z] === RUN   TestAuthZPluginV2Disable
23:02:47 [2019-10-17T23:02:47.403Z] --- SKIP: TestAuthZPluginV2Disable (0.00s)
23:02:47 [2019-10-17T23:02:47.403Z]     authz_plugin_v2_test.go:65: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
23:02:47 [2019-10-17T23:02:47.403Z] === RUN   TestAuthZPluginV2RejectVolumeRequests
23:02:47 [2019-10-17T23:02:47.403Z] --- SKIP: TestAuthZPluginV2RejectVolumeRequests (0.00s)
23:02:47 [2019-10-17T23:02:47.403Z]     authz_plugin_v2_test.go:91: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
23:02:47 [2019-10-17T23:02:47.403Z] === RUN   TestAuthZPluginV2BadManifestFailsDaemonStart
23:02:47 [2019-10-17T23:02:47.403Z] --- SKIP: TestAuthZPluginV2BadManifestFailsDaemonStart (0.00s)
23:02:47 [2019-10-17T23:02:47.403Z]     authz_plugin_v2_test.go:126: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
23:02:47 [2019-10-17T23:02:47.403Z] === RUN   TestAuthZPluginV2NonexistentFailsDaemonStart
23:03:07 [2019-10-17T23:03:07.097Z] --- PASS: TestAuthZPluginV2NonexistentFailsDaemonStart (16.82s)
23:03:07 [2019-10-17T23:03:07.097Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginV2NonexistentFailsDaemonStart"
23:03:07 [2019-10-17T23:03:07.097Z] PASS
23:03:07 [2019-10-17T23:03:07.097Z] 
23:03:07 [2019-10-17T23:03:07.097Z] === Skipped
23:03:07 [2019-10-17T23:03:07.097Z] === SKIP: s390x.integration.plugin.authz TestAuthZPluginV2AllowNonVolumeRequest (0.00s)
23:03:07 [2019-10-17T23:03:07.097Z]     authz_plugin_v2_test.go:43: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
23:03:07 [2019-10-17T23:03:07.097Z] 
23:03:07 [2019-10-17T23:03:07.097Z] === SKIP: s390x.integration.plugin.authz TestAuthZPluginV2Disable (0.00s)
23:03:07 [2019-10-17T23:03:07.097Z]     authz_plugin_v2_test.go:65: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
23:03:07 [2019-10-17T23:03:07.097Z] 
23:03:07 [2019-10-17T23:03:07.097Z] === SKIP: s390x.integration.plugin.authz TestAuthZPluginV2RejectVolumeRequests (0.00s)
23:03:07 [2019-10-17T23:03:07.097Z]     authz_plugin_v2_test.go:91: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
23:03:07 [2019-10-17T23:03:07.097Z] 
23:03:07 [2019-10-17T23:03:07.097Z] === SKIP: s390x.integration.plugin.authz TestAuthZPluginV2BadManifestFailsDaemonStart (0.00s)
23:03:07 [2019-10-17T23:03:07.097Z]     authz_plugin_v2_test.go:126: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
23:03:07 [2019-10-17T23:03:07.097Z] 
23:03:07 [2019-10-17T23:03:07.097Z] 
23:03:07 [2019-10-17T23:03:07.097Z] DONE 17 tests, 4 skipped in 29.473s
23:03:07 [2019-10-17T23:03:07.097Z] Running /go/src/github.com/docker/docker/integration/plugin/common (s390x.integration.plugin.common) flags=-test.v -test.timeout=120m 
23:03:07 [2019-10-17T23:03:07.097Z] ++ 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
23:03:07 [2019-10-17T23:03:07.097Z] ++ set -e
23:03:07 [2019-10-17T23:03:07.097Z] ++ '[' -n 0 ']'
23:03:07 [2019-10-17T23:03:07.097Z] ++ set -x
23:03:07 [2019-10-17T23:03:07.097Z] ++ 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
23:03:07 [2019-10-17T23:03:07.097Z] INFO: Testing against a local daemon
23:03:07 [2019-10-17T23:03:07.097Z] === RUN   TestPluginInvalidJSON
23:03:07 [2019-10-17T23:03:07.097Z] === RUN   TestPluginInvalidJSON//plugins/foobar/set
23:03:07 [2019-10-17T23:03:07.097Z] === PAUSE TestPluginInvalidJSON//plugins/foobar/set
23:03:07 [2019-10-17T23:03:07.097Z] === CONT  TestPluginInvalidJSON//plugins/foobar/set
23:03:07 [2019-10-17T23:03:07.097Z] --- PASS: TestPluginInvalidJSON (0.02s)
23:03:07 [2019-10-17T23:03:07.097Z]     --- PASS: TestPluginInvalidJSON//plugins/foobar/set (0.00s)
23:03:07 [2019-10-17T23:03:07.097Z] PASS
23:03:07 [2019-10-17T23:03:07.097Z] 
23:03:07 [2019-10-17T23:03:07.097Z] DONE 2 tests in 0.093s
23:03:07 [2019-10-17T23:03:07.097Z] Running /go/src/github.com/docker/docker/integration/plugin/graphdriver (s390x.integration.plugin.graphdriver) flags=-test.v -test.timeout=120m 
23:03:07 [2019-10-17T23:03:07.097Z] ++ 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
23:03:07 [2019-10-17T23:03:07.097Z] ++ set -e
23:03:07 [2019-10-17T23:03:07.097Z] ++ '[' -n 0 ']'
23:03:07 [2019-10-17T23:03:07.097Z] ++ set -x
23:03:07 [2019-10-17T23:03:07.097Z] ++ 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
23:03:07 [2019-10-17T23:03:07.097Z] INFO: Testing against a local daemon
23:03:07 [2019-10-17T23:03:07.097Z] === RUN   TestExternalGraphDriver
23:03:07 [2019-10-17T23:03:07.097Z] === RUN   TestExternalGraphDriver/json
23:03:07 [2019-10-17T23:03:07.097Z] === RUN   TestExternalGraphDriver/spec
23:03:08 [2019-10-17T23:03:08.410Z] === RUN   TestExternalGraphDriver/pull
23:03:11 [2019-10-17T23:03:11.169Z] --- PASS: TestExternalGraphDriver (6.65s)
23:03:11 [2019-10-17T23:03:11.169Z]     external_test.go:57: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestExternalGraphDriver"
23:03:11 [2019-10-17T23:03:11.169Z]     --- PASS: TestExternalGraphDriver/json (2.03s)
23:03:11 [2019-10-17T23:03:11.169Z]     --- PASS: TestExternalGraphDriver/spec (2.13s)
23:03:11 [2019-10-17T23:03:11.169Z]     --- PASS: TestExternalGraphDriver/pull (2.28s)
23:03:11 [2019-10-17T23:03:11.169Z] === RUN   TestGraphdriverPluginV2
23:03:11 [2019-10-17T23:03:11.169Z] --- SKIP: TestGraphdriverPluginV2 (0.09s)
23:03:11 [2019-10-17T23:03:11.169Z]     external_test.go:410: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
23:03:11 [2019-10-17T23:03:11.169Z] PASS
23:03:11 [2019-10-17T23:03:11.169Z] 
23:03:11 [2019-10-17T23:03:11.169Z] === Skipped
23:03:11 [2019-10-17T23:03:11.169Z] === SKIP: s390x.integration.plugin.graphdriver TestGraphdriverPluginV2 (0.09s)
23:03:11 [2019-10-17T23:03:11.169Z]     external_test.go:410: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
23:03:11 [2019-10-17T23:03:11.169Z] 
23:03:11 [2019-10-17T23:03:11.169Z] 
23:03:11 [2019-10-17T23:03:11.169Z] DONE 5 tests, 1 skipped in 6.823s
23:03:11 [2019-10-17T23:03:11.169Z] Running /go/src/github.com/docker/docker/integration/plugin/logging (s390x.integration.plugin.logging) flags=-test.v -test.timeout=120m 
23:03:11 [2019-10-17T23:03:11.169Z] ++ 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
23:03:11 [2019-10-17T23:03:11.169Z] ++ set -e
23:03:11 [2019-10-17T23:03:11.169Z] ++ '[' -n 0 ']'
23:03:11 [2019-10-17T23:03:11.169Z] ++ set -x
23:03:11 [2019-10-17T23:03:11.170Z] ++ 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
23:03:11 [2019-10-17T23:03:11.170Z] INFO: Testing against a local daemon
23:03:11 [2019-10-17T23:03:11.170Z] === RUN   TestContinueAfterPluginCrash
23:03:11 [2019-10-17T23:03:11.170Z] === PAUSE TestContinueAfterPluginCrash
23:03:11 [2019-10-17T23:03:11.170Z] === RUN   TestDaemonStartWithLogOpt
23:03:11 [2019-10-17T23:03:11.170Z] === PAUSE TestDaemonStartWithLogOpt
23:03:11 [2019-10-17T23:03:11.170Z] === CONT  TestContinueAfterPluginCrash
23:03:11 [2019-10-17T23:03:11.170Z] === CONT  TestDaemonStartWithLogOpt
23:03:22 [2019-10-17T23:03:22.770Z] --- PASS: TestDaemonStartWithLogOpt (10.64s)
23:03:22 [2019-10-17T23:03:22.770Z]     validation_test.go:23: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonStartWithLogOpt"
23:03:26 [2019-10-17T23:03:26.938Z] --- PASS: TestContinueAfterPluginCrash (15.59s)
23:03:26 [2019-10-17T23:03:26.938Z]     logging_linux_test.go:22: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestContinueAfterPluginCrash"
23:03:26 [2019-10-17T23:03:26.938Z] PASS
23:03:26 [2019-10-17T23:03:26.938Z] 
23:03:26 [2019-10-17T23:03:26.938Z] DONE 2 tests in 15.679s
23:03:26 [2019-10-17T23:03:26.938Z] Running /go/src/github.com/docker/docker/integration/plugin/volumes (s390x.integration.plugin.volumes) flags=-test.v -test.timeout=120m 
23:03:26 [2019-10-17T23:03:26.938Z] ++ 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
23:03:26 [2019-10-17T23:03:26.938Z] ++ set -e
23:03:26 [2019-10-17T23:03:26.939Z] ++ '[' -n 0 ']'
23:03:26 [2019-10-17T23:03:26.939Z] ++ set -x
23:03:26 [2019-10-17T23:03:26.939Z] ++ 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
23:03:26 [2019-10-17T23:03:26.939Z] INFO: Testing against a local daemon
23:03:26 [2019-10-17T23:03:26.939Z] === RUN   TestPluginWithDevMounts
23:03:26 [2019-10-17T23:03:26.939Z] === PAUSE TestPluginWithDevMounts
23:03:26 [2019-10-17T23:03:26.939Z] === CONT  TestPluginWithDevMounts
23:03:28 [2019-10-17T23:03:28.971Z] --- PASS: TestPluginWithDevMounts (1.99s)
23:03:28 [2019-10-17T23:03:28.971Z]     mounts_test.go:23: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestPluginWithDevMounts"
23:03:28 [2019-10-17T23:03:28.971Z] PASS
23:03:28 [2019-10-17T23:03:28.971Z] 
23:03:28 [2019-10-17T23:03:28.971Z] DONE 1 tests in 2.085s
23:03:28 [2019-10-17T23:03:28.971Z] Running /go/src/github.com/docker/docker/integration/secret (s390x.integration.secret) flags=-test.v -test.timeout=120m 
23:03:28 [2019-10-17T23:03:28.971Z] ++ 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
23:03:28 [2019-10-17T23:03:28.971Z] ++ set -e
23:03:28 [2019-10-17T23:03:28.971Z] ++ '[' -n 0 ']'
23:03:28 [2019-10-17T23:03:28.971Z] ++ set -x
23:03:28 [2019-10-17T23:03:28.971Z] ++ 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
23:03:28 [2019-10-17T23:03:28.971Z] INFO: Testing against a local daemon
23:03:28 [2019-10-17T23:03:28.971Z] === RUN   TestSecretInspect
23:03:31 [2019-10-17T23:03:31.513Z] --- PASS: TestSecretInspect (2.83s)
23:03:31 [2019-10-17T23:03:31.513Z]     secret_test.go:25: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestSecretInspect"
23:03:31 [2019-10-17T23:03:31.513Z] === RUN   TestSecretList
23:03:34 [2019-10-17T23:03:34.726Z] --- PASS: TestSecretList (2.76s)
23:03:34 [2019-10-17T23:03:34.726Z]     secret_test.go:48: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestSecretList"
23:03:34 [2019-10-17T23:03:34.726Z] === RUN   TestSecretsCreateAndDelete
23:03:37 [2019-10-17T23:03:37.920Z] --- PASS: TestSecretsCreateAndDelete (3.03s)
23:03:37 [2019-10-17T23:03:37.920Z]     secret_test.go:125: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestSecretsCreateAndDelete"
23:03:37 [2019-10-17T23:03:37.920Z] === RUN   TestSecretsUpdate
23:03:40 [2019-10-17T23:03:40.368Z] --- PASS: TestSecretsUpdate (2.96s)
23:03:40 [2019-10-17T23:03:40.368Z]     secret_test.go:172: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestSecretsUpdate"
23:03:40 [2019-10-17T23:03:40.368Z] === RUN   TestTemplatedSecret
23:03:44 [2019-10-17T23:03:44.475Z] --- PASS: TestTemplatedSecret (3.56s)
23:03:44 [2019-10-17T23:03:44.475Z]     secret_test.go:221: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestTemplatedSecret"
23:03:44 [2019-10-17T23:03:44.475Z] === RUN   TestSecretCreateResolve
23:03:47 [2019-10-17T23:03:47.243Z] --- PASS: TestSecretCreateResolve (2.96s)
23:03:47 [2019-10-17T23:03:47.243Z]     secret_test.go:342: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestSecretCreateResolve"
23:03:47 [2019-10-17T23:03:47.243Z] PASS
23:03:47 [2019-10-17T23:03:47.243Z] 
23:03:47 [2019-10-17T23:03:47.243Z] DONE 6 tests in 18.189s
23:03:47 [2019-10-17T23:03:47.243Z] Running /go/src/github.com/docker/docker/integration/service (s390x.integration.service) flags=-test.v -test.timeout=120m 
23:03:47 [2019-10-17T23:03:47.243Z] ++ 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
23:03:47 [2019-10-17T23:03:47.243Z] ++ set -e
23:03:47 [2019-10-17T23:03:47.243Z] ++ '[' -n 0 ']'
23:03:47 [2019-10-17T23:03:47.243Z] ++ set -x
23:03:47 [2019-10-17T23:03:47.243Z] ++ 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
23:03:47 [2019-10-17T23:03:47.243Z] INFO: Testing against a local daemon
23:03:47 [2019-10-17T23:03:47.243Z] === RUN   TestServiceCreateInit
23:03:47 [2019-10-17T23:03:47.243Z] === RUN   TestServiceCreateInit/daemonInitDisabled
23:03:52 [2019-10-17T23:03:52.377Z] === RUN   TestServiceCreateInit/daemonInitEnabled
23:03:57 [2019-10-17T23:03:57.469Z] --- PASS: TestServiceCreateInit (10.17s)
23:03:57 [2019-10-17T23:03:57.469Z]     --- PASS: TestServiceCreateInit/daemonInitDisabled (5.17s)
23:03:57 [2019-10-17T23:03:57.469Z]         create_test.go:38: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceCreateInit/daemonInitDisabled"
23:03:57 [2019-10-17T23:03:57.469Z]     --- PASS: TestServiceCreateInit/daemonInitEnabled (4.98s)
23:03:57 [2019-10-17T23:03:57.469Z]         create_test.go:38: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceCreateInit/daemonInitEnabled"
23:03:57 [2019-10-17T23:03:57.469Z] === RUN   TestCreateServiceMultipleTimes
23:04:17 [2019-10-17T23:04:17.448Z] --- PASS: TestCreateServiceMultipleTimes (17.51s)
23:04:17 [2019-10-17T23:04:17.448Z]     create_test.go:80: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceMultipleTimes"
23:04:17 [2019-10-17T23:04:17.448Z] === RUN   TestCreateServiceConflict
23:04:17 [2019-10-17T23:04:17.448Z] --- PASS: TestCreateServiceConflict (2.77s)
23:04:17 [2019-10-17T23:04:17.448Z]     create_test.go:129: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceConflict"
23:04:17 [2019-10-17T23:04:17.448Z] === RUN   TestCreateServiceMaxReplicas
23:04:21 [2019-10-17T23:04:21.555Z] --- PASS: TestCreateServiceMaxReplicas (3.66s)
23:04:21 [2019-10-17T23:04:21.555Z]     create_test.go:150: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceMaxReplicas"
23:04:21 [2019-10-17T23:04:21.555Z] === RUN   TestCreateWithDuplicateNetworkNames
23:04:35 [2019-10-17T23:04:35.170Z] --- PASS: TestCreateWithDuplicateNetworkNames (14.13s)
23:04:35 [2019-10-17T23:04:35.171Z]     create_test.go:171: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateWithDuplicateNetworkNames"
23:04:35 [2019-10-17T23:04:35.171Z] === RUN   TestCreateServiceSecretFileMode
23:04:38 [2019-10-17T23:04:38.569Z] --- PASS: TestCreateServiceSecretFileMode (2.93s)
23:04:38 [2019-10-17T23:04:38.569Z]     create_test.go:224: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceSecretFileMode"
23:04:38 [2019-10-17T23:04:38.569Z] === RUN   TestCreateServiceConfigFileMode
23:04:41 [2019-10-17T23:04:41.764Z] --- PASS: TestCreateServiceConfigFileMode (3.46s)
23:04:41 [2019-10-17T23:04:41.764Z]     create_test.go:288: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceConfigFileMode"
23:04:41 [2019-10-17T23:04:41.764Z] === RUN   TestCreateServiceSysctls
23:04:46 [2019-10-17T23:04:46.868Z] --- PASS: TestCreateServiceSysctls (4.44s)
23:04:46 [2019-10-17T23:04:46.868Z]     create_test.go:378: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceSysctls"
23:04:46 [2019-10-17T23:04:46.868Z] === RUN   TestCreateServiceCapabilities
23:04:49 [2019-10-17T23:04:49.337Z] --- PASS: TestCreateServiceCapabilities (3.19s)
23:04:49 [2019-10-17T23:04:49.337Z]     create_test.go:462: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceCapabilities"
23:04:49 [2019-10-17T23:04:49.337Z] === RUN   TestInspect
23:04:53 [2019-10-17T23:04:53.471Z] --- PASS: TestInspect (3.57s)
23:04:53 [2019-10-17T23:04:53.471Z]     inspect_test.go:23: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestInspect"
23:04:53 [2019-10-17T23:04:53.471Z] === RUN   TestServiceListWithStatuses
23:04:53 [2019-10-17T23:04:53.471Z] --- SKIP: TestServiceListWithStatuses (0.00s)
23:04:53 [2019-10-17T23:04:53.471Z]     list_test.go:34: versions.LessThan(testEnv.DaemonInfo.ServerVersion, "1.41")
23:04:53 [2019-10-17T23:04:53.471Z] === RUN   TestDockerNetworkConnectAlias
23:04:59 [2019-10-17T23:04:59.754Z] --- PASS: TestDockerNetworkConnectAlias (5.98s)
23:04:59 [2019-10-17T23:04:59.798Z]     network_test.go:20: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkConnectAlias"
23:04:59 [2019-10-17T23:04:59.798Z] === RUN   TestDockerNetworkReConnect
23:05:05 [2019-10-17T23:05:05.290Z] --- PASS: TestDockerNetworkReConnect (5.71s)
23:05:05 [2019-10-17T23:05:05.290Z]     network_test.go:82: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkReConnect"
23:05:05 [2019-10-17T23:05:05.290Z] === RUN   TestServicePlugin
23:05:05 [2019-10-17T23:05:05.290Z] --- SKIP: TestServicePlugin (0.00s)
23:05:05 [2019-10-17T23:05:05.290Z]     plugin_test.go:28: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
23:05:05 [2019-10-17T23:05:05.290Z] === RUN   TestServiceUpdateLabel
23:05:07 [2019-10-17T23:05:07.967Z] --- PASS: TestServiceUpdateLabel (3.11s)
23:05:07 [2019-10-17T23:05:07.967Z]     update_test.go:21: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateLabel"
23:05:07 [2019-10-17T23:05:07.967Z] === RUN   TestServiceUpdateSecrets
23:05:24 [2019-10-17T23:05:24.452Z] --- PASS: TestServiceUpdateSecrets (15.05s)
23:05:24 [2019-10-17T23:05:24.453Z]     update_test.go:77: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateSecrets"
23:05:24 [2019-10-17T23:05:24.453Z] === RUN   TestServiceUpdateConfigs
23:05:40 [2019-10-17T23:05:40.848Z] --- PASS: TestServiceUpdateConfigs (15.72s)
23:05:40 [2019-10-17T23:05:40.848Z]     update_test.go:139: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateConfigs"
23:05:40 [2019-10-17T23:05:40.848Z] === RUN   TestServiceUpdateNetwork
23:05:54 [2019-10-17T23:05:54.427Z] --- PASS: TestServiceUpdateNetwork (14.01s)
23:05:54 [2019-10-17T23:05:54.427Z]     update_test.go:201: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateNetwork"
23:05:54 [2019-10-17T23:05:54.427Z] PASS
23:05:54 [2019-10-17T23:05:54.427Z] 
23:05:54 [2019-10-17T23:05:54.427Z] === Skipped
23:05:54 [2019-10-17T23:05:54.427Z] === SKIP: s390x.integration.service TestServiceListWithStatuses (0.00s)
23:05:54 [2019-10-17T23:05:54.427Z]     list_test.go:34: versions.LessThan(testEnv.DaemonInfo.ServerVersion, "1.41")
23:05:54 [2019-10-17T23:05:54.427Z] 
23:05:54 [2019-10-17T23:05:54.427Z] === SKIP: s390x.integration.service TestServicePlugin (0.00s)
23:05:54 [2019-10-17T23:05:54.427Z]     plugin_test.go:28: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
23:05:54 [2019-10-17T23:05:54.427Z] 
23:05:54 [2019-10-17T23:05:54.427Z] 
23:05:54 [2019-10-17T23:05:54.427Z] DONE 20 tests, 2 skipped in 125.520s
23:05:54 [2019-10-17T23:05:54.427Z] Running /go/src/github.com/docker/docker/integration/session (s390x.integration.session) flags=-test.v -test.timeout=120m 
23:05:54 [2019-10-17T23:05:54.427Z] ++ 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
23:05:54 [2019-10-17T23:05:54.427Z] ++ set -e
23:05:54 [2019-10-17T23:05:54.427Z] ++ '[' -n 0 ']'
23:05:54 [2019-10-17T23:05:54.427Z] ++ set -x
23:05:54 [2019-10-17T23:05:54.427Z] ++ 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
23:05:54 [2019-10-17T23:05:54.427Z] INFO: Testing against a local daemon
23:05:54 [2019-10-17T23:05:54.427Z] === RUN   TestSessionCreate
23:05:54 [2019-10-17T23:05:54.427Z] --- PASS: TestSessionCreate (0.03s)
23:05:54 [2019-10-17T23:05:54.427Z] === RUN   TestSessionCreateWithBadUpgrade
23:05:54 [2019-10-17T23:05:54.427Z] --- PASS: TestSessionCreateWithBadUpgrade (0.02s)
23:05:54 [2019-10-17T23:05:54.427Z] PASS
23:05:54 [2019-10-17T23:05:54.427Z] 
23:05:54 [2019-10-17T23:05:54.427Z] DONE 2 tests in 0.146s
23:05:54 [2019-10-17T23:05:54.427Z] Running /go/src/github.com/docker/docker/integration/system (s390x.integration.system) flags=-test.v -test.timeout=120m 
23:05:54 [2019-10-17T23:05:54.428Z] ++ 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
23:05:54 [2019-10-17T23:05:54.428Z] ++ set -e
23:05:54 [2019-10-17T23:05:54.428Z] ++ '[' -n 0 ']'
23:05:54 [2019-10-17T23:05:54.428Z] ++ set -x
23:05:54 [2019-10-17T23:05:54.428Z] ++ 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
23:05:54 [2019-10-17T23:05:54.428Z] INFO: Testing against a local daemon
23:05:54 [2019-10-17T23:05:54.428Z] === RUN   TestCgroupDriverSystemdMemoryLimit
23:05:54 [2019-10-17T23:05:54.428Z] --- SKIP: TestCgroupDriverSystemdMemoryLimit (0.00s)
23:05:54 [2019-10-17T23:05:54.428Z]     cgroupdriver_systemd_test.go:32: !hasSystemd()
23:05:54 [2019-10-17T23:05:54.428Z] === RUN   TestEventsExecDie
23:05:54 [2019-10-17T23:05:54.428Z] --- PASS: TestEventsExecDie (0.99s)
23:05:54 [2019-10-17T23:05:54.428Z] === RUN   TestEventsBackwardsCompatible
23:05:54 [2019-10-17T23:05:54.428Z] --- PASS: TestEventsBackwardsCompatible (0.09s)
23:05:54 [2019-10-17T23:05:54.428Z] === RUN   TestInfoBinaryCommits
23:05:54 [2019-10-17T23:05:54.428Z] --- PASS: TestInfoBinaryCommits (0.02s)
23:05:54 [2019-10-17T23:05:54.428Z] === RUN   TestInfoAPIVersioned
23:05:54 [2019-10-17T23:05:54.428Z] --- PASS: TestInfoAPIVersioned (0.01s)
23:05:54 [2019-10-17T23:05:54.428Z] === RUN   TestInfoAPI
23:05:54 [2019-10-17T23:05:54.428Z] --- PASS: TestInfoAPI (0.02s)
23:05:54 [2019-10-17T23:05:54.428Z] === RUN   TestInfoAPIWarnings
23:05:54 [2019-10-17T23:05:54.796Z] --- PASS: TestInfoAPIWarnings (0.86s)
23:05:54 [2019-10-17T23:05:54.796Z]     info_test.go:49: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestInfoAPIWarnings"
23:05:54 [2019-10-17T23:05:54.796Z] === RUN   TestLoginFailsWithBadCredentials
23:05:55 [2019-10-17T23:05:55.173Z] --- PASS: TestLoginFailsWithBadCredentials (0.33s)
23:05:55 [2019-10-17T23:05:55.173Z] === RUN   TestPingCacheHeaders
23:05:55 [2019-10-17T23:05:55.173Z] --- PASS: TestPingCacheHeaders (0.02s)
23:05:55 [2019-10-17T23:05:55.173Z] === RUN   TestPingGet
23:05:55 [2019-10-17T23:05:55.173Z] --- PASS: TestPingGet (0.02s)
23:05:55 [2019-10-17T23:05:55.173Z] === RUN   TestPingHead
23:05:55 [2019-10-17T23:05:55.173Z] --- PASS: TestPingHead (0.02s)
23:05:55 [2019-10-17T23:05:55.173Z] === RUN   TestVersion
23:05:55 [2019-10-17T23:05:55.173Z] --- PASS: TestVersion (0.02s)
23:05:55 [2019-10-17T23:05:55.173Z] PASS
23:05:55 [2019-10-17T23:05:55.173Z] 
23:05:55 [2019-10-17T23:05:55.173Z] === Skipped
23:05:55 [2019-10-17T23:05:55.173Z] === SKIP: s390x.integration.system TestCgroupDriverSystemdMemoryLimit (0.00s)
23:05:55 [2019-10-17T23:05:55.173Z]     cgroupdriver_systemd_test.go:32: !hasSystemd()
23:05:55 [2019-10-17T23:05:55.173Z] 
23:05:55 [2019-10-17T23:05:55.173Z] 
23:05:55 [2019-10-17T23:05:55.173Z] DONE 12 tests, 1 skipped in 2.476s
23:05:55 [2019-10-17T23:05:55.173Z] Running /go/src/github.com/docker/docker/integration/volume (s390x.integration.volume) flags=-test.v -test.timeout=120m 
23:05:55 [2019-10-17T23:05:55.173Z] ++ 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
23:05:55 [2019-10-17T23:05:55.173Z] ++ set -e
23:05:55 [2019-10-17T23:05:55.173Z] ++ '[' -n 0 ']'
23:05:55 [2019-10-17T23:05:55.173Z] ++ set -x
23:05:55 [2019-10-17T23:05:55.173Z] ++ 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
23:05:55 [2019-10-17T23:05:55.173Z] INFO: Testing against a local daemon
23:05:55 [2019-10-17T23:05:55.173Z] === RUN   TestVolumesCreateAndList
23:05:55 [2019-10-17T23:05:55.173Z] --- PASS: TestVolumesCreateAndList (0.02s)
23:05:55 [2019-10-17T23:05:55.173Z] === RUN   TestVolumesRemove
23:05:55 [2019-10-17T23:05:55.173Z] --- PASS: TestVolumesRemove (0.12s)
23:05:55 [2019-10-17T23:05:55.173Z] === RUN   TestVolumesInspect
23:05:55 [2019-10-17T23:05:55.554Z] --- PASS: TestVolumesInspect (0.03s)
23:05:55 [2019-10-17T23:05:55.554Z] === RUN   TestVolumesInvalidJSON
23:05:55 [2019-10-17T23:05:55.554Z] === RUN   TestVolumesInvalidJSON//volumes/create
23:05:55 [2019-10-17T23:05:55.554Z] === PAUSE TestVolumesInvalidJSON//volumes/create
23:05:55 [2019-10-17T23:05:55.554Z] === CONT  TestVolumesInvalidJSON//volumes/create
23:05:55 [2019-10-17T23:05:55.554Z] --- PASS: TestVolumesInvalidJSON (0.01s)
23:05:55 [2019-10-17T23:05:55.554Z]     --- PASS: TestVolumesInvalidJSON//volumes/create (0.00s)
23:05:55 [2019-10-17T23:05:55.554Z] PASS
23:05:55 [2019-10-17T23:05:55.554Z] 
23:05:55 [2019-10-17T23:05:55.554Z] DONE 5 tests in 0.258s
23:05:55 [2019-10-17T23:05:55.554Z] ---> Making bundle: .integration-daemon-stop (in bundles/test-integration)
23:05:55 [2019-10-17T23:05:55.554Z] ++++ cat bundles/test-integration/docker.pid
23:05:55 [2019-10-17T23:05:55.554Z] +++ kill 11495
23:05:56 [2019-10-17T23:05:56.812Z] +++ /etc/init.d/apparmor stop
23:05:57 [2019-10-17T23:05:57.316Z] Clearing AppArmor profiles cache:.
23:05:57 [2019-10-17T23:05:57.316Z] All profile caches have been cleared, but no profiles have been unloaded.
23:05:57 [2019-10-17T23:05:57.316Z] Unloading profiles will leave already running processes permanently
23:05:57 [2019-10-17T23:05:57.316Z] unconfined, which can lead to unexpected situations.
23:05:57 [2019-10-17T23:05:57.316Z] 
23:05:57 [2019-10-17T23:05:57.316Z] To set a process to complain mode, use the command line tool
23:05:57 [2019-10-17T23:05:57.316Z] 'aa-complain'. To really tear down all profiles, run the init script
23:05:57 [2019-10-17T23:05:57.316Z] with the 'teardown' option."
23:05:57 [2019-10-17T23:05:57.316Z]