Status
Console Output
14:22:50 [2019-09-30T14:22:50.175Z] + docker run --rm -t --privileged -v /home/jenkins/workspace/moby_PR-39992/bundles:/go/src/github.com/docker/docker/bundles --name docker-pr3 -e DOCKER_EXPERIMENTAL -e DOCKER_GITCOMMIT=404d87ec6946aaa9c130b64c0c75514a2fcd50c0 -e DOCKER_GRAPHDRIVER -e TESTDEBUG -e TEST_SKIP_INTEGRATION_CLI -e TIMEOUT docker:404d87ec6946aaa9c130b64c0c75514a2fcd50c0 hack/make.sh dynbinary test-integration
14:22:50 [2019-09-30T14:22:50.600Z] 
14:22:50 [2019-09-30T14:22:50.600Z] Removing bundles/
14:22:50 [2019-09-30T14:22:50.600Z] 
14:22:50 [2019-09-30T14:22:50.600Z] ---> Making bundle: dynbinary (in bundles/dynbinary)
14:22:50 [2019-09-30T14:22:50.600Z] Building: bundles/dynbinary-daemon/dockerd-dev
14:22:50 [2019-09-30T14:22:50.600Z] GOOS="" GOARCH="" GOARM=""
14:24:01 [2019-09-30T14:24:01.577Z] Created binary: bundles/dynbinary-daemon/dockerd-dev
14:24:01 [2019-09-30T14:24:01.578Z] 
14:24:01 [2019-09-30T14:24:01.578Z] ---> Making bundle: test-integration (in bundles/test-integration)
14:24:01 [2019-09-30T14:24:01.578Z] PKG_CONFIG=pkg-config
14:24:01 [2019-09-30T14:24:01.578Z] GOLANG_VERSION=1.13.1
14:24:01 [2019-09-30T14:24:01.578Z] HOSTNAME=56b276943085
14:24:01 [2019-09-30T14:24:01.578Z] DOCKER_EXPERIMENTAL=1
14:24:01 [2019-09-30T14:24:01.578Z] container=docker
14:24:01 [2019-09-30T14:24:01.578Z] TEST_SKIP_INTEGRATION_CLI=1
14:24:01 [2019-09-30T14:24:01.578Z] GO111MODULE=off
14:24:01 [2019-09-30T14:24:01.578Z] GOPATH=/go
14:24:01 [2019-09-30T14:24:01.578Z] PWD=/go/src/github.com/docker/docker
14:24:01 [2019-09-30T14:24:01.578Z] HOME=/root
14:24:01 [2019-09-30T14:24:01.578Z] SCRIPTDIR=/go/src/github.com/docker/docker/hack
14:24:01 [2019-09-30T14:24:01.578Z] MAKEDIR=/go/src/github.com/docker/docker/hack/make
14:24:01 [2019-09-30T14:24:01.578Z] DOCKER_GITCOMMIT=404d87ec6946aaa9c130b64c0c75514a2fcd50c0
14:24:01 [2019-09-30T14:24:01.578Z] DOCKER_BUILDTAGS=apparmor seccomp selinux journald
14:24:01 [2019-09-30T14:24:01.578Z] DOCKER_GRAPHDRIVER=overlay2
14:24:01 [2019-09-30T14:24:01.578Z] TERM=xterm
14:24:01 [2019-09-30T14:24:01.578Z] DEST=bundles/test-integration
14:24:01 [2019-09-30T14:24:01.578Z] SHLVL=1
14:24:01 [2019-09-30T14:24:01.578Z] TIMEOUT=120m
14:24:01 [2019-09-30T14:24:01.578Z] PATH=/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
14:24:01 [2019-09-30T14:24:01.578Z] DOCKER_PKG=github.com/docker/docker
14:24:01 [2019-09-30T14:24:01.578Z] TESTDEBUG=0
14:24:01 [2019-09-30T14:24:01.578Z] _=/usr/bin/env
14:24:01 [2019-09-30T14:24:01.578Z] Building test suite binary /go/src/github.com/docker/docker/integration/build/test.main
14:24:36 [2019-09-30T14:24:36.252Z] Building test suite binary /go/src/github.com/docker/docker/integration/config/test.main
14:24:36 [2019-09-30T14:24:36.252Z] Building test suite binary /go/src/github.com/docker/docker/integration/container/test.main
14:24:36 [2019-09-30T14:24:36.634Z] Building test suite binary /go/src/github.com/docker/docker/integration/image/test.main
14:25:00 [2019-09-30T14:25:00.831Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/test.main
14:25:00 [2019-09-30T14:25:00.831Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/ipvlan/test.main
14:25:02 [2019-09-30T14:25:02.214Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/macvlan/test.main
14:25:03 [2019-09-30T14:25:03.605Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/test.main
14:25:04 [2019-09-30T14:25:04.074Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/authz/test.main
14:25:06 [2019-09-30T14:25:06.840Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/common/test.main
14:25:07 [2019-09-30T14:25:07.761Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/graphdriver/test.main
14:25:09 [2019-09-30T14:25:09.734Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/logging/test.main
14:25:12 [2019-09-30T14:25:12.362Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/volumes/test.main
14:25:14 [2019-09-30T14:25:14.453Z] Building test suite binary /go/src/github.com/docker/docker/integration/secret/test.main
14:25:15 [2019-09-30T14:25:15.899Z] Building test suite binary /go/src/github.com/docker/docker/integration/service/test.main
14:25:17 [2019-09-30T14:25:17.800Z] Building test suite binary /go/src/github.com/docker/docker/integration/session/test.main
14:25:19 [2019-09-30T14:25:19.349Z] Building test suite binary /go/src/github.com/docker/docker/integration/system/test.main
14:25:20 [2019-09-30T14:25:20.729Z] Building test suite binary /go/src/github.com/docker/docker/integration/volume/test.main
14:25:22 [2019-09-30T14:25:22.133Z] ---> Making bundle: .integration-daemon-start (in bundles/test-integration)
14:25:22 [2019-09-30T14:25:22.133Z] Using test binary docker
14:25:22 [2019-09-30T14:25:22.133Z] # DOCKER_EXPERIMENTAL is set: starting daemon with experimental features enabled! 
14:25:22 [2019-09-30T14:25:22.133Z] +++ /etc/init.d/apparmor start
14:25:22 [2019-09-30T14:25:22.133Z] /etc/init.d/apparmor: 130: /etc/init.d/apparmor: systemd-detect-virt: not found
14:25:22 [2019-09-30T14:25:22.133Z] Starting AppArmor profiles:Warning from stdin (line 1): /sbin/apparmor_parser: cannot use or update cache, disable, or force-complain via stdin
14:25:22 [2019-09-30T14:25:22.133Z] Warning failed to create cache: (null)
14:25:22 [2019-09-30T14:25:22.133Z] .
14:25:22 [2019-09-30T14:25:22.133Z] Starting dockerd
14:25:22 [2019-09-30T14:25:22.133Z] +++ 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
14:25:22 [2019-09-30T14:25:22.133Z] INFO: Waiting for daemon to start...
14:25:24 [2019-09-30T14:25:24.644Z] .
14:25:24 [2019-09-30T14:25:24.644Z] ---> Making bundle: .integration-daemon-setup (in bundles/test-integration)
14:25:24 [2019-09-30T14:25:24.644Z] ---> Making bundle: .ensure-emptyfs (in bundles/test-integration)
14:25:24 [2019-09-30T14:25:24.644Z] Error: No such image: emptyfs
14:25:24 [2019-09-30T14:25:24.644Z] ++++ docker load
14:25:24 [2019-09-30T14:25:24.644Z] ++++ tar -cC bundles/test-integration/emptyfs .
14:25:24 [2019-09-30T14:25:24.644Z] Running integration-test (iteration 1)
14:25:24 [2019-09-30T14:25:24.644Z] Running /go/src/github.com/docker/docker/integration/build (s390x.integration.build) flags=-test.v -test.timeout=120m 
14:25:24 [2019-09-30T14:25:24.644Z] ++ 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
14:25:24 [2019-09-30T14:25:24.644Z] ++ set -e
14:25:24 [2019-09-30T14:25:24.644Z] ++ '[' -n 0 ']'
14:25:24 [2019-09-30T14:25:24.644Z] ++ set -x
14:25:24 [2019-09-30T14:25:24.644Z] ++ 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
14:25:36 [2019-09-30T14:25:36.417Z] Loaded image: buildpack-deps:jessie
14:25:36 [2019-09-30T14:25:36.417Z] Loaded image: busybox:latest
14:25:36 [2019-09-30T14:25:36.417Z] Loaded image: busybox:glibc
14:25:36 [2019-09-30T14:25:36.417Z] Loaded image: debian:jessie
14:25:36 [2019-09-30T14:25:36.417Z] Loaded image: hello-world:latest
14:25:36 [2019-09-30T14:25:36.417Z] INFO: Testing against a local daemon
14:25:36 [2019-09-30T14:25:36.417Z] === RUN   TestCgroupNamespacesBuild
14:25:37 [2019-09-30T14:25:37.710Z] --- PASS: TestCgroupNamespacesBuild (1.89s)
14:25:37 [2019-09-30T14:25:37.710Z]     build_cgroupns_linux_test.go:42: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesBuild"
14:25:37 [2019-09-30T14:25:37.710Z] === RUN   TestCgroupNamespacesBuildDaemonHostMode
14:25:39 [2019-09-30T14:25:39.717Z] --- PASS: TestCgroupNamespacesBuildDaemonHostMode (2.33s)
14:25:39 [2019-09-30T14:25:39.717Z]     build_cgroupns_linux_test.go:42: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesBuildDaemonHostMode"
14:25:39 [2019-09-30T14:25:39.717Z] === RUN   TestBuildWithSession
14:25:43 [2019-09-30T14:25:43.069Z] --- PASS: TestBuildWithSession (2.88s)
14:25:43 [2019-09-30T14:25:43.069Z] === RUN   TestBuildSquashParent
14:25:49 [2019-09-30T14:25:49.543Z] --- PASS: TestBuildSquashParent (6.34s)
14:25:49 [2019-09-30T14:25:49.543Z] === RUN   TestBuildWithRemoveAndForceRemove
14:25:49 [2019-09-30T14:25:49.543Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
14:25:49 [2019-09-30T14:25:49.543Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
14:25:49 [2019-09-30T14:25:49.543Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_remove
14:25:49 [2019-09-30T14:25:49.543Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_remove
14:25:49 [2019-09-30T14:25:49.543Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
14:25:49 [2019-09-30T14:25:49.543Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
14:25:49 [2019-09-30T14:25:49.543Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
14:25:49 [2019-09-30T14:25:49.543Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
14:25:49 [2019-09-30T14:25:49.543Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_remove
14:25:49 [2019-09-30T14:25:49.543Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_remove
14:25:49 [2019-09-30T14:25:49.543Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
14:25:49 [2019-09-30T14:25:49.543Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
14:25:49 [2019-09-30T14:25:49.543Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
14:25:49 [2019-09-30T14:25:49.543Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
14:25:52 [2019-09-30T14:25:52.246Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_remove
14:25:52 [2019-09-30T14:25:52.246Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
14:25:54 [2019-09-30T14:25:54.816Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
14:25:54 [2019-09-30T14:25:54.816Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_remove
14:25:58 [2019-09-30T14:25:58.225Z] --- PASS: TestBuildWithRemoveAndForceRemove (0.01s)
14:25:58 [2019-09-30T14:25:58.225Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal (2.95s)
14:25:58 [2019-09-30T14:25:58.225Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove (2.99s)
14:25:58 [2019-09-30T14:25:58.225Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_remove (2.86s)
14:25:58 [2019-09-30T14:25:58.225Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal (2.87s)
14:25:58 [2019-09-30T14:25:58.225Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove (3.17s)
14:25:58 [2019-09-30T14:25:58.225Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_remove (3.22s)
14:25:58 [2019-09-30T14:25:58.225Z] === RUN   TestBuildMultiStageCopy
14:25:58 [2019-09-30T14:25:58.225Z] === RUN   TestBuildMultiStageCopy/copy_to_root
14:26:02 [2019-09-30T14:26:02.407Z] === RUN   TestBuildMultiStageCopy/copy_to_newdir
14:26:02 [2019-09-30T14:26:02.790Z] === RUN   TestBuildMultiStageCopy/copy_to_newdir_nested
14:26:03 [2019-09-30T14:26:03.614Z] === RUN   TestBuildMultiStageCopy/copy_to_existingdir
14:26:04 [2019-09-30T14:26:04.423Z] === RUN   TestBuildMultiStageCopy/copy_to_newsubdir
14:26:06 [2019-09-30T14:26:06.431Z] --- PASS: TestBuildMultiStageCopy (8.29s)
14:26:06 [2019-09-30T14:26:06.431Z]     --- PASS: TestBuildMultiStageCopy/copy_to_root (4.24s)
14:26:06 [2019-09-30T14:26:06.431Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newdir (0.48s)
14:26:06 [2019-09-30T14:26:06.431Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newdir_nested (0.79s)
14:26:06 [2019-09-30T14:26:06.431Z]     --- PASS: TestBuildMultiStageCopy/copy_to_existingdir (0.71s)
14:26:06 [2019-09-30T14:26:06.431Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newsubdir (2.07s)
14:26:06 [2019-09-30T14:26:06.431Z] === RUN   TestBuildMultiStageParentConfig
14:26:08 [2019-09-30T14:26:08.290Z] --- PASS: TestBuildMultiStageParentConfig (1.78s)
14:26:08 [2019-09-30T14:26:08.290Z] === RUN   TestBuildLabelWithTargets
14:26:12 [2019-09-30T14:26:12.436Z] --- PASS: TestBuildLabelWithTargets (4.28s)
14:26:12 [2019-09-30T14:26:12.436Z] === RUN   TestBuildWithEmptyLayers
14:26:13 [2019-09-30T14:26:13.765Z] --- PASS: TestBuildWithEmptyLayers (1.02s)
14:26:13 [2019-09-30T14:26:13.765Z] === RUN   TestBuildMultiStageOnBuild
14:26:17 [2019-09-30T14:26:17.952Z] --- PASS: TestBuildMultiStageOnBuild (3.87s)
14:26:17 [2019-09-30T14:26:17.952Z] === RUN   TestBuildUncleanTarFilenames
14:26:18 [2019-09-30T14:26:18.781Z] --- PASS: TestBuildUncleanTarFilenames (1.34s)
14:26:18 [2019-09-30T14:26:18.781Z] === RUN   TestBuildMultiStageLayerLeak
14:26:23 [2019-09-30T14:26:23.141Z] --- PASS: TestBuildMultiStageLayerLeak (4.44s)
14:26:23 [2019-09-30T14:26:23.141Z] === RUN   TestBuildWithHugeFile
14:26:57 [2019-09-30T14:26:57.700Z] --- PASS: TestBuildWithHugeFile (32.14s)
14:26:57 [2019-09-30T14:26:57.700Z] === RUN   TestBuildWithEmptyDockerfile
14:26:57 [2019-09-30T14:26:57.700Z] === RUN   TestBuildWithEmptyDockerfile/empty-dockerfile
14:26:57 [2019-09-30T14:26:57.700Z] === PAUSE TestBuildWithEmptyDockerfile/empty-dockerfile
14:26:57 [2019-09-30T14:26:57.700Z] === RUN   TestBuildWithEmptyDockerfile/empty-lines-dockerfile
14:26:57 [2019-09-30T14:26:57.700Z] === PAUSE TestBuildWithEmptyDockerfile/empty-lines-dockerfile
14:26:57 [2019-09-30T14:26:57.700Z] === RUN   TestBuildWithEmptyDockerfile/comment-only-dockerfile
14:26:57 [2019-09-30T14:26:57.700Z] === PAUSE TestBuildWithEmptyDockerfile/comment-only-dockerfile
14:26:57 [2019-09-30T14:26:57.700Z] === CONT  TestBuildWithEmptyDockerfile/empty-dockerfile
14:26:57 [2019-09-30T14:26:57.700Z] === CONT  TestBuildWithEmptyDockerfile/comment-only-dockerfile
14:26:57 [2019-09-30T14:26:57.700Z] === CONT  TestBuildWithEmptyDockerfile/empty-lines-dockerfile
14:26:57 [2019-09-30T14:26:57.700Z] --- PASS: TestBuildWithEmptyDockerfile (0.20s)
14:26:57 [2019-09-30T14:26:57.700Z]     --- PASS: TestBuildWithEmptyDockerfile/comment-only-dockerfile (0.22s)
14:26:57 [2019-09-30T14:26:57.700Z]     --- PASS: TestBuildWithEmptyDockerfile/empty-dockerfile (0.23s)
14:26:57 [2019-09-30T14:26:57.700Z]     --- PASS: TestBuildWithEmptyDockerfile/empty-lines-dockerfile (0.11s)
14:26:57 [2019-09-30T14:26:57.700Z] === RUN   TestBuildPreserveOwnership
14:26:57 [2019-09-30T14:26:57.700Z] === RUN   TestBuildPreserveOwnership/copy_from
14:27:00 [2019-09-30T14:27:00.219Z] === RUN   TestBuildPreserveOwnership/copy_from_chowned
14:27:02 [2019-09-30T14:27:02.312Z] --- PASS: TestBuildPreserveOwnership (6.68s)
14:27:02 [2019-09-30T14:27:02.312Z]     --- PASS: TestBuildPreserveOwnership/copy_from (4.23s)
14:27:02 [2019-09-30T14:27:02.312Z]     --- PASS: TestBuildPreserveOwnership/copy_from_chowned (2.41s)
14:27:02 [2019-09-30T14:27:02.312Z] === RUN   TestBuildPlatformInvalid
14:27:02 [2019-09-30T14:27:02.684Z] --- PASS: TestBuildPlatformInvalid (0.16s)
14:27:02 [2019-09-30T14:27:02.684Z] PASS
14:27:02 [2019-09-30T14:27:02.684Z] 
14:27:02 [2019-09-30T14:27:02.684Z] DONE 32 tests in 98.026s
14:27:02 [2019-09-30T14:27:02.684Z] Running /go/src/github.com/docker/docker/integration/config (s390x.integration.config) flags=-test.v -test.timeout=120m 
14:27:02 [2019-09-30T14:27:02.684Z] ++ 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
14:27:02 [2019-09-30T14:27:02.684Z] ++ set -e
14:27:02 [2019-09-30T14:27:02.684Z] ++ '[' -n 0 ']'
14:27:02 [2019-09-30T14:27:02.684Z] ++ set -x
14:27:02 [2019-09-30T14:27:02.684Z] ++ 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
14:27:03 [2019-09-30T14:27:03.054Z] INFO: Testing against a local daemon
14:27:03 [2019-09-30T14:27:03.054Z] === RUN   TestConfigList
14:27:06 [2019-09-30T14:27:06.316Z] --- PASS: TestConfigList (3.16s)
14:27:06 [2019-09-30T14:27:06.317Z]     config_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigList"
14:27:06 [2019-09-30T14:27:06.317Z] === RUN   TestConfigsCreateAndDelete
14:27:09 [2019-09-30T14:27:09.827Z] --- PASS: TestConfigsCreateAndDelete (3.02s)
14:27:09 [2019-09-30T14:27:09.828Z]     config_test.go:112: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigsCreateAndDelete"
14:27:09 [2019-09-30T14:27:09.828Z] === RUN   TestConfigsUpdate
14:27:12 [2019-09-30T14:27:12.296Z] --- PASS: TestConfigsUpdate (2.96s)
14:27:12 [2019-09-30T14:27:12.296Z]     config_test.go:140: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigsUpdate"
14:27:12 [2019-09-30T14:27:12.296Z] === RUN   TestTemplatedConfig
14:27:15 [2019-09-30T14:27:15.588Z] --- PASS: TestTemplatedConfig (3.60s)
14:27:15 [2019-09-30T14:27:15.588Z]     config_test.go:192: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestTemplatedConfig"
14:27:15 [2019-09-30T14:27:15.588Z] === RUN   TestConfigInspect
14:27:18 [2019-09-30T14:27:18.884Z] --- PASS: TestConfigInspect (3.08s)
14:27:18 [2019-09-30T14:27:18.884Z]     config_test.go:326: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigInspect"
14:27:18 [2019-09-30T14:27:18.884Z] === RUN   TestConfigCreateWithLabels
14:27:22 [2019-09-30T14:27:22.168Z] --- PASS: TestConfigCreateWithLabels (3.00s)
14:27:22 [2019-09-30T14:27:22.168Z]     config_test.go:350: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigCreateWithLabels"
14:27:22 [2019-09-30T14:27:22.168Z] === RUN   TestConfigCreateResolve
14:27:24 [2019-09-30T14:27:24.778Z] --- PASS: TestConfigCreateResolve (3.04s)
14:27:24 [2019-09-30T14:27:24.778Z]     config_test.go:377: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigCreateResolve"
14:27:24 [2019-09-30T14:27:24.778Z] === RUN   TestConfigDaemonLibtrustID
14:27:25 [2019-09-30T14:27:25.662Z] --- PASS: TestConfigDaemonLibtrustID (0.54s)
14:27:25 [2019-09-30T14:27:25.662Z]     config_test.go:427: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigDaemonLibtrustID"
14:27:25 [2019-09-30T14:27:25.662Z] PASS
14:27:25 [2019-09-30T14:27:25.662Z] 
14:27:25 [2019-09-30T14:27:25.662Z] DONE 8 tests in 22.609s
14:27:25 [2019-09-30T14:27:25.662Z] Running /go/src/github.com/docker/docker/integration/container (s390x.integration.container) flags=-test.v -test.timeout=120m 
14:27:25 [2019-09-30T14:27:25.663Z] ++ 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
14:27:25 [2019-09-30T14:27:25.663Z] ++ set -e
14:27:25 [2019-09-30T14:27:25.663Z] ++ '[' -n 0 ']'
14:27:25 [2019-09-30T14:27:25.663Z] ++ set -x
14:27:25 [2019-09-30T14:27:25.663Z] ++ 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
14:27:25 [2019-09-30T14:27:25.663Z] INFO: Testing against a local daemon
14:27:25 [2019-09-30T14:27:25.663Z] === RUN   TestCheckpoint
14:27:25 [2019-09-30T14:27:25.663Z] --- SKIP: TestCheckpoint (0.00s)
14:27:25 [2019-09-30T14:27:25.663Z]     checkpoint_test.go:33: TestCheckpoint is broken; see https://github.com/moby/moby/issues/38963
14:27:25 [2019-09-30T14:27:25.663Z] === RUN   TestContainerInvalidJSON
14:27:25 [2019-09-30T14:27:25.663Z] === RUN   TestContainerInvalidJSON//containers/foobar/copy
14:27:25 [2019-09-30T14:27:25.663Z] === PAUSE TestContainerInvalidJSON//containers/foobar/copy
14:27:25 [2019-09-30T14:27:25.663Z] === RUN   TestContainerInvalidJSON//containers/foobar/exec
14:27:25 [2019-09-30T14:27:25.663Z] === PAUSE TestContainerInvalidJSON//containers/foobar/exec
14:27:25 [2019-09-30T14:27:25.663Z] === RUN   TestContainerInvalidJSON//exec/foobar/start
14:27:25 [2019-09-30T14:27:25.663Z] === PAUSE TestContainerInvalidJSON//exec/foobar/start
14:27:25 [2019-09-30T14:27:25.663Z] === CONT  TestContainerInvalidJSON//containers/foobar/copy
14:27:25 [2019-09-30T14:27:25.663Z] === CONT  TestContainerInvalidJSON//exec/foobar/start
14:27:25 [2019-09-30T14:27:25.663Z] === CONT  TestContainerInvalidJSON//containers/foobar/exec
14:27:25 [2019-09-30T14:27:25.663Z] --- PASS: TestContainerInvalidJSON (0.01s)
14:27:25 [2019-09-30T14:27:25.663Z]     --- PASS: TestContainerInvalidJSON//containers/foobar/copy (0.00s)
14:27:25 [2019-09-30T14:27:25.663Z]     --- PASS: TestContainerInvalidJSON//exec/foobar/start (0.00s)
14:27:25 [2019-09-30T14:27:25.663Z]     --- PASS: TestContainerInvalidJSON//containers/foobar/exec (0.00s)
14:27:25 [2019-09-30T14:27:25.663Z] === RUN   TestCopyFromContainerPathDoesNotExist
14:27:25 [2019-09-30T14:27:25.663Z] --- PASS: TestCopyFromContainerPathDoesNotExist (0.14s)
14:27:25 [2019-09-30T14:27:25.663Z] === RUN   TestCopyFromContainerPathIsNotDir
14:27:26 [2019-09-30T14:27:26.060Z] --- PASS: TestCopyFromContainerPathIsNotDir (0.15s)
14:27:26 [2019-09-30T14:27:26.060Z] === RUN   TestCopyToContainerPathDoesNotExist
14:27:26 [2019-09-30T14:27:26.060Z] --- PASS: TestCopyToContainerPathDoesNotExist (0.11s)
14:27:26 [2019-09-30T14:27:26.060Z] === RUN   TestCopyToContainerPathIsNotDir
14:27:26 [2019-09-30T14:27:26.060Z] --- PASS: TestCopyToContainerPathIsNotDir (0.13s)
14:27:26 [2019-09-30T14:27:26.060Z] === RUN   TestCopyFromContainer
14:27:28 [2019-09-30T14:27:28.603Z] === RUN   TestCopyFromContainer//
14:27:28 [2019-09-30T14:27:28.603Z] === RUN   TestCopyFromContainer//bar/root
14:27:28 [2019-09-30T14:27:28.603Z] === RUN   TestCopyFromContainer//bar/root/
14:27:28 [2019-09-30T14:27:28.603Z] === RUN   TestCopyFromContainer/bar/quux
14:27:28 [2019-09-30T14:27:28.603Z] === RUN   TestCopyFromContainer/bar/quux/
14:27:28 [2019-09-30T14:27:28.603Z] === RUN   TestCopyFromContainer/bar/quux/baz
14:27:28 [2019-09-30T14:27:28.603Z] === RUN   TestCopyFromContainer/bar/filesymlink
14:27:28 [2019-09-30T14:27:28.991Z] === RUN   TestCopyFromContainer/bar/dirsymlink
14:27:28 [2019-09-30T14:27:28.991Z] === RUN   TestCopyFromContainer/bar/dirsymlink/
14:27:28 [2019-09-30T14:27:28.991Z] === RUN   TestCopyFromContainer/bar/notarget
14:27:28 [2019-09-30T14:27:28.991Z] --- PASS: TestCopyFromContainer (2.87s)
14:27:28 [2019-09-30T14:27:28.991Z]     --- PASS: TestCopyFromContainer// (0.07s)
14:27:28 [2019-09-30T14:27:28.991Z]     --- PASS: TestCopyFromContainer//bar/root (0.10s)
14:27:28 [2019-09-30T14:27:28.991Z]     --- PASS: TestCopyFromContainer//bar/root/ (0.06s)
14:27:28 [2019-09-30T14:27:28.991Z]     --- PASS: TestCopyFromContainer/bar/quux (0.10s)
14:27:28 [2019-09-30T14:27:28.991Z]     --- PASS: TestCopyFromContainer/bar/quux/ (0.08s)
14:27:28 [2019-09-30T14:27:28.991Z]     --- PASS: TestCopyFromContainer/bar/quux/baz (0.09s)
14:27:28 [2019-09-30T14:27:28.991Z]     --- PASS: TestCopyFromContainer/bar/filesymlink (0.11s)
14:27:28 [2019-09-30T14:27:28.991Z]     --- PASS: TestCopyFromContainer/bar/dirsymlink (0.08s)
14:27:28 [2019-09-30T14:27:28.991Z]     --- PASS: TestCopyFromContainer/bar/dirsymlink/ (0.06s)
14:27:28 [2019-09-30T14:27:28.991Z]     --- PASS: TestCopyFromContainer/bar/notarget (0.07s)
14:27:28 [2019-09-30T14:27:28.991Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist
14:27:28 [2019-09-30T14:27:28.991Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
14:27:28 [2019-09-30T14:27:28.991Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
14:27:28 [2019-09-30T14:27:28.991Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
14:27:28 [2019-09-30T14:27:28.991Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
14:27:28 [2019-09-30T14:27:28.991Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/digest
14:27:28 [2019-09-30T14:27:28.991Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/digest
14:27:28 [2019-09-30T14:27:28.991Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
14:27:28 [2019-09-30T14:27:28.991Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/digest
14:27:28 [2019-09-30T14:27:28.991Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
14:27:28 [2019-09-30T14:27:28.991Z] --- PASS: TestCreateFailsWhenIdentifierDoesNotExist (0.01s)
14:27:28 [2019-09-30T14:27:28.991Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag (0.00s)
14:27:28 [2019-09-30T14:27:28.991Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag (0.00s)
14:27:28 [2019-09-30T14:27:28.991Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/digest (0.01s)
14:27:28 [2019-09-30T14:27:28.991Z] === RUN   TestCreateLinkToNonExistingContainer
14:27:28 [2019-09-30T14:27:28.991Z] --- PASS: TestCreateLinkToNonExistingContainer (0.05s)
14:27:28 [2019-09-30T14:27:28.991Z] === RUN   TestCreateWithInvalidEnv
14:27:28 [2019-09-30T14:27:28.991Z] === RUN   TestCreateWithInvalidEnv/0
14:27:28 [2019-09-30T14:27:28.991Z] === PAUSE TestCreateWithInvalidEnv/0
14:27:28 [2019-09-30T14:27:28.991Z] === RUN   TestCreateWithInvalidEnv/1
14:27:28 [2019-09-30T14:27:28.991Z] === PAUSE TestCreateWithInvalidEnv/1
14:27:28 [2019-09-30T14:27:28.991Z] === RUN   TestCreateWithInvalidEnv/2
14:27:28 [2019-09-30T14:27:28.991Z] === PAUSE TestCreateWithInvalidEnv/2
14:27:28 [2019-09-30T14:27:28.991Z] === CONT  TestCreateWithInvalidEnv/0
14:27:28 [2019-09-30T14:27:28.991Z] === CONT  TestCreateWithInvalidEnv/2
14:27:28 [2019-09-30T14:27:28.991Z] === CONT  TestCreateWithInvalidEnv/1
14:27:28 [2019-09-30T14:27:28.991Z] --- PASS: TestCreateWithInvalidEnv (0.03s)
14:27:28 [2019-09-30T14:27:28.991Z]     --- PASS: TestCreateWithInvalidEnv/2 (0.00s)
14:27:28 [2019-09-30T14:27:28.991Z]     --- PASS: TestCreateWithInvalidEnv/1 (0.00s)
14:27:28 [2019-09-30T14:27:28.991Z]     --- PASS: TestCreateWithInvalidEnv/0 (0.00s)
14:27:28 [2019-09-30T14:27:28.991Z] === RUN   TestCreateTmpfsMountsTarget
14:27:28 [2019-09-30T14:27:28.991Z] --- PASS: TestCreateTmpfsMountsTarget (0.02s)
14:27:28 [2019-09-30T14:27:28.991Z] === RUN   TestCreateWithCustomMaskedPaths
14:27:31 [2019-09-30T14:27:31.542Z] --- PASS: TestCreateWithCustomMaskedPaths (2.48s)
14:27:31 [2019-09-30T14:27:31.542Z] === RUN   TestCreateWithCapabilities
14:27:31 [2019-09-30T14:27:31.542Z] === RUN   TestCreateWithCapabilities/no_capabilities
14:27:31 [2019-09-30T14:27:31.542Z] === PAUSE TestCreateWithCapabilities/no_capabilities
14:27:31 [2019-09-30T14:27:31.542Z] === RUN   TestCreateWithCapabilities/empty_capabilities
14:27:31 [2019-09-30T14:27:31.542Z] === PAUSE TestCreateWithCapabilities/empty_capabilities
14:27:31 [2019-09-30T14:27:31.542Z] === RUN   TestCreateWithCapabilities/valid_capabilities
14:27:31 [2019-09-30T14:27:31.542Z] === PAUSE TestCreateWithCapabilities/valid_capabilities
14:27:31 [2019-09-30T14:27:31.542Z] === RUN   TestCreateWithCapabilities/invalid_capabilities
14:27:31 [2019-09-30T14:27:31.542Z] === PAUSE TestCreateWithCapabilities/invalid_capabilities
14:27:31 [2019-09-30T14:27:31.542Z] === RUN   TestCreateWithCapabilities/duplicate_capabilities
14:27:31 [2019-09-30T14:27:31.542Z] === PAUSE TestCreateWithCapabilities/duplicate_capabilities
14:27:31 [2019-09-30T14:27:31.542Z] === RUN   TestCreateWithCapabilities/capabilities_API_v1.39
14:27:31 [2019-09-30T14:27:31.542Z] === PAUSE TestCreateWithCapabilities/capabilities_API_v1.39
14:27:31 [2019-09-30T14:27:31.542Z] === RUN   TestCreateWithCapabilities/empty_capadd
14:27:31 [2019-09-30T14:27:31.542Z] === PAUSE TestCreateWithCapabilities/empty_capadd
14:27:31 [2019-09-30T14:27:31.542Z] === RUN   TestCreateWithCapabilities/empty_capdrop
14:27:31 [2019-09-30T14:27:31.542Z] === PAUSE TestCreateWithCapabilities/empty_capdrop
14:27:31 [2019-09-30T14:27:31.542Z] === RUN   TestCreateWithCapabilities/capadd_capdrop
14:27:31 [2019-09-30T14:27:31.542Z] === PAUSE TestCreateWithCapabilities/capadd_capdrop
14:27:31 [2019-09-30T14:27:31.542Z] === RUN   TestCreateWithCapabilities/conflict_with_capadd
14:27:31 [2019-09-30T14:27:31.542Z] === PAUSE TestCreateWithCapabilities/conflict_with_capadd
14:27:31 [2019-09-30T14:27:31.542Z] === RUN   TestCreateWithCapabilities/conflict_with_capdrop
14:27:31 [2019-09-30T14:27:31.542Z] === PAUSE TestCreateWithCapabilities/conflict_with_capdrop
14:27:31 [2019-09-30T14:27:31.542Z] === CONT  TestCreateWithCapabilities/no_capabilities
14:27:31 [2019-09-30T14:27:31.542Z] === CONT  TestCreateWithCapabilities/conflict_with_capdrop
14:27:31 [2019-09-30T14:27:31.542Z] === CONT  TestCreateWithCapabilities/conflict_with_capadd
14:27:31 [2019-09-30T14:27:31.542Z] === CONT  TestCreateWithCapabilities/capadd_capdrop
14:27:32 [2019-09-30T14:27:32.088Z] === CONT  TestCreateWithCapabilities/empty_capdrop
14:27:32 [2019-09-30T14:27:32.088Z] === CONT  TestCreateWithCapabilities/empty_capadd
14:27:32 [2019-09-30T14:27:32.088Z] === CONT  TestCreateWithCapabilities/capabilities_API_v1.39
14:27:32 [2019-09-30T14:27:32.088Z] === CONT  TestCreateWithCapabilities/duplicate_capabilities
14:27:32 [2019-09-30T14:27:32.088Z] === CONT  TestCreateWithCapabilities/invalid_capabilities
14:27:32 [2019-09-30T14:27:32.088Z] === CONT  TestCreateWithCapabilities/valid_capabilities
14:27:32 [2019-09-30T14:27:32.088Z] === CONT  TestCreateWithCapabilities/empty_capabilities
14:27:32 [2019-09-30T14:27:32.088Z] --- PASS: TestCreateWithCapabilities (0.03s)
14:27:32 [2019-09-30T14:27:32.088Z]     --- PASS: TestCreateWithCapabilities/conflict_with_capdrop (0.00s)
14:27:32 [2019-09-30T14:27:32.088Z]     --- PASS: TestCreateWithCapabilities/conflict_with_capadd (0.00s)
14:27:32 [2019-09-30T14:27:32.088Z]     --- PASS: TestCreateWithCapabilities/no_capabilities (0.10s)
14:27:32 [2019-09-30T14:27:32.088Z]     --- PASS: TestCreateWithCapabilities/capadd_capdrop (0.09s)
14:27:32 [2019-09-30T14:27:32.088Z]     --- PASS: TestCreateWithCapabilities/empty_capdrop (0.07s)
14:27:32 [2019-09-30T14:27:32.088Z]     --- PASS: TestCreateWithCapabilities/empty_capadd (0.07s)
14:27:32 [2019-09-30T14:27:32.088Z]     --- PASS: TestCreateWithCapabilities/capabilities_API_v1.39 (0.09s)
14:27:32 [2019-09-30T14:27:32.088Z]     --- PASS: TestCreateWithCapabilities/invalid_capabilities (0.00s)
14:27:32 [2019-09-30T14:27:32.088Z]     --- PASS: TestCreateWithCapabilities/duplicate_capabilities (0.09s)
14:27:32 [2019-09-30T14:27:32.088Z]     --- PASS: TestCreateWithCapabilities/empty_capabilities (0.10s)
14:27:32 [2019-09-30T14:27:32.088Z]     --- PASS: TestCreateWithCapabilities/valid_capabilities (0.11s)
14:27:32 [2019-09-30T14:27:32.088Z] === RUN   TestCreateWithCustomReadonlyPaths
14:27:35 [2019-09-30T14:27:35.565Z] --- PASS: TestCreateWithCustomReadonlyPaths (2.96s)
14:27:35 [2019-09-30T14:27:35.565Z] === RUN   TestCreateWithInvalidHealthcheckParams
14:27:35 [2019-09-30T14:27:35.565Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
14:27:35 [2019-09-30T14:27:35.565Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
14:27:35 [2019-09-30T14:27:35.565Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
14:27:35 [2019-09-30T14:27:35.565Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
14:27:35 [2019-09-30T14:27:35.565Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
14:27:35 [2019-09-30T14:27:35.565Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
14:27:35 [2019-09-30T14:27:35.565Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
14:27:35 [2019-09-30T14:27:35.565Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
14:27:35 [2019-09-30T14:27:35.566Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
14:27:35 [2019-09-30T14:27:35.566Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
14:27:35 [2019-09-30T14:27:35.566Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
14:27:35 [2019-09-30T14:27:35.566Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
14:27:35 [2019-09-30T14:27:35.566Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
14:27:35 [2019-09-30T14:27:35.566Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
14:27:35 [2019-09-30T14:27:35.566Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
14:27:35 [2019-09-30T14:27:35.566Z] --- PASS: TestCreateWithInvalidHealthcheckParams (0.03s)
14:27:35 [2019-09-30T14:27:35.566Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms (0.01s)
14:27:35 [2019-09-30T14:27:35.566Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s (0.01s)
14:27:35 [2019-09-30T14:27:35.566Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0 (0.01s)
14:27:35 [2019-09-30T14:27:35.566Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms (0.01s)
14:27:35 [2019-09-30T14:27:35.566Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms (0.01s)
14:27:35 [2019-09-30T14:27:35.566Z] === RUN   TestContainerStartOnDaemonRestart
14:27:35 [2019-09-30T14:27:35.566Z] === PAUSE TestContainerStartOnDaemonRestart
14:27:35 [2019-09-30T14:27:35.566Z] === RUN   TestDaemonRestartIpcMode
14:27:35 [2019-09-30T14:27:35.566Z] === PAUSE TestDaemonRestartIpcMode
14:27:35 [2019-09-30T14:27:35.566Z] === RUN   TestDiff
14:27:35 [2019-09-30T14:27:35.947Z] --- PASS: TestDiff (0.82s)
14:27:35 [2019-09-30T14:27:35.947Z] === RUN   TestExecWithCloseStdin
14:27:37 [2019-09-30T14:27:37.228Z] --- PASS: TestExecWithCloseStdin (1.14s)
14:27:37 [2019-09-30T14:27:37.228Z] === RUN   TestExec
14:27:38 [2019-09-30T14:27:38.041Z] --- PASS: TestExec (1.17s)
14:27:38 [2019-09-30T14:27:38.041Z] === RUN   TestExecUser
14:27:39 [2019-09-30T14:27:39.492Z] --- PASS: TestExecUser (1.18s)
14:27:39 [2019-09-30T14:27:39.492Z] === RUN   TestExportContainerAndImportImage
14:27:40 [2019-09-30T14:27:40.799Z] --- PASS: TestExportContainerAndImportImage (1.31s)
14:27:40 [2019-09-30T14:27:40.799Z] === RUN   TestExportContainerAfterDaemonRestart
14:27:42 [2019-09-30T14:27:42.120Z] --- PASS: TestExportContainerAfterDaemonRestart (1.55s)
14:27:42 [2019-09-30T14:27:42.120Z]     export_test.go:63: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestExportContainerAfterDaemonRestart"
14:27:42 [2019-09-30T14:27:42.120Z] === RUN   TestHealthCheckWorkdir
14:27:43 [2019-09-30T14:27:43.455Z] --- PASS: TestHealthCheckWorkdir (1.26s)
14:27:43 [2019-09-30T14:27:43.455Z] === RUN   TestHealthKillContainer
14:27:46 [2019-09-30T14:27:46.778Z] --- PASS: TestHealthKillContainer (3.09s)
14:27:46 [2019-09-30T14:27:46.778Z] === RUN   TestInspectCpusetInConfigPre120
14:27:47 [2019-09-30T14:27:47.587Z] --- PASS: TestInspectCpusetInConfigPre120 (1.01s)
14:27:47 [2019-09-30T14:27:47.587Z] === RUN   TestIpcModeNone
14:27:48 [2019-09-30T14:27:48.879Z] --- PASS: TestIpcModeNone (1.01s)
14:27:48 [2019-09-30T14:27:48.879Z] === RUN   TestIpcModePrivate
14:27:49 [2019-09-30T14:27:49.692Z] --- PASS: TestIpcModePrivate (1.09s)
14:27:49 [2019-09-30T14:27:49.692Z]     ipcmode_linux_test.go:90: [testIpcPrivateShareable] ipcmode: private, ipcdev: 0:56, shared: false, mustBeShared: false
14:27:49 [2019-09-30T14:27:49.692Z] === RUN   TestIpcModeShareable
14:27:50 [2019-09-30T14:27:50.958Z] --- PASS: TestIpcModeShareable (1.10s)
14:27:50 [2019-09-30T14:27:50.958Z]     ipcmode_linux_test.go:90: [testIpcPrivateShareable] ipcmode: shareable, ipcdev: 0:50, shared: true, mustBeShared: true
14:27:50 [2019-09-30T14:27:50.958Z] === RUN   TestAPIIpcModeShareableAndContainer
14:27:54 [2019-09-30T14:27:54.289Z] --- PASS: TestAPIIpcModeShareableAndContainer (3.44s)
14:27:54 [2019-09-30T14:27:54.289Z] === RUN   TestAPIIpcModeHost
14:27:55 [2019-09-30T14:27:55.112Z] --- PASS: TestAPIIpcModeHost (0.85s)
14:27:55 [2019-09-30T14:27:55.112Z] === RUN   TestDaemonIpcModeShareable
14:27:57 [2019-09-30T14:27:57.004Z] --- PASS: TestDaemonIpcModeShareable (1.90s)
14:27:57 [2019-09-30T14:27:57.004Z]     ipcmode_linux_test.go:230: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModeShareable"
14:27:57 [2019-09-30T14:27:57.004Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:58, shared: true, mustBeShared: true
14:27:57 [2019-09-30T14:27:57.004Z] === RUN   TestDaemonIpcModePrivate
14:27:58 [2019-09-30T14:27:58.911Z] --- PASS: TestDaemonIpcModePrivate (1.95s)
14:27:58 [2019-09-30T14:27:58.911Z]     ipcmode_linux_test.go:230: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModePrivate"
14:27:58 [2019-09-30T14:27:58.911Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:64, shared: false, mustBeShared: false
14:27:58 [2019-09-30T14:27:58.911Z] === RUN   TestDaemonIpcModePrivateFromConfig
14:28:01 [2019-09-30T14:28:01.057Z] --- PASS: TestDaemonIpcModePrivateFromConfig (2.19s)
14:28:01 [2019-09-30T14:28:01.057Z]     ipcmode_linux_test.go:230: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModePrivateFromConfig"
14:28:01 [2019-09-30T14:28:01.057Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:64, shared: false, mustBeShared: false
14:28:01 [2019-09-30T14:28:01.057Z] === RUN   TestDaemonIpcModeShareableFromConfig
14:28:02 [2019-09-30T14:28:02.955Z] --- PASS: TestDaemonIpcModeShareableFromConfig (1.95s)
14:28:02 [2019-09-30T14:28:02.955Z]     ipcmode_linux_test.go:230: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModeShareableFromConfig"
14:28:02 [2019-09-30T14:28:02.955Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:58, shared: true, mustBeShared: true
14:28:02 [2019-09-30T14:28:02.955Z] === RUN   TestIpcModeOlderClient
14:28:02 [2019-09-30T14:28:02.955Z] === PAUSE TestIpcModeOlderClient
14:28:02 [2019-09-30T14:28:02.955Z] === RUN   TestKillContainerInvalidSignal
14:28:04 [2019-09-30T14:28:04.248Z] --- PASS: TestKillContainerInvalidSignal (0.91s)
14:28:04 [2019-09-30T14:28:04.248Z] === RUN   TestKillContainer
14:28:04 [2019-09-30T14:28:04.248Z] === RUN   TestKillContainer/no_signal
14:28:05 [2019-09-30T14:28:05.044Z] === RUN   TestKillContainer/non_killing_signal
14:28:05 [2019-09-30T14:28:05.432Z] === RUN   TestKillContainer/killing_signal
14:28:06 [2019-09-30T14:28:06.834Z] --- PASS: TestKillContainer (2.84s)
14:28:06 [2019-09-30T14:28:06.834Z]     --- PASS: TestKillContainer/no_signal (0.93s)
14:28:06 [2019-09-30T14:28:06.834Z]     --- PASS: TestKillContainer/non_killing_signal (0.62s)
14:28:06 [2019-09-30T14:28:06.834Z]     --- PASS: TestKillContainer/killing_signal (0.89s)
14:28:06 [2019-09-30T14:28:06.834Z] === RUN   TestKillWithStopSignalAndRestartPolicies
14:28:06 [2019-09-30T14:28:06.834Z] === RUN   TestKillWithStopSignalAndRestartPolicies/same-signal-disables-restart-policy
14:28:07 [2019-09-30T14:28:07.724Z] === RUN   TestKillWithStopSignalAndRestartPolicies/different-signal-keep-restart-policy
14:28:08 [2019-09-30T14:28:08.991Z] --- PASS: TestKillWithStopSignalAndRestartPolicies (2.03s)
14:28:08 [2019-09-30T14:28:08.991Z]     --- PASS: TestKillWithStopSignalAndRestartPolicies/same-signal-disables-restart-policy (1.00s)
14:28:08 [2019-09-30T14:28:08.991Z]     --- PASS: TestKillWithStopSignalAndRestartPolicies/different-signal-keep-restart-policy (0.64s)
14:28:08 [2019-09-30T14:28:08.991Z] === RUN   TestKillStoppedContainer
14:28:08 [2019-09-30T14:28:08.991Z] --- PASS: TestKillStoppedContainer (0.10s)
14:28:08 [2019-09-30T14:28:08.991Z] === RUN   TestKillStoppedContainerAPIPre120
14:28:08 [2019-09-30T14:28:08.991Z] --- PASS: TestKillStoppedContainerAPIPre120 (0.10s)
14:28:08 [2019-09-30T14:28:08.991Z] === RUN   TestKillDifferentUserContainer
14:28:09 [2019-09-30T14:28:09.786Z] --- PASS: TestKillDifferentUserContainer (0.90s)
14:28:09 [2019-09-30T14:28:09.786Z] === RUN   TestInspectOomKilledTrue
14:28:09 [2019-09-30T14:28:09.786Z] --- SKIP: TestInspectOomKilledTrue (0.01s)
14:28:09 [2019-09-30T14:28:09.786Z]     kill_test.go:151: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
14:28:09 [2019-09-30T14:28:09.786Z] === RUN   TestInspectOomKilledFalse
14:28:09 [2019-09-30T14:28:09.786Z] --- SKIP: TestInspectOomKilledFalse (0.00s)
14:28:09 [2019-09-30T14:28:09.786Z]     kill_test.go:169: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
14:28:09 [2019-09-30T14:28:09.786Z] === RUN   TestLinksEtcHostsContentMatch
14:28:10 [2019-09-30T14:28:10.596Z] --- PASS: TestLinksEtcHostsContentMatch (0.76s)
14:28:10 [2019-09-30T14:28:10.596Z] === RUN   TestLinksContainerNames
14:28:12 [2019-09-30T14:28:12.466Z] --- PASS: TestLinksContainerNames (1.78s)
14:28:12 [2019-09-30T14:28:12.467Z] === RUN   TestLogsFollowTailEmpty
14:28:13 [2019-09-30T14:28:13.380Z] --- PASS: TestLogsFollowTailEmpty (0.98s)
14:28:13 [2019-09-30T14:28:13.380Z] === RUN   TestContainerNetworkMountsNoChown
14:28:14 [2019-09-30T14:28:14.218Z] --- PASS: TestContainerNetworkMountsNoChown (0.89s)
14:28:14 [2019-09-30T14:28:14.218Z] === RUN   TestMountDaemonRoot
14:28:14 [2019-09-30T14:28:14.218Z] === RUN   TestMountDaemonRoot/default
14:28:14 [2019-09-30T14:28:14.218Z] === PAUSE TestMountDaemonRoot/default
14:28:14 [2019-09-30T14:28:14.218Z] === RUN   TestMountDaemonRoot/private
14:28:14 [2019-09-30T14:28:14.218Z] === PAUSE TestMountDaemonRoot/private
14:28:14 [2019-09-30T14:28:14.218Z] === RUN   TestMountDaemonRoot/rprivate
14:28:14 [2019-09-30T14:28:14.218Z] === PAUSE TestMountDaemonRoot/rprivate
14:28:14 [2019-09-30T14:28:14.218Z] === RUN   TestMountDaemonRoot/slave
14:28:14 [2019-09-30T14:28:14.218Z] === PAUSE TestMountDaemonRoot/slave
14:28:14 [2019-09-30T14:28:14.218Z] === RUN   TestMountDaemonRoot/rslave
14:28:14 [2019-09-30T14:28:14.218Z] === PAUSE TestMountDaemonRoot/rslave
14:28:14 [2019-09-30T14:28:14.218Z] === RUN   TestMountDaemonRoot/shared
14:28:14 [2019-09-30T14:28:14.218Z] === PAUSE TestMountDaemonRoot/shared
14:28:14 [2019-09-30T14:28:14.218Z] === RUN   TestMountDaemonRoot/rshared
14:28:14 [2019-09-30T14:28:14.218Z] === PAUSE TestMountDaemonRoot/rshared
14:28:14 [2019-09-30T14:28:14.218Z] === CONT  TestMountDaemonRoot/default
14:28:14 [2019-09-30T14:28:14.218Z] === RUN   TestMountDaemonRoot/default/bind_root
14:28:14 [2019-09-30T14:28:14.218Z] === PAUSE TestMountDaemonRoot/default/bind_root
14:28:14 [2019-09-30T14:28:14.218Z] === RUN   TestMountDaemonRoot/default/bind_subpath
14:28:14 [2019-09-30T14:28:14.218Z] === PAUSE TestMountDaemonRoot/default/bind_subpath
14:28:14 [2019-09-30T14:28:14.218Z] === RUN   TestMountDaemonRoot/default/mount_root
14:28:14 [2019-09-30T14:28:14.218Z] === PAUSE TestMountDaemonRoot/default/mount_root
14:28:14 [2019-09-30T14:28:14.218Z] === RUN   TestMountDaemonRoot/default/mount_subpath
14:28:14 [2019-09-30T14:28:14.218Z] === PAUSE TestMountDaemonRoot/default/mount_subpath
14:28:14 [2019-09-30T14:28:14.218Z] === CONT  TestMountDaemonRoot/default/bind_root
14:28:14 [2019-09-30T14:28:14.218Z] === CONT  TestMountDaemonRoot/rprivate
14:28:14 [2019-09-30T14:28:14.218Z] === RUN   TestMountDaemonRoot/rprivate/bind_root
14:28:14 [2019-09-30T14:28:14.218Z] === PAUSE TestMountDaemonRoot/rprivate/bind_root
14:28:14 [2019-09-30T14:28:14.218Z] === RUN   TestMountDaemonRoot/rprivate/bind_subpath
14:28:14 [2019-09-30T14:28:14.218Z] === PAUSE TestMountDaemonRoot/rprivate/bind_subpath
14:28:14 [2019-09-30T14:28:14.218Z] === RUN   TestMountDaemonRoot/rprivate/mount_root
14:28:14 [2019-09-30T14:28:14.218Z] === PAUSE TestMountDaemonRoot/rprivate/mount_root
14:28:14 [2019-09-30T14:28:14.218Z] === RUN   TestMountDaemonRoot/rprivate/mount_subpath
14:28:14 [2019-09-30T14:28:14.218Z] === PAUSE TestMountDaemonRoot/rprivate/mount_subpath
14:28:14 [2019-09-30T14:28:14.218Z] === CONT  TestMountDaemonRoot/rprivate/bind_root
14:28:14 [2019-09-30T14:28:14.620Z] === CONT  TestMountDaemonRoot/rshared
14:28:14 [2019-09-30T14:28:14.620Z] === RUN   TestMountDaemonRoot/rshared/bind_root
14:28:14 [2019-09-30T14:28:14.620Z] === PAUSE TestMountDaemonRoot/rshared/bind_root
14:28:14 [2019-09-30T14:28:14.620Z] === RUN   TestMountDaemonRoot/rshared/bind_subpath
14:28:14 [2019-09-30T14:28:14.620Z] === PAUSE TestMountDaemonRoot/rshared/bind_subpath
14:28:14 [2019-09-30T14:28:14.620Z] === RUN   TestMountDaemonRoot/rshared/mount_root
14:28:14 [2019-09-30T14:28:14.620Z] === PAUSE TestMountDaemonRoot/rshared/mount_root
14:28:14 [2019-09-30T14:28:14.620Z] === RUN   TestMountDaemonRoot/rshared/mount_subpath
14:28:14 [2019-09-30T14:28:14.620Z] === PAUSE TestMountDaemonRoot/rshared/mount_subpath
14:28:14 [2019-09-30T14:28:14.620Z] === CONT  TestMountDaemonRoot/shared
14:28:14 [2019-09-30T14:28:14.620Z] === RUN   TestMountDaemonRoot/shared/bind_root
14:28:14 [2019-09-30T14:28:14.620Z] === PAUSE TestMountDaemonRoot/shared/bind_root
14:28:14 [2019-09-30T14:28:14.620Z] === RUN   TestMountDaemonRoot/shared/bind_subpath
14:28:14 [2019-09-30T14:28:14.620Z] === PAUSE TestMountDaemonRoot/shared/bind_subpath
14:28:14 [2019-09-30T14:28:14.620Z] === RUN   TestMountDaemonRoot/shared/mount_root
14:28:14 [2019-09-30T14:28:14.620Z] === PAUSE TestMountDaemonRoot/shared/mount_root
14:28:14 [2019-09-30T14:28:14.620Z] === RUN   TestMountDaemonRoot/shared/mount_subpath
14:28:14 [2019-09-30T14:28:14.620Z] === PAUSE TestMountDaemonRoot/shared/mount_subpath
14:28:14 [2019-09-30T14:28:14.620Z] === CONT  TestMountDaemonRoot/rslave
14:28:14 [2019-09-30T14:28:14.620Z] === RUN   TestMountDaemonRoot/rslave/bind_root
14:28:14 [2019-09-30T14:28:14.620Z] === PAUSE TestMountDaemonRoot/rslave/bind_root
14:28:14 [2019-09-30T14:28:14.620Z] === RUN   TestMountDaemonRoot/rslave/bind_subpath
14:28:14 [2019-09-30T14:28:14.620Z] === PAUSE TestMountDaemonRoot/rslave/bind_subpath
14:28:14 [2019-09-30T14:28:14.620Z] === RUN   TestMountDaemonRoot/rslave/mount_root
14:28:14 [2019-09-30T14:28:14.620Z] === PAUSE TestMountDaemonRoot/rslave/mount_root
14:28:14 [2019-09-30T14:28:14.620Z] === RUN   TestMountDaemonRoot/rslave/mount_subpath
14:28:14 [2019-09-30T14:28:14.620Z] === PAUSE TestMountDaemonRoot/rslave/mount_subpath
14:28:14 [2019-09-30T14:28:14.620Z] === CONT  TestMountDaemonRoot/slave
14:28:14 [2019-09-30T14:28:14.620Z] === RUN   TestMountDaemonRoot/slave/bind_root
14:28:14 [2019-09-30T14:28:14.620Z] === PAUSE TestMountDaemonRoot/slave/bind_root
14:28:14 [2019-09-30T14:28:14.620Z] === RUN   TestMountDaemonRoot/slave/bind_subpath
14:28:14 [2019-09-30T14:28:14.620Z] === PAUSE TestMountDaemonRoot/slave/bind_subpath
14:28:14 [2019-09-30T14:28:14.620Z] === RUN   TestMountDaemonRoot/slave/mount_root
14:28:14 [2019-09-30T14:28:14.620Z] === PAUSE TestMountDaemonRoot/slave/mount_root
14:28:14 [2019-09-30T14:28:14.620Z] === RUN   TestMountDaemonRoot/slave/mount_subpath
14:28:14 [2019-09-30T14:28:14.620Z] === PAUSE TestMountDaemonRoot/slave/mount_subpath
14:28:14 [2019-09-30T14:28:14.620Z] === CONT  TestMountDaemonRoot/rprivate/mount_subpath
14:28:14 [2019-09-30T14:28:14.620Z] === CONT  TestMountDaemonRoot/rprivate/mount_root
14:28:14 [2019-09-30T14:28:14.620Z] === CONT  TestMountDaemonRoot/rprivate/bind_subpath
14:28:14 [2019-09-30T14:28:14.620Z] === CONT  TestMountDaemonRoot/default/mount_subpath
14:28:14 [2019-09-30T14:28:14.620Z] === CONT  TestMountDaemonRoot/private
14:28:14 [2019-09-30T14:28:14.620Z] === RUN   TestMountDaemonRoot/private/bind_root
14:28:14 [2019-09-30T14:28:14.620Z] === PAUSE TestMountDaemonRoot/private/bind_root
14:28:14 [2019-09-30T14:28:14.620Z] === RUN   TestMountDaemonRoot/private/bind_subpath
14:28:14 [2019-09-30T14:28:14.620Z] === PAUSE TestMountDaemonRoot/private/bind_subpath
14:28:14 [2019-09-30T14:28:14.620Z] === RUN   TestMountDaemonRoot/private/mount_root
14:28:14 [2019-09-30T14:28:14.620Z] === PAUSE TestMountDaemonRoot/private/mount_root
14:28:14 [2019-09-30T14:28:14.620Z] === RUN   TestMountDaemonRoot/private/mount_subpath
14:28:14 [2019-09-30T14:28:14.620Z] === PAUSE TestMountDaemonRoot/private/mount_subpath
14:28:14 [2019-09-30T14:28:14.620Z] === CONT  TestMountDaemonRoot/default/mount_root
14:28:14 [2019-09-30T14:28:14.620Z] === CONT  TestMountDaemonRoot/default/bind_subpath
14:28:14 [2019-09-30T14:28:14.620Z] === CONT  TestMountDaemonRoot/rshared/bind_root
14:28:14 [2019-09-30T14:28:14.620Z] === CONT  TestMountDaemonRoot/shared/bind_root
14:28:14 [2019-09-30T14:28:14.620Z] === CONT  TestMountDaemonRoot/rshared/mount_subpath
14:28:14 [2019-09-30T14:28:14.620Z] === CONT  TestMountDaemonRoot/rshared/mount_root
14:28:14 [2019-09-30T14:28:14.620Z] === CONT  TestMountDaemonRoot/rshared/bind_subpath
14:28:14 [2019-09-30T14:28:14.620Z] === CONT  TestMountDaemonRoot/rslave/bind_root
14:28:15 [2019-09-30T14:28:15.037Z] === CONT  TestMountDaemonRoot/shared/mount_subpath
14:28:15 [2019-09-30T14:28:15.037Z] === CONT  TestMountDaemonRoot/shared/mount_root
14:28:15 [2019-09-30T14:28:15.037Z] === CONT  TestMountDaemonRoot/shared/bind_subpath
14:28:15 [2019-09-30T14:28:15.037Z] === CONT  TestMountDaemonRoot/slave/bind_root
14:28:15 [2019-09-30T14:28:15.037Z] === CONT  TestMountDaemonRoot/rslave/mount_subpath
14:28:15 [2019-09-30T14:28:15.037Z] === CONT  TestMountDaemonRoot/rslave/mount_root
14:28:15 [2019-09-30T14:28:15.037Z] === CONT  TestMountDaemonRoot/rslave/bind_subpath
14:28:15 [2019-09-30T14:28:15.037Z] === CONT  TestMountDaemonRoot/slave/mount_subpath
14:28:15 [2019-09-30T14:28:15.037Z] === CONT  TestMountDaemonRoot/slave/mount_root
14:28:15 [2019-09-30T14:28:15.037Z] === CONT  TestMountDaemonRoot/slave/bind_subpath
14:28:15 [2019-09-30T14:28:15.037Z] === CONT  TestMountDaemonRoot/private/bind_root
14:28:15 [2019-09-30T14:28:15.037Z] === CONT  TestMountDaemonRoot/private/mount_subpath
14:28:15 [2019-09-30T14:28:15.037Z] === CONT  TestMountDaemonRoot/private/mount_root
14:28:15 [2019-09-30T14:28:15.037Z] === CONT  TestMountDaemonRoot/private/bind_subpath
14:28:15 [2019-09-30T14:28:15.037Z] --- PASS: TestMountDaemonRoot (0.03s)
14:28:15 [2019-09-30T14:28:15.037Z]     --- PASS: TestMountDaemonRoot/rprivate (0.00s)
14:28:15 [2019-09-30T14:28:15.037Z]         --- PASS: TestMountDaemonRoot/rprivate/bind_root (0.05s)
14:28:15 [2019-09-30T14:28:15.037Z]         --- PASS: TestMountDaemonRoot/rprivate/mount_subpath (0.04s)
14:28:15 [2019-09-30T14:28:15.037Z]         --- PASS: TestMountDaemonRoot/rprivate/mount_root (0.04s)
14:28:15 [2019-09-30T14:28:15.037Z]         --- PASS: TestMountDaemonRoot/rprivate/bind_subpath (0.05s)
14:28:15 [2019-09-30T14:28:15.037Z]     --- PASS: TestMountDaemonRoot/default (0.00s)
14:28:15 [2019-09-30T14:28:15.037Z]         --- PASS: TestMountDaemonRoot/default/bind_root (0.10s)
14:28:15 [2019-09-30T14:28:15.037Z]         --- PASS: TestMountDaemonRoot/default/mount_subpath (0.05s)
14:28:15 [2019-09-30T14:28:15.037Z]         --- PASS: TestMountDaemonRoot/default/mount_root (0.08s)
14:28:15 [2019-09-30T14:28:15.037Z]         --- PASS: TestMountDaemonRoot/default/bind_subpath (0.08s)
14:28:15 [2019-09-30T14:28:15.037Z]     --- PASS: TestMountDaemonRoot/rshared (0.00s)
14:28:15 [2019-09-30T14:28:15.037Z]         --- PASS: TestMountDaemonRoot/rshared/bind_root (0.07s)
14:28:15 [2019-09-30T14:28:15.037Z]         --- PASS: TestMountDaemonRoot/rshared/mount_root (0.06s)
14:28:15 [2019-09-30T14:28:15.037Z]         --- PASS: TestMountDaemonRoot/rshared/mount_subpath (0.08s)
14:28:15 [2019-09-30T14:28:15.037Z]         --- PASS: TestMountDaemonRoot/rshared/bind_subpath (0.06s)
14:28:15 [2019-09-30T14:28:15.037Z]     --- PASS: TestMountDaemonRoot/shared (0.00s)
14:28:15 [2019-09-30T14:28:15.037Z]         --- PASS: TestMountDaemonRoot/shared/bind_root (0.03s)
14:28:15 [2019-09-30T14:28:15.037Z]         --- PASS: TestMountDaemonRoot/shared/mount_subpath (0.05s)
14:28:15 [2019-09-30T14:28:15.037Z]         --- PASS: TestMountDaemonRoot/shared/bind_subpath (0.03s)
14:28:15 [2019-09-30T14:28:15.037Z]         --- PASS: TestMountDaemonRoot/shared/mount_root (0.04s)
14:28:15 [2019-09-30T14:28:15.037Z]     --- PASS: TestMountDaemonRoot/rslave (0.00s)
14:28:15 [2019-09-30T14:28:15.037Z]         --- PASS: TestMountDaemonRoot/rslave/bind_root (0.09s)
14:28:15 [2019-09-30T14:28:15.037Z]         --- PASS: TestMountDaemonRoot/rslave/mount_subpath (0.07s)
14:28:15 [2019-09-30T14:28:15.037Z]         --- PASS: TestMountDaemonRoot/rslave/mount_root (0.08s)
14:28:15 [2019-09-30T14:28:15.038Z]         --- PASS: TestMountDaemonRoot/rslave/bind_subpath (0.07s)
14:28:15 [2019-09-30T14:28:15.038Z]     --- PASS: TestMountDaemonRoot/slave (0.00s)
14:28:15 [2019-09-30T14:28:15.038Z]         --- PASS: TestMountDaemonRoot/slave/bind_root (0.03s)
14:28:15 [2019-09-30T14:28:15.038Z]         --- PASS: TestMountDaemonRoot/slave/mount_subpath (0.04s)
14:28:15 [2019-09-30T14:28:15.038Z]         --- PASS: TestMountDaemonRoot/slave/bind_subpath (0.05s)
14:28:15 [2019-09-30T14:28:15.038Z]         --- PASS: TestMountDaemonRoot/slave/mount_root (0.05s)
14:28:15 [2019-09-30T14:28:15.038Z]     --- PASS: TestMountDaemonRoot/private (0.00s)
14:28:15 [2019-09-30T14:28:15.038Z]         --- PASS: TestMountDaemonRoot/private/bind_root (0.04s)
14:28:15 [2019-09-30T14:28:15.038Z]         --- PASS: TestMountDaemonRoot/private/mount_subpath (0.04s)
14:28:15 [2019-09-30T14:28:15.038Z]         --- PASS: TestMountDaemonRoot/private/mount_root (0.03s)
14:28:15 [2019-09-30T14:28:15.038Z]         --- PASS: TestMountDaemonRoot/private/bind_subpath (0.03s)
14:28:15 [2019-09-30T14:28:15.038Z] === RUN   TestContainerBindMountNonRecursive
14:28:17 [2019-09-30T14:28:17.593Z] --- PASS: TestContainerBindMountNonRecursive (1.97s)
14:28:17 [2019-09-30T14:28:17.593Z] === RUN   TestNetworkNat
14:28:18 [2019-09-30T14:28:18.010Z] --- PASS: TestNetworkNat (0.94s)
14:28:18 [2019-09-30T14:28:18.010Z] === RUN   TestNetworkLocalhostTCPNat
14:28:19 [2019-09-30T14:28:19.342Z] --- PASS: TestNetworkLocalhostTCPNat (1.03s)
14:28:19 [2019-09-30T14:28:19.342Z] === RUN   TestNetworkLoopbackNat
14:28:20 [2019-09-30T14:28:20.218Z] --- PASS: TestNetworkLoopbackNat (1.27s)
14:28:20 [2019-09-30T14:28:20.219Z] === RUN   TestPause
14:28:21 [2019-09-30T14:28:21.562Z] --- PASS: TestPause (0.93s)
14:28:21 [2019-09-30T14:28:21.562Z] === RUN   TestPauseFailsOnWindowsServerContainers
14:28:21 [2019-09-30T14:28:21.562Z] --- SKIP: TestPauseFailsOnWindowsServerContainers (0.00s)
14:28:21 [2019-09-30T14:28:21.562Z]     pause_test.go:54: testEnv.DaemonInfo.OSType != "windows" || testEnv.DaemonInfo.Isolation != "process"
14:28:21 [2019-09-30T14:28:21.562Z] === RUN   TestPauseStopPausedContainer
14:28:22 [2019-09-30T14:28:22.357Z] --- PASS: TestPauseStopPausedContainer (0.99s)
14:28:22 [2019-09-30T14:28:22.357Z] === RUN   TestPsFilter
14:28:22 [2019-09-30T14:28:22.731Z] --- PASS: TestPsFilter (0.27s)
14:28:22 [2019-09-30T14:28:22.731Z] === RUN   TestRemoveContainerWithRemovedVolume
14:28:23 [2019-09-30T14:28:23.514Z] --- PASS: TestRemoveContainerWithRemovedVolume (0.80s)
14:28:23 [2019-09-30T14:28:23.514Z] === RUN   TestRemoveContainerWithVolume
14:28:24 [2019-09-30T14:28:24.312Z] --- PASS: TestRemoveContainerWithVolume (0.99s)
14:28:24 [2019-09-30T14:28:24.312Z] === RUN   TestRemoveContainerRunning
14:28:25 [2019-09-30T14:28:25.177Z] --- PASS: TestRemoveContainerRunning (0.92s)
14:28:25 [2019-09-30T14:28:25.177Z] === RUN   TestRemoveContainerForceRemoveRunning
14:28:26 [2019-09-30T14:28:26.228Z] --- PASS: TestRemoveContainerForceRemoveRunning (1.03s)
14:28:26 [2019-09-30T14:28:26.228Z] === RUN   TestRemoveInvalidContainer
14:28:26 [2019-09-30T14:28:26.228Z] --- PASS: TestRemoveInvalidContainer (0.02s)
14:28:26 [2019-09-30T14:28:26.228Z] === RUN   TestRenameLinkedContainer
14:28:30 [2019-09-30T14:28:30.350Z] --- PASS: TestRenameLinkedContainer (3.83s)
14:28:30 [2019-09-30T14:28:30.350Z] === RUN   TestRenameStoppedContainer
14:28:31 [2019-09-30T14:28:31.143Z] --- PASS: TestRenameStoppedContainer (0.96s)
14:28:31 [2019-09-30T14:28:31.144Z] === RUN   TestRenameRunningContainerAndReuse
14:28:33 [2019-09-30T14:28:33.029Z] --- PASS: TestRenameRunningContainerAndReuse (1.69s)
14:28:33 [2019-09-30T14:28:33.029Z] === RUN   TestRenameInvalidName
14:28:33 [2019-09-30T14:28:33.855Z] --- PASS: TestRenameInvalidName (1.07s)
14:28:33 [2019-09-30T14:28:33.856Z] === RUN   TestRenameAnonymousContainer
14:28:37 [2019-09-30T14:28:37.079Z] --- PASS: TestRenameAnonymousContainer (2.97s)
14:28:37 [2019-09-30T14:28:37.079Z] === RUN   TestRenameContainerWithSameName
14:28:37 [2019-09-30T14:28:37.885Z] --- PASS: TestRenameContainerWithSameName (0.85s)
14:28:37 [2019-09-30T14:28:37.885Z] === RUN   TestRenameContainerWithLinkedContainer
14:28:39 [2019-09-30T14:28:39.748Z] --- PASS: TestRenameContainerWithLinkedContainer (1.76s)
14:28:39 [2019-09-30T14:28:39.748Z] === RUN   TestResize
14:28:40 [2019-09-30T14:28:40.205Z] --- PASS: TestResize (0.85s)
14:28:40 [2019-09-30T14:28:40.205Z] === RUN   TestResizeWithInvalidSize
14:28:41 [2019-09-30T14:28:41.059Z] --- PASS: TestResizeWithInvalidSize (0.95s)
14:28:41 [2019-09-30T14:28:41.059Z] === RUN   TestResizeWhenContainerNotStarted
14:28:42 [2019-09-30T14:28:42.333Z] --- PASS: TestResizeWhenContainerNotStarted (0.94s)
14:28:42 [2019-09-30T14:28:42.333Z] === RUN   TestDaemonRestartKillContainers
14:28:42 [2019-09-30T14:28:42.333Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
14:28:42 [2019-09-30T14:28:42.333Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
14:28:42 [2019-09-30T14:28:42.333Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
14:28:42 [2019-09-30T14:28:42.333Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
14:28:42 [2019-09-30T14:28:42.333Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
14:28:42 [2019-09-30T14:28:42.333Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
14:28:42 [2019-09-30T14:28:42.333Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
14:28:42 [2019-09-30T14:28:42.333Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
14:28:42 [2019-09-30T14:28:42.333Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
14:28:42 [2019-09-30T14:28:42.333Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
14:28:42 [2019-09-30T14:28:42.333Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
14:28:42 [2019-09-30T14:28:42.333Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
14:28:42 [2019-09-30T14:28:42.333Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
14:28:42 [2019-09-30T14:28:42.333Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
14:28:42 [2019-09-30T14:28:42.333Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
14:28:42 [2019-09-30T14:28:42.333Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
14:28:42 [2019-09-30T14:28:42.333Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
14:28:42 [2019-09-30T14:28:42.333Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
14:28:42 [2019-09-30T14:28:42.333Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
14:28:42 [2019-09-30T14:28:42.333Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
14:28:42 [2019-09-30T14:28:42.333Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
14:28:42 [2019-09-30T14:28:42.333Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
14:28:42 [2019-09-30T14:28:42.333Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
14:28:42 [2019-09-30T14:28:42.333Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
14:28:42 [2019-09-30T14:28:42.333Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
14:28:42 [2019-09-30T14:28:42.333Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
14:28:44 [2019-09-30T14:28:44.263Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
14:28:44 [2019-09-30T14:28:44.638Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
14:28:45 [2019-09-30T14:28:45.998Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
14:28:46 [2019-09-30T14:28:46.486Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
14:28:47 [2019-09-30T14:28:47.422Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
14:28:47 [2019-09-30T14:28:47.816Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
14:28:49 [2019-09-30T14:28:49.744Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
14:28:50 [2019-09-30T14:28:50.321Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
14:28:52 [2019-09-30T14:28:52.936Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
14:28:53 [2019-09-30T14:28:53.790Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
14:28:56 [2019-09-30T14:28:56.290Z] --- PASS: TestDaemonRestartKillContainers (0.00s)
14:28:56 [2019-09-30T14:28:56.290Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon (2.15s)
14:28:56 [2019-09-30T14:28:56.290Z]         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"
14:28:56 [2019-09-30T14:28:56.290Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon (2.52s)
14:28:56 [2019-09-30T14:28:56.290Z]         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"
14:28:56 [2019-09-30T14:28:56.290Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon (1.45s)
14:28:56 [2019-09-30T14:28:56.290Z]         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"
14:28:56 [2019-09-30T14:28:56.290Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon (1.53s)
14:28:56 [2019-09-30T14:28:56.290Z]         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"
14:28:56 [2019-09-30T14:28:56.290Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon (1.58s)
14:28:56 [2019-09-30T14:28:56.290Z]         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"
14:28:56 [2019-09-30T14:28:56.290Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon (1.61s)
14:28:56 [2019-09-30T14:28:56.290Z]         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"
14:28:56 [2019-09-30T14:28:56.290Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon (2.41s)
14:28:56 [2019-09-30T14:28:56.290Z]         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"
14:28:56 [2019-09-30T14:28:56.290Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon (2.47s)
14:28:56 [2019-09-30T14:28:56.290Z]         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"
14:28:56 [2019-09-30T14:28:56.290Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon (3.21s)
14:28:56 [2019-09-30T14:28:56.290Z]         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"
14:28:56 [2019-09-30T14:28:56.290Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon (3.30s)
14:28:56 [2019-09-30T14:28:56.290Z]         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"
14:28:56 [2019-09-30T14:28:56.290Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon (2.46s)
14:28:56 [2019-09-30T14:28:56.290Z]         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"
14:28:56 [2019-09-30T14:28:56.290Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon (2.38s)
14:28:56 [2019-09-30T14:28:56.290Z]         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"
14:28:56 [2019-09-30T14:28:56.290Z] === RUN   TestCgroupNamespacesRun
14:28:58 [2019-09-30T14:28:58.118Z] --- PASS: TestCgroupNamespacesRun (1.77s)
14:28:58 [2019-09-30T14:28:58.118Z]     run_cgroupns_linux_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRun"
14:28:58 [2019-09-30T14:28:58.118Z] === RUN   TestCgroupNamespacesRunPrivileged
14:28:59 [2019-09-30T14:28:59.532Z] --- PASS: TestCgroupNamespacesRunPrivileged (1.73s)
14:28:59 [2019-09-30T14:28:59.532Z]     run_cgroupns_linux_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunPrivileged"
14:28:59 [2019-09-30T14:28:59.532Z] === RUN   TestCgroupNamespacesRunDaemonHostMode
14:29:01 [2019-09-30T14:29:01.519Z] --- PASS: TestCgroupNamespacesRunDaemonHostMode (1.96s)
14:29:01 [2019-09-30T14:29:01.519Z]     run_cgroupns_linux_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunDaemonHostMode"
14:29:01 [2019-09-30T14:29:01.519Z] === RUN   TestCgroupNamespacesRunHostMode
14:29:03 [2019-09-30T14:29:03.403Z] --- PASS: TestCgroupNamespacesRunHostMode (1.84s)
14:29:03 [2019-09-30T14:29:03.403Z]     run_cgroupns_linux_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunHostMode"
14:29:03 [2019-09-30T14:29:03.403Z] === RUN   TestCgroupNamespacesRunPrivateMode
14:29:05 [2019-09-30T14:29:05.359Z] --- PASS: TestCgroupNamespacesRunPrivateMode (1.93s)
14:29:05 [2019-09-30T14:29:05.359Z]     run_cgroupns_linux_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunPrivateMode"
14:29:05 [2019-09-30T14:29:05.359Z] === RUN   TestCgroupNamespacesRunPrivilegedAndPrivate
14:29:06 [2019-09-30T14:29:06.153Z] --- PASS: TestCgroupNamespacesRunPrivilegedAndPrivate (0.88s)
14:29:06 [2019-09-30T14:29:06.153Z]     run_cgroupns_linux_test.go:48: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunPrivilegedAndPrivate"
14:29:06 [2019-09-30T14:29:06.153Z] === RUN   TestCgroupNamespacesRunInvalidMode
14:29:06 [2019-09-30T14:29:06.955Z] --- PASS: TestCgroupNamespacesRunInvalidMode (0.86s)
14:29:06 [2019-09-30T14:29:06.955Z]     run_cgroupns_linux_test.go:48: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunInvalidMode"
14:29:06 [2019-09-30T14:29:06.955Z] === RUN   TestCgroupNamespacesRunOlderClient
14:29:08 [2019-09-30T14:29:08.826Z] --- PASS: TestCgroupNamespacesRunOlderClient (1.79s)
14:29:08 [2019-09-30T14:29:08.826Z]     run_cgroupns_linux_test.go:139: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunOlderClient"
14:29:08 [2019-09-30T14:29:08.826Z] === RUN   TestKernelTCPMemory
14:29:10 [2019-09-30T14:29:10.101Z] --- PASS: TestKernelTCPMemory (1.11s)
14:29:10 [2019-09-30T14:29:10.101Z] === RUN   TestNISDomainname
14:29:11 [2019-09-30T14:29:11.385Z] --- PASS: TestNISDomainname (1.23s)
14:29:11 [2019-09-30T14:29:11.385Z] === RUN   TestHostnameDnsResolution
14:29:12 [2019-09-30T14:29:12.214Z] --- PASS: TestHostnameDnsResolution (1.24s)
14:29:12 [2019-09-30T14:29:12.214Z] === RUN   TestStats
14:29:14 [2019-09-30T14:29:14.809Z] --- PASS: TestStats (2.55s)
14:29:14 [2019-09-30T14:29:14.809Z] === RUN   TestStopContainerWithTimeout
14:29:14 [2019-09-30T14:29:14.809Z] === RUN   TestStopContainerWithTimeout/0
14:29:14 [2019-09-30T14:29:14.809Z] === PAUSE TestStopContainerWithTimeout/0
14:29:14 [2019-09-30T14:29:14.809Z] === RUN   TestStopContainerWithTimeout/1
14:29:14 [2019-09-30T14:29:14.809Z] === PAUSE TestStopContainerWithTimeout/1
14:29:14 [2019-09-30T14:29:14.809Z] === RUN   TestStopContainerWithTimeout/3
14:29:14 [2019-09-30T14:29:14.809Z] === PAUSE TestStopContainerWithTimeout/3
14:29:14 [2019-09-30T14:29:14.809Z] === RUN   TestStopContainerWithTimeout/-1
14:29:14 [2019-09-30T14:29:14.809Z] === PAUSE TestStopContainerWithTimeout/-1
14:29:14 [2019-09-30T14:29:14.809Z] === CONT  TestStopContainerWithTimeout/0
14:29:14 [2019-09-30T14:29:14.809Z] === CONT  TestStopContainerWithTimeout/-1
14:29:16 [2019-09-30T14:29:16.090Z] === CONT  TestStopContainerWithTimeout/3
14:29:17 [2019-09-30T14:29:17.989Z] === CONT  TestStopContainerWithTimeout/1
14:29:20 [2019-09-30T14:29:20.062Z] --- PASS: TestStopContainerWithTimeout (0.01s)
14:29:20 [2019-09-30T14:29:20.063Z]     --- PASS: TestStopContainerWithTimeout/0 (1.03s)
14:29:20 [2019-09-30T14:29:20.063Z]     --- PASS: TestStopContainerWithTimeout/-1 (3.02s)
14:29:20 [2019-09-30T14:29:20.063Z]     --- PASS: TestStopContainerWithTimeout/3 (2.99s)
14:29:20 [2019-09-30T14:29:20.063Z]     --- PASS: TestStopContainerWithTimeout/1 (2.01s)
14:29:20 [2019-09-30T14:29:20.063Z] === RUN   TestDeleteDevicemapper
14:29:20 [2019-09-30T14:29:20.063Z] --- SKIP: TestDeleteDevicemapper (0.00s)
14:29:20 [2019-09-30T14:29:20.063Z]     stop_linux_test.go:74: testEnv.DaemonInfo.Driver != "devicemapper"
14:29:20 [2019-09-30T14:29:20.063Z] === RUN   TestStopContainerWithRestartPolicyAlways
14:29:23 [2019-09-30T14:29:23.336Z] --- PASS: TestStopContainerWithRestartPolicyAlways (3.46s)
14:29:23 [2019-09-30T14:29:23.336Z] === RUN   TestUpdateMemory
14:29:23 [2019-09-30T14:29:23.336Z] --- SKIP: TestUpdateMemory (0.00s)
14:29:23 [2019-09-30T14:29:23.336Z]     update_linux_test.go:23: !testEnv.DaemonInfo.SwapLimit
14:29:23 [2019-09-30T14:29:23.336Z] === RUN   TestUpdateCPUQuota
14:29:25 [2019-09-30T14:29:25.846Z] --- PASS: TestUpdateCPUQuota (2.04s)
14:29:25 [2019-09-30T14:29:25.846Z] === RUN   TestUpdatePidsLimit
14:29:25 [2019-09-30T14:29:25.846Z] === RUN   TestUpdatePidsLimit/update_from_none
14:29:25 [2019-09-30T14:29:25.846Z] === RUN   TestUpdatePidsLimit/no_change
14:29:26 [2019-09-30T14:29:26.253Z] === RUN   TestUpdatePidsLimit/update_lower
14:29:26 [2019-09-30T14:29:26.672Z] === RUN   TestUpdatePidsLimit/update_on_old_api_ignores_value
14:29:27 [2019-09-30T14:29:27.579Z] === RUN   TestUpdatePidsLimit/unset_limit_with_zero
14:29:28 [2019-09-30T14:29:28.022Z] === RUN   TestUpdatePidsLimit/unset_limit_with_minus_one
14:29:28 [2019-09-30T14:29:28.389Z] === RUN   TestUpdatePidsLimit/unset_limit_with_minus_two
14:29:30 [2019-09-30T14:29:30.236Z] --- PASS: TestUpdatePidsLimit (4.82s)
14:29:30 [2019-09-30T14:29:30.236Z]     --- PASS: TestUpdatePidsLimit/update_from_none (0.46s)
14:29:30 [2019-09-30T14:29:30.236Z]     --- PASS: TestUpdatePidsLimit/no_change (0.48s)
14:29:30 [2019-09-30T14:29:30.236Z]     --- PASS: TestUpdatePidsLimit/update_lower (0.45s)
14:29:30 [2019-09-30T14:29:30.236Z]     --- PASS: TestUpdatePidsLimit/update_on_old_api_ignores_value (0.60s)
14:29:30 [2019-09-30T14:29:30.236Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_zero (0.55s)
14:29:30 [2019-09-30T14:29:30.236Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_minus_one (0.47s)
14:29:30 [2019-09-30T14:29:30.236Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_minus_two (0.48s)
14:29:30 [2019-09-30T14:29:30.236Z] === RUN   TestUpdateRestartPolicy
14:29:44 [2019-09-30T14:29:44.127Z] --- PASS: TestUpdateRestartPolicy (12.88s)
14:29:44 [2019-09-30T14:29:44.127Z] === RUN   TestUpdateRestartWithAutoRemove
14:29:44 [2019-09-30T14:29:44.127Z] --- PASS: TestUpdateRestartWithAutoRemove (0.97s)
14:29:44 [2019-09-30T14:29:44.127Z] === RUN   TestWaitNonBlocked
14:29:44 [2019-09-30T14:29:44.127Z] === RUN   TestWaitNonBlocked/wait-nonblocking-exit-0
14:29:44 [2019-09-30T14:29:44.127Z] === PAUSE TestWaitNonBlocked/wait-nonblocking-exit-0
14:29:44 [2019-09-30T14:29:44.127Z] === RUN   TestWaitNonBlocked/wait-nonblocking-exit-random
14:29:44 [2019-09-30T14:29:44.127Z] === PAUSE TestWaitNonBlocked/wait-nonblocking-exit-random
14:29:44 [2019-09-30T14:29:44.127Z] === CONT  TestWaitNonBlocked/wait-nonblocking-exit-0
14:29:44 [2019-09-30T14:29:44.127Z] === CONT  TestWaitNonBlocked/wait-nonblocking-exit-random
14:29:45 [2019-09-30T14:29:45.423Z] --- PASS: TestWaitNonBlocked (0.01s)
14:29:45 [2019-09-30T14:29:45.423Z]     --- PASS: TestWaitNonBlocked/wait-nonblocking-exit-random (1.06s)
14:29:45 [2019-09-30T14:29:45.423Z]     --- PASS: TestWaitNonBlocked/wait-nonblocking-exit-0 (1.14s)
14:29:45 [2019-09-30T14:29:45.423Z] === RUN   TestWaitBlocked
14:29:45 [2019-09-30T14:29:45.423Z] === RUN   TestWaitBlocked/test-wait-blocked-exit-zero
14:29:45 [2019-09-30T14:29:45.423Z] === PAUSE TestWaitBlocked/test-wait-blocked-exit-zero
14:29:45 [2019-09-30T14:29:45.423Z] === RUN   TestWaitBlocked/test-wait-blocked-exit-random
14:29:45 [2019-09-30T14:29:45.423Z] === PAUSE TestWaitBlocked/test-wait-blocked-exit-random
14:29:45 [2019-09-30T14:29:45.423Z] === CONT  TestWaitBlocked/test-wait-blocked-exit-zero
14:29:45 [2019-09-30T14:29:45.423Z] === CONT  TestWaitBlocked/test-wait-blocked-exit-random
14:29:46 [2019-09-30T14:29:46.700Z] --- PASS: TestWaitBlocked (0.02s)
14:29:46 [2019-09-30T14:29:46.700Z]     --- PASS: TestWaitBlocked/test-wait-blocked-exit-random (1.33s)
14:29:46 [2019-09-30T14:29:46.700Z]     --- PASS: TestWaitBlocked/test-wait-blocked-exit-zero (1.39s)
14:29:46 [2019-09-30T14:29:46.700Z] === CONT  TestContainerStartOnDaemonRestart
14:29:46 [2019-09-30T14:29:46.700Z] === CONT  TestIpcModeOlderClient
14:29:46 [2019-09-30T14:29:46.700Z] --- PASS: TestIpcModeOlderClient (0.18s)
14:29:46 [2019-09-30T14:29:46.700Z] === CONT  TestDaemonRestartIpcMode
14:29:50 [2019-09-30T14:29:50.110Z] --- PASS: TestContainerStartOnDaemonRestart (3.43s)
14:29:50 [2019-09-30T14:29:50.110Z]     daemon_linux_test.go:35: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestContainerStartOnDaemonRestart"
14:29:51 [2019-09-30T14:29:51.429Z] --- PASS: TestDaemonRestartIpcMode (4.33s)
14:29:51 [2019-09-30T14:29:51.429Z]     daemon_linux_test.go:89: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartIpcMode"
14:29:51 [2019-09-30T14:29:51.429Z] PASS
14:29:51 [2019-09-30T14:29:51.429Z] 
14:29:51 [2019-09-30T14:29:51.429Z] === Skipped
14:29:51 [2019-09-30T14:29:51.429Z] === SKIP: s390x.integration.container TestCheckpoint (0.00s)
14:29:51 [2019-09-30T14:29:51.429Z]     checkpoint_test.go:33: TestCheckpoint is broken; see https://github.com/moby/moby/issues/38963
14:29:51 [2019-09-30T14:29:51.429Z] 
14:29:51 [2019-09-30T14:29:51.429Z] === SKIP: s390x.integration.container TestInspectOomKilledTrue (0.01s)
14:29:51 [2019-09-30T14:29:51.429Z]     kill_test.go:151: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
14:29:51 [2019-09-30T14:29:51.429Z] 
14:29:51 [2019-09-30T14:29:51.429Z] === SKIP: s390x.integration.container TestInspectOomKilledFalse (0.00s)
14:29:51 [2019-09-30T14:29:51.429Z]     kill_test.go:169: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
14:29:51 [2019-09-30T14:29:51.429Z] 
14:29:51 [2019-09-30T14:29:51.429Z] === SKIP: s390x.integration.container TestPauseFailsOnWindowsServerContainers (0.00s)
14:29:51 [2019-09-30T14:29:51.429Z]     pause_test.go:54: testEnv.DaemonInfo.OSType != "windows" || testEnv.DaemonInfo.Isolation != "process"
14:29:51 [2019-09-30T14:29:51.429Z] 
14:29:51 [2019-09-30T14:29:51.429Z] === SKIP: s390x.integration.container TestDeleteDevicemapper (0.00s)
14:29:51 [2019-09-30T14:29:51.429Z]     stop_linux_test.go:74: testEnv.DaemonInfo.Driver != "devicemapper"
14:29:51 [2019-09-30T14:29:51.429Z] 
14:29:51 [2019-09-30T14:29:51.429Z] === SKIP: s390x.integration.container TestUpdateMemory (0.00s)
14:29:51 [2019-09-30T14:29:51.429Z]     update_linux_test.go:23: !testEnv.DaemonInfo.SwapLimit
14:29:51 [2019-09-30T14:29:51.429Z] 
14:29:51 [2019-09-30T14:29:51.429Z] 
14:29:51 [2019-09-30T14:29:51.429Z] DONE 197 tests, 6 skipped in 145.740s
14:29:51 [2019-09-30T14:29:51.429Z] Running /go/src/github.com/docker/docker/integration/image (s390x.integration.image) flags=-test.v -test.timeout=120m 
14:29:51 [2019-09-30T14:29:51.429Z] ++ 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
14:29:51 [2019-09-30T14:29:51.429Z] ++ set -e
14:29:51 [2019-09-30T14:29:51.429Z] ++ '[' -n 0 ']'
14:29:51 [2019-09-30T14:29:51.429Z] ++ set -x
14:29:51 [2019-09-30T14:29:51.429Z] ++ 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
14:29:51 [2019-09-30T14:29:51.429Z] INFO: Testing against a local daemon
14:29:51 [2019-09-30T14:29:51.429Z] === RUN   TestCommitInheritsEnv
14:29:52 [2019-09-30T14:29:52.232Z] --- PASS: TestCommitInheritsEnv (0.53s)
14:29:52 [2019-09-30T14:29:52.232Z] === RUN   TestImportExtremelyLargeImageWorks
14:29:52 [2019-09-30T14:29:52.232Z] === PAUSE TestImportExtremelyLargeImageWorks
14:29:52 [2019-09-30T14:29:52.232Z] === RUN   TestImagesFilterMultiReference
14:29:52 [2019-09-30T14:29:52.232Z] --- PASS: TestImagesFilterMultiReference (0.05s)
14:29:52 [2019-09-30T14:29:52.232Z] === RUN   TestImagePullPlatformInvalid
14:29:52 [2019-09-30T14:29:52.232Z] --- PASS: TestImagePullPlatformInvalid (0.02s)
14:29:52 [2019-09-30T14:29:52.232Z] === RUN   TestRemoveImageOrphaning
14:29:52 [2019-09-30T14:29:52.625Z] --- PASS: TestRemoveImageOrphaning (0.51s)
14:29:52 [2019-09-30T14:29:52.625Z] === RUN   TestRemoveImageGarbageCollector
14:29:52 [2019-09-30T14:29:52.625Z] --- SKIP: TestRemoveImageGarbageCollector (0.00s)
14:29:52 [2019-09-30T14:29:52.625Z]     remove_unix_test.go:36: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
14:29:52 [2019-09-30T14:29:52.625Z] === RUN   TestTagUnprefixedRepoByNameOrName
14:29:52 [2019-09-30T14:29:52.625Z] --- PASS: TestTagUnprefixedRepoByNameOrName (0.03s)
14:29:52 [2019-09-30T14:29:52.625Z] === RUN   TestTagInvalidReference
14:29:52 [2019-09-30T14:29:52.625Z] --- PASS: TestTagInvalidReference (0.01s)
14:29:52 [2019-09-30T14:29:52.625Z] === RUN   TestTagValidPrefixedRepo
14:29:52 [2019-09-30T14:29:52.625Z] --- PASS: TestTagValidPrefixedRepo (0.04s)
14:29:52 [2019-09-30T14:29:52.625Z] === RUN   TestTagExistedNameWithoutForce
14:29:52 [2019-09-30T14:29:52.625Z] --- PASS: TestTagExistedNameWithoutForce (0.02s)
14:29:52 [2019-09-30T14:29:52.625Z] === RUN   TestTagOfficialNames
14:29:52 [2019-09-30T14:29:52.625Z] --- PASS: TestTagOfficialNames (0.05s)
14:29:52 [2019-09-30T14:29:52.625Z] === RUN   TestTagMatchesDigest
14:29:52 [2019-09-30T14:29:52.625Z] --- PASS: TestTagMatchesDigest (0.02s)
14:29:52 [2019-09-30T14:29:52.625Z] === CONT  TestImportExtremelyLargeImageWorks
14:31:47 [2019-09-30T14:31:47.523Z] --- PASS: TestImportExtremelyLargeImageWorks (111.18s)
14:31:47 [2019-09-30T14:31:47.523Z]     import_test.go:26: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestImportExtremelyLargeImageWorks"
14:31:47 [2019-09-30T14:31:47.523Z] PASS
14:31:47 [2019-09-30T14:31:47.523Z] 
14:31:47 [2019-09-30T14:31:47.523Z] === Skipped
14:31:47 [2019-09-30T14:31:47.523Z] === SKIP: s390x.integration.image TestRemoveImageGarbageCollector (0.00s)
14:31:47 [2019-09-30T14:31:47.523Z]     remove_unix_test.go:36: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
14:31:47 [2019-09-30T14:31:47.523Z] 
14:31:47 [2019-09-30T14:31:47.523Z] 
14:31:47 [2019-09-30T14:31:47.523Z] DONE 12 tests, 1 skipped in 112.794s
14:31:47 [2019-09-30T14:31:47.523Z] Running /go/src/github.com/docker/docker/integration/network (s390x.integration.network) flags=-test.v -test.timeout=120m 
14:31:47 [2019-09-30T14:31:47.523Z] ++ 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
14:31:47 [2019-09-30T14:31:47.523Z] ++ set -e
14:31:47 [2019-09-30T14:31:47.523Z] ++ '[' -n 0 ']'
14:31:47 [2019-09-30T14:31:47.523Z] ++ set -x
14:31:47 [2019-09-30T14:31:47.523Z] ++ 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
14:31:47 [2019-09-30T14:31:47.523Z] INFO: Testing against a local daemon
14:31:47 [2019-09-30T14:31:47.523Z] === RUN   TestNetworkCreateDelete
14:31:47 [2019-09-30T14:31:47.523Z] --- PASS: TestNetworkCreateDelete (0.12s)
14:31:47 [2019-09-30T14:31:47.523Z] === RUN   TestDockerNetworkDeletePreferID
14:31:47 [2019-09-30T14:31:47.523Z] --- PASS: TestDockerNetworkDeletePreferID (0.33s)
14:31:47 [2019-09-30T14:31:47.523Z] === RUN   TestInspectNetwork
14:31:49 [2019-09-30T14:31:49.354Z] === RUN   TestInspectNetwork/full_network_id
14:31:49 [2019-09-30T14:31:49.354Z] === RUN   TestInspectNetwork/partial_network_id
14:31:49 [2019-09-30T14:31:49.354Z] === RUN   TestInspectNetwork/network_name
14:31:49 [2019-09-30T14:31:49.354Z] === RUN   TestInspectNetwork/network_name_and_swarm_scope
14:31:54 [2019-09-30T14:31:54.447Z] --- PASS: TestInspectNetwork (9.85s)
14:31:54 [2019-09-30T14:31:54.447Z]     inspect_test.go:18: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestInspectNetwork"
14:31:54 [2019-09-30T14:31:54.447Z]     --- PASS: TestInspectNetwork/full_network_id (0.01s)
14:31:54 [2019-09-30T14:31:54.447Z]     --- PASS: TestInspectNetwork/partial_network_id (0.00s)
14:31:54 [2019-09-30T14:31:54.447Z]     --- PASS: TestInspectNetwork/network_name (0.00s)
14:31:54 [2019-09-30T14:31:54.447Z]     --- PASS: TestInspectNetwork/network_name_and_swarm_scope (0.00s)
14:31:54 [2019-09-30T14:31:54.447Z] === RUN   TestRunContainerWithBridgeNone
14:31:57 [2019-09-30T14:31:57.665Z] --- PASS: TestRunContainerWithBridgeNone (2.76s)
14:31:57 [2019-09-30T14:31:57.665Z]     network_test.go:25: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestRunContainerWithBridgeNone"
14:31:57 [2019-09-30T14:31:57.665Z] === RUN   TestNetworkInvalidJSON
14:31:57 [2019-09-30T14:31:57.665Z] === RUN   TestNetworkInvalidJSON//networks/create
14:31:57 [2019-09-30T14:31:57.665Z] === PAUSE TestNetworkInvalidJSON//networks/create
14:31:57 [2019-09-30T14:31:57.665Z] === RUN   TestNetworkInvalidJSON//networks/bridge/connect
14:31:57 [2019-09-30T14:31:57.665Z] === PAUSE TestNetworkInvalidJSON//networks/bridge/connect
14:31:57 [2019-09-30T14:31:57.665Z] === RUN   TestNetworkInvalidJSON//networks/bridge/disconnect
14:31:57 [2019-09-30T14:31:57.665Z] === PAUSE TestNetworkInvalidJSON//networks/bridge/disconnect
14:31:57 [2019-09-30T14:31:57.665Z] === CONT  TestNetworkInvalidJSON//networks/create
14:31:57 [2019-09-30T14:31:57.665Z] === CONT  TestNetworkInvalidJSON//networks/bridge/disconnect
14:31:57 [2019-09-30T14:31:57.665Z] === CONT  TestNetworkInvalidJSON//networks/bridge/connect
14:31:57 [2019-09-30T14:31:57.665Z] --- PASS: TestNetworkInvalidJSON (0.01s)
14:31:57 [2019-09-30T14:31:57.665Z]     --- PASS: TestNetworkInvalidJSON//networks/create (0.00s)
14:31:57 [2019-09-30T14:31:57.665Z]     --- PASS: TestNetworkInvalidJSON//networks/bridge/disconnect (0.01s)
14:31:57 [2019-09-30T14:31:57.665Z]     --- PASS: TestNetworkInvalidJSON//networks/bridge/connect (0.01s)
14:31:57 [2019-09-30T14:31:57.665Z] === RUN   TestDaemonRestartWithLiveRestore
14:31:58 [2019-09-30T14:31:58.463Z] --- PASS: TestDaemonRestartWithLiveRestore (1.07s)
14:31:58 [2019-09-30T14:31:58.463Z]     service_test.go:32: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartWithLiveRestore"
14:31:58 [2019-09-30T14:31:58.463Z] === RUN   TestDaemonDefaultNetworkPools
14:31:59 [2019-09-30T14:31:59.264Z] --- PASS: TestDaemonDefaultNetworkPools (0.74s)
14:31:59 [2019-09-30T14:31:59.264Z]     service_test.go:57: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonDefaultNetworkPools"
14:31:59 [2019-09-30T14:31:59.264Z] === RUN   TestDaemonRestartWithExistingNetwork
14:32:00 [2019-09-30T14:32:00.325Z] --- PASS: TestDaemonRestartWithExistingNetwork (1.18s)
14:32:00 [2019-09-30T14:32:00.325Z]     service_test.go:98: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartWithExistingNetwork"
14:32:00 [2019-09-30T14:32:00.325Z] === RUN   TestDaemonRestartWithExistingNetworkWithDefaultPoolRange
14:32:01 [2019-09-30T14:32:01.623Z] --- PASS: TestDaemonRestartWithExistingNetworkWithDefaultPoolRange (1.20s)
14:32:01 [2019-09-30T14:32:01.623Z]     service_test.go:131: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartWithExistingNetworkWithDefaultPoolRange"
14:32:01 [2019-09-30T14:32:01.623Z] === RUN   TestDaemonWithBipAndDefaultNetworkPool
14:32:01 [2019-09-30T14:32:01.999Z] --- PASS: TestDaemonWithBipAndDefaultNetworkPool (0.62s)
14:32:01 [2019-09-30T14:32:01.999Z]     service_test.go:181: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonWithBipAndDefaultNetworkPool"
14:32:01 [2019-09-30T14:32:01.999Z] === RUN   TestServiceWithPredefinedNetwork
14:32:05 [2019-09-30T14:32:05.252Z] --- PASS: TestServiceWithPredefinedNetwork (2.99s)
14:32:05 [2019-09-30T14:32:05.252Z]     service_test.go:203: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithPredefinedNetwork"
14:32:05 [2019-09-30T14:32:05.252Z] === RUN   TestServiceRemoveKeepsIngressNetwork
14:32:05 [2019-09-30T14:32:05.252Z] --- SKIP: TestServiceRemoveKeepsIngressNetwork (0.00s)
14:32:05 [2019-09-30T14:32:05.252Z]     service_test.go:230: FLAKY_TEST
14:32:05 [2019-09-30T14:32:05.252Z] === RUN   TestServiceWithDataPathPortInit
14:32:21 [2019-09-30T14:32:21.909Z] --- PASS: TestServiceWithDataPathPortInit (16.87s)
14:32:21 [2019-09-30T14:32:21.909Z]     service_test.go:323: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithDataPathPortInit"
14:32:21 [2019-09-30T14:32:21.909Z]     service_test.go:355: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithDataPathPortInit"
14:32:21 [2019-09-30T14:32:21.909Z] === RUN   TestServiceWithDefaultAddressPoolInit
14:32:31 [2019-09-30T14:32:31.351Z] --- PASS: TestServiceWithDefaultAddressPoolInit (8.45s)
14:32:31 [2019-09-30T14:32:31.351Z]     service_test.go:388: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithDefaultAddressPoolInit"
14:32:31 [2019-09-30T14:32:31.351Z]     service_test.go:418: TestServiceWithDefaultAddressPoolInit: NetworkInspect: {Name:sthiraTestServiceWithDefaultAddressPoolInit ID:ugmp3qj3ff22csa610kmajs4u Created:2019-09-30 14:32:23.378342635 +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[fa271d748f42cf9b57c58aa603e7b92dc4c36d5f2803833420bacf7b7f095f32:{Name:TestServiceTestServiceWithDefaultAddressPoolInit.1.rq5fc1dvd3179mfe2jmuxjoyv EndpointID:cd0a0010cacdae15b7017f28ff16bd06dda2847384e1ff170f3282b6dd3b5892 MacAddress:02:42:14:14:00:03 IPv4Address:20.20.0.3/24 IPv6Address:} lb-sthiraTestServiceWithDefaultAddressPoolInit:{Name:sthiraTestServiceWithDefaultAddressPoolInit-endpoint EndpointID:12dfe4d30cc48d26c130a0c5619db8a12fe9b44a4295c37eaea4cda2dd45dc60 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:7fcc51e7ede4 IP:127.0.0.1}] Services:map[TestServiceTestServiceWithDefaultAddressPoolInit:{VIP:20.20.0.2 Ports:[] LocalLBIndex:256 Tasks:[{Name:TestServiceTestServiceWithDefaultAddressPoolInit.1.rq5fc1dvd3179mfe2jmuxjoyv EndpointID:cd0a0010cacdae15b7017f28ff16bd06dda2847384e1ff170f3282b6dd3b5892 EndpointIP:20.20.0.3 Info:map[Host IP:127.0.0.1]}]}]}
14:32:31 [2019-09-30T14:32:31.351Z] PASS
14:32:31 [2019-09-30T14:32:31.351Z] 
14:32:31 [2019-09-30T14:32:31.351Z] === Skipped
14:32:31 [2019-09-30T14:32:31.351Z] === SKIP: s390x.integration.network TestServiceRemoveKeepsIngressNetwork (0.00s)
14:32:31 [2019-09-30T14:32:31.351Z]     service_test.go:230: FLAKY_TEST
14:32:31 [2019-09-30T14:32:31.351Z] 
14:32:31 [2019-09-30T14:32:31.351Z] 
14:32:31 [2019-09-30T14:32:31.351Z] DONE 21 tests, 1 skipped in 46.417s
14:32:31 [2019-09-30T14:32:31.351Z] Running /go/src/github.com/docker/docker/integration/network/ipvlan (s390x.integration.network.ipvlan) flags=-test.v -test.timeout=120m 
14:32:31 [2019-09-30T14:32:31.351Z] ++ 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
14:32:31 [2019-09-30T14:32:31.351Z] ++ set -e
14:32:31 [2019-09-30T14:32:31.351Z] ++ '[' -n 0 ']'
14:32:31 [2019-09-30T14:32:31.351Z] ++ set -x
14:32:31 [2019-09-30T14:32:31.351Z] ++ 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
14:32:31 [2019-09-30T14:32:31.351Z] INFO: Testing against a local daemon
14:32:31 [2019-09-30T14:32:31.351Z] === RUN   TestDockerNetworkIpvlanPersistance
14:32:31 [2019-09-30T14:32:31.351Z] --- SKIP: TestDockerNetworkIpvlanPersistance (0.02s)
14:32:31 [2019-09-30T14:32:31.351Z]     ipvlan_test.go:26: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
14:32:31 [2019-09-30T14:32:31.351Z] === RUN   TestDockerNetworkIpvlan
14:32:31 [2019-09-30T14:32:31.351Z] --- SKIP: TestDockerNetworkIpvlan (0.00s)
14:32:31 [2019-09-30T14:32:31.351Z]     ipvlan_test.go:53: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
14:32:31 [2019-09-30T14:32:31.351Z] PASS
14:32:31 [2019-09-30T14:32:31.351Z] 
14:32:31 [2019-09-30T14:32:31.351Z] === Skipped
14:32:31 [2019-09-30T14:32:31.351Z] === SKIP: s390x.integration.network.ipvlan TestDockerNetworkIpvlanPersistance (0.02s)
14:32:31 [2019-09-30T14:32:31.351Z]     ipvlan_test.go:26: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
14:32:31 [2019-09-30T14:32:31.351Z] 
14:32:31 [2019-09-30T14:32:31.351Z] === SKIP: s390x.integration.network.ipvlan TestDockerNetworkIpvlan (0.00s)
14:32:31 [2019-09-30T14:32:31.351Z]     ipvlan_test.go:53: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
14:32:31 [2019-09-30T14:32:31.351Z] 
14:32:31 [2019-09-30T14:32:31.351Z] 
14:32:31 [2019-09-30T14:32:31.351Z] DONE 2 tests, 2 skipped in 0.226s
14:32:31 [2019-09-30T14:32:31.351Z] Running /go/src/github.com/docker/docker/integration/network/macvlan (s390x.integration.network.macvlan) flags=-test.v -test.timeout=120m 
14:32:31 [2019-09-30T14:32:31.351Z] ++ 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
14:32:31 [2019-09-30T14:32:31.351Z] ++ set -e
14:32:31 [2019-09-30T14:32:31.351Z] ++ '[' -n 0 ']'
14:32:31 [2019-09-30T14:32:31.351Z] ++ set -x
14:32:31 [2019-09-30T14:32:31.351Z] ++ 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
14:32:31 [2019-09-30T14:32:31.351Z] INFO: Testing against a local daemon
14:32:31 [2019-09-30T14:32:31.351Z] === RUN   TestDockerNetworkMacvlanPersistance
14:32:32 [2019-09-30T14:32:32.157Z] --- PASS: TestDockerNetworkMacvlanPersistance (1.44s)
14:32:32 [2019-09-30T14:32:32.157Z]     macvlan_test.go:24: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlanPersistance"
14:32:32 [2019-09-30T14:32:32.157Z] === RUN   TestDockerNetworkMacvlan
14:32:32 [2019-09-30T14:32:32.978Z] === RUN   TestDockerNetworkMacvlan/Subinterface
14:32:33 [2019-09-30T14:32:33.840Z] === RUN   TestDockerNetworkMacvlan/OverlapParent
14:32:35 [2019-09-30T14:32:35.255Z] === RUN   TestDockerNetworkMacvlan/NilParent
14:32:37 [2019-09-30T14:32:37.744Z] === RUN   TestDockerNetworkMacvlan/InternalMode
14:32:41 [2019-09-30T14:32:41.849Z] === RUN   TestDockerNetworkMacvlan/MultiSubnet
14:32:46 [2019-09-30T14:32:46.075Z] === RUN   TestDockerNetworkMacvlan/Addressing
14:32:47 [2019-09-30T14:32:47.944Z] --- PASS: TestDockerNetworkMacvlan (15.33s)
14:32:47 [2019-09-30T14:32:47.944Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
14:32:47 [2019-09-30T14:32:47.944Z]     --- PASS: TestDockerNetworkMacvlan/Subinterface (0.06s)
14:32:47 [2019-09-30T14:32:47.944Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
14:32:47 [2019-09-30T14:32:47.944Z]     --- PASS: TestDockerNetworkMacvlan/OverlapParent (0.12s)
14:32:47 [2019-09-30T14:32:47.944Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
14:32:47 [2019-09-30T14:32:47.944Z]     --- PASS: TestDockerNetworkMacvlan/NilParent (1.17s)
14:32:47 [2019-09-30T14:32:47.944Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
14:32:47 [2019-09-30T14:32:47.944Z]     --- PASS: TestDockerNetworkMacvlan/InternalMode (2.25s)
14:32:47 [2019-09-30T14:32:47.944Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
14:32:47 [2019-09-30T14:32:47.944Z]     --- PASS: TestDockerNetworkMacvlan/MultiSubnet (3.29s)
14:32:47 [2019-09-30T14:32:47.944Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
14:32:47 [2019-09-30T14:32:47.944Z]     --- PASS: TestDockerNetworkMacvlan/Addressing (1.02s)
14:32:47 [2019-09-30T14:32:47.944Z] PASS
14:32:47 [2019-09-30T14:32:47.944Z] 
14:32:47 [2019-09-30T14:32:47.944Z] DONE 8 tests in 16.912s
14:32:47 [2019-09-30T14:32:47.945Z] Running /go/src/github.com/docker/docker/integration/plugin (s390x.integration.plugin) flags=-test.v -test.timeout=120m 
14:32:47 [2019-09-30T14:32:47.945Z] ++ 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
14:32:47 [2019-09-30T14:32:47.945Z] ++ set -e
14:32:47 [2019-09-30T14:32:47.945Z] ++ '[' -n 0 ']'
14:32:47 [2019-09-30T14:32:47.945Z] ++ set -x
14:32:47 [2019-09-30T14:32:47.945Z] ++ 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
14:32:47 [2019-09-30T14:32:47.945Z] testing: warning: no tests to run
14:32:47 [2019-09-30T14:32:47.945Z] PASS
14:32:47 [2019-09-30T14:32:47.945Z] 
14:32:47 [2019-09-30T14:32:47.945Z] DONE 0 tests in 0.077s
14:32:47 [2019-09-30T14:32:47.945Z] Running /go/src/github.com/docker/docker/integration/plugin/authz (s390x.integration.plugin.authz) flags=-test.v -test.timeout=120m 
14:32:47 [2019-09-30T14:32:47.945Z] ++ 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
14:32:47 [2019-09-30T14:32:47.945Z] ++ set -e
14:32:47 [2019-09-30T14:32:47.945Z] ++ '[' -n 0 ']'
14:32:47 [2019-09-30T14:32:47.945Z] ++ set -x
14:32:47 [2019-09-30T14:32:47.945Z] ++ 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
14:32:47 [2019-09-30T14:32:47.945Z] INFO: Testing against a local daemon
14:32:47 [2019-09-30T14:32:47.945Z] === RUN   TestAuthZPluginAllowRequest
14:32:49 [2019-09-30T14:32:49.913Z] --- PASS: TestAuthZPluginAllowRequest (1.77s)
14:32:49 [2019-09-30T14:32:49.913Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginAllowRequest"
14:32:49 [2019-09-30T14:32:49.913Z] === RUN   TestAuthZPluginTLS
14:32:50 [2019-09-30T14:32:50.279Z] --- PASS: TestAuthZPluginTLS (0.55s)
14:32:50 [2019-09-30T14:32:50.279Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginTLS"
14:32:50 [2019-09-30T14:32:50.279Z] === RUN   TestAuthZPluginDenyRequest
14:32:50 [2019-09-30T14:32:50.650Z] --- PASS: TestAuthZPluginDenyRequest (0.53s)
14:32:50 [2019-09-30T14:32:50.650Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginDenyRequest"
14:32:50 [2019-09-30T14:32:50.650Z] === RUN   TestAuthZPluginAPIDenyResponse
14:32:51 [2019-09-30T14:32:51.471Z] --- PASS: TestAuthZPluginAPIDenyResponse (0.54s)
14:32:51 [2019-09-30T14:32:51.471Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginAPIDenyResponse"
14:32:51 [2019-09-30T14:32:51.471Z] === RUN   TestAuthZPluginDenyResponse
14:32:51 [2019-09-30T14:32:51.841Z] --- PASS: TestAuthZPluginDenyResponse (0.57s)
14:32:51 [2019-09-30T14:32:51.841Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginDenyResponse"
14:32:51 [2019-09-30T14:32:51.841Z] === RUN   TestAuthZPluginAllowEventStream
14:32:53 [2019-09-30T14:32:53.702Z] --- PASS: TestAuthZPluginAllowEventStream (1.68s)
14:32:53 [2019-09-30T14:32:53.702Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginAllowEventStream"
14:32:53 [2019-09-30T14:32:53.702Z] === RUN   TestAuthZPluginErrorResponse
14:32:54 [2019-09-30T14:32:54.067Z] --- PASS: TestAuthZPluginErrorResponse (0.54s)
14:32:54 [2019-09-30T14:32:54.067Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginErrorResponse"
14:32:54 [2019-09-30T14:32:54.067Z] === RUN   TestAuthZPluginErrorRequest
14:32:54 [2019-09-30T14:32:54.455Z] --- PASS: TestAuthZPluginErrorRequest (0.54s)
14:32:54 [2019-09-30T14:32:54.455Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginErrorRequest"
14:32:54 [2019-09-30T14:32:54.455Z] === RUN   TestAuthZPluginEnsureNoDuplicatePluginRegistration
14:32:55 [2019-09-30T14:32:55.260Z] --- PASS: TestAuthZPluginEnsureNoDuplicatePluginRegistration (0.54s)
14:32:55 [2019-09-30T14:32:55.260Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginEnsureNoDuplicatePluginRegistration"
14:32:55 [2019-09-30T14:32:55.260Z] === RUN   TestAuthZPluginEnsureLoadImportWorking
14:32:57 [2019-09-30T14:32:57.209Z] --- PASS: TestAuthZPluginEnsureLoadImportWorking (2.16s)
14:32:57 [2019-09-30T14:32:57.209Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginEnsureLoadImportWorking"
14:32:57 [2019-09-30T14:32:57.209Z] === RUN   TestAuthzPluginEnsureContainerCopyToFrom
14:32:59 [2019-09-30T14:32:59.687Z] --- PASS: TestAuthzPluginEnsureContainerCopyToFrom (2.20s)
14:32:59 [2019-09-30T14:32:59.687Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthzPluginEnsureContainerCopyToFrom"
14:32:59 [2019-09-30T14:32:59.687Z] === RUN   TestAuthZPluginHeader
14:33:00 [2019-09-30T14:33:00.487Z] --- PASS: TestAuthZPluginHeader (0.89s)
14:33:00 [2019-09-30T14:33:00.487Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginHeader"
14:33:00 [2019-09-30T14:33:00.487Z] === RUN   TestAuthZPluginV2AllowNonVolumeRequest
14:33:00 [2019-09-30T14:33:00.487Z] --- SKIP: TestAuthZPluginV2AllowNonVolumeRequest (0.01s)
14:33:00 [2019-09-30T14:33:00.487Z]     authz_plugin_v2_test.go:43: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
14:33:00 [2019-09-30T14:33:00.487Z] === RUN   TestAuthZPluginV2Disable
14:33:00 [2019-09-30T14:33:00.487Z] --- SKIP: TestAuthZPluginV2Disable (0.00s)
14:33:00 [2019-09-30T14:33:00.487Z]     authz_plugin_v2_test.go:65: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
14:33:00 [2019-09-30T14:33:00.487Z] === RUN   TestAuthZPluginV2RejectVolumeRequests
14:33:00 [2019-09-30T14:33:00.487Z] --- SKIP: TestAuthZPluginV2RejectVolumeRequests (0.00s)
14:33:00 [2019-09-30T14:33:00.487Z]     authz_plugin_v2_test.go:91: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
14:33:00 [2019-09-30T14:33:00.487Z] === RUN   TestAuthZPluginV2BadManifestFailsDaemonStart
14:33:00 [2019-09-30T14:33:00.487Z] --- SKIP: TestAuthZPluginV2BadManifestFailsDaemonStart (0.00s)
14:33:00 [2019-09-30T14:33:00.487Z]     authz_plugin_v2_test.go:126: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
14:33:00 [2019-09-30T14:33:00.487Z] === RUN   TestAuthZPluginV2NonexistentFailsDaemonStart
14:33:20 [2019-09-30T14:33:20.268Z] --- PASS: TestAuthZPluginV2NonexistentFailsDaemonStart (16.86s)
14:33:20 [2019-09-30T14:33:20.268Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginV2NonexistentFailsDaemonStart"
14:33:20 [2019-09-30T14:33:20.268Z] PASS
14:33:20 [2019-09-30T14:33:20.268Z] 
14:33:20 [2019-09-30T14:33:20.268Z] === Skipped
14:33:20 [2019-09-30T14:33:20.268Z] === SKIP: s390x.integration.plugin.authz TestAuthZPluginV2AllowNonVolumeRequest (0.01s)
14:33:20 [2019-09-30T14:33:20.268Z]     authz_plugin_v2_test.go:43: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
14:33:20 [2019-09-30T14:33:20.268Z] 
14:33:20 [2019-09-30T14:33:20.268Z] === SKIP: s390x.integration.plugin.authz TestAuthZPluginV2Disable (0.00s)
14:33:20 [2019-09-30T14:33:20.268Z]     authz_plugin_v2_test.go:65: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
14:33:20 [2019-09-30T14:33:20.268Z] 
14:33:20 [2019-09-30T14:33:20.268Z] === SKIP: s390x.integration.plugin.authz TestAuthZPluginV2RejectVolumeRequests (0.00s)
14:33:20 [2019-09-30T14:33:20.268Z]     authz_plugin_v2_test.go:91: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
14:33:20 [2019-09-30T14:33:20.268Z] 
14:33:20 [2019-09-30T14:33:20.268Z] === SKIP: s390x.integration.plugin.authz TestAuthZPluginV2BadManifestFailsDaemonStart (0.00s)
14:33:20 [2019-09-30T14:33:20.268Z]     authz_plugin_v2_test.go:126: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
14:33:20 [2019-09-30T14:33:20.268Z] 
14:33:20 [2019-09-30T14:33:20.268Z] 
14:33:20 [2019-09-30T14:33:20.268Z] DONE 17 tests, 4 skipped in 29.605s
14:33:20 [2019-09-30T14:33:20.268Z] Running /go/src/github.com/docker/docker/integration/plugin/common (s390x.integration.plugin.common) flags=-test.v -test.timeout=120m 
14:33:20 [2019-09-30T14:33:20.268Z] ++ 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
14:33:20 [2019-09-30T14:33:20.269Z] ++ set -e
14:33:20 [2019-09-30T14:33:20.269Z] ++ '[' -n 0 ']'
14:33:20 [2019-09-30T14:33:20.269Z] ++ set -x
14:33:20 [2019-09-30T14:33:20.269Z] ++ 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
14:33:20 [2019-09-30T14:33:20.269Z] INFO: Testing against a local daemon
14:33:20 [2019-09-30T14:33:20.269Z] === RUN   TestPluginInvalidJSON
14:33:20 [2019-09-30T14:33:20.269Z] === RUN   TestPluginInvalidJSON//plugins/foobar/set
14:33:20 [2019-09-30T14:33:20.269Z] === PAUSE TestPluginInvalidJSON//plugins/foobar/set
14:33:20 [2019-09-30T14:33:20.269Z] === CONT  TestPluginInvalidJSON//plugins/foobar/set
14:33:20 [2019-09-30T14:33:20.269Z] --- PASS: TestPluginInvalidJSON (0.03s)
14:33:20 [2019-09-30T14:33:20.269Z]     --- PASS: TestPluginInvalidJSON//plugins/foobar/set (0.00s)
14:33:20 [2019-09-30T14:33:20.269Z] PASS
14:33:20 [2019-09-30T14:33:20.269Z] 
14:33:20 [2019-09-30T14:33:20.269Z] DONE 2 tests in 0.204s
14:33:20 [2019-09-30T14:33:20.269Z] Running /go/src/github.com/docker/docker/integration/plugin/graphdriver (s390x.integration.plugin.graphdriver) flags=-test.v -test.timeout=120m 
14:33:20 [2019-09-30T14:33:20.269Z] ++ 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
14:33:20 [2019-09-30T14:33:20.269Z] ++ set -e
14:33:20 [2019-09-30T14:33:20.269Z] ++ '[' -n 0 ']'
14:33:20 [2019-09-30T14:33:20.269Z] ++ set -x
14:33:20 [2019-09-30T14:33:20.269Z] ++ 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
14:33:20 [2019-09-30T14:33:20.269Z] INFO: Testing against a local daemon
14:33:20 [2019-09-30T14:33:20.269Z] === RUN   TestExternalGraphDriver
14:33:20 [2019-09-30T14:33:20.269Z] === RUN   TestExternalGraphDriver/json
14:33:20 [2019-09-30T14:33:20.269Z] === RUN   TestExternalGraphDriver/spec
14:33:22 [2019-09-30T14:33:22.208Z] === RUN   TestExternalGraphDriver/pull
14:33:24 [2019-09-30T14:33:24.677Z] --- PASS: TestExternalGraphDriver (6.60s)
14:33:24 [2019-09-30T14:33:24.677Z]     external_test.go:57: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestExternalGraphDriver"
14:33:24 [2019-09-30T14:33:24.677Z]     --- PASS: TestExternalGraphDriver/json (2.12s)
14:33:24 [2019-09-30T14:33:24.677Z]     --- PASS: TestExternalGraphDriver/spec (2.16s)
14:33:24 [2019-09-30T14:33:24.677Z]     --- PASS: TestExternalGraphDriver/pull (2.15s)
14:33:24 [2019-09-30T14:33:24.677Z] === RUN   TestGraphdriverPluginV2
14:33:24 [2019-09-30T14:33:24.677Z] --- SKIP: TestGraphdriverPluginV2 (0.06s)
14:33:24 [2019-09-30T14:33:24.677Z]     external_test.go:410: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
14:33:24 [2019-09-30T14:33:24.677Z] PASS
14:33:24 [2019-09-30T14:33:24.677Z] 
14:33:24 [2019-09-30T14:33:24.677Z] === Skipped
14:33:24 [2019-09-30T14:33:24.677Z] === SKIP: s390x.integration.plugin.graphdriver TestGraphdriverPluginV2 (0.06s)
14:33:24 [2019-09-30T14:33:24.677Z]     external_test.go:410: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
14:33:24 [2019-09-30T14:33:24.677Z] 
14:33:24 [2019-09-30T14:33:24.677Z] 
14:33:24 [2019-09-30T14:33:24.677Z] DONE 5 tests, 1 skipped in 6.821s
14:33:24 [2019-09-30T14:33:24.677Z] Running /go/src/github.com/docker/docker/integration/plugin/logging (s390x.integration.plugin.logging) flags=-test.v -test.timeout=120m 
14:33:24 [2019-09-30T14:33:24.677Z] ++ 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
14:33:24 [2019-09-30T14:33:24.677Z] ++ set -e
14:33:24 [2019-09-30T14:33:24.677Z] ++ '[' -n 0 ']'
14:33:24 [2019-09-30T14:33:24.677Z] ++ set -x
14:33:24 [2019-09-30T14:33:24.677Z] ++ 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
14:33:24 [2019-09-30T14:33:24.677Z] INFO: Testing against a local daemon
14:33:24 [2019-09-30T14:33:24.677Z] === RUN   TestContinueAfterPluginCrash
14:33:24 [2019-09-30T14:33:24.677Z] === PAUSE TestContinueAfterPluginCrash
14:33:24 [2019-09-30T14:33:24.677Z] === RUN   TestDaemonStartWithLogOpt
14:33:24 [2019-09-30T14:33:24.677Z] === PAUSE TestDaemonStartWithLogOpt
14:33:24 [2019-09-30T14:33:24.677Z] === CONT  TestContinueAfterPluginCrash
14:33:24 [2019-09-30T14:33:24.677Z] === CONT  TestDaemonStartWithLogOpt
14:33:36 [2019-09-30T14:33:36.178Z] --- PASS: TestDaemonStartWithLogOpt (11.01s)
14:33:36 [2019-09-30T14:33:36.178Z]     validation_test.go:23: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonStartWithLogOpt"
14:33:41 [2019-09-30T14:33:41.267Z] --- PASS: TestContinueAfterPluginCrash (15.97s)
14:33:41 [2019-09-30T14:33:41.267Z]     logging_linux_test.go:22: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestContinueAfterPluginCrash"
14:33:41 [2019-09-30T14:33:41.267Z] PASS
14:33:41 [2019-09-30T14:33:41.267Z] 
14:33:41 [2019-09-30T14:33:41.267Z] DONE 2 tests in 16.140s
14:33:41 [2019-09-30T14:33:41.267Z] Running /go/src/github.com/docker/docker/integration/plugin/volumes (s390x.integration.plugin.volumes) flags=-test.v -test.timeout=120m 
14:33:41 [2019-09-30T14:33:41.267Z] ++ 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
14:33:41 [2019-09-30T14:33:41.267Z] ++ set -e
14:33:41 [2019-09-30T14:33:41.267Z] ++ '[' -n 0 ']'
14:33:41 [2019-09-30T14:33:41.267Z] ++ set -x
14:33:41 [2019-09-30T14:33:41.267Z] ++ 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
14:33:41 [2019-09-30T14:33:41.267Z] INFO: Testing against a local daemon
14:33:41 [2019-09-30T14:33:41.267Z] === RUN   TestPluginWithDevMounts
14:33:41 [2019-09-30T14:33:41.267Z] === PAUSE TestPluginWithDevMounts
14:33:41 [2019-09-30T14:33:41.267Z] === CONT  TestPluginWithDevMounts
14:33:42 [2019-09-30T14:33:42.622Z] --- PASS: TestPluginWithDevMounts (2.04s)
14:33:42 [2019-09-30T14:33:42.622Z]     mounts_test.go:23: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestPluginWithDevMounts"
14:33:42 [2019-09-30T14:33:42.622Z] PASS
14:33:42 [2019-09-30T14:33:42.622Z] 
14:33:42 [2019-09-30T14:33:42.622Z] DONE 1 tests in 2.198s
14:33:42 [2019-09-30T14:33:42.622Z] Running /go/src/github.com/docker/docker/integration/secret (s390x.integration.secret) flags=-test.v -test.timeout=120m 
14:33:42 [2019-09-30T14:33:42.622Z] ++ 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
14:33:42 [2019-09-30T14:33:42.622Z] ++ set -e
14:33:42 [2019-09-30T14:33:42.622Z] ++ '[' -n 0 ']'
14:33:42 [2019-09-30T14:33:42.622Z] ++ set -x
14:33:42 [2019-09-30T14:33:42.622Z] ++ 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
14:33:43 [2019-09-30T14:33:43.018Z] INFO: Testing against a local daemon
14:33:43 [2019-09-30T14:33:43.018Z] === RUN   TestSecretInspect
14:33:46 [2019-09-30T14:33:46.256Z] --- PASS: TestSecretInspect (2.90s)
14:33:46 [2019-09-30T14:33:46.256Z]     secret_test.go:25: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestSecretInspect"
14:33:46 [2019-09-30T14:33:46.256Z] === RUN   TestSecretList
14:33:48 [2019-09-30T14:33:48.716Z] --- PASS: TestSecretList (2.89s)
14:33:48 [2019-09-30T14:33:48.716Z]     secret_test.go:48: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestSecretList"
14:33:48 [2019-09-30T14:33:48.716Z] === RUN   TestSecretsCreateAndDelete
14:33:52 [2019-09-30T14:33:52.054Z] --- PASS: TestSecretsCreateAndDelete (3.01s)
14:33:52 [2019-09-30T14:33:52.054Z]     secret_test.go:125: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestSecretsCreateAndDelete"
14:33:52 [2019-09-30T14:33:52.054Z] === RUN   TestSecretsUpdate
14:33:54 [2019-09-30T14:33:54.508Z] --- PASS: TestSecretsUpdate (2.88s)
14:33:54 [2019-09-30T14:33:54.508Z]     secret_test.go:172: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestSecretsUpdate"
14:33:54 [2019-09-30T14:33:54.508Z] === RUN   TestTemplatedSecret
14:33:58 [2019-09-30T14:33:58.678Z] --- PASS: TestTemplatedSecret (3.73s)
14:33:58 [2019-09-30T14:33:58.678Z]     secret_test.go:221: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestTemplatedSecret"
14:33:58 [2019-09-30T14:33:58.678Z] === RUN   TestSecretCreateResolve
14:34:01 [2019-09-30T14:34:01.175Z] --- PASS: TestSecretCreateResolve (2.76s)
14:34:01 [2019-09-30T14:34:01.175Z]     secret_test.go:342: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestSecretCreateResolve"
14:34:01 [2019-09-30T14:34:01.175Z] PASS
14:34:01 [2019-09-30T14:34:01.175Z] 
14:34:01 [2019-09-30T14:34:01.175Z] DONE 6 tests in 18.367s
14:34:01 [2019-09-30T14:34:01.175Z] Running /go/src/github.com/docker/docker/integration/service (s390x.integration.service) flags=-test.v -test.timeout=120m 
14:34:01 [2019-09-30T14:34:01.175Z] ++ 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
14:34:01 [2019-09-30T14:34:01.175Z] ++ set -e
14:34:01 [2019-09-30T14:34:01.175Z] ++ '[' -n 0 ']'
14:34:01 [2019-09-30T14:34:01.175Z] ++ set -x
14:34:01 [2019-09-30T14:34:01.175Z] ++ 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
14:34:01 [2019-09-30T14:34:01.175Z] INFO: Testing against a local daemon
14:34:01 [2019-09-30T14:34:01.175Z] === RUN   TestServiceCreateInit
14:34:01 [2019-09-30T14:34:01.175Z] === RUN   TestServiceCreateInit/daemonInitDisabled
14:34:06 [2019-09-30T14:34:06.263Z] === RUN   TestServiceCreateInit/daemonInitEnabled
14:34:11 [2019-09-30T14:34:11.511Z] --- PASS: TestServiceCreateInit (9.80s)
14:34:11 [2019-09-30T14:34:11.511Z]     --- PASS: TestServiceCreateInit/daemonInitDisabled (4.99s)
14:34:11 [2019-09-30T14:34:11.511Z]         create_test.go:38: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceCreateInit/daemonInitDisabled"
14:34:11 [2019-09-30T14:34:11.511Z]     --- PASS: TestServiceCreateInit/daemonInitEnabled (4.79s)
14:34:11 [2019-09-30T14:34:11.511Z]         create_test.go:38: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceCreateInit/daemonInitEnabled"
14:34:11 [2019-09-30T14:34:11.511Z] === RUN   TestCreateServiceMultipleTimes
14:34:31 [2019-09-30T14:34:31.303Z] --- PASS: TestCreateServiceMultipleTimes (17.36s)
14:34:31 [2019-09-30T14:34:31.303Z]     create_test.go:80: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceMultipleTimes"
14:34:31 [2019-09-30T14:34:31.303Z] === RUN   TestCreateServiceConflict
14:34:31 [2019-09-30T14:34:31.303Z] --- PASS: TestCreateServiceConflict (2.77s)
14:34:31 [2019-09-30T14:34:31.303Z]     create_test.go:129: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceConflict"
14:34:31 [2019-09-30T14:34:31.303Z] === RUN   TestCreateServiceMaxReplicas
14:34:35 [2019-09-30T14:34:35.341Z] --- PASS: TestCreateServiceMaxReplicas (3.58s)
14:34:35 [2019-09-30T14:34:35.341Z]     create_test.go:150: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceMaxReplicas"
14:34:35 [2019-09-30T14:34:35.341Z] === RUN   TestCreateWithDuplicateNetworkNames
14:34:49 [2019-09-30T14:34:49.158Z] --- PASS: TestCreateWithDuplicateNetworkNames (14.19s)
14:34:49 [2019-09-30T14:34:49.158Z]     create_test.go:171: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateWithDuplicateNetworkNames"
14:34:49 [2019-09-30T14:34:49.158Z] === RUN   TestCreateServiceSecretFileMode
14:34:52 [2019-09-30T14:34:52.467Z] --- PASS: TestCreateServiceSecretFileMode (3.51s)
14:34:52 [2019-09-30T14:34:52.467Z]     create_test.go:224: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceSecretFileMode"
14:34:52 [2019-09-30T14:34:52.467Z] === RUN   TestCreateServiceConfigFileMode
14:34:55 [2019-09-30T14:34:55.678Z] --- PASS: TestCreateServiceConfigFileMode (3.18s)
14:34:55 [2019-09-30T14:34:55.678Z]     create_test.go:288: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceConfigFileMode"
14:34:55 [2019-09-30T14:34:55.678Z] === RUN   TestCreateServiceSysctls
14:34:59 [2019-09-30T14:34:59.829Z] --- PASS: TestCreateServiceSysctls (4.24s)
14:34:59 [2019-09-30T14:34:59.829Z]     create_test.go:378: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceSysctls"
14:34:59 [2019-09-30T14:34:59.829Z] === RUN   TestCreateServiceCapabilities
14:35:03 [2019-09-30T14:35:03.054Z] --- PASS: TestCreateServiceCapabilities (2.81s)
14:35:03 [2019-09-30T14:35:03.054Z]     create_test.go:462: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceCapabilities"
14:35:03 [2019-09-30T14:35:03.054Z] === RUN   TestInspect
14:35:06 [2019-09-30T14:35:06.304Z] --- PASS: TestInspect (3.09s)
14:35:06 [2019-09-30T14:35:06.304Z]     inspect_test.go:23: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestInspect"
14:35:06 [2019-09-30T14:35:06.304Z] === RUN   TestDockerNetworkConnectAlias
14:35:12 [2019-09-30T14:35:12.780Z] --- PASS: TestDockerNetworkConnectAlias (6.13s)
14:35:12 [2019-09-30T14:35:12.781Z]     network_test.go:20: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkConnectAlias"
14:35:12 [2019-09-30T14:35:12.781Z] === RUN   TestDockerNetworkReConnect
14:35:17 [2019-09-30T14:35:17.764Z] --- PASS: TestDockerNetworkReConnect (5.56s)
14:35:17 [2019-09-30T14:35:17.764Z]     network_test.go:82: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkReConnect"
14:35:17 [2019-09-30T14:35:17.764Z] === RUN   TestServicePlugin
14:35:17 [2019-09-30T14:35:17.764Z] --- SKIP: TestServicePlugin (0.01s)
14:35:17 [2019-09-30T14:35:17.764Z]     plugin_test.go:28: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
14:35:17 [2019-09-30T14:35:17.764Z] === RUN   TestServiceUpdateLabel
14:35:20 [2019-09-30T14:35:20.377Z] --- PASS: TestServiceUpdateLabel (3.03s)
14:35:20 [2019-09-30T14:35:20.377Z]     update_test.go:21: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateLabel"
14:35:20 [2019-09-30T14:35:20.377Z] === RUN   TestServiceUpdateSecrets
14:35:36 [2019-09-30T14:35:36.833Z] --- PASS: TestServiceUpdateSecrets (15.65s)
14:35:36 [2019-09-30T14:35:36.833Z]     update_test.go:77: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateSecrets"
14:35:36 [2019-09-30T14:35:36.833Z] === RUN   TestServiceUpdateConfigs
14:35:53 [2019-09-30T14:35:53.476Z] --- PASS: TestServiceUpdateConfigs (15.52s)
14:35:53 [2019-09-30T14:35:53.476Z]     update_test.go:139: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateConfigs"
14:35:53 [2019-09-30T14:35:53.476Z] === RUN   TestServiceUpdateNetwork
14:36:07 [2019-09-30T14:36:07.272Z] --- PASS: TestServiceUpdateNetwork (14.34s)
14:36:07 [2019-09-30T14:36:07.272Z]     update_test.go:201: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateNetwork"
14:36:07 [2019-09-30T14:36:07.272Z] PASS
14:36:07 [2019-09-30T14:36:07.272Z] 
14:36:07 [2019-09-30T14:36:07.272Z] === Skipped
14:36:07 [2019-09-30T14:36:07.272Z] === SKIP: s390x.integration.service TestServicePlugin (0.01s)
14:36:07 [2019-09-30T14:36:07.272Z]     plugin_test.go:28: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
14:36:07 [2019-09-30T14:36:07.272Z] 
14:36:07 [2019-09-30T14:36:07.272Z] 
14:36:07 [2019-09-30T14:36:07.272Z] DONE 19 tests, 1 skipped in 124.940s
14:36:07 [2019-09-30T14:36:07.272Z] Running /go/src/github.com/docker/docker/integration/session (s390x.integration.session) flags=-test.v -test.timeout=120m 
14:36:07 [2019-09-30T14:36:07.272Z] ++ 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
14:36:07 [2019-09-30T14:36:07.272Z] ++ set -e
14:36:07 [2019-09-30T14:36:07.272Z] ++ '[' -n 0 ']'
14:36:07 [2019-09-30T14:36:07.272Z] ++ set -x
14:36:07 [2019-09-30T14:36:07.272Z] ++ 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
14:36:07 [2019-09-30T14:36:07.272Z] INFO: Testing against a local daemon
14:36:07 [2019-09-30T14:36:07.272Z] === RUN   TestSessionCreate
14:36:07 [2019-09-30T14:36:07.272Z] --- PASS: TestSessionCreate (0.02s)
14:36:07 [2019-09-30T14:36:07.272Z] === RUN   TestSessionCreateWithBadUpgrade
14:36:07 [2019-09-30T14:36:07.272Z] --- PASS: TestSessionCreateWithBadUpgrade (0.03s)
14:36:07 [2019-09-30T14:36:07.272Z] PASS
14:36:07 [2019-09-30T14:36:07.272Z] 
14:36:07 [2019-09-30T14:36:07.272Z] DONE 2 tests in 0.281s
14:36:07 [2019-09-30T14:36:07.272Z] Running /go/src/github.com/docker/docker/integration/system (s390x.integration.system) flags=-test.v -test.timeout=120m 
14:36:07 [2019-09-30T14:36:07.272Z] ++ 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
14:36:07 [2019-09-30T14:36:07.272Z] ++ set -e
14:36:07 [2019-09-30T14:36:07.272Z] ++ '[' -n 0 ']'
14:36:07 [2019-09-30T14:36:07.272Z] ++ set -x
14:36:07 [2019-09-30T14:36:07.272Z] ++ 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
14:36:07 [2019-09-30T14:36:07.272Z] INFO: Testing against a local daemon
14:36:07 [2019-09-30T14:36:07.272Z] === RUN   TestCgroupDriverSystemdMemoryLimit
14:36:07 [2019-09-30T14:36:07.272Z] --- SKIP: TestCgroupDriverSystemdMemoryLimit (0.00s)
14:36:07 [2019-09-30T14:36:07.272Z]     cgroupdriver_systemd_test.go:32: !hasSystemd()
14:36:07 [2019-09-30T14:36:07.272Z] === RUN   TestEventsExecDie
14:36:07 [2019-09-30T14:36:07.645Z] --- PASS: TestEventsExecDie (0.98s)
14:36:07 [2019-09-30T14:36:07.645Z] === RUN   TestEventsBackwardsCompatible
14:36:07 [2019-09-30T14:36:07.645Z] --- PASS: TestEventsBackwardsCompatible (0.08s)
14:36:07 [2019-09-30T14:36:07.645Z] === RUN   TestInfoBinaryCommits
14:36:07 [2019-09-30T14:36:07.645Z] --- PASS: TestInfoBinaryCommits (0.03s)
14:36:07 [2019-09-30T14:36:07.645Z] === RUN   TestInfoAPIVersioned
14:36:07 [2019-09-30T14:36:07.645Z] --- PASS: TestInfoAPIVersioned (0.01s)
14:36:07 [2019-09-30T14:36:07.645Z] === RUN   TestInfoAPI
14:36:07 [2019-09-30T14:36:07.645Z] --- PASS: TestInfoAPI (0.02s)
14:36:07 [2019-09-30T14:36:07.645Z] === RUN   TestInfoAPIWarnings
14:36:08 [2019-09-30T14:36:08.530Z] --- PASS: TestInfoAPIWarnings (0.87s)
14:36:08 [2019-09-30T14:36:08.530Z]     info_test.go:49: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestInfoAPIWarnings"
14:36:08 [2019-09-30T14:36:08.530Z] === RUN   TestLoginFailsWithBadCredentials
14:36:08 [2019-09-30T14:36:08.967Z] --- PASS: TestLoginFailsWithBadCredentials (0.43s)
14:36:08 [2019-09-30T14:36:08.967Z] === RUN   TestPingCacheHeaders
14:36:08 [2019-09-30T14:36:08.967Z] --- PASS: TestPingCacheHeaders (0.03s)
14:36:08 [2019-09-30T14:36:08.967Z] === RUN   TestPingGet
14:36:08 [2019-09-30T14:36:08.967Z] --- PASS: TestPingGet (0.01s)
14:36:08 [2019-09-30T14:36:08.967Z] === RUN   TestPingHead
14:36:08 [2019-09-30T14:36:08.967Z] --- PASS: TestPingHead (0.02s)
14:36:08 [2019-09-30T14:36:08.967Z] === RUN   TestVersion
14:36:08 [2019-09-30T14:36:08.967Z] --- PASS: TestVersion (0.02s)
14:36:08 [2019-09-30T14:36:08.967Z] PASS
14:36:08 [2019-09-30T14:36:08.967Z] 
14:36:08 [2019-09-30T14:36:08.967Z] === Skipped
14:36:08 [2019-09-30T14:36:08.967Z] === SKIP: s390x.integration.system TestCgroupDriverSystemdMemoryLimit (0.00s)
14:36:08 [2019-09-30T14:36:08.967Z]     cgroupdriver_systemd_test.go:32: !hasSystemd()
14:36:08 [2019-09-30T14:36:08.967Z] 
14:36:08 [2019-09-30T14:36:08.967Z] 
14:36:08 [2019-09-30T14:36:08.967Z] DONE 12 tests, 1 skipped in 2.693s
14:36:08 [2019-09-30T14:36:08.967Z] Running /go/src/github.com/docker/docker/integration/volume (s390x.integration.volume) flags=-test.v -test.timeout=120m 
14:36:08 [2019-09-30T14:36:08.967Z] ++ 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
14:36:08 [2019-09-30T14:36:08.967Z] ++ set -e
14:36:08 [2019-09-30T14:36:08.967Z] ++ '[' -n 0 ']'
14:36:08 [2019-09-30T14:36:08.967Z] ++ set -x
14:36:08 [2019-09-30T14:36:08.968Z] ++ 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
14:36:09 [2019-09-30T14:36:09.439Z] INFO: Testing against a local daemon
14:36:09 [2019-09-30T14:36:09.440Z] === RUN   TestVolumesCreateAndList
14:36:09 [2019-09-30T14:36:09.440Z] --- PASS: TestVolumesCreateAndList (0.03s)
14:36:09 [2019-09-30T14:36:09.440Z] === RUN   TestVolumesRemove
14:36:09 [2019-09-30T14:36:09.440Z] --- PASS: TestVolumesRemove (0.12s)
14:36:09 [2019-09-30T14:36:09.440Z] === RUN   TestVolumesInspect
14:36:09 [2019-09-30T14:36:09.440Z] --- PASS: TestVolumesInspect (0.02s)
14:36:09 [2019-09-30T14:36:09.440Z] === RUN   TestVolumesInvalidJSON
14:36:09 [2019-09-30T14:36:09.440Z] === RUN   TestVolumesInvalidJSON//volumes/create
14:36:09 [2019-09-30T14:36:09.440Z] === PAUSE TestVolumesInvalidJSON//volumes/create
14:36:09 [2019-09-30T14:36:09.440Z] === CONT  TestVolumesInvalidJSON//volumes/create
14:36:09 [2019-09-30T14:36:09.440Z] --- PASS: TestVolumesInvalidJSON (0.01s)
14:36:09 [2019-09-30T14:36:09.440Z]     --- PASS: TestVolumesInvalidJSON//volumes/create (0.00s)
14:36:09 [2019-09-30T14:36:09.440Z] PASS
14:36:09 [2019-09-30T14:36:09.440Z] 
14:36:09 [2019-09-30T14:36:09.440Z] DONE 5 tests in 0.381s
14:36:09 [2019-09-30T14:36:09.440Z] ---> Making bundle: .integration-daemon-stop (in bundles/test-integration)
14:36:09 [2019-09-30T14:36:09.923Z] ++++ cat bundles/test-integration/docker.pid
14:36:09 [2019-09-30T14:36:09.923Z] +++ kill 11418
14:36:11 [2019-09-30T14:36:11.192Z] umount: bundles/test-integration/root: mountpoint not found
14:36:11 [2019-09-30T14:36:11.192Z] +++ /etc/init.d/apparmor stop
14:36:11 [2019-09-30T14:36:11.192Z] Clearing AppArmor profiles cache:.
14:36:11 [2019-09-30T14:36:11.192Z] All profile caches have been cleared, but no profiles have been unloaded.
14:36:11 [2019-09-30T14:36:11.192Z] Unloading profiles will leave already running processes permanently
14:36:11 [2019-09-30T14:36:11.192Z] unconfined, which can lead to unexpected situations.
14:36:11 [2019-09-30T14:36:11.192Z] 
14:36:11 [2019-09-30T14:36:11.192Z] To set a process to complain mode, use the command line tool
14:36:11 [2019-09-30T14:36:11.192Z] 'aa-complain'. To really tear down all profiles, run the init script
14:36:11 [2019-09-30T14:36:11.192Z] with the 'teardown' option."
14:36:11 [2019-09-30T14:36:11.192Z]