Console Output

12:33:05 [2019-09-27T12:33:05.306Z] + docker run --rm -t --privileged -v /home/jenkins/workspace/moby_PR-39997/bundles:/go/src/github.com/docker/docker/bundles --name docker-pr2 -e DOCKER_EXPERIMENTAL -e DOCKER_GITCOMMIT=b5dcdbde1cece60b0cb4f623eb2adc4a9f24384c -e DOCKER_GRAPHDRIVER -e TESTDEBUG -e TEST_SKIP_INTEGRATION_CLI -e TIMEOUT docker:b5dcdbde1cece60b0cb4f623eb2adc4a9f24384c hack/make.sh dynbinary test-integration
12:33:05 [2019-09-27T12:33:05.699Z] 
12:33:05 [2019-09-27T12:33:05.699Z] Removing bundles/
12:33:05 [2019-09-27T12:33:05.699Z] 
12:33:05 [2019-09-27T12:33:05.699Z] ---> Making bundle: dynbinary (in bundles/dynbinary)
12:33:05 [2019-09-27T12:33:05.699Z] Building: bundles/dynbinary-daemon/dockerd-dev
12:33:05 [2019-09-27T12:33:05.699Z] GOOS="" GOARCH="" GOARM=""
12:34:16 [2019-09-27T12:34:16.201Z] Created binary: bundles/dynbinary-daemon/dockerd-dev
12:34:16 [2019-09-27T12:34:16.201Z] 
12:34:16 [2019-09-27T12:34:16.201Z] ---> Making bundle: test-integration (in bundles/test-integration)
12:34:16 [2019-09-27T12:34:16.201Z] PKG_CONFIG=pkg-config
12:34:16 [2019-09-27T12:34:16.201Z] GOLANG_VERSION=1.13
12:34:16 [2019-09-27T12:34:16.201Z] HOSTNAME=60dddcc03250
12:34:16 [2019-09-27T12:34:16.201Z] DOCKER_EXPERIMENTAL=1
12:34:16 [2019-09-27T12:34:16.201Z] container=docker
12:34:16 [2019-09-27T12:34:16.201Z] TEST_SKIP_INTEGRATION_CLI=1
12:34:16 [2019-09-27T12:34:16.201Z] GO111MODULE=off
12:34:16 [2019-09-27T12:34:16.201Z] GOPATH=/go
12:34:16 [2019-09-27T12:34:16.201Z] PWD=/go/src/github.com/docker/docker
12:34:16 [2019-09-27T12:34:16.201Z] HOME=/root
12:34:16 [2019-09-27T12:34:16.201Z] SCRIPTDIR=/go/src/github.com/docker/docker/hack
12:34:16 [2019-09-27T12:34:16.201Z] MAKEDIR=/go/src/github.com/docker/docker/hack/make
12:34:16 [2019-09-27T12:34:16.201Z] DOCKER_GITCOMMIT=b5dcdbde1cece60b0cb4f623eb2adc4a9f24384c
12:34:16 [2019-09-27T12:34:16.201Z] DOCKER_BUILDTAGS=apparmor seccomp selinux journald
12:34:16 [2019-09-27T12:34:16.201Z] DOCKER_GRAPHDRIVER=overlay2
12:34:16 [2019-09-27T12:34:16.201Z] TERM=xterm
12:34:16 [2019-09-27T12:34:16.201Z] DEST=bundles/test-integration
12:34:16 [2019-09-27T12:34:16.201Z] SHLVL=1
12:34:16 [2019-09-27T12:34:16.201Z] TIMEOUT=120m
12:34:16 [2019-09-27T12:34:16.201Z] PATH=/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
12:34:16 [2019-09-27T12:34:16.201Z] DOCKER_PKG=github.com/docker/docker
12:34:16 [2019-09-27T12:34:16.201Z] TESTDEBUG=0
12:34:16 [2019-09-27T12:34:16.201Z] _=/usr/bin/env
12:34:16 [2019-09-27T12:34:16.201Z] Building test suite binary /go/src/github.com/docker/docker/integration/build/test.main
12:34:36 [2019-09-27T12:34:36.199Z] Building test suite binary /go/src/github.com/docker/docker/integration/config/test.main
12:34:37 [2019-09-27T12:34:37.495Z] Building test suite binary /go/src/github.com/docker/docker/integration/container/test.main
12:34:40 [2019-09-27T12:34:40.868Z] Building test suite binary /go/src/github.com/docker/docker/integration/image/test.main
12:35:00 [2019-09-27T12:35:00.811Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/test.main
12:35:01 [2019-09-27T12:35:01.213Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/ipvlan/test.main
12:35:02 [2019-09-27T12:35:02.505Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/macvlan/test.main
12:35:03 [2019-09-27T12:35:03.878Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/test.main
12:35:04 [2019-09-27T12:35:04.265Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/authz/test.main
12:35:06 [2019-09-27T12:35:06.128Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/common/test.main
12:35:07 [2019-09-27T12:35:07.431Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/graphdriver/test.main
12:35:08 [2019-09-27T12:35:08.747Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/logging/test.main
12:35:11 [2019-09-27T12:35:11.343Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/volumes/test.main
12:35:13 [2019-09-27T12:35:13.199Z] Building test suite binary /go/src/github.com/docker/docker/integration/secret/test.main
12:35:14 [2019-09-27T12:35:14.614Z] Building test suite binary /go/src/github.com/docker/docker/integration/service/test.main
12:35:16 [2019-09-27T12:35:16.493Z] Building test suite binary /go/src/github.com/docker/docker/integration/session/test.main
12:35:17 [2019-09-27T12:35:17.828Z] Building test suite binary /go/src/github.com/docker/docker/integration/system/test.main
12:35:19 [2019-09-27T12:35:19.135Z] Building test suite binary /go/src/github.com/docker/docker/integration/volume/test.main
12:35:20 [2019-09-27T12:35:20.575Z] ---> Making bundle: .integration-daemon-start (in bundles/test-integration)
12:35:20 [2019-09-27T12:35:20.575Z] Using test binary docker
12:35:20 [2019-09-27T12:35:20.575Z] # DOCKER_EXPERIMENTAL is set: starting daemon with experimental features enabled! 
12:35:20 [2019-09-27T12:35:20.575Z] +++ /etc/init.d/apparmor start
12:35:20 [2019-09-27T12:35:20.575Z] /etc/init.d/apparmor: 130: /etc/init.d/apparmor: systemd-detect-virt: not found
12:35:20 [2019-09-27T12:35:20.575Z] Starting AppArmor profiles:Warning from stdin (line 1): /sbin/apparmor_parser: cannot use or update cache, disable, or force-complain via stdin
12:35:20 [2019-09-27T12:35:20.575Z] Warning failed to create cache: (null)
12:35:20 [2019-09-27T12:35:20.575Z] .
12:35:20 [2019-09-27T12:35:20.575Z] INFO: Waiting for daemon to start...
12:35:20 [2019-09-27T12:35:20.575Z] Starting dockerd
12:35:20 [2019-09-27T12:35:20.575Z] +++ 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
12:35:22 [2019-09-27T12:35:22.368Z] .
12:35:22 [2019-09-27T12:35:22.368Z] ---> Making bundle: .integration-daemon-setup (in bundles/test-integration)
12:35:22 [2019-09-27T12:35:22.368Z] ---> Making bundle: .ensure-emptyfs (in bundles/test-integration)
12:35:22 [2019-09-27T12:35:22.368Z] Error: No such image: emptyfs
12:35:22 [2019-09-27T12:35:22.368Z] ++++ tar -cC bundles/test-integration/emptyfs .
12:35:22 [2019-09-27T12:35:22.368Z] ++++ docker load
12:35:22 [2019-09-27T12:35:22.744Z] Running integration-test (iteration 1)
12:35:22 [2019-09-27T12:35:22.744Z] Running /go/src/github.com/docker/docker/integration/build (s390x.integration.build) flags=-test.v -test.timeout=120m 
12:35:22 [2019-09-27T12:35:22.744Z] ++ 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
12:35:22 [2019-09-27T12:35:22.744Z] ++ set -e
12:35:22 [2019-09-27T12:35:22.744Z] ++ '[' -n 0 ']'
12:35:22 [2019-09-27T12:35:22.744Z] ++ set -x
12:35:22 [2019-09-27T12:35:22.744Z] ++ 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
12:35:32 [2019-09-27T12:35:32.409Z] Loaded image: buildpack-deps:jessie
12:35:32 [2019-09-27T12:35:32.409Z] Loaded image: busybox:latest
12:35:32 [2019-09-27T12:35:32.409Z] Loaded image: busybox:glibc
12:35:32 [2019-09-27T12:35:32.409Z] Loaded image: debian:jessie
12:35:32 [2019-09-27T12:35:32.409Z] Loaded image: hello-world:latest
12:35:32 [2019-09-27T12:35:32.409Z] INFO: Testing against a local daemon
12:35:32 [2019-09-27T12:35:32.409Z] === RUN   TestCgroupNamespacesBuild
12:35:33 [2019-09-27T12:35:33.214Z] --- PASS: TestCgroupNamespacesBuild (1.67s)
12:35:33 [2019-09-27T12:35:33.214Z]     build_cgroupns_linux_test.go:42: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesBuild"
12:35:33 [2019-09-27T12:35:33.214Z] === RUN   TestCgroupNamespacesBuildDaemonHostMode
12:35:35 [2019-09-27T12:35:35.100Z] --- PASS: TestCgroupNamespacesBuildDaemonHostMode (1.68s)
12:35:35 [2019-09-27T12:35:35.100Z]     build_cgroupns_linux_test.go:42: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesBuildDaemonHostMode"
12:35:35 [2019-09-27T12:35:35.100Z] === RUN   TestBuildWithSession
12:35:38 [2019-09-27T12:35:38.294Z] --- PASS: TestBuildWithSession (3.22s)
12:35:38 [2019-09-27T12:35:38.294Z] === RUN   TestBuildSquashParent
12:35:44 [2019-09-27T12:35:44.696Z] --- PASS: TestBuildSquashParent (6.56s)
12:35:44 [2019-09-27T12:35:44.696Z] === RUN   TestBuildWithRemoveAndForceRemove
12:35:44 [2019-09-27T12:35:44.696Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
12:35:44 [2019-09-27T12:35:44.696Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
12:35:44 [2019-09-27T12:35:44.696Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_remove
12:35:44 [2019-09-27T12:35:44.696Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_remove
12:35:44 [2019-09-27T12:35:44.696Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
12:35:44 [2019-09-27T12:35:44.696Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
12:35:44 [2019-09-27T12:35:44.696Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
12:35:44 [2019-09-27T12:35:44.696Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
12:35:44 [2019-09-27T12:35:44.696Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_remove
12:35:44 [2019-09-27T12:35:44.696Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_remove
12:35:44 [2019-09-27T12:35:44.696Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
12:35:44 [2019-09-27T12:35:44.696Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
12:35:44 [2019-09-27T12:35:44.696Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
12:35:44 [2019-09-27T12:35:44.696Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
12:35:47 [2019-09-27T12:35:47.936Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_remove
12:35:47 [2019-09-27T12:35:47.936Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
12:35:50 [2019-09-27T12:35:50.553Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
12:35:50 [2019-09-27T12:35:50.553Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_remove
12:35:52 [2019-09-27T12:35:52.395Z] --- PASS: TestBuildWithRemoveAndForceRemove (0.01s)
12:35:52 [2019-09-27T12:35:52.395Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove (2.76s)
12:35:52 [2019-09-27T12:35:52.395Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal (2.81s)
12:35:52 [2019-09-27T12:35:52.395Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_remove (2.67s)
12:35:52 [2019-09-27T12:35:52.395Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal (2.68s)
12:35:52 [2019-09-27T12:35:52.395Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove (2.29s)
12:35:52 [2019-09-27T12:35:52.395Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_remove (2.30s)
12:35:52 [2019-09-27T12:35:52.395Z] === RUN   TestBuildMultiStageCopy
12:35:52 [2019-09-27T12:35:52.395Z] === RUN   TestBuildMultiStageCopy/copy_to_root
12:35:55 [2019-09-27T12:35:55.701Z] === RUN   TestBuildMultiStageCopy/copy_to_newdir
12:35:55 [2019-09-27T12:35:55.701Z] === RUN   TestBuildMultiStageCopy/copy_to_newdir_nested
12:35:56 [2019-09-27T12:35:56.064Z] === RUN   TestBuildMultiStageCopy/copy_to_existingdir
12:35:56 [2019-09-27T12:35:56.856Z] === RUN   TestBuildMultiStageCopy/copy_to_newsubdir
12:35:57 [2019-09-27T12:35:57.222Z] --- PASS: TestBuildMultiStageCopy (4.64s)
12:35:57 [2019-09-27T12:35:57.222Z]     --- PASS: TestBuildMultiStageCopy/copy_to_root (2.58s)
12:35:57 [2019-09-27T12:35:57.223Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newdir (0.47s)
12:35:57 [2019-09-27T12:35:57.223Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newdir_nested (0.50s)
12:35:57 [2019-09-27T12:35:57.223Z]     --- PASS: TestBuildMultiStageCopy/copy_to_existingdir (0.55s)
12:35:57 [2019-09-27T12:35:57.223Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newsubdir (0.54s)
12:35:57 [2019-09-27T12:35:57.223Z] === RUN   TestBuildMultiStageParentConfig
12:35:59 [2019-09-27T12:35:59.027Z] --- PASS: TestBuildMultiStageParentConfig (1.75s)
12:35:59 [2019-09-27T12:35:59.027Z] === RUN   TestBuildLabelWithTargets
12:36:00 [2019-09-27T12:36:00.900Z] --- PASS: TestBuildLabelWithTargets (1.96s)
12:36:00 [2019-09-27T12:36:00.900Z] === RUN   TestBuildWithEmptyLayers
12:36:02 [2019-09-27T12:36:02.158Z] --- PASS: TestBuildWithEmptyLayers (1.20s)
12:36:02 [2019-09-27T12:36:02.158Z] === RUN   TestBuildMultiStageOnBuild
12:36:05 [2019-09-27T12:36:05.335Z] --- PASS: TestBuildMultiStageOnBuild (2.84s)
12:36:05 [2019-09-27T12:36:05.336Z] === RUN   TestBuildUncleanTarFilenames
12:36:06 [2019-09-27T12:36:06.297Z] --- PASS: TestBuildUncleanTarFilenames (1.24s)
12:36:06 [2019-09-27T12:36:06.297Z] === RUN   TestBuildMultiStageLayerLeak
12:36:08 [2019-09-27T12:36:08.749Z] --- PASS: TestBuildMultiStageLayerLeak (2.72s)
12:36:08 [2019-09-27T12:36:08.749Z] === RUN   TestBuildWithHugeFile
12:36:43 [2019-09-27T12:36:43.222Z] --- PASS: TestBuildWithHugeFile (31.98s)
12:36:43 [2019-09-27T12:36:43.222Z] === RUN   TestBuildWithEmptyDockerfile
12:36:43 [2019-09-27T12:36:43.222Z] === RUN   TestBuildWithEmptyDockerfile/empty-dockerfile
12:36:43 [2019-09-27T12:36:43.222Z] === PAUSE TestBuildWithEmptyDockerfile/empty-dockerfile
12:36:43 [2019-09-27T12:36:43.222Z] === RUN   TestBuildWithEmptyDockerfile/empty-lines-dockerfile
12:36:43 [2019-09-27T12:36:43.222Z] === PAUSE TestBuildWithEmptyDockerfile/empty-lines-dockerfile
12:36:43 [2019-09-27T12:36:43.222Z] === RUN   TestBuildWithEmptyDockerfile/comment-only-dockerfile
12:36:43 [2019-09-27T12:36:43.222Z] === PAUSE TestBuildWithEmptyDockerfile/comment-only-dockerfile
12:36:43 [2019-09-27T12:36:43.222Z] === CONT  TestBuildWithEmptyDockerfile/empty-dockerfile
12:36:43 [2019-09-27T12:36:43.222Z] === CONT  TestBuildWithEmptyDockerfile/comment-only-dockerfile
12:36:43 [2019-09-27T12:36:43.222Z] === CONT  TestBuildWithEmptyDockerfile/empty-lines-dockerfile
12:36:43 [2019-09-27T12:36:43.222Z] --- PASS: TestBuildWithEmptyDockerfile (0.14s)
12:36:43 [2019-09-27T12:36:43.222Z]     --- PASS: TestBuildWithEmptyDockerfile/empty-dockerfile (0.26s)
12:36:43 [2019-09-27T12:36:43.222Z]     --- PASS: TestBuildWithEmptyDockerfile/comment-only-dockerfile (0.26s)
12:36:43 [2019-09-27T12:36:43.222Z]     --- PASS: TestBuildWithEmptyDockerfile/empty-lines-dockerfile (0.11s)
12:36:43 [2019-09-27T12:36:43.222Z] === RUN   TestBuildPreserveOwnership
12:36:43 [2019-09-27T12:36:43.222Z] === RUN   TestBuildPreserveOwnership/copy_from
12:36:45 [2019-09-27T12:36:45.672Z] === RUN   TestBuildPreserveOwnership/copy_from_chowned
12:36:47 [2019-09-27T12:36:47.510Z] --- PASS: TestBuildPreserveOwnership (6.16s)
12:36:47 [2019-09-27T12:36:47.510Z]     --- PASS: TestBuildPreserveOwnership/copy_from (4.07s)
12:36:47 [2019-09-27T12:36:47.510Z]     --- PASS: TestBuildPreserveOwnership/copy_from_chowned (2.08s)
12:36:47 [2019-09-27T12:36:47.510Z] === RUN   TestBuildPlatformInvalid
12:36:47 [2019-09-27T12:36:47.991Z] --- PASS: TestBuildPlatformInvalid (0.18s)
12:36:47 [2019-09-27T12:36:47.991Z] PASS
12:36:47 [2019-09-27T12:36:47.991Z] 
12:36:47 [2019-09-27T12:36:47.991Z] DONE 32 tests in 85.126s
12:36:47 [2019-09-27T12:36:47.991Z] Running /go/src/github.com/docker/docker/integration/config (s390x.integration.config) flags=-test.v -test.timeout=120m 
12:36:47 [2019-09-27T12:36:47.991Z] ++ 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
12:36:47 [2019-09-27T12:36:47.991Z] ++ set -e
12:36:47 [2019-09-27T12:36:47.991Z] ++ '[' -n 0 ']'
12:36:47 [2019-09-27T12:36:47.991Z] ++ set -x
12:36:47 [2019-09-27T12:36:47.991Z] ++ 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
12:36:48 [2019-09-27T12:36:48.405Z] INFO: Testing against a local daemon
12:36:48 [2019-09-27T12:36:48.405Z] === RUN   TestConfigList
12:36:51 [2019-09-27T12:36:51.596Z] --- PASS: TestConfigList (3.26s)
12:36:51 [2019-09-27T12:36:51.596Z]     config_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigList"
12:36:51 [2019-09-27T12:36:51.596Z] === RUN   TestConfigsCreateAndDelete
12:36:54 [2019-09-27T12:36:54.872Z] --- PASS: TestConfigsCreateAndDelete (3.00s)
12:36:54 [2019-09-27T12:36:54.872Z]     config_test.go:112: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigsCreateAndDelete"
12:36:54 [2019-09-27T12:36:54.872Z] === RUN   TestConfigsUpdate
12:36:57 [2019-09-27T12:36:57.323Z] --- PASS: TestConfigsUpdate (2.88s)
12:36:57 [2019-09-27T12:36:57.324Z]     config_test.go:140: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigsUpdate"
12:36:57 [2019-09-27T12:36:57.324Z] === RUN   TestTemplatedConfig
12:37:00 [2019-09-27T12:37:00.620Z] --- PASS: TestTemplatedConfig (3.00s)
12:37:00 [2019-09-27T12:37:00.620Z]     config_test.go:192: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestTemplatedConfig"
12:37:00 [2019-09-27T12:37:00.620Z] === RUN   TestConfigInspect
12:37:03 [2019-09-27T12:37:03.063Z] --- PASS: TestConfigInspect (2.75s)
12:37:03 [2019-09-27T12:37:03.063Z]     config_test.go:326: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigInspect"
12:37:03 [2019-09-27T12:37:03.063Z] === RUN   TestConfigCreateWithLabels
12:37:06 [2019-09-27T12:37:06.357Z] --- PASS: TestConfigCreateWithLabels (2.72s)
12:37:06 [2019-09-27T12:37:06.357Z]     config_test.go:350: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigCreateWithLabels"
12:37:06 [2019-09-27T12:37:06.357Z] === RUN   TestConfigCreateResolve
12:37:08 [2019-09-27T12:37:08.952Z] --- PASS: TestConfigCreateResolve (3.01s)
12:37:08 [2019-09-27T12:37:08.952Z]     config_test.go:377: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigCreateResolve"
12:37:08 [2019-09-27T12:37:08.952Z] === RUN   TestConfigDaemonLibtrustID
12:37:09 [2019-09-27T12:37:09.320Z] --- PASS: TestConfigDaemonLibtrustID (0.54s)
12:37:09 [2019-09-27T12:37:09.320Z]     config_test.go:427: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigDaemonLibtrustID"
12:37:09 [2019-09-27T12:37:09.320Z] PASS
12:37:09 [2019-09-27T12:37:09.320Z] 
12:37:09 [2019-09-27T12:37:09.320Z] DONE 8 tests in 21.356s
12:37:09 [2019-09-27T12:37:09.320Z] Running /go/src/github.com/docker/docker/integration/container (s390x.integration.container) flags=-test.v -test.timeout=120m 
12:37:09 [2019-09-27T12:37:09.320Z] ++ 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
12:37:09 [2019-09-27T12:37:09.320Z] ++ set -e
12:37:09 [2019-09-27T12:37:09.320Z] ++ '[' -n 0 ']'
12:37:09 [2019-09-27T12:37:09.320Z] ++ set -x
12:37:09 [2019-09-27T12:37:09.320Z] ++ 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
12:37:09 [2019-09-27T12:37:09.688Z] INFO: Testing against a local daemon
12:37:09 [2019-09-27T12:37:09.689Z] === RUN   TestCheckpoint
12:37:09 [2019-09-27T12:37:09.689Z] --- SKIP: TestCheckpoint (0.00s)
12:37:09 [2019-09-27T12:37:09.689Z]     checkpoint_test.go:33: TestCheckpoint is broken; see https://github.com/moby/moby/issues/38963
12:37:09 [2019-09-27T12:37:09.689Z] === RUN   TestContainerInvalidJSON
12:37:09 [2019-09-27T12:37:09.689Z] === RUN   TestContainerInvalidJSON//containers/foobar/copy
12:37:09 [2019-09-27T12:37:09.689Z] === PAUSE TestContainerInvalidJSON//containers/foobar/copy
12:37:09 [2019-09-27T12:37:09.689Z] === RUN   TestContainerInvalidJSON//containers/foobar/exec
12:37:09 [2019-09-27T12:37:09.689Z] === PAUSE TestContainerInvalidJSON//containers/foobar/exec
12:37:09 [2019-09-27T12:37:09.689Z] === RUN   TestContainerInvalidJSON//exec/foobar/start
12:37:09 [2019-09-27T12:37:09.689Z] === PAUSE TestContainerInvalidJSON//exec/foobar/start
12:37:09 [2019-09-27T12:37:09.689Z] === CONT  TestContainerInvalidJSON//containers/foobar/copy
12:37:09 [2019-09-27T12:37:09.689Z] === CONT  TestContainerInvalidJSON//exec/foobar/start
12:37:09 [2019-09-27T12:37:09.689Z] === CONT  TestContainerInvalidJSON//containers/foobar/exec
12:37:09 [2019-09-27T12:37:09.689Z] --- PASS: TestContainerInvalidJSON (0.01s)
12:37:09 [2019-09-27T12:37:09.689Z]     --- PASS: TestContainerInvalidJSON//containers/foobar/copy (0.00s)
12:37:09 [2019-09-27T12:37:09.689Z]     --- PASS: TestContainerInvalidJSON//containers/foobar/exec (0.00s)
12:37:09 [2019-09-27T12:37:09.689Z]     --- PASS: TestContainerInvalidJSON//exec/foobar/start (0.00s)
12:37:09 [2019-09-27T12:37:09.689Z] === RUN   TestCopyFromContainerPathDoesNotExist
12:37:09 [2019-09-27T12:37:09.689Z] --- PASS: TestCopyFromContainerPathDoesNotExist (0.13s)
12:37:09 [2019-09-27T12:37:09.689Z] === RUN   TestCopyFromContainerPathIsNotDir
12:37:10 [2019-09-27T12:37:10.060Z] --- PASS: TestCopyFromContainerPathIsNotDir (0.11s)
12:37:10 [2019-09-27T12:37:10.060Z] === RUN   TestCopyToContainerPathDoesNotExist
12:37:10 [2019-09-27T12:37:10.060Z] --- PASS: TestCopyToContainerPathDoesNotExist (0.10s)
12:37:10 [2019-09-27T12:37:10.060Z] === RUN   TestCopyToContainerPathIsNotDir
12:37:10 [2019-09-27T12:37:10.060Z] --- PASS: TestCopyToContainerPathIsNotDir (0.14s)
12:37:10 [2019-09-27T12:37:10.060Z] === RUN   TestCopyFromContainer
12:37:11 [2019-09-27T12:37:11.946Z] === RUN   TestCopyFromContainer//
12:37:12 [2019-09-27T12:37:12.344Z] === RUN   TestCopyFromContainer//bar/root
12:37:12 [2019-09-27T12:37:12.344Z] === RUN   TestCopyFromContainer//bar/root/
12:37:12 [2019-09-27T12:37:12.344Z] === RUN   TestCopyFromContainer/bar/quux
12:37:12 [2019-09-27T12:37:12.344Z] === RUN   TestCopyFromContainer/bar/quux/
12:37:12 [2019-09-27T12:37:12.717Z] === RUN   TestCopyFromContainer/bar/quux/baz
12:37:12 [2019-09-27T12:37:12.717Z] === RUN   TestCopyFromContainer/bar/filesymlink
12:37:12 [2019-09-27T12:37:12.717Z] === RUN   TestCopyFromContainer/bar/dirsymlink
12:37:12 [2019-09-27T12:37:12.717Z] === RUN   TestCopyFromContainer/bar/dirsymlink/
12:37:12 [2019-09-27T12:37:12.717Z] === RUN   TestCopyFromContainer/bar/notarget
12:37:13 [2019-09-27T12:37:13.105Z] --- PASS: TestCopyFromContainer (2.79s)
12:37:13 [2019-09-27T12:37:13.105Z]     --- PASS: TestCopyFromContainer// (0.07s)
12:37:13 [2019-09-27T12:37:13.105Z]     --- PASS: TestCopyFromContainer//bar/root (0.12s)
12:37:13 [2019-09-27T12:37:13.105Z]     --- PASS: TestCopyFromContainer//bar/root/ (0.06s)
12:37:13 [2019-09-27T12:37:13.105Z]     --- PASS: TestCopyFromContainer/bar/quux (0.15s)
12:37:13 [2019-09-27T12:37:13.105Z]     --- PASS: TestCopyFromContainer/bar/quux/ (0.09s)
12:37:13 [2019-09-27T12:37:13.105Z]     --- PASS: TestCopyFromContainer/bar/quux/baz (0.08s)
12:37:13 [2019-09-27T12:37:13.105Z]     --- PASS: TestCopyFromContainer/bar/filesymlink (0.08s)
12:37:13 [2019-09-27T12:37:13.105Z]     --- PASS: TestCopyFromContainer/bar/dirsymlink (0.07s)
12:37:13 [2019-09-27T12:37:13.105Z]     --- PASS: TestCopyFromContainer/bar/dirsymlink/ (0.06s)
12:37:13 [2019-09-27T12:37:13.105Z]     --- PASS: TestCopyFromContainer/bar/notarget (0.07s)
12:37:13 [2019-09-27T12:37:13.105Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist
12:37:13 [2019-09-27T12:37:13.105Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
12:37:13 [2019-09-27T12:37:13.105Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
12:37:13 [2019-09-27T12:37:13.105Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
12:37:13 [2019-09-27T12:37:13.105Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
12:37:13 [2019-09-27T12:37:13.105Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/digest
12:37:13 [2019-09-27T12:37:13.105Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/digest
12:37:13 [2019-09-27T12:37:13.105Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
12:37:13 [2019-09-27T12:37:13.105Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/digest
12:37:13 [2019-09-27T12:37:13.105Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
12:37:13 [2019-09-27T12:37:13.105Z] --- PASS: TestCreateFailsWhenIdentifierDoesNotExist (0.01s)
12:37:13 [2019-09-27T12:37:13.105Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/digest (0.00s)
12:37:13 [2019-09-27T12:37:13.105Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag (0.00s)
12:37:13 [2019-09-27T12:37:13.105Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag (0.00s)
12:37:13 [2019-09-27T12:37:13.105Z] === RUN   TestCreateLinkToNonExistingContainer
12:37:13 [2019-09-27T12:37:13.105Z] --- PASS: TestCreateLinkToNonExistingContainer (0.04s)
12:37:13 [2019-09-27T12:37:13.105Z] === RUN   TestCreateWithInvalidEnv
12:37:13 [2019-09-27T12:37:13.105Z] === RUN   TestCreateWithInvalidEnv/0
12:37:13 [2019-09-27T12:37:13.105Z] === PAUSE TestCreateWithInvalidEnv/0
12:37:13 [2019-09-27T12:37:13.105Z] === RUN   TestCreateWithInvalidEnv/1
12:37:13 [2019-09-27T12:37:13.105Z] === PAUSE TestCreateWithInvalidEnv/1
12:37:13 [2019-09-27T12:37:13.105Z] === RUN   TestCreateWithInvalidEnv/2
12:37:13 [2019-09-27T12:37:13.105Z] === PAUSE TestCreateWithInvalidEnv/2
12:37:13 [2019-09-27T12:37:13.105Z] === CONT  TestCreateWithInvalidEnv/0
12:37:13 [2019-09-27T12:37:13.105Z] === CONT  TestCreateWithInvalidEnv/2
12:37:13 [2019-09-27T12:37:13.105Z] === CONT  TestCreateWithInvalidEnv/1
12:37:13 [2019-09-27T12:37:13.105Z] --- PASS: TestCreateWithInvalidEnv (0.01s)
12:37:13 [2019-09-27T12:37:13.105Z]     --- PASS: TestCreateWithInvalidEnv/2 (0.00s)
12:37:13 [2019-09-27T12:37:13.105Z]     --- PASS: TestCreateWithInvalidEnv/1 (0.00s)
12:37:13 [2019-09-27T12:37:13.105Z]     --- PASS: TestCreateWithInvalidEnv/0 (0.00s)
12:37:13 [2019-09-27T12:37:13.105Z] === RUN   TestCreateTmpfsMountsTarget
12:37:13 [2019-09-27T12:37:13.105Z] --- PASS: TestCreateTmpfsMountsTarget (0.03s)
12:37:13 [2019-09-27T12:37:13.105Z] === RUN   TestCreateWithCustomMaskedPaths
12:37:15 [2019-09-27T12:37:15.582Z] --- PASS: TestCreateWithCustomMaskedPaths (2.62s)
12:37:15 [2019-09-27T12:37:15.582Z] === RUN   TestCreateWithCapabilities
12:37:15 [2019-09-27T12:37:15.582Z] === RUN   TestCreateWithCapabilities/no_capabilities
12:37:15 [2019-09-27T12:37:15.582Z] === PAUSE TestCreateWithCapabilities/no_capabilities
12:37:15 [2019-09-27T12:37:15.582Z] === RUN   TestCreateWithCapabilities/empty_capabilities
12:37:15 [2019-09-27T12:37:15.582Z] === PAUSE TestCreateWithCapabilities/empty_capabilities
12:37:15 [2019-09-27T12:37:15.582Z] === RUN   TestCreateWithCapabilities/valid_capabilities
12:37:15 [2019-09-27T12:37:15.582Z] === PAUSE TestCreateWithCapabilities/valid_capabilities
12:37:15 [2019-09-27T12:37:15.582Z] === RUN   TestCreateWithCapabilities/invalid_capabilities
12:37:15 [2019-09-27T12:37:15.582Z] === PAUSE TestCreateWithCapabilities/invalid_capabilities
12:37:15 [2019-09-27T12:37:15.582Z] === RUN   TestCreateWithCapabilities/duplicate_capabilities
12:37:15 [2019-09-27T12:37:15.582Z] === PAUSE TestCreateWithCapabilities/duplicate_capabilities
12:37:15 [2019-09-27T12:37:15.582Z] === RUN   TestCreateWithCapabilities/capabilities_API_v1.39
12:37:15 [2019-09-27T12:37:15.582Z] === PAUSE TestCreateWithCapabilities/capabilities_API_v1.39
12:37:15 [2019-09-27T12:37:15.582Z] === RUN   TestCreateWithCapabilities/empty_capadd
12:37:15 [2019-09-27T12:37:15.582Z] === PAUSE TestCreateWithCapabilities/empty_capadd
12:37:15 [2019-09-27T12:37:15.582Z] === RUN   TestCreateWithCapabilities/empty_capdrop
12:37:15 [2019-09-27T12:37:15.582Z] === PAUSE TestCreateWithCapabilities/empty_capdrop
12:37:15 [2019-09-27T12:37:15.582Z] === RUN   TestCreateWithCapabilities/capadd_capdrop
12:37:15 [2019-09-27T12:37:15.582Z] === PAUSE TestCreateWithCapabilities/capadd_capdrop
12:37:15 [2019-09-27T12:37:15.582Z] === RUN   TestCreateWithCapabilities/conflict_with_capadd
12:37:15 [2019-09-27T12:37:15.582Z] === PAUSE TestCreateWithCapabilities/conflict_with_capadd
12:37:15 [2019-09-27T12:37:15.582Z] === RUN   TestCreateWithCapabilities/conflict_with_capdrop
12:37:15 [2019-09-27T12:37:15.582Z] === PAUSE TestCreateWithCapabilities/conflict_with_capdrop
12:37:15 [2019-09-27T12:37:15.582Z] === CONT  TestCreateWithCapabilities/no_capabilities
12:37:15 [2019-09-27T12:37:15.582Z] === CONT  TestCreateWithCapabilities/conflict_with_capdrop
12:37:15 [2019-09-27T12:37:15.582Z] === CONT  TestCreateWithCapabilities/conflict_with_capadd
12:37:15 [2019-09-27T12:37:15.582Z] === CONT  TestCreateWithCapabilities/capadd_capdrop
12:37:15 [2019-09-27T12:37:15.961Z] === CONT  TestCreateWithCapabilities/empty_capdrop
12:37:15 [2019-09-27T12:37:15.961Z] === CONT  TestCreateWithCapabilities/empty_capadd
12:37:15 [2019-09-27T12:37:15.961Z] === CONT  TestCreateWithCapabilities/capabilities_API_v1.39
12:37:15 [2019-09-27T12:37:15.961Z] === CONT  TestCreateWithCapabilities/duplicate_capabilities
12:37:15 [2019-09-27T12:37:15.961Z] === CONT  TestCreateWithCapabilities/invalid_capabilities
12:37:15 [2019-09-27T12:37:15.961Z] === CONT  TestCreateWithCapabilities/valid_capabilities
12:37:15 [2019-09-27T12:37:15.961Z] === CONT  TestCreateWithCapabilities/empty_capabilities
12:37:15 [2019-09-27T12:37:15.961Z] --- PASS: TestCreateWithCapabilities (0.01s)
12:37:15 [2019-09-27T12:37:15.961Z]     --- PASS: TestCreateWithCapabilities/conflict_with_capdrop (0.00s)
12:37:15 [2019-09-27T12:37:15.961Z]     --- PASS: TestCreateWithCapabilities/conflict_with_capadd (0.00s)
12:37:15 [2019-09-27T12:37:15.961Z]     --- PASS: TestCreateWithCapabilities/no_capabilities (0.08s)
12:37:15 [2019-09-27T12:37:15.961Z]     --- PASS: TestCreateWithCapabilities/capadd_capdrop (0.08s)
12:37:15 [2019-09-27T12:37:15.961Z]     --- PASS: TestCreateWithCapabilities/empty_capdrop (0.07s)
12:37:15 [2019-09-27T12:37:15.961Z]     --- PASS: TestCreateWithCapabilities/empty_capadd (0.07s)
12:37:15 [2019-09-27T12:37:15.961Z]     --- PASS: TestCreateWithCapabilities/capabilities_API_v1.39 (0.06s)
12:37:15 [2019-09-27T12:37:15.961Z]     --- PASS: TestCreateWithCapabilities/invalid_capabilities (0.00s)
12:37:15 [2019-09-27T12:37:15.961Z]     --- PASS: TestCreateWithCapabilities/duplicate_capabilities (0.08s)
12:37:15 [2019-09-27T12:37:15.961Z]     --- PASS: TestCreateWithCapabilities/valid_capabilities (0.06s)
12:37:15 [2019-09-27T12:37:15.961Z]     --- PASS: TestCreateWithCapabilities/empty_capabilities (0.06s)
12:37:15 [2019-09-27T12:37:15.961Z] === RUN   TestCreateWithCustomReadonlyPaths
12:37:19 [2019-09-27T12:37:19.283Z] --- PASS: TestCreateWithCustomReadonlyPaths (2.73s)
12:37:19 [2019-09-27T12:37:19.283Z] === RUN   TestCreateWithInvalidHealthcheckParams
12:37:19 [2019-09-27T12:37:19.283Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
12:37:19 [2019-09-27T12:37:19.283Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
12:37:19 [2019-09-27T12:37:19.283Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
12:37:19 [2019-09-27T12:37:19.283Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
12:37:19 [2019-09-27T12:37:19.284Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
12:37:19 [2019-09-27T12:37:19.284Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
12:37:19 [2019-09-27T12:37:19.284Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
12:37:19 [2019-09-27T12:37:19.284Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
12:37:19 [2019-09-27T12:37:19.284Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
12:37:19 [2019-09-27T12:37:19.284Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
12:37:19 [2019-09-27T12:37:19.284Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
12:37:19 [2019-09-27T12:37:19.284Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
12:37:19 [2019-09-27T12:37:19.284Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
12:37:19 [2019-09-27T12:37:19.284Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
12:37:19 [2019-09-27T12:37:19.284Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
12:37:19 [2019-09-27T12:37:19.284Z] --- PASS: TestCreateWithInvalidHealthcheckParams (0.02s)
12:37:19 [2019-09-27T12:37:19.284Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms (0.01s)
12:37:19 [2019-09-27T12:37:19.284Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s (0.01s)
12:37:19 [2019-09-27T12:37:19.284Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0 (0.01s)
12:37:19 [2019-09-27T12:37:19.284Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms (0.01s)
12:37:19 [2019-09-27T12:37:19.284Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms (0.00s)
12:37:19 [2019-09-27T12:37:19.284Z] === RUN   TestContainerStartOnDaemonRestart
12:37:19 [2019-09-27T12:37:19.284Z] === PAUSE TestContainerStartOnDaemonRestart
12:37:19 [2019-09-27T12:37:19.284Z] === RUN   TestDaemonRestartIpcMode
12:37:19 [2019-09-27T12:37:19.284Z] === PAUSE TestDaemonRestartIpcMode
12:37:19 [2019-09-27T12:37:19.284Z] === RUN   TestDiff
12:37:19 [2019-09-27T12:37:19.660Z] --- PASS: TestDiff (1.07s)
12:37:19 [2019-09-27T12:37:19.660Z] === RUN   TestExecWithCloseStdin
12:37:20 [2019-09-27T12:37:20.909Z] --- PASS: TestExecWithCloseStdin (1.05s)
12:37:20 [2019-09-27T12:37:20.909Z] === RUN   TestExec
12:37:22 [2019-09-27T12:37:22.166Z] --- PASS: TestExec (1.07s)
12:37:22 [2019-09-27T12:37:22.166Z] === RUN   TestExecUser
12:37:23 [2019-09-27T12:37:23.026Z] --- PASS: TestExecUser (1.11s)
12:37:23 [2019-09-27T12:37:23.026Z] === RUN   TestExportContainerAndImportImage
12:37:24 [2019-09-27T12:37:24.305Z] --- PASS: TestExportContainerAndImportImage (1.18s)
12:37:24 [2019-09-27T12:37:24.305Z] === RUN   TestExportContainerAfterDaemonRestart
12:37:26 [2019-09-27T12:37:26.114Z] --- PASS: TestExportContainerAfterDaemonRestart (1.58s)
12:37:26 [2019-09-27T12:37:26.114Z]     export_test.go:63: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestExportContainerAfterDaemonRestart"
12:37:26 [2019-09-27T12:37:26.114Z] === RUN   TestHealthCheckWorkdir
12:37:26 [2019-09-27T12:37:26.897Z] --- PASS: TestHealthCheckWorkdir (1.18s)
12:37:26 [2019-09-27T12:37:26.897Z] === RUN   TestHealthKillContainer
12:37:30 [2019-09-27T12:37:30.074Z] --- PASS: TestHealthKillContainer (3.04s)
12:37:30 [2019-09-27T12:37:30.074Z] === RUN   TestInspectCpusetInConfigPre120
12:37:30 [2019-09-27T12:37:30.862Z] --- PASS: TestInspectCpusetInConfigPre120 (1.02s)
12:37:30 [2019-09-27T12:37:30.863Z] === RUN   TestIpcModeNone
12:37:32 [2019-09-27T12:37:32.133Z] --- PASS: TestIpcModeNone (1.13s)
12:37:32 [2019-09-27T12:37:32.133Z] === RUN   TestIpcModePrivate
12:37:33 [2019-09-27T12:37:33.448Z] --- PASS: TestIpcModePrivate (1.21s)
12:37:33 [2019-09-27T12:37:33.448Z]     ipcmode_linux_test.go:90: [testIpcPrivateShareable] ipcmode: private, ipcdev: 0:56, shared: false, mustBeShared: false
12:37:33 [2019-09-27T12:37:33.448Z] === RUN   TestIpcModeShareable
12:37:34 [2019-09-27T12:37:34.741Z] --- PASS: TestIpcModeShareable (1.16s)
12:37:34 [2019-09-27T12:37:34.741Z]     ipcmode_linux_test.go:90: [testIpcPrivateShareable] ipcmode: shareable, ipcdev: 0:50, shared: true, mustBeShared: true
12:37:34 [2019-09-27T12:37:34.741Z] === RUN   TestAPIIpcModeShareableAndContainer
12:37:39 [2019-09-27T12:37:39.862Z] --- PASS: TestAPIIpcModeShareableAndContainer (4.82s)
12:37:39 [2019-09-27T12:37:39.862Z] === RUN   TestAPIIpcModeHost
12:37:40 [2019-09-27T12:37:40.279Z] --- PASS: TestAPIIpcModeHost (0.80s)
12:37:40 [2019-09-27T12:37:40.279Z] === RUN   TestDaemonIpcModeShareable
12:37:42 [2019-09-27T12:37:42.169Z] --- PASS: TestDaemonIpcModeShareable (1.98s)
12:37:42 [2019-09-27T12:37:42.169Z]     ipcmode_linux_test.go:230: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModeShareable"
12:37:42 [2019-09-27T12:37:42.169Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:58, shared: true, mustBeShared: true
12:37:42 [2019-09-27T12:37:42.169Z] === RUN   TestDaemonIpcModePrivate
12:37:44 [2019-09-27T12:37:44.616Z] --- PASS: TestDaemonIpcModePrivate (2.32s)
12:37:44 [2019-09-27T12:37:44.616Z]     ipcmode_linux_test.go:230: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModePrivate"
12:37:44 [2019-09-27T12:37:44.616Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:64, shared: false, mustBeShared: false
12:37:44 [2019-09-27T12:37:44.616Z] === RUN   TestDaemonIpcModePrivateFromConfig
12:37:47 [2019-09-27T12:37:47.155Z] --- PASS: TestDaemonIpcModePrivateFromConfig (2.57s)
12:37:47 [2019-09-27T12:37:47.155Z]     ipcmode_linux_test.go:230: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModePrivateFromConfig"
12:37:47 [2019-09-27T12:37:47.155Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:64, shared: false, mustBeShared: false
12:37:47 [2019-09-27T12:37:47.155Z] === RUN   TestDaemonIpcModeShareableFromConfig
12:37:49 [2019-09-27T12:37:49.645Z] --- PASS: TestDaemonIpcModeShareableFromConfig (2.17s)
12:37:49 [2019-09-27T12:37:49.645Z]     ipcmode_linux_test.go:230: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModeShareableFromConfig"
12:37:49 [2019-09-27T12:37:49.645Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:58, shared: true, mustBeShared: true
12:37:49 [2019-09-27T12:37:49.645Z] === RUN   TestIpcModeOlderClient
12:37:49 [2019-09-27T12:37:49.645Z] === PAUSE TestIpcModeOlderClient
12:37:49 [2019-09-27T12:37:49.645Z] === RUN   TestKillContainerInvalidSignal
12:37:50 [2019-09-27T12:37:50.423Z] --- PASS: TestKillContainerInvalidSignal (1.04s)
12:37:50 [2019-09-27T12:37:50.423Z] === RUN   TestKillContainer
12:37:50 [2019-09-27T12:37:50.423Z] === RUN   TestKillContainer/no_signal
12:37:51 [2019-09-27T12:37:51.260Z] === RUN   TestKillContainer/non_killing_signal
12:37:52 [2019-09-27T12:37:52.076Z] === RUN   TestKillContainer/killing_signal
12:37:53 [2019-09-27T12:37:53.871Z] --- PASS: TestKillContainer (3.63s)
12:37:53 [2019-09-27T12:37:53.871Z]     --- PASS: TestKillContainer/no_signal (1.12s)
12:37:53 [2019-09-27T12:37:53.871Z]     --- PASS: TestKillContainer/non_killing_signal (0.71s)
12:37:53 [2019-09-27T12:37:53.871Z]     --- PASS: TestKillContainer/killing_signal (1.43s)
12:37:53 [2019-09-27T12:37:53.871Z] === RUN   TestKillWithStopSignalAndRestartPolicies
12:37:53 [2019-09-27T12:37:53.871Z] === RUN   TestKillWithStopSignalAndRestartPolicies/same-signal-disables-restart-policy
12:37:54 [2019-09-27T12:37:54.678Z] === RUN   TestKillWithStopSignalAndRestartPolicies/different-signal-keep-restart-policy
12:37:56 [2019-09-27T12:37:56.600Z] --- PASS: TestKillWithStopSignalAndRestartPolicies (2.61s)
12:37:56 [2019-09-27T12:37:56.600Z]     --- PASS: TestKillWithStopSignalAndRestartPolicies/same-signal-disables-restart-policy (0.88s)
12:37:56 [2019-09-27T12:37:56.600Z]     --- PASS: TestKillWithStopSignalAndRestartPolicies/different-signal-keep-restart-policy (1.01s)
12:37:56 [2019-09-27T12:37:56.600Z] === RUN   TestKillStoppedContainer
12:37:56 [2019-09-27T12:37:56.600Z] --- PASS: TestKillStoppedContainer (0.15s)
12:37:56 [2019-09-27T12:37:56.600Z] === RUN   TestKillStoppedContainerAPIPre120
12:37:57 [2019-09-27T12:37:57.024Z] --- PASS: TestKillStoppedContainerAPIPre120 (0.19s)
12:37:57 [2019-09-27T12:37:57.024Z] === RUN   TestKillDifferentUserContainer
12:37:57 [2019-09-27T12:37:57.808Z] --- PASS: TestKillDifferentUserContainer (0.87s)
12:37:57 [2019-09-27T12:37:57.808Z] === RUN   TestInspectOomKilledTrue
12:37:57 [2019-09-27T12:37:57.808Z] --- SKIP: TestInspectOomKilledTrue (0.00s)
12:37:57 [2019-09-27T12:37:57.808Z]     kill_test.go:151: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
12:37:57 [2019-09-27T12:37:57.808Z] === RUN   TestInspectOomKilledFalse
12:37:57 [2019-09-27T12:37:57.808Z] --- SKIP: TestInspectOomKilledFalse (0.00s)
12:37:57 [2019-09-27T12:37:57.808Z]     kill_test.go:169: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
12:37:57 [2019-09-27T12:37:57.808Z] === RUN   TestLinksEtcHostsContentMatch
12:37:58 [2019-09-27T12:37:58.596Z] --- PASS: TestLinksEtcHostsContentMatch (0.75s)
12:37:58 [2019-09-27T12:37:58.596Z] === RUN   TestLinksContainerNames
12:38:00 [2019-09-27T12:38:00.422Z] --- PASS: TestLinksContainerNames (1.74s)
12:38:00 [2019-09-27T12:38:00.422Z] === RUN   TestLogsFollowTailEmpty
12:38:01 [2019-09-27T12:38:01.224Z] --- PASS: TestLogsFollowTailEmpty (0.96s)
12:38:01 [2019-09-27T12:38:01.224Z] === RUN   TestContainerNetworkMountsNoChown
12:38:02 [2019-09-27T12:38:02.159Z] --- PASS: TestContainerNetworkMountsNoChown (1.00s)
12:38:02 [2019-09-27T12:38:02.159Z] === RUN   TestMountDaemonRoot
12:38:02 [2019-09-27T12:38:02.159Z] === RUN   TestMountDaemonRoot/default
12:38:02 [2019-09-27T12:38:02.159Z] === PAUSE TestMountDaemonRoot/default
12:38:02 [2019-09-27T12:38:02.159Z] === RUN   TestMountDaemonRoot/private
12:38:02 [2019-09-27T12:38:02.159Z] === PAUSE TestMountDaemonRoot/private
12:38:02 [2019-09-27T12:38:02.159Z] === RUN   TestMountDaemonRoot/rprivate
12:38:02 [2019-09-27T12:38:02.159Z] === PAUSE TestMountDaemonRoot/rprivate
12:38:02 [2019-09-27T12:38:02.159Z] === RUN   TestMountDaemonRoot/slave
12:38:02 [2019-09-27T12:38:02.159Z] === PAUSE TestMountDaemonRoot/slave
12:38:02 [2019-09-27T12:38:02.159Z] === RUN   TestMountDaemonRoot/rslave
12:38:02 [2019-09-27T12:38:02.159Z] === PAUSE TestMountDaemonRoot/rslave
12:38:02 [2019-09-27T12:38:02.159Z] === RUN   TestMountDaemonRoot/shared
12:38:02 [2019-09-27T12:38:02.159Z] === PAUSE TestMountDaemonRoot/shared
12:38:02 [2019-09-27T12:38:02.159Z] === RUN   TestMountDaemonRoot/rshared
12:38:02 [2019-09-27T12:38:02.159Z] === PAUSE TestMountDaemonRoot/rshared
12:38:02 [2019-09-27T12:38:02.159Z] === CONT  TestMountDaemonRoot/default
12:38:02 [2019-09-27T12:38:02.159Z] === RUN   TestMountDaemonRoot/default/bind_root
12:38:02 [2019-09-27T12:38:02.159Z] === PAUSE TestMountDaemonRoot/default/bind_root
12:38:02 [2019-09-27T12:38:02.159Z] === RUN   TestMountDaemonRoot/default/bind_subpath
12:38:02 [2019-09-27T12:38:02.159Z] === PAUSE TestMountDaemonRoot/default/bind_subpath
12:38:02 [2019-09-27T12:38:02.159Z] === RUN   TestMountDaemonRoot/default/mount_root
12:38:02 [2019-09-27T12:38:02.159Z] === PAUSE TestMountDaemonRoot/default/mount_root
12:38:02 [2019-09-27T12:38:02.159Z] === RUN   TestMountDaemonRoot/default/mount_subpath
12:38:02 [2019-09-27T12:38:02.159Z] === PAUSE TestMountDaemonRoot/default/mount_subpath
12:38:02 [2019-09-27T12:38:02.159Z] === CONT  TestMountDaemonRoot/default/bind_root
12:38:02 [2019-09-27T12:38:02.159Z] === CONT  TestMountDaemonRoot/rshared
12:38:02 [2019-09-27T12:38:02.159Z] === RUN   TestMountDaemonRoot/rshared/bind_root
12:38:02 [2019-09-27T12:38:02.159Z] === PAUSE TestMountDaemonRoot/rshared/bind_root
12:38:02 [2019-09-27T12:38:02.159Z] === RUN   TestMountDaemonRoot/rshared/bind_subpath
12:38:02 [2019-09-27T12:38:02.159Z] === PAUSE TestMountDaemonRoot/rshared/bind_subpath
12:38:02 [2019-09-27T12:38:02.159Z] === RUN   TestMountDaemonRoot/rshared/mount_root
12:38:02 [2019-09-27T12:38:02.159Z] === PAUSE TestMountDaemonRoot/rshared/mount_root
12:38:02 [2019-09-27T12:38:02.159Z] === RUN   TestMountDaemonRoot/rshared/mount_subpath
12:38:02 [2019-09-27T12:38:02.159Z] === PAUSE TestMountDaemonRoot/rshared/mount_subpath
12:38:02 [2019-09-27T12:38:02.159Z] === CONT  TestMountDaemonRoot/rshared/bind_root
12:38:02 [2019-09-27T12:38:02.159Z] === CONT  TestMountDaemonRoot/shared
12:38:02 [2019-09-27T12:38:02.159Z] === RUN   TestMountDaemonRoot/shared/bind_root
12:38:02 [2019-09-27T12:38:02.159Z] === PAUSE TestMountDaemonRoot/shared/bind_root
12:38:02 [2019-09-27T12:38:02.159Z] === RUN   TestMountDaemonRoot/shared/bind_subpath
12:38:02 [2019-09-27T12:38:02.159Z] === PAUSE TestMountDaemonRoot/shared/bind_subpath
12:38:02 [2019-09-27T12:38:02.159Z] === RUN   TestMountDaemonRoot/shared/mount_root
12:38:02 [2019-09-27T12:38:02.159Z] === PAUSE TestMountDaemonRoot/shared/mount_root
12:38:02 [2019-09-27T12:38:02.159Z] === RUN   TestMountDaemonRoot/shared/mount_subpath
12:38:02 [2019-09-27T12:38:02.159Z] === PAUSE TestMountDaemonRoot/shared/mount_subpath
12:38:02 [2019-09-27T12:38:02.159Z] === CONT  TestMountDaemonRoot/rslave
12:38:02 [2019-09-27T12:38:02.159Z] === RUN   TestMountDaemonRoot/rslave/bind_root
12:38:02 [2019-09-27T12:38:02.159Z] === PAUSE TestMountDaemonRoot/rslave/bind_root
12:38:02 [2019-09-27T12:38:02.159Z] === RUN   TestMountDaemonRoot/rslave/bind_subpath
12:38:02 [2019-09-27T12:38:02.159Z] === PAUSE TestMountDaemonRoot/rslave/bind_subpath
12:38:02 [2019-09-27T12:38:02.159Z] === RUN   TestMountDaemonRoot/rslave/mount_root
12:38:02 [2019-09-27T12:38:02.159Z] === PAUSE TestMountDaemonRoot/rslave/mount_root
12:38:02 [2019-09-27T12:38:02.159Z] === RUN   TestMountDaemonRoot/rslave/mount_subpath
12:38:02 [2019-09-27T12:38:02.159Z] === PAUSE TestMountDaemonRoot/rslave/mount_subpath
12:38:02 [2019-09-27T12:38:02.159Z] === CONT  TestMountDaemonRoot/slave
12:38:02 [2019-09-27T12:38:02.159Z] === RUN   TestMountDaemonRoot/slave/mount_subpath
12:38:02 [2019-09-27T12:38:02.159Z] === PAUSE TestMountDaemonRoot/slave/mount_subpath
12:38:02 [2019-09-27T12:38:02.159Z] === RUN   TestMountDaemonRoot/slave/bind_root
12:38:02 [2019-09-27T12:38:02.159Z] === PAUSE TestMountDaemonRoot/slave/bind_root
12:38:02 [2019-09-27T12:38:02.159Z] === RUN   TestMountDaemonRoot/slave/bind_subpath
12:38:02 [2019-09-27T12:38:02.159Z] === PAUSE TestMountDaemonRoot/slave/bind_subpath
12:38:02 [2019-09-27T12:38:02.159Z] === RUN   TestMountDaemonRoot/slave/mount_root
12:38:02 [2019-09-27T12:38:02.159Z] === PAUSE TestMountDaemonRoot/slave/mount_root
12:38:02 [2019-09-27T12:38:02.159Z] === CONT  TestMountDaemonRoot/rprivate
12:38:02 [2019-09-27T12:38:02.159Z] === RUN   TestMountDaemonRoot/rprivate/bind_root
12:38:02 [2019-09-27T12:38:02.159Z] === PAUSE TestMountDaemonRoot/rprivate/bind_root
12:38:02 [2019-09-27T12:38:02.159Z] === RUN   TestMountDaemonRoot/rprivate/bind_subpath
12:38:02 [2019-09-27T12:38:02.159Z] === PAUSE TestMountDaemonRoot/rprivate/bind_subpath
12:38:02 [2019-09-27T12:38:02.159Z] === RUN   TestMountDaemonRoot/rprivate/mount_root
12:38:02 [2019-09-27T12:38:02.159Z] === PAUSE TestMountDaemonRoot/rprivate/mount_root
12:38:02 [2019-09-27T12:38:02.159Z] === RUN   TestMountDaemonRoot/rprivate/mount_subpath
12:38:02 [2019-09-27T12:38:02.159Z] === PAUSE TestMountDaemonRoot/rprivate/mount_subpath
12:38:02 [2019-09-27T12:38:02.159Z] === CONT  TestMountDaemonRoot/private
12:38:02 [2019-09-27T12:38:02.159Z] === RUN   TestMountDaemonRoot/private/mount_root
12:38:02 [2019-09-27T12:38:02.159Z] === PAUSE TestMountDaemonRoot/private/mount_root
12:38:02 [2019-09-27T12:38:02.159Z] === RUN   TestMountDaemonRoot/private/mount_subpath
12:38:02 [2019-09-27T12:38:02.159Z] === PAUSE TestMountDaemonRoot/private/mount_subpath
12:38:02 [2019-09-27T12:38:02.159Z] === RUN   TestMountDaemonRoot/private/bind_root
12:38:02 [2019-09-27T12:38:02.159Z] === PAUSE TestMountDaemonRoot/private/bind_root
12:38:02 [2019-09-27T12:38:02.159Z] === RUN   TestMountDaemonRoot/private/bind_subpath
12:38:02 [2019-09-27T12:38:02.159Z] === PAUSE TestMountDaemonRoot/private/bind_subpath
12:38:02 [2019-09-27T12:38:02.159Z] === CONT  TestMountDaemonRoot/default/mount_subpath
12:38:02 [2019-09-27T12:38:02.159Z] === CONT  TestMountDaemonRoot/default/mount_root
12:38:02 [2019-09-27T12:38:02.530Z] === CONT  TestMountDaemonRoot/default/bind_subpath
12:38:02 [2019-09-27T12:38:02.530Z] === CONT  TestMountDaemonRoot/rshared/mount_subpath
12:38:02 [2019-09-27T12:38:02.530Z] === CONT  TestMountDaemonRoot/rshared/mount_root
12:38:02 [2019-09-27T12:38:02.530Z] === CONT  TestMountDaemonRoot/rshared/bind_subpath
12:38:02 [2019-09-27T12:38:02.530Z] === CONT  TestMountDaemonRoot/shared/bind_root
12:38:02 [2019-09-27T12:38:02.530Z] === CONT  TestMountDaemonRoot/rslave/bind_root
12:38:02 [2019-09-27T12:38:02.530Z] === CONT  TestMountDaemonRoot/shared/mount_subpath
12:38:02 [2019-09-27T12:38:02.530Z] === CONT  TestMountDaemonRoot/shared/mount_root
12:38:02 [2019-09-27T12:38:02.530Z] === CONT  TestMountDaemonRoot/shared/bind_subpath
12:38:02 [2019-09-27T12:38:02.530Z] === CONT  TestMountDaemonRoot/slave/mount_subpath
12:38:02 [2019-09-27T12:38:02.530Z] === CONT  TestMountDaemonRoot/rslave/mount_subpath
12:38:02 [2019-09-27T12:38:02.530Z] === CONT  TestMountDaemonRoot/rslave/mount_root
12:38:02 [2019-09-27T12:38:02.911Z] === CONT  TestMountDaemonRoot/rslave/bind_subpath
12:38:02 [2019-09-27T12:38:02.911Z] === CONT  TestMountDaemonRoot/rprivate/bind_root
12:38:02 [2019-09-27T12:38:02.911Z] === CONT  TestMountDaemonRoot/slave/mount_root
12:38:02 [2019-09-27T12:38:02.911Z] === CONT  TestMountDaemonRoot/slave/bind_subpath
12:38:02 [2019-09-27T12:38:02.911Z] === CONT  TestMountDaemonRoot/slave/bind_root
12:38:02 [2019-09-27T12:38:02.911Z] === CONT  TestMountDaemonRoot/private/mount_root
12:38:02 [2019-09-27T12:38:02.911Z] === CONT  TestMountDaemonRoot/rprivate/mount_subpath
12:38:02 [2019-09-27T12:38:02.911Z] === CONT  TestMountDaemonRoot/rprivate/mount_root
12:38:02 [2019-09-27T12:38:02.911Z] === CONT  TestMountDaemonRoot/rprivate/bind_subpath
12:38:02 [2019-09-27T12:38:02.911Z] === CONT  TestMountDaemonRoot/private/bind_subpath
12:38:02 [2019-09-27T12:38:02.911Z] === CONT  TestMountDaemonRoot/private/bind_root
12:38:02 [2019-09-27T12:38:02.911Z] === CONT  TestMountDaemonRoot/private/mount_subpath
12:38:02 [2019-09-27T12:38:02.911Z] --- PASS: TestMountDaemonRoot (0.02s)
12:38:02 [2019-09-27T12:38:02.911Z]     --- PASS: TestMountDaemonRoot/default (0.00s)
12:38:02 [2019-09-27T12:38:02.911Z]         --- PASS: TestMountDaemonRoot/default/bind_root (0.11s)
12:38:02 [2019-09-27T12:38:02.911Z]         --- PASS: TestMountDaemonRoot/default/mount_subpath (0.08s)
12:38:02 [2019-09-27T12:38:02.911Z]         --- PASS: TestMountDaemonRoot/default/mount_root (0.10s)
12:38:02 [2019-09-27T12:38:02.911Z]         --- PASS: TestMountDaemonRoot/default/bind_subpath (0.09s)
12:38:02 [2019-09-27T12:38:02.911Z]     --- PASS: TestMountDaemonRoot/rshared (0.00s)
12:38:02 [2019-09-27T12:38:02.911Z]         --- PASS: TestMountDaemonRoot/rshared/bind_root (0.10s)
12:38:02 [2019-09-27T12:38:02.911Z]         --- PASS: TestMountDaemonRoot/rshared/mount_subpath (0.06s)
12:38:02 [2019-09-27T12:38:02.911Z]         --- PASS: TestMountDaemonRoot/rshared/mount_root (0.06s)
12:38:02 [2019-09-27T12:38:02.911Z]         --- PASS: TestMountDaemonRoot/rshared/bind_subpath (0.06s)
12:38:02 [2019-09-27T12:38:02.911Z]     --- PASS: TestMountDaemonRoot/shared (0.00s)
12:38:02 [2019-09-27T12:38:02.911Z]         --- PASS: TestMountDaemonRoot/shared/bind_root (0.05s)
12:38:02 [2019-09-27T12:38:02.911Z]         --- PASS: TestMountDaemonRoot/shared/mount_subpath (0.03s)
12:38:02 [2019-09-27T12:38:02.911Z]         --- PASS: TestMountDaemonRoot/shared/mount_root (0.04s)
12:38:02 [2019-09-27T12:38:02.911Z]         --- PASS: TestMountDaemonRoot/shared/bind_subpath (0.04s)
12:38:02 [2019-09-27T12:38:02.911Z]     --- PASS: TestMountDaemonRoot/rslave (0.00s)
12:38:02 [2019-09-27T12:38:02.911Z]         --- PASS: TestMountDaemonRoot/rslave/bind_root (0.08s)
12:38:02 [2019-09-27T12:38:02.911Z]         --- PASS: TestMountDaemonRoot/rslave/mount_subpath (0.10s)
12:38:02 [2019-09-27T12:38:02.911Z]         --- PASS: TestMountDaemonRoot/rslave/mount_root (0.08s)
12:38:02 [2019-09-27T12:38:02.911Z]         --- PASS: TestMountDaemonRoot/rslave/bind_subpath (0.08s)
12:38:02 [2019-09-27T12:38:02.911Z]     --- PASS: TestMountDaemonRoot/slave (0.00s)
12:38:02 [2019-09-27T12:38:02.911Z]         --- PASS: TestMountDaemonRoot/slave/mount_subpath (0.05s)
12:38:02 [2019-09-27T12:38:02.911Z]         --- PASS: TestMountDaemonRoot/slave/mount_root (0.05s)
12:38:02 [2019-09-27T12:38:02.911Z]         --- PASS: TestMountDaemonRoot/slave/bind_subpath (0.04s)
12:38:02 [2019-09-27T12:38:02.911Z]         --- PASS: TestMountDaemonRoot/slave/bind_root (0.03s)
12:38:02 [2019-09-27T12:38:02.911Z]     --- PASS: TestMountDaemonRoot/rprivate (0.00s)
12:38:02 [2019-09-27T12:38:02.911Z]         --- PASS: TestMountDaemonRoot/rprivate/bind_root (0.04s)
12:38:02 [2019-09-27T12:38:02.911Z]         --- PASS: TestMountDaemonRoot/rprivate/mount_subpath (0.03s)
12:38:02 [2019-09-27T12:38:02.911Z]         --- PASS: TestMountDaemonRoot/rprivate/bind_subpath (0.03s)
12:38:02 [2019-09-27T12:38:02.911Z]         --- PASS: TestMountDaemonRoot/rprivate/mount_root (0.04s)
12:38:02 [2019-09-27T12:38:02.911Z]     --- PASS: TestMountDaemonRoot/private (0.00s)
12:38:02 [2019-09-27T12:38:02.911Z]         --- PASS: TestMountDaemonRoot/private/mount_root (0.04s)
12:38:02 [2019-09-27T12:38:02.911Z]         --- PASS: TestMountDaemonRoot/private/bind_root (0.03s)
12:38:02 [2019-09-27T12:38:02.911Z]         --- PASS: TestMountDaemonRoot/private/bind_subpath (0.03s)
12:38:02 [2019-09-27T12:38:02.911Z]         --- PASS: TestMountDaemonRoot/private/mount_subpath (0.03s)
12:38:02 [2019-09-27T12:38:02.911Z] === RUN   TestContainerBindMountNonRecursive
12:38:04 [2019-09-27T12:38:04.745Z] --- PASS: TestContainerBindMountNonRecursive (1.83s)
12:38:04 [2019-09-27T12:38:04.745Z] === RUN   TestNetworkNat
12:38:05 [2019-09-27T12:38:05.540Z] --- PASS: TestNetworkNat (0.88s)
12:38:05 [2019-09-27T12:38:05.540Z] === RUN   TestNetworkLocalhostTCPNat
12:38:06 [2019-09-27T12:38:06.873Z] --- PASS: TestNetworkLocalhostTCPNat (1.02s)
12:38:06 [2019-09-27T12:38:06.873Z] === RUN   TestNetworkLoopbackNat
12:38:08 [2019-09-27T12:38:08.168Z] --- PASS: TestNetworkLoopbackNat (1.27s)
12:38:08 [2019-09-27T12:38:08.168Z] === RUN   TestPause
12:38:08 [2019-09-27T12:38:08.966Z] --- PASS: TestPause (1.00s)
12:38:08 [2019-09-27T12:38:08.966Z] === RUN   TestPauseFailsOnWindowsServerContainers
12:38:08 [2019-09-27T12:38:08.966Z] --- SKIP: TestPauseFailsOnWindowsServerContainers (0.00s)
12:38:08 [2019-09-27T12:38:08.966Z]     pause_test.go:54: testEnv.DaemonInfo.OSType != "windows" || testEnv.DaemonInfo.Isolation != "process"
12:38:08 [2019-09-27T12:38:08.966Z] === RUN   TestPauseStopPausedContainer
12:38:10 [2019-09-27T12:38:10.237Z] --- PASS: TestPauseStopPausedContainer (0.97s)
12:38:10 [2019-09-27T12:38:10.237Z] === RUN   TestPsFilter
12:38:10 [2019-09-27T12:38:10.237Z] --- PASS: TestPsFilter (0.26s)
12:38:10 [2019-09-27T12:38:10.237Z] === RUN   TestRemoveContainerWithRemovedVolume
12:38:11 [2019-09-27T12:38:11.056Z] --- PASS: TestRemoveContainerWithRemovedVolume (0.81s)
12:38:11 [2019-09-27T12:38:11.056Z] === RUN   TestRemoveContainerWithVolume
12:38:11 [2019-09-27T12:38:11.917Z] --- PASS: TestRemoveContainerWithVolume (0.94s)
12:38:11 [2019-09-27T12:38:11.917Z] === RUN   TestRemoveContainerRunning
12:38:12 [2019-09-27T12:38:12.695Z] --- PASS: TestRemoveContainerRunning (0.88s)
12:38:12 [2019-09-27T12:38:12.695Z] === RUN   TestRemoveContainerForceRemoveRunning
12:38:13 [2019-09-27T12:38:13.958Z] --- PASS: TestRemoveContainerForceRemoveRunning (1.01s)
12:38:13 [2019-09-27T12:38:13.958Z] === RUN   TestRemoveInvalidContainer
12:38:13 [2019-09-27T12:38:13.958Z] --- PASS: TestRemoveInvalidContainer (0.01s)
12:38:13 [2019-09-27T12:38:13.958Z] === RUN   TestRenameLinkedContainer
12:38:17 [2019-09-27T12:38:17.255Z] --- PASS: TestRenameLinkedContainer (3.55s)
12:38:17 [2019-09-27T12:38:17.255Z] === RUN   TestRenameStoppedContainer
12:38:18 [2019-09-27T12:38:18.518Z] --- PASS: TestRenameStoppedContainer (0.93s)
12:38:18 [2019-09-27T12:38:18.518Z] === RUN   TestRenameRunningContainerAndReuse
12:38:20 [2019-09-27T12:38:20.329Z] --- PASS: TestRenameRunningContainerAndReuse (1.79s)
12:38:20 [2019-09-27T12:38:20.329Z] === RUN   TestRenameInvalidName
12:38:21 [2019-09-27T12:38:21.105Z] --- PASS: TestRenameInvalidName (0.93s)
12:38:21 [2019-09-27T12:38:21.105Z] === RUN   TestRenameAnonymousContainer
12:38:24 [2019-09-27T12:38:24.328Z] --- PASS: TestRenameAnonymousContainer (2.94s)
12:38:24 [2019-09-27T12:38:24.328Z] === RUN   TestRenameContainerWithSameName
12:38:24 [2019-09-27T12:38:24.701Z] --- PASS: TestRenameContainerWithSameName (0.86s)
12:38:24 [2019-09-27T12:38:24.701Z] === RUN   TestRenameContainerWithLinkedContainer
12:38:26 [2019-09-27T12:38:26.506Z] --- PASS: TestRenameContainerWithLinkedContainer (1.79s)
12:38:26 [2019-09-27T12:38:26.506Z] === RUN   TestResize
12:38:27 [2019-09-27T12:38:27.829Z] --- PASS: TestResize (1.00s)
12:38:27 [2019-09-27T12:38:27.829Z] === RUN   TestResizeWithInvalidSize
12:38:28 [2019-09-27T12:38:28.665Z] --- PASS: TestResizeWithInvalidSize (0.99s)
12:38:28 [2019-09-27T12:38:28.665Z] === RUN   TestResizeWhenContainerNotStarted
12:38:29 [2019-09-27T12:38:29.479Z] --- PASS: TestResizeWhenContainerNotStarted (0.91s)
12:38:29 [2019-09-27T12:38:29.479Z] === RUN   TestDaemonRestartKillContainers
12:38:29 [2019-09-27T12:38:29.479Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
12:38:29 [2019-09-27T12:38:29.479Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
12:38:29 [2019-09-27T12:38:29.479Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
12:38:29 [2019-09-27T12:38:29.479Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
12:38:29 [2019-09-27T12:38:29.479Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
12:38:29 [2019-09-27T12:38:29.479Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
12:38:29 [2019-09-27T12:38:29.479Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
12:38:29 [2019-09-27T12:38:29.479Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
12:38:29 [2019-09-27T12:38:29.479Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
12:38:29 [2019-09-27T12:38:29.479Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
12:38:29 [2019-09-27T12:38:29.479Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
12:38:29 [2019-09-27T12:38:29.479Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
12:38:29 [2019-09-27T12:38:29.479Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
12:38:29 [2019-09-27T12:38:29.479Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
12:38:29 [2019-09-27T12:38:29.479Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
12:38:29 [2019-09-27T12:38:29.479Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
12:38:29 [2019-09-27T12:38:29.479Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
12:38:29 [2019-09-27T12:38:29.479Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
12:38:29 [2019-09-27T12:38:29.479Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
12:38:29 [2019-09-27T12:38:29.479Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
12:38:29 [2019-09-27T12:38:29.479Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
12:38:29 [2019-09-27T12:38:29.479Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
12:38:29 [2019-09-27T12:38:29.479Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
12:38:29 [2019-09-27T12:38:29.479Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
12:38:29 [2019-09-27T12:38:29.479Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
12:38:29 [2019-09-27T12:38:29.479Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
12:38:32 [2019-09-27T12:38:32.007Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
12:38:32 [2019-09-27T12:38:32.007Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
12:38:33 [2019-09-27T12:38:33.428Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
12:38:33 [2019-09-27T12:38:33.428Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
12:38:34 [2019-09-27T12:38:34.722Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
12:38:34 [2019-09-27T12:38:34.722Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
12:38:37 [2019-09-27T12:38:37.190Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
12:38:37 [2019-09-27T12:38:37.190Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
12:38:39 [2019-09-27T12:38:39.864Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
12:38:40 [2019-09-27T12:38:40.251Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
12:38:42 [2019-09-27T12:38:42.729Z] --- PASS: TestDaemonRestartKillContainers (0.00s)
12:38:42 [2019-09-27T12:38:42.730Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon (2.05s)
12:38:42 [2019-09-27T12:38:42.730Z]         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"
12:38:42 [2019-09-27T12:38:42.730Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon (2.42s)
12:38:42 [2019-09-27T12:38:42.730Z]         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"
12:38:42 [2019-09-27T12:38:42.730Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon (1.48s)
12:38:42 [2019-09-27T12:38:42.730Z]         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"
12:38:42 [2019-09-27T12:38:42.730Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon (1.49s)
12:38:42 [2019-09-27T12:38:42.730Z]         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"
12:38:42 [2019-09-27T12:38:42.730Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon (1.51s)
12:38:42 [2019-09-27T12:38:42.730Z]         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"
12:38:42 [2019-09-27T12:38:42.730Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon (1.44s)
12:38:42 [2019-09-27T12:38:42.730Z]         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"
12:38:42 [2019-09-27T12:38:42.730Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon (2.22s)
12:38:42 [2019-09-27T12:38:42.730Z]         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"
12:38:42 [2019-09-27T12:38:42.730Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon (2.31s)
12:38:42 [2019-09-27T12:38:42.730Z]         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"
12:38:42 [2019-09-27T12:38:42.730Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon (3.06s)
12:38:42 [2019-09-27T12:38:42.730Z]         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"
12:38:42 [2019-09-27T12:38:42.730Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon (3.07s)
12:38:42 [2019-09-27T12:38:42.730Z]         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"
12:38:42 [2019-09-27T12:38:42.730Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon (2.28s)
12:38:42 [2019-09-27T12:38:42.730Z]         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"
12:38:42 [2019-09-27T12:38:42.730Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon (2.29s)
12:38:42 [2019-09-27T12:38:42.730Z]         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"
12:38:42 [2019-09-27T12:38:42.730Z] === RUN   TestCgroupNamespacesRun
12:38:44 [2019-09-27T12:38:44.602Z] --- PASS: TestCgroupNamespacesRun (1.73s)
12:38:44 [2019-09-27T12:38:44.602Z]     run_cgroupns_linux_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRun"
12:38:44 [2019-09-27T12:38:44.602Z] === RUN   TestCgroupNamespacesRunPrivileged
12:38:45 [2019-09-27T12:38:45.953Z] --- PASS: TestCgroupNamespacesRunPrivileged (1.69s)
12:38:45 [2019-09-27T12:38:45.953Z]     run_cgroupns_linux_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunPrivileged"
12:38:45 [2019-09-27T12:38:45.953Z] === RUN   TestCgroupNamespacesRunDaemonHostMode
12:38:47 [2019-09-27T12:38:47.798Z] --- PASS: TestCgroupNamespacesRunDaemonHostMode (1.85s)
12:38:47 [2019-09-27T12:38:47.798Z]     run_cgroupns_linux_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunDaemonHostMode"
12:38:47 [2019-09-27T12:38:47.798Z] === RUN   TestCgroupNamespacesRunHostMode
12:38:49 [2019-09-27T12:38:49.666Z] --- PASS: TestCgroupNamespacesRunHostMode (1.81s)
12:38:49 [2019-09-27T12:38:49.666Z]     run_cgroupns_linux_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunHostMode"
12:38:49 [2019-09-27T12:38:49.666Z] === RUN   TestCgroupNamespacesRunPrivateMode
12:38:51 [2019-09-27T12:38:51.605Z] --- PASS: TestCgroupNamespacesRunPrivateMode (1.83s)
12:38:51 [2019-09-27T12:38:51.605Z]     run_cgroupns_linux_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunPrivateMode"
12:38:51 [2019-09-27T12:38:51.605Z] === RUN   TestCgroupNamespacesRunPrivilegedAndPrivate
12:38:52 [2019-09-27T12:38:52.394Z] --- PASS: TestCgroupNamespacesRunPrivilegedAndPrivate (0.85s)
12:38:52 [2019-09-27T12:38:52.394Z]     run_cgroupns_linux_test.go:48: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunPrivilegedAndPrivate"
12:38:52 [2019-09-27T12:38:52.394Z] === RUN   TestCgroupNamespacesRunInvalidMode
12:38:53 [2019-09-27T12:38:53.190Z] --- PASS: TestCgroupNamespacesRunInvalidMode (0.90s)
12:38:53 [2019-09-27T12:38:53.190Z]     run_cgroupns_linux_test.go:48: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunInvalidMode"
12:38:53 [2019-09-27T12:38:53.190Z] === RUN   TestCgroupNamespacesRunOlderClient
12:38:55 [2019-09-27T12:38:55.019Z] --- PASS: TestCgroupNamespacesRunOlderClient (1.86s)
12:38:55 [2019-09-27T12:38:55.019Z]     run_cgroupns_linux_test.go:139: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunOlderClient"
12:38:55 [2019-09-27T12:38:55.019Z] === RUN   TestKernelTCPMemory
12:38:56 [2019-09-27T12:38:56.340Z] --- PASS: TestKernelTCPMemory (1.01s)
12:38:56 [2019-09-27T12:38:56.340Z] === RUN   TestNISDomainname
12:38:57 [2019-09-27T12:38:57.147Z] --- PASS: TestNISDomainname (1.16s)
12:38:57 [2019-09-27T12:38:57.147Z] === RUN   TestHostnameDnsResolution
12:38:58 [2019-09-27T12:38:58.400Z] --- PASS: TestHostnameDnsResolution (1.21s)
12:38:58 [2019-09-27T12:38:58.400Z] === RUN   TestStats
12:39:00 [2019-09-27T12:39:00.891Z] --- PASS: TestStats (2.43s)
12:39:00 [2019-09-27T12:39:00.891Z] === RUN   TestStopContainerWithTimeout
12:39:00 [2019-09-27T12:39:00.891Z] === RUN   TestStopContainerWithTimeout/0
12:39:00 [2019-09-27T12:39:00.891Z] === PAUSE TestStopContainerWithTimeout/0
12:39:00 [2019-09-27T12:39:00.891Z] === RUN   TestStopContainerWithTimeout/1
12:39:00 [2019-09-27T12:39:00.891Z] === PAUSE TestStopContainerWithTimeout/1
12:39:00 [2019-09-27T12:39:00.891Z] === RUN   TestStopContainerWithTimeout/3
12:39:00 [2019-09-27T12:39:00.891Z] === PAUSE TestStopContainerWithTimeout/3
12:39:00 [2019-09-27T12:39:00.891Z] === RUN   TestStopContainerWithTimeout/-1
12:39:00 [2019-09-27T12:39:00.891Z] === PAUSE TestStopContainerWithTimeout/-1
12:39:00 [2019-09-27T12:39:00.891Z] === CONT  TestStopContainerWithTimeout/0
12:39:00 [2019-09-27T12:39:00.891Z] === CONT  TestStopContainerWithTimeout/-1
12:39:02 [2019-09-27T12:39:02.199Z] === CONT  TestStopContainerWithTimeout/3
12:39:03 [2019-09-27T12:39:03.982Z] === CONT  TestStopContainerWithTimeout/1
12:39:05 [2019-09-27T12:39:05.849Z] --- PASS: TestStopContainerWithTimeout (0.01s)
12:39:05 [2019-09-27T12:39:05.849Z]     --- PASS: TestStopContainerWithTimeout/0 (1.07s)
12:39:05 [2019-09-27T12:39:05.849Z]     --- PASS: TestStopContainerWithTimeout/-1 (3.01s)
12:39:05 [2019-09-27T12:39:05.849Z]     --- PASS: TestStopContainerWithTimeout/3 (2.93s)
12:39:05 [2019-09-27T12:39:05.849Z]     --- PASS: TestStopContainerWithTimeout/1 (1.90s)
12:39:05 [2019-09-27T12:39:05.849Z] === RUN   TestDeleteDevicemapper
12:39:05 [2019-09-27T12:39:05.849Z] --- SKIP: TestDeleteDevicemapper (0.00s)
12:39:05 [2019-09-27T12:39:05.849Z]     stop_linux_test.go:74: testEnv.DaemonInfo.Driver != "devicemapper"
12:39:05 [2019-09-27T12:39:05.849Z] === RUN   TestStopContainerWithRestartPolicyAlways
12:39:09 [2019-09-27T12:39:09.955Z] --- PASS: TestStopContainerWithRestartPolicyAlways (3.88s)
12:39:09 [2019-09-27T12:39:09.955Z] === RUN   TestUpdateMemory
12:39:09 [2019-09-27T12:39:09.955Z] --- SKIP: TestUpdateMemory (0.00s)
12:39:09 [2019-09-27T12:39:09.955Z]     update_linux_test.go:23: !testEnv.DaemonInfo.SwapLimit
12:39:09 [2019-09-27T12:39:09.955Z] === RUN   TestUpdateCPUQuota
12:39:11 [2019-09-27T12:39:11.224Z] --- PASS: TestUpdateCPUQuota (1.66s)
12:39:11 [2019-09-27T12:39:11.224Z] === RUN   TestUpdatePidsLimit
12:39:11 [2019-09-27T12:39:11.224Z] === RUN   TestUpdatePidsLimit/update_from_none
12:39:12 [2019-09-27T12:39:12.091Z] === RUN   TestUpdatePidsLimit/no_change
12:39:12 [2019-09-27T12:39:12.091Z] === RUN   TestUpdatePidsLimit/update_lower
12:39:12 [2019-09-27T12:39:12.509Z] === RUN   TestUpdatePidsLimit/update_on_old_api_ignores_value
12:39:13 [2019-09-27T12:39:13.311Z] === RUN   TestUpdatePidsLimit/unset_limit_with_zero
12:39:13 [2019-09-27T12:39:13.672Z] === RUN   TestUpdatePidsLimit/unset_limit_with_minus_one
12:39:14 [2019-09-27T12:39:14.050Z] === RUN   TestUpdatePidsLimit/unset_limit_with_minus_two
12:39:15 [2019-09-27T12:39:15.877Z] --- PASS: TestUpdatePidsLimit (4.42s)
12:39:15 [2019-09-27T12:39:15.877Z]     --- PASS: TestUpdatePidsLimit/update_from_none (0.43s)
12:39:15 [2019-09-27T12:39:15.877Z]     --- PASS: TestUpdatePidsLimit/no_change (0.40s)
12:39:15 [2019-09-27T12:39:15.877Z]     --- PASS: TestUpdatePidsLimit/update_lower (0.45s)
12:39:15 [2019-09-27T12:39:15.877Z]     --- PASS: TestUpdatePidsLimit/update_on_old_api_ignores_value (0.46s)
12:39:15 [2019-09-27T12:39:15.877Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_zero (0.47s)
12:39:15 [2019-09-27T12:39:15.877Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_minus_one (0.47s)
12:39:15 [2019-09-27T12:39:15.877Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_minus_two (0.41s)
12:39:15 [2019-09-27T12:39:15.877Z] === RUN   TestUpdateRestartPolicy
12:39:29 [2019-09-27T12:39:29.618Z] --- PASS: TestUpdateRestartPolicy (12.84s)
12:39:29 [2019-09-27T12:39:29.618Z] === RUN   TestUpdateRestartWithAutoRemove
12:39:29 [2019-09-27T12:39:29.618Z] --- PASS: TestUpdateRestartWithAutoRemove (0.92s)
12:39:29 [2019-09-27T12:39:29.618Z] === RUN   TestWaitNonBlocked
12:39:29 [2019-09-27T12:39:29.618Z] === RUN   TestWaitNonBlocked/wait-nonblocking-exit-0
12:39:29 [2019-09-27T12:39:29.618Z] === PAUSE TestWaitNonBlocked/wait-nonblocking-exit-0
12:39:29 [2019-09-27T12:39:29.618Z] === RUN   TestWaitNonBlocked/wait-nonblocking-exit-random
12:39:29 [2019-09-27T12:39:29.618Z] === PAUSE TestWaitNonBlocked/wait-nonblocking-exit-random
12:39:29 [2019-09-27T12:39:29.618Z] === CONT  TestWaitNonBlocked/wait-nonblocking-exit-0
12:39:29 [2019-09-27T12:39:29.618Z] === CONT  TestWaitNonBlocked/wait-nonblocking-exit-random
12:39:30 [2019-09-27T12:39:30.632Z] --- PASS: TestWaitNonBlocked (0.01s)
12:39:30 [2019-09-27T12:39:30.632Z]     --- PASS: TestWaitNonBlocked/wait-nonblocking-exit-random (1.02s)
12:39:30 [2019-09-27T12:39:30.632Z]     --- PASS: TestWaitNonBlocked/wait-nonblocking-exit-0 (1.07s)
12:39:30 [2019-09-27T12:39:30.632Z] === RUN   TestWaitBlocked
12:39:30 [2019-09-27T12:39:30.632Z] === RUN   TestWaitBlocked/test-wait-blocked-exit-zero
12:39:30 [2019-09-27T12:39:30.632Z] === PAUSE TestWaitBlocked/test-wait-blocked-exit-zero
12:39:30 [2019-09-27T12:39:30.632Z] === RUN   TestWaitBlocked/test-wait-blocked-exit-random
12:39:30 [2019-09-27T12:39:30.632Z] === PAUSE TestWaitBlocked/test-wait-blocked-exit-random
12:39:30 [2019-09-27T12:39:30.632Z] === CONT  TestWaitBlocked/test-wait-blocked-exit-zero
12:39:30 [2019-09-27T12:39:30.632Z] === CONT  TestWaitBlocked/test-wait-blocked-exit-random
12:39:31 [2019-09-27T12:39:31.935Z] --- PASS: TestWaitBlocked (0.01s)
12:39:31 [2019-09-27T12:39:31.935Z]     --- PASS: TestWaitBlocked/test-wait-blocked-exit-zero (0.94s)
12:39:31 [2019-09-27T12:39:31.935Z]     --- PASS: TestWaitBlocked/test-wait-blocked-exit-random (1.24s)
12:39:31 [2019-09-27T12:39:31.935Z] === CONT  TestContainerStartOnDaemonRestart
12:39:31 [2019-09-27T12:39:31.935Z] === CONT  TestIpcModeOlderClient
12:39:31 [2019-09-27T12:39:31.935Z] --- PASS: TestIpcModeOlderClient (0.19s)
12:39:31 [2019-09-27T12:39:31.935Z] === CONT  TestDaemonRestartIpcMode
12:39:35 [2019-09-27T12:39:35.173Z] --- PASS: TestContainerStartOnDaemonRestart (3.28s)
12:39:35 [2019-09-27T12:39:35.174Z]     daemon_linux_test.go:35: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestContainerStartOnDaemonRestart"
12:39:36 [2019-09-27T12:39:36.023Z] --- PASS: TestDaemonRestartIpcMode (3.68s)
12:39:36 [2019-09-27T12:39:36.023Z]     daemon_linux_test.go:89: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartIpcMode"
12:39:36 [2019-09-27T12:39:36.023Z] PASS
12:39:36 [2019-09-27T12:39:36.023Z] 
12:39:36 [2019-09-27T12:39:36.023Z] === Skipped
12:39:36 [2019-09-27T12:39:36.023Z] === SKIP: s390x.integration.container TestCheckpoint (0.00s)
12:39:36 [2019-09-27T12:39:36.023Z]     checkpoint_test.go:33: TestCheckpoint is broken; see https://github.com/moby/moby/issues/38963
12:39:36 [2019-09-27T12:39:36.023Z] 
12:39:36 [2019-09-27T12:39:36.023Z] === SKIP: s390x.integration.container TestInspectOomKilledTrue (0.00s)
12:39:36 [2019-09-27T12:39:36.023Z]     kill_test.go:151: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
12:39:36 [2019-09-27T12:39:36.023Z] 
12:39:36 [2019-09-27T12:39:36.023Z] === SKIP: s390x.integration.container TestInspectOomKilledFalse (0.00s)
12:39:36 [2019-09-27T12:39:36.023Z]     kill_test.go:169: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
12:39:36 [2019-09-27T12:39:36.023Z] 
12:39:36 [2019-09-27T12:39:36.023Z] === SKIP: s390x.integration.container TestPauseFailsOnWindowsServerContainers (0.00s)
12:39:36 [2019-09-27T12:39:36.023Z]     pause_test.go:54: testEnv.DaemonInfo.OSType != "windows" || testEnv.DaemonInfo.Isolation != "process"
12:39:36 [2019-09-27T12:39:36.023Z] 
12:39:36 [2019-09-27T12:39:36.023Z] === SKIP: s390x.integration.container TestDeleteDevicemapper (0.00s)
12:39:36 [2019-09-27T12:39:36.023Z]     stop_linux_test.go:74: testEnv.DaemonInfo.Driver != "devicemapper"
12:39:36 [2019-09-27T12:39:36.023Z] 
12:39:36 [2019-09-27T12:39:36.023Z] === SKIP: s390x.integration.container TestUpdateMemory (0.00s)
12:39:36 [2019-09-27T12:39:36.023Z]     update_linux_test.go:23: !testEnv.DaemonInfo.SwapLimit
12:39:36 [2019-09-27T12:39:36.023Z] 
12:39:36 [2019-09-27T12:39:36.023Z] 
12:39:36 [2019-09-27T12:39:36.023Z] DONE 197 tests, 6 skipped in 146.304s
12:39:36 [2019-09-27T12:39:36.023Z] Running /go/src/github.com/docker/docker/integration/image (s390x.integration.image) flags=-test.v -test.timeout=120m 
12:39:36 [2019-09-27T12:39:36.024Z] ++ 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
12:39:36 [2019-09-27T12:39:36.024Z] ++ set -e
12:39:36 [2019-09-27T12:39:36.024Z] ++ '[' -n 0 ']'
12:39:36 [2019-09-27T12:39:36.024Z] ++ set -x
12:39:36 [2019-09-27T12:39:36.024Z] ++ 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
12:39:36 [2019-09-27T12:39:36.024Z] INFO: Testing against a local daemon
12:39:36 [2019-09-27T12:39:36.024Z] === RUN   TestCommitInheritsEnv
12:39:36 [2019-09-27T12:39:36.438Z] --- PASS: TestCommitInheritsEnv (0.49s)
12:39:36 [2019-09-27T12:39:36.438Z] === RUN   TestImportExtremelyLargeImageWorks
12:39:36 [2019-09-27T12:39:36.438Z] === PAUSE TestImportExtremelyLargeImageWorks
12:39:36 [2019-09-27T12:39:36.438Z] === RUN   TestImagesFilterMultiReference
12:39:36 [2019-09-27T12:39:36.438Z] --- PASS: TestImagesFilterMultiReference (0.05s)
12:39:36 [2019-09-27T12:39:36.438Z] === RUN   TestImagePullPlatformInvalid
12:39:36 [2019-09-27T12:39:36.438Z] --- PASS: TestImagePullPlatformInvalid (0.02s)
12:39:36 [2019-09-27T12:39:36.438Z] === RUN   TestRemoveImageOrphaning
12:39:37 [2019-09-27T12:39:37.251Z] --- PASS: TestRemoveImageOrphaning (0.50s)
12:39:37 [2019-09-27T12:39:37.251Z] === RUN   TestRemoveImageGarbageCollector
12:39:37 [2019-09-27T12:39:37.251Z] --- SKIP: TestRemoveImageGarbageCollector (0.00s)
12:39:37 [2019-09-27T12:39:37.251Z]     remove_unix_test.go:36: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
12:39:37 [2019-09-27T12:39:37.251Z] === RUN   TestTagUnprefixedRepoByNameOrName
12:39:37 [2019-09-27T12:39:37.251Z] --- PASS: TestTagUnprefixedRepoByNameOrName (0.02s)
12:39:37 [2019-09-27T12:39:37.251Z] === RUN   TestTagInvalidReference
12:39:37 [2019-09-27T12:39:37.251Z] --- PASS: TestTagInvalidReference (0.03s)
12:39:37 [2019-09-27T12:39:37.251Z] === RUN   TestTagValidPrefixedRepo
12:39:37 [2019-09-27T12:39:37.251Z] --- PASS: TestTagValidPrefixedRepo (0.04s)
12:39:37 [2019-09-27T12:39:37.251Z] === RUN   TestTagExistedNameWithoutForce
12:39:37 [2019-09-27T12:39:37.251Z] --- PASS: TestTagExistedNameWithoutForce (0.02s)
12:39:37 [2019-09-27T12:39:37.251Z] === RUN   TestTagOfficialNames
12:39:37 [2019-09-27T12:39:37.251Z] --- PASS: TestTagOfficialNames (0.04s)
12:39:37 [2019-09-27T12:39:37.251Z] === RUN   TestTagMatchesDigest
12:39:37 [2019-09-27T12:39:37.251Z] --- PASS: TestTagMatchesDigest (0.01s)
12:39:37 [2019-09-27T12:39:37.251Z] === CONT  TestImportExtremelyLargeImageWorks
12:41:46 [2019-09-27T12:41:46.981Z] --- PASS: TestImportExtremelyLargeImageWorks (115.07s)
12:41:46 [2019-09-27T12:41:46.981Z]     import_test.go:26: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestImportExtremelyLargeImageWorks"
12:41:46 [2019-09-27T12:41:46.981Z] PASS
12:41:46 [2019-09-27T12:41:46.981Z] 
12:41:46 [2019-09-27T12:41:46.981Z] === Skipped
12:41:46 [2019-09-27T12:41:46.981Z] === SKIP: s390x.integration.image TestRemoveImageGarbageCollector (0.00s)
12:41:46 [2019-09-27T12:41:46.981Z]     remove_unix_test.go:36: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
12:41:46 [2019-09-27T12:41:46.981Z] 
12:41:46 [2019-09-27T12:41:46.981Z] 
12:41:46 [2019-09-27T12:41:46.981Z] DONE 12 tests, 1 skipped in 116.538s
12:41:46 [2019-09-27T12:41:46.981Z] Running /go/src/github.com/docker/docker/integration/network (s390x.integration.network) flags=-test.v -test.timeout=120m 
12:41:46 [2019-09-27T12:41:46.981Z] ++ 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
12:41:46 [2019-09-27T12:41:46.981Z] ++ set -e
12:41:46 [2019-09-27T12:41:46.981Z] ++ '[' -n 0 ']'
12:41:46 [2019-09-27T12:41:46.981Z] ++ set -x
12:41:46 [2019-09-27T12:41:46.981Z] ++ 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
12:41:46 [2019-09-27T12:41:46.981Z] INFO: Testing against a local daemon
12:41:46 [2019-09-27T12:41:46.981Z] === RUN   TestNetworkCreateDelete
12:41:46 [2019-09-27T12:41:46.981Z] --- PASS: TestNetworkCreateDelete (0.13s)
12:41:46 [2019-09-27T12:41:46.981Z] === RUN   TestDockerNetworkDeletePreferID
12:41:46 [2019-09-27T12:41:46.981Z] --- PASS: TestDockerNetworkDeletePreferID (0.35s)
12:41:46 [2019-09-27T12:41:46.981Z] === RUN   TestInspectNetwork
12:41:46 [2019-09-27T12:41:46.981Z] === RUN   TestInspectNetwork/full_network_id
12:41:46 [2019-09-27T12:41:46.981Z] === RUN   TestInspectNetwork/partial_network_id
12:41:46 [2019-09-27T12:41:46.981Z] === RUN   TestInspectNetwork/network_name
12:41:46 [2019-09-27T12:41:46.981Z] === RUN   TestInspectNetwork/network_name_and_swarm_scope
12:41:46 [2019-09-27T12:41:46.981Z] --- PASS: TestInspectNetwork (9.56s)
12:41:46 [2019-09-27T12:41:46.981Z]     inspect_test.go:18: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestInspectNetwork"
12:41:46 [2019-09-27T12:41:46.981Z]     --- PASS: TestInspectNetwork/full_network_id (0.01s)
12:41:46 [2019-09-27T12:41:46.981Z]     --- PASS: TestInspectNetwork/partial_network_id (0.00s)
12:41:46 [2019-09-27T12:41:46.981Z]     --- PASS: TestInspectNetwork/network_name (0.00s)
12:41:46 [2019-09-27T12:41:46.981Z]     --- PASS: TestInspectNetwork/network_name_and_swarm_scope (0.00s)
12:41:46 [2019-09-27T12:41:46.981Z] === RUN   TestRunContainerWithBridgeNone
12:41:46 [2019-09-27T12:41:46.981Z] --- PASS: TestRunContainerWithBridgeNone (2.63s)
12:41:46 [2019-09-27T12:41:46.981Z]     network_test.go:25: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestRunContainerWithBridgeNone"
12:41:46 [2019-09-27T12:41:46.981Z] === RUN   TestNetworkInvalidJSON
12:41:46 [2019-09-27T12:41:46.981Z] === RUN   TestNetworkInvalidJSON//networks/create
12:41:46 [2019-09-27T12:41:46.981Z] === PAUSE TestNetworkInvalidJSON//networks/create
12:41:46 [2019-09-27T12:41:46.981Z] === RUN   TestNetworkInvalidJSON//networks/bridge/connect
12:41:46 [2019-09-27T12:41:46.981Z] === PAUSE TestNetworkInvalidJSON//networks/bridge/connect
12:41:46 [2019-09-27T12:41:46.981Z] === RUN   TestNetworkInvalidJSON//networks/bridge/disconnect
12:41:46 [2019-09-27T12:41:46.981Z] === PAUSE TestNetworkInvalidJSON//networks/bridge/disconnect
12:41:46 [2019-09-27T12:41:46.981Z] === CONT  TestNetworkInvalidJSON//networks/create
12:41:46 [2019-09-27T12:41:46.981Z] === CONT  TestNetworkInvalidJSON//networks/bridge/disconnect
12:41:46 [2019-09-27T12:41:46.981Z] === CONT  TestNetworkInvalidJSON//networks/bridge/connect
12:41:46 [2019-09-27T12:41:46.981Z] --- PASS: TestNetworkInvalidJSON (0.02s)
12:41:46 [2019-09-27T12:41:46.981Z]     --- PASS: TestNetworkInvalidJSON//networks/bridge/disconnect (0.00s)
12:41:46 [2019-09-27T12:41:46.981Z]     --- PASS: TestNetworkInvalidJSON//networks/create (0.00s)
12:41:46 [2019-09-27T12:41:46.981Z]     --- PASS: TestNetworkInvalidJSON//networks/bridge/connect (0.00s)
12:41:46 [2019-09-27T12:41:46.981Z] === RUN   TestDaemonRestartWithLiveRestore
12:41:46 [2019-09-27T12:41:46.981Z] --- PASS: TestDaemonRestartWithLiveRestore (1.04s)
12:41:46 [2019-09-27T12:41:46.981Z]     service_test.go:32: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartWithLiveRestore"
12:41:46 [2019-09-27T12:41:46.981Z] === RUN   TestDaemonDefaultNetworkPools
12:41:46 [2019-09-27T12:41:46.981Z] --- PASS: TestDaemonDefaultNetworkPools (0.73s)
12:41:46 [2019-09-27T12:41:46.981Z]     service_test.go:57: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonDefaultNetworkPools"
12:41:46 [2019-09-27T12:41:46.981Z] === RUN   TestDaemonRestartWithExistingNetwork
12:41:48 [2019-09-27T12:41:48.223Z] --- PASS: TestDaemonRestartWithExistingNetwork (1.18s)
12:41:48 [2019-09-27T12:41:48.223Z]     service_test.go:98: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartWithExistingNetwork"
12:41:48 [2019-09-27T12:41:48.223Z] === RUN   TestDaemonRestartWithExistingNetworkWithDefaultPoolRange
12:41:49 [2019-09-27T12:41:49.504Z] --- PASS: TestDaemonRestartWithExistingNetworkWithDefaultPoolRange (1.25s)
12:41:49 [2019-09-27T12:41:49.504Z]     service_test.go:131: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartWithExistingNetworkWithDefaultPoolRange"
12:41:49 [2019-09-27T12:41:49.504Z] === RUN   TestDaemonWithBipAndDefaultNetworkPool
12:41:49 [2019-09-27T12:41:49.913Z] --- PASS: TestDaemonWithBipAndDefaultNetworkPool (0.61s)
12:41:49 [2019-09-27T12:41:49.913Z]     service_test.go:181: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonWithBipAndDefaultNetworkPool"
12:41:49 [2019-09-27T12:41:49.913Z] === RUN   TestServiceWithPredefinedNetwork
12:41:53 [2019-09-27T12:41:53.088Z] --- PASS: TestServiceWithPredefinedNetwork (2.81s)
12:41:53 [2019-09-27T12:41:53.088Z]     service_test.go:203: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithPredefinedNetwork"
12:41:53 [2019-09-27T12:41:53.088Z] === RUN   TestServiceRemoveKeepsIngressNetwork
12:41:53 [2019-09-27T12:41:53.088Z] --- SKIP: TestServiceRemoveKeepsIngressNetwork (0.00s)
12:41:53 [2019-09-27T12:41:53.088Z]     service_test.go:230: FLAKY_TEST
12:41:53 [2019-09-27T12:41:53.088Z] === RUN   TestServiceWithDataPathPortInit
12:42:09 [2019-09-27T12:42:09.558Z] --- PASS: TestServiceWithDataPathPortInit (16.55s)
12:42:09 [2019-09-27T12:42:09.558Z]     service_test.go:323: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithDataPathPortInit"
12:42:09 [2019-09-27T12:42:09.558Z]     service_test.go:355: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithDataPathPortInit"
12:42:09 [2019-09-27T12:42:09.558Z] === RUN   TestServiceWithDefaultAddressPoolInit
12:42:19 [2019-09-27T12:42:19.084Z] --- PASS: TestServiceWithDefaultAddressPoolInit (8.64s)
12:42:19 [2019-09-27T12:42:19.084Z]     service_test.go:388: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithDefaultAddressPoolInit"
12:42:19 [2019-09-27T12:42:19.084Z]     service_test.go:418: TestServiceWithDefaultAddressPoolInit: NetworkInspect: {Name:sthiraTestServiceWithDefaultAddressPoolInit ID:8rln8c1vaphacglbot9rjxs3u Created:2019-09-27 12:42:10.654294447 +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[55516adf293460a98c12fba0a22545e4e407d97acfe30a63296b3041aca2d861:{Name:TestServiceTestServiceWithDefaultAddressPoolInit.1.ixx06pctvjpxy45btbf392ywg EndpointID:7519c3876200a04a6a1dd38e5da8a98582a8f7e582906a2ebe3a08922f758280 MacAddress:02:42:14:14:00:03 IPv4Address:20.20.0.3/24 IPv6Address:} lb-sthiraTestServiceWithDefaultAddressPoolInit:{Name:sthiraTestServiceWithDefaultAddressPoolInit-endpoint EndpointID:40f706e34e34dcb5585bb09ab9579471f97513c4be77d64394e2d5a0ea8ce362 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:9292fbcea129 IP:127.0.0.1}] Services:map[TestServiceTestServiceWithDefaultAddressPoolInit:{VIP:20.20.0.2 Ports:[] LocalLBIndex:256 Tasks:[{Name:TestServiceTestServiceWithDefaultAddressPoolInit.1.ixx06pctvjpxy45btbf392ywg EndpointID:7519c3876200a04a6a1dd38e5da8a98582a8f7e582906a2ebe3a08922f758280 EndpointIP:20.20.0.3 Info:map[Host IP:127.0.0.1]}]}]}
12:42:19 [2019-09-27T12:42:19.084Z] PASS
12:42:19 [2019-09-27T12:42:19.084Z] 
12:42:19 [2019-09-27T12:42:19.084Z] === Skipped
12:42:19 [2019-09-27T12:42:19.084Z] === SKIP: s390x.integration.network TestServiceRemoveKeepsIngressNetwork (0.00s)
12:42:19 [2019-09-27T12:42:19.084Z]     service_test.go:230: FLAKY_TEST
12:42:19 [2019-09-27T12:42:19.084Z] 
12:42:19 [2019-09-27T12:42:19.084Z] 
12:42:19 [2019-09-27T12:42:19.084Z] DONE 21 tests, 1 skipped in 45.687s
12:42:19 [2019-09-27T12:42:19.084Z] Running /go/src/github.com/docker/docker/integration/network/ipvlan (s390x.integration.network.ipvlan) flags=-test.v -test.timeout=120m 
12:42:19 [2019-09-27T12:42:19.085Z] ++ 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
12:42:19 [2019-09-27T12:42:19.085Z] ++ set -e
12:42:19 [2019-09-27T12:42:19.085Z] ++ '[' -n 0 ']'
12:42:19 [2019-09-27T12:42:19.085Z] ++ set -x
12:42:19 [2019-09-27T12:42:19.085Z] ++ 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
12:42:19 [2019-09-27T12:42:19.085Z] INFO: Testing against a local daemon
12:42:19 [2019-09-27T12:42:19.085Z] === RUN   TestDockerNetworkIpvlanPersistance
12:42:19 [2019-09-27T12:42:19.085Z] --- SKIP: TestDockerNetworkIpvlanPersistance (0.00s)
12:42:19 [2019-09-27T12:42:19.085Z]     ipvlan_test.go:26: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
12:42:19 [2019-09-27T12:42:19.085Z] === RUN   TestDockerNetworkIpvlan
12:42:19 [2019-09-27T12:42:19.085Z] --- SKIP: TestDockerNetworkIpvlan (0.00s)
12:42:19 [2019-09-27T12:42:19.085Z]     ipvlan_test.go:53: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
12:42:19 [2019-09-27T12:42:19.085Z] PASS
12:42:19 [2019-09-27T12:42:19.085Z] 
12:42:19 [2019-09-27T12:42:19.085Z] === Skipped
12:42:19 [2019-09-27T12:42:19.085Z] === SKIP: s390x.integration.network.ipvlan TestDockerNetworkIpvlanPersistance (0.00s)
12:42:19 [2019-09-27T12:42:19.085Z]     ipvlan_test.go:26: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
12:42:19 [2019-09-27T12:42:19.085Z] 
12:42:19 [2019-09-27T12:42:19.085Z] === SKIP: s390x.integration.network.ipvlan TestDockerNetworkIpvlan (0.00s)
12:42:19 [2019-09-27T12:42:19.085Z]     ipvlan_test.go:53: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
12:42:19 [2019-09-27T12:42:19.085Z] 
12:42:19 [2019-09-27T12:42:19.085Z] 
12:42:19 [2019-09-27T12:42:19.085Z] DONE 2 tests, 2 skipped in 0.121s
12:42:19 [2019-09-27T12:42:19.085Z] Running /go/src/github.com/docker/docker/integration/network/macvlan (s390x.integration.network.macvlan) flags=-test.v -test.timeout=120m 
12:42:19 [2019-09-27T12:42:19.085Z] ++ 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
12:42:19 [2019-09-27T12:42:19.085Z] ++ set -e
12:42:19 [2019-09-27T12:42:19.085Z] ++ '[' -n 0 ']'
12:42:19 [2019-09-27T12:42:19.085Z] ++ set -x
12:42:19 [2019-09-27T12:42:19.085Z] ++ 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
12:42:19 [2019-09-27T12:42:19.085Z] INFO: Testing against a local daemon
12:42:19 [2019-09-27T12:42:19.085Z] === RUN   TestDockerNetworkMacvlanPersistance
12:42:19 [2019-09-27T12:42:19.463Z] --- PASS: TestDockerNetworkMacvlanPersistance (1.38s)
12:42:19 [2019-09-27T12:42:19.463Z]     macvlan_test.go:24: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlanPersistance"
12:42:19 [2019-09-27T12:42:19.463Z] === RUN   TestDockerNetworkMacvlan
12:42:20 [2019-09-27T12:42:20.294Z] === RUN   TestDockerNetworkMacvlan/Subinterface
12:42:21 [2019-09-27T12:42:21.610Z] === RUN   TestDockerNetworkMacvlan/OverlapParent
12:42:22 [2019-09-27T12:42:22.410Z] === RUN   TestDockerNetworkMacvlan/NilParent
12:42:24 [2019-09-27T12:42:24.833Z] === RUN   TestDockerNetworkMacvlan/InternalMode
12:42:28 [2019-09-27T12:42:28.922Z] === RUN   TestDockerNetworkMacvlan/MultiSubnet
12:42:33 [2019-09-27T12:42:33.017Z] === RUN   TestDockerNetworkMacvlan/Addressing
12:42:34 [2019-09-27T12:42:34.847Z] --- PASS: TestDockerNetworkMacvlan (14.86s)
12:42:34 [2019-09-27T12:42:34.847Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
12:42:34 [2019-09-27T12:42:34.847Z]     --- PASS: TestDockerNetworkMacvlan/Subinterface (0.09s)
12:42:34 [2019-09-27T12:42:34.847Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
12:42:34 [2019-09-27T12:42:34.847Z]     --- PASS: TestDockerNetworkMacvlan/OverlapParent (0.14s)
12:42:34 [2019-09-27T12:42:34.847Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
12:42:34 [2019-09-27T12:42:34.847Z]     --- PASS: TestDockerNetworkMacvlan/NilParent (1.18s)
12:42:34 [2019-09-27T12:42:34.847Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
12:42:34 [2019-09-27T12:42:34.847Z]     --- PASS: TestDockerNetworkMacvlan/InternalMode (2.27s)
12:42:34 [2019-09-27T12:42:34.847Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
12:42:34 [2019-09-27T12:42:34.847Z]     --- PASS: TestDockerNetworkMacvlan/MultiSubnet (3.02s)
12:42:34 [2019-09-27T12:42:34.847Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
12:42:34 [2019-09-27T12:42:34.847Z]     --- PASS: TestDockerNetworkMacvlan/Addressing (0.91s)
12:42:34 [2019-09-27T12:42:34.847Z] PASS
12:42:34 [2019-09-27T12:42:34.847Z] 
12:42:34 [2019-09-27T12:42:34.847Z] DONE 8 tests in 16.356s
12:42:34 [2019-09-27T12:42:34.847Z] Running /go/src/github.com/docker/docker/integration/plugin (s390x.integration.plugin) flags=-test.v -test.timeout=120m 
12:42:34 [2019-09-27T12:42:34.847Z] ++ 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
12:42:34 [2019-09-27T12:42:34.847Z] ++ set -e
12:42:34 [2019-09-27T12:42:34.847Z] ++ '[' -n 0 ']'
12:42:34 [2019-09-27T12:42:34.847Z] ++ set -x
12:42:34 [2019-09-27T12:42:34.848Z] ++ 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
12:42:34 [2019-09-27T12:42:34.848Z] testing: warning: no tests to run
12:42:34 [2019-09-27T12:42:34.848Z] PASS
12:42:34 [2019-09-27T12:42:34.848Z] 
12:42:34 [2019-09-27T12:42:34.848Z] DONE 0 tests in 0.131s
12:42:34 [2019-09-27T12:42:34.848Z] Running /go/src/github.com/docker/docker/integration/plugin/authz (s390x.integration.plugin.authz) flags=-test.v -test.timeout=120m 
12:42:34 [2019-09-27T12:42:34.848Z] ++ 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
12:42:34 [2019-09-27T12:42:34.848Z] ++ set -e
12:42:34 [2019-09-27T12:42:34.848Z] ++ '[' -n 0 ']'
12:42:34 [2019-09-27T12:42:34.848Z] ++ set -x
12:42:34 [2019-09-27T12:42:34.848Z] ++ 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
12:42:35 [2019-09-27T12:42:35.224Z] INFO: Testing against a local daemon
12:42:35 [2019-09-27T12:42:35.224Z] === RUN   TestAuthZPluginAllowRequest
12:42:37 [2019-09-27T12:42:37.025Z] --- PASS: TestAuthZPluginAllowRequest (1.67s)
12:42:37 [2019-09-27T12:42:37.025Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginAllowRequest"
12:42:37 [2019-09-27T12:42:37.025Z] === RUN   TestAuthZPluginTLS
12:42:37 [2019-09-27T12:42:37.389Z] --- PASS: TestAuthZPluginTLS (0.55s)
12:42:37 [2019-09-27T12:42:37.389Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginTLS"
12:42:37 [2019-09-27T12:42:37.389Z] === RUN   TestAuthZPluginDenyRequest
12:42:37 [2019-09-27T12:42:37.787Z] --- PASS: TestAuthZPluginDenyRequest (0.53s)
12:42:37 [2019-09-27T12:42:37.787Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginDenyRequest"
12:42:37 [2019-09-27T12:42:37.787Z] === RUN   TestAuthZPluginAPIDenyResponse
12:42:38 [2019-09-27T12:42:38.646Z] --- PASS: TestAuthZPluginAPIDenyResponse (0.55s)
12:42:38 [2019-09-27T12:42:38.646Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginAPIDenyResponse"
12:42:38 [2019-09-27T12:42:38.646Z] === RUN   TestAuthZPluginDenyResponse
12:42:39 [2019-09-27T12:42:39.011Z] --- PASS: TestAuthZPluginDenyResponse (0.54s)
12:42:39 [2019-09-27T12:42:39.011Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginDenyResponse"
12:42:39 [2019-09-27T12:42:39.011Z] === RUN   TestAuthZPluginAllowEventStream
12:42:40 [2019-09-27T12:42:40.820Z] --- PASS: TestAuthZPluginAllowEventStream (1.71s)
12:42:40 [2019-09-27T12:42:40.820Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginAllowEventStream"
12:42:40 [2019-09-27T12:42:40.820Z] === RUN   TestAuthZPluginErrorResponse
12:42:41 [2019-09-27T12:42:41.184Z] --- PASS: TestAuthZPluginErrorResponse (0.54s)
12:42:41 [2019-09-27T12:42:41.184Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginErrorResponse"
12:42:41 [2019-09-27T12:42:41.184Z] === RUN   TestAuthZPluginErrorRequest
12:42:41 [2019-09-27T12:42:41.560Z] --- PASS: TestAuthZPluginErrorRequest (0.53s)
12:42:41 [2019-09-27T12:42:41.560Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginErrorRequest"
12:42:41 [2019-09-27T12:42:41.560Z] === RUN   TestAuthZPluginEnsureNoDuplicatePluginRegistration
12:42:42 [2019-09-27T12:42:42.345Z] --- PASS: TestAuthZPluginEnsureNoDuplicatePluginRegistration (0.54s)
12:42:42 [2019-09-27T12:42:42.345Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginEnsureNoDuplicatePluginRegistration"
12:42:42 [2019-09-27T12:42:42.345Z] === RUN   TestAuthZPluginEnsureLoadImportWorking
12:42:44 [2019-09-27T12:42:44.925Z] --- PASS: TestAuthZPluginEnsureLoadImportWorking (2.38s)
12:42:44 [2019-09-27T12:42:44.925Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginEnsureLoadImportWorking"
12:42:44 [2019-09-27T12:42:44.925Z] === RUN   TestAuthzPluginEnsureContainerCopyToFrom
12:42:46 [2019-09-27T12:42:46.759Z] --- PASS: TestAuthzPluginEnsureContainerCopyToFrom (2.14s)
12:42:46 [2019-09-27T12:42:46.759Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthzPluginEnsureContainerCopyToFrom"
12:42:46 [2019-09-27T12:42:46.759Z] === RUN   TestAuthZPluginHeader
12:42:47 [2019-09-27T12:42:47.538Z] --- PASS: TestAuthZPluginHeader (0.83s)
12:42:47 [2019-09-27T12:42:47.538Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginHeader"
12:42:47 [2019-09-27T12:42:47.538Z] === RUN   TestAuthZPluginV2AllowNonVolumeRequest
12:42:47 [2019-09-27T12:42:47.538Z] --- SKIP: TestAuthZPluginV2AllowNonVolumeRequest (0.01s)
12:42:47 [2019-09-27T12:42:47.538Z]     authz_plugin_v2_test.go:43: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
12:42:47 [2019-09-27T12:42:47.538Z] === RUN   TestAuthZPluginV2Disable
12:42:47 [2019-09-27T12:42:47.538Z] --- SKIP: TestAuthZPluginV2Disable (0.00s)
12:42:47 [2019-09-27T12:42:47.538Z]     authz_plugin_v2_test.go:65: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
12:42:47 [2019-09-27T12:42:47.538Z] === RUN   TestAuthZPluginV2RejectVolumeRequests
12:42:47 [2019-09-27T12:42:47.538Z] --- SKIP: TestAuthZPluginV2RejectVolumeRequests (0.00s)
12:42:47 [2019-09-27T12:42:47.538Z]     authz_plugin_v2_test.go:91: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
12:42:47 [2019-09-27T12:42:47.538Z] === RUN   TestAuthZPluginV2BadManifestFailsDaemonStart
12:42:47 [2019-09-27T12:42:47.538Z] --- SKIP: TestAuthZPluginV2BadManifestFailsDaemonStart (0.00s)
12:42:47 [2019-09-27T12:42:47.538Z]     authz_plugin_v2_test.go:126: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
12:42:47 [2019-09-27T12:42:47.538Z] === RUN   TestAuthZPluginV2NonexistentFailsDaemonStart
12:43:07 [2019-09-27T12:43:07.322Z] --- PASS: TestAuthZPluginV2NonexistentFailsDaemonStart (16.83s)
12:43:07 [2019-09-27T12:43:07.322Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginV2NonexistentFailsDaemonStart"
12:43:07 [2019-09-27T12:43:07.322Z] PASS
12:43:07 [2019-09-27T12:43:07.322Z] 
12:43:07 [2019-09-27T12:43:07.322Z] === Skipped
12:43:07 [2019-09-27T12:43:07.322Z] === SKIP: s390x.integration.plugin.authz TestAuthZPluginV2AllowNonVolumeRequest (0.01s)
12:43:07 [2019-09-27T12:43:07.322Z]     authz_plugin_v2_test.go:43: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
12:43:07 [2019-09-27T12:43:07.322Z] 
12:43:07 [2019-09-27T12:43:07.322Z] === SKIP: s390x.integration.plugin.authz TestAuthZPluginV2Disable (0.00s)
12:43:07 [2019-09-27T12:43:07.322Z]     authz_plugin_v2_test.go:65: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
12:43:07 [2019-09-27T12:43:07.322Z] 
12:43:07 [2019-09-27T12:43:07.322Z] === SKIP: s390x.integration.plugin.authz TestAuthZPluginV2RejectVolumeRequests (0.00s)
12:43:07 [2019-09-27T12:43:07.322Z]     authz_plugin_v2_test.go:91: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
12:43:07 [2019-09-27T12:43:07.322Z] 
12:43:07 [2019-09-27T12:43:07.322Z] === SKIP: s390x.integration.plugin.authz TestAuthZPluginV2BadManifestFailsDaemonStart (0.00s)
12:43:07 [2019-09-27T12:43:07.322Z]     authz_plugin_v2_test.go:126: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
12:43:07 [2019-09-27T12:43:07.322Z] 
12:43:07 [2019-09-27T12:43:07.322Z] 
12:43:07 [2019-09-27T12:43:07.322Z] DONE 17 tests, 4 skipped in 29.785s
12:43:07 [2019-09-27T12:43:07.322Z] Running /go/src/github.com/docker/docker/integration/plugin/common (s390x.integration.plugin.common) flags=-test.v -test.timeout=120m 
12:43:07 [2019-09-27T12:43:07.322Z] ++ 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
12:43:07 [2019-09-27T12:43:07.322Z] ++ set -e
12:43:07 [2019-09-27T12:43:07.322Z] ++ '[' -n 0 ']'
12:43:07 [2019-09-27T12:43:07.322Z] ++ set -x
12:43:07 [2019-09-27T12:43:07.322Z] ++ 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
12:43:07 [2019-09-27T12:43:07.322Z] INFO: Testing against a local daemon
12:43:07 [2019-09-27T12:43:07.322Z] === RUN   TestPluginInvalidJSON
12:43:07 [2019-09-27T12:43:07.322Z] === RUN   TestPluginInvalidJSON//plugins/foobar/set
12:43:07 [2019-09-27T12:43:07.322Z] === PAUSE TestPluginInvalidJSON//plugins/foobar/set
12:43:07 [2019-09-27T12:43:07.322Z] === CONT  TestPluginInvalidJSON//plugins/foobar/set
12:43:07 [2019-09-27T12:43:07.322Z] --- PASS: TestPluginInvalidJSON (0.02s)
12:43:07 [2019-09-27T12:43:07.322Z]     --- PASS: TestPluginInvalidJSON//plugins/foobar/set (0.00s)
12:43:07 [2019-09-27T12:43:07.322Z] PASS
12:43:07 [2019-09-27T12:43:07.322Z] 
12:43:07 [2019-09-27T12:43:07.322Z] DONE 2 tests in 0.189s
12:43:07 [2019-09-27T12:43:07.322Z] Running /go/src/github.com/docker/docker/integration/plugin/graphdriver (s390x.integration.plugin.graphdriver) flags=-test.v -test.timeout=120m 
12:43:07 [2019-09-27T12:43:07.322Z] ++ 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
12:43:07 [2019-09-27T12:43:07.322Z] ++ set -e
12:43:07 [2019-09-27T12:43:07.322Z] ++ '[' -n 0 ']'
12:43:07 [2019-09-27T12:43:07.322Z] ++ set -x
12:43:07 [2019-09-27T12:43:07.322Z] ++ 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
12:43:07 [2019-09-27T12:43:07.322Z] INFO: Testing against a local daemon
12:43:07 [2019-09-27T12:43:07.322Z] === RUN   TestExternalGraphDriver
12:43:07 [2019-09-27T12:43:07.322Z] === RUN   TestExternalGraphDriver/json
12:43:08 [2019-09-27T12:43:08.126Z] === RUN   TestExternalGraphDriver/spec
12:43:10 [2019-09-27T12:43:10.571Z] === RUN   TestExternalGraphDriver/pull
12:43:13 [2019-09-27T12:43:13.840Z] --- PASS: TestExternalGraphDriver (8.29s)
12:43:13 [2019-09-27T12:43:13.840Z]     external_test.go:57: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestExternalGraphDriver"
12:43:13 [2019-09-27T12:43:13.840Z]     --- PASS: TestExternalGraphDriver/json (2.98s)
12:43:13 [2019-09-27T12:43:13.840Z]     --- PASS: TestExternalGraphDriver/spec (2.22s)
12:43:13 [2019-09-27T12:43:13.840Z]     --- PASS: TestExternalGraphDriver/pull (2.94s)
12:43:13 [2019-09-27T12:43:13.840Z] === RUN   TestGraphdriverPluginV2
12:43:13 [2019-09-27T12:43:13.840Z] --- SKIP: TestGraphdriverPluginV2 (0.08s)
12:43:13 [2019-09-27T12:43:13.840Z]     external_test.go:410: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
12:43:13 [2019-09-27T12:43:13.840Z] PASS
12:43:13 [2019-09-27T12:43:13.840Z] 
12:43:13 [2019-09-27T12:43:13.840Z] === Skipped
12:43:13 [2019-09-27T12:43:13.840Z] === SKIP: s390x.integration.plugin.graphdriver TestGraphdriverPluginV2 (0.08s)
12:43:13 [2019-09-27T12:43:13.840Z]     external_test.go:410: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
12:43:13 [2019-09-27T12:43:13.840Z] 
12:43:13 [2019-09-27T12:43:13.840Z] 
12:43:13 [2019-09-27T12:43:13.840Z] DONE 5 tests, 1 skipped in 8.768s
12:43:13 [2019-09-27T12:43:13.840Z] Running /go/src/github.com/docker/docker/integration/plugin/logging (s390x.integration.plugin.logging) flags=-test.v -test.timeout=120m 
12:43:13 [2019-09-27T12:43:13.840Z] ++ 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
12:43:13 [2019-09-27T12:43:13.840Z] ++ set -e
12:43:13 [2019-09-27T12:43:13.840Z] ++ '[' -n 0 ']'
12:43:13 [2019-09-27T12:43:13.840Z] ++ set -x
12:43:13 [2019-09-27T12:43:13.840Z] ++ 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
12:43:13 [2019-09-27T12:43:13.840Z] INFO: Testing against a local daemon
12:43:13 [2019-09-27T12:43:13.840Z] === RUN   TestContinueAfterPluginCrash
12:43:13 [2019-09-27T12:43:13.840Z] === PAUSE TestContinueAfterPluginCrash
12:43:13 [2019-09-27T12:43:13.840Z] === RUN   TestDaemonStartWithLogOpt
12:43:13 [2019-09-27T12:43:13.840Z] === PAUSE TestDaemonStartWithLogOpt
12:43:13 [2019-09-27T12:43:13.840Z] === CONT  TestContinueAfterPluginCrash
12:43:13 [2019-09-27T12:43:13.840Z] === CONT  TestDaemonStartWithLogOpt
12:43:27 [2019-09-27T12:43:27.674Z] --- PASS: TestDaemonStartWithLogOpt (12.12s)
12:43:27 [2019-09-27T12:43:27.674Z]     validation_test.go:23: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonStartWithLogOpt"
12:43:30 [2019-09-27T12:43:30.823Z] --- PASS: TestContinueAfterPluginCrash (17.01s)
12:43:30 [2019-09-27T12:43:30.823Z]     logging_linux_test.go:22: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestContinueAfterPluginCrash"
12:43:30 [2019-09-27T12:43:30.823Z] PASS
12:43:30 [2019-09-27T12:43:30.823Z] 
12:43:30 [2019-09-27T12:43:30.823Z] DONE 2 tests in 17.172s
12:43:30 [2019-09-27T12:43:30.823Z] Running /go/src/github.com/docker/docker/integration/plugin/volumes (s390x.integration.plugin.volumes) flags=-test.v -test.timeout=120m 
12:43:30 [2019-09-27T12:43:30.824Z] ++ 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
12:43:30 [2019-09-27T12:43:30.824Z] ++ set -e
12:43:30 [2019-09-27T12:43:30.824Z] ++ '[' -n 0 ']'
12:43:30 [2019-09-27T12:43:30.824Z] ++ set -x
12:43:30 [2019-09-27T12:43:30.824Z] ++ 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
12:43:30 [2019-09-27T12:43:30.824Z] INFO: Testing against a local daemon
12:43:30 [2019-09-27T12:43:30.824Z] === RUN   TestPluginWithDevMounts
12:43:30 [2019-09-27T12:43:30.824Z] === PAUSE TestPluginWithDevMounts
12:43:30 [2019-09-27T12:43:30.824Z] === CONT  TestPluginWithDevMounts
12:43:32 [2019-09-27T12:43:32.842Z] --- PASS: TestPluginWithDevMounts (2.10s)
12:43:32 [2019-09-27T12:43:32.842Z]     mounts_test.go:23: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestPluginWithDevMounts"
12:43:32 [2019-09-27T12:43:32.842Z] PASS
12:43:32 [2019-09-27T12:43:32.842Z] 
12:43:32 [2019-09-27T12:43:32.842Z] DONE 1 tests in 2.309s
12:43:32 [2019-09-27T12:43:32.842Z] Running /go/src/github.com/docker/docker/integration/secret (s390x.integration.secret) flags=-test.v -test.timeout=120m 
12:43:32 [2019-09-27T12:43:32.842Z] ++ 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
12:43:32 [2019-09-27T12:43:32.842Z] ++ set -e
12:43:32 [2019-09-27T12:43:32.842Z] ++ '[' -n 0 ']'
12:43:32 [2019-09-27T12:43:32.842Z] ++ set -x
12:43:32 [2019-09-27T12:43:32.842Z] ++ 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
12:43:33 [2019-09-27T12:43:33.208Z] INFO: Testing against a local daemon
12:43:33 [2019-09-27T12:43:33.208Z] === RUN   TestSecretInspect
12:43:36 [2019-09-27T12:43:36.409Z] --- PASS: TestSecretInspect (2.84s)
12:43:36 [2019-09-27T12:43:36.409Z]     secret_test.go:25: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestSecretInspect"
12:43:36 [2019-09-27T12:43:36.409Z] === RUN   TestSecretList
12:43:38 [2019-09-27T12:43:38.989Z] --- PASS: TestSecretList (2.89s)
12:43:38 [2019-09-27T12:43:38.989Z]     secret_test.go:48: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestSecretList"
12:43:38 [2019-09-27T12:43:38.989Z] === RUN   TestSecretsCreateAndDelete
12:43:42 [2019-09-27T12:43:42.190Z] --- PASS: TestSecretsCreateAndDelete (2.96s)
12:43:42 [2019-09-27T12:43:42.190Z]     secret_test.go:125: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestSecretsCreateAndDelete"
12:43:42 [2019-09-27T12:43:42.190Z] === RUN   TestSecretsUpdate
12:43:44 [2019-09-27T12:43:44.778Z] --- PASS: TestSecretsUpdate (2.87s)
12:43:44 [2019-09-27T12:43:44.778Z]     secret_test.go:172: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestSecretsUpdate"
12:43:44 [2019-09-27T12:43:44.778Z] === RUN   TestTemplatedSecret
12:43:48 [2019-09-27T12:43:48.833Z] --- PASS: TestTemplatedSecret (3.50s)
12:43:48 [2019-09-27T12:43:48.833Z]     secret_test.go:221: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestTemplatedSecret"
12:43:48 [2019-09-27T12:43:48.833Z] === RUN   TestSecretCreateResolve
12:43:51 [2019-09-27T12:43:51.370Z] --- PASS: TestSecretCreateResolve (2.75s)
12:43:51 [2019-09-27T12:43:51.370Z]     secret_test.go:342: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestSecretCreateResolve"
12:43:51 [2019-09-27T12:43:51.370Z] PASS
12:43:51 [2019-09-27T12:43:51.370Z] 
12:43:51 [2019-09-27T12:43:51.370Z] DONE 6 tests in 18.000s
12:43:51 [2019-09-27T12:43:51.370Z] Running /go/src/github.com/docker/docker/integration/service (s390x.integration.service) flags=-test.v -test.timeout=120m 
12:43:51 [2019-09-27T12:43:51.370Z] ++ 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
12:43:51 [2019-09-27T12:43:51.370Z] ++ set -e
12:43:51 [2019-09-27T12:43:51.370Z] ++ '[' -n 0 ']'
12:43:51 [2019-09-27T12:43:51.370Z] ++ set -x
12:43:51 [2019-09-27T12:43:51.370Z] ++ 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
12:43:51 [2019-09-27T12:43:51.370Z] INFO: Testing against a local daemon
12:43:51 [2019-09-27T12:43:51.370Z] === RUN   TestServiceCreateInit
12:43:51 [2019-09-27T12:43:51.370Z] === RUN   TestServiceCreateInit/daemonInitDisabled
12:43:56 [2019-09-27T12:43:56.398Z] === RUN   TestServiceCreateInit/daemonInitEnabled
12:44:01 [2019-09-27T12:44:01.571Z] --- PASS: TestServiceCreateInit (9.99s)
12:44:01 [2019-09-27T12:44:01.571Z]     --- PASS: TestServiceCreateInit/daemonInitDisabled (4.92s)
12:44:01 [2019-09-27T12:44:01.571Z]         create_test.go:38: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceCreateInit/daemonInitDisabled"
12:44:01 [2019-09-27T12:44:01.571Z]     --- PASS: TestServiceCreateInit/daemonInitEnabled (5.05s)
12:44:01 [2019-09-27T12:44:01.571Z]         create_test.go:38: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceCreateInit/daemonInitEnabled"
12:44:01 [2019-09-27T12:44:01.571Z] === RUN   TestCreateServiceMultipleTimes
12:44:21 [2019-09-27T12:44:21.325Z] --- PASS: TestCreateServiceMultipleTimes (19.33s)
12:44:21 [2019-09-27T12:44:21.325Z]     create_test.go:80: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceMultipleTimes"
12:44:21 [2019-09-27T12:44:21.325Z] === RUN   TestCreateServiceConflict
12:44:23 [2019-09-27T12:44:23.212Z] --- PASS: TestCreateServiceConflict (2.77s)
12:44:23 [2019-09-27T12:44:23.212Z]     create_test.go:129: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceConflict"
12:44:23 [2019-09-27T12:44:23.212Z] === RUN   TestCreateServiceMaxReplicas
12:44:27 [2019-09-27T12:44:27.265Z] --- PASS: TestCreateServiceMaxReplicas (3.59s)
12:44:27 [2019-09-27T12:44:27.265Z]     create_test.go:150: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceMaxReplicas"
12:44:27 [2019-09-27T12:44:27.265Z] === RUN   TestCreateWithDuplicateNetworkNames
12:44:40 [2019-09-27T12:44:40.929Z] --- PASS: TestCreateWithDuplicateNetworkNames (14.01s)
12:44:40 [2019-09-27T12:44:40.929Z]     create_test.go:171: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateWithDuplicateNetworkNames"
12:44:40 [2019-09-27T12:44:40.930Z] === RUN   TestCreateServiceSecretFileMode
12:44:44 [2019-09-27T12:44:44.181Z] --- PASS: TestCreateServiceSecretFileMode (3.17s)
12:44:44 [2019-09-27T12:44:44.181Z]     create_test.go:224: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceSecretFileMode"
12:44:44 [2019-09-27T12:44:44.181Z] === RUN   TestCreateServiceConfigFileMode
12:44:47 [2019-09-27T12:44:47.399Z] --- PASS: TestCreateServiceConfigFileMode (3.24s)
12:44:47 [2019-09-27T12:44:47.399Z]     create_test.go:288: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceConfigFileMode"
12:44:47 [2019-09-27T12:44:47.399Z] === RUN   TestCreateServiceSysctls
12:44:51 [2019-09-27T12:44:51.670Z] --- PASS: TestCreateServiceSysctls (4.13s)
12:44:51 [2019-09-27T12:44:51.670Z]     create_test.go:378: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceSysctls"
12:44:51 [2019-09-27T12:44:51.670Z] === RUN   TestCreateServiceCapabilities
12:44:54 [2019-09-27T12:44:54.837Z] --- PASS: TestCreateServiceCapabilities (3.22s)
12:44:54 [2019-09-27T12:44:54.837Z]     create_test.go:462: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceCapabilities"
12:44:54 [2019-09-27T12:44:54.837Z] === RUN   TestInspect
12:44:58 [2019-09-27T12:44:58.160Z] --- PASS: TestInspect (3.53s)
12:44:58 [2019-09-27T12:44:58.160Z]     inspect_test.go:23: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestInspect"
12:44:58 [2019-09-27T12:44:58.160Z] === RUN   TestDockerNetworkConnectAlias
12:45:04 [2019-09-27T12:45:04.459Z] --- PASS: TestDockerNetworkConnectAlias (6.15s)
12:45:04 [2019-09-27T12:45:04.459Z]     network_test.go:20: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkConnectAlias"
12:45:04 [2019-09-27T12:45:04.460Z] === RUN   TestDockerNetworkReConnect
12:45:09 [2019-09-27T12:45:09.541Z] --- PASS: TestDockerNetworkReConnect (4.82s)
12:45:09 [2019-09-27T12:45:09.541Z]     network_test.go:82: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkReConnect"
12:45:09 [2019-09-27T12:45:09.541Z] === RUN   TestServicePlugin
12:45:09 [2019-09-27T12:45:09.541Z] --- SKIP: TestServicePlugin (0.00s)
12:45:09 [2019-09-27T12:45:09.541Z]     plugin_test.go:28: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
12:45:09 [2019-09-27T12:45:09.541Z] === RUN   TestServiceUpdateLabel
12:45:12 [2019-09-27T12:45:12.053Z] --- PASS: TestServiceUpdateLabel (2.50s)
12:45:12 [2019-09-27T12:45:12.053Z]     update_test.go:21: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateLabel"
12:45:12 [2019-09-27T12:45:12.053Z] === RUN   TestServiceUpdateSecrets
12:45:28 [2019-09-27T12:45:28.401Z] --- PASS: TestServiceUpdateSecrets (15.60s)
12:45:28 [2019-09-27T12:45:28.401Z]     update_test.go:77: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateSecrets"
12:45:28 [2019-09-27T12:45:28.401Z] === RUN   TestServiceUpdateConfigs
12:45:44 [2019-09-27T12:45:44.839Z] --- PASS: TestServiceUpdateConfigs (15.52s)
12:45:44 [2019-09-27T12:45:44.839Z]     update_test.go:139: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateConfigs"
12:45:44 [2019-09-27T12:45:44.839Z] === RUN   TestServiceUpdateNetwork
12:45:58 [2019-09-27T12:45:58.488Z] --- PASS: TestServiceUpdateNetwork (14.25s)
12:45:58 [2019-09-27T12:45:58.488Z]     update_test.go:201: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateNetwork"
12:45:58 [2019-09-27T12:45:58.488Z] PASS
12:45:58 [2019-09-27T12:45:58.488Z] 
12:45:58 [2019-09-27T12:45:58.488Z] === Skipped
12:45:58 [2019-09-27T12:45:58.488Z] === SKIP: s390x.integration.service TestServicePlugin (0.00s)
12:45:58 [2019-09-27T12:45:58.488Z]     plugin_test.go:28: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
12:45:58 [2019-09-27T12:45:58.488Z] 
12:45:58 [2019-09-27T12:45:58.488Z] 
12:45:58 [2019-09-27T12:45:58.488Z] DONE 19 tests, 1 skipped in 125.997s
12:45:58 [2019-09-27T12:45:58.488Z] Running /go/src/github.com/docker/docker/integration/session (s390x.integration.session) flags=-test.v -test.timeout=120m 
12:45:58 [2019-09-27T12:45:58.488Z] ++ 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
12:45:58 [2019-09-27T12:45:58.488Z] ++ set -e
12:45:58 [2019-09-27T12:45:58.488Z] ++ '[' -n 0 ']'
12:45:58 [2019-09-27T12:45:58.488Z] ++ set -x
12:45:58 [2019-09-27T12:45:58.488Z] ++ 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
12:45:58 [2019-09-27T12:45:58.488Z] INFO: Testing against a local daemon
12:45:58 [2019-09-27T12:45:58.488Z] === RUN   TestSessionCreate
12:45:58 [2019-09-27T12:45:58.488Z] --- PASS: TestSessionCreate (0.02s)
12:45:58 [2019-09-27T12:45:58.488Z] === RUN   TestSessionCreateWithBadUpgrade
12:45:58 [2019-09-27T12:45:58.488Z] --- PASS: TestSessionCreateWithBadUpgrade (0.02s)
12:45:58 [2019-09-27T12:45:58.488Z] PASS
12:45:58 [2019-09-27T12:45:58.488Z] 
12:45:58 [2019-09-27T12:45:58.488Z] DONE 2 tests in 0.256s
12:45:58 [2019-09-27T12:45:58.488Z] Running /go/src/github.com/docker/docker/integration/system (s390x.integration.system) flags=-test.v -test.timeout=120m 
12:45:58 [2019-09-27T12:45:58.488Z] ++ 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
12:45:58 [2019-09-27T12:45:58.488Z] ++ set -e
12:45:58 [2019-09-27T12:45:58.488Z] ++ '[' -n 0 ']'
12:45:58 [2019-09-27T12:45:58.488Z] ++ set -x
12:45:58 [2019-09-27T12:45:58.488Z] ++ 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
12:45:58 [2019-09-27T12:45:58.488Z] INFO: Testing against a local daemon
12:45:58 [2019-09-27T12:45:58.488Z] === RUN   TestCgroupDriverSystemdMemoryLimit
12:45:58 [2019-09-27T12:45:58.488Z] --- SKIP: TestCgroupDriverSystemdMemoryLimit (0.00s)
12:45:58 [2019-09-27T12:45:58.488Z]     cgroupdriver_systemd_test.go:32: !hasSystemd()
12:45:58 [2019-09-27T12:45:58.488Z] === RUN   TestEventsExecDie
12:45:58 [2019-09-27T12:45:58.488Z] --- PASS: TestEventsExecDie (1.02s)
12:45:58 [2019-09-27T12:45:58.488Z] === RUN   TestEventsBackwardsCompatible
12:45:58 [2019-09-27T12:45:58.488Z] --- PASS: TestEventsBackwardsCompatible (0.09s)
12:45:58 [2019-09-27T12:45:58.488Z] === RUN   TestInfoBinaryCommits
12:45:58 [2019-09-27T12:45:58.488Z] --- PASS: TestInfoBinaryCommits (0.02s)
12:45:58 [2019-09-27T12:45:58.488Z] === RUN   TestInfoAPIVersioned
12:45:58 [2019-09-27T12:45:58.488Z] --- PASS: TestInfoAPIVersioned (0.01s)
12:45:58 [2019-09-27T12:45:58.488Z] === RUN   TestInfoAPI
12:45:58 [2019-09-27T12:45:58.488Z] --- PASS: TestInfoAPI (0.04s)
12:45:58 [2019-09-27T12:45:58.488Z] === RUN   TestInfoAPIWarnings
12:45:59 [2019-09-27T12:45:59.794Z] --- PASS: TestInfoAPIWarnings (0.85s)
12:45:59 [2019-09-27T12:45:59.794Z]     info_test.go:49: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestInfoAPIWarnings"
12:45:59 [2019-09-27T12:45:59.794Z] === RUN   TestLoginFailsWithBadCredentials
12:45:59 [2019-09-27T12:45:59.794Z] --- PASS: TestLoginFailsWithBadCredentials (0.39s)
12:45:59 [2019-09-27T12:45:59.794Z] === RUN   TestPingCacheHeaders
12:45:59 [2019-09-27T12:45:59.794Z] --- PASS: TestPingCacheHeaders (0.03s)
12:45:59 [2019-09-27T12:45:59.794Z] === RUN   TestPingGet
12:45:59 [2019-09-27T12:45:59.794Z] --- PASS: TestPingGet (0.03s)
12:45:59 [2019-09-27T12:45:59.794Z] === RUN   TestPingHead
12:45:59 [2019-09-27T12:45:59.794Z] --- PASS: TestPingHead (0.06s)
12:45:59 [2019-09-27T12:45:59.794Z] === RUN   TestVersion
12:46:00 [2019-09-27T12:46:00.241Z] --- PASS: TestVersion (0.03s)
12:46:00 [2019-09-27T12:46:00.241Z] PASS
12:46:00 [2019-09-27T12:46:00.241Z] 
12:46:00 [2019-09-27T12:46:00.241Z] === Skipped
12:46:00 [2019-09-27T12:46:00.241Z] === SKIP: s390x.integration.system TestCgroupDriverSystemdMemoryLimit (0.00s)
12:46:00 [2019-09-27T12:46:00.241Z]     cgroupdriver_systemd_test.go:32: !hasSystemd()
12:46:00 [2019-09-27T12:46:00.241Z] 
12:46:00 [2019-09-27T12:46:00.241Z] 
12:46:00 [2019-09-27T12:46:00.241Z] DONE 12 tests, 1 skipped in 2.741s
12:46:00 [2019-09-27T12:46:00.241Z] Running /go/src/github.com/docker/docker/integration/volume (s390x.integration.volume) flags=-test.v -test.timeout=120m 
12:46:00 [2019-09-27T12:46:00.241Z] ++ 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
12:46:00 [2019-09-27T12:46:00.241Z] ++ set -e
12:46:00 [2019-09-27T12:46:00.241Z] ++ '[' -n 0 ']'
12:46:00 [2019-09-27T12:46:00.241Z] ++ set -x
12:46:00 [2019-09-27T12:46:00.241Z] ++ 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
12:46:00 [2019-09-27T12:46:00.241Z] INFO: Testing against a local daemon
12:46:00 [2019-09-27T12:46:00.241Z] === RUN   TestVolumesCreateAndList
12:46:00 [2019-09-27T12:46:00.241Z] --- PASS: TestVolumesCreateAndList (0.03s)
12:46:00 [2019-09-27T12:46:00.241Z] === RUN   TestVolumesRemove
12:46:00 [2019-09-27T12:46:00.241Z] --- PASS: TestVolumesRemove (0.09s)
12:46:00 [2019-09-27T12:46:00.241Z] === RUN   TestVolumesInspect
12:46:00 [2019-09-27T12:46:00.241Z] --- PASS: TestVolumesInspect (0.04s)
12:46:00 [2019-09-27T12:46:00.241Z] === RUN   TestVolumesInvalidJSON
12:46:00 [2019-09-27T12:46:00.241Z] === RUN   TestVolumesInvalidJSON//volumes/create
12:46:00 [2019-09-27T12:46:00.241Z] === PAUSE TestVolumesInvalidJSON//volumes/create
12:46:00 [2019-09-27T12:46:00.241Z] === CONT  TestVolumesInvalidJSON//volumes/create
12:46:00 [2019-09-27T12:46:00.241Z] --- PASS: TestVolumesInvalidJSON (0.01s)
12:46:00 [2019-09-27T12:46:00.241Z]     --- PASS: TestVolumesInvalidJSON//volumes/create (0.00s)
12:46:00 [2019-09-27T12:46:00.241Z] PASS
12:46:00 [2019-09-27T12:46:00.241Z] 
12:46:00 [2019-09-27T12:46:00.241Z] DONE 5 tests in 0.329s
12:46:00 [2019-09-27T12:46:00.241Z] ---> Making bundle: .integration-daemon-stop (in bundles/test-integration)
12:46:00 [2019-09-27T12:46:00.719Z] ++++ cat bundles/test-integration/docker.pid
12:46:00 [2019-09-27T12:46:00.719Z] +++ kill 11477
12:46:01 [2019-09-27T12:46:01.990Z] umount: bundles/test-integration/root: mountpoint not found
12:46:01 [2019-09-27T12:46:01.990Z] +++ /etc/init.d/apparmor stop
12:46:01 [2019-09-27T12:46:01.990Z] Clearing AppArmor profiles cache:.
12:46:01 [2019-09-27T12:46:01.990Z] All profile caches have been cleared, but no profiles have been unloaded.
12:46:01 [2019-09-27T12:46:01.990Z] Unloading profiles will leave already running processes permanently
12:46:01 [2019-09-27T12:46:01.990Z] unconfined, which can lead to unexpected situations.
12:46:01 [2019-09-27T12:46:01.990Z] 
12:46:01 [2019-09-27T12:46:01.990Z] To set a process to complain mode, use the command line tool
12:46:01 [2019-09-27T12:46:01.990Z] 'aa-complain'. To really tear down all profiles, run the init script
12:46:01 [2019-09-27T12:46:01.990Z] with the 'teardown' option."
12:46:01 [2019-09-27T12:46:01.990Z]