Console Output

04:57:22 [2019-09-30T04:57:22.552Z] + docker run --rm -t --privileged -v /home/jenkins/workspace/moby_PR-40009/bundles:/go/src/github.com/docker/docker/bundles --name docker-pr1 -e DOCKER_EXPERIMENTAL -e DOCKER_GITCOMMIT=8498ee7514cfb166197f637cc3dd69194de5f16b -e DOCKER_GRAPHDRIVER -e TESTDEBUG -e TEST_SKIP_INTEGRATION_CLI -e TIMEOUT docker:8498ee7514cfb166197f637cc3dd69194de5f16b hack/make.sh dynbinary test-integration
04:57:22 [2019-09-30T04:57:22.934Z] 
04:57:22 [2019-09-30T04:57:22.934Z] Removing bundles/
04:57:22 [2019-09-30T04:57:22.934Z] 
04:57:22 [2019-09-30T04:57:22.934Z] ---> Making bundle: dynbinary (in bundles/dynbinary)
04:57:22 [2019-09-30T04:57:22.934Z] Building: bundles/dynbinary-daemon/dockerd-dev
04:57:22 [2019-09-30T04:57:22.934Z] GOOS="" GOARCH="" GOARM=""
04:58:21 [2019-09-30T04:58:21.813Z] Created binary: bundles/dynbinary-daemon/dockerd-dev
04:58:21 [2019-09-30T04:58:21.813Z] 
04:58:21 [2019-09-30T04:58:21.813Z] ---> Making bundle: test-integration (in bundles/test-integration)
04:58:21 [2019-09-30T04:58:21.813Z] PKG_CONFIG=pkg-config
04:58:21 [2019-09-30T04:58:21.813Z] GOLANG_VERSION=1.13.1
04:58:21 [2019-09-30T04:58:21.813Z] HOSTNAME=86104f975689
04:58:21 [2019-09-30T04:58:21.813Z] DOCKER_EXPERIMENTAL=1
04:58:21 [2019-09-30T04:58:21.813Z] container=docker
04:58:21 [2019-09-30T04:58:21.813Z] TEST_SKIP_INTEGRATION_CLI=1
04:58:21 [2019-09-30T04:58:21.813Z] GO111MODULE=off
04:58:21 [2019-09-30T04:58:21.813Z] GOPATH=/go
04:58:21 [2019-09-30T04:58:21.813Z] PWD=/go/src/github.com/docker/docker
04:58:21 [2019-09-30T04:58:21.813Z] HOME=/root
04:58:21 [2019-09-30T04:58:21.813Z] SCRIPTDIR=/go/src/github.com/docker/docker/hack
04:58:21 [2019-09-30T04:58:21.813Z] MAKEDIR=/go/src/github.com/docker/docker/hack/make
04:58:21 [2019-09-30T04:58:21.813Z] DOCKER_GITCOMMIT=8498ee7514cfb166197f637cc3dd69194de5f16b
04:58:21 [2019-09-30T04:58:21.813Z] DOCKER_BUILDTAGS=apparmor seccomp selinux journald
04:58:21 [2019-09-30T04:58:21.813Z] DOCKER_GRAPHDRIVER=overlay2
04:58:21 [2019-09-30T04:58:21.813Z] TERM=xterm
04:58:21 [2019-09-30T04:58:21.813Z] DEST=bundles/test-integration
04:58:21 [2019-09-30T04:58:21.813Z] SHLVL=1
04:58:21 [2019-09-30T04:58:21.813Z] TIMEOUT=120m
04:58:21 [2019-09-30T04:58:21.813Z] PATH=/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
04:58:21 [2019-09-30T04:58:21.813Z] DOCKER_PKG=github.com/docker/docker
04:58:21 [2019-09-30T04:58:21.813Z] TESTDEBUG=0
04:58:21 [2019-09-30T04:58:21.813Z] _=/usr/bin/env
04:58:21 [2019-09-30T04:58:21.813Z] Building test suite binary /go/src/github.com/docker/docker/integration/build/test.main
04:58:50 [2019-09-30T04:58:50.392Z] Building test suite binary /go/src/github.com/docker/docker/integration/config/test.main
04:58:50 [2019-09-30T04:58:50.393Z] Building test suite binary /go/src/github.com/docker/docker/integration/container/test.main
04:58:52 [2019-09-30T04:58:52.916Z] Building test suite binary /go/src/github.com/docker/docker/integration/image/test.main
04:59:13 [2019-09-30T04:59:13.029Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/test.main
04:59:13 [2019-09-30T04:59:13.418Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/ipvlan/test.main
04:59:14 [2019-09-30T04:59:14.766Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/macvlan/test.main
04:59:16 [2019-09-30T04:59:16.093Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/test.main
04:59:16 [2019-09-30T04:59:16.093Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/authz/test.main
04:59:17 [2019-09-30T04:59:17.997Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/common/test.main
04:59:19 [2019-09-30T04:59:19.271Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/graphdriver/test.main
04:59:20 [2019-09-30T04:59:20.549Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/logging/test.main
04:59:23 [2019-09-30T04:59:23.389Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/volumes/test.main
04:59:25 [2019-09-30T04:59:25.207Z] Building test suite binary /go/src/github.com/docker/docker/integration/secret/test.main
04:59:26 [2019-09-30T04:59:26.027Z] Building test suite binary /go/src/github.com/docker/docker/integration/service/test.main
04:59:28 [2019-09-30T04:59:28.077Z] Building test suite binary /go/src/github.com/docker/docker/integration/session/test.main
04:59:29 [2019-09-30T04:59:29.363Z] Building test suite binary /go/src/github.com/docker/docker/integration/system/test.main
04:59:30 [2019-09-30T04:59:30.634Z] Building test suite binary /go/src/github.com/docker/docker/integration/volume/test.main
04:59:31 [2019-09-30T04:59:31.917Z] ---> Making bundle: .integration-daemon-start (in bundles/test-integration)
04:59:31 [2019-09-30T04:59:31.917Z] Using test binary docker
04:59:31 [2019-09-30T04:59:31.917Z] # DOCKER_EXPERIMENTAL is set: starting daemon with experimental features enabled! 
04:59:31 [2019-09-30T04:59:31.917Z] +++ /etc/init.d/apparmor start
04:59:31 [2019-09-30T04:59:31.917Z] /etc/init.d/apparmor: 130: /etc/init.d/apparmor: systemd-detect-virt: not found
04:59:31 [2019-09-30T04:59:31.917Z] Starting AppArmor profiles:Warning from stdin (line 1): /sbin/apparmor_parser: cannot use or update cache, disable, or force-complain via stdin
04:59:31 [2019-09-30T04:59:31.917Z] Warning failed to create cache: (null)
04:59:31 [2019-09-30T04:59:31.917Z] .
04:59:31 [2019-09-30T04:59:31.917Z] Starting dockerd
04:59:31 [2019-09-30T04:59:31.917Z] INFO: Waiting for daemon to start...
04:59:31 [2019-09-30T04:59:31.917Z] +++ 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
04:59:33 [2019-09-30T04:59:33.705Z] .
04:59:33 [2019-09-30T04:59:33.705Z] ---> Making bundle: .integration-daemon-setup (in bundles/test-integration)
04:59:33 [2019-09-30T04:59:33.705Z] ---> Making bundle: .ensure-emptyfs (in bundles/test-integration)
04:59:33 [2019-09-30T04:59:33.705Z] Error: No such image: emptyfs
04:59:33 [2019-09-30T04:59:33.705Z] ++++ tar -cC bundles/test-integration/emptyfs .
04:59:33 [2019-09-30T04:59:33.705Z] ++++ docker load
04:59:34 [2019-09-30T04:59:34.094Z] Running integration-test (iteration 1)
04:59:34 [2019-09-30T04:59:34.094Z] Running /go/src/github.com/docker/docker/integration/build (s390x.integration.build) flags=-test.v -test.timeout=120m 
04:59:34 [2019-09-30T04:59:34.094Z] ++ 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
04:59:34 [2019-09-30T04:59:34.094Z] ++ set -e
04:59:34 [2019-09-30T04:59:34.094Z] ++ '[' -n 0 ']'
04:59:34 [2019-09-30T04:59:34.094Z] ++ set -x
04:59:34 [2019-09-30T04:59:34.094Z] ++ 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
04:59:43 [2019-09-30T04:59:43.649Z] Loaded image: buildpack-deps:jessie
04:59:43 [2019-09-30T04:59:43.649Z] Loaded image: busybox:latest
04:59:43 [2019-09-30T04:59:43.649Z] Loaded image: busybox:glibc
04:59:43 [2019-09-30T04:59:43.649Z] Loaded image: debian:jessie
04:59:43 [2019-09-30T04:59:43.649Z] Loaded image: hello-world:latest
04:59:43 [2019-09-30T04:59:43.649Z] INFO: Testing against a local daemon
04:59:43 [2019-09-30T04:59:43.649Z] === RUN   TestCgroupNamespacesBuild
04:59:44 [2019-09-30T04:59:44.433Z] --- PASS: TestCgroupNamespacesBuild (1.67s)
04:59:44 [2019-09-30T04:59:44.433Z]     build_cgroupns_linux_test.go:42: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesBuild"
04:59:44 [2019-09-30T04:59:44.433Z] === RUN   TestCgroupNamespacesBuildDaemonHostMode
04:59:46 [2019-09-30T04:59:46.325Z] --- PASS: TestCgroupNamespacesBuildDaemonHostMode (1.63s)
04:59:46 [2019-09-30T04:59:46.325Z]     build_cgroupns_linux_test.go:42: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesBuildDaemonHostMode"
04:59:46 [2019-09-30T04:59:46.325Z] === RUN   TestBuildWithSession
04:59:49 [2019-09-30T04:59:49.509Z] --- PASS: TestBuildWithSession (2.79s)
04:59:49 [2019-09-30T04:59:49.509Z] === RUN   TestBuildSquashParent
04:59:55 [2019-09-30T04:59:55.817Z] --- PASS: TestBuildSquashParent (6.13s)
04:59:55 [2019-09-30T04:59:55.817Z] === RUN   TestBuildWithRemoveAndForceRemove
04:59:55 [2019-09-30T04:59:55.817Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
04:59:55 [2019-09-30T04:59:55.817Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
04:59:55 [2019-09-30T04:59:55.817Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_remove
04:59:55 [2019-09-30T04:59:55.817Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_remove
04:59:55 [2019-09-30T04:59:55.817Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
04:59:55 [2019-09-30T04:59:55.817Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
04:59:55 [2019-09-30T04:59:55.817Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
04:59:55 [2019-09-30T04:59:55.817Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
04:59:55 [2019-09-30T04:59:55.817Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_remove
04:59:55 [2019-09-30T04:59:55.817Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_remove
04:59:55 [2019-09-30T04:59:55.817Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
04:59:55 [2019-09-30T04:59:55.817Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
04:59:55 [2019-09-30T04:59:55.817Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
04:59:55 [2019-09-30T04:59:55.817Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
04:59:57 [2019-09-30T04:59:57.623Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_remove
04:59:57 [2019-09-30T04:59:57.998Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
04:59:59 [2019-09-30T04:59:59.822Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
05:00:00 [2019-09-30T05:00:00.190Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_remove
05:00:02 [2019-09-30T05:00:02.782Z] --- PASS: TestBuildWithRemoveAndForceRemove (0.01s)
05:00:02 [2019-09-30T05:00:02.783Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove (2.61s)
05:00:02 [2019-09-30T05:00:02.783Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal (2.70s)
05:00:02 [2019-09-30T05:00:02.783Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_remove (2.20s)
05:00:02 [2019-09-30T05:00:02.783Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal (2.40s)
05:00:02 [2019-09-30T05:00:02.783Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove (2.73s)
05:00:02 [2019-09-30T05:00:02.783Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_remove (2.50s)
05:00:02 [2019-09-30T05:00:02.783Z] === RUN   TestBuildMultiStageCopy
05:00:02 [2019-09-30T05:00:02.783Z] === RUN   TestBuildMultiStageCopy/copy_to_root
05:00:05 [2019-09-30T05:00:05.247Z] === RUN   TestBuildMultiStageCopy/copy_to_newdir
05:00:05 [2019-09-30T05:00:05.610Z] === RUN   TestBuildMultiStageCopy/copy_to_newdir_nested
05:00:05 [2019-09-30T05:00:05.972Z] === RUN   TestBuildMultiStageCopy/copy_to_existingdir
05:00:06 [2019-09-30T05:00:06.752Z] === RUN   TestBuildMultiStageCopy/copy_to_newsubdir
05:00:07 [2019-09-30T05:00:07.538Z] --- PASS: TestBuildMultiStageCopy (4.54s)
05:00:07 [2019-09-30T05:00:07.538Z]     --- PASS: TestBuildMultiStageCopy/copy_to_root (2.47s)
05:00:07 [2019-09-30T05:00:07.538Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newdir (0.44s)
05:00:07 [2019-09-30T05:00:07.538Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newdir_nested (0.45s)
05:00:07 [2019-09-30T05:00:07.538Z]     --- PASS: TestBuildMultiStageCopy/copy_to_existingdir (0.62s)
05:00:07 [2019-09-30T05:00:07.538Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newsubdir (0.56s)
05:00:07 [2019-09-30T05:00:07.538Z] === RUN   TestBuildMultiStageParentConfig
05:00:08 [2019-09-30T05:00:08.875Z] --- PASS: TestBuildMultiStageParentConfig (1.46s)
05:00:08 [2019-09-30T05:00:08.875Z] === RUN   TestBuildLabelWithTargets
05:00:11 [2019-09-30T05:00:11.447Z] --- PASS: TestBuildLabelWithTargets (2.33s)
05:00:11 [2019-09-30T05:00:11.447Z] === RUN   TestBuildWithEmptyLayers
05:00:12 [2019-09-30T05:00:12.246Z] --- PASS: TestBuildWithEmptyLayers (0.96s)
05:00:12 [2019-09-30T05:00:12.246Z] === RUN   TestBuildMultiStageOnBuild
05:00:15 [2019-09-30T05:00:15.489Z] --- PASS: TestBuildMultiStageOnBuild (3.27s)
05:00:15 [2019-09-30T05:00:15.489Z] === RUN   TestBuildUncleanTarFilenames
05:00:16 [2019-09-30T05:00:16.840Z] --- PASS: TestBuildUncleanTarFilenames (1.19s)
05:00:16 [2019-09-30T05:00:16.840Z] === RUN   TestBuildMultiStageLayerLeak
05:00:19 [2019-09-30T05:00:19.288Z] --- PASS: TestBuildMultiStageLayerLeak (2.85s)
05:00:19 [2019-09-30T05:00:19.288Z] === RUN   TestBuildWithHugeFile
05:00:53 [2019-09-30T05:00:53.772Z] --- PASS: TestBuildWithHugeFile (30.62s)
05:00:53 [2019-09-30T05:00:53.772Z] === RUN   TestBuildWithEmptyDockerfile
05:00:53 [2019-09-30T05:00:53.772Z] === RUN   TestBuildWithEmptyDockerfile/empty-dockerfile
05:00:53 [2019-09-30T05:00:53.772Z] === PAUSE TestBuildWithEmptyDockerfile/empty-dockerfile
05:00:53 [2019-09-30T05:00:53.772Z] === RUN   TestBuildWithEmptyDockerfile/empty-lines-dockerfile
05:00:53 [2019-09-30T05:00:53.772Z] === PAUSE TestBuildWithEmptyDockerfile/empty-lines-dockerfile
05:00:53 [2019-09-30T05:00:53.772Z] === RUN   TestBuildWithEmptyDockerfile/comment-only-dockerfile
05:00:53 [2019-09-30T05:00:53.772Z] === PAUSE TestBuildWithEmptyDockerfile/comment-only-dockerfile
05:00:53 [2019-09-30T05:00:53.772Z] === CONT  TestBuildWithEmptyDockerfile/empty-dockerfile
05:00:53 [2019-09-30T05:00:53.772Z] === CONT  TestBuildWithEmptyDockerfile/comment-only-dockerfile
05:00:53 [2019-09-30T05:00:53.772Z] === CONT  TestBuildWithEmptyDockerfile/empty-lines-dockerfile
05:00:53 [2019-09-30T05:00:53.772Z] --- PASS: TestBuildWithEmptyDockerfile (0.04s)
05:00:53 [2019-09-30T05:00:53.772Z]     --- PASS: TestBuildWithEmptyDockerfile/empty-dockerfile (0.22s)
05:00:53 [2019-09-30T05:00:53.772Z]     --- PASS: TestBuildWithEmptyDockerfile/comment-only-dockerfile (0.22s)
05:00:53 [2019-09-30T05:00:53.772Z]     --- PASS: TestBuildWithEmptyDockerfile/empty-lines-dockerfile (0.12s)
05:00:53 [2019-09-30T05:00:53.772Z] === RUN   TestBuildPreserveOwnership
05:00:53 [2019-09-30T05:00:53.772Z] === RUN   TestBuildPreserveOwnership/copy_from
05:00:54 [2019-09-30T05:00:54.143Z] === RUN   TestBuildPreserveOwnership/copy_from_chowned
05:00:56 [2019-09-30T05:00:56.110Z] --- PASS: TestBuildPreserveOwnership (5.70s)
05:00:56 [2019-09-30T05:00:56.110Z]     --- PASS: TestBuildPreserveOwnership/copy_from (3.71s)
05:00:56 [2019-09-30T05:00:56.110Z]     --- PASS: TestBuildPreserveOwnership/copy_from_chowned (1.98s)
05:00:56 [2019-09-30T05:00:56.110Z] === RUN   TestBuildPlatformInvalid
05:00:56 [2019-09-30T05:00:56.110Z] --- PASS: TestBuildPlatformInvalid (0.11s)
05:00:56 [2019-09-30T05:00:56.110Z] PASS
05:00:56 [2019-09-30T05:00:56.110Z] 
05:00:56 [2019-09-30T05:00:56.110Z] DONE 32 tests in 82.173s
05:00:56 [2019-09-30T05:00:56.520Z] Running /go/src/github.com/docker/docker/integration/config (s390x.integration.config) flags=-test.v -test.timeout=120m 
05:00:56 [2019-09-30T05:00:56.520Z] ++ 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
05:00:56 [2019-09-30T05:00:56.520Z] ++ set -e
05:00:56 [2019-09-30T05:00:56.520Z] ++ '[' -n 0 ']'
05:00:56 [2019-09-30T05:00:56.520Z] ++ set -x
05:00:56 [2019-09-30T05:00:56.520Z] ++ 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
05:00:56 [2019-09-30T05:00:56.520Z] INFO: Testing against a local daemon
05:00:56 [2019-09-30T05:00:56.520Z] === RUN   TestConfigList
05:00:59 [2019-09-30T05:00:59.711Z] --- PASS: TestConfigList (2.77s)
05:00:59 [2019-09-30T05:00:59.711Z]     config_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigList"
05:00:59 [2019-09-30T05:00:59.711Z] === RUN   TestConfigsCreateAndDelete
05:01:02 [2019-09-30T05:01:02.169Z] --- PASS: TestConfigsCreateAndDelete (2.81s)
05:01:02 [2019-09-30T05:01:02.169Z]     config_test.go:112: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigsCreateAndDelete"
05:01:02 [2019-09-30T05:01:02.169Z] === RUN   TestConfigsUpdate
05:01:04 [2019-09-30T05:01:04.808Z] --- PASS: TestConfigsUpdate (2.85s)
05:01:04 [2019-09-30T05:01:04.808Z]     config_test.go:140: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigsUpdate"
05:01:04 [2019-09-30T05:01:04.808Z] === RUN   TestTemplatedConfig
05:01:08 [2019-09-30T05:01:08.160Z] --- PASS: TestTemplatedConfig (3.11s)
05:01:08 [2019-09-30T05:01:08.160Z]     config_test.go:192: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestTemplatedConfig"
05:01:08 [2019-09-30T05:01:08.160Z] === RUN   TestConfigInspect
05:01:11 [2019-09-30T05:01:11.388Z] --- PASS: TestConfigInspect (2.86s)
05:01:11 [2019-09-30T05:01:11.389Z]     config_test.go:326: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigInspect"
05:01:11 [2019-09-30T05:01:11.389Z] === RUN   TestConfigCreateWithLabels
05:01:14 [2019-09-30T05:01:14.008Z] --- PASS: TestConfigCreateWithLabels (2.85s)
05:01:14 [2019-09-30T05:01:14.008Z]     config_test.go:350: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigCreateWithLabels"
05:01:14 [2019-09-30T05:01:14.008Z] === RUN   TestConfigCreateResolve
05:01:16 [2019-09-30T05:01:16.449Z] --- PASS: TestConfigCreateResolve (2.94s)
05:01:16 [2019-09-30T05:01:16.449Z]     config_test.go:377: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigCreateResolve"
05:01:16 [2019-09-30T05:01:16.449Z] === RUN   TestConfigDaemonLibtrustID
05:01:17 [2019-09-30T05:01:17.235Z] --- PASS: TestConfigDaemonLibtrustID (0.54s)
05:01:17 [2019-09-30T05:01:17.235Z]     config_test.go:427: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigDaemonLibtrustID"
05:01:17 [2019-09-30T05:01:17.235Z] PASS
05:01:17 [2019-09-30T05:01:17.235Z] 
05:01:17 [2019-09-30T05:01:17.235Z] DONE 8 tests in 20.828s
05:01:17 [2019-09-30T05:01:17.235Z] Running /go/src/github.com/docker/docker/integration/container (s390x.integration.container) flags=-test.v -test.timeout=120m 
05:01:17 [2019-09-30T05:01:17.235Z] ++ 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
05:01:17 [2019-09-30T05:01:17.235Z] ++ set -e
05:01:17 [2019-09-30T05:01:17.235Z] ++ '[' -n 0 ']'
05:01:17 [2019-09-30T05:01:17.235Z] ++ set -x
05:01:17 [2019-09-30T05:01:17.235Z] ++ 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
05:01:17 [2019-09-30T05:01:17.235Z] INFO: Testing against a local daemon
05:01:17 [2019-09-30T05:01:17.235Z] === RUN   TestCheckpoint
05:01:17 [2019-09-30T05:01:17.235Z] --- SKIP: TestCheckpoint (0.00s)
05:01:17 [2019-09-30T05:01:17.235Z]     checkpoint_test.go:33: TestCheckpoint is broken; see https://github.com/moby/moby/issues/38963
05:01:17 [2019-09-30T05:01:17.235Z] === RUN   TestContainerInvalidJSON
05:01:17 [2019-09-30T05:01:17.235Z] === RUN   TestContainerInvalidJSON//containers/foobar/copy
05:01:17 [2019-09-30T05:01:17.235Z] === PAUSE TestContainerInvalidJSON//containers/foobar/copy
05:01:17 [2019-09-30T05:01:17.235Z] === RUN   TestContainerInvalidJSON//containers/foobar/exec
05:01:17 [2019-09-30T05:01:17.235Z] === PAUSE TestContainerInvalidJSON//containers/foobar/exec
05:01:17 [2019-09-30T05:01:17.235Z] === RUN   TestContainerInvalidJSON//exec/foobar/start
05:01:17 [2019-09-30T05:01:17.235Z] === PAUSE TestContainerInvalidJSON//exec/foobar/start
05:01:17 [2019-09-30T05:01:17.235Z] === CONT  TestContainerInvalidJSON//containers/foobar/copy
05:01:17 [2019-09-30T05:01:17.235Z] === CONT  TestContainerInvalidJSON//exec/foobar/start
05:01:17 [2019-09-30T05:01:17.235Z] === CONT  TestContainerInvalidJSON//containers/foobar/exec
05:01:17 [2019-09-30T05:01:17.235Z] --- PASS: TestContainerInvalidJSON (0.01s)
05:01:17 [2019-09-30T05:01:17.235Z]     --- PASS: TestContainerInvalidJSON//containers/foobar/copy (0.00s)
05:01:17 [2019-09-30T05:01:17.235Z]     --- PASS: TestContainerInvalidJSON//containers/foobar/exec (0.00s)
05:01:17 [2019-09-30T05:01:17.235Z]     --- PASS: TestContainerInvalidJSON//exec/foobar/start (0.00s)
05:01:17 [2019-09-30T05:01:17.235Z] === RUN   TestCopyFromContainerPathDoesNotExist
05:01:17 [2019-09-30T05:01:17.235Z] --- PASS: TestCopyFromContainerPathDoesNotExist (0.10s)
05:01:17 [2019-09-30T05:01:17.235Z] === RUN   TestCopyFromContainerPathIsNotDir
05:01:17 [2019-09-30T05:01:17.597Z] --- PASS: TestCopyFromContainerPathIsNotDir (0.12s)
05:01:17 [2019-09-30T05:01:17.598Z] === RUN   TestCopyToContainerPathDoesNotExist
05:01:17 [2019-09-30T05:01:17.598Z] --- PASS: TestCopyToContainerPathDoesNotExist (0.12s)
05:01:17 [2019-09-30T05:01:17.598Z] === RUN   TestCopyToContainerPathIsNotDir
05:01:17 [2019-09-30T05:01:17.598Z] --- PASS: TestCopyToContainerPathIsNotDir (0.12s)
05:01:17 [2019-09-30T05:01:17.598Z] === RUN   TestCopyFromContainer
05:01:19 [2019-09-30T05:01:19.535Z] === RUN   TestCopyFromContainer//
05:01:19 [2019-09-30T05:01:19.903Z] === RUN   TestCopyFromContainer//bar/root
05:01:19 [2019-09-30T05:01:19.903Z] === RUN   TestCopyFromContainer//bar/root/
05:01:19 [2019-09-30T05:01:19.903Z] === RUN   TestCopyFromContainer/bar/quux
05:01:19 [2019-09-30T05:01:19.903Z] === RUN   TestCopyFromContainer/bar/quux/
05:01:20 [2019-09-30T05:01:20.278Z] === RUN   TestCopyFromContainer/bar/quux/baz
05:01:20 [2019-09-30T05:01:20.278Z] === RUN   TestCopyFromContainer/bar/filesymlink
05:01:20 [2019-09-30T05:01:20.278Z] === RUN   TestCopyFromContainer/bar/dirsymlink
05:01:20 [2019-09-30T05:01:20.278Z] === RUN   TestCopyFromContainer/bar/dirsymlink/
05:01:20 [2019-09-30T05:01:20.278Z] === RUN   TestCopyFromContainer/bar/notarget
05:01:20 [2019-09-30T05:01:20.652Z] --- PASS: TestCopyFromContainer (2.84s)
05:01:20 [2019-09-30T05:01:20.652Z]     --- PASS: TestCopyFromContainer// (0.07s)
05:01:20 [2019-09-30T05:01:20.652Z]     --- PASS: TestCopyFromContainer//bar/root (0.10s)
05:01:20 [2019-09-30T05:01:20.652Z]     --- PASS: TestCopyFromContainer//bar/root/ (0.05s)
05:01:20 [2019-09-30T05:01:20.652Z]     --- PASS: TestCopyFromContainer/bar/quux (0.12s)
05:01:20 [2019-09-30T05:01:20.652Z]     --- PASS: TestCopyFromContainer/bar/quux/ (0.10s)
05:01:20 [2019-09-30T05:01:20.652Z]     --- PASS: TestCopyFromContainer/bar/quux/baz (0.08s)
05:01:20 [2019-09-30T05:01:20.652Z]     --- PASS: TestCopyFromContainer/bar/filesymlink (0.09s)
05:01:20 [2019-09-30T05:01:20.652Z]     --- PASS: TestCopyFromContainer/bar/dirsymlink (0.08s)
05:01:20 [2019-09-30T05:01:20.652Z]     --- PASS: TestCopyFromContainer/bar/dirsymlink/ (0.10s)
05:01:20 [2019-09-30T05:01:20.652Z]     --- PASS: TestCopyFromContainer/bar/notarget (0.08s)
05:01:20 [2019-09-30T05:01:20.652Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist
05:01:20 [2019-09-30T05:01:20.652Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
05:01:20 [2019-09-30T05:01:20.652Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
05:01:20 [2019-09-30T05:01:20.652Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
05:01:20 [2019-09-30T05:01:20.652Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
05:01:20 [2019-09-30T05:01:20.652Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/digest
05:01:20 [2019-09-30T05:01:20.652Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/digest
05:01:20 [2019-09-30T05:01:20.652Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
05:01:20 [2019-09-30T05:01:20.652Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/digest
05:01:20 [2019-09-30T05:01:20.652Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
05:01:20 [2019-09-30T05:01:20.652Z] --- PASS: TestCreateFailsWhenIdentifierDoesNotExist (0.01s)
05:01:20 [2019-09-30T05:01:20.652Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag (0.00s)
05:01:20 [2019-09-30T05:01:20.652Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag (0.00s)
05:01:20 [2019-09-30T05:01:20.652Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/digest (0.00s)
05:01:20 [2019-09-30T05:01:20.652Z] === RUN   TestCreateLinkToNonExistingContainer
05:01:20 [2019-09-30T05:01:20.652Z] --- PASS: TestCreateLinkToNonExistingContainer (0.05s)
05:01:20 [2019-09-30T05:01:20.652Z] === RUN   TestCreateWithInvalidEnv
05:01:20 [2019-09-30T05:01:20.652Z] === RUN   TestCreateWithInvalidEnv/0
05:01:20 [2019-09-30T05:01:20.652Z] === PAUSE TestCreateWithInvalidEnv/0
05:01:20 [2019-09-30T05:01:20.652Z] === RUN   TestCreateWithInvalidEnv/1
05:01:20 [2019-09-30T05:01:20.652Z] === PAUSE TestCreateWithInvalidEnv/1
05:01:20 [2019-09-30T05:01:20.652Z] === RUN   TestCreateWithInvalidEnv/2
05:01:20 [2019-09-30T05:01:20.652Z] === PAUSE TestCreateWithInvalidEnv/2
05:01:20 [2019-09-30T05:01:20.652Z] === CONT  TestCreateWithInvalidEnv/0
05:01:20 [2019-09-30T05:01:20.652Z] === CONT  TestCreateWithInvalidEnv/2
05:01:20 [2019-09-30T05:01:20.652Z] === CONT  TestCreateWithInvalidEnv/1
05:01:20 [2019-09-30T05:01:20.652Z] --- PASS: TestCreateWithInvalidEnv (0.01s)
05:01:20 [2019-09-30T05:01:20.652Z]     --- PASS: TestCreateWithInvalidEnv/2 (0.00s)
05:01:20 [2019-09-30T05:01:20.652Z]     --- PASS: TestCreateWithInvalidEnv/0 (0.00s)
05:01:20 [2019-09-30T05:01:20.652Z]     --- PASS: TestCreateWithInvalidEnv/1 (0.00s)
05:01:20 [2019-09-30T05:01:20.652Z] === RUN   TestCreateTmpfsMountsTarget
05:01:20 [2019-09-30T05:01:20.652Z] --- PASS: TestCreateTmpfsMountsTarget (0.02s)
05:01:20 [2019-09-30T05:01:20.652Z] === RUN   TestCreateWithCustomMaskedPaths
05:01:23 [2019-09-30T05:01:23.109Z] --- PASS: TestCreateWithCustomMaskedPaths (2.50s)
05:01:23 [2019-09-30T05:01:23.109Z] === RUN   TestCreateWithCapabilities
05:01:23 [2019-09-30T05:01:23.109Z] === RUN   TestCreateWithCapabilities/no_capabilities
05:01:23 [2019-09-30T05:01:23.109Z] === PAUSE TestCreateWithCapabilities/no_capabilities
05:01:23 [2019-09-30T05:01:23.109Z] === RUN   TestCreateWithCapabilities/empty_capabilities
05:01:23 [2019-09-30T05:01:23.109Z] === PAUSE TestCreateWithCapabilities/empty_capabilities
05:01:23 [2019-09-30T05:01:23.109Z] === RUN   TestCreateWithCapabilities/valid_capabilities
05:01:23 [2019-09-30T05:01:23.109Z] === PAUSE TestCreateWithCapabilities/valid_capabilities
05:01:23 [2019-09-30T05:01:23.109Z] === RUN   TestCreateWithCapabilities/invalid_capabilities
05:01:23 [2019-09-30T05:01:23.109Z] === PAUSE TestCreateWithCapabilities/invalid_capabilities
05:01:23 [2019-09-30T05:01:23.109Z] === RUN   TestCreateWithCapabilities/duplicate_capabilities
05:01:23 [2019-09-30T05:01:23.109Z] === PAUSE TestCreateWithCapabilities/duplicate_capabilities
05:01:23 [2019-09-30T05:01:23.109Z] === RUN   TestCreateWithCapabilities/capabilities_API_v1.39
05:01:23 [2019-09-30T05:01:23.109Z] === PAUSE TestCreateWithCapabilities/capabilities_API_v1.39
05:01:23 [2019-09-30T05:01:23.109Z] === RUN   TestCreateWithCapabilities/empty_capadd
05:01:23 [2019-09-30T05:01:23.109Z] === PAUSE TestCreateWithCapabilities/empty_capadd
05:01:23 [2019-09-30T05:01:23.109Z] === RUN   TestCreateWithCapabilities/empty_capdrop
05:01:23 [2019-09-30T05:01:23.109Z] === PAUSE TestCreateWithCapabilities/empty_capdrop
05:01:23 [2019-09-30T05:01:23.109Z] === RUN   TestCreateWithCapabilities/capadd_capdrop
05:01:23 [2019-09-30T05:01:23.109Z] === PAUSE TestCreateWithCapabilities/capadd_capdrop
05:01:23 [2019-09-30T05:01:23.109Z] === RUN   TestCreateWithCapabilities/conflict_with_capadd
05:01:23 [2019-09-30T05:01:23.109Z] === PAUSE TestCreateWithCapabilities/conflict_with_capadd
05:01:23 [2019-09-30T05:01:23.109Z] === RUN   TestCreateWithCapabilities/conflict_with_capdrop
05:01:23 [2019-09-30T05:01:23.109Z] === PAUSE TestCreateWithCapabilities/conflict_with_capdrop
05:01:23 [2019-09-30T05:01:23.109Z] === CONT  TestCreateWithCapabilities/no_capabilities
05:01:23 [2019-09-30T05:01:23.109Z] === CONT  TestCreateWithCapabilities/empty_capadd
05:01:23 [2019-09-30T05:01:23.109Z] === CONT  TestCreateWithCapabilities/conflict_with_capdrop
05:01:23 [2019-09-30T05:01:23.109Z] === CONT  TestCreateWithCapabilities/conflict_with_capadd
05:01:23 [2019-09-30T05:01:23.109Z] === CONT  TestCreateWithCapabilities/capadd_capdrop
05:01:23 [2019-09-30T05:01:23.109Z] === CONT  TestCreateWithCapabilities/empty_capdrop
05:01:23 [2019-09-30T05:01:23.483Z] === CONT  TestCreateWithCapabilities/invalid_capabilities
05:01:23 [2019-09-30T05:01:23.483Z] === CONT  TestCreateWithCapabilities/capabilities_API_v1.39
05:01:23 [2019-09-30T05:01:23.483Z] === CONT  TestCreateWithCapabilities/duplicate_capabilities
05:01:23 [2019-09-30T05:01:23.483Z] === CONT  TestCreateWithCapabilities/valid_capabilities
05:01:23 [2019-09-30T05:01:23.483Z] === CONT  TestCreateWithCapabilities/empty_capabilities
05:01:23 [2019-09-30T05:01:23.483Z] --- PASS: TestCreateWithCapabilities (0.02s)
05:01:23 [2019-09-30T05:01:23.483Z]     --- PASS: TestCreateWithCapabilities/no_capabilities (0.07s)
05:01:23 [2019-09-30T05:01:23.483Z]     --- PASS: TestCreateWithCapabilities/empty_capadd (0.07s)
05:01:23 [2019-09-30T05:01:23.483Z]     --- PASS: TestCreateWithCapabilities/conflict_with_capdrop (0.00s)
05:01:23 [2019-09-30T05:01:23.483Z]     --- PASS: TestCreateWithCapabilities/conflict_with_capadd (0.00s)
05:01:23 [2019-09-30T05:01:23.483Z]     --- PASS: TestCreateWithCapabilities/empty_capdrop (0.08s)
05:01:23 [2019-09-30T05:01:23.483Z]     --- PASS: TestCreateWithCapabilities/capadd_capdrop (0.08s)
05:01:23 [2019-09-30T05:01:23.483Z]     --- PASS: TestCreateWithCapabilities/invalid_capabilities (0.00s)
05:01:23 [2019-09-30T05:01:23.483Z]     --- PASS: TestCreateWithCapabilities/duplicate_capabilities (0.06s)
05:01:23 [2019-09-30T05:01:23.483Z]     --- PASS: TestCreateWithCapabilities/capabilities_API_v1.39 (0.08s)
05:01:23 [2019-09-30T05:01:23.483Z]     --- PASS: TestCreateWithCapabilities/valid_capabilities (0.07s)
05:01:23 [2019-09-30T05:01:23.483Z]     --- PASS: TestCreateWithCapabilities/empty_capabilities (0.07s)
05:01:23 [2019-09-30T05:01:23.483Z] === RUN   TestCreateWithCustomReadonlyPaths
05:01:25 [2019-09-30T05:01:25.983Z] --- PASS: TestCreateWithCustomReadonlyPaths (2.53s)
05:01:25 [2019-09-30T05:01:25.983Z] === RUN   TestCreateWithInvalidHealthcheckParams
05:01:25 [2019-09-30T05:01:25.983Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
05:01:25 [2019-09-30T05:01:25.983Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
05:01:25 [2019-09-30T05:01:25.983Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
05:01:25 [2019-09-30T05:01:25.983Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
05:01:25 [2019-09-30T05:01:25.983Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
05:01:25 [2019-09-30T05:01:25.983Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
05:01:25 [2019-09-30T05:01:25.983Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
05:01:25 [2019-09-30T05:01:25.983Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
05:01:25 [2019-09-30T05:01:25.983Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
05:01:25 [2019-09-30T05:01:25.983Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
05:01:25 [2019-09-30T05:01:25.983Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
05:01:25 [2019-09-30T05:01:25.983Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
05:01:25 [2019-09-30T05:01:25.983Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
05:01:25 [2019-09-30T05:01:25.983Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
05:01:25 [2019-09-30T05:01:25.983Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
05:01:25 [2019-09-30T05:01:25.983Z] --- PASS: TestCreateWithInvalidHealthcheckParams (0.02s)
05:01:25 [2019-09-30T05:01:25.983Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s (0.01s)
05:01:25 [2019-09-30T05:01:25.983Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms (0.01s)
05:01:25 [2019-09-30T05:01:25.983Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0 (0.01s)
05:01:25 [2019-09-30T05:01:25.983Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms (0.01s)
05:01:25 [2019-09-30T05:01:25.983Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms (0.01s)
05:01:25 [2019-09-30T05:01:25.983Z] === RUN   TestContainerStartOnDaemonRestart
05:01:25 [2019-09-30T05:01:25.983Z] === PAUSE TestContainerStartOnDaemonRestart
05:01:25 [2019-09-30T05:01:25.983Z] === RUN   TestDaemonRestartIpcMode
05:01:25 [2019-09-30T05:01:25.983Z] === PAUSE TestDaemonRestartIpcMode
05:01:25 [2019-09-30T05:01:25.983Z] === RUN   TestDiff
05:01:26 [2019-09-30T05:01:26.774Z] --- PASS: TestDiff (0.81s)
05:01:26 [2019-09-30T05:01:26.774Z] === RUN   TestExecWithCloseStdin
05:01:28 [2019-09-30T05:01:28.037Z] --- PASS: TestExecWithCloseStdin (1.09s)
05:01:28 [2019-09-30T05:01:28.037Z] === RUN   TestExec
05:01:29 [2019-09-30T05:01:29.306Z] --- PASS: TestExec (1.10s)
05:01:29 [2019-09-30T05:01:29.306Z] === RUN   TestExecUser
05:01:30 [2019-09-30T05:01:30.082Z] --- PASS: TestExecUser (1.01s)
05:01:30 [2019-09-30T05:01:30.082Z] === RUN   TestExportContainerAndImportImage
05:01:31 [2019-09-30T05:01:31.355Z] --- PASS: TestExportContainerAndImportImage (1.16s)
05:01:31 [2019-09-30T05:01:31.355Z] === RUN   TestExportContainerAfterDaemonRestart
05:01:32 [2019-09-30T05:01:32.727Z] --- PASS: TestExportContainerAfterDaemonRestart (1.57s)
05:01:32 [2019-09-30T05:01:32.727Z]     export_test.go:63: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestExportContainerAfterDaemonRestart"
05:01:32 [2019-09-30T05:01:32.727Z] === RUN   TestHealthCheckWorkdir
05:01:33 [2019-09-30T05:01:33.998Z] --- PASS: TestHealthCheckWorkdir (1.21s)
05:01:33 [2019-09-30T05:01:33.998Z] === RUN   TestHealthKillContainer
05:01:37 [2019-09-30T05:01:37.143Z] --- PASS: TestHealthKillContainer (3.12s)
05:01:37 [2019-09-30T05:01:37.143Z] === RUN   TestInspectCpusetInConfigPre120
05:01:37 [2019-09-30T05:01:37.925Z] --- PASS: TestInspectCpusetInConfigPre120 (0.92s)
05:01:37 [2019-09-30T05:01:37.926Z] === RUN   TestIpcModeNone
05:01:39 [2019-09-30T05:01:39.252Z] --- PASS: TestIpcModeNone (1.14s)
05:01:39 [2019-09-30T05:01:39.252Z] === RUN   TestIpcModePrivate
05:01:40 [2019-09-30T05:01:40.552Z] --- PASS: TestIpcModePrivate (1.17s)
05:01:40 [2019-09-30T05:01:40.552Z]     ipcmode_linux_test.go:90: [testIpcPrivateShareable] ipcmode: private, ipcdev: 0:56, shared: false, mustBeShared: false
05:01:40 [2019-09-30T05:01:40.552Z] === RUN   TestIpcModeShareable
05:01:41 [2019-09-30T05:01:41.348Z] --- PASS: TestIpcModeShareable (1.15s)
05:01:41 [2019-09-30T05:01:41.348Z]     ipcmode_linux_test.go:90: [testIpcPrivateShareable] ipcmode: shareable, ipcdev: 0:50, shared: true, mustBeShared: true
05:01:41 [2019-09-30T05:01:41.348Z] === RUN   TestAPIIpcModeShareableAndContainer
05:01:44 [2019-09-30T05:01:44.517Z] --- PASS: TestAPIIpcModeShareableAndContainer (2.86s)
05:01:44 [2019-09-30T05:01:44.517Z] === RUN   TestAPIIpcModeHost
05:01:45 [2019-09-30T05:01:45.333Z] --- PASS: TestAPIIpcModeHost (0.89s)
05:01:45 [2019-09-30T05:01:45.334Z] === RUN   TestDaemonIpcModeShareable
05:01:47 [2019-09-30T05:01:47.256Z] --- PASS: TestDaemonIpcModeShareable (1.74s)
05:01:47 [2019-09-30T05:01:47.256Z]     ipcmode_linux_test.go:230: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModeShareable"
05:01:47 [2019-09-30T05:01:47.256Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:58, shared: true, mustBeShared: true
05:01:47 [2019-09-30T05:01:47.256Z] === RUN   TestDaemonIpcModePrivate
05:01:49 [2019-09-30T05:01:49.065Z] --- PASS: TestDaemonIpcModePrivate (1.78s)
05:01:49 [2019-09-30T05:01:49.065Z]     ipcmode_linux_test.go:230: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModePrivate"
05:01:49 [2019-09-30T05:01:49.065Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:64, shared: false, mustBeShared: false
05:01:49 [2019-09-30T05:01:49.065Z] === RUN   TestDaemonIpcModePrivateFromConfig
05:01:50 [2019-09-30T05:01:50.351Z] --- PASS: TestDaemonIpcModePrivateFromConfig (1.76s)
05:01:50 [2019-09-30T05:01:50.351Z]     ipcmode_linux_test.go:230: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModePrivateFromConfig"
05:01:50 [2019-09-30T05:01:50.351Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:64, shared: false, mustBeShared: false
05:01:50 [2019-09-30T05:01:50.351Z] === RUN   TestDaemonIpcModeShareableFromConfig
05:01:52 [2019-09-30T05:01:52.189Z] --- PASS: TestDaemonIpcModeShareableFromConfig (1.72s)
05:01:52 [2019-09-30T05:01:52.189Z]     ipcmode_linux_test.go:230: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModeShareableFromConfig"
05:01:52 [2019-09-30T05:01:52.189Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:58, shared: true, mustBeShared: true
05:01:52 [2019-09-30T05:01:52.189Z] === RUN   TestIpcModeOlderClient
05:01:52 [2019-09-30T05:01:52.189Z] === PAUSE TestIpcModeOlderClient
05:01:52 [2019-09-30T05:01:52.189Z] === RUN   TestKillContainerInvalidSignal
05:01:53 [2019-09-30T05:01:53.006Z] --- PASS: TestKillContainerInvalidSignal (0.92s)
05:01:53 [2019-09-30T05:01:53.006Z] === RUN   TestKillContainer
05:01:53 [2019-09-30T05:01:53.006Z] === RUN   TestKillContainer/no_signal
05:01:54 [2019-09-30T05:01:54.265Z] === RUN   TestKillContainer/non_killing_signal
05:01:54 [2019-09-30T05:01:54.639Z] === RUN   TestKillContainer/killing_signal
05:01:55 [2019-09-30T05:01:55.905Z] --- PASS: TestKillContainer (2.67s)
05:01:55 [2019-09-30T05:01:55.905Z]     --- PASS: TestKillContainer/no_signal (0.93s)
05:01:55 [2019-09-30T05:01:55.905Z]     --- PASS: TestKillContainer/non_killing_signal (0.59s)
05:01:55 [2019-09-30T05:01:55.905Z]     --- PASS: TestKillContainer/killing_signal (0.77s)
05:01:55 [2019-09-30T05:01:55.905Z] === RUN   TestKillWithStopSignalAndRestartPolicies
05:01:55 [2019-09-30T05:01:55.905Z] === RUN   TestKillWithStopSignalAndRestartPolicies/same-signal-disables-restart-policy
05:01:56 [2019-09-30T05:01:56.695Z] === RUN   TestKillWithStopSignalAndRestartPolicies/different-signal-keep-restart-policy
05:01:57 [2019-09-30T05:01:57.490Z] --- PASS: TestKillWithStopSignalAndRestartPolicies (1.82s)
05:01:57 [2019-09-30T05:01:57.490Z]     --- PASS: TestKillWithStopSignalAndRestartPolicies/same-signal-disables-restart-policy (0.89s)
05:01:57 [2019-09-30T05:01:57.490Z]     --- PASS: TestKillWithStopSignalAndRestartPolicies/different-signal-keep-restart-policy (0.58s)
05:01:57 [2019-09-30T05:01:57.490Z] === RUN   TestKillStoppedContainer
05:01:57 [2019-09-30T05:01:57.864Z] --- PASS: TestKillStoppedContainer (0.10s)
05:01:57 [2019-09-30T05:01:57.865Z] === RUN   TestKillStoppedContainerAPIPre120
05:01:57 [2019-09-30T05:01:57.865Z] --- PASS: TestKillStoppedContainerAPIPre120 (0.10s)
05:01:57 [2019-09-30T05:01:57.865Z] === RUN   TestKillDifferentUserContainer
05:01:58 [2019-09-30T05:01:58.775Z] --- PASS: TestKillDifferentUserContainer (0.95s)
05:01:58 [2019-09-30T05:01:58.775Z] === RUN   TestInspectOomKilledTrue
05:01:58 [2019-09-30T05:01:58.775Z] --- SKIP: TestInspectOomKilledTrue (0.00s)
05:01:58 [2019-09-30T05:01:58.775Z]     kill_test.go:151: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
05:01:58 [2019-09-30T05:01:58.775Z] === RUN   TestInspectOomKilledFalse
05:01:58 [2019-09-30T05:01:58.775Z] --- SKIP: TestInspectOomKilledFalse (0.00s)
05:01:58 [2019-09-30T05:01:58.775Z]     kill_test.go:169: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
05:01:58 [2019-09-30T05:01:58.775Z] === RUN   TestLinksEtcHostsContentMatch
05:01:59 [2019-09-30T05:01:59.567Z] --- PASS: TestLinksEtcHostsContentMatch (0.65s)
05:01:59 [2019-09-30T05:01:59.567Z] === RUN   TestLinksContainerNames
05:02:01 [2019-09-30T05:02:01.396Z] --- PASS: TestLinksContainerNames (1.71s)
05:02:01 [2019-09-30T05:02:01.396Z] === RUN   TestLogsFollowTailEmpty
05:02:02 [2019-09-30T05:02:02.175Z] --- PASS: TestLogsFollowTailEmpty (0.96s)
05:02:02 [2019-09-30T05:02:02.175Z] === RUN   TestContainerNetworkMountsNoChown
05:02:02 [2019-09-30T05:02:02.969Z] --- PASS: TestContainerNetworkMountsNoChown (0.90s)
05:02:02 [2019-09-30T05:02:02.969Z] === RUN   TestMountDaemonRoot
05:02:02 [2019-09-30T05:02:02.969Z] === RUN   TestMountDaemonRoot/default
05:02:02 [2019-09-30T05:02:02.969Z] === PAUSE TestMountDaemonRoot/default
05:02:02 [2019-09-30T05:02:02.969Z] === RUN   TestMountDaemonRoot/private
05:02:02 [2019-09-30T05:02:02.969Z] === PAUSE TestMountDaemonRoot/private
05:02:02 [2019-09-30T05:02:02.969Z] === RUN   TestMountDaemonRoot/rprivate
05:02:02 [2019-09-30T05:02:02.969Z] === PAUSE TestMountDaemonRoot/rprivate
05:02:02 [2019-09-30T05:02:02.969Z] === RUN   TestMountDaemonRoot/slave
05:02:02 [2019-09-30T05:02:02.969Z] === PAUSE TestMountDaemonRoot/slave
05:02:02 [2019-09-30T05:02:02.969Z] === RUN   TestMountDaemonRoot/rslave
05:02:02 [2019-09-30T05:02:02.969Z] === PAUSE TestMountDaemonRoot/rslave
05:02:02 [2019-09-30T05:02:02.969Z] === RUN   TestMountDaemonRoot/shared
05:02:02 [2019-09-30T05:02:02.969Z] === PAUSE TestMountDaemonRoot/shared
05:02:02 [2019-09-30T05:02:02.969Z] === RUN   TestMountDaemonRoot/rshared
05:02:02 [2019-09-30T05:02:02.969Z] === PAUSE TestMountDaemonRoot/rshared
05:02:02 [2019-09-30T05:02:02.969Z] === CONT  TestMountDaemonRoot/default
05:02:02 [2019-09-30T05:02:02.969Z] === RUN   TestMountDaemonRoot/default/bind_subpath
05:02:02 [2019-09-30T05:02:02.969Z] === PAUSE TestMountDaemonRoot/default/bind_subpath
05:02:02 [2019-09-30T05:02:02.969Z] === RUN   TestMountDaemonRoot/default/mount_root
05:02:02 [2019-09-30T05:02:02.969Z] === PAUSE TestMountDaemonRoot/default/mount_root
05:02:02 [2019-09-30T05:02:02.969Z] === RUN   TestMountDaemonRoot/default/mount_subpath
05:02:02 [2019-09-30T05:02:02.969Z] === PAUSE TestMountDaemonRoot/default/mount_subpath
05:02:02 [2019-09-30T05:02:02.969Z] === RUN   TestMountDaemonRoot/default/bind_root
05:02:02 [2019-09-30T05:02:02.969Z] === PAUSE TestMountDaemonRoot/default/bind_root
05:02:02 [2019-09-30T05:02:02.969Z] === CONT  TestMountDaemonRoot/default/bind_subpath
05:02:02 [2019-09-30T05:02:02.969Z] === CONT  TestMountDaemonRoot/rshared
05:02:02 [2019-09-30T05:02:02.969Z] === RUN   TestMountDaemonRoot/rshared/bind_root
05:02:02 [2019-09-30T05:02:02.969Z] === PAUSE TestMountDaemonRoot/rshared/bind_root
05:02:02 [2019-09-30T05:02:02.969Z] === RUN   TestMountDaemonRoot/rshared/bind_subpath
05:02:02 [2019-09-30T05:02:02.969Z] === PAUSE TestMountDaemonRoot/rshared/bind_subpath
05:02:02 [2019-09-30T05:02:02.969Z] === RUN   TestMountDaemonRoot/rshared/mount_root
05:02:02 [2019-09-30T05:02:02.969Z] === PAUSE TestMountDaemonRoot/rshared/mount_root
05:02:02 [2019-09-30T05:02:02.969Z] === RUN   TestMountDaemonRoot/rshared/mount_subpath
05:02:02 [2019-09-30T05:02:02.969Z] === PAUSE TestMountDaemonRoot/rshared/mount_subpath
05:02:02 [2019-09-30T05:02:02.969Z] === CONT  TestMountDaemonRoot/rshared/bind_root
05:02:02 [2019-09-30T05:02:02.969Z] === CONT  TestMountDaemonRoot/shared
05:02:02 [2019-09-30T05:02:02.969Z] === RUN   TestMountDaemonRoot/shared/mount_root
05:02:02 [2019-09-30T05:02:02.969Z] === PAUSE TestMountDaemonRoot/shared/mount_root
05:02:02 [2019-09-30T05:02:02.969Z] === RUN   TestMountDaemonRoot/shared/mount_subpath
05:02:02 [2019-09-30T05:02:02.969Z] === PAUSE TestMountDaemonRoot/shared/mount_subpath
05:02:02 [2019-09-30T05:02:02.969Z] === RUN   TestMountDaemonRoot/shared/bind_root
05:02:02 [2019-09-30T05:02:02.969Z] === PAUSE TestMountDaemonRoot/shared/bind_root
05:02:02 [2019-09-30T05:02:02.969Z] === RUN   TestMountDaemonRoot/shared/bind_subpath
05:02:02 [2019-09-30T05:02:02.969Z] === PAUSE TestMountDaemonRoot/shared/bind_subpath
05:02:02 [2019-09-30T05:02:02.969Z] === CONT  TestMountDaemonRoot/rslave
05:02:02 [2019-09-30T05:02:02.969Z] === RUN   TestMountDaemonRoot/rslave/bind_root
05:02:02 [2019-09-30T05:02:02.969Z] === PAUSE TestMountDaemonRoot/rslave/bind_root
05:02:02 [2019-09-30T05:02:02.969Z] === RUN   TestMountDaemonRoot/rslave/bind_subpath
05:02:02 [2019-09-30T05:02:02.969Z] === PAUSE TestMountDaemonRoot/rslave/bind_subpath
05:02:02 [2019-09-30T05:02:02.969Z] === RUN   TestMountDaemonRoot/rslave/mount_root
05:02:02 [2019-09-30T05:02:02.969Z] === PAUSE TestMountDaemonRoot/rslave/mount_root
05:02:02 [2019-09-30T05:02:02.969Z] === RUN   TestMountDaemonRoot/rslave/mount_subpath
05:02:02 [2019-09-30T05:02:02.969Z] === PAUSE TestMountDaemonRoot/rslave/mount_subpath
05:02:02 [2019-09-30T05:02:02.969Z] === CONT  TestMountDaemonRoot/slave
05:02:02 [2019-09-30T05:02:02.969Z] === RUN   TestMountDaemonRoot/slave/mount_subpath
05:02:02 [2019-09-30T05:02:02.969Z] === PAUSE TestMountDaemonRoot/slave/mount_subpath
05:02:02 [2019-09-30T05:02:02.969Z] === RUN   TestMountDaemonRoot/slave/bind_root
05:02:02 [2019-09-30T05:02:02.969Z] === PAUSE TestMountDaemonRoot/slave/bind_root
05:02:02 [2019-09-30T05:02:02.969Z] === RUN   TestMountDaemonRoot/slave/bind_subpath
05:02:02 [2019-09-30T05:02:02.969Z] === PAUSE TestMountDaemonRoot/slave/bind_subpath
05:02:02 [2019-09-30T05:02:02.969Z] === RUN   TestMountDaemonRoot/slave/mount_root
05:02:02 [2019-09-30T05:02:02.969Z] === PAUSE TestMountDaemonRoot/slave/mount_root
05:02:02 [2019-09-30T05:02:02.969Z] === CONT  TestMountDaemonRoot/rprivate
05:02:02 [2019-09-30T05:02:02.969Z] === RUN   TestMountDaemonRoot/rprivate/bind_root
05:02:02 [2019-09-30T05:02:02.969Z] === PAUSE TestMountDaemonRoot/rprivate/bind_root
05:02:02 [2019-09-30T05:02:02.969Z] === RUN   TestMountDaemonRoot/rprivate/bind_subpath
05:02:02 [2019-09-30T05:02:02.969Z] === PAUSE TestMountDaemonRoot/rprivate/bind_subpath
05:02:02 [2019-09-30T05:02:02.969Z] === RUN   TestMountDaemonRoot/rprivate/mount_root
05:02:02 [2019-09-30T05:02:02.969Z] === PAUSE TestMountDaemonRoot/rprivate/mount_root
05:02:02 [2019-09-30T05:02:02.969Z] === RUN   TestMountDaemonRoot/rprivate/mount_subpath
05:02:02 [2019-09-30T05:02:02.969Z] === PAUSE TestMountDaemonRoot/rprivate/mount_subpath
05:02:02 [2019-09-30T05:02:02.969Z] === CONT  TestMountDaemonRoot/private
05:02:02 [2019-09-30T05:02:02.969Z] === RUN   TestMountDaemonRoot/private/bind_subpath
05:02:02 [2019-09-30T05:02:02.969Z] === PAUSE TestMountDaemonRoot/private/bind_subpath
05:02:02 [2019-09-30T05:02:02.969Z] === RUN   TestMountDaemonRoot/private/mount_root
05:02:02 [2019-09-30T05:02:02.969Z] === PAUSE TestMountDaemonRoot/private/mount_root
05:02:02 [2019-09-30T05:02:02.969Z] === RUN   TestMountDaemonRoot/private/mount_subpath
05:02:02 [2019-09-30T05:02:02.969Z] === PAUSE TestMountDaemonRoot/private/mount_subpath
05:02:02 [2019-09-30T05:02:02.969Z] === RUN   TestMountDaemonRoot/private/bind_root
05:02:02 [2019-09-30T05:02:02.969Z] === PAUSE TestMountDaemonRoot/private/bind_root
05:02:02 [2019-09-30T05:02:02.969Z] === CONT  TestMountDaemonRoot/default/bind_root
05:02:02 [2019-09-30T05:02:02.969Z] === CONT  TestMountDaemonRoot/default/mount_subpath
05:02:03 [2019-09-30T05:02:03.333Z] === CONT  TestMountDaemonRoot/default/mount_root
05:02:03 [2019-09-30T05:02:03.333Z] === CONT  TestMountDaemonRoot/rshared/mount_subpath
05:02:03 [2019-09-30T05:02:03.333Z] === CONT  TestMountDaemonRoot/rshared/mount_root
05:02:03 [2019-09-30T05:02:03.333Z] === CONT  TestMountDaemonRoot/rshared/bind_subpath
05:02:03 [2019-09-30T05:02:03.333Z] === CONT  TestMountDaemonRoot/shared/mount_root
05:02:03 [2019-09-30T05:02:03.333Z] === CONT  TestMountDaemonRoot/rslave/bind_root
05:02:03 [2019-09-30T05:02:03.333Z] === CONT  TestMountDaemonRoot/shared/bind_subpath
05:02:03 [2019-09-30T05:02:03.333Z] === CONT  TestMountDaemonRoot/shared/bind_root
05:02:03 [2019-09-30T05:02:03.333Z] === CONT  TestMountDaemonRoot/shared/mount_subpath
05:02:03 [2019-09-30T05:02:03.333Z] === CONT  TestMountDaemonRoot/slave/mount_subpath
05:02:03 [2019-09-30T05:02:03.333Z] === CONT  TestMountDaemonRoot/rslave/mount_subpath
05:02:03 [2019-09-30T05:02:03.713Z] === CONT  TestMountDaemonRoot/rslave/mount_root
05:02:03 [2019-09-30T05:02:03.713Z] === CONT  TestMountDaemonRoot/rslave/bind_subpath
05:02:03 [2019-09-30T05:02:03.713Z] === CONT  TestMountDaemonRoot/rprivate/bind_root
05:02:03 [2019-09-30T05:02:03.713Z] === CONT  TestMountDaemonRoot/slave/mount_root
05:02:03 [2019-09-30T05:02:03.713Z] === CONT  TestMountDaemonRoot/slave/bind_subpath
05:02:03 [2019-09-30T05:02:03.713Z] === CONT  TestMountDaemonRoot/slave/bind_root
05:02:03 [2019-09-30T05:02:03.713Z] === CONT  TestMountDaemonRoot/private/bind_subpath
05:02:03 [2019-09-30T05:02:03.713Z] === CONT  TestMountDaemonRoot/rprivate/mount_subpath
05:02:03 [2019-09-30T05:02:03.713Z] === CONT  TestMountDaemonRoot/rprivate/mount_root
05:02:03 [2019-09-30T05:02:03.713Z] === CONT  TestMountDaemonRoot/rprivate/bind_subpath
05:02:03 [2019-09-30T05:02:03.713Z] === CONT  TestMountDaemonRoot/private/bind_root
05:02:03 [2019-09-30T05:02:03.713Z] === CONT  TestMountDaemonRoot/private/mount_subpath
05:02:03 [2019-09-30T05:02:03.713Z] === CONT  TestMountDaemonRoot/private/mount_root
05:02:03 [2019-09-30T05:02:03.713Z] --- PASS: TestMountDaemonRoot (0.03s)
05:02:03 [2019-09-30T05:02:03.713Z]     --- PASS: TestMountDaemonRoot/default (0.00s)
05:02:03 [2019-09-30T05:02:03.713Z]         --- PASS: TestMountDaemonRoot/default/bind_subpath (0.08s)
05:02:03 [2019-09-30T05:02:03.713Z]         --- PASS: TestMountDaemonRoot/default/mount_subpath (0.08s)
05:02:03 [2019-09-30T05:02:03.713Z]         --- PASS: TestMountDaemonRoot/default/bind_root (0.08s)
05:02:03 [2019-09-30T05:02:03.713Z]         --- PASS: TestMountDaemonRoot/default/mount_root (0.07s)
05:02:03 [2019-09-30T05:02:03.713Z]     --- PASS: TestMountDaemonRoot/rshared (0.00s)
05:02:03 [2019-09-30T05:02:03.713Z]         --- PASS: TestMountDaemonRoot/rshared/bind_root (0.08s)
05:02:03 [2019-09-30T05:02:03.713Z]         --- PASS: TestMountDaemonRoot/rshared/mount_subpath (0.07s)
05:02:03 [2019-09-30T05:02:03.713Z]         --- PASS: TestMountDaemonRoot/rshared/bind_subpath (0.08s)
05:02:03 [2019-09-30T05:02:03.713Z]         --- PASS: TestMountDaemonRoot/rshared/mount_root (0.08s)
05:02:03 [2019-09-30T05:02:03.713Z]     --- PASS: TestMountDaemonRoot/shared (0.00s)
05:02:03 [2019-09-30T05:02:03.713Z]         --- PASS: TestMountDaemonRoot/shared/mount_root (0.04s)
05:02:03 [2019-09-30T05:02:03.713Z]         --- PASS: TestMountDaemonRoot/shared/bind_subpath (0.05s)
05:02:03 [2019-09-30T05:02:03.713Z]         --- PASS: TestMountDaemonRoot/shared/mount_subpath (0.05s)
05:02:03 [2019-09-30T05:02:03.713Z]         --- PASS: TestMountDaemonRoot/shared/bind_root (0.05s)
05:02:03 [2019-09-30T05:02:03.713Z]     --- PASS: TestMountDaemonRoot/rslave (0.00s)
05:02:03 [2019-09-30T05:02:03.713Z]         --- PASS: TestMountDaemonRoot/rslave/bind_root (0.09s)
05:02:03 [2019-09-30T05:02:03.713Z]         --- PASS: TestMountDaemonRoot/rslave/mount_subpath (0.08s)
05:02:03 [2019-09-30T05:02:03.713Z]         --- PASS: TestMountDaemonRoot/rslave/mount_root (0.07s)
05:02:03 [2019-09-30T05:02:03.713Z]         --- PASS: TestMountDaemonRoot/rslave/bind_subpath (0.07s)
05:02:03 [2019-09-30T05:02:03.713Z]     --- PASS: TestMountDaemonRoot/slave (0.00s)
05:02:03 [2019-09-30T05:02:03.713Z]         --- PASS: TestMountDaemonRoot/slave/mount_subpath (0.04s)
05:02:03 [2019-09-30T05:02:03.713Z]         --- PASS: TestMountDaemonRoot/slave/mount_root (0.04s)
05:02:03 [2019-09-30T05:02:03.713Z]         --- PASS: TestMountDaemonRoot/slave/bind_subpath (0.04s)
05:02:03 [2019-09-30T05:02:03.713Z]         --- PASS: TestMountDaemonRoot/slave/bind_root (0.03s)
05:02:03 [2019-09-30T05:02:03.713Z]     --- PASS: TestMountDaemonRoot/rprivate (0.00s)
05:02:03 [2019-09-30T05:02:03.713Z]         --- PASS: TestMountDaemonRoot/rprivate/bind_root (0.04s)
05:02:03 [2019-09-30T05:02:03.713Z]         --- PASS: TestMountDaemonRoot/rprivate/mount_subpath (0.05s)
05:02:03 [2019-09-30T05:02:03.713Z]         --- PASS: TestMountDaemonRoot/rprivate/mount_root (0.04s)
05:02:03 [2019-09-30T05:02:03.713Z]         --- PASS: TestMountDaemonRoot/rprivate/bind_subpath (0.05s)
05:02:03 [2019-09-30T05:02:03.713Z]     --- PASS: TestMountDaemonRoot/private (0.00s)
05:02:03 [2019-09-30T05:02:03.713Z]         --- PASS: TestMountDaemonRoot/private/bind_subpath (0.05s)
05:02:03 [2019-09-30T05:02:03.713Z]         --- PASS: TestMountDaemonRoot/private/bind_root (0.04s)
05:02:03 [2019-09-30T05:02:03.713Z]         --- PASS: TestMountDaemonRoot/private/mount_subpath (0.03s)
05:02:03 [2019-09-30T05:02:03.713Z]         --- PASS: TestMountDaemonRoot/private/mount_root (0.05s)
05:02:03 [2019-09-30T05:02:03.713Z] === RUN   TestContainerBindMountNonRecursive
05:02:05 [2019-09-30T05:02:05.693Z] --- PASS: TestContainerBindMountNonRecursive (1.92s)
05:02:05 [2019-09-30T05:02:05.693Z] === RUN   TestNetworkNat
05:02:06 [2019-09-30T05:02:06.494Z] --- PASS: TestNetworkNat (0.79s)
05:02:06 [2019-09-30T05:02:06.495Z] === RUN   TestNetworkLocalhostTCPNat
05:02:07 [2019-09-30T05:02:07.278Z] --- PASS: TestNetworkLocalhostTCPNat (0.85s)
05:02:07 [2019-09-30T05:02:07.278Z] === RUN   TestNetworkLoopbackNat
05:02:08 [2019-09-30T05:02:08.545Z] --- PASS: TestNetworkLoopbackNat (1.26s)
05:02:08 [2019-09-30T05:02:08.545Z] === RUN   TestPause
05:02:09 [2019-09-30T05:02:09.809Z] --- PASS: TestPause (1.02s)
05:02:09 [2019-09-30T05:02:09.809Z] === RUN   TestPauseFailsOnWindowsServerContainers
05:02:09 [2019-09-30T05:02:09.809Z] --- SKIP: TestPauseFailsOnWindowsServerContainers (0.00s)
05:02:09 [2019-09-30T05:02:09.809Z]     pause_test.go:54: testEnv.DaemonInfo.OSType != "windows" || testEnv.DaemonInfo.Isolation != "process"
05:02:09 [2019-09-30T05:02:09.809Z] === RUN   TestPauseStopPausedContainer
05:02:10 [2019-09-30T05:02:10.617Z] --- PASS: TestPauseStopPausedContainer (0.98s)
05:02:10 [2019-09-30T05:02:10.617Z] === RUN   TestPsFilter
05:02:11 [2019-09-30T05:02:11.039Z] --- PASS: TestPsFilter (0.23s)
05:02:11 [2019-09-30T05:02:11.039Z] === RUN   TestRemoveContainerWithRemovedVolume
05:02:11 [2019-09-30T05:02:11.881Z] --- PASS: TestRemoveContainerWithRemovedVolume (0.87s)
05:02:11 [2019-09-30T05:02:11.881Z] === RUN   TestRemoveContainerWithVolume
05:02:12 [2019-09-30T05:02:12.670Z] --- PASS: TestRemoveContainerWithVolume (0.91s)
05:02:12 [2019-09-30T05:02:12.670Z] === RUN   TestRemoveContainerRunning
05:02:13 [2019-09-30T05:02:13.927Z] --- PASS: TestRemoveContainerRunning (0.93s)
05:02:13 [2019-09-30T05:02:13.927Z] === RUN   TestRemoveContainerForceRemoveRunning
05:02:14 [2019-09-30T05:02:14.703Z] --- PASS: TestRemoveContainerForceRemoveRunning (0.88s)
05:02:14 [2019-09-30T05:02:14.703Z] === RUN   TestRemoveInvalidContainer
05:02:14 [2019-09-30T05:02:14.703Z] --- PASS: TestRemoveInvalidContainer (0.01s)
05:02:14 [2019-09-30T05:02:14.703Z] === RUN   TestRenameLinkedContainer
05:02:18 [2019-09-30T05:02:18.089Z] --- PASS: TestRenameLinkedContainer (3.49s)
05:02:18 [2019-09-30T05:02:18.089Z] === RUN   TestRenameStoppedContainer
05:02:18 [2019-09-30T05:02:18.891Z] --- PASS: TestRenameStoppedContainer (0.89s)
05:02:18 [2019-09-30T05:02:18.891Z] === RUN   TestRenameRunningContainerAndReuse
05:02:20 [2019-09-30T05:02:20.680Z] --- PASS: TestRenameRunningContainerAndReuse (1.75s)
05:02:20 [2019-09-30T05:02:20.680Z] === RUN   TestRenameInvalidName
05:02:21 [2019-09-30T05:02:21.475Z] --- PASS: TestRenameInvalidName (0.81s)
05:02:21 [2019-09-30T05:02:21.475Z] === RUN   TestRenameAnonymousContainer
05:02:24 [2019-09-30T05:02:24.663Z] --- PASS: TestRenameAnonymousContainer (2.82s)
05:02:24 [2019-09-30T05:02:24.663Z] === RUN   TestRenameContainerWithSameName
05:02:25 [2019-09-30T05:02:25.064Z] --- PASS: TestRenameContainerWithSameName (0.83s)
05:02:25 [2019-09-30T05:02:25.064Z] === RUN   TestRenameContainerWithLinkedContainer
05:02:26 [2019-09-30T05:02:26.904Z] --- PASS: TestRenameContainerWithLinkedContainer (1.76s)
05:02:26 [2019-09-30T05:02:26.904Z] === RUN   TestResize
05:02:27 [2019-09-30T05:02:27.686Z] --- PASS: TestResize (0.91s)
05:02:27 [2019-09-30T05:02:27.686Z] === RUN   TestResizeWithInvalidSize
05:02:28 [2019-09-30T05:02:28.962Z] --- PASS: TestResizeWithInvalidSize (1.00s)
05:02:28 [2019-09-30T05:02:28.962Z] === RUN   TestResizeWhenContainerNotStarted
05:02:29 [2019-09-30T05:02:29.777Z] --- PASS: TestResizeWhenContainerNotStarted (0.98s)
05:02:29 [2019-09-30T05:02:29.777Z] === RUN   TestDaemonRestartKillContainers
05:02:29 [2019-09-30T05:02:29.777Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
05:02:29 [2019-09-30T05:02:29.777Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
05:02:29 [2019-09-30T05:02:29.777Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
05:02:29 [2019-09-30T05:02:29.777Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
05:02:29 [2019-09-30T05:02:29.777Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
05:02:29 [2019-09-30T05:02:29.777Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
05:02:29 [2019-09-30T05:02:29.777Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
05:02:29 [2019-09-30T05:02:29.777Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
05:02:29 [2019-09-30T05:02:29.777Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
05:02:29 [2019-09-30T05:02:29.777Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
05:02:29 [2019-09-30T05:02:29.777Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
05:02:29 [2019-09-30T05:02:29.777Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
05:02:29 [2019-09-30T05:02:29.777Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
05:02:29 [2019-09-30T05:02:29.777Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
05:02:29 [2019-09-30T05:02:29.777Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
05:02:29 [2019-09-30T05:02:29.777Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
05:02:29 [2019-09-30T05:02:29.777Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
05:02:29 [2019-09-30T05:02:29.777Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
05:02:29 [2019-09-30T05:02:29.777Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
05:02:29 [2019-09-30T05:02:29.777Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
05:02:29 [2019-09-30T05:02:29.777Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
05:02:29 [2019-09-30T05:02:29.777Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
05:02:29 [2019-09-30T05:02:29.777Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
05:02:29 [2019-09-30T05:02:29.777Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
05:02:29 [2019-09-30T05:02:29.777Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
05:02:29 [2019-09-30T05:02:29.777Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
05:02:31 [2019-09-30T05:02:31.786Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
05:02:32 [2019-09-30T05:02:32.619Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
05:02:33 [2019-09-30T05:02:33.424Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
05:02:33 [2019-09-30T05:02:33.791Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
05:02:35 [2019-09-30T05:02:35.092Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
05:02:35 [2019-09-30T05:02:35.462Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
05:02:37 [2019-09-30T05:02:37.307Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
05:02:37 [2019-09-30T05:02:37.783Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
05:02:39 [2019-09-30T05:02:39.682Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
05:02:40 [2019-09-30T05:02:40.955Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
05:02:43 [2019-09-30T05:02:43.411Z] --- PASS: TestDaemonRestartKillContainers (0.00s)
05:02:43 [2019-09-30T05:02:43.411Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon (2.12s)
05:02:43 [2019-09-30T05:02:43.411Z]         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"
05:02:43 [2019-09-30T05:02:43.411Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon (2.60s)
05:02:43 [2019-09-30T05:02:43.411Z]         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"
05:02:43 [2019-09-30T05:02:43.411Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon (1.45s)
05:02:43 [2019-09-30T05:02:43.411Z]         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"
05:02:43 [2019-09-30T05:02:43.411Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon (1.47s)
05:02:43 [2019-09-30T05:02:43.411Z]         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"
05:02:43 [2019-09-30T05:02:43.411Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon (1.46s)
05:02:43 [2019-09-30T05:02:43.411Z]         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"
05:02:43 [2019-09-30T05:02:43.411Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon (1.49s)
05:02:43 [2019-09-30T05:02:43.411Z]         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"
05:02:43 [2019-09-30T05:02:43.411Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon (2.20s)
05:02:43 [2019-09-30T05:02:43.411Z]         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"
05:02:43 [2019-09-30T05:02:43.411Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon (2.32s)
05:02:43 [2019-09-30T05:02:43.411Z]         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"
05:02:43 [2019-09-30T05:02:43.411Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon (2.77s)
05:02:43 [2019-09-30T05:02:43.411Z]         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"
05:02:43 [2019-09-30T05:02:43.411Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon (3.11s)
05:02:43 [2019-09-30T05:02:43.411Z]         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"
05:02:43 [2019-09-30T05:02:43.411Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon (2.44s)
05:02:43 [2019-09-30T05:02:43.411Z]         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"
05:02:43 [2019-09-30T05:02:43.411Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon (2.30s)
05:02:43 [2019-09-30T05:02:43.411Z]         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"
05:02:43 [2019-09-30T05:02:43.411Z] === RUN   TestCgroupNamespacesRun
05:02:44 [2019-09-30T05:02:44.786Z] --- PASS: TestCgroupNamespacesRun (1.85s)
05:02:44 [2019-09-30T05:02:44.786Z]     run_cgroupns_linux_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRun"
05:02:44 [2019-09-30T05:02:44.786Z] === RUN   TestCgroupNamespacesRunPrivileged
05:02:46 [2019-09-30T05:02:46.666Z] --- PASS: TestCgroupNamespacesRunPrivileged (1.69s)
05:02:46 [2019-09-30T05:02:46.666Z]     run_cgroupns_linux_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunPrivileged"
05:02:46 [2019-09-30T05:02:46.666Z] === RUN   TestCgroupNamespacesRunDaemonHostMode
05:02:48 [2019-09-30T05:02:48.491Z] --- PASS: TestCgroupNamespacesRunDaemonHostMode (1.77s)
05:02:48 [2019-09-30T05:02:48.491Z]     run_cgroupns_linux_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunDaemonHostMode"
05:02:48 [2019-09-30T05:02:48.491Z] === RUN   TestCgroupNamespacesRunHostMode
05:02:50 [2019-09-30T05:02:50.312Z] --- PASS: TestCgroupNamespacesRunHostMode (1.82s)
05:02:50 [2019-09-30T05:02:50.312Z]     run_cgroupns_linux_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunHostMode"
05:02:50 [2019-09-30T05:02:50.312Z] === RUN   TestCgroupNamespacesRunPrivateMode
05:02:52 [2019-09-30T05:02:52.244Z] --- PASS: TestCgroupNamespacesRunPrivateMode (1.92s)
05:02:52 [2019-09-30T05:02:52.244Z]     run_cgroupns_linux_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunPrivateMode"
05:02:52 [2019-09-30T05:02:52.244Z] === RUN   TestCgroupNamespacesRunPrivilegedAndPrivate
05:02:53 [2019-09-30T05:02:53.032Z] --- PASS: TestCgroupNamespacesRunPrivilegedAndPrivate (0.82s)
05:02:53 [2019-09-30T05:02:53.032Z]     run_cgroupns_linux_test.go:48: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunPrivilegedAndPrivate"
05:02:53 [2019-09-30T05:02:53.032Z] === RUN   TestCgroupNamespacesRunInvalidMode
05:02:53 [2019-09-30T05:02:53.829Z] --- PASS: TestCgroupNamespacesRunInvalidMode (0.87s)
05:02:53 [2019-09-30T05:02:53.829Z]     run_cgroupns_linux_test.go:48: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunInvalidMode"
05:02:53 [2019-09-30T05:02:53.829Z] === RUN   TestCgroupNamespacesRunOlderClient
05:02:55 [2019-09-30T05:02:55.658Z] --- PASS: TestCgroupNamespacesRunOlderClient (1.80s)
05:02:55 [2019-09-30T05:02:55.658Z]     run_cgroupns_linux_test.go:139: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunOlderClient"
05:02:55 [2019-09-30T05:02:55.658Z] === RUN   TestKernelTCPMemory
05:02:56 [2019-09-30T05:02:56.924Z] --- PASS: TestKernelTCPMemory (1.05s)
05:02:56 [2019-09-30T05:02:56.924Z] === RUN   TestNISDomainname
05:02:57 [2019-09-30T05:02:57.730Z] --- PASS: TestNISDomainname (1.16s)
05:02:57 [2019-09-30T05:02:57.730Z] === RUN   TestHostnameDnsResolution
05:02:59 [2019-09-30T05:02:59.136Z] --- PASS: TestHostnameDnsResolution (1.28s)
05:02:59 [2019-09-30T05:02:59.136Z] === RUN   TestStats
05:03:01 [2019-09-30T05:03:01.546Z] --- PASS: TestStats (2.14s)
05:03:01 [2019-09-30T05:03:01.546Z] === RUN   TestStopContainerWithTimeout
05:03:01 [2019-09-30T05:03:01.546Z] === RUN   TestStopContainerWithTimeout/0
05:03:01 [2019-09-30T05:03:01.546Z] === PAUSE TestStopContainerWithTimeout/0
05:03:01 [2019-09-30T05:03:01.546Z] === RUN   TestStopContainerWithTimeout/1
05:03:01 [2019-09-30T05:03:01.546Z] === PAUSE TestStopContainerWithTimeout/1
05:03:01 [2019-09-30T05:03:01.546Z] === RUN   TestStopContainerWithTimeout/3
05:03:01 [2019-09-30T05:03:01.546Z] === PAUSE TestStopContainerWithTimeout/3
05:03:01 [2019-09-30T05:03:01.546Z] === RUN   TestStopContainerWithTimeout/-1
05:03:01 [2019-09-30T05:03:01.546Z] === PAUSE TestStopContainerWithTimeout/-1
05:03:01 [2019-09-30T05:03:01.546Z] === CONT  TestStopContainerWithTimeout/0
05:03:01 [2019-09-30T05:03:01.546Z] === CONT  TestStopContainerWithTimeout/3
05:03:02 [2019-09-30T05:03:02.316Z] === CONT  TestStopContainerWithTimeout/-1
05:03:04 [2019-09-30T05:03:04.121Z] === CONT  TestStopContainerWithTimeout/1
05:03:06 [2019-09-30T05:03:06.107Z] --- PASS: TestStopContainerWithTimeout (0.01s)
05:03:06 [2019-09-30T05:03:06.107Z]     --- PASS: TestStopContainerWithTimeout/0 (1.01s)
05:03:06 [2019-09-30T05:03:06.107Z]     --- PASS: TestStopContainerWithTimeout/3 (3.02s)
05:03:06 [2019-09-30T05:03:06.107Z]     --- PASS: TestStopContainerWithTimeout/-1 (3.01s)
05:03:06 [2019-09-30T05:03:06.107Z]     --- PASS: TestStopContainerWithTimeout/1 (1.94s)
05:03:06 [2019-09-30T05:03:06.107Z] === RUN   TestDeleteDevicemapper
05:03:06 [2019-09-30T05:03:06.107Z] --- SKIP: TestDeleteDevicemapper (0.00s)
05:03:06 [2019-09-30T05:03:06.107Z]     stop_linux_test.go:74: testEnv.DaemonInfo.Driver != "devicemapper"
05:03:06 [2019-09-30T05:03:06.107Z] === RUN   TestStopContainerWithRestartPolicyAlways
05:03:10 [2019-09-30T05:03:10.137Z] --- PASS: TestStopContainerWithRestartPolicyAlways (3.79s)
05:03:10 [2019-09-30T05:03:10.137Z] === RUN   TestUpdateMemory
05:03:10 [2019-09-30T05:03:10.137Z] --- SKIP: TestUpdateMemory (0.00s)
05:03:10 [2019-09-30T05:03:10.137Z]     update_linux_test.go:23: !testEnv.DaemonInfo.SwapLimit
05:03:10 [2019-09-30T05:03:10.137Z] === RUN   TestUpdateCPUQuota
05:03:11 [2019-09-30T05:03:11.414Z] --- PASS: TestUpdateCPUQuota (1.60s)
05:03:11 [2019-09-30T05:03:11.414Z] === RUN   TestUpdatePidsLimit
05:03:11 [2019-09-30T05:03:11.777Z] === RUN   TestUpdatePidsLimit/update_from_none
05:03:12 [2019-09-30T05:03:12.335Z] === RUN   TestUpdatePidsLimit/no_change
05:03:12 [2019-09-30T05:03:12.335Z] === RUN   TestUpdatePidsLimit/update_lower
05:03:12 [2019-09-30T05:03:12.821Z] === RUN   TestUpdatePidsLimit/update_on_old_api_ignores_value
05:03:13 [2019-09-30T05:03:13.192Z] === RUN   TestUpdatePidsLimit/unset_limit_with_zero
05:03:13 [2019-09-30T05:03:13.638Z] === RUN   TestUpdatePidsLimit/unset_limit_with_minus_one
05:03:14 [2019-09-30T05:03:14.004Z] === RUN   TestUpdatePidsLimit/unset_limit_with_minus_two
05:03:15 [2019-09-30T05:03:15.816Z] --- PASS: TestUpdatePidsLimit (4.18s)
05:03:15 [2019-09-30T05:03:15.816Z]     --- PASS: TestUpdatePidsLimit/update_from_none (0.41s)
05:03:15 [2019-09-30T05:03:15.816Z]     --- PASS: TestUpdatePidsLimit/no_change (0.39s)
05:03:15 [2019-09-30T05:03:15.816Z]     --- PASS: TestUpdatePidsLimit/update_lower (0.41s)
05:03:15 [2019-09-30T05:03:15.816Z]     --- PASS: TestUpdatePidsLimit/update_on_old_api_ignores_value (0.45s)
05:03:15 [2019-09-30T05:03:15.816Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_zero (0.48s)
05:03:15 [2019-09-30T05:03:15.816Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_minus_one (0.43s)
05:03:15 [2019-09-30T05:03:15.816Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_minus_two (0.41s)
05:03:15 [2019-09-30T05:03:15.816Z] === RUN   TestUpdateRestartPolicy
05:03:29 [2019-09-30T05:03:29.422Z] --- PASS: TestUpdateRestartPolicy (12.91s)
05:03:29 [2019-09-30T05:03:29.422Z] === RUN   TestUpdateRestartWithAutoRemove
05:03:29 [2019-09-30T05:03:29.422Z] --- PASS: TestUpdateRestartWithAutoRemove (0.86s)
05:03:29 [2019-09-30T05:03:29.422Z] === RUN   TestWaitNonBlocked
05:03:29 [2019-09-30T05:03:29.422Z] === RUN   TestWaitNonBlocked/wait-nonblocking-exit-0
05:03:29 [2019-09-30T05:03:29.422Z] === PAUSE TestWaitNonBlocked/wait-nonblocking-exit-0
05:03:29 [2019-09-30T05:03:29.422Z] === RUN   TestWaitNonBlocked/wait-nonblocking-exit-random
05:03:29 [2019-09-30T05:03:29.422Z] === PAUSE TestWaitNonBlocked/wait-nonblocking-exit-random
05:03:29 [2019-09-30T05:03:29.422Z] === CONT  TestWaitNonBlocked/wait-nonblocking-exit-0
05:03:29 [2019-09-30T05:03:29.422Z] === CONT  TestWaitNonBlocked/wait-nonblocking-exit-random
05:03:30 [2019-09-30T05:03:30.724Z] --- PASS: TestWaitNonBlocked (0.02s)
05:03:30 [2019-09-30T05:03:30.724Z]     --- PASS: TestWaitNonBlocked/wait-nonblocking-exit-random (1.06s)
05:03:30 [2019-09-30T05:03:30.724Z]     --- PASS: TestWaitNonBlocked/wait-nonblocking-exit-0 (1.09s)
05:03:30 [2019-09-30T05:03:30.724Z] === RUN   TestWaitBlocked
05:03:30 [2019-09-30T05:03:30.724Z] === RUN   TestWaitBlocked/test-wait-blocked-exit-zero
05:03:30 [2019-09-30T05:03:30.724Z] === PAUSE TestWaitBlocked/test-wait-blocked-exit-zero
05:03:30 [2019-09-30T05:03:30.724Z] === RUN   TestWaitBlocked/test-wait-blocked-exit-random
05:03:30 [2019-09-30T05:03:30.724Z] === PAUSE TestWaitBlocked/test-wait-blocked-exit-random
05:03:30 [2019-09-30T05:03:30.724Z] === CONT  TestWaitBlocked/test-wait-blocked-exit-zero
05:03:30 [2019-09-30T05:03:30.724Z] === CONT  TestWaitBlocked/test-wait-blocked-exit-random
05:03:32 [2019-09-30T05:03:32.013Z] --- PASS: TestWaitBlocked (0.02s)
05:03:32 [2019-09-30T05:03:32.013Z]     --- PASS: TestWaitBlocked/test-wait-blocked-exit-random (1.06s)
05:03:32 [2019-09-30T05:03:32.013Z]     --- PASS: TestWaitBlocked/test-wait-blocked-exit-zero (1.15s)
05:03:32 [2019-09-30T05:03:32.013Z] === CONT  TestContainerStartOnDaemonRestart
05:03:32 [2019-09-30T05:03:32.013Z] === CONT  TestIpcModeOlderClient
05:03:32 [2019-09-30T05:03:32.013Z] --- PASS: TestIpcModeOlderClient (0.16s)
05:03:32 [2019-09-30T05:03:32.013Z] === CONT  TestDaemonRestartIpcMode
05:03:34 [2019-09-30T05:03:34.694Z] --- PASS: TestContainerStartOnDaemonRestart (3.00s)
05:03:34 [2019-09-30T05:03:34.694Z]     daemon_linux_test.go:35: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestContainerStartOnDaemonRestart"
05:03:36 [2019-09-30T05:03:36.496Z] --- PASS: TestDaemonRestartIpcMode (4.20s)
05:03:36 [2019-09-30T05:03:36.496Z]     daemon_linux_test.go:89: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartIpcMode"
05:03:36 [2019-09-30T05:03:36.496Z] PASS
05:03:36 [2019-09-30T05:03:36.496Z] 
05:03:36 [2019-09-30T05:03:36.496Z] === Skipped
05:03:36 [2019-09-30T05:03:36.496Z] === SKIP: s390x.integration.container TestCheckpoint (0.00s)
05:03:36 [2019-09-30T05:03:36.496Z]     checkpoint_test.go:33: TestCheckpoint is broken; see https://github.com/moby/moby/issues/38963
05:03:36 [2019-09-30T05:03:36.496Z] 
05:03:36 [2019-09-30T05:03:36.496Z] === SKIP: s390x.integration.container TestInspectOomKilledTrue (0.00s)
05:03:36 [2019-09-30T05:03:36.496Z]     kill_test.go:151: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
05:03:36 [2019-09-30T05:03:36.496Z] 
05:03:36 [2019-09-30T05:03:36.496Z] === SKIP: s390x.integration.container TestInspectOomKilledFalse (0.00s)
05:03:36 [2019-09-30T05:03:36.496Z]     kill_test.go:169: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
05:03:36 [2019-09-30T05:03:36.496Z] 
05:03:36 [2019-09-30T05:03:36.496Z] === SKIP: s390x.integration.container TestPauseFailsOnWindowsServerContainers (0.00s)
05:03:36 [2019-09-30T05:03:36.496Z]     pause_test.go:54: testEnv.DaemonInfo.OSType != "windows" || testEnv.DaemonInfo.Isolation != "process"
05:03:36 [2019-09-30T05:03:36.496Z] 
05:03:36 [2019-09-30T05:03:36.496Z] === SKIP: s390x.integration.container TestDeleteDevicemapper (0.00s)
05:03:36 [2019-09-30T05:03:36.496Z]     stop_linux_test.go:74: testEnv.DaemonInfo.Driver != "devicemapper"
05:03:36 [2019-09-30T05:03:36.496Z] 
05:03:36 [2019-09-30T05:03:36.496Z] === SKIP: s390x.integration.container TestUpdateMemory (0.00s)
05:03:36 [2019-09-30T05:03:36.496Z]     update_linux_test.go:23: !testEnv.DaemonInfo.SwapLimit
05:03:36 [2019-09-30T05:03:36.496Z] 
05:03:36 [2019-09-30T05:03:36.496Z] 
05:03:36 [2019-09-30T05:03:36.496Z] DONE 197 tests, 6 skipped in 139.023s
05:03:36 [2019-09-30T05:03:36.496Z] Running /go/src/github.com/docker/docker/integration/image (s390x.integration.image) flags=-test.v -test.timeout=120m 
05:03:36 [2019-09-30T05:03:36.496Z] ++ 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
05:03:36 [2019-09-30T05:03:36.496Z] ++ set -e
05:03:36 [2019-09-30T05:03:36.496Z] ++ '[' -n 0 ']'
05:03:36 [2019-09-30T05:03:36.496Z] ++ set -x
05:03:36 [2019-09-30T05:03:36.496Z] ++ 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
05:03:36 [2019-09-30T05:03:36.496Z] INFO: Testing against a local daemon
05:03:36 [2019-09-30T05:03:36.496Z] === RUN   TestCommitInheritsEnv
05:03:36 [2019-09-30T05:03:36.864Z] --- PASS: TestCommitInheritsEnv (0.52s)
05:03:36 [2019-09-30T05:03:36.864Z] === RUN   TestImportExtremelyLargeImageWorks
05:03:36 [2019-09-30T05:03:36.864Z] === PAUSE TestImportExtremelyLargeImageWorks
05:03:36 [2019-09-30T05:03:36.864Z] === RUN   TestImagesFilterMultiReference
05:03:36 [2019-09-30T05:03:36.864Z] --- PASS: TestImagesFilterMultiReference (0.04s)
05:03:36 [2019-09-30T05:03:36.864Z] === RUN   TestImagePullPlatformInvalid
05:03:36 [2019-09-30T05:03:36.864Z] --- PASS: TestImagePullPlatformInvalid (0.02s)
05:03:36 [2019-09-30T05:03:36.864Z] === RUN   TestRemoveImageOrphaning
05:03:37 [2019-09-30T05:03:37.230Z] --- PASS: TestRemoveImageOrphaning (0.49s)
05:03:37 [2019-09-30T05:03:37.230Z] === RUN   TestRemoveImageGarbageCollector
05:03:37 [2019-09-30T05:03:37.230Z] --- SKIP: TestRemoveImageGarbageCollector (0.00s)
05:03:37 [2019-09-30T05:03:37.230Z]     remove_unix_test.go:36: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
05:03:37 [2019-09-30T05:03:37.230Z] === RUN   TestTagUnprefixedRepoByNameOrName
05:03:37 [2019-09-30T05:03:37.604Z] --- PASS: TestTagUnprefixedRepoByNameOrName (0.03s)
05:03:37 [2019-09-30T05:03:37.604Z] === RUN   TestTagInvalidReference
05:03:37 [2019-09-30T05:03:37.604Z] --- PASS: TestTagInvalidReference (0.01s)
05:03:37 [2019-09-30T05:03:37.604Z] === RUN   TestTagValidPrefixedRepo
05:03:37 [2019-09-30T05:03:37.604Z] --- PASS: TestTagValidPrefixedRepo (0.04s)
05:03:37 [2019-09-30T05:03:37.604Z] === RUN   TestTagExistedNameWithoutForce
05:03:37 [2019-09-30T05:03:37.604Z] --- PASS: TestTagExistedNameWithoutForce (0.02s)
05:03:37 [2019-09-30T05:03:37.604Z] === RUN   TestTagOfficialNames
05:03:37 [2019-09-30T05:03:37.604Z] --- PASS: TestTagOfficialNames (0.05s)
05:03:37 [2019-09-30T05:03:37.604Z] === RUN   TestTagMatchesDigest
05:03:37 [2019-09-30T05:03:37.604Z] --- PASS: TestTagMatchesDigest (0.01s)
05:03:37 [2019-09-30T05:03:37.604Z] === CONT  TestImportExtremelyLargeImageWorks
05:05:32 [2019-09-30T05:05:32.336Z] --- PASS: TestImportExtremelyLargeImageWorks (106.70s)
05:05:32 [2019-09-30T05:05:32.336Z]     import_test.go:26: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestImportExtremelyLargeImageWorks"
05:05:32 [2019-09-30T05:05:32.336Z] PASS
05:05:32 [2019-09-30T05:05:32.336Z] 
05:05:32 [2019-09-30T05:05:32.336Z] === Skipped
05:05:32 [2019-09-30T05:05:32.336Z] === SKIP: s390x.integration.image TestRemoveImageGarbageCollector (0.00s)
05:05:32 [2019-09-30T05:05:32.336Z]     remove_unix_test.go:36: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
05:05:32 [2019-09-30T05:05:32.336Z] 
05:05:32 [2019-09-30T05:05:32.336Z] 
05:05:32 [2019-09-30T05:05:32.336Z] DONE 12 tests, 1 skipped in 108.058s
05:05:32 [2019-09-30T05:05:32.336Z] Running /go/src/github.com/docker/docker/integration/network (s390x.integration.network) flags=-test.v -test.timeout=120m 
05:05:32 [2019-09-30T05:05:32.336Z] ++ 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
05:05:32 [2019-09-30T05:05:32.336Z] ++ set -e
05:05:32 [2019-09-30T05:05:32.336Z] ++ '[' -n 0 ']'
05:05:32 [2019-09-30T05:05:32.336Z] ++ set -x
05:05:32 [2019-09-30T05:05:32.337Z] ++ 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
05:05:32 [2019-09-30T05:05:32.337Z] INFO: Testing against a local daemon
05:05:32 [2019-09-30T05:05:32.337Z] === RUN   TestNetworkCreateDelete
05:05:32 [2019-09-30T05:05:32.337Z] --- PASS: TestNetworkCreateDelete (0.16s)
05:05:32 [2019-09-30T05:05:32.337Z] === RUN   TestDockerNetworkDeletePreferID
05:05:32 [2019-09-30T05:05:32.337Z] --- PASS: TestDockerNetworkDeletePreferID (0.31s)
05:05:32 [2019-09-30T05:05:32.337Z] === RUN   TestInspectNetwork
05:05:32 [2019-09-30T05:05:32.337Z] === RUN   TestInspectNetwork/full_network_id
05:05:32 [2019-09-30T05:05:32.337Z] === RUN   TestInspectNetwork/partial_network_id
05:05:32 [2019-09-30T05:05:32.337Z] === RUN   TestInspectNetwork/network_name
05:05:32 [2019-09-30T05:05:32.337Z] === RUN   TestInspectNetwork/network_name_and_swarm_scope
05:05:33 [2019-09-30T05:05:33.110Z] --- PASS: TestInspectNetwork (8.14s)
05:05:33 [2019-09-30T05:05:33.110Z]     inspect_test.go:18: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestInspectNetwork"
05:05:33 [2019-09-30T05:05:33.110Z]     --- PASS: TestInspectNetwork/full_network_id (0.00s)
05:05:33 [2019-09-30T05:05:33.110Z]     --- PASS: TestInspectNetwork/partial_network_id (0.00s)
05:05:33 [2019-09-30T05:05:33.110Z]     --- PASS: TestInspectNetwork/network_name (0.00s)
05:05:33 [2019-09-30T05:05:33.110Z]     --- PASS: TestInspectNetwork/network_name_and_swarm_scope (0.00s)
05:05:33 [2019-09-30T05:05:33.110Z] === RUN   TestRunContainerWithBridgeNone
05:05:35 [2019-09-30T05:05:35.584Z] --- PASS: TestRunContainerWithBridgeNone (2.67s)
05:05:35 [2019-09-30T05:05:35.585Z]     network_test.go:25: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestRunContainerWithBridgeNone"
05:05:35 [2019-09-30T05:05:35.585Z] === RUN   TestNetworkInvalidJSON
05:05:35 [2019-09-30T05:05:35.585Z] === RUN   TestNetworkInvalidJSON//networks/create
05:05:35 [2019-09-30T05:05:35.585Z] === PAUSE TestNetworkInvalidJSON//networks/create
05:05:35 [2019-09-30T05:05:35.585Z] === RUN   TestNetworkInvalidJSON//networks/bridge/connect
05:05:35 [2019-09-30T05:05:35.585Z] === PAUSE TestNetworkInvalidJSON//networks/bridge/connect
05:05:35 [2019-09-30T05:05:35.585Z] === RUN   TestNetworkInvalidJSON//networks/bridge/disconnect
05:05:35 [2019-09-30T05:05:35.585Z] === PAUSE TestNetworkInvalidJSON//networks/bridge/disconnect
05:05:35 [2019-09-30T05:05:35.585Z] === CONT  TestNetworkInvalidJSON//networks/create
05:05:35 [2019-09-30T05:05:35.585Z] === CONT  TestNetworkInvalidJSON//networks/bridge/disconnect
05:05:35 [2019-09-30T05:05:35.585Z] === CONT  TestNetworkInvalidJSON//networks/bridge/connect
05:05:35 [2019-09-30T05:05:35.585Z] --- PASS: TestNetworkInvalidJSON (0.01s)
05:05:35 [2019-09-30T05:05:35.585Z]     --- PASS: TestNetworkInvalidJSON//networks/create (0.00s)
05:05:35 [2019-09-30T05:05:35.585Z]     --- PASS: TestNetworkInvalidJSON//networks/bridge/disconnect (0.00s)
05:05:35 [2019-09-30T05:05:35.585Z]     --- PASS: TestNetworkInvalidJSON//networks/bridge/connect (0.00s)
05:05:35 [2019-09-30T05:05:35.585Z] === RUN   TestDaemonRestartWithLiveRestore
05:05:36 [2019-09-30T05:05:36.875Z] --- PASS: TestDaemonRestartWithLiveRestore (1.04s)
05:05:36 [2019-09-30T05:05:36.875Z]     service_test.go:32: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartWithLiveRestore"
05:05:36 [2019-09-30T05:05:36.875Z] === RUN   TestDaemonDefaultNetworkPools
05:05:37 [2019-09-30T05:05:37.279Z] --- PASS: TestDaemonDefaultNetworkPools (0.73s)
05:05:37 [2019-09-30T05:05:37.279Z]     service_test.go:57: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonDefaultNetworkPools"
05:05:37 [2019-09-30T05:05:37.279Z] === RUN   TestDaemonRestartWithExistingNetwork
05:05:38 [2019-09-30T05:05:38.545Z] --- PASS: TestDaemonRestartWithExistingNetwork (1.12s)
05:05:38 [2019-09-30T05:05:38.545Z]     service_test.go:98: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartWithExistingNetwork"
05:05:38 [2019-09-30T05:05:38.545Z] === RUN   TestDaemonRestartWithExistingNetworkWithDefaultPoolRange
05:05:39 [2019-09-30T05:05:39.826Z] --- PASS: TestDaemonRestartWithExistingNetworkWithDefaultPoolRange (1.24s)
05:05:39 [2019-09-30T05:05:39.826Z]     service_test.go:131: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartWithExistingNetworkWithDefaultPoolRange"
05:05:39 [2019-09-30T05:05:39.826Z] === RUN   TestDaemonWithBipAndDefaultNetworkPool
05:05:40 [2019-09-30T05:05:40.616Z] --- PASS: TestDaemonWithBipAndDefaultNetworkPool (0.61s)
05:05:40 [2019-09-30T05:05:40.616Z]     service_test.go:181: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonWithBipAndDefaultNetworkPool"
05:05:40 [2019-09-30T05:05:40.616Z] === RUN   TestServiceWithPredefinedNetwork
05:05:44 [2019-09-30T05:05:44.025Z] --- PASS: TestServiceWithPredefinedNetwork (3.05s)
05:05:44 [2019-09-30T05:05:44.025Z]     service_test.go:203: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithPredefinedNetwork"
05:05:44 [2019-09-30T05:05:44.025Z] === RUN   TestServiceRemoveKeepsIngressNetwork
05:05:44 [2019-09-30T05:05:44.025Z] --- SKIP: TestServiceRemoveKeepsIngressNetwork (0.00s)
05:05:44 [2019-09-30T05:05:44.025Z]     service_test.go:230: FLAKY_TEST
05:05:44 [2019-09-30T05:05:44.025Z] === RUN   TestServiceWithDataPathPortInit
05:06:00 [2019-09-30T05:06:00.628Z] --- PASS: TestServiceWithDataPathPortInit (16.60s)
05:06:00 [2019-09-30T05:06:00.628Z]     service_test.go:323: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithDataPathPortInit"
05:06:00 [2019-09-30T05:06:00.628Z]     service_test.go:355: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithDataPathPortInit"
05:06:00 [2019-09-30T05:06:00.628Z] === RUN   TestServiceWithDefaultAddressPoolInit
05:06:08 [2019-09-30T05:06:08.448Z] --- PASS: TestServiceWithDefaultAddressPoolInit (8.43s)
05:06:08 [2019-09-30T05:06:08.449Z]     service_test.go:388: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithDefaultAddressPoolInit"
05:06:08 [2019-09-30T05:06:08.449Z]     service_test.go:418: TestServiceWithDefaultAddressPoolInit: NetworkInspect: {Name:sthiraTestServiceWithDefaultAddressPoolInit ID:l091n5jqab9lmtwsbhh7j7xkf Created:2019-09-30 05:06:01.504182459 +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[4c052ce929de1873b9f5396c266aaf1648963f9a56821c57d6b1b19c4306bf4c:{Name:TestServiceTestServiceWithDefaultAddressPoolInit.1.uerpwd2m1yyq3mlkz3b69h9rf EndpointID:fe7f8689ab1cbed472bfb0353415c3b339d9ea6a5b07d963b2aff5007996d7a5 MacAddress:02:42:14:14:00:03 IPv4Address:20.20.0.3/24 IPv6Address:} lb-sthiraTestServiceWithDefaultAddressPoolInit:{Name:sthiraTestServiceWithDefaultAddressPoolInit-endpoint EndpointID:fc87df3092548ae92104e82d9e51e78c384fd7f918263c0c912f3c6aec895395 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:f0e859adee4d IP:127.0.0.1}] Services:map[TestServiceTestServiceWithDefaultAddressPoolInit:{VIP:20.20.0.2 Ports:[] LocalLBIndex:256 Tasks:[{Name:TestServiceTestServiceWithDefaultAddressPoolInit.1.uerpwd2m1yyq3mlkz3b69h9rf EndpointID:fe7f8689ab1cbed472bfb0353415c3b339d9ea6a5b07d963b2aff5007996d7a5 EndpointIP:20.20.0.3 Info:map[Host IP:127.0.0.1]}]}]}
05:06:08 [2019-09-30T05:06:08.449Z] PASS
05:06:08 [2019-09-30T05:06:08.449Z] 
05:06:08 [2019-09-30T05:06:08.449Z] === Skipped
05:06:08 [2019-09-30T05:06:08.449Z] === SKIP: s390x.integration.network TestServiceRemoveKeepsIngressNetwork (0.00s)
05:06:08 [2019-09-30T05:06:08.449Z]     service_test.go:230: FLAKY_TEST
05:06:08 [2019-09-30T05:06:08.449Z] 
05:06:08 [2019-09-30T05:06:08.449Z] 
05:06:08 [2019-09-30T05:06:08.449Z] DONE 21 tests, 1 skipped in 44.205s
05:06:08 [2019-09-30T05:06:08.449Z] Running /go/src/github.com/docker/docker/integration/network/ipvlan (s390x.integration.network.ipvlan) flags=-test.v -test.timeout=120m 
05:06:08 [2019-09-30T05:06:08.449Z] ++ 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
05:06:08 [2019-09-30T05:06:08.449Z] ++ set -e
05:06:08 [2019-09-30T05:06:08.449Z] ++ '[' -n 0 ']'
05:06:08 [2019-09-30T05:06:08.449Z] ++ set -x
05:06:08 [2019-09-30T05:06:08.449Z] ++ 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
05:06:08 [2019-09-30T05:06:08.449Z] INFO: Testing against a local daemon
05:06:08 [2019-09-30T05:06:08.449Z] === RUN   TestDockerNetworkIpvlanPersistance
05:06:08 [2019-09-30T05:06:08.449Z] --- SKIP: TestDockerNetworkIpvlanPersistance (0.00s)
05:06:08 [2019-09-30T05:06:08.449Z]     ipvlan_test.go:26: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
05:06:08 [2019-09-30T05:06:08.449Z] === RUN   TestDockerNetworkIpvlan
05:06:08 [2019-09-30T05:06:08.449Z] --- SKIP: TestDockerNetworkIpvlan (0.01s)
05:06:08 [2019-09-30T05:06:08.449Z]     ipvlan_test.go:53: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
05:06:08 [2019-09-30T05:06:08.449Z] PASS
05:06:08 [2019-09-30T05:06:08.449Z] 
05:06:08 [2019-09-30T05:06:08.449Z] === Skipped
05:06:08 [2019-09-30T05:06:08.449Z] === SKIP: s390x.integration.network.ipvlan TestDockerNetworkIpvlanPersistance (0.00s)
05:06:08 [2019-09-30T05:06:08.449Z]     ipvlan_test.go:26: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
05:06:08 [2019-09-30T05:06:08.449Z] 
05:06:08 [2019-09-30T05:06:08.449Z] === SKIP: s390x.integration.network.ipvlan TestDockerNetworkIpvlan (0.01s)
05:06:08 [2019-09-30T05:06:08.449Z]     ipvlan_test.go:53: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
05:06:08 [2019-09-30T05:06:08.449Z] 
05:06:08 [2019-09-30T05:06:08.449Z] 
05:06:08 [2019-09-30T05:06:08.449Z] DONE 2 tests, 2 skipped in 0.114s
05:06:08 [2019-09-30T05:06:08.449Z] Running /go/src/github.com/docker/docker/integration/network/macvlan (s390x.integration.network.macvlan) flags=-test.v -test.timeout=120m 
05:06:08 [2019-09-30T05:06:08.449Z] ++ 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
05:06:08 [2019-09-30T05:06:08.449Z] ++ set -e
05:06:08 [2019-09-30T05:06:08.449Z] ++ '[' -n 0 ']'
05:06:08 [2019-09-30T05:06:08.449Z] ++ set -x
05:06:08 [2019-09-30T05:06:08.449Z] ++ 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
05:06:08 [2019-09-30T05:06:08.821Z] INFO: Testing against a local daemon
05:06:08 [2019-09-30T05:06:08.821Z] === RUN   TestDockerNetworkMacvlanPersistance
05:06:10 [2019-09-30T05:06:10.090Z] --- PASS: TestDockerNetworkMacvlanPersistance (1.42s)
05:06:10 [2019-09-30T05:06:10.090Z]     macvlan_test.go:24: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlanPersistance"
05:06:10 [2019-09-30T05:06:10.090Z] === RUN   TestDockerNetworkMacvlan
05:06:10 [2019-09-30T05:06:10.902Z] === RUN   TestDockerNetworkMacvlan/Subinterface
05:06:11 [2019-09-30T05:06:11.839Z] === RUN   TestDockerNetworkMacvlan/OverlapParent
05:06:12 [2019-09-30T05:06:12.640Z] === RUN   TestDockerNetworkMacvlan/NilParent
05:06:15 [2019-09-30T05:06:15.843Z] === RUN   TestDockerNetworkMacvlan/InternalMode
05:06:19 [2019-09-30T05:06:19.132Z] === RUN   TestDockerNetworkMacvlan/MultiSubnet
05:06:24 [2019-09-30T05:06:24.216Z] === RUN   TestDockerNetworkMacvlan/Addressing
05:06:25 [2019-09-30T05:06:25.037Z] --- PASS: TestDockerNetworkMacvlan (14.92s)
05:06:25 [2019-09-30T05:06:25.037Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
05:06:25 [2019-09-30T05:06:25.037Z]     --- PASS: TestDockerNetworkMacvlan/Subinterface (0.06s)
05:06:25 [2019-09-30T05:06:25.037Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
05:06:25 [2019-09-30T05:06:25.037Z]     --- PASS: TestDockerNetworkMacvlan/OverlapParent (0.13s)
05:06:25 [2019-09-30T05:06:25.037Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
05:06:25 [2019-09-30T05:06:25.037Z]     --- PASS: TestDockerNetworkMacvlan/NilParent (1.23s)
05:06:25 [2019-09-30T05:06:25.037Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
05:06:25 [2019-09-30T05:06:25.037Z]     --- PASS: TestDockerNetworkMacvlan/InternalMode (2.17s)
05:06:25 [2019-09-30T05:06:25.037Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
05:06:25 [2019-09-30T05:06:25.037Z]     --- PASS: TestDockerNetworkMacvlan/MultiSubnet (2.98s)
05:06:25 [2019-09-30T05:06:25.037Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
05:06:25 [2019-09-30T05:06:25.037Z]     --- PASS: TestDockerNetworkMacvlan/Addressing (0.92s)
05:06:25 [2019-09-30T05:06:25.037Z] PASS
05:06:25 [2019-09-30T05:06:25.037Z] 
05:06:25 [2019-09-30T05:06:25.037Z] DONE 8 tests in 16.429s
05:06:25 [2019-09-30T05:06:25.037Z] Running /go/src/github.com/docker/docker/integration/plugin (s390x.integration.plugin) flags=-test.v -test.timeout=120m 
05:06:25 [2019-09-30T05:06:25.037Z] ++ 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
05:06:25 [2019-09-30T05:06:25.037Z] ++ set -e
05:06:25 [2019-09-30T05:06:25.037Z] ++ '[' -n 0 ']'
05:06:25 [2019-09-30T05:06:25.037Z] ++ set -x
05:06:25 [2019-09-30T05:06:25.037Z] ++ 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
05:06:25 [2019-09-30T05:06:25.037Z] testing: warning: no tests to run
05:06:25 [2019-09-30T05:06:25.037Z] PASS
05:06:25 [2019-09-30T05:06:25.037Z] 
05:06:25 [2019-09-30T05:06:25.037Z] DONE 0 tests in 0.017s
05:06:25 [2019-09-30T05:06:25.037Z] Running /go/src/github.com/docker/docker/integration/plugin/authz (s390x.integration.plugin.authz) flags=-test.v -test.timeout=120m 
05:06:25 [2019-09-30T05:06:25.037Z] ++ 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
05:06:25 [2019-09-30T05:06:25.037Z] ++ set -e
05:06:25 [2019-09-30T05:06:25.037Z] ++ '[' -n 0 ']'
05:06:25 [2019-09-30T05:06:25.037Z] ++ set -x
05:06:25 [2019-09-30T05:06:25.037Z] ++ 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
05:06:25 [2019-09-30T05:06:25.037Z] INFO: Testing against a local daemon
05:06:25 [2019-09-30T05:06:25.037Z] === RUN   TestAuthZPluginAllowRequest
05:06:26 [2019-09-30T05:06:26.936Z] --- PASS: TestAuthZPluginAllowRequest (1.65s)
05:06:26 [2019-09-30T05:06:26.936Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginAllowRequest"
05:06:26 [2019-09-30T05:06:26.936Z] === RUN   TestAuthZPluginTLS
05:06:27 [2019-09-30T05:06:27.385Z] --- PASS: TestAuthZPluginTLS (0.55s)
05:06:27 [2019-09-30T05:06:27.385Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginTLS"
05:06:27 [2019-09-30T05:06:27.385Z] === RUN   TestAuthZPluginDenyRequest
05:06:27 [2019-09-30T05:06:27.784Z] --- PASS: TestAuthZPluginDenyRequest (0.53s)
05:06:27 [2019-09-30T05:06:27.784Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginDenyRequest"
05:06:27 [2019-09-30T05:06:27.784Z] === RUN   TestAuthZPluginAPIDenyResponse
05:06:28 [2019-09-30T05:06:28.558Z] --- PASS: TestAuthZPluginAPIDenyResponse (0.54s)
05:06:28 [2019-09-30T05:06:28.558Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginAPIDenyResponse"
05:06:28 [2019-09-30T05:06:28.558Z] === RUN   TestAuthZPluginDenyResponse
05:06:28 [2019-09-30T05:06:28.936Z] --- PASS: TestAuthZPluginDenyResponse (0.55s)
05:06:28 [2019-09-30T05:06:28.936Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginDenyResponse"
05:06:28 [2019-09-30T05:06:28.936Z] === RUN   TestAuthZPluginAllowEventStream
05:06:30 [2019-09-30T05:06:30.751Z] --- PASS: TestAuthZPluginAllowEventStream (1.69s)
05:06:30 [2019-09-30T05:06:30.751Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginAllowEventStream"
05:06:30 [2019-09-30T05:06:30.751Z] === RUN   TestAuthZPluginErrorResponse
05:06:31 [2019-09-30T05:06:31.113Z] --- PASS: TestAuthZPluginErrorResponse (0.54s)
05:06:31 [2019-09-30T05:06:31.113Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginErrorResponse"
05:06:31 [2019-09-30T05:06:31.113Z] === RUN   TestAuthZPluginErrorRequest
05:06:31 [2019-09-30T05:06:31.885Z] --- PASS: TestAuthZPluginErrorRequest (0.54s)
05:06:31 [2019-09-30T05:06:31.885Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginErrorRequest"
05:06:31 [2019-09-30T05:06:31.885Z] === RUN   TestAuthZPluginEnsureNoDuplicatePluginRegistration
05:06:32 [2019-09-30T05:06:32.262Z] --- PASS: TestAuthZPluginEnsureNoDuplicatePluginRegistration (0.55s)
05:06:32 [2019-09-30T05:06:32.263Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginEnsureNoDuplicatePluginRegistration"
05:06:32 [2019-09-30T05:06:32.263Z] === RUN   TestAuthZPluginEnsureLoadImportWorking
05:06:34 [2019-09-30T05:06:34.826Z] --- PASS: TestAuthZPluginEnsureLoadImportWorking (2.19s)
05:06:34 [2019-09-30T05:06:34.826Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginEnsureLoadImportWorking"
05:06:34 [2019-09-30T05:06:34.826Z] === RUN   TestAuthzPluginEnsureContainerCopyToFrom
05:06:36 [2019-09-30T05:06:36.667Z] --- PASS: TestAuthzPluginEnsureContainerCopyToFrom (2.12s)
05:06:36 [2019-09-30T05:06:36.667Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthzPluginEnsureContainerCopyToFrom"
05:06:36 [2019-09-30T05:06:36.667Z] === RUN   TestAuthZPluginHeader
05:06:37 [2019-09-30T05:06:37.458Z] --- PASS: TestAuthZPluginHeader (0.90s)
05:06:37 [2019-09-30T05:06:37.458Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginHeader"
05:06:37 [2019-09-30T05:06:37.458Z] === RUN   TestAuthZPluginV2AllowNonVolumeRequest
05:06:37 [2019-09-30T05:06:37.458Z] --- SKIP: TestAuthZPluginV2AllowNonVolumeRequest (0.00s)
05:06:37 [2019-09-30T05:06:37.458Z]     authz_plugin_v2_test.go:43: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
05:06:37 [2019-09-30T05:06:37.458Z] === RUN   TestAuthZPluginV2Disable
05:06:37 [2019-09-30T05:06:37.458Z] --- SKIP: TestAuthZPluginV2Disable (0.00s)
05:06:37 [2019-09-30T05:06:37.458Z]     authz_plugin_v2_test.go:65: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
05:06:37 [2019-09-30T05:06:37.458Z] === RUN   TestAuthZPluginV2RejectVolumeRequests
05:06:37 [2019-09-30T05:06:37.458Z] --- SKIP: TestAuthZPluginV2RejectVolumeRequests (0.00s)
05:06:37 [2019-09-30T05:06:37.458Z]     authz_plugin_v2_test.go:91: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
05:06:37 [2019-09-30T05:06:37.458Z] === RUN   TestAuthZPluginV2BadManifestFailsDaemonStart
05:06:37 [2019-09-30T05:06:37.458Z] --- SKIP: TestAuthZPluginV2BadManifestFailsDaemonStart (0.00s)
05:06:37 [2019-09-30T05:06:37.458Z]     authz_plugin_v2_test.go:126: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
05:06:37 [2019-09-30T05:06:37.458Z] === RUN   TestAuthZPluginV2NonexistentFailsDaemonStart
05:06:57 [2019-09-30T05:06:57.231Z] --- PASS: TestAuthZPluginV2NonexistentFailsDaemonStart (16.84s)
05:06:57 [2019-09-30T05:06:57.231Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginV2NonexistentFailsDaemonStart"
05:06:57 [2019-09-30T05:06:57.231Z] PASS
05:06:57 [2019-09-30T05:06:57.231Z] 
05:06:57 [2019-09-30T05:06:57.231Z] === Skipped
05:06:57 [2019-09-30T05:06:57.231Z] === SKIP: s390x.integration.plugin.authz TestAuthZPluginV2AllowNonVolumeRequest (0.00s)
05:06:57 [2019-09-30T05:06:57.231Z]     authz_plugin_v2_test.go:43: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
05:06:57 [2019-09-30T05:06:57.231Z] 
05:06:57 [2019-09-30T05:06:57.231Z] === SKIP: s390x.integration.plugin.authz TestAuthZPluginV2Disable (0.00s)
05:06:57 [2019-09-30T05:06:57.231Z]     authz_plugin_v2_test.go:65: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
05:06:57 [2019-09-30T05:06:57.231Z] 
05:06:57 [2019-09-30T05:06:57.231Z] === SKIP: s390x.integration.plugin.authz TestAuthZPluginV2RejectVolumeRequests (0.00s)
05:06:57 [2019-09-30T05:06:57.231Z]     authz_plugin_v2_test.go:91: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
05:06:57 [2019-09-30T05:06:57.231Z] 
05:06:57 [2019-09-30T05:06:57.231Z] === SKIP: s390x.integration.plugin.authz TestAuthZPluginV2BadManifestFailsDaemonStart (0.00s)
05:06:57 [2019-09-30T05:06:57.231Z]     authz_plugin_v2_test.go:126: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
05:06:57 [2019-09-30T05:06:57.231Z] 
05:06:57 [2019-09-30T05:06:57.231Z] 
05:06:57 [2019-09-30T05:06:57.231Z] DONE 17 tests, 4 skipped in 29.271s
05:06:57 [2019-09-30T05:06:57.231Z] Running /go/src/github.com/docker/docker/integration/plugin/common (s390x.integration.plugin.common) flags=-test.v -test.timeout=120m 
05:06:57 [2019-09-30T05:06:57.231Z] ++ 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
05:06:57 [2019-09-30T05:06:57.231Z] ++ set -e
05:06:57 [2019-09-30T05:06:57.231Z] ++ '[' -n 0 ']'
05:06:57 [2019-09-30T05:06:57.231Z] ++ set -x
05:06:57 [2019-09-30T05:06:57.231Z] ++ 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
05:06:57 [2019-09-30T05:06:57.231Z] INFO: Testing against a local daemon
05:06:57 [2019-09-30T05:06:57.231Z] === RUN   TestPluginInvalidJSON
05:06:57 [2019-09-30T05:06:57.231Z] === RUN   TestPluginInvalidJSON//plugins/foobar/set
05:06:57 [2019-09-30T05:06:57.231Z] === PAUSE TestPluginInvalidJSON//plugins/foobar/set
05:06:57 [2019-09-30T05:06:57.231Z] === CONT  TestPluginInvalidJSON//plugins/foobar/set
05:06:57 [2019-09-30T05:06:57.231Z] --- PASS: TestPluginInvalidJSON (0.03s)
05:06:57 [2019-09-30T05:06:57.231Z]     --- PASS: TestPluginInvalidJSON//plugins/foobar/set (0.00s)
05:06:57 [2019-09-30T05:06:57.231Z] PASS
05:06:57 [2019-09-30T05:06:57.231Z] 
05:06:57 [2019-09-30T05:06:57.231Z] DONE 2 tests in 0.103s
05:06:57 [2019-09-30T05:06:57.231Z] Running /go/src/github.com/docker/docker/integration/plugin/graphdriver (s390x.integration.plugin.graphdriver) flags=-test.v -test.timeout=120m 
05:06:57 [2019-09-30T05:06:57.231Z] ++ 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
05:06:57 [2019-09-30T05:06:57.231Z] ++ set -e
05:06:57 [2019-09-30T05:06:57.231Z] ++ '[' -n 0 ']'
05:06:57 [2019-09-30T05:06:57.231Z] ++ set -x
05:06:57 [2019-09-30T05:06:57.231Z] ++ 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
05:06:57 [2019-09-30T05:06:57.231Z] INFO: Testing against a local daemon
05:06:57 [2019-09-30T05:06:57.231Z] === RUN   TestExternalGraphDriver
05:06:57 [2019-09-30T05:06:57.231Z] === RUN   TestExternalGraphDriver/json
05:06:57 [2019-09-30T05:06:57.231Z] === RUN   TestExternalGraphDriver/spec
05:06:59 [2019-09-30T05:06:59.046Z] === RUN   TestExternalGraphDriver/pull
05:07:01 [2019-09-30T05:07:01.030Z] --- PASS: TestExternalGraphDriver (6.47s)
05:07:01 [2019-09-30T05:07:01.030Z]     external_test.go:57: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestExternalGraphDriver"
05:07:01 [2019-09-30T05:07:01.030Z]     --- PASS: TestExternalGraphDriver/json (2.04s)
05:07:01 [2019-09-30T05:07:01.030Z]     --- PASS: TestExternalGraphDriver/spec (2.07s)
05:07:01 [2019-09-30T05:07:01.030Z]     --- PASS: TestExternalGraphDriver/pull (2.18s)
05:07:01 [2019-09-30T05:07:01.030Z] === RUN   TestGraphdriverPluginV2
05:07:01 [2019-09-30T05:07:01.030Z] --- SKIP: TestGraphdriverPluginV2 (0.06s)
05:07:01 [2019-09-30T05:07:01.030Z]     external_test.go:410: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
05:07:01 [2019-09-30T05:07:01.030Z] PASS
05:07:01 [2019-09-30T05:07:01.030Z] 
05:07:01 [2019-09-30T05:07:01.030Z] === Skipped
05:07:01 [2019-09-30T05:07:01.030Z] === SKIP: s390x.integration.plugin.graphdriver TestGraphdriverPluginV2 (0.06s)
05:07:01 [2019-09-30T05:07:01.030Z]     external_test.go:410: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
05:07:01 [2019-09-30T05:07:01.030Z] 
05:07:01 [2019-09-30T05:07:01.030Z] 
05:07:01 [2019-09-30T05:07:01.030Z] DONE 5 tests, 1 skipped in 6.607s
05:07:01 [2019-09-30T05:07:01.030Z] Running /go/src/github.com/docker/docker/integration/plugin/logging (s390x.integration.plugin.logging) flags=-test.v -test.timeout=120m 
05:07:01 [2019-09-30T05:07:01.030Z] ++ 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
05:07:01 [2019-09-30T05:07:01.030Z] ++ set -e
05:07:01 [2019-09-30T05:07:01.030Z] ++ '[' -n 0 ']'
05:07:01 [2019-09-30T05:07:01.030Z] ++ set -x
05:07:01 [2019-09-30T05:07:01.030Z] ++ 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
05:07:01 [2019-09-30T05:07:01.030Z] INFO: Testing against a local daemon
05:07:01 [2019-09-30T05:07:01.030Z] === RUN   TestContinueAfterPluginCrash
05:07:01 [2019-09-30T05:07:01.030Z] === PAUSE TestContinueAfterPluginCrash
05:07:01 [2019-09-30T05:07:01.030Z] === RUN   TestDaemonStartWithLogOpt
05:07:01 [2019-09-30T05:07:01.030Z] === PAUSE TestDaemonStartWithLogOpt
05:07:01 [2019-09-30T05:07:01.030Z] === CONT  TestContinueAfterPluginCrash
05:07:01 [2019-09-30T05:07:01.030Z] === CONT  TestDaemonStartWithLogOpt
05:07:12 [2019-09-30T05:07:12.572Z] --- PASS: TestDaemonStartWithLogOpt (10.27s)
05:07:12 [2019-09-30T05:07:12.572Z]     validation_test.go:23: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonStartWithLogOpt"
05:07:16 [2019-09-30T05:07:16.579Z] --- PASS: TestContinueAfterPluginCrash (15.23s)
05:07:16 [2019-09-30T05:07:16.579Z]     logging_linux_test.go:22: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestContinueAfterPluginCrash"
05:07:16 [2019-09-30T05:07:16.579Z] PASS
05:07:16 [2019-09-30T05:07:16.579Z] 
05:07:16 [2019-09-30T05:07:16.579Z] DONE 2 tests in 15.316s
05:07:16 [2019-09-30T05:07:16.579Z] Running /go/src/github.com/docker/docker/integration/plugin/volumes (s390x.integration.plugin.volumes) flags=-test.v -test.timeout=120m 
05:07:16 [2019-09-30T05:07:16.579Z] ++ 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
05:07:16 [2019-09-30T05:07:16.579Z] ++ set -e
05:07:16 [2019-09-30T05:07:16.579Z] ++ '[' -n 0 ']'
05:07:16 [2019-09-30T05:07:16.579Z] ++ set -x
05:07:16 [2019-09-30T05:07:16.579Z] ++ 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
05:07:16 [2019-09-30T05:07:16.579Z] INFO: Testing against a local daemon
05:07:16 [2019-09-30T05:07:16.579Z] === RUN   TestPluginWithDevMounts
05:07:16 [2019-09-30T05:07:16.579Z] === PAUSE TestPluginWithDevMounts
05:07:16 [2019-09-30T05:07:16.579Z] === CONT  TestPluginWithDevMounts
05:07:19 [2019-09-30T05:07:19.035Z] --- PASS: TestPluginWithDevMounts (2.11s)
05:07:19 [2019-09-30T05:07:19.035Z]     mounts_test.go:23: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestPluginWithDevMounts"
05:07:19 [2019-09-30T05:07:19.035Z] PASS
05:07:19 [2019-09-30T05:07:19.035Z] 
05:07:19 [2019-09-30T05:07:19.035Z] DONE 1 tests in 2.198s
05:07:19 [2019-09-30T05:07:19.035Z] Running /go/src/github.com/docker/docker/integration/secret (s390x.integration.secret) flags=-test.v -test.timeout=120m 
05:07:19 [2019-09-30T05:07:19.035Z] ++ 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
05:07:19 [2019-09-30T05:07:19.035Z] ++ set -e
05:07:19 [2019-09-30T05:07:19.035Z] ++ '[' -n 0 ']'
05:07:19 [2019-09-30T05:07:19.035Z] ++ set -x
05:07:19 [2019-09-30T05:07:19.035Z] ++ 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
05:07:19 [2019-09-30T05:07:19.035Z] INFO: Testing against a local daemon
05:07:19 [2019-09-30T05:07:19.035Z] === RUN   TestSecretInspect
05:07:20 [2019-09-30T05:07:20.979Z] --- PASS: TestSecretInspect (2.36s)
05:07:20 [2019-09-30T05:07:20.979Z]     secret_test.go:25: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestSecretInspect"
05:07:20 [2019-09-30T05:07:20.979Z] === RUN   TestSecretList
05:07:24 [2019-09-30T05:07:24.199Z] --- PASS: TestSecretList (2.66s)
05:07:24 [2019-09-30T05:07:24.200Z]     secret_test.go:48: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestSecretList"
05:07:24 [2019-09-30T05:07:24.200Z] === RUN   TestSecretsCreateAndDelete
05:07:26 [2019-09-30T05:07:26.010Z] --- PASS: TestSecretsCreateAndDelete (2.42s)
05:07:26 [2019-09-30T05:07:26.010Z]     secret_test.go:125: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestSecretsCreateAndDelete"
05:07:26 [2019-09-30T05:07:26.010Z] === RUN   TestSecretsUpdate
05:07:28 [2019-09-30T05:07:28.501Z] --- PASS: TestSecretsUpdate (2.36s)
05:07:28 [2019-09-30T05:07:28.502Z]     secret_test.go:172: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestSecretsUpdate"
05:07:28 [2019-09-30T05:07:28.502Z] === RUN   TestTemplatedSecret
05:07:32 [2019-09-30T05:07:32.579Z] --- PASS: TestTemplatedSecret (3.50s)
05:07:32 [2019-09-30T05:07:32.579Z]     secret_test.go:221: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestTemplatedSecret"
05:07:32 [2019-09-30T05:07:32.579Z] === RUN   TestSecretCreateResolve
05:07:35 [2019-09-30T05:07:35.016Z] --- PASS: TestSecretCreateResolve (2.92s)
05:07:35 [2019-09-30T05:07:35.016Z]     secret_test.go:342: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestSecretCreateResolve"
05:07:35 [2019-09-30T05:07:35.016Z] PASS
05:07:35 [2019-09-30T05:07:35.016Z] 
05:07:35 [2019-09-30T05:07:35.016Z] DONE 6 tests in 16.312s
05:07:35 [2019-09-30T05:07:35.016Z] Running /go/src/github.com/docker/docker/integration/service (s390x.integration.service) flags=-test.v -test.timeout=120m 
05:07:35 [2019-09-30T05:07:35.016Z] ++ 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
05:07:35 [2019-09-30T05:07:35.016Z] ++ set -e
05:07:35 [2019-09-30T05:07:35.016Z] ++ '[' -n 0 ']'
05:07:35 [2019-09-30T05:07:35.016Z] ++ set -x
05:07:35 [2019-09-30T05:07:35.017Z] ++ 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
05:07:35 [2019-09-30T05:07:35.017Z] INFO: Testing against a local daemon
05:07:35 [2019-09-30T05:07:35.017Z] === RUN   TestServiceCreateInit
05:07:35 [2019-09-30T05:07:35.017Z] === RUN   TestServiceCreateInit/daemonInitDisabled
05:07:40 [2019-09-30T05:07:40.190Z] === RUN   TestServiceCreateInit/daemonInitEnabled
05:07:45 [2019-09-30T05:07:45.235Z] --- PASS: TestServiceCreateInit (10.02s)
05:07:45 [2019-09-30T05:07:45.235Z]     --- PASS: TestServiceCreateInit/daemonInitDisabled (4.96s)
05:07:45 [2019-09-30T05:07:45.235Z]         create_test.go:38: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceCreateInit/daemonInitDisabled"
05:07:45 [2019-09-30T05:07:45.235Z]     --- PASS: TestServiceCreateInit/daemonInitEnabled (5.03s)
05:07:45 [2019-09-30T05:07:45.235Z]         create_test.go:38: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceCreateInit/daemonInitEnabled"
05:07:45 [2019-09-30T05:07:45.235Z] === RUN   TestCreateServiceMultipleTimes
05:08:01 [2019-09-30T05:08:01.710Z] --- PASS: TestCreateServiceMultipleTimes (16.79s)
05:08:01 [2019-09-30T05:08:01.710Z]     create_test.go:80: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceMultipleTimes"
05:08:01 [2019-09-30T05:08:01.710Z] === RUN   TestCreateServiceConflict
05:08:05 [2019-09-30T05:08:05.031Z] --- PASS: TestCreateServiceConflict (2.77s)
05:08:05 [2019-09-30T05:08:05.032Z]     create_test.go:129: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceConflict"
05:08:05 [2019-09-30T05:08:05.032Z] === RUN   TestCreateServiceMaxReplicas
05:08:08 [2019-09-30T05:08:08.230Z] --- PASS: TestCreateServiceMaxReplicas (3.61s)
05:08:08 [2019-09-30T05:08:08.230Z]     create_test.go:150: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceMaxReplicas"
05:08:08 [2019-09-30T05:08:08.230Z] === RUN   TestCreateWithDuplicateNetworkNames
05:08:24 [2019-09-30T05:08:24.780Z] --- PASS: TestCreateWithDuplicateNetworkNames (14.09s)
05:08:24 [2019-09-30T05:08:24.780Z]     create_test.go:171: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateWithDuplicateNetworkNames"
05:08:24 [2019-09-30T05:08:24.780Z] === RUN   TestCreateServiceSecretFileMode
05:08:25 [2019-09-30T05:08:25.571Z] --- PASS: TestCreateServiceSecretFileMode (3.23s)
05:08:25 [2019-09-30T05:08:25.571Z]     create_test.go:224: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceSecretFileMode"
05:08:25 [2019-09-30T05:08:25.571Z] === RUN   TestCreateServiceConfigFileMode
05:08:28 [2019-09-30T05:08:28.966Z] --- PASS: TestCreateServiceConfigFileMode (3.57s)
05:08:28 [2019-09-30T05:08:28.966Z]     create_test.go:288: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceConfigFileMode"
05:08:28 [2019-09-30T05:08:28.966Z] === RUN   TestCreateServiceSysctls
05:08:34 [2019-09-30T05:08:34.011Z] --- PASS: TestCreateServiceSysctls (4.30s)
05:08:34 [2019-09-30T05:08:34.011Z]     create_test.go:378: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceSysctls"
05:08:34 [2019-09-30T05:08:34.011Z] === RUN   TestCreateServiceCapabilities
05:08:36 [2019-09-30T05:08:36.640Z] --- PASS: TestCreateServiceCapabilities (3.29s)
05:08:36 [2019-09-30T05:08:36.640Z]     create_test.go:462: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceCapabilities"
05:08:36 [2019-09-30T05:08:36.640Z] === RUN   TestInspect
05:08:40 [2019-09-30T05:08:40.734Z] --- PASS: TestInspect (3.31s)
05:08:40 [2019-09-30T05:08:40.734Z]     inspect_test.go:23: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestInspect"
05:08:40 [2019-09-30T05:08:40.734Z] === RUN   TestDockerNetworkConnectAlias
05:08:45 [2019-09-30T05:08:45.892Z] --- PASS: TestDockerNetworkConnectAlias (5.70s)
05:08:45 [2019-09-30T05:08:45.892Z]     network_test.go:20: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkConnectAlias"
05:08:45 [2019-09-30T05:08:45.892Z] === RUN   TestDockerNetworkReConnect
05:08:50 [2019-09-30T05:08:50.953Z] --- PASS: TestDockerNetworkReConnect (4.53s)
05:08:50 [2019-09-30T05:08:50.953Z]     network_test.go:82: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkReConnect"
05:08:50 [2019-09-30T05:08:50.953Z] === RUN   TestServicePlugin
05:08:50 [2019-09-30T05:08:50.953Z] --- SKIP: TestServicePlugin (0.00s)
05:08:50 [2019-09-30T05:08:50.953Z]     plugin_test.go:28: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
05:08:50 [2019-09-30T05:08:50.953Z] === RUN   TestServiceUpdateLabel
05:08:53 [2019-09-30T05:08:53.372Z] --- PASS: TestServiceUpdateLabel (2.74s)
05:08:53 [2019-09-30T05:08:53.372Z]     update_test.go:21: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateLabel"
05:08:53 [2019-09-30T05:08:53.372Z] === RUN   TestServiceUpdateSecrets
05:09:10 [2019-09-30T05:09:10.021Z] --- PASS: TestServiceUpdateSecrets (15.16s)
05:09:10 [2019-09-30T05:09:10.021Z]     update_test.go:77: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateSecrets"
05:09:10 [2019-09-30T05:09:10.021Z] === RUN   TestServiceUpdateConfigs
05:09:23 [2019-09-30T05:09:23.673Z] --- PASS: TestServiceUpdateConfigs (15.16s)
05:09:23 [2019-09-30T05:09:23.673Z]     update_test.go:139: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateConfigs"
05:09:23 [2019-09-30T05:09:23.673Z] === RUN   TestServiceUpdateNetwork
05:09:40 [2019-09-30T05:09:40.169Z] --- PASS: TestServiceUpdateNetwork (14.30s)
05:09:40 [2019-09-30T05:09:40.169Z]     update_test.go:201: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateNetwork"
05:09:40 [2019-09-30T05:09:40.169Z] PASS
05:09:40 [2019-09-30T05:09:40.169Z] 
05:09:40 [2019-09-30T05:09:40.169Z] === Skipped
05:09:40 [2019-09-30T05:09:40.169Z] === SKIP: s390x.integration.service TestServicePlugin (0.00s)
05:09:40 [2019-09-30T05:09:40.169Z]     plugin_test.go:28: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
05:09:40 [2019-09-30T05:09:40.169Z] 
05:09:40 [2019-09-30T05:09:40.169Z] 
05:09:40 [2019-09-30T05:09:40.169Z] DONE 19 tests, 1 skipped in 122.680s
05:09:40 [2019-09-30T05:09:40.169Z] Running /go/src/github.com/docker/docker/integration/session (s390x.integration.session) flags=-test.v -test.timeout=120m 
05:09:40 [2019-09-30T05:09:40.169Z] ++ 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
05:09:40 [2019-09-30T05:09:40.169Z] ++ set -e
05:09:40 [2019-09-30T05:09:40.169Z] ++ '[' -n 0 ']'
05:09:40 [2019-09-30T05:09:40.169Z] ++ set -x
05:09:40 [2019-09-30T05:09:40.170Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=s390x DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-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
05:09:40 [2019-09-30T05:09:40.170Z] INFO: Testing against a local daemon
05:09:40 [2019-09-30T05:09:40.170Z] === RUN   TestSessionCreate
05:09:40 [2019-09-30T05:09:40.170Z] --- PASS: TestSessionCreate (0.03s)
05:09:40 [2019-09-30T05:09:40.170Z] === RUN   TestSessionCreateWithBadUpgrade
05:09:40 [2019-09-30T05:09:40.170Z] --- PASS: TestSessionCreateWithBadUpgrade (0.02s)
05:09:40 [2019-09-30T05:09:40.170Z] PASS
05:09:40 [2019-09-30T05:09:40.170Z] 
05:09:40 [2019-09-30T05:09:40.170Z] DONE 2 tests in 0.120s
05:09:40 [2019-09-30T05:09:40.170Z] Running /go/src/github.com/docker/docker/integration/system (s390x.integration.system) flags=-test.v -test.timeout=120m 
05:09:40 [2019-09-30T05:09:40.170Z] ++ 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
05:09:40 [2019-09-30T05:09:40.170Z] ++ set -e
05:09:40 [2019-09-30T05:09:40.170Z] ++ '[' -n 0 ']'
05:09:40 [2019-09-30T05:09:40.170Z] ++ set -x
05:09:40 [2019-09-30T05:09:40.170Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=s390x DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-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
05:09:40 [2019-09-30T05:09:40.170Z] INFO: Testing against a local daemon
05:09:40 [2019-09-30T05:09:40.170Z] === RUN   TestCgroupDriverSystemdMemoryLimit
05:09:40 [2019-09-30T05:09:40.170Z] --- SKIP: TestCgroupDriverSystemdMemoryLimit (0.00s)
05:09:40 [2019-09-30T05:09:40.170Z]     cgroupdriver_systemd_test.go:32: !hasSystemd()
05:09:40 [2019-09-30T05:09:40.170Z] === RUN   TestEventsExecDie
05:09:40 [2019-09-30T05:09:40.170Z] --- PASS: TestEventsExecDie (1.00s)
05:09:40 [2019-09-30T05:09:40.170Z] === RUN   TestEventsBackwardsCompatible
05:09:40 [2019-09-30T05:09:40.170Z] --- PASS: TestEventsBackwardsCompatible (0.12s)
05:09:40 [2019-09-30T05:09:40.170Z] === RUN   TestInfoBinaryCommits
05:09:40 [2019-09-30T05:09:40.170Z] --- PASS: TestInfoBinaryCommits (0.02s)
05:09:40 [2019-09-30T05:09:40.170Z] === RUN   TestInfoAPIVersioned
05:09:40 [2019-09-30T05:09:40.170Z] --- PASS: TestInfoAPIVersioned (0.01s)
05:09:40 [2019-09-30T05:09:40.170Z] === RUN   TestInfoAPI
05:09:40 [2019-09-30T05:09:40.170Z] --- PASS: TestInfoAPI (0.02s)
05:09:40 [2019-09-30T05:09:40.170Z] === RUN   TestInfoAPIWarnings
05:09:40 [2019-09-30T05:09:40.170Z] --- PASS: TestInfoAPIWarnings (0.82s)
05:09:40 [2019-09-30T05:09:40.170Z]     info_test.go:49: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestInfoAPIWarnings"
05:09:40 [2019-09-30T05:09:40.170Z] === RUN   TestLoginFailsWithBadCredentials
05:09:40 [2019-09-30T05:09:40.170Z] --- PASS: TestLoginFailsWithBadCredentials (0.40s)
05:09:40 [2019-09-30T05:09:40.170Z] === RUN   TestPingCacheHeaders
05:09:40 [2019-09-30T05:09:40.170Z] --- PASS: TestPingCacheHeaders (0.03s)
05:09:40 [2019-09-30T05:09:40.170Z] === RUN   TestPingGet
05:09:40 [2019-09-30T05:09:40.170Z] --- PASS: TestPingGet (0.01s)
05:09:40 [2019-09-30T05:09:40.170Z] === RUN   TestPingHead
05:09:40 [2019-09-30T05:09:40.170Z] --- PASS: TestPingHead (0.02s)
05:09:40 [2019-09-30T05:09:40.170Z] === RUN   TestVersion
05:09:40 [2019-09-30T05:09:40.540Z] --- PASS: TestVersion (0.03s)
05:09:40 [2019-09-30T05:09:40.540Z] PASS
05:09:40 [2019-09-30T05:09:40.540Z] 
05:09:40 [2019-09-30T05:09:40.540Z] === Skipped
05:09:40 [2019-09-30T05:09:40.540Z] === SKIP: s390x.integration.system TestCgroupDriverSystemdMemoryLimit (0.00s)
05:09:40 [2019-09-30T05:09:40.540Z]     cgroupdriver_systemd_test.go:32: !hasSystemd()
05:09:40 [2019-09-30T05:09:40.540Z] 
05:09:40 [2019-09-30T05:09:40.540Z] 
05:09:40 [2019-09-30T05:09:40.540Z] DONE 12 tests, 1 skipped in 2.566s
05:09:40 [2019-09-30T05:09:40.540Z] Running /go/src/github.com/docker/docker/integration/volume (s390x.integration.volume) flags=-test.v -test.timeout=120m 
05:09:40 [2019-09-30T05:09:40.540Z] ++ 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
05:09:40 [2019-09-30T05:09:40.540Z] ++ set -e
05:09:40 [2019-09-30T05:09:40.540Z] ++ '[' -n 0 ']'
05:09:40 [2019-09-30T05:09:40.540Z] ++ set -x
05:09:40 [2019-09-30T05:09:40.540Z] ++ 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
05:09:40 [2019-09-30T05:09:40.540Z] INFO: Testing against a local daemon
05:09:40 [2019-09-30T05:09:40.540Z] === RUN   TestVolumesCreateAndList
05:09:40 [2019-09-30T05:09:40.540Z] --- PASS: TestVolumesCreateAndList (0.02s)
05:09:40 [2019-09-30T05:09:40.540Z] === RUN   TestVolumesRemove
05:09:40 [2019-09-30T05:09:40.540Z] --- PASS: TestVolumesRemove (0.09s)
05:09:40 [2019-09-30T05:09:40.540Z] === RUN   TestVolumesInspect
05:09:40 [2019-09-30T05:09:40.540Z] --- PASS: TestVolumesInspect (0.02s)
05:09:40 [2019-09-30T05:09:40.540Z] === RUN   TestVolumesInvalidJSON
05:09:40 [2019-09-30T05:09:40.540Z] === RUN   TestVolumesInvalidJSON//volumes/create
05:09:40 [2019-09-30T05:09:40.540Z] === PAUSE TestVolumesInvalidJSON//volumes/create
05:09:40 [2019-09-30T05:09:40.540Z] === CONT  TestVolumesInvalidJSON//volumes/create
05:09:40 [2019-09-30T05:09:40.540Z] --- PASS: TestVolumesInvalidJSON (0.01s)
05:09:40 [2019-09-30T05:09:40.540Z]     --- PASS: TestVolumesInvalidJSON//volumes/create (0.00s)
05:09:40 [2019-09-30T05:09:40.540Z] PASS
05:09:40 [2019-09-30T05:09:40.540Z] 
05:09:40 [2019-09-30T05:09:40.540Z] DONE 5 tests in 0.246s
05:09:40 [2019-09-30T05:09:40.540Z] ---> Making bundle: .integration-daemon-stop (in bundles/test-integration)
05:09:40 [2019-09-30T05:09:40.904Z] ++++ cat bundles/test-integration/docker.pid
05:09:40 [2019-09-30T05:09:40.904Z] +++ kill 11550
05:09:42 [2019-09-30T05:09:42.165Z] umount: bundles/test-integration/root: mountpoint not found
05:09:42 [2019-09-30T05:09:42.165Z] +++ /etc/init.d/apparmor stop
05:09:42 [2019-09-30T05:09:42.165Z] Clearing AppArmor profiles cache:.
05:09:42 [2019-09-30T05:09:42.165Z] All profile caches have been cleared, but no profiles have been unloaded.
05:09:42 [2019-09-30T05:09:42.165Z] Unloading profiles will leave already running processes permanently
05:09:42 [2019-09-30T05:09:42.165Z] unconfined, which can lead to unexpected situations.
05:09:42 [2019-09-30T05:09:42.165Z] 
05:09:42 [2019-09-30T05:09:42.165Z] To set a process to complain mode, use the command line tool
05:09:42 [2019-09-30T05:09:42.165Z] 'aa-complain'. To really tear down all profiles, run the init script
05:09:42 [2019-09-30T05:09:42.165Z] with the 'teardown' option."
05:09:42 [2019-09-30T05:09:42.165Z]