Console Output

12:33:35 [2019-10-21T12:33:35.063Z] + docker run --rm -t --privileged -v /home/docker/workspace/moby_PR-40111/bundles:/go/src/github.com/docker/docker/bundles --name docker-pr1 -e DOCKER_EXPERIMENTAL -e DOCKER_GITCOMMIT=18a97ee981d80fe4764f7ec8d8384212981ccf24 -e DOCKER_GRAPHDRIVER -e TESTDEBUG -e TEST_SKIP_INTEGRATION_CLI -e TIMEOUT -e VALIDATE_REPO=https://github.com/moby/moby.git -e VALIDATE_BRANCH=master docker:18a97ee981d80fe4764f7ec8d8384212981ccf24 hack/make.sh dynbinary test-integration
12:33:35 [2019-10-21T12:33:35.703Z] 
12:33:35 [2019-10-21T12:33:35.703Z] Removing bundles/
12:33:35 [2019-10-21T12:33:35.703Z] 
12:33:35 [2019-10-21T12:33:35.703Z] ---> Making bundle: dynbinary (in bundles/dynbinary)
12:33:35 [2019-10-21T12:33:35.703Z] Building: bundles/dynbinary-daemon/dockerd-dev
12:33:35 [2019-10-21T12:33:35.703Z] GOOS="" GOARCH="" GOARM=""
12:35:42 [2019-10-21T12:35:42.866Z] Created binary: bundles/dynbinary-daemon/dockerd-dev
12:35:42 [2019-10-21T12:35:42.866Z] 
12:35:42 [2019-10-21T12:35:42.866Z] ---> Making bundle: test-integration (in bundles/test-integration)
12:35:42 [2019-10-21T12:35:42.866Z] PKG_CONFIG=pkg-config
12:35:42 [2019-10-21T12:35:42.866Z] GOLANG_VERSION=1.13.3
12:35:42 [2019-10-21T12:35:42.866Z] HOSTNAME=4eff6d9dea5e
12:35:42 [2019-10-21T12:35:42.866Z] DOCKER_EXPERIMENTAL=1
12:35:42 [2019-10-21T12:35:42.866Z] container=docker
12:35:42 [2019-10-21T12:35:42.866Z] TEST_SKIP_INTEGRATION_CLI=1
12:35:42 [2019-10-21T12:35:42.866Z] GO111MODULE=off
12:35:42 [2019-10-21T12:35:42.866Z] GOPATH=/go
12:35:42 [2019-10-21T12:35:42.866Z] PWD=/go/src/github.com/docker/docker
12:35:42 [2019-10-21T12:35:42.866Z] HOME=/root
12:35:42 [2019-10-21T12:35:42.866Z] VALIDATE_REPO=https://github.com/moby/moby.git
12:35:42 [2019-10-21T12:35:42.866Z] SCRIPTDIR=/go/src/github.com/docker/docker/hack
12:35:42 [2019-10-21T12:35:42.866Z] MAKEDIR=/go/src/github.com/docker/docker/hack/make
12:35:42 [2019-10-21T12:35:42.866Z] DOCKER_GITCOMMIT=18a97ee981d80fe4764f7ec8d8384212981ccf24
12:35:42 [2019-10-21T12:35:42.866Z] DOCKER_BUILDTAGS=apparmor seccomp selinux journald
12:35:42 [2019-10-21T12:35:42.866Z] DOCKER_GRAPHDRIVER=overlay2
12:35:42 [2019-10-21T12:35:42.866Z] TERM=xterm
12:35:42 [2019-10-21T12:35:42.866Z] VALIDATE_BRANCH=master
12:35:42 [2019-10-21T12:35:42.866Z] DEST=bundles/test-integration
12:35:42 [2019-10-21T12:35:42.866Z] SHLVL=1
12:35:42 [2019-10-21T12:35:42.866Z] TIMEOUT=120m
12:35:42 [2019-10-21T12:35:42.866Z] PATH=/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
12:35:42 [2019-10-21T12:35:42.866Z] DOCKER_PKG=github.com/docker/docker
12:35:42 [2019-10-21T12:35:42.866Z] TESTDEBUG=0
12:35:42 [2019-10-21T12:35:42.866Z] _=/usr/bin/env
12:35:42 [2019-10-21T12:35:42.866Z] Building test suite binary /go/src/github.com/docker/docker/integration/build/test.main
12:36:22 [2019-10-21T12:36:22.139Z] Building test suite binary /go/src/github.com/docker/docker/integration/config/test.main
12:36:24 [2019-10-21T12:36:24.169Z] Building test suite binary /go/src/github.com/docker/docker/integration/container/test.main
12:36:28 [2019-10-21T12:36:28.563Z] Building test suite binary /go/src/github.com/docker/docker/integration/image/test.main
12:37:07 [2019-10-21T12:37:07.859Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/test.main
12:37:07 [2019-10-21T12:37:07.860Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/ipvlan/test.main
12:37:07 [2019-10-21T12:37:07.860Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/macvlan/test.main
12:37:07 [2019-10-21T12:37:07.860Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/test.main
12:37:08 [2019-10-21T12:37:08.476Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/authz/test.main
12:37:11 [2019-10-21T12:37:11.945Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/common/test.main
12:37:13 [2019-10-21T12:37:13.430Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/graphdriver/test.main
12:37:16 [2019-10-21T12:37:16.892Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/logging/test.main
12:37:20 [2019-10-21T12:37:20.376Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/volumes/test.main
12:37:23 [2019-10-21T12:37:23.855Z] Building test suite binary /go/src/github.com/docker/docker/integration/secret/test.main
12:37:25 [2019-10-21T12:37:25.329Z] Building test suite binary /go/src/github.com/docker/docker/integration/service/test.main
12:37:28 [2019-10-21T12:37:28.792Z] Building test suite binary /go/src/github.com/docker/docker/integration/session/test.main
12:37:30 [2019-10-21T12:37:30.831Z] Building test suite binary /go/src/github.com/docker/docker/integration/system/test.main
12:37:32 [2019-10-21T12:37:32.308Z] Building test suite binary /go/src/github.com/docker/docker/integration/volume/test.main
12:37:34 [2019-10-21T12:37:34.356Z] ---> Making bundle: .integration-daemon-start (in bundles/test-integration)
12:37:34 [2019-10-21T12:37:34.356Z] Using test binary docker
12:37:34 [2019-10-21T12:37:34.356Z] # DOCKER_EXPERIMENTAL is set: starting daemon with experimental features enabled! 
12:37:34 [2019-10-21T12:37:34.356Z] +++ /etc/init.d/apparmor start
12:37:34 [2019-10-21T12:37:34.356Z] /etc/init.d/apparmor: 130: /etc/init.d/apparmor: systemd-detect-virt: not found
12:37:34 [2019-10-21T12:37:34.356Z] Starting AppArmor profiles:Warning from stdin (line 1): /sbin/apparmor_parser: cannot use or update cache, disable, or force-complain via stdin
12:37:34 [2019-10-21T12:37:34.356Z] Warning failed to create cache: (null)
12:37:34 [2019-10-21T12:37:34.356Z] .
12:37:34 [2019-10-21T12:37:34.356Z] INFO: Waiting for daemon to start...
12:37:34 [2019-10-21T12:37:34.356Z] Starting dockerd
12:37:34 [2019-10-21T12:37:34.356Z] +++ exec dockerd --debug --host unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock --storage-driver overlay2 --pidfile bundles/test-integration/docker.pid --userland-proxy=true --experimental
12:37:36 [2019-10-21T12:37:36.665Z] .
12:37:36 [2019-10-21T12:37:36.665Z] ---> Making bundle: .integration-daemon-setup (in bundles/test-integration)
12:37:36 [2019-10-21T12:37:36.665Z] ---> Making bundle: .ensure-emptyfs (in bundles/test-integration)
12:37:36 [2019-10-21T12:37:36.665Z] Error: No such image: emptyfs
12:37:36 [2019-10-21T12:37:36.665Z] ++++ tar -cC bundles/test-integration/emptyfs .
12:37:36 [2019-10-21T12:37:36.665Z] ++++ docker load
12:37:36 [2019-10-21T12:37:36.953Z] Running integration-test (iteration 1)
12:37:36 [2019-10-21T12:37:36.953Z] Running /go/src/github.com/docker/docker/integration/build (ppc64le.integration.build) flags=-test.v -test.timeout=120m 
12:37:36 [2019-10-21T12:37:36.953Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-build-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-build-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.build -t ./test.main -test.v -test.timeout=120m
12:37:36 [2019-10-21T12:37:36.953Z] ++ set -e
12:37:36 [2019-10-21T12:37:36.953Z] ++ '[' -n 0 ']'
12:37:36 [2019-10-21T12:37:36.953Z] ++ set -x
12:37:36 [2019-10-21T12:37:36.953Z] ++ 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=ppc64le 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/ppc64le-integration-build-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-build-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.build -t ./test.main -test.v -test.timeout=120m
12:37:52 [2019-10-21T12:37:52.198Z] Loaded image: buildpack-deps:jessie
12:37:52 [2019-10-21T12:37:52.199Z] Loaded image: busybox:latest
12:37:52 [2019-10-21T12:37:52.199Z] Loaded image: busybox:glibc
12:37:52 [2019-10-21T12:37:52.199Z] Loaded image: debian:jessie
12:37:52 [2019-10-21T12:37:52.199Z] Loaded image: hello-world:latest
12:37:52 [2019-10-21T12:37:52.199Z] INFO: Testing against a local daemon
12:37:52 [2019-10-21T12:37:52.199Z] === RUN   TestCgroupNamespacesBuild
12:37:53 [2019-10-21T12:37:53.212Z] --- PASS: TestCgroupNamespacesBuild (1.65s)
12:37:53 [2019-10-21T12:37:53.212Z]     build_cgroupns_linux_test.go:42: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesBuild"
12:37:53 [2019-10-21T12:37:53.212Z] === RUN   TestCgroupNamespacesBuildDaemonHostMode
12:37:54 [2019-10-21T12:37:54.686Z] --- PASS: TestCgroupNamespacesBuildDaemonHostMode (1.61s)
12:37:54 [2019-10-21T12:37:54.686Z]     build_cgroupns_linux_test.go:42: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesBuildDaemonHostMode"
12:37:54 [2019-10-21T12:37:54.686Z] === RUN   TestBuildWithSession
12:37:54 [2019-10-21T12:37:54.686Z] --- SKIP: TestBuildWithSession (0.00s)
12:37:54 [2019-10-21T12:37:54.686Z]     build_session_test.go:25: TODO: BuildKit
12:37:54 [2019-10-21T12:37:54.686Z] === RUN   TestBuildSquashParent
12:38:00 [2019-10-21T12:38:00.197Z] --- PASS: TestBuildSquashParent (4.85s)
12:38:00 [2019-10-21T12:38:00.197Z] === RUN   TestBuildWithRemoveAndForceRemove
12:38:00 [2019-10-21T12:38:00.197Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
12:38:00 [2019-10-21T12:38:00.197Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
12:38:00 [2019-10-21T12:38:00.197Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_remove
12:38:00 [2019-10-21T12:38:00.197Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_remove
12:38:00 [2019-10-21T12:38:00.197Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
12:38:00 [2019-10-21T12:38:00.197Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
12:38:00 [2019-10-21T12:38:00.197Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
12:38:00 [2019-10-21T12:38:00.197Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
12:38:00 [2019-10-21T12:38:00.197Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_remove
12:38:00 [2019-10-21T12:38:00.197Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_remove
12:38:00 [2019-10-21T12:38:00.197Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
12:38:00 [2019-10-21T12:38:00.197Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
12:38:00 [2019-10-21T12:38:00.197Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
12:38:00 [2019-10-21T12:38:00.197Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
12:38:00 [2019-10-21T12:38:00.197Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_remove
12:38:00 [2019-10-21T12:38:00.197Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
12:38:02 [2019-10-21T12:38:02.245Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
12:38:02 [2019-10-21T12:38:02.529Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_remove
12:38:04 [2019-10-21T12:38:04.554Z] --- PASS: TestBuildWithRemoveAndForceRemove (0.02s)
12:38:04 [2019-10-21T12:38:04.555Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal (2.65s)
12:38:04 [2019-10-21T12:38:04.555Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove (2.86s)
12:38:04 [2019-10-21T12:38:04.555Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal (2.93s)
12:38:04 [2019-10-21T12:38:04.555Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_remove (3.27s)
12:38:04 [2019-10-21T12:38:04.555Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove (2.23s)
12:38:04 [2019-10-21T12:38:04.555Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_remove (2.12s)
12:38:04 [2019-10-21T12:38:04.555Z] === RUN   TestBuildMultiStageCopy
12:38:04 [2019-10-21T12:38:04.555Z] === RUN   TestBuildMultiStageCopy/copy_to_root
12:38:06 [2019-10-21T12:38:06.584Z] === RUN   TestBuildMultiStageCopy/copy_to_newdir
12:38:06 [2019-10-21T12:38:06.866Z] === RUN   TestBuildMultiStageCopy/copy_to_newdir_nested
12:38:07 [2019-10-21T12:38:07.147Z] === RUN   TestBuildMultiStageCopy/copy_to_existingdir
12:38:07 [2019-10-21T12:38:07.431Z] === RUN   TestBuildMultiStageCopy/copy_to_newsubdir
12:38:08 [2019-10-21T12:38:08.051Z] --- PASS: TestBuildMultiStageCopy (3.38s)
12:38:08 [2019-10-21T12:38:08.051Z]     --- PASS: TestBuildMultiStageCopy/copy_to_root (1.82s)
12:38:08 [2019-10-21T12:38:08.051Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newdir (0.36s)
12:38:08 [2019-10-21T12:38:08.051Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newdir_nested (0.40s)
12:38:08 [2019-10-21T12:38:08.051Z]     --- PASS: TestBuildMultiStageCopy/copy_to_existingdir (0.38s)
12:38:08 [2019-10-21T12:38:08.051Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newsubdir (0.42s)
12:38:08 [2019-10-21T12:38:08.051Z] === RUN   TestBuildMultiStageParentConfig
12:38:09 [2019-10-21T12:38:09.059Z] --- PASS: TestBuildMultiStageParentConfig (0.99s)
12:38:09 [2019-10-21T12:38:09.059Z] === RUN   TestBuildLabelWithTargets
12:38:10 [2019-10-21T12:38:10.536Z] --- PASS: TestBuildLabelWithTargets (1.53s)
12:38:10 [2019-10-21T12:38:10.536Z] === RUN   TestBuildWithEmptyLayers
12:38:11 [2019-10-21T12:38:11.156Z] --- PASS: TestBuildWithEmptyLayers (0.73s)
12:38:11 [2019-10-21T12:38:11.156Z] === RUN   TestBuildMultiStageOnBuild
12:38:13 [2019-10-21T12:38:13.847Z] --- PASS: TestBuildMultiStageOnBuild (2.16s)
12:38:13 [2019-10-21T12:38:13.847Z] === RUN   TestBuildUncleanTarFilenames
12:38:14 [2019-10-21T12:38:14.463Z] --- PASS: TestBuildUncleanTarFilenames (1.11s)
12:38:14 [2019-10-21T12:38:14.463Z] === RUN   TestBuildMultiStageLayerLeak
12:38:17 [2019-10-21T12:38:17.152Z] --- PASS: TestBuildMultiStageLayerLeak (2.26s)
12:38:17 [2019-10-21T12:38:17.152Z] === RUN   TestBuildWithHugeFile
12:39:54 [2019-10-21T12:39:54.219Z] --- PASS: TestBuildWithHugeFile (83.22s)
12:39:54 [2019-10-21T12:39:54.219Z] === RUN   TestBuildWithEmptyDockerfile
12:39:54 [2019-10-21T12:39:54.219Z] === RUN   TestBuildWithEmptyDockerfile/empty-dockerfile
12:39:54 [2019-10-21T12:39:54.219Z] === PAUSE TestBuildWithEmptyDockerfile/empty-dockerfile
12:39:54 [2019-10-21T12:39:54.219Z] === RUN   TestBuildWithEmptyDockerfile/empty-lines-dockerfile
12:39:54 [2019-10-21T12:39:54.219Z] === PAUSE TestBuildWithEmptyDockerfile/empty-lines-dockerfile
12:39:54 [2019-10-21T12:39:54.219Z] === RUN   TestBuildWithEmptyDockerfile/comment-only-dockerfile
12:39:54 [2019-10-21T12:39:54.219Z] === PAUSE TestBuildWithEmptyDockerfile/comment-only-dockerfile
12:39:54 [2019-10-21T12:39:54.219Z] === CONT  TestBuildWithEmptyDockerfile/empty-dockerfile
12:39:54 [2019-10-21T12:39:54.219Z] === CONT  TestBuildWithEmptyDockerfile/comment-only-dockerfile
12:39:54 [2019-10-21T12:39:54.219Z] === CONT  TestBuildWithEmptyDockerfile/empty-lines-dockerfile
12:39:54 [2019-10-21T12:39:54.219Z] --- PASS: TestBuildWithEmptyDockerfile (0.08s)
12:39:54 [2019-10-21T12:39:54.219Z]     --- PASS: TestBuildWithEmptyDockerfile/comment-only-dockerfile (0.31s)
12:39:54 [2019-10-21T12:39:54.219Z]     --- PASS: TestBuildWithEmptyDockerfile/empty-dockerfile (0.32s)
12:39:54 [2019-10-21T12:39:54.219Z]     --- PASS: TestBuildWithEmptyDockerfile/empty-lines-dockerfile (0.33s)
12:39:54 [2019-10-21T12:39:54.219Z] === RUN   TestBuildPreserveOwnership
12:39:54 [2019-10-21T12:39:54.219Z] === RUN   TestBuildPreserveOwnership/copy_from
12:39:54 [2019-10-21T12:39:54.219Z] === RUN   TestBuildPreserveOwnership/copy_from_chowned
12:39:54 [2019-10-21T12:39:54.219Z] --- PASS: TestBuildPreserveOwnership (4.79s)
12:39:54 [2019-10-21T12:39:54.219Z]     --- PASS: TestBuildPreserveOwnership/copy_from (3.13s)
12:39:54 [2019-10-21T12:39:54.219Z]     --- PASS: TestBuildPreserveOwnership/copy_from_chowned (1.65s)
12:39:54 [2019-10-21T12:39:54.219Z] === RUN   TestBuildPlatformInvalid
12:39:54 [2019-10-21T12:39:54.219Z] --- PASS: TestBuildPlatformInvalid (0.17s)
12:39:54 [2019-10-21T12:39:54.219Z] PASS
12:39:54 [2019-10-21T12:39:54.219Z] 
12:39:54 [2019-10-21T12:39:54.219Z] === Skipped
12:39:54 [2019-10-21T12:39:54.219Z] === SKIP: ppc64le.integration.build TestBuildWithSession (0.00s)
12:39:54 [2019-10-21T12:39:54.219Z]     build_session_test.go:25: TODO: BuildKit
12:39:54 [2019-10-21T12:39:54.219Z] 
12:39:54 [2019-10-21T12:39:54.219Z] 
12:39:54 [2019-10-21T12:39:54.219Z] DONE 32 tests, 1 skipped in 128.414s
12:39:54 [2019-10-21T12:39:54.219Z] Running /go/src/github.com/docker/docker/integration/config (ppc64le.integration.config) flags=-test.v -test.timeout=120m 
12:39:54 [2019-10-21T12:39:54.219Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-config-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-config-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.config -t ./test.main -test.v -test.timeout=120m
12:39:54 [2019-10-21T12:39:54.219Z] ++ set -e
12:39:54 [2019-10-21T12:39:54.219Z] ++ '[' -n 0 ']'
12:39:54 [2019-10-21T12:39:54.219Z] ++ set -x
12:39:54 [2019-10-21T12:39:54.219Z] ++ 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=ppc64le 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/ppc64le-integration-config-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-config-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.config -t ./test.main -test.v -test.timeout=120m
12:39:54 [2019-10-21T12:39:54.219Z] INFO: Testing against a local daemon
12:39:54 [2019-10-21T12:39:54.219Z] === RUN   TestConfigList
12:39:54 [2019-10-21T12:39:54.219Z] --- PASS: TestConfigList (2.16s)
12:39:54 [2019-10-21T12:39:54.219Z]     config_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigList"
12:39:54 [2019-10-21T12:39:54.219Z] === RUN   TestConfigsCreateAndDelete
12:39:54 [2019-10-21T12:39:54.219Z] --- PASS: TestConfigsCreateAndDelete (2.21s)
12:39:54 [2019-10-21T12:39:54.219Z]     config_test.go:112: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigsCreateAndDelete"
12:39:54 [2019-10-21T12:39:54.219Z] === RUN   TestConfigsUpdate
12:39:54 [2019-10-21T12:39:54.219Z] --- PASS: TestConfigsUpdate (2.18s)
12:39:54 [2019-10-21T12:39:54.219Z]     config_test.go:140: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigsUpdate"
12:39:54 [2019-10-21T12:39:54.219Z] === RUN   TestTemplatedConfig
12:39:54 [2019-10-21T12:39:54.836Z] --- PASS: TestTemplatedConfig (2.72s)
12:39:54 [2019-10-21T12:39:54.836Z]     config_test.go:192: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestTemplatedConfig"
12:39:54 [2019-10-21T12:39:54.836Z] === RUN   TestConfigInspect
12:39:56 [2019-10-21T12:39:56.875Z] --- PASS: TestConfigInspect (2.17s)
12:39:56 [2019-10-21T12:39:56.875Z]     config_test.go:326: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigInspect"
12:39:56 [2019-10-21T12:39:56.875Z] === RUN   TestConfigCreateWithLabels
12:39:59 [2019-10-21T12:39:59.574Z] --- PASS: TestConfigCreateWithLabels (2.16s)
12:39:59 [2019-10-21T12:39:59.574Z]     config_test.go:350: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigCreateWithLabels"
12:39:59 [2019-10-21T12:39:59.574Z] === RUN   TestConfigCreateResolve
12:40:01 [2019-10-21T12:40:01.600Z] --- PASS: TestConfigCreateResolve (2.20s)
12:40:01 [2019-10-21T12:40:01.600Z]     config_test.go:377: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigCreateResolve"
12:40:01 [2019-10-21T12:40:01.600Z] === RUN   TestConfigDaemonLibtrustID
12:40:01 [2019-10-21T12:40:01.885Z] --- PASS: TestConfigDaemonLibtrustID (0.56s)
12:40:01 [2019-10-21T12:40:01.885Z]     config_test.go:427: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigDaemonLibtrustID"
12:40:01 [2019-10-21T12:40:01.885Z] PASS
12:40:01 [2019-10-21T12:40:01.885Z] 
12:40:01 [2019-10-21T12:40:01.885Z] DONE 8 tests in 16.456s
12:40:01 [2019-10-21T12:40:01.885Z] Running /go/src/github.com/docker/docker/integration/container (ppc64le.integration.container) flags=-test.v -test.timeout=120m 
12:40:01 [2019-10-21T12:40:01.885Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-container-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-container-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.container -t ./test.main -test.v -test.timeout=120m
12:40:01 [2019-10-21T12:40:01.885Z] ++ set -e
12:40:01 [2019-10-21T12:40:01.885Z] ++ '[' -n 0 ']'
12:40:01 [2019-10-21T12:40:01.885Z] ++ set -x
12:40:01 [2019-10-21T12:40:01.885Z] ++ 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=ppc64le 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/ppc64le-integration-container-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-container-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.container -t ./test.main -test.v -test.timeout=120m
12:40:01 [2019-10-21T12:40:01.885Z] INFO: Testing against a local daemon
12:40:01 [2019-10-21T12:40:01.885Z] === RUN   TestCheckpoint
12:40:01 [2019-10-21T12:40:01.885Z] --- SKIP: TestCheckpoint (0.00s)
12:40:01 [2019-10-21T12:40:01.885Z]     checkpoint_test.go:33: TestCheckpoint is broken; see https://github.com/moby/moby/issues/38963
12:40:01 [2019-10-21T12:40:01.885Z] === RUN   TestContainerInvalidJSON
12:40:01 [2019-10-21T12:40:01.885Z] === RUN   TestContainerInvalidJSON//containers/foobar/copy
12:40:01 [2019-10-21T12:40:01.885Z] === PAUSE TestContainerInvalidJSON//containers/foobar/copy
12:40:01 [2019-10-21T12:40:01.885Z] === RUN   TestContainerInvalidJSON//containers/foobar/exec
12:40:01 [2019-10-21T12:40:01.885Z] === PAUSE TestContainerInvalidJSON//containers/foobar/exec
12:40:01 [2019-10-21T12:40:01.885Z] === RUN   TestContainerInvalidJSON//exec/foobar/start
12:40:01 [2019-10-21T12:40:01.885Z] === PAUSE TestContainerInvalidJSON//exec/foobar/start
12:40:01 [2019-10-21T12:40:01.885Z] === CONT  TestContainerInvalidJSON//containers/foobar/copy
12:40:01 [2019-10-21T12:40:01.885Z] === CONT  TestContainerInvalidJSON//containers/foobar/exec
12:40:01 [2019-10-21T12:40:01.885Z] === CONT  TestContainerInvalidJSON//exec/foobar/start
12:40:01 [2019-10-21T12:40:01.885Z] --- PASS: TestContainerInvalidJSON (0.04s)
12:40:01 [2019-10-21T12:40:01.885Z]     --- PASS: TestContainerInvalidJSON//containers/foobar/exec (0.00s)
12:40:01 [2019-10-21T12:40:01.885Z]     --- PASS: TestContainerInvalidJSON//containers/foobar/copy (0.00s)
12:40:01 [2019-10-21T12:40:01.885Z]     --- PASS: TestContainerInvalidJSON//exec/foobar/start (0.00s)
12:40:01 [2019-10-21T12:40:01.885Z] === RUN   TestCopyFromContainerPathDoesNotExist
12:40:02 [2019-10-21T12:40:02.169Z] --- PASS: TestCopyFromContainerPathDoesNotExist (0.08s)
12:40:02 [2019-10-21T12:40:02.169Z] === RUN   TestCopyFromContainerPathIsNotDir
12:40:02 [2019-10-21T12:40:02.169Z] --- PASS: TestCopyFromContainerPathIsNotDir (0.08s)
12:40:02 [2019-10-21T12:40:02.169Z] === RUN   TestCopyToContainerPathDoesNotExist
12:40:02 [2019-10-21T12:40:02.169Z] --- PASS: TestCopyToContainerPathDoesNotExist (0.06s)
12:40:02 [2019-10-21T12:40:02.169Z] === RUN   TestCopyToContainerPathIsNotDir
12:40:02 [2019-10-21T12:40:02.454Z] --- PASS: TestCopyToContainerPathIsNotDir (0.09s)
12:40:02 [2019-10-21T12:40:02.454Z] === RUN   TestCopyFromContainer
12:40:03 [2019-10-21T12:40:03.928Z] === RUN   TestCopyFromContainer//
12:40:03 [2019-10-21T12:40:03.928Z] === RUN   TestCopyFromContainer//bar/root
12:40:03 [2019-10-21T12:40:03.928Z] === RUN   TestCopyFromContainer//bar/root/
12:40:04 [2019-10-21T12:40:04.212Z] === RUN   TestCopyFromContainer/bar/quux
12:40:04 [2019-10-21T12:40:04.212Z] === RUN   TestCopyFromContainer/bar/quux/
12:40:04 [2019-10-21T12:40:04.212Z] === RUN   TestCopyFromContainer/bar/quux/baz
12:40:04 [2019-10-21T12:40:04.496Z] === RUN   TestCopyFromContainer/bar/filesymlink
12:40:04 [2019-10-21T12:40:04.496Z] === RUN   TestCopyFromContainer/bar/dirsymlink
12:40:04 [2019-10-21T12:40:04.496Z] === RUN   TestCopyFromContainer/bar/dirsymlink/
12:40:04 [2019-10-21T12:40:04.781Z] === RUN   TestCopyFromContainer/bar/notarget
12:40:04 [2019-10-21T12:40:04.781Z] --- PASS: TestCopyFromContainer (2.44s)
12:40:04 [2019-10-21T12:40:04.781Z]     --- PASS: TestCopyFromContainer// (0.09s)
12:40:04 [2019-10-21T12:40:04.781Z]     --- PASS: TestCopyFromContainer//bar/root (0.09s)
12:40:04 [2019-10-21T12:40:04.781Z]     --- PASS: TestCopyFromContainer//bar/root/ (0.09s)
12:40:04 [2019-10-21T12:40:04.781Z]     --- PASS: TestCopyFromContainer/bar/quux (0.10s)
12:40:04 [2019-10-21T12:40:04.781Z]     --- PASS: TestCopyFromContainer/bar/quux/ (0.08s)
12:40:04 [2019-10-21T12:40:04.781Z]     --- PASS: TestCopyFromContainer/bar/quux/baz (0.08s)
12:40:04 [2019-10-21T12:40:04.781Z]     --- PASS: TestCopyFromContainer/bar/filesymlink (0.08s)
12:40:04 [2019-10-21T12:40:04.781Z]     --- PASS: TestCopyFromContainer/bar/dirsymlink (0.08s)
12:40:04 [2019-10-21T12:40:04.781Z]     --- PASS: TestCopyFromContainer/bar/dirsymlink/ (0.08s)
12:40:04 [2019-10-21T12:40:04.781Z]     --- PASS: TestCopyFromContainer/bar/notarget (0.09s)
12:40:04 [2019-10-21T12:40:04.781Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist
12:40:04 [2019-10-21T12:40:04.781Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
12:40:04 [2019-10-21T12:40:04.781Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
12:40:04 [2019-10-21T12:40:04.781Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
12:40:04 [2019-10-21T12:40:04.781Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
12:40:04 [2019-10-21T12:40:04.781Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/digest
12:40:04 [2019-10-21T12:40:04.781Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/digest
12:40:04 [2019-10-21T12:40:04.781Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
12:40:04 [2019-10-21T12:40:04.781Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/digest
12:40:04 [2019-10-21T12:40:04.781Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
12:40:04 [2019-10-21T12:40:04.781Z] --- PASS: TestCreateFailsWhenIdentifierDoesNotExist (0.02s)
12:40:04 [2019-10-21T12:40:04.781Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag (0.00s)
12:40:04 [2019-10-21T12:40:04.781Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/digest (0.00s)
12:40:04 [2019-10-21T12:40:04.781Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag (0.00s)
12:40:04 [2019-10-21T12:40:04.781Z] === RUN   TestCreateLinkToNonExistingContainer
12:40:04 [2019-10-21T12:40:04.781Z] --- PASS: TestCreateLinkToNonExistingContainer (0.05s)
12:40:04 [2019-10-21T12:40:04.781Z] === RUN   TestCreateWithInvalidEnv
12:40:04 [2019-10-21T12:40:04.781Z] === RUN   TestCreateWithInvalidEnv/0
12:40:04 [2019-10-21T12:40:04.781Z] === PAUSE TestCreateWithInvalidEnv/0
12:40:04 [2019-10-21T12:40:04.781Z] === RUN   TestCreateWithInvalidEnv/1
12:40:04 [2019-10-21T12:40:04.781Z] === PAUSE TestCreateWithInvalidEnv/1
12:40:04 [2019-10-21T12:40:04.781Z] === RUN   TestCreateWithInvalidEnv/2
12:40:04 [2019-10-21T12:40:04.781Z] === PAUSE TestCreateWithInvalidEnv/2
12:40:04 [2019-10-21T12:40:04.781Z] === CONT  TestCreateWithInvalidEnv/0
12:40:04 [2019-10-21T12:40:04.781Z] === CONT  TestCreateWithInvalidEnv/2
12:40:04 [2019-10-21T12:40:04.781Z] === CONT  TestCreateWithInvalidEnv/1
12:40:04 [2019-10-21T12:40:04.781Z] --- PASS: TestCreateWithInvalidEnv (0.02s)
12:40:04 [2019-10-21T12:40:04.781Z]     --- PASS: TestCreateWithInvalidEnv/0 (0.01s)
12:40:04 [2019-10-21T12:40:04.781Z]     --- PASS: TestCreateWithInvalidEnv/1 (0.02s)
12:40:04 [2019-10-21T12:40:04.781Z]     --- PASS: TestCreateWithInvalidEnv/2 (0.02s)
12:40:04 [2019-10-21T12:40:04.781Z] === RUN   TestCreateTmpfsMountsTarget
12:40:05 [2019-10-21T12:40:05.064Z] --- PASS: TestCreateTmpfsMountsTarget (0.04s)
12:40:05 [2019-10-21T12:40:05.064Z] === RUN   TestCreateWithCustomMaskedPaths
12:40:07 [2019-10-21T12:40:07.097Z] --- PASS: TestCreateWithCustomMaskedPaths (1.84s)
12:40:07 [2019-10-21T12:40:07.097Z] === RUN   TestCreateWithCapabilities
12:40:07 [2019-10-21T12:40:07.097Z] === RUN   TestCreateWithCapabilities/no_capabilities
12:40:07 [2019-10-21T12:40:07.097Z] === PAUSE TestCreateWithCapabilities/no_capabilities
12:40:07 [2019-10-21T12:40:07.097Z] === RUN   TestCreateWithCapabilities/empty_capabilities
12:40:07 [2019-10-21T12:40:07.097Z] === PAUSE TestCreateWithCapabilities/empty_capabilities
12:40:07 [2019-10-21T12:40:07.097Z] === RUN   TestCreateWithCapabilities/valid_capabilities
12:40:07 [2019-10-21T12:40:07.097Z] === PAUSE TestCreateWithCapabilities/valid_capabilities
12:40:07 [2019-10-21T12:40:07.097Z] === RUN   TestCreateWithCapabilities/invalid_capabilities
12:40:07 [2019-10-21T12:40:07.097Z] === PAUSE TestCreateWithCapabilities/invalid_capabilities
12:40:07 [2019-10-21T12:40:07.097Z] === RUN   TestCreateWithCapabilities/duplicate_capabilities
12:40:07 [2019-10-21T12:40:07.097Z] === PAUSE TestCreateWithCapabilities/duplicate_capabilities
12:40:07 [2019-10-21T12:40:07.097Z] === RUN   TestCreateWithCapabilities/capabilities_API_v1.39
12:40:07 [2019-10-21T12:40:07.097Z] === PAUSE TestCreateWithCapabilities/capabilities_API_v1.39
12:40:07 [2019-10-21T12:40:07.097Z] === RUN   TestCreateWithCapabilities/empty_capadd
12:40:07 [2019-10-21T12:40:07.097Z] === PAUSE TestCreateWithCapabilities/empty_capadd
12:40:07 [2019-10-21T12:40:07.097Z] === RUN   TestCreateWithCapabilities/empty_capdrop
12:40:07 [2019-10-21T12:40:07.097Z] === PAUSE TestCreateWithCapabilities/empty_capdrop
12:40:07 [2019-10-21T12:40:07.097Z] === RUN   TestCreateWithCapabilities/capadd_capdrop
12:40:07 [2019-10-21T12:40:07.097Z] === PAUSE TestCreateWithCapabilities/capadd_capdrop
12:40:07 [2019-10-21T12:40:07.097Z] === RUN   TestCreateWithCapabilities/conflict_with_capadd
12:40:07 [2019-10-21T12:40:07.097Z] === PAUSE TestCreateWithCapabilities/conflict_with_capadd
12:40:07 [2019-10-21T12:40:07.097Z] === RUN   TestCreateWithCapabilities/conflict_with_capdrop
12:40:07 [2019-10-21T12:40:07.097Z] === PAUSE TestCreateWithCapabilities/conflict_with_capdrop
12:40:07 [2019-10-21T12:40:07.097Z] === CONT  TestCreateWithCapabilities/no_capabilities
12:40:07 [2019-10-21T12:40:07.097Z] === CONT  TestCreateWithCapabilities/empty_capadd
12:40:07 [2019-10-21T12:40:07.097Z] === CONT  TestCreateWithCapabilities/invalid_capabilities
12:40:07 [2019-10-21T12:40:07.097Z] === CONT  TestCreateWithCapabilities/conflict_with_capdrop
12:40:07 [2019-10-21T12:40:07.097Z] === CONT  TestCreateWithCapabilities/capabilities_API_v1.39
12:40:07 [2019-10-21T12:40:07.097Z] === CONT  TestCreateWithCapabilities/empty_capabilities
12:40:07 [2019-10-21T12:40:07.097Z] === CONT  TestCreateWithCapabilities/valid_capabilities
12:40:07 [2019-10-21T12:40:07.097Z] === CONT  TestCreateWithCapabilities/conflict_with_capadd
12:40:07 [2019-10-21T12:40:07.097Z] === CONT  TestCreateWithCapabilities/capadd_capdrop
12:40:07 [2019-10-21T12:40:07.097Z] === CONT  TestCreateWithCapabilities/empty_capdrop
12:40:07 [2019-10-21T12:40:07.097Z] === CONT  TestCreateWithCapabilities/duplicate_capabilities
12:40:07 [2019-10-21T12:40:07.097Z] --- PASS: TestCreateWithCapabilities (0.04s)
12:40:07 [2019-10-21T12:40:07.097Z]     --- PASS: TestCreateWithCapabilities/conflict_with_capdrop (0.00s)
12:40:07 [2019-10-21T12:40:07.097Z]     --- PASS: TestCreateWithCapabilities/invalid_capabilities (0.01s)
12:40:07 [2019-10-21T12:40:07.097Z]     --- PASS: TestCreateWithCapabilities/capabilities_API_v1.39 (0.05s)
12:40:07 [2019-10-21T12:40:07.097Z]     --- PASS: TestCreateWithCapabilities/no_capabilities (0.05s)
12:40:07 [2019-10-21T12:40:07.097Z]     --- PASS: TestCreateWithCapabilities/empty_capabilities (0.05s)
12:40:07 [2019-10-21T12:40:07.097Z]     --- PASS: TestCreateWithCapabilities/conflict_with_capadd (0.00s)
12:40:07 [2019-10-21T12:40:07.097Z]     --- PASS: TestCreateWithCapabilities/empty_capadd (0.06s)
12:40:07 [2019-10-21T12:40:07.097Z]     --- PASS: TestCreateWithCapabilities/capadd_capdrop (0.05s)
12:40:07 [2019-10-21T12:40:07.097Z]     --- PASS: TestCreateWithCapabilities/empty_capdrop (0.05s)
12:40:07 [2019-10-21T12:40:07.097Z]     --- PASS: TestCreateWithCapabilities/valid_capabilities (0.06s)
12:40:07 [2019-10-21T12:40:07.097Z]     --- PASS: TestCreateWithCapabilities/duplicate_capabilities (0.04s)
12:40:07 [2019-10-21T12:40:07.097Z] === RUN   TestCreateWithCustomReadonlyPaths
12:40:09 [2019-10-21T12:40:09.120Z] --- PASS: TestCreateWithCustomReadonlyPaths (1.85s)
12:40:09 [2019-10-21T12:40:09.120Z] === RUN   TestCreateWithInvalidHealthcheckParams
12:40:09 [2019-10-21T12:40:09.120Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
12:40:09 [2019-10-21T12:40:09.120Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
12:40:09 [2019-10-21T12:40:09.120Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
12:40:09 [2019-10-21T12:40:09.120Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
12:40:09 [2019-10-21T12:40:09.120Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
12:40:09 [2019-10-21T12:40:09.120Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
12:40:09 [2019-10-21T12:40:09.120Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
12:40:09 [2019-10-21T12:40:09.120Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
12:40:09 [2019-10-21T12:40:09.120Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
12:40:09 [2019-10-21T12:40:09.120Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
12:40:09 [2019-10-21T12:40:09.120Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
12:40:09 [2019-10-21T12:40:09.120Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
12:40:09 [2019-10-21T12:40:09.120Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
12:40:09 [2019-10-21T12:40:09.120Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
12:40:09 [2019-10-21T12:40:09.120Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
12:40:09 [2019-10-21T12:40:09.120Z] --- PASS: TestCreateWithInvalidHealthcheckParams (0.03s)
12:40:09 [2019-10-21T12:40:09.120Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s (0.02s)
12:40:09 [2019-10-21T12:40:09.120Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms (0.03s)
12:40:09 [2019-10-21T12:40:09.120Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms (0.03s)
12:40:09 [2019-10-21T12:40:09.120Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0 (0.03s)
12:40:09 [2019-10-21T12:40:09.120Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms (0.02s)
12:40:09 [2019-10-21T12:40:09.120Z] === RUN   TestContainerStartOnDaemonRestart
12:40:09 [2019-10-21T12:40:09.120Z] === PAUSE TestContainerStartOnDaemonRestart
12:40:09 [2019-10-21T12:40:09.120Z] === RUN   TestDaemonRestartIpcMode
12:40:09 [2019-10-21T12:40:09.120Z] === PAUSE TestDaemonRestartIpcMode
12:40:09 [2019-10-21T12:40:09.120Z] === RUN   TestDiff
12:40:09 [2019-10-21T12:40:09.403Z] --- PASS: TestDiff (0.63s)
12:40:09 [2019-10-21T12:40:09.403Z] === RUN   TestExecWithCloseStdin
12:40:10 [2019-10-21T12:40:10.420Z] --- PASS: TestExecWithCloseStdin (0.90s)
12:40:10 [2019-10-21T12:40:10.420Z] === RUN   TestExec
12:40:11 [2019-10-21T12:40:11.431Z] --- PASS: TestExec (0.86s)
12:40:11 [2019-10-21T12:40:11.431Z] === RUN   TestExecUser
12:40:12 [2019-10-21T12:40:12.047Z] --- PASS: TestExecUser (0.85s)
12:40:12 [2019-10-21T12:40:12.047Z] === RUN   TestExportContainerAndImportImage
12:40:13 [2019-10-21T12:40:13.071Z] --- PASS: TestExportContainerAndImportImage (0.96s)
12:40:13 [2019-10-21T12:40:13.071Z] === RUN   TestExportContainerAfterDaemonRestart
12:40:14 [2019-10-21T12:40:14.549Z] --- PASS: TestExportContainerAfterDaemonRestart (1.52s)
12:40:14 [2019-10-21T12:40:14.549Z]     export_test.go:63: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestExportContainerAfterDaemonRestart"
12:40:14 [2019-10-21T12:40:14.549Z] === RUN   TestHealthCheckWorkdir
12:40:15 [2019-10-21T12:40:15.562Z] --- PASS: TestHealthCheckWorkdir (1.05s)
12:40:15 [2019-10-21T12:40:15.562Z] === RUN   TestHealthKillContainer
12:40:19 [2019-10-21T12:40:19.013Z] --- PASS: TestHealthKillContainer (2.90s)
12:40:19 [2019-10-21T12:40:19.013Z] === RUN   TestInspectCpusetInConfigPre120
12:40:19 [2019-10-21T12:40:19.298Z] --- PASS: TestInspectCpusetInConfigPre120 (0.67s)
12:40:19 [2019-10-21T12:40:19.298Z] === RUN   TestIpcModeNone
12:40:19 [2019-10-21T12:40:19.931Z] --- PASS: TestIpcModeNone (0.86s)
12:40:19 [2019-10-21T12:40:19.931Z] === RUN   TestIpcModePrivate
12:40:20 [2019-10-21T12:40:20.943Z] --- PASS: TestIpcModePrivate (0.82s)
12:40:20 [2019-10-21T12:40:20.943Z]     ipcmode_linux_test.go:90: [testIpcPrivateShareable] ipcmode: private, ipcdev: 0:62, shared: false, mustBeShared: false
12:40:20 [2019-10-21T12:40:20.943Z] === RUN   TestIpcModeShareable
12:40:21 [2019-10-21T12:40:21.562Z] --- PASS: TestIpcModeShareable (0.83s)
12:40:21 [2019-10-21T12:40:21.562Z]     ipcmode_linux_test.go:90: [testIpcPrivateShareable] ipcmode: shareable, ipcdev: 0:56, shared: true, mustBeShared: true
12:40:21 [2019-10-21T12:40:21.562Z] === RUN   TestAPIIpcModeShareableAndContainer
12:40:24 [2019-10-21T12:40:24.242Z] --- PASS: TestAPIIpcModeShareableAndContainer (2.43s)
12:40:24 [2019-10-21T12:40:24.243Z] === RUN   TestAPIIpcModeHost
12:40:24 [2019-10-21T12:40:24.860Z] --- PASS: TestAPIIpcModeHost (0.70s)
12:40:24 [2019-10-21T12:40:24.860Z] === RUN   TestDaemonIpcModeShareable
12:40:26 [2019-10-21T12:40:26.888Z] --- PASS: TestDaemonIpcModeShareable (1.79s)
12:40:26 [2019-10-21T12:40:26.888Z]     ipcmode_linux_test.go:230: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModeShareable"
12:40:26 [2019-10-21T12:40:26.888Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:64, shared: true, mustBeShared: true
12:40:26 [2019-10-21T12:40:26.888Z] === RUN   TestDaemonIpcModePrivate
12:40:28 [2019-10-21T12:40:28.366Z] --- PASS: TestDaemonIpcModePrivate (1.72s)
12:40:28 [2019-10-21T12:40:28.366Z]     ipcmode_linux_test.go:230: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModePrivate"
12:40:28 [2019-10-21T12:40:28.366Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:70, shared: false, mustBeShared: false
12:40:28 [2019-10-21T12:40:28.366Z] === RUN   TestDaemonIpcModePrivateFromConfig
12:40:30 [2019-10-21T12:40:30.392Z] --- PASS: TestDaemonIpcModePrivateFromConfig (1.71s)
12:40:30 [2019-10-21T12:40:30.392Z]     ipcmode_linux_test.go:230: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModePrivateFromConfig"
12:40:30 [2019-10-21T12:40:30.392Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:70, shared: false, mustBeShared: false
12:40:30 [2019-10-21T12:40:30.392Z] === RUN   TestDaemonIpcModeShareableFromConfig
12:40:31 [2019-10-21T12:40:31.871Z] --- PASS: TestDaemonIpcModeShareableFromConfig (1.75s)
12:40:31 [2019-10-21T12:40:31.871Z]     ipcmode_linux_test.go:230: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModeShareableFromConfig"
12:40:31 [2019-10-21T12:40:31.871Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:64, shared: true, mustBeShared: true
12:40:31 [2019-10-21T12:40:31.871Z] === RUN   TestIpcModeOlderClient
12:40:31 [2019-10-21T12:40:31.871Z] === PAUSE TestIpcModeOlderClient
12:40:31 [2019-10-21T12:40:31.871Z] === RUN   TestKillContainerInvalidSignal
12:40:32 [2019-10-21T12:40:32.502Z] --- PASS: TestKillContainerInvalidSignal (0.69s)
12:40:32 [2019-10-21T12:40:32.502Z] === RUN   TestKillContainer
12:40:32 [2019-10-21T12:40:32.502Z] === RUN   TestKillContainer/no_signal
12:40:33 [2019-10-21T12:40:33.134Z] === RUN   TestKillContainer/non_killing_signal
12:40:33 [2019-10-21T12:40:33.749Z] === RUN   TestKillContainer/killing_signal
12:40:34 [2019-10-21T12:40:34.758Z] --- PASS: TestKillContainer (2.03s)
12:40:34 [2019-10-21T12:40:34.758Z]     --- PASS: TestKillContainer/no_signal (0.70s)
12:40:34 [2019-10-21T12:40:34.758Z]     --- PASS: TestKillContainer/non_killing_signal (0.45s)
12:40:34 [2019-10-21T12:40:34.758Z]     --- PASS: TestKillContainer/killing_signal (0.61s)
12:40:34 [2019-10-21T12:40:34.758Z] === RUN   TestKillWithStopSignalAndRestartPolicies
12:40:34 [2019-10-21T12:40:34.758Z] === RUN   TestKillWithStopSignalAndRestartPolicies/same-signal-disables-restart-policy
12:40:35 [2019-10-21T12:40:35.042Z] === RUN   TestKillWithStopSignalAndRestartPolicies/different-signal-keep-restart-policy
12:40:36 [2019-10-21T12:40:36.048Z] --- PASS: TestKillWithStopSignalAndRestartPolicies (1.32s)
12:40:36 [2019-10-21T12:40:36.048Z]     --- PASS: TestKillWithStopSignalAndRestartPolicies/same-signal-disables-restart-policy (0.61s)
12:40:36 [2019-10-21T12:40:36.048Z]     --- PASS: TestKillWithStopSignalAndRestartPolicies/different-signal-keep-restart-policy (0.44s)
12:40:36 [2019-10-21T12:40:36.048Z] === RUN   TestKillStoppedContainer
12:40:36 [2019-10-21T12:40:36.048Z] --- PASS: TestKillStoppedContainer (0.08s)
12:40:36 [2019-10-21T12:40:36.048Z] === RUN   TestKillStoppedContainerAPIPre120
12:40:36 [2019-10-21T12:40:36.048Z] --- PASS: TestKillStoppedContainerAPIPre120 (0.08s)
12:40:36 [2019-10-21T12:40:36.048Z] === RUN   TestKillDifferentUserContainer
12:40:36 [2019-10-21T12:40:36.668Z] --- PASS: TestKillDifferentUserContainer (0.71s)
12:40:36 [2019-10-21T12:40:36.668Z] === RUN   TestInspectOomKilledTrue
12:40:38 [2019-10-21T12:40:38.141Z] --- PASS: TestInspectOomKilledTrue (1.22s)
12:40:38 [2019-10-21T12:40:38.141Z] === RUN   TestInspectOomKilledFalse
12:40:38 [2019-10-21T12:40:38.757Z] --- PASS: TestInspectOomKilledFalse (0.66s)
12:40:38 [2019-10-21T12:40:38.757Z] === RUN   TestLinksEtcHostsContentMatch
12:40:39 [2019-10-21T12:40:39.375Z] --- PASS: TestLinksEtcHostsContentMatch (0.64s)
12:40:39 [2019-10-21T12:40:39.375Z] === RUN   TestLinksContainerNames
12:40:40 [2019-10-21T12:40:40.851Z] --- PASS: TestLinksContainerNames (1.35s)
12:40:40 [2019-10-21T12:40:40.851Z] === RUN   TestLogsFollowTailEmpty
12:40:41 [2019-10-21T12:40:41.134Z] --- PASS: TestLogsFollowTailEmpty (0.66s)
12:40:41 [2019-10-21T12:40:41.134Z] === RUN   TestContainerNetworkMountsNoChown
12:40:42 [2019-10-21T12:40:42.144Z] --- PASS: TestContainerNetworkMountsNoChown (0.67s)
12:40:42 [2019-10-21T12:40:42.144Z] === RUN   TestMountDaemonRoot
12:40:42 [2019-10-21T12:40:42.144Z] === RUN   TestMountDaemonRoot/default
12:40:42 [2019-10-21T12:40:42.145Z] === PAUSE TestMountDaemonRoot/default
12:40:42 [2019-10-21T12:40:42.145Z] === RUN   TestMountDaemonRoot/private
12:40:42 [2019-10-21T12:40:42.145Z] === PAUSE TestMountDaemonRoot/private
12:40:42 [2019-10-21T12:40:42.145Z] === RUN   TestMountDaemonRoot/rprivate
12:40:42 [2019-10-21T12:40:42.145Z] === PAUSE TestMountDaemonRoot/rprivate
12:40:42 [2019-10-21T12:40:42.145Z] === RUN   TestMountDaemonRoot/slave
12:40:42 [2019-10-21T12:40:42.145Z] === PAUSE TestMountDaemonRoot/slave
12:40:42 [2019-10-21T12:40:42.145Z] === RUN   TestMountDaemonRoot/rslave
12:40:42 [2019-10-21T12:40:42.145Z] === PAUSE TestMountDaemonRoot/rslave
12:40:42 [2019-10-21T12:40:42.145Z] === RUN   TestMountDaemonRoot/shared
12:40:42 [2019-10-21T12:40:42.145Z] === PAUSE TestMountDaemonRoot/shared
12:40:42 [2019-10-21T12:40:42.145Z] === RUN   TestMountDaemonRoot/rshared
12:40:42 [2019-10-21T12:40:42.145Z] === PAUSE TestMountDaemonRoot/rshared
12:40:42 [2019-10-21T12:40:42.145Z] === CONT  TestMountDaemonRoot/default
12:40:42 [2019-10-21T12:40:42.145Z] === CONT  TestMountDaemonRoot/rshared
12:40:42 [2019-10-21T12:40:42.145Z] === CONT  TestMountDaemonRoot/shared
12:40:42 [2019-10-21T12:40:42.145Z] === CONT  TestMountDaemonRoot/rslave
12:40:42 [2019-10-21T12:40:42.145Z] === RUN   TestMountDaemonRoot/default/mount_subpath
12:40:42 [2019-10-21T12:40:42.145Z] === RUN   TestMountDaemonRoot/rslave/bind_root
12:40:42 [2019-10-21T12:40:42.145Z] === PAUSE TestMountDaemonRoot/default/mount_subpath
12:40:42 [2019-10-21T12:40:42.145Z] === RUN   TestMountDaemonRoot/default/bind_root
12:40:42 [2019-10-21T12:40:42.145Z] === PAUSE TestMountDaemonRoot/default/bind_root
12:40:42 [2019-10-21T12:40:42.145Z] === RUN   TestMountDaemonRoot/default/bind_subpath
12:40:42 [2019-10-21T12:40:42.145Z] === PAUSE TestMountDaemonRoot/default/bind_subpath
12:40:42 [2019-10-21T12:40:42.145Z] === RUN   TestMountDaemonRoot/default/mount_root
12:40:42 [2019-10-21T12:40:42.145Z] === PAUSE TestMountDaemonRoot/default/mount_root
12:40:42 [2019-10-21T12:40:42.145Z] === RUN   TestMountDaemonRoot/shared/bind_root
12:40:42 [2019-10-21T12:40:42.145Z] === PAUSE TestMountDaemonRoot/shared/bind_root
12:40:42 [2019-10-21T12:40:42.145Z] === RUN   TestMountDaemonRoot/shared/bind_subpath
12:40:42 [2019-10-21T12:40:42.145Z] === PAUSE TestMountDaemonRoot/shared/bind_subpath
12:40:42 [2019-10-21T12:40:42.145Z] === RUN   TestMountDaemonRoot/shared/mount_root
12:40:42 [2019-10-21T12:40:42.145Z] === PAUSE TestMountDaemonRoot/shared/mount_root
12:40:42 [2019-10-21T12:40:42.145Z] === RUN   TestMountDaemonRoot/shared/mount_subpath
12:40:42 [2019-10-21T12:40:42.145Z] === PAUSE TestMountDaemonRoot/shared/mount_subpath
12:40:42 [2019-10-21T12:40:42.145Z] === PAUSE TestMountDaemonRoot/rslave/bind_root
12:40:42 [2019-10-21T12:40:42.145Z] === RUN   TestMountDaemonRoot/rslave/bind_subpath
12:40:42 [2019-10-21T12:40:42.145Z] === PAUSE TestMountDaemonRoot/rslave/bind_subpath
12:40:42 [2019-10-21T12:40:42.145Z] === RUN   TestMountDaemonRoot/rslave/mount_root
12:40:42 [2019-10-21T12:40:42.145Z] === PAUSE TestMountDaemonRoot/rslave/mount_root
12:40:42 [2019-10-21T12:40:42.145Z] === RUN   TestMountDaemonRoot/rslave/mount_subpath
12:40:42 [2019-10-21T12:40:42.145Z] === PAUSE TestMountDaemonRoot/rslave/mount_subpath
12:40:42 [2019-10-21T12:40:42.145Z] === CONT  TestMountDaemonRoot/rprivate
12:40:42 [2019-10-21T12:40:42.145Z] === RUN   TestMountDaemonRoot/rprivate/bind_root
12:40:42 [2019-10-21T12:40:42.145Z] === PAUSE TestMountDaemonRoot/rprivate/bind_root
12:40:42 [2019-10-21T12:40:42.145Z] === RUN   TestMountDaemonRoot/rprivate/bind_subpath
12:40:42 [2019-10-21T12:40:42.145Z] === PAUSE TestMountDaemonRoot/rprivate/bind_subpath
12:40:42 [2019-10-21T12:40:42.145Z] === RUN   TestMountDaemonRoot/rprivate/mount_root
12:40:42 [2019-10-21T12:40:42.145Z] === PAUSE TestMountDaemonRoot/rprivate/mount_root
12:40:42 [2019-10-21T12:40:42.145Z] === RUN   TestMountDaemonRoot/rprivate/mount_subpath
12:40:42 [2019-10-21T12:40:42.145Z] === PAUSE TestMountDaemonRoot/rprivate/mount_subpath
12:40:42 [2019-10-21T12:40:42.145Z] === RUN   TestMountDaemonRoot/rshared/mount_subpath
12:40:42 [2019-10-21T12:40:42.145Z] === PAUSE TestMountDaemonRoot/rshared/mount_subpath
12:40:42 [2019-10-21T12:40:42.145Z] === RUN   TestMountDaemonRoot/rshared/bind_root
12:40:42 [2019-10-21T12:40:42.145Z] === PAUSE TestMountDaemonRoot/rshared/bind_root
12:40:42 [2019-10-21T12:40:42.145Z] === RUN   TestMountDaemonRoot/rshared/bind_subpath
12:40:42 [2019-10-21T12:40:42.145Z] === PAUSE TestMountDaemonRoot/rshared/bind_subpath
12:40:42 [2019-10-21T12:40:42.145Z] === RUN   TestMountDaemonRoot/rshared/mount_root
12:40:42 [2019-10-21T12:40:42.145Z] === PAUSE TestMountDaemonRoot/rshared/mount_root
12:40:42 [2019-10-21T12:40:42.145Z] === CONT  TestMountDaemonRoot/slave
12:40:42 [2019-10-21T12:40:42.145Z] === RUN   TestMountDaemonRoot/slave/bind_root
12:40:42 [2019-10-21T12:40:42.145Z] === PAUSE TestMountDaemonRoot/slave/bind_root
12:40:42 [2019-10-21T12:40:42.145Z] === RUN   TestMountDaemonRoot/slave/bind_subpath
12:40:42 [2019-10-21T12:40:42.145Z] === PAUSE TestMountDaemonRoot/slave/bind_subpath
12:40:42 [2019-10-21T12:40:42.145Z] === RUN   TestMountDaemonRoot/slave/mount_root
12:40:42 [2019-10-21T12:40:42.145Z] === PAUSE TestMountDaemonRoot/slave/mount_root
12:40:42 [2019-10-21T12:40:42.145Z] === RUN   TestMountDaemonRoot/slave/mount_subpath
12:40:42 [2019-10-21T12:40:42.145Z] === PAUSE TestMountDaemonRoot/slave/mount_subpath
12:40:42 [2019-10-21T12:40:42.145Z] === CONT  TestMountDaemonRoot/private
12:40:42 [2019-10-21T12:40:42.145Z] === RUN   TestMountDaemonRoot/private/bind_root
12:40:42 [2019-10-21T12:40:42.145Z] === PAUSE TestMountDaemonRoot/private/bind_root
12:40:42 [2019-10-21T12:40:42.145Z] === RUN   TestMountDaemonRoot/private/bind_subpath
12:40:42 [2019-10-21T12:40:42.145Z] === PAUSE TestMountDaemonRoot/private/bind_subpath
12:40:42 [2019-10-21T12:40:42.145Z] === RUN   TestMountDaemonRoot/private/mount_root
12:40:42 [2019-10-21T12:40:42.145Z] === PAUSE TestMountDaemonRoot/private/mount_root
12:40:42 [2019-10-21T12:40:42.145Z] === RUN   TestMountDaemonRoot/private/mount_subpath
12:40:42 [2019-10-21T12:40:42.145Z] === PAUSE TestMountDaemonRoot/private/mount_subpath
12:40:42 [2019-10-21T12:40:42.145Z] === CONT  TestMountDaemonRoot/default/mount_subpath
12:40:42 [2019-10-21T12:40:42.145Z] === CONT  TestMountDaemonRoot/shared/bind_root
12:40:42 [2019-10-21T12:40:42.145Z] === CONT  TestMountDaemonRoot/rslave/bind_root
12:40:42 [2019-10-21T12:40:42.145Z] === CONT  TestMountDaemonRoot/rprivate/bind_root
12:40:42 [2019-10-21T12:40:42.145Z] === CONT  TestMountDaemonRoot/default/mount_root
12:40:42 [2019-10-21T12:40:42.145Z] === CONT  TestMountDaemonRoot/default/bind_subpath
12:40:42 [2019-10-21T12:40:42.145Z] === CONT  TestMountDaemonRoot/default/bind_root
12:40:42 [2019-10-21T12:40:42.145Z] === CONT  TestMountDaemonRoot/rshared/mount_subpath
12:40:42 [2019-10-21T12:40:42.145Z] === CONT  TestMountDaemonRoot/slave/bind_root
12:40:42 [2019-10-21T12:40:42.145Z] === CONT  TestMountDaemonRoot/shared/mount_subpath
12:40:42 [2019-10-21T12:40:42.145Z] === CONT  TestMountDaemonRoot/shared/mount_root
12:40:42 [2019-10-21T12:40:42.145Z] === CONT  TestMountDaemonRoot/shared/bind_subpath
12:40:42 [2019-10-21T12:40:42.145Z] === CONT  TestMountDaemonRoot/private/bind_root
12:40:42 [2019-10-21T12:40:42.145Z] === CONT  TestMountDaemonRoot/rslave/mount_subpath
12:40:42 [2019-10-21T12:40:42.145Z] === CONT  TestMountDaemonRoot/rslave/mount_root
12:40:42 [2019-10-21T12:40:42.145Z] === CONT  TestMountDaemonRoot/rslave/bind_subpath
12:40:42 [2019-10-21T12:40:42.145Z] === CONT  TestMountDaemonRoot/rprivate/mount_subpath
12:40:42 [2019-10-21T12:40:42.145Z] === CONT  TestMountDaemonRoot/rprivate/mount_root
12:40:42 [2019-10-21T12:40:42.145Z] === CONT  TestMountDaemonRoot/rprivate/bind_subpath
12:40:42 [2019-10-21T12:40:42.145Z] === CONT  TestMountDaemonRoot/rshared/mount_root
12:40:42 [2019-10-21T12:40:42.145Z] === CONT  TestMountDaemonRoot/rshared/bind_subpath
12:40:42 [2019-10-21T12:40:42.145Z] === CONT  TestMountDaemonRoot/rshared/bind_root
12:40:42 [2019-10-21T12:40:42.145Z] === CONT  TestMountDaemonRoot/slave/mount_subpath
12:40:42 [2019-10-21T12:40:42.145Z] === CONT  TestMountDaemonRoot/slave/mount_root
12:40:42 [2019-10-21T12:40:42.145Z] === CONT  TestMountDaemonRoot/slave/bind_subpath
12:40:42 [2019-10-21T12:40:42.145Z] === CONT  TestMountDaemonRoot/private/mount_subpath
12:40:42 [2019-10-21T12:40:42.145Z] === CONT  TestMountDaemonRoot/private/mount_root
12:40:42 [2019-10-21T12:40:42.145Z] === CONT  TestMountDaemonRoot/private/bind_subpath
12:40:42 [2019-10-21T12:40:42.428Z] --- PASS: TestMountDaemonRoot (0.04s)
12:40:42 [2019-10-21T12:40:42.428Z]     --- PASS: TestMountDaemonRoot/default (0.00s)
12:40:42 [2019-10-21T12:40:42.428Z]         --- PASS: TestMountDaemonRoot/default/mount_subpath (0.07s)
12:40:42 [2019-10-21T12:40:42.428Z]         --- PASS: TestMountDaemonRoot/default/bind_subpath (0.07s)
12:40:42 [2019-10-21T12:40:42.428Z]         --- PASS: TestMountDaemonRoot/default/mount_root (0.08s)
12:40:42 [2019-10-21T12:40:42.428Z]         --- PASS: TestMountDaemonRoot/default/bind_root (0.06s)
12:40:42 [2019-10-21T12:40:42.428Z]     --- PASS: TestMountDaemonRoot/shared (0.00s)
12:40:42 [2019-10-21T12:40:42.428Z]         --- PASS: TestMountDaemonRoot/shared/bind_root (0.04s)
12:40:42 [2019-10-21T12:40:42.428Z]         --- PASS: TestMountDaemonRoot/shared/mount_subpath (0.03s)
12:40:42 [2019-10-21T12:40:42.428Z]         --- PASS: TestMountDaemonRoot/shared/bind_subpath (0.03s)
12:40:42 [2019-10-21T12:40:42.428Z]         --- PASS: TestMountDaemonRoot/shared/mount_root (0.03s)
12:40:42 [2019-10-21T12:40:42.428Z]     --- PASS: TestMountDaemonRoot/rslave (0.00s)
12:40:42 [2019-10-21T12:40:42.428Z]         --- PASS: TestMountDaemonRoot/rslave/bind_root (0.07s)
12:40:42 [2019-10-21T12:40:42.428Z]         --- PASS: TestMountDaemonRoot/rslave/mount_subpath (0.06s)
12:40:42 [2019-10-21T12:40:42.428Z]         --- PASS: TestMountDaemonRoot/rslave/mount_root (0.06s)
12:40:42 [2019-10-21T12:40:42.428Z]         --- PASS: TestMountDaemonRoot/rslave/bind_subpath (0.06s)
12:40:42 [2019-10-21T12:40:42.428Z]     --- PASS: TestMountDaemonRoot/rprivate (0.00s)
12:40:42 [2019-10-21T12:40:42.428Z]         --- PASS: TestMountDaemonRoot/rprivate/bind_root (0.03s)
12:40:42 [2019-10-21T12:40:42.428Z]         --- PASS: TestMountDaemonRoot/rprivate/mount_subpath (0.04s)
12:40:42 [2019-10-21T12:40:42.428Z]         --- PASS: TestMountDaemonRoot/rprivate/mount_root (0.03s)
12:40:42 [2019-10-21T12:40:42.428Z]         --- PASS: TestMountDaemonRoot/rprivate/bind_subpath (0.03s)
12:40:42 [2019-10-21T12:40:42.428Z]     --- PASS: TestMountDaemonRoot/rshared (0.00s)
12:40:42 [2019-10-21T12:40:42.428Z]         --- PASS: TestMountDaemonRoot/rshared/mount_subpath (0.06s)
12:40:42 [2019-10-21T12:40:42.428Z]         --- PASS: TestMountDaemonRoot/rshared/bind_subpath (0.06s)
12:40:42 [2019-10-21T12:40:42.428Z]         --- PASS: TestMountDaemonRoot/rshared/mount_root (0.06s)
12:40:42 [2019-10-21T12:40:42.428Z]         --- PASS: TestMountDaemonRoot/rshared/bind_root (0.05s)
12:40:42 [2019-10-21T12:40:42.428Z]     --- PASS: TestMountDaemonRoot/slave (0.00s)
12:40:42 [2019-10-21T12:40:42.428Z]         --- PASS: TestMountDaemonRoot/slave/bind_root (0.04s)
12:40:42 [2019-10-21T12:40:42.428Z]         --- PASS: TestMountDaemonRoot/slave/mount_subpath (0.03s)
12:40:42 [2019-10-21T12:40:42.428Z]         --- PASS: TestMountDaemonRoot/slave/mount_root (0.04s)
12:40:42 [2019-10-21T12:40:42.428Z]         --- PASS: TestMountDaemonRoot/slave/bind_subpath (0.04s)
12:40:42 [2019-10-21T12:40:42.428Z]     --- PASS: TestMountDaemonRoot/private (0.00s)
12:40:42 [2019-10-21T12:40:42.428Z]         --- PASS: TestMountDaemonRoot/private/bind_root (0.04s)
12:40:42 [2019-10-21T12:40:42.428Z]         --- PASS: TestMountDaemonRoot/private/mount_subpath (0.03s)
12:40:42 [2019-10-21T12:40:42.428Z]         --- PASS: TestMountDaemonRoot/private/mount_root (0.04s)
12:40:42 [2019-10-21T12:40:42.428Z]         --- PASS: TestMountDaemonRoot/private/bind_subpath (0.03s)
12:40:42 [2019-10-21T12:40:42.428Z] === RUN   TestContainerBindMountNonRecursive
12:40:43 [2019-10-21T12:40:43.904Z] --- PASS: TestContainerBindMountNonRecursive (1.57s)
12:40:43 [2019-10-21T12:40:43.904Z] === RUN   TestNetworkNat
12:40:44 [2019-10-21T12:40:44.525Z] --- PASS: TestNetworkNat (0.73s)
12:40:44 [2019-10-21T12:40:44.525Z] === RUN   TestNetworkLocalhostTCPNat
12:40:45 [2019-10-21T12:40:45.538Z] --- PASS: TestNetworkLocalhostTCPNat (0.71s)
12:40:45 [2019-10-21T12:40:45.538Z] === RUN   TestNetworkLoopbackNat
12:40:46 [2019-10-21T12:40:46.152Z] --- PASS: TestNetworkLoopbackNat (0.92s)
12:40:46 [2019-10-21T12:40:46.152Z] === RUN   TestPause
12:40:47 [2019-10-21T12:40:47.164Z] --- PASS: TestPause (0.74s)
12:40:47 [2019-10-21T12:40:47.164Z] === RUN   TestPauseFailsOnWindowsServerContainers
12:40:47 [2019-10-21T12:40:47.164Z] --- SKIP: TestPauseFailsOnWindowsServerContainers (0.00s)
12:40:47 [2019-10-21T12:40:47.164Z]     pause_test.go:54: testEnv.DaemonInfo.OSType != "windows" || testEnv.DaemonInfo.Isolation != "process"
12:40:47 [2019-10-21T12:40:47.164Z] === RUN   TestPauseStopPausedContainer
12:40:47 [2019-10-21T12:40:47.783Z] --- PASS: TestPauseStopPausedContainer (0.77s)
12:40:47 [2019-10-21T12:40:47.783Z] === RUN   TestPsFilter
12:40:48 [2019-10-21T12:40:48.068Z] --- PASS: TestPsFilter (0.19s)
12:40:48 [2019-10-21T12:40:48.068Z] === RUN   TestRemoveContainerWithRemovedVolume
12:40:48 [2019-10-21T12:40:48.688Z] --- PASS: TestRemoveContainerWithRemovedVolume (0.67s)
12:40:48 [2019-10-21T12:40:48.688Z] === RUN   TestRemoveContainerWithVolume
12:40:49 [2019-10-21T12:40:49.307Z] --- PASS: TestRemoveContainerWithVolume (0.67s)
12:40:49 [2019-10-21T12:40:49.307Z] === RUN   TestRemoveContainerRunning
12:40:49 [2019-10-21T12:40:49.924Z] --- PASS: TestRemoveContainerRunning (0.67s)
12:40:49 [2019-10-21T12:40:49.924Z] === RUN   TestRemoveContainerForceRemoveRunning
12:40:50 [2019-10-21T12:40:50.542Z] --- PASS: TestRemoveContainerForceRemoveRunning (0.70s)
12:40:50 [2019-10-21T12:40:50.542Z] === RUN   TestRemoveInvalidContainer
12:40:50 [2019-10-21T12:40:50.542Z] --- PASS: TestRemoveInvalidContainer (0.03s)
12:40:50 [2019-10-21T12:40:50.542Z] === RUN   TestRenameLinkedContainer
12:40:53 [2019-10-21T12:40:53.222Z] --- PASS: TestRenameLinkedContainer (2.66s)
12:40:53 [2019-10-21T12:40:53.222Z] === RUN   TestRenameStoppedContainer
12:40:54 [2019-10-21T12:40:54.229Z] --- PASS: TestRenameStoppedContainer (0.66s)
12:40:54 [2019-10-21T12:40:54.229Z] === RUN   TestRenameRunningContainerAndReuse
12:40:55 [2019-10-21T12:40:55.239Z] --- PASS: TestRenameRunningContainerAndReuse (1.35s)
12:40:55 [2019-10-21T12:40:55.239Z] === RUN   TestRenameInvalidName
12:40:56 [2019-10-21T12:40:56.256Z] --- PASS: TestRenameInvalidName (0.69s)
12:40:56 [2019-10-21T12:40:56.256Z] === RUN   TestRenameAnonymousContainer
12:40:58 [2019-10-21T12:40:58.937Z] --- PASS: TestRenameAnonymousContainer (2.48s)
12:40:58 [2019-10-21T12:40:58.937Z] === RUN   TestRenameContainerWithSameName
12:40:59 [2019-10-21T12:40:59.221Z] --- PASS: TestRenameContainerWithSameName (0.67s)
12:40:59 [2019-10-21T12:40:59.221Z] === RUN   TestRenameContainerWithLinkedContainer
12:41:00 [2019-10-21T12:41:00.695Z] --- PASS: TestRenameContainerWithLinkedContainer (1.38s)
12:41:00 [2019-10-21T12:41:00.695Z] === RUN   TestResize
12:41:01 [2019-10-21T12:41:01.318Z] --- PASS: TestResize (0.70s)
12:41:01 [2019-10-21T12:41:01.319Z] === RUN   TestResizeWithInvalidSize
12:41:01 [2019-10-21T12:41:01.936Z] --- PASS: TestResizeWithInvalidSize (0.71s)
12:41:01 [2019-10-21T12:41:01.936Z] === RUN   TestResizeWhenContainerNotStarted
12:41:02 [2019-10-21T12:41:02.554Z] --- PASS: TestResizeWhenContainerNotStarted (0.66s)
12:41:02 [2019-10-21T12:41:02.554Z] === RUN   TestDaemonRestartKillContainers
12:41:02 [2019-10-21T12:41:02.554Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
12:41:02 [2019-10-21T12:41:02.554Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
12:41:02 [2019-10-21T12:41:02.554Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
12:41:02 [2019-10-21T12:41:02.554Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
12:41:02 [2019-10-21T12:41:02.554Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
12:41:02 [2019-10-21T12:41:02.554Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
12:41:02 [2019-10-21T12:41:02.554Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
12:41:02 [2019-10-21T12:41:02.554Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
12:41:02 [2019-10-21T12:41:02.554Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
12:41:02 [2019-10-21T12:41:02.554Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
12:41:02 [2019-10-21T12:41:02.554Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
12:41:02 [2019-10-21T12:41:02.554Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
12:41:02 [2019-10-21T12:41:02.554Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
12:41:02 [2019-10-21T12:41:02.554Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
12:41:02 [2019-10-21T12:41:02.554Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
12:41:02 [2019-10-21T12:41:02.554Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
12:41:02 [2019-10-21T12:41:02.554Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
12:41:02 [2019-10-21T12:41:02.554Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
12:41:02 [2019-10-21T12:41:02.554Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
12:41:02 [2019-10-21T12:41:02.554Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
12:41:02 [2019-10-21T12:41:02.554Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
12:41:02 [2019-10-21T12:41:02.554Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
12:41:02 [2019-10-21T12:41:02.554Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
12:41:02 [2019-10-21T12:41:02.554Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
12:41:02 [2019-10-21T12:41:02.554Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
12:41:02 [2019-10-21T12:41:02.554Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
12:41:02 [2019-10-21T12:41:02.554Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
12:41:02 [2019-10-21T12:41:02.554Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
12:41:06 [2019-10-21T12:41:06.042Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
12:41:06 [2019-10-21T12:41:06.042Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
12:41:07 [2019-10-21T12:41:07.061Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
12:41:07 [2019-10-21T12:41:07.348Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
12:41:09 [2019-10-21T12:41:09.398Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
12:41:09 [2019-10-21T12:41:09.398Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
12:41:09 [2019-10-21T12:41:09.398Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
12:41:10 [2019-10-21T12:41:10.430Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
12:41:12 [2019-10-21T12:41:12.466Z] --- PASS: TestDaemonRestartKillContainers (0.00s)
12:41:12 [2019-10-21T12:41:12.466Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon (3.23s)
12:41:12 [2019-10-21T12:41:12.466Z]         restart_test.go:67: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon"
12:41:12 [2019-10-21T12:41:12.466Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon (3.46s)
12:41:12 [2019-10-21T12:41:12.466Z]         restart_test.go:67: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon"
12:41:12 [2019-10-21T12:41:12.466Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon (4.42s)
12:41:12 [2019-10-21T12:41:12.466Z]         restart_test.go:67: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon"
12:41:12 [2019-10-21T12:41:12.466Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon (4.67s)
12:41:12 [2019-10-21T12:41:12.466Z]         restart_test.go:67: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon"
12:41:12 [2019-10-21T12:41:12.466Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon (3.11s)
12:41:12 [2019-10-21T12:41:12.467Z]         restart_test.go:67: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon"
12:41:12 [2019-10-21T12:41:12.467Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon (3.02s)
12:41:12 [2019-10-21T12:41:12.467Z]         restart_test.go:67: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon"
12:41:12 [2019-10-21T12:41:12.467Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon (2.01s)
12:41:12 [2019-10-21T12:41:12.467Z]         restart_test.go:67: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon"
12:41:12 [2019-10-21T12:41:12.467Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon (3.13s)
12:41:12 [2019-10-21T12:41:12.467Z]         restart_test.go:67: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon"
12:41:12 [2019-10-21T12:41:12.467Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon (1.92s)
12:41:12 [2019-10-21T12:41:12.467Z]         restart_test.go:67: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon"
12:41:12 [2019-10-21T12:41:12.467Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon (1.98s)
12:41:12 [2019-10-21T12:41:12.467Z]         restart_test.go:67: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon"
12:41:12 [2019-10-21T12:41:12.467Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon (1.97s)
12:41:12 [2019-10-21T12:41:12.467Z]         restart_test.go:67: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon"
12:41:12 [2019-10-21T12:41:12.467Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon (2.22s)
12:41:12 [2019-10-21T12:41:12.467Z]         restart_test.go:67: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon"
12:41:12 [2019-10-21T12:41:12.467Z] === RUN   TestCgroupNamespacesRun
12:41:14 [2019-10-21T12:41:14.495Z] --- PASS: TestCgroupNamespacesRun (1.66s)
12:41:14 [2019-10-21T12:41:14.495Z]     run_cgroupns_linux_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRun"
12:41:14 [2019-10-21T12:41:14.495Z] === RUN   TestCgroupNamespacesRunPrivileged
12:41:15 [2019-10-21T12:41:15.983Z] --- PASS: TestCgroupNamespacesRunPrivileged (1.74s)
12:41:15 [2019-10-21T12:41:15.983Z]     run_cgroupns_linux_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunPrivileged"
12:41:15 [2019-10-21T12:41:15.983Z] === RUN   TestCgroupNamespacesRunDaemonHostMode
12:41:17 [2019-10-21T12:41:17.460Z] --- PASS: TestCgroupNamespacesRunDaemonHostMode (1.69s)
12:41:17 [2019-10-21T12:41:17.460Z]     run_cgroupns_linux_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunDaemonHostMode"
12:41:17 [2019-10-21T12:41:17.460Z] === RUN   TestCgroupNamespacesRunHostMode
12:41:19 [2019-10-21T12:41:19.486Z] --- PASS: TestCgroupNamespacesRunHostMode (1.70s)
12:41:19 [2019-10-21T12:41:19.486Z]     run_cgroupns_linux_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunHostMode"
12:41:19 [2019-10-21T12:41:19.486Z] === RUN   TestCgroupNamespacesRunPrivateMode
12:41:20 [2019-10-21T12:41:20.970Z] --- PASS: TestCgroupNamespacesRunPrivateMode (1.72s)
12:41:20 [2019-10-21T12:41:20.970Z]     run_cgroupns_linux_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunPrivateMode"
12:41:20 [2019-10-21T12:41:20.970Z] === RUN   TestCgroupNamespacesRunPrivilegedAndPrivate
12:41:21 [2019-10-21T12:41:21.989Z] --- PASS: TestCgroupNamespacesRunPrivilegedAndPrivate (0.89s)
12:41:21 [2019-10-21T12:41:21.989Z]     run_cgroupns_linux_test.go:48: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunPrivilegedAndPrivate"
12:41:21 [2019-10-21T12:41:21.989Z] === RUN   TestCgroupNamespacesRunInvalidMode
12:41:22 [2019-10-21T12:41:22.607Z] --- PASS: TestCgroupNamespacesRunInvalidMode (0.89s)
12:41:22 [2019-10-21T12:41:22.607Z]     run_cgroupns_linux_test.go:48: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunInvalidMode"
12:41:22 [2019-10-21T12:41:22.607Z] === RUN   TestCgroupNamespacesRunOlderClient
12:41:24 [2019-10-21T12:41:24.642Z] --- PASS: TestCgroupNamespacesRunOlderClient (1.73s)
12:41:24 [2019-10-21T12:41:24.642Z]     run_cgroupns_linux_test.go:139: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunOlderClient"
12:41:24 [2019-10-21T12:41:24.642Z] === RUN   TestKernelTCPMemory
12:41:25 [2019-10-21T12:41:25.259Z] --- PASS: TestKernelTCPMemory (0.88s)
12:41:25 [2019-10-21T12:41:25.259Z] === RUN   TestNISDomainname
12:41:26 [2019-10-21T12:41:26.269Z] --- PASS: TestNISDomainname (0.99s)
12:41:26 [2019-10-21T12:41:26.269Z] === RUN   TestHostnameDnsResolution
12:41:27 [2019-10-21T12:41:27.279Z] --- PASS: TestHostnameDnsResolution (1.09s)
12:41:27 [2019-10-21T12:41:27.279Z] === RUN   TestStats
12:41:29 [2019-10-21T12:41:29.956Z] --- PASS: TestStats (2.68s)
12:41:29 [2019-10-21T12:41:29.956Z] === RUN   TestStopContainerWithTimeout
12:41:30 [2019-10-21T12:41:30.241Z] === RUN   TestStopContainerWithTimeout/0
12:41:30 [2019-10-21T12:41:30.241Z] === PAUSE TestStopContainerWithTimeout/0
12:41:30 [2019-10-21T12:41:30.241Z] === RUN   TestStopContainerWithTimeout/1
12:41:30 [2019-10-21T12:41:30.241Z] === PAUSE TestStopContainerWithTimeout/1
12:41:30 [2019-10-21T12:41:30.241Z] === RUN   TestStopContainerWithTimeout/3
12:41:30 [2019-10-21T12:41:30.241Z] === PAUSE TestStopContainerWithTimeout/3
12:41:30 [2019-10-21T12:41:30.241Z] === RUN   TestStopContainerWithTimeout/-1
12:41:30 [2019-10-21T12:41:30.241Z] === PAUSE TestStopContainerWithTimeout/-1
12:41:30 [2019-10-21T12:41:30.241Z] === CONT  TestStopContainerWithTimeout/0
12:41:30 [2019-10-21T12:41:30.241Z] === CONT  TestStopContainerWithTimeout/3
12:41:30 [2019-10-21T12:41:30.241Z] === CONT  TestStopContainerWithTimeout/-1
12:41:30 [2019-10-21T12:41:30.241Z] === CONT  TestStopContainerWithTimeout/1
12:41:33 [2019-10-21T12:41:33.703Z] --- PASS: TestStopContainerWithTimeout (0.03s)
12:41:33 [2019-10-21T12:41:33.703Z]     --- PASS: TestStopContainerWithTimeout/0 (1.05s)
12:41:33 [2019-10-21T12:41:33.703Z]     --- PASS: TestStopContainerWithTimeout/1 (2.26s)
12:41:33 [2019-10-21T12:41:33.703Z]     --- PASS: TestStopContainerWithTimeout/-1 (3.18s)
12:41:33 [2019-10-21T12:41:33.703Z]     --- PASS: TestStopContainerWithTimeout/3 (3.23s)
12:41:33 [2019-10-21T12:41:33.703Z] === RUN   TestDeleteDevicemapper
12:41:33 [2019-10-21T12:41:33.703Z] --- SKIP: TestDeleteDevicemapper (0.00s)
12:41:33 [2019-10-21T12:41:33.703Z]     stop_linux_test.go:74: testEnv.DaemonInfo.Driver != "devicemapper"
12:41:33 [2019-10-21T12:41:33.703Z] === RUN   TestStopContainerWithRestartPolicyAlways
12:41:36 [2019-10-21T12:41:36.384Z] --- PASS: TestStopContainerWithRestartPolicyAlways (2.86s)
12:41:36 [2019-10-21T12:41:36.384Z] === RUN   TestUpdateMemory
12:41:37 [2019-10-21T12:41:37.404Z] --- PASS: TestUpdateMemory (1.00s)
12:41:37 [2019-10-21T12:41:37.405Z] === RUN   TestUpdateCPUQuota
12:41:38 [2019-10-21T12:41:38.881Z] --- PASS: TestUpdateCPUQuota (1.55s)
12:41:38 [2019-10-21T12:41:38.881Z] === RUN   TestUpdatePidsLimit
12:41:38 [2019-10-21T12:41:38.881Z] === RUN   TestUpdatePidsLimit/update_from_none
12:41:39 [2019-10-21T12:41:39.164Z] === RUN   TestUpdatePidsLimit/no_change
12:41:39 [2019-10-21T12:41:39.448Z] === RUN   TestUpdatePidsLimit/update_lower
12:41:40 [2019-10-21T12:41:40.066Z] === RUN   TestUpdatePidsLimit/update_on_old_api_ignores_value
12:41:40 [2019-10-21T12:41:40.350Z] === RUN   TestUpdatePidsLimit/unset_limit_with_zero
12:41:40 [2019-10-21T12:41:40.633Z] === RUN   TestUpdatePidsLimit/unset_limit_with_minus_one
12:41:40 [2019-10-21T12:41:40.917Z] === RUN   TestUpdatePidsLimit/unset_limit_with_minus_two
12:41:42 [2019-10-21T12:41:42.949Z] --- PASS: TestUpdatePidsLimit (3.84s)
12:41:42 [2019-10-21T12:41:42.949Z]     --- PASS: TestUpdatePidsLimit/update_from_none (0.38s)
12:41:42 [2019-10-21T12:41:42.949Z]     --- PASS: TestUpdatePidsLimit/no_change (0.37s)
12:41:42 [2019-10-21T12:41:42.949Z]     --- PASS: TestUpdatePidsLimit/update_lower (0.36s)
12:41:42 [2019-10-21T12:41:42.949Z]     --- PASS: TestUpdatePidsLimit/update_on_old_api_ignores_value (0.39s)
12:41:42 [2019-10-21T12:41:42.949Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_zero (0.37s)
12:41:42 [2019-10-21T12:41:42.949Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_minus_one (0.38s)
12:41:42 [2019-10-21T12:41:42.949Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_minus_two (0.38s)
12:41:42 [2019-10-21T12:41:42.949Z] === RUN   TestUpdateRestartPolicy
12:41:55 [2019-10-21T12:41:55.465Z] --- PASS: TestUpdateRestartPolicy (12.01s)
12:41:55 [2019-10-21T12:41:55.465Z] === RUN   TestUpdateRestartWithAutoRemove
12:41:55 [2019-10-21T12:41:55.465Z] --- PASS: TestUpdateRestartWithAutoRemove (0.71s)
12:41:55 [2019-10-21T12:41:55.465Z] === RUN   TestWaitNonBlocked
12:41:55 [2019-10-21T12:41:55.465Z] === RUN   TestWaitNonBlocked/wait-nonblocking-exit-0
12:41:55 [2019-10-21T12:41:55.465Z] === PAUSE TestWaitNonBlocked/wait-nonblocking-exit-0
12:41:55 [2019-10-21T12:41:55.465Z] === RUN   TestWaitNonBlocked/wait-nonblocking-exit-random
12:41:55 [2019-10-21T12:41:55.465Z] === PAUSE TestWaitNonBlocked/wait-nonblocking-exit-random
12:41:55 [2019-10-21T12:41:55.465Z] === CONT  TestWaitNonBlocked/wait-nonblocking-exit-0
12:41:55 [2019-10-21T12:41:55.465Z] === CONT  TestWaitNonBlocked/wait-nonblocking-exit-random
12:41:56 [2019-10-21T12:41:56.084Z] --- PASS: TestWaitNonBlocked (0.03s)
12:41:56 [2019-10-21T12:41:56.084Z]     --- PASS: TestWaitNonBlocked/wait-nonblocking-exit-random (0.73s)
12:41:56 [2019-10-21T12:41:56.084Z]     --- PASS: TestWaitNonBlocked/wait-nonblocking-exit-0 (0.80s)
12:41:56 [2019-10-21T12:41:56.084Z] === RUN   TestWaitBlocked
12:41:56 [2019-10-21T12:41:56.084Z] === RUN   TestWaitBlocked/test-wait-blocked-exit-zero
12:41:56 [2019-10-21T12:41:56.084Z] === PAUSE TestWaitBlocked/test-wait-blocked-exit-zero
12:41:56 [2019-10-21T12:41:56.084Z] === RUN   TestWaitBlocked/test-wait-blocked-exit-random
12:41:56 [2019-10-21T12:41:56.084Z] === PAUSE TestWaitBlocked/test-wait-blocked-exit-random
12:41:56 [2019-10-21T12:41:56.084Z] === CONT  TestWaitBlocked/test-wait-blocked-exit-zero
12:41:56 [2019-10-21T12:41:56.084Z] === CONT  TestWaitBlocked/test-wait-blocked-exit-random
12:41:57 [2019-10-21T12:41:57.111Z] --- PASS: TestWaitBlocked (0.03s)
12:41:57 [2019-10-21T12:41:57.111Z]     --- PASS: TestWaitBlocked/test-wait-blocked-exit-zero (0.97s)
12:41:57 [2019-10-21T12:41:57.111Z]     --- PASS: TestWaitBlocked/test-wait-blocked-exit-random (1.01s)
12:41:57 [2019-10-21T12:41:57.111Z] === CONT  TestContainerStartOnDaemonRestart
12:41:57 [2019-10-21T12:41:57.111Z] === CONT  TestIpcModeOlderClient
12:41:57 [2019-10-21T12:41:57.111Z] === CONT  TestDaemonRestartIpcMode
12:41:57 [2019-10-21T12:41:57.411Z] --- PASS: TestIpcModeOlderClient (0.13s)
12:42:00 [2019-10-21T12:42:00.882Z] --- PASS: TestContainerStartOnDaemonRestart (3.09s)
12:42:00 [2019-10-21T12:42:00.882Z]     daemon_linux_test.go:35: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestContainerStartOnDaemonRestart"
12:42:00 [2019-10-21T12:42:00.882Z] --- PASS: TestDaemonRestartIpcMode (3.67s)
12:42:00 [2019-10-21T12:42:00.882Z]     daemon_linux_test.go:89: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartIpcMode"
12:42:00 [2019-10-21T12:42:00.882Z] PASS
12:42:00 [2019-10-21T12:42:00.882Z] 
12:42:00 [2019-10-21T12:42:00.882Z] === Skipped
12:42:00 [2019-10-21T12:42:00.882Z] === SKIP: ppc64le.integration.container TestCheckpoint (0.00s)
12:42:00 [2019-10-21T12:42:00.882Z]     checkpoint_test.go:33: TestCheckpoint is broken; see https://github.com/moby/moby/issues/38963
12:42:00 [2019-10-21T12:42:00.882Z] 
12:42:00 [2019-10-21T12:42:00.882Z] === SKIP: ppc64le.integration.container TestPauseFailsOnWindowsServerContainers (0.00s)
12:42:00 [2019-10-21T12:42:00.882Z]     pause_test.go:54: testEnv.DaemonInfo.OSType != "windows" || testEnv.DaemonInfo.Isolation != "process"
12:42:00 [2019-10-21T12:42:00.882Z] 
12:42:00 [2019-10-21T12:42:00.882Z] === SKIP: ppc64le.integration.container TestDeleteDevicemapper (0.00s)
12:42:00 [2019-10-21T12:42:00.882Z]     stop_linux_test.go:74: testEnv.DaemonInfo.Driver != "devicemapper"
12:42:00 [2019-10-21T12:42:00.882Z] 
12:42:00 [2019-10-21T12:42:00.882Z] 
12:42:00 [2019-10-21T12:42:00.882Z] DONE 197 tests, 3 skipped in 119.020s
12:42:00 [2019-10-21T12:42:00.882Z] Running /go/src/github.com/docker/docker/integration/image (ppc64le.integration.image) flags=-test.v -test.timeout=120m 
12:42:00 [2019-10-21T12:42:00.882Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-image-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-image-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.image -t ./test.main -test.v -test.timeout=120m
12:42:00 [2019-10-21T12:42:00.882Z] ++ set -e
12:42:00 [2019-10-21T12:42:00.882Z] ++ '[' -n 0 ']'
12:42:00 [2019-10-21T12:42:00.882Z] ++ set -x
12:42:00 [2019-10-21T12:42:00.882Z] ++ 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=ppc64le 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/ppc64le-integration-image-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-image-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.image -t ./test.main -test.v -test.timeout=120m
12:42:01 [2019-10-21T12:42:01.168Z] INFO: Testing against a local daemon
12:42:01 [2019-10-21T12:42:01.168Z] === RUN   TestCommitInheritsEnv
12:42:01 [2019-10-21T12:42:01.453Z] --- PASS: TestCommitInheritsEnv (0.42s)
12:42:01 [2019-10-21T12:42:01.453Z] === RUN   TestImportExtremelyLargeImageWorks
12:42:01 [2019-10-21T12:42:01.453Z] === PAUSE TestImportExtremelyLargeImageWorks
12:42:01 [2019-10-21T12:42:01.453Z] === RUN   TestImagesFilterMultiReference
12:42:01 [2019-10-21T12:42:01.453Z] --- PASS: TestImagesFilterMultiReference (0.08s)
12:42:01 [2019-10-21T12:42:01.453Z] === RUN   TestImagePullPlatformInvalid
12:42:01 [2019-10-21T12:42:01.453Z] --- PASS: TestImagePullPlatformInvalid (0.05s)
12:42:01 [2019-10-21T12:42:01.453Z] === RUN   TestRemoveImageOrphaning
12:42:02 [2019-10-21T12:42:02.070Z] --- PASS: TestRemoveImageOrphaning (0.40s)
12:42:02 [2019-10-21T12:42:02.070Z] === RUN   TestRemoveImageGarbageCollector
12:42:02 [2019-10-21T12:42:02.070Z] --- SKIP: TestRemoveImageGarbageCollector (0.00s)
12:42:02 [2019-10-21T12:42:02.070Z]     remove_unix_test.go:36: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
12:42:02 [2019-10-21T12:42:02.070Z] === RUN   TestTagUnprefixedRepoByNameOrName
12:42:02 [2019-10-21T12:42:02.070Z] --- PASS: TestTagUnprefixedRepoByNameOrName (0.04s)
12:42:02 [2019-10-21T12:42:02.070Z] === RUN   TestTagInvalidReference
12:42:02 [2019-10-21T12:42:02.070Z] --- PASS: TestTagInvalidReference (0.03s)
12:42:02 [2019-10-21T12:42:02.070Z] === RUN   TestTagValidPrefixedRepo
12:42:02 [2019-10-21T12:42:02.070Z] --- PASS: TestTagValidPrefixedRepo (0.07s)
12:42:02 [2019-10-21T12:42:02.070Z] === RUN   TestTagExistedNameWithoutForce
12:42:02 [2019-10-21T12:42:02.070Z] --- PASS: TestTagExistedNameWithoutForce (0.04s)
12:42:02 [2019-10-21T12:42:02.070Z] === RUN   TestTagOfficialNames
12:42:02 [2019-10-21T12:42:02.353Z] --- PASS: TestTagOfficialNames (0.06s)
12:42:02 [2019-10-21T12:42:02.353Z] === RUN   TestTagMatchesDigest
12:42:02 [2019-10-21T12:42:02.353Z] --- PASS: TestTagMatchesDigest (0.03s)
12:42:02 [2019-10-21T12:42:02.353Z] === CONT  TestImportExtremelyLargeImageWorks
12:47:09 [2019-10-21T12:47:09.879Z] --- PASS: TestImportExtremelyLargeImageWorks (299.98s)
12:47:09 [2019-10-21T12:47:09.879Z]     import_test.go:26: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestImportExtremelyLargeImageWorks"
12:47:09 [2019-10-21T12:47:09.879Z] PASS
12:47:09 [2019-10-21T12:47:09.879Z] 
12:47:09 [2019-10-21T12:47:09.879Z] === Skipped
12:47:09 [2019-10-21T12:47:09.879Z] === SKIP: ppc64le.integration.image TestRemoveImageGarbageCollector (0.00s)
12:47:09 [2019-10-21T12:47:09.879Z]     remove_unix_test.go:36: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
12:47:09 [2019-10-21T12:47:09.879Z] 
12:47:09 [2019-10-21T12:47:09.879Z] 
12:47:09 [2019-10-21T12:47:09.879Z] DONE 12 tests, 1 skipped in 301.317s
12:47:09 [2019-10-21T12:47:09.879Z] Running /go/src/github.com/docker/docker/integration/network (ppc64le.integration.network) flags=-test.v -test.timeout=120m 
12:47:09 [2019-10-21T12:47:09.879Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-network-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-network-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.network -t ./test.main -test.v -test.timeout=120m
12:47:09 [2019-10-21T12:47:09.879Z] ++ set -e
12:47:09 [2019-10-21T12:47:09.879Z] ++ '[' -n 0 ']'
12:47:09 [2019-10-21T12:47:09.879Z] ++ set -x
12:47:09 [2019-10-21T12:47:09.879Z] ++ 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=ppc64le 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/ppc64le-integration-network-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-network-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.network -t ./test.main -test.v -test.timeout=120m
12:47:09 [2019-10-21T12:47:09.879Z] INFO: Testing against a local daemon
12:47:09 [2019-10-21T12:47:09.879Z] === RUN   TestNetworkCreateDelete
12:47:09 [2019-10-21T12:47:09.879Z] --- PASS: TestNetworkCreateDelete (0.20s)
12:47:09 [2019-10-21T12:47:09.879Z] === RUN   TestDockerNetworkDeletePreferID
12:47:09 [2019-10-21T12:47:09.879Z] --- PASS: TestDockerNetworkDeletePreferID (0.55s)
12:47:09 [2019-10-21T12:47:09.879Z] === RUN   TestInspectNetwork
12:47:09 [2019-10-21T12:47:09.879Z] === RUN   TestInspectNetwork/full_network_id
12:47:09 [2019-10-21T12:47:09.879Z] === RUN   TestInspectNetwork/partial_network_id
12:47:09 [2019-10-21T12:47:09.879Z] === RUN   TestInspectNetwork/network_name
12:47:09 [2019-10-21T12:47:09.879Z] === RUN   TestInspectNetwork/network_name_and_swarm_scope
12:47:10 [2019-10-21T12:47:10.493Z] --- PASS: TestInspectNetwork (7.34s)
12:47:10 [2019-10-21T12:47:10.493Z]     inspect_test.go:18: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestInspectNetwork"
12:47:10 [2019-10-21T12:47:10.493Z]     --- PASS: TestInspectNetwork/full_network_id (0.00s)
12:47:10 [2019-10-21T12:47:10.493Z]     --- PASS: TestInspectNetwork/partial_network_id (0.00s)
12:47:10 [2019-10-21T12:47:10.493Z]     --- PASS: TestInspectNetwork/network_name (0.00s)
12:47:10 [2019-10-21T12:47:10.493Z]     --- PASS: TestInspectNetwork/network_name_and_swarm_scope (0.00s)
12:47:10 [2019-10-21T12:47:10.493Z] === RUN   TestRunContainerWithBridgeNone
12:47:13 [2019-10-21T12:47:13.172Z] --- PASS: TestRunContainerWithBridgeNone (2.57s)
12:47:13 [2019-10-21T12:47:13.172Z]     network_test.go:25: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestRunContainerWithBridgeNone"
12:47:13 [2019-10-21T12:47:13.172Z] === RUN   TestNetworkInvalidJSON
12:47:13 [2019-10-21T12:47:13.172Z] === RUN   TestNetworkInvalidJSON//networks/create
12:47:13 [2019-10-21T12:47:13.172Z] === PAUSE TestNetworkInvalidJSON//networks/create
12:47:13 [2019-10-21T12:47:13.172Z] === RUN   TestNetworkInvalidJSON//networks/bridge/connect
12:47:13 [2019-10-21T12:47:13.172Z] === PAUSE TestNetworkInvalidJSON//networks/bridge/connect
12:47:13 [2019-10-21T12:47:13.172Z] === RUN   TestNetworkInvalidJSON//networks/bridge/disconnect
12:47:13 [2019-10-21T12:47:13.172Z] === PAUSE TestNetworkInvalidJSON//networks/bridge/disconnect
12:47:13 [2019-10-21T12:47:13.172Z] === CONT  TestNetworkInvalidJSON//networks/create
12:47:13 [2019-10-21T12:47:13.172Z] === CONT  TestNetworkInvalidJSON//networks/bridge/connect
12:47:13 [2019-10-21T12:47:13.172Z] === CONT  TestNetworkInvalidJSON//networks/bridge/disconnect
12:47:13 [2019-10-21T12:47:13.172Z] --- PASS: TestNetworkInvalidJSON (0.04s)
12:47:13 [2019-10-21T12:47:13.172Z]     --- PASS: TestNetworkInvalidJSON//networks/create (0.00s)
12:47:13 [2019-10-21T12:47:13.172Z]     --- PASS: TestNetworkInvalidJSON//networks/bridge/disconnect (0.00s)
12:47:13 [2019-10-21T12:47:13.172Z]     --- PASS: TestNetworkInvalidJSON//networks/bridge/connect (0.00s)
12:47:13 [2019-10-21T12:47:13.172Z] === RUN   TestDaemonRestartWithLiveRestore
12:47:14 [2019-10-21T12:47:14.186Z] --- PASS: TestDaemonRestartWithLiveRestore (1.06s)
12:47:14 [2019-10-21T12:47:14.187Z]     service_test.go:32: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartWithLiveRestore"
12:47:14 [2019-10-21T12:47:14.187Z] === RUN   TestDaemonDefaultNetworkPools
12:47:14 [2019-10-21T12:47:14.804Z] --- PASS: TestDaemonDefaultNetworkPools (0.78s)
12:47:14 [2019-10-21T12:47:14.805Z]     service_test.go:57: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonDefaultNetworkPools"
12:47:14 [2019-10-21T12:47:14.805Z] === RUN   TestDaemonRestartWithExistingNetwork
12:47:16 [2019-10-21T12:47:16.306Z] --- PASS: TestDaemonRestartWithExistingNetwork (1.18s)
12:47:16 [2019-10-21T12:47:16.306Z]     service_test.go:98: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartWithExistingNetwork"
12:47:16 [2019-10-21T12:47:16.306Z] === RUN   TestDaemonRestartWithExistingNetworkWithDefaultPoolRange
12:47:17 [2019-10-21T12:47:17.330Z] --- PASS: TestDaemonRestartWithExistingNetworkWithDefaultPoolRange (1.38s)
12:47:17 [2019-10-21T12:47:17.330Z]     service_test.go:131: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartWithExistingNetworkWithDefaultPoolRange"
12:47:17 [2019-10-21T12:47:17.330Z] === RUN   TestDaemonWithBipAndDefaultNetworkPool
12:47:17 [2019-10-21T12:47:17.948Z] --- PASS: TestDaemonWithBipAndDefaultNetworkPool (0.58s)
12:47:17 [2019-10-21T12:47:17.948Z]     service_test.go:181: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonWithBipAndDefaultNetworkPool"
12:47:17 [2019-10-21T12:47:17.948Z] === RUN   TestServiceWithPredefinedNetwork
12:47:20 [2019-10-21T12:47:20.631Z] --- PASS: TestServiceWithPredefinedNetwork (2.27s)
12:47:20 [2019-10-21T12:47:20.631Z]     service_test.go:203: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithPredefinedNetwork"
12:47:20 [2019-10-21T12:47:20.631Z] === RUN   TestServiceRemoveKeepsIngressNetwork
12:47:20 [2019-10-21T12:47:20.631Z] --- SKIP: TestServiceRemoveKeepsIngressNetwork (0.00s)
12:47:20 [2019-10-21T12:47:20.631Z]     service_test.go:230: FLAKY_TEST
12:47:20 [2019-10-21T12:47:20.631Z] === RUN   TestServiceWithDataPathPortInit
12:47:35 [2019-10-21T12:47:35.871Z] --- PASS: TestServiceWithDataPathPortInit (14.43s)
12:47:35 [2019-10-21T12:47:35.871Z]     service_test.go:323: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithDataPathPortInit"
12:47:35 [2019-10-21T12:47:35.871Z]     service_test.go:355: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithDataPathPortInit"
12:47:35 [2019-10-21T12:47:35.871Z] === RUN   TestServiceWithDefaultAddressPoolInit
12:47:42 [2019-10-21T12:47:42.681Z] --- PASS: TestServiceWithDefaultAddressPoolInit (7.16s)
12:47:42 [2019-10-21T12:47:42.681Z]     service_test.go:388: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithDefaultAddressPoolInit"
12:47:42 [2019-10-21T12:47:42.681Z]     service_test.go:418: TestServiceWithDefaultAddressPoolInit: NetworkInspect: {Name:sthiraTestServiceWithDefaultAddressPoolInit ID:rvxbl2ug6ejergdy30ioc208a Created:2019-10-21 12:47:35.855299734 +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[7354407aa5456dc2f3093e3c35a3adbaaff3836591ede4f5606adc740861e571:{Name:TestServiceTestServiceWithDefaultAddressPoolInit.1.brp8ef4tfyyne5qwv12r2itqd EndpointID:4d4792e69ab253cbeefd09306f69108a27a58d4af7d7a7e46e7ab8a0d7574ce9 MacAddress:02:42:14:14:00:03 IPv4Address:20.20.0.3/24 IPv6Address:} lb-sthiraTestServiceWithDefaultAddressPoolInit:{Name:sthiraTestServiceWithDefaultAddressPoolInit-endpoint EndpointID:e223f8525c0ac6d4866bf56a202715b8873c026a0b19bb0d3376dd142f5d7e4d 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:a7dd704e6c6c IP:127.0.0.1}] Services:map[TestServiceTestServiceWithDefaultAddressPoolInit:{VIP:20.20.0.2 Ports:[] LocalLBIndex:256 Tasks:[{Name:TestServiceTestServiceWithDefaultAddressPoolInit.1.brp8ef4tfyyne5qwv12r2itqd EndpointID:4d4792e69ab253cbeefd09306f69108a27a58d4af7d7a7e46e7ab8a0d7574ce9 EndpointIP:20.20.0.3 Info:map[Host IP:127.0.0.1]}]}]}
12:47:42 [2019-10-21T12:47:42.681Z] PASS
12:47:42 [2019-10-21T12:47:42.681Z] 
12:47:42 [2019-10-21T12:47:42.681Z] === Skipped
12:47:42 [2019-10-21T12:47:42.681Z] === SKIP: ppc64le.integration.network TestServiceRemoveKeepsIngressNetwork (0.00s)
12:47:42 [2019-10-21T12:47:42.681Z]     service_test.go:230: FLAKY_TEST
12:47:42 [2019-10-21T12:47:42.681Z] 
12:47:42 [2019-10-21T12:47:42.681Z] 
12:47:42 [2019-10-21T12:47:42.681Z] DONE 21 tests, 1 skipped in 39.640s
12:47:42 [2019-10-21T12:47:42.681Z] Running /go/src/github.com/docker/docker/integration/network/ipvlan (ppc64le.integration.network.ipvlan) flags=-test.v -test.timeout=120m 
12:47:42 [2019-10-21T12:47:42.681Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-network-ipvlan-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-network-ipvlan-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.network.ipvlan -t ./test.main -test.v -test.timeout=120m
12:47:42 [2019-10-21T12:47:42.681Z] ++ set -e
12:47:42 [2019-10-21T12:47:42.681Z] ++ '[' -n 0 ']'
12:47:42 [2019-10-21T12:47:42.681Z] ++ set -x
12:47:42 [2019-10-21T12:47:42.681Z] ++ 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=ppc64le 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/ppc64le-integration-network-ipvlan-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-network-ipvlan-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.network.ipvlan -t ./test.main -test.v -test.timeout=120m
12:47:42 [2019-10-21T12:47:42.681Z] INFO: Testing against a local daemon
12:47:42 [2019-10-21T12:47:42.681Z] === RUN   TestDockerNetworkIpvlanPersistance
12:47:43 [2019-10-21T12:47:43.702Z] --- PASS: TestDockerNetworkIpvlanPersistance (1.47s)
12:47:43 [2019-10-21T12:47:43.702Z]     ipvlan_test.go:28: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkIpvlanPersistance"
12:47:43 [2019-10-21T12:47:43.702Z] === RUN   TestDockerNetworkIpvlan
12:47:44 [2019-10-21T12:47:44.321Z] === RUN   TestDockerNetworkIpvlan/Subinterface
12:47:45 [2019-10-21T12:47:45.332Z] === RUN   TestDockerNetworkIpvlan/OverlapParent
12:47:46 [2019-10-21T12:47:46.342Z] === RUN   TestDockerNetworkIpvlan/L2NilParent
12:47:49 [2019-10-21T12:47:49.048Z] === RUN   TestDockerNetworkIpvlan/L2InternalMode
12:47:52 [2019-10-21T12:47:52.506Z] === RUN   TestDockerNetworkIpvlan/L3NilParent
12:47:54 [2019-10-21T12:47:54.540Z] === RUN   TestDockerNetworkIpvlan/L3InternalMode
12:47:58 [2019-10-21T12:47:58.003Z] === RUN   TestDockerNetworkIpvlan/L2MultiSubnet
12:48:03 [2019-10-21T12:48:03.513Z] === RUN   TestDockerNetworkIpvlan/L3MultiSubnet
12:48:07 [2019-10-21T12:48:07.928Z] === RUN   TestDockerNetworkIpvlan/Addressing
12:48:09 [2019-10-21T12:48:09.968Z] --- PASS: TestDockerNetworkIpvlan (26.19s)
12:48:09 [2019-10-21T12:48:09.968Z]     ipvlan_test.go:88: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkIpvlan"
12:48:09 [2019-10-21T12:48:09.968Z]     --- PASS: TestDockerNetworkIpvlan/Subinterface (0.08s)
12:48:09 [2019-10-21T12:48:09.968Z]     ipvlan_test.go:88: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkIpvlan"
12:48:09 [2019-10-21T12:48:09.968Z]     --- PASS: TestDockerNetworkIpvlan/OverlapParent (0.06s)
12:48:09 [2019-10-21T12:48:09.968Z]     ipvlan_test.go:88: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkIpvlan"
12:48:09 [2019-10-21T12:48:09.968Z]     --- PASS: TestDockerNetworkIpvlan/L2NilParent (1.19s)
12:48:09 [2019-10-21T12:48:09.968Z]     ipvlan_test.go:88: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkIpvlan"
12:48:09 [2019-10-21T12:48:09.968Z]     --- PASS: TestDockerNetworkIpvlan/L2InternalMode (2.12s)
12:48:09 [2019-10-21T12:48:09.968Z]     ipvlan_test.go:88: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkIpvlan"
12:48:09 [2019-10-21T12:48:09.968Z]     --- PASS: TestDockerNetworkIpvlan/L3NilParent (1.11s)
12:48:09 [2019-10-21T12:48:09.968Z]     ipvlan_test.go:88: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkIpvlan"
12:48:09 [2019-10-21T12:48:09.968Z]     --- PASS: TestDockerNetworkIpvlan/L3InternalMode (2.15s)
12:48:09 [2019-10-21T12:48:09.968Z]     ipvlan_test.go:88: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkIpvlan"
12:48:09 [2019-10-21T12:48:09.968Z]     --- PASS: TestDockerNetworkIpvlan/L2MultiSubnet (3.19s)
12:48:09 [2019-10-21T12:48:09.968Z]     ipvlan_test.go:88: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkIpvlan"
12:48:09 [2019-10-21T12:48:09.968Z]     --- PASS: TestDockerNetworkIpvlan/L3MultiSubnet (3.12s)
12:48:09 [2019-10-21T12:48:09.968Z]     ipvlan_test.go:88: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkIpvlan"
12:48:09 [2019-10-21T12:48:09.968Z]     --- PASS: TestDockerNetworkIpvlan/Addressing (2.08s)
12:48:09 [2019-10-21T12:48:09.968Z] PASS
12:48:09 [2019-10-21T12:48:09.968Z] 
12:48:09 [2019-10-21T12:48:09.968Z] DONE 11 tests in 27.763s
12:48:09 [2019-10-21T12:48:09.968Z] Running /go/src/github.com/docker/docker/integration/network/macvlan (ppc64le.integration.network.macvlan) flags=-test.v -test.timeout=120m 
12:48:09 [2019-10-21T12:48:09.968Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-network-macvlan-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-network-macvlan-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.network.macvlan -t ./test.main -test.v -test.timeout=120m
12:48:09 [2019-10-21T12:48:09.968Z] ++ set -e
12:48:09 [2019-10-21T12:48:09.968Z] ++ '[' -n 0 ']'
12:48:09 [2019-10-21T12:48:09.968Z] ++ set -x
12:48:09 [2019-10-21T12:48:09.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=ppc64le 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/ppc64le-integration-network-macvlan-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-network-macvlan-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.network.macvlan -t ./test.main -test.v -test.timeout=120m
12:48:09 [2019-10-21T12:48:09.968Z] INFO: Testing against a local daemon
12:48:09 [2019-10-21T12:48:09.968Z] === RUN   TestDockerNetworkMacvlanPersistance
12:48:11 [2019-10-21T12:48:11.445Z] --- PASS: TestDockerNetworkMacvlanPersistance (1.47s)
12:48:11 [2019-10-21T12:48:11.445Z]     macvlan_test.go:24: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlanPersistance"
12:48:11 [2019-10-21T12:48:11.445Z] === RUN   TestDockerNetworkMacvlan
12:48:12 [2019-10-21T12:48:12.064Z] === RUN   TestDockerNetworkMacvlan/Subinterface
12:48:13 [2019-10-21T12:48:13.075Z] === RUN   TestDockerNetworkMacvlan/OverlapParent
12:48:14 [2019-10-21T12:48:14.086Z] === RUN   TestDockerNetworkMacvlan/NilParent
12:48:16 [2019-10-21T12:48:16.776Z] === RUN   TestDockerNetworkMacvlan/InternalMode
12:48:20 [2019-10-21T12:48:20.230Z] === RUN   TestDockerNetworkMacvlan/MultiSubnet
12:48:25 [2019-10-21T12:48:25.731Z] === RUN   TestDockerNetworkMacvlan/Addressing
12:48:26 [2019-10-21T12:48:26.015Z] --- PASS: TestDockerNetworkMacvlan (14.84s)
12:48:26 [2019-10-21T12:48:26.015Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
12:48:26 [2019-10-21T12:48:26.015Z]     --- PASS: TestDockerNetworkMacvlan/Subinterface (0.07s)
12:48:26 [2019-10-21T12:48:26.015Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
12:48:26 [2019-10-21T12:48:26.015Z]     --- PASS: TestDockerNetworkMacvlan/OverlapParent (0.10s)
12:48:26 [2019-10-21T12:48:26.015Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
12:48:26 [2019-10-21T12:48:26.015Z]     --- PASS: TestDockerNetworkMacvlan/NilParent (1.20s)
12:48:26 [2019-10-21T12:48:26.015Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
12:48:26 [2019-10-21T12:48:26.015Z]     --- PASS: TestDockerNetworkMacvlan/InternalMode (2.16s)
12:48:26 [2019-10-21T12:48:26.015Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
12:48:26 [2019-10-21T12:48:26.015Z]     --- PASS: TestDockerNetworkMacvlan/MultiSubnet (3.19s)
12:48:26 [2019-10-21T12:48:26.015Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
12:48:26 [2019-10-21T12:48:26.015Z]     --- PASS: TestDockerNetworkMacvlan/Addressing (0.93s)
12:48:26 [2019-10-21T12:48:26.015Z] PASS
12:48:26 [2019-10-21T12:48:26.015Z] 
12:48:26 [2019-10-21T12:48:26.015Z] DONE 8 tests in 16.407s
12:48:26 [2019-10-21T12:48:26.015Z] Running /go/src/github.com/docker/docker/integration/plugin (ppc64le.integration.plugin) flags=-test.v -test.timeout=120m 
12:48:26 [2019-10-21T12:48:26.015Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-plugin-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-plugin-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.plugin -t ./test.main -test.v -test.timeout=120m
12:48:26 [2019-10-21T12:48:26.015Z] ++ set -e
12:48:26 [2019-10-21T12:48:26.015Z] ++ '[' -n 0 ']'
12:48:26 [2019-10-21T12:48:26.015Z] ++ set -x
12:48:26 [2019-10-21T12:48:26.015Z] ++ 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=ppc64le 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/ppc64le-integration-plugin-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-plugin-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.plugin -t ./test.main -test.v -test.timeout=120m
12:48:26 [2019-10-21T12:48:26.015Z] testing: warning: no tests to run
12:48:26 [2019-10-21T12:48:26.015Z] PASS
12:48:26 [2019-10-21T12:48:26.015Z] 
12:48:26 [2019-10-21T12:48:26.015Z] DONE 0 tests in 0.014s
12:48:26 [2019-10-21T12:48:26.302Z] Running /go/src/github.com/docker/docker/integration/plugin/authz (ppc64le.integration.plugin.authz) flags=-test.v -test.timeout=120m 
12:48:26 [2019-10-21T12:48:26.302Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-plugin-authz-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-plugin-authz-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.plugin.authz -t ./test.main -test.v -test.timeout=120m
12:48:26 [2019-10-21T12:48:26.302Z] ++ set -e
12:48:26 [2019-10-21T12:48:26.302Z] ++ '[' -n 0 ']'
12:48:26 [2019-10-21T12:48:26.302Z] ++ set -x
12:48:26 [2019-10-21T12:48:26.302Z] ++ 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=ppc64le 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/ppc64le-integration-plugin-authz-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-plugin-authz-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.plugin.authz -t ./test.main -test.v -test.timeout=120m
12:48:26 [2019-10-21T12:48:26.302Z] INFO: Testing against a local daemon
12:48:26 [2019-10-21T12:48:26.302Z] === RUN   TestAuthZPluginAllowRequest
12:48:27 [2019-10-21T12:48:27.776Z] --- PASS: TestAuthZPluginAllowRequest (1.59s)
12:48:27 [2019-10-21T12:48:27.776Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginAllowRequest"
12:48:27 [2019-10-21T12:48:27.776Z] === RUN   TestAuthZPluginTLS
12:48:28 [2019-10-21T12:48:28.391Z] --- PASS: TestAuthZPluginTLS (0.58s)
12:48:28 [2019-10-21T12:48:28.391Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginTLS"
12:48:28 [2019-10-21T12:48:28.391Z] === RUN   TestAuthZPluginDenyRequest
12:48:29 [2019-10-21T12:48:29.012Z] --- PASS: TestAuthZPluginDenyRequest (0.56s)
12:48:29 [2019-10-21T12:48:29.012Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginDenyRequest"
12:48:29 [2019-10-21T12:48:29.012Z] === RUN   TestAuthZPluginAPIDenyResponse
12:48:29 [2019-10-21T12:48:29.627Z] --- PASS: TestAuthZPluginAPIDenyResponse (0.57s)
12:48:29 [2019-10-21T12:48:29.627Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginAPIDenyResponse"
12:48:29 [2019-10-21T12:48:29.627Z] === RUN   TestAuthZPluginDenyResponse
12:48:30 [2019-10-21T12:48:30.243Z] --- PASS: TestAuthZPluginDenyResponse (0.57s)
12:48:30 [2019-10-21T12:48:30.243Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginDenyResponse"
12:48:30 [2019-10-21T12:48:30.243Z] === RUN   TestAuthZPluginAllowEventStream
12:48:31 [2019-10-21T12:48:31.724Z] --- PASS: TestAuthZPluginAllowEventStream (1.62s)
12:48:31 [2019-10-21T12:48:31.724Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginAllowEventStream"
12:48:31 [2019-10-21T12:48:31.724Z] === RUN   TestAuthZPluginErrorResponse
12:48:32 [2019-10-21T12:48:32.341Z] --- PASS: TestAuthZPluginErrorResponse (0.57s)
12:48:32 [2019-10-21T12:48:32.341Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginErrorResponse"
12:48:32 [2019-10-21T12:48:32.341Z] === RUN   TestAuthZPluginErrorRequest
12:48:32 [2019-10-21T12:48:32.957Z] --- PASS: TestAuthZPluginErrorRequest (0.56s)
12:48:32 [2019-10-21T12:48:32.957Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginErrorRequest"
12:48:32 [2019-10-21T12:48:32.957Z] === RUN   TestAuthZPluginEnsureNoDuplicatePluginRegistration
12:48:33 [2019-10-21T12:48:33.572Z] --- PASS: TestAuthZPluginEnsureNoDuplicatePluginRegistration (0.58s)
12:48:33 [2019-10-21T12:48:33.572Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginEnsureNoDuplicatePluginRegistration"
12:48:33 [2019-10-21T12:48:33.572Z] === RUN   TestAuthZPluginEnsureLoadImportWorking
12:48:35 [2019-10-21T12:48:35.599Z] --- PASS: TestAuthZPluginEnsureLoadImportWorking (2.12s)
12:48:35 [2019-10-21T12:48:35.599Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginEnsureLoadImportWorking"
12:48:35 [2019-10-21T12:48:35.599Z] === RUN   TestAuthzPluginEnsureContainerCopyToFrom
12:48:37 [2019-10-21T12:48:37.631Z] --- PASS: TestAuthzPluginEnsureContainerCopyToFrom (2.12s)
12:48:37 [2019-10-21T12:48:37.631Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthzPluginEnsureContainerCopyToFrom"
12:48:37 [2019-10-21T12:48:37.631Z] === RUN   TestAuthZPluginHeader
12:48:38 [2019-10-21T12:48:38.642Z] --- PASS: TestAuthZPluginHeader (0.94s)
12:48:38 [2019-10-21T12:48:38.642Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginHeader"
12:48:38 [2019-10-21T12:48:38.642Z] === RUN   TestAuthZPluginV2AllowNonVolumeRequest
12:48:38 [2019-10-21T12:48:38.642Z] --- SKIP: TestAuthZPluginV2AllowNonVolumeRequest (0.00s)
12:48:38 [2019-10-21T12:48:38.642Z]     authz_plugin_v2_test.go:43: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
12:48:38 [2019-10-21T12:48:38.642Z] === RUN   TestAuthZPluginV2Disable
12:48:38 [2019-10-21T12:48:38.642Z] --- SKIP: TestAuthZPluginV2Disable (0.00s)
12:48:38 [2019-10-21T12:48:38.642Z]     authz_plugin_v2_test.go:65: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
12:48:38 [2019-10-21T12:48:38.642Z] === RUN   TestAuthZPluginV2RejectVolumeRequests
12:48:38 [2019-10-21T12:48:38.642Z] --- SKIP: TestAuthZPluginV2RejectVolumeRequests (0.00s)
12:48:38 [2019-10-21T12:48:38.642Z]     authz_plugin_v2_test.go:91: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
12:48:38 [2019-10-21T12:48:38.642Z] === RUN   TestAuthZPluginV2BadManifestFailsDaemonStart
12:48:38 [2019-10-21T12:48:38.642Z] --- SKIP: TestAuthZPluginV2BadManifestFailsDaemonStart (0.00s)
12:48:38 [2019-10-21T12:48:38.642Z]     authz_plugin_v2_test.go:126: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
12:48:38 [2019-10-21T12:48:38.642Z] === RUN   TestAuthZPluginV2NonexistentFailsDaemonStart
12:48:57 [2019-10-21T12:48:57.108Z] --- PASS: TestAuthZPluginV2NonexistentFailsDaemonStart (16.87s)
12:48:57 [2019-10-21T12:48:57.108Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginV2NonexistentFailsDaemonStart"
12:48:57 [2019-10-21T12:48:57.108Z] PASS
12:48:57 [2019-10-21T12:48:57.108Z] 
12:48:57 [2019-10-21T12:48:57.108Z] === Skipped
12:48:57 [2019-10-21T12:48:57.108Z] === SKIP: ppc64le.integration.plugin.authz TestAuthZPluginV2AllowNonVolumeRequest (0.00s)
12:48:57 [2019-10-21T12:48:57.108Z]     authz_plugin_v2_test.go:43: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
12:48:57 [2019-10-21T12:48:57.108Z] 
12:48:57 [2019-10-21T12:48:57.108Z] === SKIP: ppc64le.integration.plugin.authz TestAuthZPluginV2Disable (0.00s)
12:48:57 [2019-10-21T12:48:57.108Z]     authz_plugin_v2_test.go:65: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
12:48:57 [2019-10-21T12:48:57.108Z] 
12:48:57 [2019-10-21T12:48:57.108Z] === SKIP: ppc64le.integration.plugin.authz TestAuthZPluginV2RejectVolumeRequests (0.00s)
12:48:57 [2019-10-21T12:48:57.108Z]     authz_plugin_v2_test.go:91: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
12:48:57 [2019-10-21T12:48:57.108Z] 
12:48:57 [2019-10-21T12:48:57.108Z] === SKIP: ppc64le.integration.plugin.authz TestAuthZPluginV2BadManifestFailsDaemonStart (0.00s)
12:48:57 [2019-10-21T12:48:57.108Z]     authz_plugin_v2_test.go:126: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
12:48:57 [2019-10-21T12:48:57.108Z] 
12:48:57 [2019-10-21T12:48:57.108Z] 
12:48:57 [2019-10-21T12:48:57.108Z] DONE 17 tests, 4 skipped in 29.353s
12:48:57 [2019-10-21T12:48:57.108Z] Running /go/src/github.com/docker/docker/integration/plugin/common (ppc64le.integration.plugin.common) flags=-test.v -test.timeout=120m 
12:48:57 [2019-10-21T12:48:57.108Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-plugin-common-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-plugin-common-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.plugin.common -t ./test.main -test.v -test.timeout=120m
12:48:57 [2019-10-21T12:48:57.108Z] ++ set -e
12:48:57 [2019-10-21T12:48:57.108Z] ++ '[' -n 0 ']'
12:48:57 [2019-10-21T12:48:57.108Z] ++ set -x
12:48:57 [2019-10-21T12:48:57.108Z] ++ 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=ppc64le 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/ppc64le-integration-plugin-common-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-plugin-common-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.plugin.common -t ./test.main -test.v -test.timeout=120m
12:48:57 [2019-10-21T12:48:57.108Z] INFO: Testing against a local daemon
12:48:57 [2019-10-21T12:48:57.108Z] === RUN   TestPluginInvalidJSON
12:48:57 [2019-10-21T12:48:57.108Z] === RUN   TestPluginInvalidJSON//plugins/foobar/set
12:48:57 [2019-10-21T12:48:57.108Z] === PAUSE TestPluginInvalidJSON//plugins/foobar/set
12:48:57 [2019-10-21T12:48:57.108Z] === CONT  TestPluginInvalidJSON//plugins/foobar/set
12:48:57 [2019-10-21T12:48:57.108Z] --- PASS: TestPluginInvalidJSON (0.05s)
12:48:57 [2019-10-21T12:48:57.108Z]     --- PASS: TestPluginInvalidJSON//plugins/foobar/set (0.00s)
12:48:57 [2019-10-21T12:48:57.108Z] PASS
12:48:57 [2019-10-21T12:48:57.108Z] 
12:48:57 [2019-10-21T12:48:57.108Z] DONE 2 tests in 0.134s
12:48:57 [2019-10-21T12:48:57.108Z] Running /go/src/github.com/docker/docker/integration/plugin/graphdriver (ppc64le.integration.plugin.graphdriver) flags=-test.v -test.timeout=120m 
12:48:57 [2019-10-21T12:48:57.108Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-plugin-graphdriver-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-plugin-graphdriver-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.plugin.graphdriver -t ./test.main -test.v -test.timeout=120m
12:48:57 [2019-10-21T12:48:57.108Z] ++ set -e
12:48:57 [2019-10-21T12:48:57.108Z] ++ '[' -n 0 ']'
12:48:57 [2019-10-21T12:48:57.108Z] ++ set -x
12:48:57 [2019-10-21T12:48:57.108Z] ++ 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=ppc64le 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/ppc64le-integration-plugin-graphdriver-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-plugin-graphdriver-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.plugin.graphdriver -t ./test.main -test.v -test.timeout=120m
12:48:57 [2019-10-21T12:48:57.108Z] INFO: Testing against a local daemon
12:48:57 [2019-10-21T12:48:57.108Z] === RUN   TestExternalGraphDriver
12:48:57 [2019-10-21T12:48:57.108Z] === RUN   TestExternalGraphDriver/json
12:48:58 [2019-10-21T12:48:58.124Z] === RUN   TestExternalGraphDriver/spec
12:49:00 [2019-10-21T12:49:00.155Z] === RUN   TestExternalGraphDriver/pull
12:49:02 [2019-10-21T12:49:02.190Z] --- PASS: TestExternalGraphDriver (6.53s)
12:49:02 [2019-10-21T12:49:02.190Z]     external_test.go:57: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestExternalGraphDriver"
12:49:02 [2019-10-21T12:49:02.190Z]     --- PASS: TestExternalGraphDriver/json (2.05s)
12:49:02 [2019-10-21T12:49:02.190Z]     --- PASS: TestExternalGraphDriver/spec (2.07s)
12:49:02 [2019-10-21T12:49:02.190Z]     --- PASS: TestExternalGraphDriver/pull (2.17s)
12:49:02 [2019-10-21T12:49:02.190Z] === RUN   TestGraphdriverPluginV2
12:49:02 [2019-10-21T12:49:02.476Z] --- SKIP: TestGraphdriverPluginV2 (0.07s)
12:49:02 [2019-10-21T12:49:02.476Z]     external_test.go:410: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
12:49:02 [2019-10-21T12:49:02.476Z] PASS
12:49:02 [2019-10-21T12:49:02.476Z] 
12:49:02 [2019-10-21T12:49:02.476Z] === Skipped
12:49:02 [2019-10-21T12:49:02.476Z] === SKIP: ppc64le.integration.plugin.graphdriver TestGraphdriverPluginV2 (0.07s)
12:49:02 [2019-10-21T12:49:02.476Z]     external_test.go:410: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
12:49:02 [2019-10-21T12:49:02.476Z] 
12:49:02 [2019-10-21T12:49:02.476Z] 
12:49:02 [2019-10-21T12:49:02.476Z] DONE 5 tests, 1 skipped in 6.682s
12:49:02 [2019-10-21T12:49:02.476Z] Running /go/src/github.com/docker/docker/integration/plugin/logging (ppc64le.integration.plugin.logging) flags=-test.v -test.timeout=120m 
12:49:02 [2019-10-21T12:49:02.476Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-plugin-logging-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-plugin-logging-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.plugin.logging -t ./test.main -test.v -test.timeout=120m
12:49:02 [2019-10-21T12:49:02.476Z] ++ set -e
12:49:02 [2019-10-21T12:49:02.476Z] ++ '[' -n 0 ']'
12:49:02 [2019-10-21T12:49:02.476Z] ++ set -x
12:49:02 [2019-10-21T12:49:02.476Z] ++ 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=ppc64le 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/ppc64le-integration-plugin-logging-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-plugin-logging-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.plugin.logging -t ./test.main -test.v -test.timeout=120m
12:49:02 [2019-10-21T12:49:02.476Z] INFO: Testing against a local daemon
12:49:02 [2019-10-21T12:49:02.476Z] === RUN   TestContinueAfterPluginCrash
12:49:02 [2019-10-21T12:49:02.476Z] === PAUSE TestContinueAfterPluginCrash
12:49:02 [2019-10-21T12:49:02.476Z] === RUN   TestDaemonStartWithLogOpt
12:49:02 [2019-10-21T12:49:02.476Z] === PAUSE TestDaemonStartWithLogOpt
12:49:02 [2019-10-21T12:49:02.476Z] === CONT  TestContinueAfterPluginCrash
12:49:02 [2019-10-21T12:49:02.476Z] === CONT  TestDaemonStartWithLogOpt
12:49:17 [2019-10-21T12:49:17.752Z] --- PASS: TestDaemonStartWithLogOpt (15.19s)
12:49:17 [2019-10-21T12:49:17.752Z]     validation_test.go:23: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonStartWithLogOpt"
12:49:23 [2019-10-21T12:49:23.237Z] --- PASS: TestContinueAfterPluginCrash (20.26s)
12:49:23 [2019-10-21T12:49:23.237Z]     logging_linux_test.go:22: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestContinueAfterPluginCrash"
12:49:23 [2019-10-21T12:49:23.237Z] PASS
12:49:23 [2019-10-21T12:49:23.237Z] 
12:49:23 [2019-10-21T12:49:23.237Z] DONE 2 tests in 20.374s
12:49:23 [2019-10-21T12:49:23.237Z] Running /go/src/github.com/docker/docker/integration/plugin/volumes (ppc64le.integration.plugin.volumes) flags=-test.v -test.timeout=120m 
12:49:23 [2019-10-21T12:49:23.237Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-plugin-volumes-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-plugin-volumes-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.plugin.volumes -t ./test.main -test.v -test.timeout=120m
12:49:23 [2019-10-21T12:49:23.237Z] ++ set -e
12:49:23 [2019-10-21T12:49:23.237Z] ++ '[' -n 0 ']'
12:49:23 [2019-10-21T12:49:23.237Z] ++ set -x
12:49:23 [2019-10-21T12:49:23.237Z] ++ 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=ppc64le 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/ppc64le-integration-plugin-volumes-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-plugin-volumes-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.plugin.volumes -t ./test.main -test.v -test.timeout=120m
12:49:23 [2019-10-21T12:49:23.237Z] INFO: Testing against a local daemon
12:49:23 [2019-10-21T12:49:23.237Z] === RUN   TestPluginWithDevMounts
12:49:23 [2019-10-21T12:49:23.237Z] === PAUSE TestPluginWithDevMounts
12:49:23 [2019-10-21T12:49:23.237Z] === CONT  TestPluginWithDevMounts
12:49:25 [2019-10-21T12:49:25.262Z] --- PASS: TestPluginWithDevMounts (2.28s)
12:49:25 [2019-10-21T12:49:25.262Z]     mounts_test.go:23: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestPluginWithDevMounts"
12:49:25 [2019-10-21T12:49:25.262Z] PASS
12:49:25 [2019-10-21T12:49:25.262Z] 
12:49:25 [2019-10-21T12:49:25.262Z] DONE 1 tests in 2.383s
12:49:25 [2019-10-21T12:49:25.262Z] Running /go/src/github.com/docker/docker/integration/secret (ppc64le.integration.secret) flags=-test.v -test.timeout=120m 
12:49:25 [2019-10-21T12:49:25.262Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-secret-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-secret-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.secret -t ./test.main -test.v -test.timeout=120m
12:49:25 [2019-10-21T12:49:25.262Z] ++ set -e
12:49:25 [2019-10-21T12:49:25.262Z] ++ '[' -n 0 ']'
12:49:25 [2019-10-21T12:49:25.262Z] ++ set -x
12:49:25 [2019-10-21T12:49:25.262Z] ++ 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=ppc64le 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/ppc64le-integration-secret-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-secret-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.secret -t ./test.main -test.v -test.timeout=120m
12:49:25 [2019-10-21T12:49:25.262Z] INFO: Testing against a local daemon
12:49:25 [2019-10-21T12:49:25.262Z] === RUN   TestSecretInspect
12:49:27 [2019-10-21T12:49:27.948Z] --- PASS: TestSecretInspect (2.16s)
12:49:27 [2019-10-21T12:49:27.948Z]     secret_test.go:25: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestSecretInspect"
12:49:27 [2019-10-21T12:49:27.948Z] === RUN   TestSecretList
12:49:29 [2019-10-21T12:49:29.976Z] --- PASS: TestSecretList (2.23s)
12:49:29 [2019-10-21T12:49:29.976Z]     secret_test.go:48: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestSecretList"
12:49:29 [2019-10-21T12:49:29.976Z] === RUN   TestSecretsCreateAndDelete
12:49:32 [2019-10-21T12:49:32.017Z] --- PASS: TestSecretsCreateAndDelete (2.18s)
12:49:32 [2019-10-21T12:49:32.017Z]     secret_test.go:125: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestSecretsCreateAndDelete"
12:49:32 [2019-10-21T12:49:32.017Z] === RUN   TestSecretsUpdate
12:49:34 [2019-10-21T12:49:34.045Z] --- PASS: TestSecretsUpdate (2.17s)
12:49:34 [2019-10-21T12:49:34.045Z]     secret_test.go:172: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestSecretsUpdate"
12:49:34 [2019-10-21T12:49:34.045Z] === RUN   TestTemplatedSecret
12:49:36 [2019-10-21T12:49:36.726Z] --- PASS: TestTemplatedSecret (2.84s)
12:49:36 [2019-10-21T12:49:36.726Z]     secret_test.go:221: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestTemplatedSecret"
12:49:36 [2019-10-21T12:49:36.726Z] === RUN   TestSecretCreateResolve
12:49:39 [2019-10-21T12:49:39.428Z] --- PASS: TestSecretCreateResolve (2.18s)
12:49:39 [2019-10-21T12:49:39.428Z]     secret_test.go:342: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestSecretCreateResolve"
12:49:39 [2019-10-21T12:49:39.428Z] PASS
12:49:39 [2019-10-21T12:49:39.428Z] 
12:49:39 [2019-10-21T12:49:39.428Z] DONE 6 tests in 13.840s
12:49:39 [2019-10-21T12:49:39.428Z] Running /go/src/github.com/docker/docker/integration/service (ppc64le.integration.service) flags=-test.v -test.timeout=120m 
12:49:39 [2019-10-21T12:49:39.428Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-service-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-service-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.service -t ./test.main -test.v -test.timeout=120m
12:49:39 [2019-10-21T12:49:39.428Z] ++ set -e
12:49:39 [2019-10-21T12:49:39.428Z] ++ '[' -n 0 ']'
12:49:39 [2019-10-21T12:49:39.428Z] ++ set -x
12:49:39 [2019-10-21T12:49:39.428Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=ppc64le 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/ppc64le-integration-service-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-service-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.service -t ./test.main -test.v -test.timeout=120m
12:49:39 [2019-10-21T12:49:39.428Z] INFO: Testing against a local daemon
12:49:39 [2019-10-21T12:49:39.428Z] === RUN   TestServiceCreateInit
12:49:39 [2019-10-21T12:49:39.428Z] === RUN   TestServiceCreateInit/daemonInitDisabled
12:49:43 [2019-10-21T12:49:43.858Z] === RUN   TestServiceCreateInit/daemonInitEnabled
12:49:48 [2019-10-21T12:49:48.267Z] --- PASS: TestServiceCreateInit (8.67s)
12:49:48 [2019-10-21T12:49:48.267Z]     --- PASS: TestServiceCreateInit/daemonInitDisabled (4.61s)
12:49:48 [2019-10-21T12:49:48.267Z]         create_test.go:38: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceCreateInit/daemonInitDisabled"
12:49:48 [2019-10-21T12:49:48.267Z]     --- PASS: TestServiceCreateInit/daemonInitEnabled (4.02s)
12:49:48 [2019-10-21T12:49:48.267Z]         create_test.go:38: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceCreateInit/daemonInitEnabled"
12:49:48 [2019-10-21T12:49:48.267Z] === RUN   TestCreateServiceMultipleTimes
12:50:06 [2019-10-21T12:50:06.742Z] --- PASS: TestCreateServiceMultipleTimes (17.77s)
12:50:06 [2019-10-21T12:50:06.742Z]     create_test.go:80: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceMultipleTimes"
12:50:06 [2019-10-21T12:50:06.742Z] === RUN   TestCreateServiceConflict
12:50:07 [2019-10-21T12:50:07.754Z] --- PASS: TestCreateServiceConflict (2.18s)
12:50:07 [2019-10-21T12:50:07.754Z]     create_test.go:129: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceConflict"
12:50:07 [2019-10-21T12:50:07.754Z] === RUN   TestCreateServiceMaxReplicas
12:50:11 [2019-10-21T12:50:11.265Z] --- PASS: TestCreateServiceMaxReplicas (3.00s)
12:50:11 [2019-10-21T12:50:11.265Z]     create_test.go:150: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceMaxReplicas"
12:50:11 [2019-10-21T12:50:11.265Z] === RUN   TestCreateWithDuplicateNetworkNames
12:50:23 [2019-10-21T12:50:23.828Z] --- PASS: TestCreateWithDuplicateNetworkNames (13.12s)
12:50:23 [2019-10-21T12:50:23.828Z]     create_test.go:171: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateWithDuplicateNetworkNames"
12:50:23 [2019-10-21T12:50:23.828Z] === RUN   TestCreateServiceSecretFileMode
12:50:26 [2019-10-21T12:50:26.511Z] --- PASS: TestCreateServiceSecretFileMode (2.44s)
12:50:26 [2019-10-21T12:50:26.511Z]     create_test.go:224: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceSecretFileMode"
12:50:26 [2019-10-21T12:50:26.511Z] === RUN   TestCreateServiceConfigFileMode
12:50:29 [2019-10-21T12:50:29.208Z] --- PASS: TestCreateServiceConfigFileMode (2.55s)
12:50:29 [2019-10-21T12:50:29.208Z]     create_test.go:288: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceConfigFileMode"
12:50:29 [2019-10-21T12:50:29.208Z] === RUN   TestCreateServiceSysctls
12:50:32 [2019-10-21T12:50:32.667Z] --- PASS: TestCreateServiceSysctls (3.47s)
12:50:32 [2019-10-21T12:50:32.667Z]     create_test.go:378: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceSysctls"
12:50:32 [2019-10-21T12:50:32.667Z] === RUN   TestCreateServiceCapabilities
12:50:35 [2019-10-21T12:50:35.364Z] --- PASS: TestCreateServiceCapabilities (2.58s)
12:50:35 [2019-10-21T12:50:35.364Z]     create_test.go:462: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceCapabilities"
12:50:35 [2019-10-21T12:50:35.364Z] === RUN   TestInspect
12:50:38 [2019-10-21T12:50:38.073Z] --- PASS: TestInspect (2.80s)
12:50:38 [2019-10-21T12:50:38.073Z]     inspect_test.go:23: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestInspect"
12:50:38 [2019-10-21T12:50:38.073Z] === RUN   TestServiceListWithStatuses
12:50:38 [2019-10-21T12:50:38.073Z] --- SKIP: TestServiceListWithStatuses (0.00s)
12:50:38 [2019-10-21T12:50:38.073Z]     list_test.go:34: versions.LessThan(testEnv.DaemonInfo.ServerVersion, "1.41")
12:50:38 [2019-10-21T12:50:38.073Z] === RUN   TestDockerNetworkConnectAlias
12:50:42 [2019-10-21T12:50:42.467Z] --- PASS: TestDockerNetworkConnectAlias (4.51s)
12:50:42 [2019-10-21T12:50:42.467Z]     network_test.go:20: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkConnectAlias"
12:50:42 [2019-10-21T12:50:42.467Z] === RUN   TestDockerNetworkReConnect
12:50:45 [2019-10-21T12:50:45.930Z] --- PASS: TestDockerNetworkReConnect (3.50s)
12:50:45 [2019-10-21T12:50:45.930Z]     network_test.go:82: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkReConnect"
12:50:45 [2019-10-21T12:50:45.930Z] === RUN   TestServicePlugin
12:50:45 [2019-10-21T12:50:45.930Z] --- SKIP: TestServicePlugin (0.00s)
12:50:45 [2019-10-21T12:50:45.930Z]     plugin_test.go:28: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
12:50:45 [2019-10-21T12:50:45.930Z] === RUN   TestServiceUpdateLabel
12:50:48 [2019-10-21T12:50:48.013Z] --- PASS: TestServiceUpdateLabel (2.21s)
12:50:48 [2019-10-21T12:50:48.013Z]     update_test.go:21: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateLabel"
12:50:48 [2019-10-21T12:50:48.013Z] === RUN   TestServiceUpdateSecrets
12:51:03 [2019-10-21T12:51:03.234Z] --- PASS: TestServiceUpdateSecrets (14.72s)
12:51:03 [2019-10-21T12:51:03.234Z]     update_test.go:77: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateSecrets"
12:51:03 [2019-10-21T12:51:03.234Z] === RUN   TestServiceUpdateConfigs
12:51:18 [2019-10-21T12:51:18.468Z] --- PASS: TestServiceUpdateConfigs (14.71s)
12:51:18 [2019-10-21T12:51:18.468Z]     update_test.go:139: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateConfigs"
12:51:18 [2019-10-21T12:51:18.468Z] === RUN   TestServiceUpdateNetwork
12:51:31 [2019-10-21T12:51:31.006Z] --- PASS: TestServiceUpdateNetwork (12.68s)
12:51:31 [2019-10-21T12:51:31.006Z]     update_test.go:201: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateNetwork"
12:51:31 [2019-10-21T12:51:31.006Z] PASS
12:51:31 [2019-10-21T12:51:31.006Z] 
12:51:31 [2019-10-21T12:51:31.006Z] === Skipped
12:51:31 [2019-10-21T12:51:31.006Z] === SKIP: ppc64le.integration.service TestServiceListWithStatuses (0.00s)
12:51:31 [2019-10-21T12:51:31.006Z]     list_test.go:34: versions.LessThan(testEnv.DaemonInfo.ServerVersion, "1.41")
12:51:31 [2019-10-21T12:51:31.006Z] 
12:51:31 [2019-10-21T12:51:31.006Z] === SKIP: ppc64le.integration.service TestServicePlugin (0.00s)
12:51:31 [2019-10-21T12:51:31.006Z]     plugin_test.go:28: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
12:51:31 [2019-10-21T12:51:31.006Z] 
12:51:31 [2019-10-21T12:51:31.006Z] 
12:51:31 [2019-10-21T12:51:31.006Z] DONE 20 tests, 2 skipped in 111.010s
12:51:31 [2019-10-21T12:51:31.006Z] Running /go/src/github.com/docker/docker/integration/session (ppc64le.integration.session) flags=-test.v -test.timeout=120m 
12:51:31 [2019-10-21T12:51:31.006Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-session-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-session-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.session -t ./test.main -test.v -test.timeout=120m
12:51:31 [2019-10-21T12:51:31.006Z] ++ set -e
12:51:31 [2019-10-21T12:51:31.006Z] ++ '[' -n 0 ']'
12:51:31 [2019-10-21T12:51:31.006Z] ++ set -x
12:51:31 [2019-10-21T12:51:31.006Z] ++ 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=ppc64le 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/ppc64le-integration-session-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-session-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.session -t ./test.main -test.v -test.timeout=120m
12:51:31 [2019-10-21T12:51:31.006Z] INFO: Testing against a local daemon
12:51:31 [2019-10-21T12:51:31.006Z] === RUN   TestSessionCreate
12:51:31 [2019-10-21T12:51:31.006Z] --- PASS: TestSessionCreate (0.06s)
12:51:31 [2019-10-21T12:51:31.006Z] === RUN   TestSessionCreateWithBadUpgrade
12:51:31 [2019-10-21T12:51:31.006Z] --- PASS: TestSessionCreateWithBadUpgrade (0.05s)
12:51:31 [2019-10-21T12:51:31.006Z] PASS
12:51:31 [2019-10-21T12:51:31.006Z] 
12:51:31 [2019-10-21T12:51:31.006Z] DONE 2 tests in 0.208s
12:51:31 [2019-10-21T12:51:31.006Z] Running /go/src/github.com/docker/docker/integration/system (ppc64le.integration.system) flags=-test.v -test.timeout=120m 
12:51:31 [2019-10-21T12:51:31.006Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-system-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-system-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.system -t ./test.main -test.v -test.timeout=120m
12:51:31 [2019-10-21T12:51:31.006Z] ++ set -e
12:51:31 [2019-10-21T12:51:31.006Z] ++ '[' -n 0 ']'
12:51:31 [2019-10-21T12:51:31.006Z] ++ set -x
12:51:31 [2019-10-21T12:51:31.006Z] ++ 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=ppc64le 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/ppc64le-integration-system-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-system-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.system -t ./test.main -test.v -test.timeout=120m
12:51:31 [2019-10-21T12:51:31.006Z] INFO: Testing against a local daemon
12:51:31 [2019-10-21T12:51:31.006Z] === RUN   TestCgroupDriverSystemdMemoryLimit
12:51:31 [2019-10-21T12:51:31.006Z] --- SKIP: TestCgroupDriverSystemdMemoryLimit (0.00s)
12:51:31 [2019-10-21T12:51:31.006Z]     cgroupdriver_systemd_test.go:32: !hasSystemd()
12:51:31 [2019-10-21T12:51:31.006Z] === RUN   TestEventsExecDie
12:51:31 [2019-10-21T12:51:31.289Z] --- PASS: TestEventsExecDie (0.87s)
12:51:31 [2019-10-21T12:51:31.289Z] === RUN   TestEventsBackwardsCompatible
12:51:31 [2019-10-21T12:51:31.289Z] --- PASS: TestEventsBackwardsCompatible (0.08s)
12:51:31 [2019-10-21T12:51:31.289Z] === RUN   TestInfoBinaryCommits
12:51:31 [2019-10-21T12:51:31.289Z] --- PASS: TestInfoBinaryCommits (0.06s)
12:51:31 [2019-10-21T12:51:31.289Z] === RUN   TestInfoAPIVersioned
12:51:31 [2019-10-21T12:51:31.574Z] --- PASS: TestInfoAPIVersioned (0.01s)
12:51:31 [2019-10-21T12:51:31.574Z] === RUN   TestInfoAPI
12:51:31 [2019-10-21T12:51:31.574Z] --- PASS: TestInfoAPI (0.05s)
12:51:31 [2019-10-21T12:51:31.574Z] === RUN   TestInfoAPIWarnings
12:51:32 [2019-10-21T12:51:32.602Z] --- PASS: TestInfoAPIWarnings (0.89s)
12:51:32 [2019-10-21T12:51:32.602Z]     info_test.go:49: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestInfoAPIWarnings"
12:51:32 [2019-10-21T12:51:32.602Z] === RUN   TestLoginFailsWithBadCredentials
12:51:32 [2019-10-21T12:51:32.887Z] --- PASS: TestLoginFailsWithBadCredentials (0.56s)
12:51:32 [2019-10-21T12:51:32.887Z] === RUN   TestPingCacheHeaders
12:51:32 [2019-10-21T12:51:32.887Z] --- PASS: TestPingCacheHeaders (0.06s)
12:51:32 [2019-10-21T12:51:32.887Z] === RUN   TestPingGet
12:51:33 [2019-10-21T12:51:33.171Z] --- PASS: TestPingGet (0.04s)
12:51:33 [2019-10-21T12:51:33.171Z] === RUN   TestPingHead
12:51:33 [2019-10-21T12:51:33.171Z] --- PASS: TestPingHead (0.05s)
12:51:33 [2019-10-21T12:51:33.171Z] === RUN   TestVersion
12:51:33 [2019-10-21T12:51:33.171Z] --- PASS: TestVersion (0.05s)
12:51:33 [2019-10-21T12:51:33.171Z] PASS
12:51:33 [2019-10-21T12:51:33.171Z] 
12:51:33 [2019-10-21T12:51:33.171Z] === Skipped
12:51:33 [2019-10-21T12:51:33.171Z] === SKIP: ppc64le.integration.system TestCgroupDriverSystemdMemoryLimit (0.00s)
12:51:33 [2019-10-21T12:51:33.171Z]     cgroupdriver_systemd_test.go:32: !hasSystemd()
12:51:33 [2019-10-21T12:51:33.171Z] 
12:51:33 [2019-10-21T12:51:33.171Z] 
12:51:33 [2019-10-21T12:51:33.171Z] DONE 12 tests, 1 skipped in 2.818s
12:51:33 [2019-10-21T12:51:33.171Z] Running /go/src/github.com/docker/docker/integration/volume (ppc64le.integration.volume) flags=-test.v -test.timeout=120m 
12:51:33 [2019-10-21T12:51:33.171Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-volume-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-volume-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.volume -t ./test.main -test.v -test.timeout=120m
12:51:33 [2019-10-21T12:51:33.171Z] ++ set -e
12:51:33 [2019-10-21T12:51:33.171Z] ++ '[' -n 0 ']'
12:51:33 [2019-10-21T12:51:33.171Z] ++ set -x
12:51:33 [2019-10-21T12:51:33.171Z] ++ 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=ppc64le 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/ppc64le-integration-volume-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-volume-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.volume -t ./test.main -test.v -test.timeout=120m
12:51:33 [2019-10-21T12:51:33.171Z] INFO: Testing against a local daemon
12:51:33 [2019-10-21T12:51:33.171Z] === RUN   TestVolumesCreateAndList
12:51:33 [2019-10-21T12:51:33.171Z] --- PASS: TestVolumesCreateAndList (0.04s)
12:51:33 [2019-10-21T12:51:33.171Z] === RUN   TestVolumesRemove
12:51:33 [2019-10-21T12:51:33.455Z] --- PASS: TestVolumesRemove (0.10s)
12:51:33 [2019-10-21T12:51:33.455Z] === RUN   TestVolumesInspect
12:51:33 [2019-10-21T12:51:33.455Z] --- PASS: TestVolumesInspect (0.04s)
12:51:33 [2019-10-21T12:51:33.455Z] === RUN   TestVolumesInvalidJSON
12:51:33 [2019-10-21T12:51:33.455Z] === RUN   TestVolumesInvalidJSON//volumes/create
12:51:33 [2019-10-21T12:51:33.455Z] === PAUSE TestVolumesInvalidJSON//volumes/create
12:51:33 [2019-10-21T12:51:33.455Z] === CONT  TestVolumesInvalidJSON//volumes/create
12:51:33 [2019-10-21T12:51:33.455Z] --- PASS: TestVolumesInvalidJSON (0.03s)
12:51:33 [2019-10-21T12:51:33.455Z]     --- PASS: TestVolumesInvalidJSON//volumes/create (0.00s)
12:51:33 [2019-10-21T12:51:33.455Z] PASS
12:51:33 [2019-10-21T12:51:33.455Z] 
12:51:33 [2019-10-21T12:51:33.455Z] DONE 5 tests in 0.297s
12:51:33 [2019-10-21T12:51:33.455Z] ---> Making bundle: .integration-daemon-stop (in bundles/test-integration)
12:51:33 [2019-10-21T12:51:33.738Z] ++++ cat bundles/test-integration/docker.pid
12:51:33 [2019-10-21T12:51:33.738Z] +++ kill 13169
12:51:35 [2019-10-21T12:51:35.213Z] +++ /etc/init.d/apparmor stop
12:51:35 [2019-10-21T12:51:35.213Z] Clearing AppArmor profiles cache:.
12:51:35 [2019-10-21T12:51:35.213Z] All profile caches have been cleared, but no profiles have been unloaded.
12:51:35 [2019-10-21T12:51:35.213Z] Unloading profiles will leave already running processes permanently
12:51:35 [2019-10-21T12:51:35.213Z] unconfined, which can lead to unexpected situations.
12:51:35 [2019-10-21T12:51:35.213Z] 
12:51:35 [2019-10-21T12:51:35.213Z] To set a process to complain mode, use the command line tool
12:51:35 [2019-10-21T12:51:35.213Z] 'aa-complain'. To really tear down all profiles, run the init script
12:51:35 [2019-10-21T12:51:35.213Z] with the 'teardown' option."
12:51:35 [2019-10-21T12:51:35.213Z]