Console Output

16:01:02 [2019-10-22T16:01:02.372Z] + docker run --rm -t --privileged -v /home/docker/workspace/moby_PR-38401/bundles:/go/src/github.com/docker/docker/bundles --name docker-pr2 -e DOCKER_EXPERIMENTAL -e DOCKER_GITCOMMIT=73a7c369c6abce6117045332cd011c21db003cda -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:73a7c369c6abce6117045332cd011c21db003cda hack/make.sh dynbinary test-integration
16:01:02 [2019-10-22T16:01:02.656Z] 
16:01:02 [2019-10-22T16:01:02.943Z] Removing bundles/
16:01:02 [2019-10-22T16:01:02.943Z] 
16:01:02 [2019-10-22T16:01:02.943Z] ---> Making bundle: dynbinary (in bundles/dynbinary)
16:01:02 [2019-10-22T16:01:02.943Z] Building: bundles/dynbinary-daemon/dockerd-dev
16:01:02 [2019-10-22T16:01:02.943Z] GOOS="" GOARCH="" GOARM=""
16:02:55 [2019-10-22T16:02:55.072Z] Created binary: bundles/dynbinary-daemon/dockerd-dev
16:02:55 [2019-10-22T16:02:55.691Z] 
16:02:55 [2019-10-22T16:02:55.691Z] ---> Making bundle: test-integration (in bundles/test-integration)
16:02:56 [2019-10-22T16:02:56.313Z] PKG_CONFIG=pkg-config
16:02:56 [2019-10-22T16:02:56.313Z] GOLANG_VERSION=1.13.3
16:02:56 [2019-10-22T16:02:56.313Z] HOSTNAME=6321ebf3e8e9
16:02:56 [2019-10-22T16:02:56.313Z] DOCKER_EXPERIMENTAL=1
16:02:56 [2019-10-22T16:02:56.313Z] container=docker
16:02:56 [2019-10-22T16:02:56.313Z] TEST_SKIP_INTEGRATION_CLI=1
16:02:56 [2019-10-22T16:02:56.313Z] GO111MODULE=off
16:02:56 [2019-10-22T16:02:56.313Z] GOPATH=/go
16:02:56 [2019-10-22T16:02:56.313Z] PWD=/go/src/github.com/docker/docker
16:02:56 [2019-10-22T16:02:56.313Z] HOME=/root
16:02:56 [2019-10-22T16:02:56.313Z] VALIDATE_REPO=https://github.com/moby/moby.git
16:02:56 [2019-10-22T16:02:56.313Z] SCRIPTDIR=/go/src/github.com/docker/docker/hack
16:02:56 [2019-10-22T16:02:56.313Z] MAKEDIR=/go/src/github.com/docker/docker/hack/make
16:02:56 [2019-10-22T16:02:56.313Z] DOCKER_GITCOMMIT=73a7c369c6abce6117045332cd011c21db003cda
16:02:56 [2019-10-22T16:02:56.313Z] DOCKER_BUILDTAGS=apparmor seccomp selinux journald
16:02:56 [2019-10-22T16:02:56.313Z] DOCKER_GRAPHDRIVER=overlay2
16:02:56 [2019-10-22T16:02:56.313Z] TERM=xterm
16:02:56 [2019-10-22T16:02:56.313Z] VALIDATE_BRANCH=master
16:02:56 [2019-10-22T16:02:56.313Z] DEST=bundles/test-integration
16:02:56 [2019-10-22T16:02:56.313Z] SHLVL=1
16:02:56 [2019-10-22T16:02:56.313Z] TIMEOUT=120m
16:02:56 [2019-10-22T16:02:56.313Z] PATH=/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
16:02:56 [2019-10-22T16:02:56.313Z] DOCKER_PKG=github.com/docker/docker
16:02:56 [2019-10-22T16:02:56.313Z] TESTDEBUG=0
16:02:56 [2019-10-22T16:02:56.313Z] _=/usr/bin/env
16:02:56 [2019-10-22T16:02:56.313Z] Building test suite binary /go/src/github.com/docker/docker/integration/build/test.main
16:03:53 [2019-10-22T16:03:53.147Z] Building test suite binary /go/src/github.com/docker/docker/integration/config/test.main
16:03:53 [2019-10-22T16:03:53.147Z] Building test suite binary /go/src/github.com/docker/docker/integration/container/test.main
16:03:54 [2019-10-22T16:03:54.157Z] Building test suite binary /go/src/github.com/docker/docker/integration/image/test.main
16:04:33 [2019-10-22T16:04:33.410Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/test.main
16:04:33 [2019-10-22T16:04:33.410Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/ipvlan/test.main
16:04:33 [2019-10-22T16:04:33.410Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/macvlan/test.main
16:04:34 [2019-10-22T16:04:34.029Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/test.main
16:04:34 [2019-10-22T16:04:34.647Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/authz/test.main
16:04:38 [2019-10-22T16:04:38.116Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/common/test.main
16:04:39 [2019-10-22T16:04:39.618Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/graphdriver/test.main
16:04:42 [2019-10-22T16:04:42.347Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/logging/test.main
16:04:46 [2019-10-22T16:04:46.750Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/volumes/test.main
16:04:49 [2019-10-22T16:04:49.437Z] Building test suite binary /go/src/github.com/docker/docker/integration/secret/test.main
16:04:51 [2019-10-22T16:04:51.486Z] Building test suite binary /go/src/github.com/docker/docker/integration/service/test.main
16:04:54 [2019-10-22T16:04:54.951Z] Building test suite binary /go/src/github.com/docker/docker/integration/session/test.main
16:04:56 [2019-10-22T16:04:56.429Z] Building test suite binary /go/src/github.com/docker/docker/integration/system/test.main
16:04:58 [2019-10-22T16:04:58.468Z] Building test suite binary /go/src/github.com/docker/docker/integration/volume/test.main
16:05:00 [2019-10-22T16:05:00.520Z] ---> Making bundle: .integration-daemon-start (in bundles/test-integration)
16:05:00 [2019-10-22T16:05:00.520Z] Using test binary docker
16:05:00 [2019-10-22T16:05:00.520Z] # DOCKER_EXPERIMENTAL is set: starting daemon with experimental features enabled! 
16:05:00 [2019-10-22T16:05:00.520Z] +++ /etc/init.d/apparmor start
16:05:00 [2019-10-22T16:05:00.520Z] /etc/init.d/apparmor: 130: /etc/init.d/apparmor: systemd-detect-virt: not found
16:05:00 [2019-10-22T16:05:00.520Z] Starting AppArmor profiles:Warning from stdin (line 1): /sbin/apparmor_parser: cannot use or update cache, disable, or force-complain via stdin
16:05:00 [2019-10-22T16:05:00.520Z] Warning failed to create cache: (null)
16:05:00 [2019-10-22T16:05:00.520Z] .
16:05:00 [2019-10-22T16:05:00.520Z] INFO: Waiting for daemon to start...
16:05:00 [2019-10-22T16:05:00.520Z] Starting dockerd
16:05:00 [2019-10-22T16:05:00.520Z] +++ 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
16:05:02 [2019-10-22T16:05:02.542Z] .
16:05:02 [2019-10-22T16:05:02.542Z] ---> Making bundle: .integration-daemon-setup (in bundles/test-integration)
16:05:02 [2019-10-22T16:05:02.542Z] ---> Making bundle: .ensure-emptyfs (in bundles/test-integration)
16:05:02 [2019-10-22T16:05:02.542Z] Error: No such image: emptyfs
16:05:02 [2019-10-22T16:05:02.542Z] ++++ tar -cC bundles/test-integration/emptyfs .
16:05:02 [2019-10-22T16:05:02.542Z] ++++ docker load
16:05:02 [2019-10-22T16:05:02.827Z] Running integration-test (iteration 1)
16:05:02 [2019-10-22T16:05:02.827Z] Running /go/src/github.com/docker/docker/integration/build (ppc64le.integration.build) flags=-test.v -test.timeout=120m 
16:05:02 [2019-10-22T16:05:02.827Z] ++ 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
16:05:02 [2019-10-22T16:05:02.827Z] ++ set -e
16:05:02 [2019-10-22T16:05:02.827Z] ++ '[' -n 0 ']'
16:05:02 [2019-10-22T16:05:02.827Z] ++ set -x
16:05:02 [2019-10-22T16:05:02.827Z] ++ 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
16:05:18 [2019-10-22T16:05:18.077Z] Loaded image: buildpack-deps:jessie
16:05:18 [2019-10-22T16:05:18.077Z] Loaded image: busybox:latest
16:05:18 [2019-10-22T16:05:18.077Z] Loaded image: busybox:glibc
16:05:18 [2019-10-22T16:05:18.077Z] Loaded image: debian:jessie
16:05:18 [2019-10-22T16:05:18.077Z] Loaded image: hello-world:latest
16:05:18 [2019-10-22T16:05:18.077Z] INFO: Testing against a local daemon
16:05:18 [2019-10-22T16:05:18.077Z] === RUN   TestCgroupNamespacesBuild
16:05:18 [2019-10-22T16:05:18.694Z] --- PASS: TestCgroupNamespacesBuild (1.61s)
16:05:18 [2019-10-22T16:05:18.694Z]     build_cgroupns_linux_test.go:42: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesBuild"
16:05:18 [2019-10-22T16:05:18.694Z] === RUN   TestCgroupNamespacesBuildDaemonHostMode
16:05:20 [2019-10-22T16:05:20.181Z] --- PASS: TestCgroupNamespacesBuildDaemonHostMode (1.62s)
16:05:20 [2019-10-22T16:05:20.181Z]     build_cgroupns_linux_test.go:42: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesBuildDaemonHostMode"
16:05:20 [2019-10-22T16:05:20.181Z] === RUN   TestBuildWithSession
16:05:20 [2019-10-22T16:05:20.181Z] --- SKIP: TestBuildWithSession (0.00s)
16:05:20 [2019-10-22T16:05:20.181Z]     build_session_test.go:25: TODO: BuildKit
16:05:20 [2019-10-22T16:05:20.181Z] === RUN   TestBuildSquashParent
16:05:25 [2019-10-22T16:05:25.679Z] --- PASS: TestBuildSquashParent (5.22s)
16:05:25 [2019-10-22T16:05:25.679Z] === RUN   TestBuildWithRemoveAndForceRemove
16:05:25 [2019-10-22T16:05:25.679Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
16:05:25 [2019-10-22T16:05:25.679Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
16:05:25 [2019-10-22T16:05:25.679Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_remove
16:05:25 [2019-10-22T16:05:25.679Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_remove
16:05:25 [2019-10-22T16:05:25.679Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
16:05:25 [2019-10-22T16:05:25.679Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
16:05:25 [2019-10-22T16:05:25.679Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
16:05:25 [2019-10-22T16:05:25.679Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
16:05:25 [2019-10-22T16:05:25.679Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_remove
16:05:25 [2019-10-22T16:05:25.679Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_remove
16:05:25 [2019-10-22T16:05:25.679Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
16:05:25 [2019-10-22T16:05:25.679Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
16:05:25 [2019-10-22T16:05:25.679Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
16:05:25 [2019-10-22T16:05:25.679Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
16:05:25 [2019-10-22T16:05:25.679Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_remove
16:05:25 [2019-10-22T16:05:25.679Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
16:05:28 [2019-10-22T16:05:28.366Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
16:05:28 [2019-10-22T16:05:28.650Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_remove
16:05:31 [2019-10-22T16:05:31.363Z] --- PASS: TestBuildWithRemoveAndForceRemove (0.02s)
16:05:31 [2019-10-22T16:05:31.363Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal (2.66s)
16:05:31 [2019-10-22T16:05:31.363Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal (3.20s)
16:05:31 [2019-10-22T16:05:31.363Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove (3.29s)
16:05:31 [2019-10-22T16:05:31.363Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_remove (3.42s)
16:05:31 [2019-10-22T16:05:31.363Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_remove (2.19s)
16:05:31 [2019-10-22T16:05:31.363Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove (2.76s)
16:05:31 [2019-10-22T16:05:31.363Z] === RUN   TestBuildMultiStageCopy
16:05:31 [2019-10-22T16:05:31.363Z] === RUN   TestBuildMultiStageCopy/copy_to_root
16:05:32 [2019-10-22T16:05:32.840Z] === RUN   TestBuildMultiStageCopy/copy_to_newdir
16:05:33 [2019-10-22T16:05:33.123Z] === RUN   TestBuildMultiStageCopy/copy_to_newdir_nested
16:05:33 [2019-10-22T16:05:33.406Z] === RUN   TestBuildMultiStageCopy/copy_to_existingdir
16:05:34 [2019-10-22T16:05:34.029Z] === RUN   TestBuildMultiStageCopy/copy_to_newsubdir
16:05:34 [2019-10-22T16:05:34.313Z] --- PASS: TestBuildMultiStageCopy (3.35s)
16:05:34 [2019-10-22T16:05:34.313Z]     --- PASS: TestBuildMultiStageCopy/copy_to_root (1.88s)
16:05:34 [2019-10-22T16:05:34.313Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newdir (0.35s)
16:05:34 [2019-10-22T16:05:34.313Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newdir_nested (0.36s)
16:05:34 [2019-10-22T16:05:34.313Z]     --- PASS: TestBuildMultiStageCopy/copy_to_existingdir (0.36s)
16:05:34 [2019-10-22T16:05:34.313Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newsubdir (0.40s)
16:05:34 [2019-10-22T16:05:34.313Z] === RUN   TestBuildMultiStageParentConfig
16:05:35 [2019-10-22T16:05:35.328Z] --- PASS: TestBuildMultiStageParentConfig (0.92s)
16:05:35 [2019-10-22T16:05:35.328Z] === RUN   TestBuildLabelWithTargets
16:05:36 [2019-10-22T16:05:36.805Z] --- PASS: TestBuildLabelWithTargets (1.48s)
16:05:36 [2019-10-22T16:05:36.805Z] === RUN   TestBuildWithEmptyLayers
16:05:37 [2019-10-22T16:05:37.425Z] --- PASS: TestBuildWithEmptyLayers (0.78s)
16:05:37 [2019-10-22T16:05:37.425Z] === RUN   TestBuildMultiStageOnBuild
16:05:40 [2019-10-22T16:05:40.122Z] --- PASS: TestBuildMultiStageOnBuild (2.24s)
16:05:40 [2019-10-22T16:05:40.122Z] === RUN   TestBuildUncleanTarFilenames
16:05:40 [2019-10-22T16:05:40.746Z] --- PASS: TestBuildUncleanTarFilenames (1.13s)
16:05:40 [2019-10-22T16:05:40.746Z] === RUN   TestBuildMultiStageLayerLeak
16:05:43 [2019-10-22T16:05:43.431Z] --- PASS: TestBuildMultiStageLayerLeak (2.32s)
16:05:43 [2019-10-22T16:05:43.431Z] === RUN   TestBuildWithHugeFile
16:07:05 [2019-10-22T16:07:05.443Z] --- PASS: TestBuildWithHugeFile (80.86s)
16:07:05 [2019-10-22T16:07:05.443Z] === RUN   TestBuildWithEmptyDockerfile
16:07:05 [2019-10-22T16:07:05.443Z] === RUN   TestBuildWithEmptyDockerfile/empty-dockerfile
16:07:05 [2019-10-22T16:07:05.443Z] === PAUSE TestBuildWithEmptyDockerfile/empty-dockerfile
16:07:05 [2019-10-22T16:07:05.443Z] === RUN   TestBuildWithEmptyDockerfile/empty-lines-dockerfile
16:07:05 [2019-10-22T16:07:05.443Z] === PAUSE TestBuildWithEmptyDockerfile/empty-lines-dockerfile
16:07:05 [2019-10-22T16:07:05.443Z] === RUN   TestBuildWithEmptyDockerfile/comment-only-dockerfile
16:07:05 [2019-10-22T16:07:05.443Z] === PAUSE TestBuildWithEmptyDockerfile/comment-only-dockerfile
16:07:05 [2019-10-22T16:07:05.443Z] === CONT  TestBuildWithEmptyDockerfile/empty-dockerfile
16:07:05 [2019-10-22T16:07:05.443Z] === CONT  TestBuildWithEmptyDockerfile/empty-lines-dockerfile
16:07:05 [2019-10-22T16:07:05.443Z] === CONT  TestBuildWithEmptyDockerfile/comment-only-dockerfile
16:07:05 [2019-10-22T16:07:05.443Z] --- PASS: TestBuildWithEmptyDockerfile (0.07s)
16:07:05 [2019-10-22T16:07:05.443Z]     --- PASS: TestBuildWithEmptyDockerfile/empty-lines-dockerfile (0.31s)
16:07:05 [2019-10-22T16:07:05.443Z]     --- PASS: TestBuildWithEmptyDockerfile/empty-dockerfile (0.31s)
16:07:05 [2019-10-22T16:07:05.443Z]     --- PASS: TestBuildWithEmptyDockerfile/comment-only-dockerfile (0.32s)
16:07:05 [2019-10-22T16:07:05.443Z] === RUN   TestBuildPreserveOwnership
16:07:05 [2019-10-22T16:07:05.443Z] === RUN   TestBuildPreserveOwnership/copy_from
16:07:07 [2019-10-22T16:07:07.483Z] === RUN   TestBuildPreserveOwnership/copy_from_chowned
16:07:09 [2019-10-22T16:07:09.535Z] --- PASS: TestBuildPreserveOwnership (4.80s)
16:07:09 [2019-10-22T16:07:09.535Z]     --- PASS: TestBuildPreserveOwnership/copy_from (3.15s)
16:07:09 [2019-10-22T16:07:09.535Z]     --- PASS: TestBuildPreserveOwnership/copy_from_chowned (1.63s)
16:07:09 [2019-10-22T16:07:09.535Z] === RUN   TestBuildPlatformInvalid
16:07:09 [2019-10-22T16:07:09.535Z] --- PASS: TestBuildPlatformInvalid (0.16s)
16:07:09 [2019-10-22T16:07:09.535Z] PASS
16:07:09 [2019-10-22T16:07:09.535Z] 
16:07:09 [2019-10-22T16:07:09.535Z] === Skipped
16:07:09 [2019-10-22T16:07:09.535Z] === SKIP: ppc64le.integration.build TestBuildWithSession (0.00s)
16:07:09 [2019-10-22T16:07:09.535Z]     build_session_test.go:25: TODO: BuildKit
16:07:09 [2019-10-22T16:07:09.535Z] 
16:07:09 [2019-10-22T16:07:09.535Z] 
16:07:09 [2019-10-22T16:07:09.535Z] DONE 32 tests, 1 skipped in 126.436s
16:07:09 [2019-10-22T16:07:09.535Z] Running /go/src/github.com/docker/docker/integration/config (ppc64le.integration.config) flags=-test.v -test.timeout=120m 
16:07:09 [2019-10-22T16:07:09.535Z] ++ 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
16:07:09 [2019-10-22T16:07:09.535Z] ++ set -e
16:07:09 [2019-10-22T16:07:09.535Z] ++ '[' -n 0 ']'
16:07:09 [2019-10-22T16:07:09.535Z] ++ set -x
16:07:09 [2019-10-22T16:07:09.535Z] ++ 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
16:07:09 [2019-10-22T16:07:09.535Z] INFO: Testing against a local daemon
16:07:09 [2019-10-22T16:07:09.535Z] === RUN   TestConfigList
16:07:12 [2019-10-22T16:07:12.219Z] --- PASS: TestConfigList (2.27s)
16:07:12 [2019-10-22T16:07:12.219Z]     config_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigList"
16:07:12 [2019-10-22T16:07:12.219Z] === RUN   TestConfigsCreateAndDelete
16:07:14 [2019-10-22T16:07:14.246Z] --- PASS: TestConfigsCreateAndDelete (2.22s)
16:07:14 [2019-10-22T16:07:14.246Z]     config_test.go:112: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigsCreateAndDelete"
16:07:14 [2019-10-22T16:07:14.246Z] === RUN   TestConfigsUpdate
16:07:16 [2019-10-22T16:07:16.267Z] --- PASS: TestConfigsUpdate (2.17s)
16:07:16 [2019-10-22T16:07:16.267Z]     config_test.go:140: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigsUpdate"
16:07:16 [2019-10-22T16:07:16.267Z] === RUN   TestTemplatedConfig
16:07:18 [2019-10-22T16:07:18.963Z] --- PASS: TestTemplatedConfig (2.81s)
16:07:18 [2019-10-22T16:07:18.963Z]     config_test.go:192: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestTemplatedConfig"
16:07:18 [2019-10-22T16:07:18.963Z] === RUN   TestConfigInspect
16:07:20 [2019-10-22T16:07:20.991Z] --- PASS: TestConfigInspect (2.15s)
16:07:20 [2019-10-22T16:07:20.991Z]     config_test.go:326: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigInspect"
16:07:20 [2019-10-22T16:07:20.991Z] === RUN   TestConfigCreateWithLabels
16:07:23 [2019-10-22T16:07:23.667Z] --- PASS: TestConfigCreateWithLabels (2.20s)
16:07:23 [2019-10-22T16:07:23.667Z]     config_test.go:350: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigCreateWithLabels"
16:07:23 [2019-10-22T16:07:23.667Z] === RUN   TestConfigCreateResolve
16:07:25 [2019-10-22T16:07:25.700Z] --- PASS: TestConfigCreateResolve (2.21s)
16:07:25 [2019-10-22T16:07:25.700Z]     config_test.go:377: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigCreateResolve"
16:07:25 [2019-10-22T16:07:25.700Z] === RUN   TestConfigDaemonLibtrustID
16:07:25 [2019-10-22T16:07:25.989Z] --- PASS: TestConfigDaemonLibtrustID (0.56s)
16:07:25 [2019-10-22T16:07:25.989Z]     config_test.go:427: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigDaemonLibtrustID"
16:07:25 [2019-10-22T16:07:25.989Z] PASS
16:07:25 [2019-10-22T16:07:25.989Z] 
16:07:25 [2019-10-22T16:07:25.989Z] DONE 8 tests in 16.691s
16:07:25 [2019-10-22T16:07:25.989Z] Running /go/src/github.com/docker/docker/integration/container (ppc64le.integration.container) flags=-test.v -test.timeout=120m 
16:07:25 [2019-10-22T16:07:25.989Z] ++ 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
16:07:25 [2019-10-22T16:07:25.989Z] ++ set -e
16:07:25 [2019-10-22T16:07:25.989Z] ++ '[' -n 0 ']'
16:07:25 [2019-10-22T16:07:25.989Z] ++ set -x
16:07:25 [2019-10-22T16:07:25.989Z] ++ 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
16:07:26 [2019-10-22T16:07:26.271Z] INFO: Testing against a local daemon
16:07:26 [2019-10-22T16:07:26.271Z] === RUN   TestCheckpoint
16:07:26 [2019-10-22T16:07:26.271Z] --- SKIP: TestCheckpoint (0.00s)
16:07:26 [2019-10-22T16:07:26.271Z]     checkpoint_test.go:33: TestCheckpoint is broken; see https://github.com/moby/moby/issues/38963
16:07:26 [2019-10-22T16:07:26.271Z] === RUN   TestContainerInvalidJSON
16:07:26 [2019-10-22T16:07:26.271Z] === RUN   TestContainerInvalidJSON//containers/foobar/copy
16:07:26 [2019-10-22T16:07:26.271Z] === PAUSE TestContainerInvalidJSON//containers/foobar/copy
16:07:26 [2019-10-22T16:07:26.271Z] === RUN   TestContainerInvalidJSON//containers/foobar/exec
16:07:26 [2019-10-22T16:07:26.271Z] === PAUSE TestContainerInvalidJSON//containers/foobar/exec
16:07:26 [2019-10-22T16:07:26.271Z] === RUN   TestContainerInvalidJSON//exec/foobar/start
16:07:26 [2019-10-22T16:07:26.271Z] === PAUSE TestContainerInvalidJSON//exec/foobar/start
16:07:26 [2019-10-22T16:07:26.271Z] === CONT  TestContainerInvalidJSON//containers/foobar/copy
16:07:26 [2019-10-22T16:07:26.271Z] === CONT  TestContainerInvalidJSON//exec/foobar/start
16:07:26 [2019-10-22T16:07:26.271Z] === CONT  TestContainerInvalidJSON//containers/foobar/exec
16:07:26 [2019-10-22T16:07:26.271Z] --- PASS: TestContainerInvalidJSON (0.02s)
16:07:26 [2019-10-22T16:07:26.271Z]     --- PASS: TestContainerInvalidJSON//containers/foobar/exec (0.00s)
16:07:26 [2019-10-22T16:07:26.271Z]     --- PASS: TestContainerInvalidJSON//containers/foobar/copy (0.00s)
16:07:26 [2019-10-22T16:07:26.271Z]     --- PASS: TestContainerInvalidJSON//exec/foobar/start (0.00s)
16:07:26 [2019-10-22T16:07:26.271Z] === RUN   TestCopyFromContainerPathDoesNotExist
16:07:26 [2019-10-22T16:07:26.271Z] --- PASS: TestCopyFromContainerPathDoesNotExist (0.08s)
16:07:26 [2019-10-22T16:07:26.271Z] === RUN   TestCopyFromContainerPathIsNotDir
16:07:26 [2019-10-22T16:07:26.555Z] --- PASS: TestCopyFromContainerPathIsNotDir (0.10s)
16:07:26 [2019-10-22T16:07:26.555Z] === RUN   TestCopyToContainerPathDoesNotExist
16:07:26 [2019-10-22T16:07:26.555Z] --- PASS: TestCopyToContainerPathDoesNotExist (0.08s)
16:07:26 [2019-10-22T16:07:26.555Z] === RUN   TestCopyToContainerPathIsNotDir
16:07:26 [2019-10-22T16:07:26.555Z] --- PASS: TestCopyToContainerPathIsNotDir (0.07s)
16:07:26 [2019-10-22T16:07:26.555Z] === RUN   TestCopyFromContainer
16:07:28 [2019-10-22T16:07:28.029Z] === RUN   TestCopyFromContainer//
16:07:28 [2019-10-22T16:07:28.029Z] === RUN   TestCopyFromContainer//bar/root
16:07:28 [2019-10-22T16:07:28.312Z] === RUN   TestCopyFromContainer//bar/root/
16:07:28 [2019-10-22T16:07:28.312Z] === RUN   TestCopyFromContainer/bar/quux
16:07:28 [2019-10-22T16:07:28.596Z] === RUN   TestCopyFromContainer/bar/quux/
16:07:28 [2019-10-22T16:07:28.596Z] === RUN   TestCopyFromContainer/bar/quux/baz
16:07:28 [2019-10-22T16:07:28.596Z] === RUN   TestCopyFromContainer/bar/filesymlink
16:07:28 [2019-10-22T16:07:28.596Z] === RUN   TestCopyFromContainer/bar/dirsymlink
16:07:28 [2019-10-22T16:07:28.880Z] === RUN   TestCopyFromContainer/bar/dirsymlink/
16:07:28 [2019-10-22T16:07:28.880Z] === RUN   TestCopyFromContainer/bar/notarget
16:07:29 [2019-10-22T16:07:29.164Z] --- PASS: TestCopyFromContainer (2.47s)
16:07:29 [2019-10-22T16:07:29.164Z]     --- PASS: TestCopyFromContainer// (0.09s)
16:07:29 [2019-10-22T16:07:29.164Z]     --- PASS: TestCopyFromContainer//bar/root (0.10s)
16:07:29 [2019-10-22T16:07:29.164Z]     --- PASS: TestCopyFromContainer//bar/root/ (0.09s)
16:07:29 [2019-10-22T16:07:29.164Z]     --- PASS: TestCopyFromContainer/bar/quux (0.11s)
16:07:29 [2019-10-22T16:07:29.164Z]     --- PASS: TestCopyFromContainer/bar/quux/ (0.09s)
16:07:29 [2019-10-22T16:07:29.164Z]     --- PASS: TestCopyFromContainer/bar/quux/baz (0.09s)
16:07:29 [2019-10-22T16:07:29.164Z]     --- PASS: TestCopyFromContainer/bar/filesymlink (0.08s)
16:07:29 [2019-10-22T16:07:29.164Z]     --- PASS: TestCopyFromContainer/bar/dirsymlink (0.10s)
16:07:29 [2019-10-22T16:07:29.164Z]     --- PASS: TestCopyFromContainer/bar/dirsymlink/ (0.08s)
16:07:29 [2019-10-22T16:07:29.164Z]     --- PASS: TestCopyFromContainer/bar/notarget (0.09s)
16:07:29 [2019-10-22T16:07:29.164Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist
16:07:29 [2019-10-22T16:07:29.164Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
16:07:29 [2019-10-22T16:07:29.164Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
16:07:29 [2019-10-22T16:07:29.164Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
16:07:29 [2019-10-22T16:07:29.164Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
16:07:29 [2019-10-22T16:07:29.164Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/digest
16:07:29 [2019-10-22T16:07:29.164Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/digest
16:07:29 [2019-10-22T16:07:29.164Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
16:07:29 [2019-10-22T16:07:29.164Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/digest
16:07:29 [2019-10-22T16:07:29.164Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
16:07:29 [2019-10-22T16:07:29.164Z] --- PASS: TestCreateFailsWhenIdentifierDoesNotExist (0.02s)
16:07:29 [2019-10-22T16:07:29.164Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag (0.00s)
16:07:29 [2019-10-22T16:07:29.164Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag (0.00s)
16:07:29 [2019-10-22T16:07:29.164Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/digest (0.00s)
16:07:29 [2019-10-22T16:07:29.164Z] === RUN   TestCreateLinkToNonExistingContainer
16:07:29 [2019-10-22T16:07:29.164Z] --- PASS: TestCreateLinkToNonExistingContainer (0.04s)
16:07:29 [2019-10-22T16:07:29.164Z] === RUN   TestCreateWithInvalidEnv
16:07:29 [2019-10-22T16:07:29.164Z] === RUN   TestCreateWithInvalidEnv/0
16:07:29 [2019-10-22T16:07:29.164Z] === PAUSE TestCreateWithInvalidEnv/0
16:07:29 [2019-10-22T16:07:29.164Z] === RUN   TestCreateWithInvalidEnv/1
16:07:29 [2019-10-22T16:07:29.164Z] === PAUSE TestCreateWithInvalidEnv/1
16:07:29 [2019-10-22T16:07:29.164Z] === RUN   TestCreateWithInvalidEnv/2
16:07:29 [2019-10-22T16:07:29.164Z] === PAUSE TestCreateWithInvalidEnv/2
16:07:29 [2019-10-22T16:07:29.164Z] === CONT  TestCreateWithInvalidEnv/0
16:07:29 [2019-10-22T16:07:29.164Z] === CONT  TestCreateWithInvalidEnv/2
16:07:29 [2019-10-22T16:07:29.164Z] === CONT  TestCreateWithInvalidEnv/1
16:07:29 [2019-10-22T16:07:29.164Z] --- PASS: TestCreateWithInvalidEnv (0.02s)
16:07:29 [2019-10-22T16:07:29.164Z]     --- PASS: TestCreateWithInvalidEnv/2 (0.00s)
16:07:29 [2019-10-22T16:07:29.164Z]     --- PASS: TestCreateWithInvalidEnv/1 (0.00s)
16:07:29 [2019-10-22T16:07:29.164Z]     --- PASS: TestCreateWithInvalidEnv/0 (0.00s)
16:07:29 [2019-10-22T16:07:29.164Z] === RUN   TestCreateTmpfsMountsTarget
16:07:29 [2019-10-22T16:07:29.164Z] --- PASS: TestCreateTmpfsMountsTarget (0.03s)
16:07:29 [2019-10-22T16:07:29.164Z] === RUN   TestCreateWithCustomMaskedPaths
16:07:33 [2019-10-22T16:07:33.552Z] --- PASS: TestCreateWithCustomMaskedPaths (1.94s)
16:07:33 [2019-10-22T16:07:33.552Z] === RUN   TestCreateWithCapabilities
16:07:33 [2019-10-22T16:07:33.552Z] === RUN   TestCreateWithCapabilities/no_capabilities
16:07:33 [2019-10-22T16:07:33.552Z] === PAUSE TestCreateWithCapabilities/no_capabilities
16:07:33 [2019-10-22T16:07:33.552Z] === RUN   TestCreateWithCapabilities/empty_capabilities
16:07:33 [2019-10-22T16:07:33.552Z] === PAUSE TestCreateWithCapabilities/empty_capabilities
16:07:33 [2019-10-22T16:07:33.552Z] === RUN   TestCreateWithCapabilities/valid_capabilities
16:07:33 [2019-10-22T16:07:33.552Z] === PAUSE TestCreateWithCapabilities/valid_capabilities
16:07:33 [2019-10-22T16:07:33.552Z] === RUN   TestCreateWithCapabilities/invalid_capabilities
16:07:33 [2019-10-22T16:07:33.552Z] === PAUSE TestCreateWithCapabilities/invalid_capabilities
16:07:33 [2019-10-22T16:07:33.552Z] === RUN   TestCreateWithCapabilities/duplicate_capabilities
16:07:33 [2019-10-22T16:07:33.552Z] === PAUSE TestCreateWithCapabilities/duplicate_capabilities
16:07:33 [2019-10-22T16:07:33.552Z] === RUN   TestCreateWithCapabilities/capabilities_API_v1.39
16:07:33 [2019-10-22T16:07:33.552Z] === PAUSE TestCreateWithCapabilities/capabilities_API_v1.39
16:07:33 [2019-10-22T16:07:33.552Z] === RUN   TestCreateWithCapabilities/empty_capadd
16:07:33 [2019-10-22T16:07:33.552Z] === PAUSE TestCreateWithCapabilities/empty_capadd
16:07:33 [2019-10-22T16:07:33.552Z] === RUN   TestCreateWithCapabilities/empty_capdrop
16:07:33 [2019-10-22T16:07:33.552Z] === PAUSE TestCreateWithCapabilities/empty_capdrop
16:07:33 [2019-10-22T16:07:33.552Z] === RUN   TestCreateWithCapabilities/capadd_capdrop
16:07:33 [2019-10-22T16:07:33.552Z] === PAUSE TestCreateWithCapabilities/capadd_capdrop
16:07:33 [2019-10-22T16:07:33.552Z] === RUN   TestCreateWithCapabilities/conflict_with_capadd
16:07:33 [2019-10-22T16:07:33.552Z] === PAUSE TestCreateWithCapabilities/conflict_with_capadd
16:07:33 [2019-10-22T16:07:33.552Z] === RUN   TestCreateWithCapabilities/conflict_with_capdrop
16:07:33 [2019-10-22T16:07:33.552Z] === PAUSE TestCreateWithCapabilities/conflict_with_capdrop
16:07:33 [2019-10-22T16:07:33.552Z] === CONT  TestCreateWithCapabilities/no_capabilities
16:07:33 [2019-10-22T16:07:33.552Z] === CONT  TestCreateWithCapabilities/empty_capdrop
16:07:33 [2019-10-22T16:07:33.552Z] === CONT  TestCreateWithCapabilities/empty_capadd
16:07:33 [2019-10-22T16:07:33.552Z] === CONT  TestCreateWithCapabilities/conflict_with_capdrop
16:07:33 [2019-10-22T16:07:33.552Z] === CONT  TestCreateWithCapabilities/capadd_capdrop
16:07:33 [2019-10-22T16:07:33.552Z] === CONT  TestCreateWithCapabilities/conflict_with_capadd
16:07:33 [2019-10-22T16:07:33.552Z] === CONT  TestCreateWithCapabilities/invalid_capabilities
16:07:33 [2019-10-22T16:07:33.552Z] === CONT  TestCreateWithCapabilities/capabilities_API_v1.39
16:07:33 [2019-10-22T16:07:33.552Z] === CONT  TestCreateWithCapabilities/duplicate_capabilities
16:07:33 [2019-10-22T16:07:33.552Z] === CONT  TestCreateWithCapabilities/valid_capabilities
16:07:33 [2019-10-22T16:07:33.552Z] === CONT  TestCreateWithCapabilities/empty_capabilities
16:07:33 [2019-10-22T16:07:33.552Z] --- PASS: TestCreateWithCapabilities (0.04s)
16:07:33 [2019-10-22T16:07:33.552Z]     --- PASS: TestCreateWithCapabilities/conflict_with_capdrop (0.01s)
16:07:33 [2019-10-22T16:07:33.552Z]     --- PASS: TestCreateWithCapabilities/empty_capadd (0.05s)
16:07:33 [2019-10-22T16:07:33.552Z]     --- PASS: TestCreateWithCapabilities/conflict_with_capadd (0.00s)
16:07:33 [2019-10-22T16:07:33.552Z]     --- PASS: TestCreateWithCapabilities/no_capabilities (0.06s)
16:07:33 [2019-10-22T16:07:33.552Z]     --- PASS: TestCreateWithCapabilities/invalid_capabilities (0.00s)
16:07:33 [2019-10-22T16:07:33.552Z]     --- PASS: TestCreateWithCapabilities/capadd_capdrop (0.06s)
16:07:33 [2019-10-22T16:07:33.552Z]     --- PASS: TestCreateWithCapabilities/empty_capdrop (0.07s)
16:07:33 [2019-10-22T16:07:33.552Z]     --- PASS: TestCreateWithCapabilities/duplicate_capabilities (0.04s)
16:07:33 [2019-10-22T16:07:33.552Z]     --- PASS: TestCreateWithCapabilities/capabilities_API_v1.39 (0.05s)
16:07:33 [2019-10-22T16:07:33.553Z]     --- PASS: TestCreateWithCapabilities/valid_capabilities (0.05s)
16:07:33 [2019-10-22T16:07:33.553Z]     --- PASS: TestCreateWithCapabilities/empty_capabilities (0.06s)
16:07:33 [2019-10-22T16:07:33.553Z] === RUN   TestCreateWithCustomReadonlyPaths
16:07:33 [2019-10-22T16:07:33.553Z] --- PASS: TestCreateWithCustomReadonlyPaths (1.97s)
16:07:33 [2019-10-22T16:07:33.553Z] === RUN   TestCreateWithInvalidHealthcheckParams
16:07:33 [2019-10-22T16:07:33.553Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
16:07:33 [2019-10-22T16:07:33.553Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
16:07:33 [2019-10-22T16:07:33.553Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
16:07:33 [2019-10-22T16:07:33.553Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
16:07:33 [2019-10-22T16:07:33.553Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
16:07:33 [2019-10-22T16:07:33.553Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
16:07:33 [2019-10-22T16:07:33.553Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
16:07:33 [2019-10-22T16:07:33.553Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
16:07:33 [2019-10-22T16:07:33.553Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
16:07:33 [2019-10-22T16:07:33.553Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
16:07:33 [2019-10-22T16:07:33.553Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
16:07:33 [2019-10-22T16:07:33.553Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
16:07:33 [2019-10-22T16:07:33.553Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
16:07:33 [2019-10-22T16:07:33.553Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
16:07:33 [2019-10-22T16:07:33.553Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
16:07:33 [2019-10-22T16:07:33.553Z] --- PASS: TestCreateWithInvalidHealthcheckParams (0.03s)
16:07:33 [2019-10-22T16:07:33.553Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms (0.03s)
16:07:33 [2019-10-22T16:07:33.553Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0 (0.03s)
16:07:33 [2019-10-22T16:07:33.553Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s (0.04s)
16:07:33 [2019-10-22T16:07:33.553Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms (0.04s)
16:07:33 [2019-10-22T16:07:33.553Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms (0.02s)
16:07:33 [2019-10-22T16:07:33.553Z] === RUN   TestContainerStartOnDaemonRestart
16:07:33 [2019-10-22T16:07:33.553Z] === PAUSE TestContainerStartOnDaemonRestart
16:07:33 [2019-10-22T16:07:33.553Z] === RUN   TestDaemonRestartIpcMode
16:07:33 [2019-10-22T16:07:33.553Z] === PAUSE TestDaemonRestartIpcMode
16:07:33 [2019-10-22T16:07:33.553Z] === RUN   TestDiff
16:07:34 [2019-10-22T16:07:34.171Z] --- PASS: TestDiff (0.71s)
16:07:34 [2019-10-22T16:07:34.171Z] === RUN   TestExecWithCloseStdin
16:07:34 [2019-10-22T16:07:34.789Z] --- PASS: TestExecWithCloseStdin (0.88s)
16:07:34 [2019-10-22T16:07:34.789Z] === RUN   TestExec
16:07:35 [2019-10-22T16:07:35.802Z] --- PASS: TestExec (0.83s)
16:07:35 [2019-10-22T16:07:35.802Z] === RUN   TestExecUser
16:07:36 [2019-10-22T16:07:36.814Z] --- PASS: TestExecUser (0.87s)
16:07:36 [2019-10-22T16:07:36.814Z] === RUN   TestExportContainerAndImportImage
16:07:37 [2019-10-22T16:07:37.824Z] --- PASS: TestExportContainerAndImportImage (0.96s)
16:07:37 [2019-10-22T16:07:37.824Z] === RUN   TestExportContainerAfterDaemonRestart
16:07:39 [2019-10-22T16:07:39.301Z] --- PASS: TestExportContainerAfterDaemonRestart (1.53s)
16:07:39 [2019-10-22T16:07:39.301Z]     export_test.go:63: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestExportContainerAfterDaemonRestart"
16:07:39 [2019-10-22T16:07:39.301Z] === RUN   TestHealthCheckWorkdir
16:07:40 [2019-10-22T16:07:40.311Z] --- PASS: TestHealthCheckWorkdir (1.06s)
16:07:40 [2019-10-22T16:07:40.311Z] === RUN   TestHealthKillContainer
16:07:42 [2019-10-22T16:07:42.983Z] --- PASS: TestHealthKillContainer (2.89s)
16:07:42 [2019-10-22T16:07:42.983Z] === RUN   TestInspectCpusetInConfigPre120
16:07:43 [2019-10-22T16:07:43.598Z] --- PASS: TestInspectCpusetInConfigPre120 (0.67s)
16:07:43 [2019-10-22T16:07:43.598Z] === RUN   TestIpcModeNone
16:07:44 [2019-10-22T16:07:44.615Z] --- PASS: TestIpcModeNone (0.85s)
16:07:44 [2019-10-22T16:07:44.615Z] === RUN   TestIpcModePrivate
16:07:45 [2019-10-22T16:07:45.624Z] --- PASS: TestIpcModePrivate (0.83s)
16:07:45 [2019-10-22T16:07:45.624Z]     ipcmode_linux_test.go:90: [testIpcPrivateShareable] ipcmode: private, ipcdev: 0:61, shared: false, mustBeShared: false
16:07:45 [2019-10-22T16:07:45.624Z] === RUN   TestIpcModeShareable
16:07:46 [2019-10-22T16:07:46.241Z] --- PASS: TestIpcModeShareable (0.86s)
16:07:46 [2019-10-22T16:07:46.241Z]     ipcmode_linux_test.go:90: [testIpcPrivateShareable] ipcmode: shareable, ipcdev: 0:55, shared: true, mustBeShared: true
16:07:46 [2019-10-22T16:07:46.241Z] === RUN   TestAPIIpcModeShareableAndContainer
16:07:48 [2019-10-22T16:07:48.919Z] --- PASS: TestAPIIpcModeShareableAndContainer (2.46s)
16:07:48 [2019-10-22T16:07:48.919Z] === RUN   TestAPIIpcModeHost
16:07:49 [2019-10-22T16:07:49.539Z] --- PASS: TestAPIIpcModeHost (0.71s)
16:07:49 [2019-10-22T16:07:49.539Z] === RUN   TestDaemonIpcModeShareable
16:07:51 [2019-10-22T16:07:51.564Z] --- PASS: TestDaemonIpcModeShareable (1.78s)
16:07:51 [2019-10-22T16:07:51.564Z]     ipcmode_linux_test.go:230: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModeShareable"
16:07:51 [2019-10-22T16:07:51.564Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:63, shared: true, mustBeShared: true
16:07:51 [2019-10-22T16:07:51.564Z] === RUN   TestDaemonIpcModePrivate
16:07:53 [2019-10-22T16:07:53.046Z] --- PASS: TestDaemonIpcModePrivate (1.74s)
16:07:53 [2019-10-22T16:07:53.046Z]     ipcmode_linux_test.go:230: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModePrivate"
16:07:53 [2019-10-22T16:07:53.046Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:69, shared: false, mustBeShared: false
16:07:53 [2019-10-22T16:07:53.046Z] === RUN   TestDaemonIpcModePrivateFromConfig
16:07:55 [2019-10-22T16:07:55.081Z] --- PASS: TestDaemonIpcModePrivateFromConfig (1.75s)
16:07:55 [2019-10-22T16:07:55.081Z]     ipcmode_linux_test.go:230: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModePrivateFromConfig"
16:07:55 [2019-10-22T16:07:55.081Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:69, shared: false, mustBeShared: false
16:07:55 [2019-10-22T16:07:55.081Z] === RUN   TestDaemonIpcModeShareableFromConfig
16:07:56 [2019-10-22T16:07:56.561Z] --- PASS: TestDaemonIpcModeShareableFromConfig (1.75s)
16:07:56 [2019-10-22T16:07:56.561Z]     ipcmode_linux_test.go:230: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModeShareableFromConfig"
16:07:56 [2019-10-22T16:07:56.561Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:63, shared: true, mustBeShared: true
16:07:56 [2019-10-22T16:07:56.561Z] === RUN   TestIpcModeOlderClient
16:07:56 [2019-10-22T16:07:56.561Z] === PAUSE TestIpcModeOlderClient
16:07:56 [2019-10-22T16:07:56.561Z] === RUN   TestKillContainerInvalidSignal
16:07:57 [2019-10-22T16:07:57.178Z] --- PASS: TestKillContainerInvalidSignal (0.70s)
16:07:57 [2019-10-22T16:07:57.178Z] === RUN   TestKillContainer
16:07:57 [2019-10-22T16:07:57.178Z] === RUN   TestKillContainer/no_signal
16:07:57 [2019-10-22T16:07:57.795Z] === RUN   TestKillContainer/non_killing_signal
16:07:58 [2019-10-22T16:07:58.410Z] === RUN   TestKillContainer/killing_signal
16:07:59 [2019-10-22T16:07:59.420Z] --- PASS: TestKillContainer (2.08s)
16:07:59 [2019-10-22T16:07:59.420Z]     --- PASS: TestKillContainer/no_signal (0.67s)
16:07:59 [2019-10-22T16:07:59.420Z]     --- PASS: TestKillContainer/non_killing_signal (0.46s)
16:07:59 [2019-10-22T16:07:59.420Z]     --- PASS: TestKillContainer/killing_signal (0.67s)
16:07:59 [2019-10-22T16:07:59.420Z] === RUN   TestKillWithStopSignalAndRestartPolicies
16:07:59 [2019-10-22T16:07:59.420Z] === RUN   TestKillWithStopSignalAndRestartPolicies/same-signal-disables-restart-policy
16:08:00 [2019-10-22T16:08:00.037Z] === RUN   TestKillWithStopSignalAndRestartPolicies/different-signal-keep-restart-policy
16:08:00 [2019-10-22T16:08:00.653Z] --- PASS: TestKillWithStopSignalAndRestartPolicies (1.42s)
16:08:00 [2019-10-22T16:08:00.653Z]     --- PASS: TestKillWithStopSignalAndRestartPolicies/same-signal-disables-restart-policy (0.66s)
16:08:00 [2019-10-22T16:08:00.653Z]     --- PASS: TestKillWithStopSignalAndRestartPolicies/different-signal-keep-restart-policy (0.49s)
16:08:00 [2019-10-22T16:08:00.653Z] === RUN   TestKillStoppedContainer
16:08:00 [2019-10-22T16:08:00.653Z] --- PASS: TestKillStoppedContainer (0.09s)
16:08:00 [2019-10-22T16:08:00.653Z] === RUN   TestKillStoppedContainerAPIPre120
16:08:00 [2019-10-22T16:08:00.941Z] --- PASS: TestKillStoppedContainerAPIPre120 (0.09s)
16:08:00 [2019-10-22T16:08:00.941Z] === RUN   TestKillDifferentUserContainer
16:08:01 [2019-10-22T16:08:01.564Z] --- PASS: TestKillDifferentUserContainer (0.71s)
16:08:01 [2019-10-22T16:08:01.564Z] === RUN   TestInspectOomKilledTrue
16:08:03 [2019-10-22T16:08:03.037Z] --- PASS: TestInspectOomKilledTrue (1.16s)
16:08:03 [2019-10-22T16:08:03.037Z] === RUN   TestInspectOomKilledFalse
16:08:03 [2019-10-22T16:08:03.318Z] --- PASS: TestInspectOomKilledFalse (0.67s)
16:08:03 [2019-10-22T16:08:03.318Z] === RUN   TestLinksEtcHostsContentMatch
16:08:03 [2019-10-22T16:08:03.936Z] --- PASS: TestLinksEtcHostsContentMatch (0.62s)
16:08:03 [2019-10-22T16:08:03.936Z] === RUN   TestLinksContainerNames
16:08:05 [2019-10-22T16:08:05.409Z] --- PASS: TestLinksContainerNames (1.30s)
16:08:05 [2019-10-22T16:08:05.409Z] === RUN   TestLogsFollowTailEmpty
16:08:06 [2019-10-22T16:08:06.027Z] --- PASS: TestLogsFollowTailEmpty (0.69s)
16:08:06 [2019-10-22T16:08:06.027Z] === RUN   TestContainerNetworkMountsNoChown
16:08:06 [2019-10-22T16:08:06.644Z] --- PASS: TestContainerNetworkMountsNoChown (0.70s)
16:08:06 [2019-10-22T16:08:06.644Z] === RUN   TestMountDaemonRoot
16:08:06 [2019-10-22T16:08:06.644Z] === RUN   TestMountDaemonRoot/default
16:08:06 [2019-10-22T16:08:06.644Z] === PAUSE TestMountDaemonRoot/default
16:08:06 [2019-10-22T16:08:06.644Z] === RUN   TestMountDaemonRoot/private
16:08:06 [2019-10-22T16:08:06.644Z] === PAUSE TestMountDaemonRoot/private
16:08:06 [2019-10-22T16:08:06.644Z] === RUN   TestMountDaemonRoot/rprivate
16:08:06 [2019-10-22T16:08:06.644Z] === PAUSE TestMountDaemonRoot/rprivate
16:08:06 [2019-10-22T16:08:06.644Z] === RUN   TestMountDaemonRoot/slave
16:08:06 [2019-10-22T16:08:06.644Z] === PAUSE TestMountDaemonRoot/slave
16:08:06 [2019-10-22T16:08:06.644Z] === RUN   TestMountDaemonRoot/rslave
16:08:06 [2019-10-22T16:08:06.644Z] === PAUSE TestMountDaemonRoot/rslave
16:08:06 [2019-10-22T16:08:06.644Z] === RUN   TestMountDaemonRoot/shared
16:08:06 [2019-10-22T16:08:06.644Z] === PAUSE TestMountDaemonRoot/shared
16:08:06 [2019-10-22T16:08:06.644Z] === RUN   TestMountDaemonRoot/rshared
16:08:06 [2019-10-22T16:08:06.644Z] === PAUSE TestMountDaemonRoot/rshared
16:08:06 [2019-10-22T16:08:06.644Z] === CONT  TestMountDaemonRoot/default
16:08:06 [2019-10-22T16:08:06.644Z] === CONT  TestMountDaemonRoot/rslave
16:08:06 [2019-10-22T16:08:06.644Z] === CONT  TestMountDaemonRoot/rshared
16:08:06 [2019-10-22T16:08:06.644Z] === RUN   TestMountDaemonRoot/default/bind_root
16:08:06 [2019-10-22T16:08:06.644Z] === RUN   TestMountDaemonRoot/rshared/bind_root
16:08:06 [2019-10-22T16:08:06.644Z] === CONT  TestMountDaemonRoot/slave
16:08:06 [2019-10-22T16:08:06.644Z] === RUN   TestMountDaemonRoot/rslave/bind_root
16:08:06 [2019-10-22T16:08:06.644Z] === PAUSE TestMountDaemonRoot/rshared/bind_root
16:08:06 [2019-10-22T16:08:06.644Z] === PAUSE TestMountDaemonRoot/rslave/bind_root
16:08:06 [2019-10-22T16:08:06.644Z] === RUN   TestMountDaemonRoot/rshared/bind_subpath
16:08:06 [2019-10-22T16:08:06.644Z] === PAUSE TestMountDaemonRoot/rshared/bind_subpath
16:08:06 [2019-10-22T16:08:06.644Z] === RUN   TestMountDaemonRoot/rslave/bind_subpath
16:08:06 [2019-10-22T16:08:06.644Z] === RUN   TestMountDaemonRoot/rshared/mount_root
16:08:06 [2019-10-22T16:08:06.644Z] === PAUSE TestMountDaemonRoot/rslave/bind_subpath
16:08:06 [2019-10-22T16:08:06.644Z] === PAUSE TestMountDaemonRoot/rshared/mount_root
16:08:06 [2019-10-22T16:08:06.644Z] === RUN   TestMountDaemonRoot/rslave/mount_root
16:08:06 [2019-10-22T16:08:06.644Z] === RUN   TestMountDaemonRoot/rshared/mount_subpath
16:08:06 [2019-10-22T16:08:06.644Z] === PAUSE TestMountDaemonRoot/rshared/mount_subpath
16:08:06 [2019-10-22T16:08:06.644Z] === PAUSE TestMountDaemonRoot/rslave/mount_root
16:08:06 [2019-10-22T16:08:06.644Z] === RUN   TestMountDaemonRoot/rslave/mount_subpath
16:08:06 [2019-10-22T16:08:06.644Z] === PAUSE TestMountDaemonRoot/rslave/mount_subpath
16:08:06 [2019-10-22T16:08:06.644Z] === CONT  TestMountDaemonRoot/shared
16:08:06 [2019-10-22T16:08:06.644Z] === RUN   TestMountDaemonRoot/shared/bind_root
16:08:06 [2019-10-22T16:08:06.644Z] === PAUSE TestMountDaemonRoot/shared/bind_root
16:08:06 [2019-10-22T16:08:06.644Z] === RUN   TestMountDaemonRoot/shared/bind_subpath
16:08:06 [2019-10-22T16:08:06.644Z] === PAUSE TestMountDaemonRoot/shared/bind_subpath
16:08:06 [2019-10-22T16:08:06.644Z] === RUN   TestMountDaemonRoot/shared/mount_root
16:08:06 [2019-10-22T16:08:06.644Z] === PAUSE TestMountDaemonRoot/shared/mount_root
16:08:06 [2019-10-22T16:08:06.644Z] === RUN   TestMountDaemonRoot/shared/mount_subpath
16:08:06 [2019-10-22T16:08:06.644Z] === PAUSE TestMountDaemonRoot/shared/mount_subpath
16:08:06 [2019-10-22T16:08:06.644Z] === RUN   TestMountDaemonRoot/slave/mount_root
16:08:06 [2019-10-22T16:08:06.644Z] === PAUSE TestMountDaemonRoot/slave/mount_root
16:08:06 [2019-10-22T16:08:06.644Z] === RUN   TestMountDaemonRoot/slave/mount_subpath
16:08:06 [2019-10-22T16:08:06.644Z] === PAUSE TestMountDaemonRoot/slave/mount_subpath
16:08:06 [2019-10-22T16:08:06.644Z] === RUN   TestMountDaemonRoot/slave/bind_root
16:08:06 [2019-10-22T16:08:06.644Z] === PAUSE TestMountDaemonRoot/slave/bind_root
16:08:06 [2019-10-22T16:08:06.644Z] === RUN   TestMountDaemonRoot/slave/bind_subpath
16:08:06 [2019-10-22T16:08:06.644Z] === PAUSE TestMountDaemonRoot/slave/bind_subpath
16:08:06 [2019-10-22T16:08:06.644Z] === CONT  TestMountDaemonRoot/rprivate
16:08:06 [2019-10-22T16:08:06.644Z] === RUN   TestMountDaemonRoot/rprivate/mount_root
16:08:06 [2019-10-22T16:08:06.644Z] === PAUSE TestMountDaemonRoot/rprivate/mount_root
16:08:06 [2019-10-22T16:08:06.644Z] === RUN   TestMountDaemonRoot/rprivate/mount_subpath
16:08:06 [2019-10-22T16:08:06.644Z] === PAUSE TestMountDaemonRoot/rprivate/mount_subpath
16:08:06 [2019-10-22T16:08:06.644Z] === RUN   TestMountDaemonRoot/rprivate/bind_root
16:08:06 [2019-10-22T16:08:06.644Z] === PAUSE TestMountDaemonRoot/rprivate/bind_root
16:08:06 [2019-10-22T16:08:06.644Z] === RUN   TestMountDaemonRoot/rprivate/bind_subpath
16:08:06 [2019-10-22T16:08:06.644Z] === PAUSE TestMountDaemonRoot/rprivate/bind_subpath
16:08:06 [2019-10-22T16:08:06.644Z] === CONT  TestMountDaemonRoot/private
16:08:06 [2019-10-22T16:08:06.644Z] === RUN   TestMountDaemonRoot/private/bind_root
16:08:06 [2019-10-22T16:08:06.644Z] === PAUSE TestMountDaemonRoot/private/bind_root
16:08:06 [2019-10-22T16:08:06.644Z] === RUN   TestMountDaemonRoot/private/bind_subpath
16:08:06 [2019-10-22T16:08:06.644Z] === PAUSE TestMountDaemonRoot/private/bind_subpath
16:08:06 [2019-10-22T16:08:06.644Z] === RUN   TestMountDaemonRoot/private/mount_root
16:08:06 [2019-10-22T16:08:06.644Z] === PAUSE TestMountDaemonRoot/private/mount_root
16:08:06 [2019-10-22T16:08:06.644Z] === RUN   TestMountDaemonRoot/private/mount_subpath
16:08:06 [2019-10-22T16:08:06.644Z] === PAUSE TestMountDaemonRoot/private/mount_subpath
16:08:06 [2019-10-22T16:08:06.644Z] === PAUSE TestMountDaemonRoot/default/bind_root
16:08:06 [2019-10-22T16:08:06.644Z] === RUN   TestMountDaemonRoot/default/bind_subpath
16:08:06 [2019-10-22T16:08:06.644Z] === PAUSE TestMountDaemonRoot/default/bind_subpath
16:08:06 [2019-10-22T16:08:06.644Z] === RUN   TestMountDaemonRoot/default/mount_root
16:08:06 [2019-10-22T16:08:06.644Z] === PAUSE TestMountDaemonRoot/default/mount_root
16:08:06 [2019-10-22T16:08:06.644Z] === RUN   TestMountDaemonRoot/default/mount_subpath
16:08:06 [2019-10-22T16:08:06.644Z] === PAUSE TestMountDaemonRoot/default/mount_subpath
16:08:06 [2019-10-22T16:08:06.644Z] === CONT  TestMountDaemonRoot/rshared/bind_root
16:08:06 [2019-10-22T16:08:06.644Z] === CONT  TestMountDaemonRoot/rslave/bind_root
16:08:06 [2019-10-22T16:08:06.644Z] === CONT  TestMountDaemonRoot/shared/bind_root
16:08:06 [2019-10-22T16:08:06.644Z] === CONT  TestMountDaemonRoot/rshared/mount_subpath
16:08:06 [2019-10-22T16:08:06.927Z] === CONT  TestMountDaemonRoot/rshared/mount_root
16:08:06 [2019-10-22T16:08:06.927Z] === CONT  TestMountDaemonRoot/rshared/bind_subpath
16:08:06 [2019-10-22T16:08:06.927Z] === CONT  TestMountDaemonRoot/slave/mount_root
16:08:06 [2019-10-22T16:08:06.927Z] === CONT  TestMountDaemonRoot/rprivate/mount_root
16:08:06 [2019-10-22T16:08:06.927Z] === CONT  TestMountDaemonRoot/rslave/mount_subpath
16:08:06 [2019-10-22T16:08:06.927Z] === CONT  TestMountDaemonRoot/rslave/mount_root
16:08:06 [2019-10-22T16:08:06.927Z] === CONT  TestMountDaemonRoot/rslave/bind_subpath
16:08:06 [2019-10-22T16:08:06.927Z] === CONT  TestMountDaemonRoot/private/bind_root
16:08:06 [2019-10-22T16:08:06.927Z] === CONT  TestMountDaemonRoot/shared/mount_subpath
16:08:06 [2019-10-22T16:08:06.927Z] === CONT  TestMountDaemonRoot/shared/mount_root
16:08:06 [2019-10-22T16:08:06.927Z] === CONT  TestMountDaemonRoot/shared/bind_subpath
16:08:06 [2019-10-22T16:08:06.927Z] === CONT  TestMountDaemonRoot/default/bind_root
16:08:06 [2019-10-22T16:08:06.927Z] === CONT  TestMountDaemonRoot/slave/bind_subpath
16:08:06 [2019-10-22T16:08:06.927Z] === CONT  TestMountDaemonRoot/slave/bind_root
16:08:06 [2019-10-22T16:08:06.927Z] === CONT  TestMountDaemonRoot/slave/mount_subpath
16:08:06 [2019-10-22T16:08:06.927Z] === CONT  TestMountDaemonRoot/rprivate/bind_subpath
16:08:06 [2019-10-22T16:08:06.927Z] === CONT  TestMountDaemonRoot/rprivate/bind_root
16:08:06 [2019-10-22T16:08:06.927Z] === CONT  TestMountDaemonRoot/rprivate/mount_subpath
16:08:06 [2019-10-22T16:08:06.927Z] === CONT  TestMountDaemonRoot/private/mount_subpath
16:08:06 [2019-10-22T16:08:06.927Z] === CONT  TestMountDaemonRoot/private/mount_root
16:08:06 [2019-10-22T16:08:06.927Z] === CONT  TestMountDaemonRoot/private/bind_subpath
16:08:06 [2019-10-22T16:08:06.927Z] === CONT  TestMountDaemonRoot/default/mount_subpath
16:08:06 [2019-10-22T16:08:06.927Z] === CONT  TestMountDaemonRoot/default/mount_root
16:08:06 [2019-10-22T16:08:06.927Z] === CONT  TestMountDaemonRoot/default/bind_subpath
16:08:07 [2019-10-22T16:08:07.212Z] --- PASS: TestMountDaemonRoot (0.04s)
16:08:07 [2019-10-22T16:08:07.212Z]     --- PASS: TestMountDaemonRoot/rshared (0.00s)
16:08:07 [2019-10-22T16:08:07.212Z]         --- PASS: TestMountDaemonRoot/rshared/bind_root (0.07s)
16:08:07 [2019-10-22T16:08:07.212Z]         --- PASS: TestMountDaemonRoot/rshared/mount_subpath (0.08s)
16:08:07 [2019-10-22T16:08:07.212Z]         --- PASS: TestMountDaemonRoot/rshared/mount_root (0.07s)
16:08:07 [2019-10-22T16:08:07.212Z]         --- PASS: TestMountDaemonRoot/rshared/bind_subpath (0.06s)
16:08:07 [2019-10-22T16:08:07.212Z]     --- PASS: TestMountDaemonRoot/rslave (0.00s)
16:08:07 [2019-10-22T16:08:07.212Z]         --- PASS: TestMountDaemonRoot/rslave/bind_root (0.07s)
16:08:07 [2019-10-22T16:08:07.212Z]         --- PASS: TestMountDaemonRoot/rslave/mount_subpath (0.05s)
16:08:07 [2019-10-22T16:08:07.212Z]         --- PASS: TestMountDaemonRoot/rslave/bind_subpath (0.05s)
16:08:07 [2019-10-22T16:08:07.212Z]         --- PASS: TestMountDaemonRoot/rslave/mount_root (0.06s)
16:08:07 [2019-10-22T16:08:07.212Z]     --- PASS: TestMountDaemonRoot/shared (0.00s)
16:08:07 [2019-10-22T16:08:07.212Z]         --- PASS: TestMountDaemonRoot/shared/bind_root (0.05s)
16:08:07 [2019-10-22T16:08:07.212Z]         --- PASS: TestMountDaemonRoot/shared/mount_subpath (0.02s)
16:08:07 [2019-10-22T16:08:07.212Z]         --- PASS: TestMountDaemonRoot/shared/mount_root (0.04s)
16:08:07 [2019-10-22T16:08:07.212Z]         --- PASS: TestMountDaemonRoot/shared/bind_subpath (0.05s)
16:08:07 [2019-10-22T16:08:07.212Z]     --- PASS: TestMountDaemonRoot/slave (0.00s)
16:08:07 [2019-10-22T16:08:07.212Z]         --- PASS: TestMountDaemonRoot/slave/mount_root (0.03s)
16:08:07 [2019-10-22T16:08:07.212Z]         --- PASS: TestMountDaemonRoot/slave/bind_subpath (0.03s)
16:08:07 [2019-10-22T16:08:07.212Z]         --- PASS: TestMountDaemonRoot/slave/mount_subpath (0.04s)
16:08:07 [2019-10-22T16:08:07.212Z]         --- PASS: TestMountDaemonRoot/slave/bind_root (0.04s)
16:08:07 [2019-10-22T16:08:07.212Z]     --- PASS: TestMountDaemonRoot/rprivate (0.00s)
16:08:07 [2019-10-22T16:08:07.212Z]         --- PASS: TestMountDaemonRoot/rprivate/mount_root (0.04s)
16:08:07 [2019-10-22T16:08:07.212Z]         --- PASS: TestMountDaemonRoot/rprivate/bind_subpath (0.04s)
16:08:07 [2019-10-22T16:08:07.212Z]         --- PASS: TestMountDaemonRoot/rprivate/bind_root (0.05s)
16:08:07 [2019-10-22T16:08:07.212Z]         --- PASS: TestMountDaemonRoot/rprivate/mount_subpath (0.04s)
16:08:07 [2019-10-22T16:08:07.212Z]     --- PASS: TestMountDaemonRoot/private (0.00s)
16:08:07 [2019-10-22T16:08:07.212Z]         --- PASS: TestMountDaemonRoot/private/bind_root (0.04s)
16:08:07 [2019-10-22T16:08:07.212Z]         --- PASS: TestMountDaemonRoot/private/mount_subpath (0.03s)
16:08:07 [2019-10-22T16:08:07.212Z]         --- PASS: TestMountDaemonRoot/private/bind_subpath (0.03s)
16:08:07 [2019-10-22T16:08:07.212Z]         --- PASS: TestMountDaemonRoot/private/mount_root (0.04s)
16:08:07 [2019-10-22T16:08:07.212Z]     --- PASS: TestMountDaemonRoot/default (0.00s)
16:08:07 [2019-10-22T16:08:07.212Z]         --- PASS: TestMountDaemonRoot/default/bind_root (0.06s)
16:08:07 [2019-10-22T16:08:07.212Z]         --- PASS: TestMountDaemonRoot/default/mount_root (0.05s)
16:08:07 [2019-10-22T16:08:07.212Z]         --- PASS: TestMountDaemonRoot/default/mount_subpath (0.05s)
16:08:07 [2019-10-22T16:08:07.212Z]         --- PASS: TestMountDaemonRoot/default/bind_subpath (0.05s)
16:08:07 [2019-10-22T16:08:07.212Z] === RUN   TestContainerBindMountNonRecursive
16:08:08 [2019-10-22T16:08:08.685Z] --- PASS: TestContainerBindMountNonRecursive (1.59s)
16:08:08 [2019-10-22T16:08:08.685Z] === RUN   TestNetworkNat
16:08:09 [2019-10-22T16:08:09.698Z] --- PASS: TestNetworkNat (0.76s)
16:08:09 [2019-10-22T16:08:09.699Z] === RUN   TestNetworkLocalhostTCPNat
16:08:10 [2019-10-22T16:08:10.313Z] --- PASS: TestNetworkLocalhostTCPNat (0.71s)
16:08:10 [2019-10-22T16:08:10.313Z] === RUN   TestNetworkLoopbackNat
16:08:10 [2019-10-22T16:08:10.928Z] --- PASS: TestNetworkLoopbackNat (0.90s)
16:08:10 [2019-10-22T16:08:10.928Z] === RUN   TestPause
16:08:11 [2019-10-22T16:08:11.941Z] --- PASS: TestPause (0.75s)
16:08:11 [2019-10-22T16:08:11.941Z] === RUN   TestPauseFailsOnWindowsServerContainers
16:08:11 [2019-10-22T16:08:11.941Z] --- SKIP: TestPauseFailsOnWindowsServerContainers (0.00s)
16:08:11 [2019-10-22T16:08:11.941Z]     pause_test.go:54: testEnv.DaemonInfo.OSType != "windows" || testEnv.DaemonInfo.Isolation != "process"
16:08:11 [2019-10-22T16:08:11.941Z] === RUN   TestPauseStopPausedContainer
16:08:12 [2019-10-22T16:08:12.558Z] --- PASS: TestPauseStopPausedContainer (0.74s)
16:08:12 [2019-10-22T16:08:12.558Z] === RUN   TestPsFilter
16:08:12 [2019-10-22T16:08:12.843Z] --- PASS: TestPsFilter (0.19s)
16:08:12 [2019-10-22T16:08:12.843Z] === RUN   TestRemoveContainerWithRemovedVolume
16:08:13 [2019-10-22T16:08:13.461Z] --- PASS: TestRemoveContainerWithRemovedVolume (0.63s)
16:08:13 [2019-10-22T16:08:13.461Z] === RUN   TestRemoveContainerWithVolume
16:08:14 [2019-10-22T16:08:14.080Z] --- PASS: TestRemoveContainerWithVolume (0.69s)
16:08:14 [2019-10-22T16:08:14.080Z] === RUN   TestRemoveContainerRunning
16:08:14 [2019-10-22T16:08:14.697Z] --- PASS: TestRemoveContainerRunning (0.72s)
16:08:14 [2019-10-22T16:08:14.697Z] === RUN   TestRemoveContainerForceRemoveRunning
16:08:15 [2019-10-22T16:08:15.706Z] --- PASS: TestRemoveContainerForceRemoveRunning (0.70s)
16:08:15 [2019-10-22T16:08:15.706Z] === RUN   TestRemoveInvalidContainer
16:08:15 [2019-10-22T16:08:15.706Z] --- PASS: TestRemoveInvalidContainer (0.04s)
16:08:15 [2019-10-22T16:08:15.706Z] === RUN   TestRenameLinkedContainer
16:08:18 [2019-10-22T16:08:18.397Z] --- PASS: TestRenameLinkedContainer (2.76s)
16:08:18 [2019-10-22T16:08:18.397Z] === RUN   TestRenameStoppedContainer
16:08:19 [2019-10-22T16:08:19.016Z] --- PASS: TestRenameStoppedContainer (0.66s)
16:08:19 [2019-10-22T16:08:19.016Z] === RUN   TestRenameRunningContainerAndReuse
16:08:20 [2019-10-22T16:08:20.496Z] --- PASS: TestRenameRunningContainerAndReuse (1.39s)
16:08:20 [2019-10-22T16:08:20.496Z] === RUN   TestRenameInvalidName
16:08:21 [2019-10-22T16:08:21.113Z] --- PASS: TestRenameInvalidName (0.70s)
16:08:21 [2019-10-22T16:08:21.113Z] === RUN   TestRenameAnonymousContainer
16:08:23 [2019-10-22T16:08:23.797Z] --- PASS: TestRenameAnonymousContainer (2.44s)
16:08:23 [2019-10-22T16:08:23.797Z] === RUN   TestRenameContainerWithSameName
16:08:24 [2019-10-22T16:08:24.080Z] --- PASS: TestRenameContainerWithSameName (0.70s)
16:08:24 [2019-10-22T16:08:24.080Z] === RUN   TestRenameContainerWithLinkedContainer
16:08:25 [2019-10-22T16:08:25.560Z] --- PASS: TestRenameContainerWithLinkedContainer (1.36s)
16:08:25 [2019-10-22T16:08:25.560Z] === RUN   TestResize
16:08:26 [2019-10-22T16:08:26.191Z] --- PASS: TestResize (0.68s)
16:08:26 [2019-10-22T16:08:26.191Z] === RUN   TestResizeWithInvalidSize
16:08:26 [2019-10-22T16:08:26.806Z] --- PASS: TestResizeWithInvalidSize (0.69s)
16:08:26 [2019-10-22T16:08:26.806Z] === RUN   TestResizeWhenContainerNotStarted
16:08:27 [2019-10-22T16:08:27.820Z] --- PASS: TestResizeWhenContainerNotStarted (0.65s)
16:08:27 [2019-10-22T16:08:27.820Z] === RUN   TestDaemonRestartKillContainers
16:08:27 [2019-10-22T16:08:27.820Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
16:08:27 [2019-10-22T16:08:27.820Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
16:08:27 [2019-10-22T16:08:27.820Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
16:08:27 [2019-10-22T16:08:27.820Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
16:08:27 [2019-10-22T16:08:27.820Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
16:08:27 [2019-10-22T16:08:27.820Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
16:08:27 [2019-10-22T16:08:27.820Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
16:08:27 [2019-10-22T16:08:27.820Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
16:08:27 [2019-10-22T16:08:27.820Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
16:08:27 [2019-10-22T16:08:27.820Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
16:08:27 [2019-10-22T16:08:27.820Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
16:08:27 [2019-10-22T16:08:27.820Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
16:08:27 [2019-10-22T16:08:27.820Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
16:08:27 [2019-10-22T16:08:27.820Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
16:08:27 [2019-10-22T16:08:27.821Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
16:08:27 [2019-10-22T16:08:27.821Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
16:08:27 [2019-10-22T16:08:27.821Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
16:08:27 [2019-10-22T16:08:27.821Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
16:08:27 [2019-10-22T16:08:27.821Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
16:08:27 [2019-10-22T16:08:27.821Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
16:08:27 [2019-10-22T16:08:27.821Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
16:08:27 [2019-10-22T16:08:27.821Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
16:08:27 [2019-10-22T16:08:27.821Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
16:08:27 [2019-10-22T16:08:27.821Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
16:08:27 [2019-10-22T16:08:27.821Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
16:08:27 [2019-10-22T16:08:27.821Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
16:08:27 [2019-10-22T16:08:27.821Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
16:08:27 [2019-10-22T16:08:27.821Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
16:08:29 [2019-10-22T16:08:29.877Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
16:08:30 [2019-10-22T16:08:30.897Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
16:08:30 [2019-10-22T16:08:30.897Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
16:08:31 [2019-10-22T16:08:31.524Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
16:08:32 [2019-10-22T16:08:32.152Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
16:08:34 [2019-10-22T16:08:34.210Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
16:08:34 [2019-10-22T16:08:34.834Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
16:08:35 [2019-10-22T16:08:35.123Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
16:08:37 [2019-10-22T16:08:37.812Z] --- PASS: TestDaemonRestartKillContainers (0.00s)
16:08:37 [2019-10-22T16:08:37.812Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon (2.08s)
16:08:37 [2019-10-22T16:08:37.812Z]         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"
16:08:37 [2019-10-22T16:08:37.812Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon (3.40s)
16:08:37 [2019-10-22T16:08:37.812Z]         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"
16:08:37 [2019-10-22T16:08:37.812Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon (3.40s)
16:08:37 [2019-10-22T16:08:37.812Z]         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"
16:08:37 [2019-10-22T16:08:37.812Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon (1.96s)
16:08:37 [2019-10-22T16:08:37.812Z]         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"
16:08:37 [2019-10-22T16:08:37.812Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon (4.43s)
16:08:37 [2019-10-22T16:08:37.812Z]         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"
16:08:37 [2019-10-22T16:08:37.812Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon (3.17s)
16:08:37 [2019-10-22T16:08:37.812Z]         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"
16:08:37 [2019-10-22T16:08:37.812Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon (3.32s)
16:08:37 [2019-10-22T16:08:37.812Z]         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"
16:08:37 [2019-10-22T16:08:37.812Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon (3.22s)
16:08:37 [2019-10-22T16:08:37.812Z]         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"
16:08:37 [2019-10-22T16:08:37.812Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon (4.44s)
16:08:37 [2019-10-22T16:08:37.812Z]         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"
16:08:37 [2019-10-22T16:08:37.812Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon (1.88s)
16:08:37 [2019-10-22T16:08:37.812Z]         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"
16:08:37 [2019-10-22T16:08:37.812Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon (1.66s)
16:08:37 [2019-10-22T16:08:37.812Z]         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"
16:08:37 [2019-10-22T16:08:37.812Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon (2.27s)
16:08:37 [2019-10-22T16:08:37.812Z]         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"
16:08:37 [2019-10-22T16:08:37.812Z] === RUN   TestCgroupNamespacesRun
16:08:39 [2019-10-22T16:08:39.287Z] --- PASS: TestCgroupNamespacesRun (1.72s)
16:08:39 [2019-10-22T16:08:39.288Z]     run_cgroupns_linux_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRun"
16:08:39 [2019-10-22T16:08:39.288Z] === RUN   TestCgroupNamespacesRunPrivileged
16:08:41 [2019-10-22T16:08:41.315Z] --- PASS: TestCgroupNamespacesRunPrivileged (1.71s)
16:08:41 [2019-10-22T16:08:41.315Z]     run_cgroupns_linux_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunPrivileged"
16:08:41 [2019-10-22T16:08:41.315Z] === RUN   TestCgroupNamespacesRunDaemonHostMode
16:08:42 [2019-10-22T16:08:42.795Z] --- PASS: TestCgroupNamespacesRunDaemonHostMode (1.71s)
16:08:42 [2019-10-22T16:08:42.795Z]     run_cgroupns_linux_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunDaemonHostMode"
16:08:42 [2019-10-22T16:08:42.795Z] === RUN   TestCgroupNamespacesRunHostMode
16:08:44 [2019-10-22T16:08:44.278Z] --- PASS: TestCgroupNamespacesRunHostMode (1.68s)
16:08:44 [2019-10-22T16:08:44.278Z]     run_cgroupns_linux_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunHostMode"
16:08:44 [2019-10-22T16:08:44.278Z] === RUN   TestCgroupNamespacesRunPrivateMode
16:08:46 [2019-10-22T16:08:46.338Z] --- PASS: TestCgroupNamespacesRunPrivateMode (1.72s)
16:08:46 [2019-10-22T16:08:46.338Z]     run_cgroupns_linux_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunPrivateMode"
16:08:46 [2019-10-22T16:08:46.338Z] === RUN   TestCgroupNamespacesRunPrivilegedAndPrivate
16:08:46 [2019-10-22T16:08:46.956Z] --- PASS: TestCgroupNamespacesRunPrivilegedAndPrivate (0.89s)
16:08:46 [2019-10-22T16:08:46.957Z]     run_cgroupns_linux_test.go:48: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunPrivilegedAndPrivate"
16:08:46 [2019-10-22T16:08:46.957Z] === RUN   TestCgroupNamespacesRunInvalidMode
16:08:47 [2019-10-22T16:08:47.967Z] --- PASS: TestCgroupNamespacesRunInvalidMode (0.91s)
16:08:47 [2019-10-22T16:08:47.967Z]     run_cgroupns_linux_test.go:48: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunInvalidMode"
16:08:47 [2019-10-22T16:08:47.967Z] === RUN   TestCgroupNamespacesRunOlderClient
16:08:49 [2019-10-22T16:08:49.993Z] --- PASS: TestCgroupNamespacesRunOlderClient (1.73s)
16:08:49 [2019-10-22T16:08:49.993Z]     run_cgroupns_linux_test.go:139: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunOlderClient"
16:08:49 [2019-10-22T16:08:49.993Z] === RUN   TestKernelTCPMemory
16:08:50 [2019-10-22T16:08:50.610Z] --- PASS: TestKernelTCPMemory (0.90s)
16:08:50 [2019-10-22T16:08:50.610Z] === RUN   TestNISDomainname
16:08:51 [2019-10-22T16:08:51.637Z] --- PASS: TestNISDomainname (1.07s)
16:08:51 [2019-10-22T16:08:51.637Z] === RUN   TestHostnameDnsResolution
16:08:52 [2019-10-22T16:08:52.645Z] --- PASS: TestHostnameDnsResolution (1.13s)
16:08:52 [2019-10-22T16:08:52.645Z] === RUN   TestStats
16:08:55 [2019-10-22T16:08:55.320Z] --- PASS: TestStats (2.43s)
16:08:55 [2019-10-22T16:08:55.320Z] === RUN   TestStopContainerWithTimeout
16:08:55 [2019-10-22T16:08:55.320Z] === RUN   TestStopContainerWithTimeout/0
16:08:55 [2019-10-22T16:08:55.320Z] === PAUSE TestStopContainerWithTimeout/0
16:08:55 [2019-10-22T16:08:55.320Z] === RUN   TestStopContainerWithTimeout/1
16:08:55 [2019-10-22T16:08:55.320Z] === PAUSE TestStopContainerWithTimeout/1
16:08:55 [2019-10-22T16:08:55.320Z] === RUN   TestStopContainerWithTimeout/3
16:08:55 [2019-10-22T16:08:55.320Z] === PAUSE TestStopContainerWithTimeout/3
16:08:55 [2019-10-22T16:08:55.320Z] === RUN   TestStopContainerWithTimeout/-1
16:08:55 [2019-10-22T16:08:55.320Z] === PAUSE TestStopContainerWithTimeout/-1
16:08:55 [2019-10-22T16:08:55.320Z] === CONT  TestStopContainerWithTimeout/0
16:08:55 [2019-10-22T16:08:55.320Z] === CONT  TestStopContainerWithTimeout/3
16:08:55 [2019-10-22T16:08:55.320Z] === CONT  TestStopContainerWithTimeout/1
16:08:55 [2019-10-22T16:08:55.320Z] === CONT  TestStopContainerWithTimeout/-1
16:08:58 [2019-10-22T16:08:58.795Z] --- PASS: TestStopContainerWithTimeout (0.03s)
16:08:58 [2019-10-22T16:08:58.795Z]     --- PASS: TestStopContainerWithTimeout/0 (1.15s)
16:08:58 [2019-10-22T16:08:58.795Z]     --- PASS: TestStopContainerWithTimeout/1 (2.26s)
16:08:58 [2019-10-22T16:08:58.795Z]     --- PASS: TestStopContainerWithTimeout/3 (3.32s)
16:08:58 [2019-10-22T16:08:58.795Z]     --- PASS: TestStopContainerWithTimeout/-1 (3.38s)
16:08:58 [2019-10-22T16:08:58.795Z] === RUN   TestDeleteDevicemapper
16:08:58 [2019-10-22T16:08:58.795Z] --- SKIP: TestDeleteDevicemapper (0.00s)
16:08:58 [2019-10-22T16:08:58.795Z]     stop_linux_test.go:74: testEnv.DaemonInfo.Driver != "devicemapper"
16:08:58 [2019-10-22T16:08:58.795Z] === RUN   TestStopContainerWithRestartPolicyAlways
16:09:01 [2019-10-22T16:09:01.490Z] --- PASS: TestStopContainerWithRestartPolicyAlways (2.96s)
16:09:01 [2019-10-22T16:09:01.490Z] === RUN   TestUpdateMemory
16:09:02 [2019-10-22T16:09:02.522Z] --- PASS: TestUpdateMemory (1.14s)
16:09:02 [2019-10-22T16:09:02.522Z] === RUN   TestUpdateCPUQuota
16:09:03 [2019-10-22T16:09:03.996Z] --- PASS: TestUpdateCPUQuota (1.47s)
16:09:03 [2019-10-22T16:09:03.996Z] === RUN   TestUpdatePidsLimit
16:09:03 [2019-10-22T16:09:03.996Z] === RUN   TestUpdatePidsLimit/update_from_none
16:09:04 [2019-10-22T16:09:04.615Z] === RUN   TestUpdatePidsLimit/no_change
16:09:04 [2019-10-22T16:09:04.898Z] === RUN   TestUpdatePidsLimit/update_lower
16:09:05 [2019-10-22T16:09:05.184Z] === RUN   TestUpdatePidsLimit/update_on_old_api_ignores_value
16:09:05 [2019-10-22T16:09:05.801Z] === RUN   TestUpdatePidsLimit/unset_limit_with_zero
16:09:06 [2019-10-22T16:09:06.085Z] === RUN   TestUpdatePidsLimit/unset_limit_with_minus_one
16:09:06 [2019-10-22T16:09:06.368Z] === RUN   TestUpdatePidsLimit/unset_limit_with_minus_two
16:09:08 [2019-10-22T16:09:08.395Z] --- PASS: TestUpdatePidsLimit (3.94s)
16:09:08 [2019-10-22T16:09:08.395Z]     --- PASS: TestUpdatePidsLimit/update_from_none (0.36s)
16:09:08 [2019-10-22T16:09:08.395Z]     --- PASS: TestUpdatePidsLimit/no_change (0.39s)
16:09:08 [2019-10-22T16:09:08.395Z]     --- PASS: TestUpdatePidsLimit/update_lower (0.37s)
16:09:08 [2019-10-22T16:09:08.395Z]     --- PASS: TestUpdatePidsLimit/update_on_old_api_ignores_value (0.40s)
16:09:08 [2019-10-22T16:09:08.395Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_zero (0.38s)
16:09:08 [2019-10-22T16:09:08.395Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_minus_one (0.37s)
16:09:08 [2019-10-22T16:09:08.395Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_minus_two (0.39s)
16:09:08 [2019-10-22T16:09:08.395Z] === RUN   TestUpdateRestartPolicy
16:09:20 [2019-10-22T16:09:20.921Z] --- PASS: TestUpdateRestartPolicy (12.07s)
16:09:20 [2019-10-22T16:09:20.921Z] === RUN   TestUpdateRestartWithAutoRemove
16:09:20 [2019-10-22T16:09:20.921Z] --- PASS: TestUpdateRestartWithAutoRemove (0.73s)
16:09:20 [2019-10-22T16:09:20.921Z] === RUN   TestWaitNonBlocked
16:09:20 [2019-10-22T16:09:20.921Z] === RUN   TestWaitNonBlocked/wait-nonblocking-exit-0
16:09:20 [2019-10-22T16:09:20.921Z] === PAUSE TestWaitNonBlocked/wait-nonblocking-exit-0
16:09:20 [2019-10-22T16:09:20.921Z] === RUN   TestWaitNonBlocked/wait-nonblocking-exit-random
16:09:20 [2019-10-22T16:09:20.921Z] === PAUSE TestWaitNonBlocked/wait-nonblocking-exit-random
16:09:20 [2019-10-22T16:09:20.921Z] === CONT  TestWaitNonBlocked/wait-nonblocking-exit-0
16:09:20 [2019-10-22T16:09:20.921Z] === CONT  TestWaitNonBlocked/wait-nonblocking-exit-random
16:09:21 [2019-10-22T16:09:21.931Z] --- PASS: TestWaitNonBlocked (0.03s)
16:09:21 [2019-10-22T16:09:21.931Z]     --- PASS: TestWaitNonBlocked/wait-nonblocking-exit-0 (0.88s)
16:09:21 [2019-10-22T16:09:21.931Z]     --- PASS: TestWaitNonBlocked/wait-nonblocking-exit-random (0.91s)
16:09:21 [2019-10-22T16:09:21.931Z] === RUN   TestWaitBlocked
16:09:21 [2019-10-22T16:09:21.931Z] === RUN   TestWaitBlocked/test-wait-blocked-exit-zero
16:09:21 [2019-10-22T16:09:21.931Z] === PAUSE TestWaitBlocked/test-wait-blocked-exit-zero
16:09:21 [2019-10-22T16:09:21.931Z] === RUN   TestWaitBlocked/test-wait-blocked-exit-random
16:09:21 [2019-10-22T16:09:21.931Z] === PAUSE TestWaitBlocked/test-wait-blocked-exit-random
16:09:21 [2019-10-22T16:09:21.931Z] === CONT  TestWaitBlocked/test-wait-blocked-exit-zero
16:09:21 [2019-10-22T16:09:21.931Z] === CONT  TestWaitBlocked/test-wait-blocked-exit-random
16:09:22 [2019-10-22T16:09:22.950Z] --- PASS: TestWaitBlocked (0.03s)
16:09:22 [2019-10-22T16:09:22.950Z]     --- PASS: TestWaitBlocked/test-wait-blocked-exit-zero (1.01s)
16:09:22 [2019-10-22T16:09:22.950Z]     --- PASS: TestWaitBlocked/test-wait-blocked-exit-random (1.07s)
16:09:22 [2019-10-22T16:09:22.950Z] === CONT  TestContainerStartOnDaemonRestart
16:09:22 [2019-10-22T16:09:22.950Z] === CONT  TestDaemonRestartIpcMode
16:09:22 [2019-10-22T16:09:22.950Z] === CONT  TestIpcModeOlderClient
16:09:22 [2019-10-22T16:09:22.950Z] --- PASS: TestIpcModeOlderClient (0.15s)
16:09:26 [2019-10-22T16:09:26.437Z] --- PASS: TestContainerStartOnDaemonRestart (3.20s)
16:09:26 [2019-10-22T16:09:26.437Z]     daemon_linux_test.go:35: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestContainerStartOnDaemonRestart"
16:09:26 [2019-10-22T16:09:26.722Z] --- PASS: TestDaemonRestartIpcMode (3.96s)
16:09:26 [2019-10-22T16:09:26.723Z]     daemon_linux_test.go:89: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartIpcMode"
16:09:26 [2019-10-22T16:09:26.723Z] PASS
16:09:26 [2019-10-22T16:09:26.723Z] 
16:09:26 [2019-10-22T16:09:26.723Z] === Skipped
16:09:26 [2019-10-22T16:09:26.723Z] === SKIP: ppc64le.integration.container TestCheckpoint (0.00s)
16:09:26 [2019-10-22T16:09:26.723Z]     checkpoint_test.go:33: TestCheckpoint is broken; see https://github.com/moby/moby/issues/38963
16:09:26 [2019-10-22T16:09:26.723Z] 
16:09:26 [2019-10-22T16:09:26.723Z] === SKIP: ppc64le.integration.container TestPauseFailsOnWindowsServerContainers (0.00s)
16:09:26 [2019-10-22T16:09:26.723Z]     pause_test.go:54: testEnv.DaemonInfo.OSType != "windows" || testEnv.DaemonInfo.Isolation != "process"
16:09:26 [2019-10-22T16:09:26.723Z] 
16:09:26 [2019-10-22T16:09:26.723Z] === SKIP: ppc64le.integration.container TestDeleteDevicemapper (0.00s)
16:09:26 [2019-10-22T16:09:26.723Z]     stop_linux_test.go:74: testEnv.DaemonInfo.Driver != "devicemapper"
16:09:26 [2019-10-22T16:09:26.723Z] 
16:09:26 [2019-10-22T16:09:26.723Z] 
16:09:26 [2019-10-22T16:09:26.723Z] DONE 197 tests, 3 skipped in 120.718s
16:09:26 [2019-10-22T16:09:26.723Z] Running /go/src/github.com/docker/docker/integration/image (ppc64le.integration.image) flags=-test.v -test.timeout=120m 
16:09:26 [2019-10-22T16:09:26.723Z] ++ 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
16:09:26 [2019-10-22T16:09:26.723Z] ++ set -e
16:09:26 [2019-10-22T16:09:26.723Z] ++ '[' -n 0 ']'
16:09:26 [2019-10-22T16:09:26.723Z] ++ set -x
16:09:26 [2019-10-22T16:09:26.723Z] ++ 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
16:09:27 [2019-10-22T16:09:27.033Z] INFO: Testing against a local daemon
16:09:27 [2019-10-22T16:09:27.033Z] === RUN   TestCommitInheritsEnv
16:09:27 [2019-10-22T16:09:27.317Z] --- PASS: TestCommitInheritsEnv (0.44s)
16:09:27 [2019-10-22T16:09:27.317Z] === RUN   TestImportExtremelyLargeImageWorks
16:09:27 [2019-10-22T16:09:27.317Z] === PAUSE TestImportExtremelyLargeImageWorks
16:09:27 [2019-10-22T16:09:27.317Z] === RUN   TestImagesFilterMultiReference
16:09:27 [2019-10-22T16:09:27.600Z] --- PASS: TestImagesFilterMultiReference (0.07s)
16:09:27 [2019-10-22T16:09:27.600Z] === RUN   TestImagePullPlatformInvalid
16:09:27 [2019-10-22T16:09:27.600Z] --- PASS: TestImagePullPlatformInvalid (0.05s)
16:09:27 [2019-10-22T16:09:27.600Z] === RUN   TestRemoveImageOrphaning
16:09:27 [2019-10-22T16:09:27.884Z] --- PASS: TestRemoveImageOrphaning (0.39s)
16:09:27 [2019-10-22T16:09:27.884Z] === RUN   TestRemoveImageGarbageCollector
16:09:27 [2019-10-22T16:09:27.884Z] --- SKIP: TestRemoveImageGarbageCollector (0.00s)
16:09:27 [2019-10-22T16:09:27.884Z]     remove_unix_test.go:36: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
16:09:27 [2019-10-22T16:09:27.884Z] === RUN   TestTagUnprefixedRepoByNameOrName
16:09:27 [2019-10-22T16:09:27.884Z] --- PASS: TestTagUnprefixedRepoByNameOrName (0.04s)
16:09:27 [2019-10-22T16:09:27.884Z] === RUN   TestTagInvalidReference
16:09:28 [2019-10-22T16:09:28.168Z] --- PASS: TestTagInvalidReference (0.04s)
16:09:28 [2019-10-22T16:09:28.168Z] === RUN   TestTagValidPrefixedRepo
16:09:28 [2019-10-22T16:09:28.168Z] --- PASS: TestTagValidPrefixedRepo (0.05s)
16:09:28 [2019-10-22T16:09:28.168Z] === RUN   TestTagExistedNameWithoutForce
16:09:28 [2019-10-22T16:09:28.168Z] --- PASS: TestTagExistedNameWithoutForce (0.05s)
16:09:28 [2019-10-22T16:09:28.168Z] === RUN   TestTagOfficialNames
16:09:28 [2019-10-22T16:09:28.168Z] --- PASS: TestTagOfficialNames (0.06s)
16:09:28 [2019-10-22T16:09:28.168Z] === RUN   TestTagMatchesDigest
16:09:28 [2019-10-22T16:09:28.168Z] --- PASS: TestTagMatchesDigest (0.03s)
16:09:28 [2019-10-22T16:09:28.168Z] === CONT  TestImportExtremelyLargeImageWorks
16:14:35 [2019-10-22T16:14:35.665Z] --- PASS: TestImportExtremelyLargeImageWorks (300.37s)
16:14:35 [2019-10-22T16:14:35.665Z]     import_test.go:26: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestImportExtremelyLargeImageWorks"
16:14:35 [2019-10-22T16:14:35.665Z] PASS
16:14:35 [2019-10-22T16:14:35.665Z] 
16:14:35 [2019-10-22T16:14:35.665Z] === Skipped
16:14:35 [2019-10-22T16:14:35.665Z] === SKIP: ppc64le.integration.image TestRemoveImageGarbageCollector (0.00s)
16:14:35 [2019-10-22T16:14:35.665Z]     remove_unix_test.go:36: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
16:14:35 [2019-10-22T16:14:35.665Z] 
16:14:35 [2019-10-22T16:14:35.665Z] 
16:14:35 [2019-10-22T16:14:35.665Z] DONE 12 tests, 1 skipped in 301.716s
16:14:35 [2019-10-22T16:14:35.665Z] Running /go/src/github.com/docker/docker/integration/network (ppc64le.integration.network) flags=-test.v -test.timeout=120m 
16:14:35 [2019-10-22T16:14:35.665Z] ++ 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
16:14:35 [2019-10-22T16:14:35.665Z] ++ set -e
16:14:35 [2019-10-22T16:14:35.665Z] ++ '[' -n 0 ']'
16:14:35 [2019-10-22T16:14:35.665Z] ++ set -x
16:14:35 [2019-10-22T16:14:35.665Z] ++ 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
16:14:35 [2019-10-22T16:14:35.665Z] INFO: Testing against a local daemon
16:14:35 [2019-10-22T16:14:35.665Z] === RUN   TestNetworkCreateDelete
16:14:35 [2019-10-22T16:14:35.665Z] --- PASS: TestNetworkCreateDelete (0.22s)
16:14:35 [2019-10-22T16:14:35.665Z] === RUN   TestDockerNetworkDeletePreferID
16:14:35 [2019-10-22T16:14:35.665Z] --- PASS: TestDockerNetworkDeletePreferID (0.56s)
16:14:35 [2019-10-22T16:14:35.665Z] === RUN   TestInspectNetwork
16:14:35 [2019-10-22T16:14:35.665Z] === RUN   TestInspectNetwork/full_network_id
16:14:35 [2019-10-22T16:14:35.665Z] === RUN   TestInspectNetwork/partial_network_id
16:14:35 [2019-10-22T16:14:35.665Z] === RUN   TestInspectNetwork/network_name
16:14:35 [2019-10-22T16:14:35.665Z] === RUN   TestInspectNetwork/network_name_and_swarm_scope
16:14:37 [2019-10-22T16:14:37.696Z] --- PASS: TestInspectNetwork (8.33s)
16:14:37 [2019-10-22T16:14:37.696Z]     inspect_test.go:18: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestInspectNetwork"
16:14:37 [2019-10-22T16:14:37.696Z]     --- PASS: TestInspectNetwork/full_network_id (0.01s)
16:14:37 [2019-10-22T16:14:37.696Z]     --- PASS: TestInspectNetwork/partial_network_id (0.00s)
16:14:37 [2019-10-22T16:14:37.696Z]     --- PASS: TestInspectNetwork/network_name (0.00s)
16:14:37 [2019-10-22T16:14:37.696Z]     --- PASS: TestInspectNetwork/network_name_and_swarm_scope (0.00s)
16:14:37 [2019-10-22T16:14:37.696Z] === RUN   TestRunContainerWithBridgeNone
16:14:40 [2019-10-22T16:14:40.384Z] --- PASS: TestRunContainerWithBridgeNone (2.60s)
16:14:40 [2019-10-22T16:14:40.384Z]     network_test.go:25: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestRunContainerWithBridgeNone"
16:14:40 [2019-10-22T16:14:40.384Z] === RUN   TestNetworkInvalidJSON
16:14:40 [2019-10-22T16:14:40.384Z] === RUN   TestNetworkInvalidJSON//networks/create
16:14:40 [2019-10-22T16:14:40.384Z] === PAUSE TestNetworkInvalidJSON//networks/create
16:14:40 [2019-10-22T16:14:40.384Z] === RUN   TestNetworkInvalidJSON//networks/bridge/connect
16:14:40 [2019-10-22T16:14:40.384Z] === PAUSE TestNetworkInvalidJSON//networks/bridge/connect
16:14:40 [2019-10-22T16:14:40.384Z] === RUN   TestNetworkInvalidJSON//networks/bridge/disconnect
16:14:40 [2019-10-22T16:14:40.384Z] === PAUSE TestNetworkInvalidJSON//networks/bridge/disconnect
16:14:40 [2019-10-22T16:14:40.384Z] === CONT  TestNetworkInvalidJSON//networks/create
16:14:40 [2019-10-22T16:14:40.384Z] === CONT  TestNetworkInvalidJSON//networks/bridge/disconnect
16:14:40 [2019-10-22T16:14:40.384Z] === CONT  TestNetworkInvalidJSON//networks/bridge/connect
16:14:40 [2019-10-22T16:14:40.384Z] --- PASS: TestNetworkInvalidJSON (0.04s)
16:14:40 [2019-10-22T16:14:40.384Z]     --- PASS: TestNetworkInvalidJSON//networks/create (0.00s)
16:14:40 [2019-10-22T16:14:40.384Z]     --- PASS: TestNetworkInvalidJSON//networks/bridge/disconnect (0.00s)
16:14:40 [2019-10-22T16:14:40.384Z]     --- PASS: TestNetworkInvalidJSON//networks/bridge/connect (0.00s)
16:14:40 [2019-10-22T16:14:40.384Z] === RUN   TestDaemonRestartWithLiveRestore
16:14:41 [2019-10-22T16:14:41.397Z] --- PASS: TestDaemonRestartWithLiveRestore (1.06s)
16:14:41 [2019-10-22T16:14:41.397Z]     service_test.go:32: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartWithLiveRestore"
16:14:41 [2019-10-22T16:14:41.397Z] === RUN   TestDaemonDefaultNetworkPools
16:14:42 [2019-10-22T16:14:42.411Z] --- PASS: TestDaemonDefaultNetworkPools (0.78s)
16:14:42 [2019-10-22T16:14:42.411Z]     service_test.go:57: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonDefaultNetworkPools"
16:14:42 [2019-10-22T16:14:42.411Z] === RUN   TestDaemonRestartWithExistingNetwork
16:14:43 [2019-10-22T16:14:43.425Z] --- PASS: TestDaemonRestartWithExistingNetwork (1.20s)
16:14:43 [2019-10-22T16:14:43.425Z]     service_test.go:98: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartWithExistingNetwork"
16:14:43 [2019-10-22T16:14:43.425Z] === RUN   TestDaemonRestartWithExistingNetworkWithDefaultPoolRange
16:14:44 [2019-10-22T16:14:44.907Z] --- PASS: TestDaemonRestartWithExistingNetworkWithDefaultPoolRange (1.46s)
16:14:44 [2019-10-22T16:14:44.907Z]     service_test.go:131: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartWithExistingNetworkWithDefaultPoolRange"
16:14:44 [2019-10-22T16:14:44.907Z] === RUN   TestDaemonWithBipAndDefaultNetworkPool
16:14:45 [2019-10-22T16:14:45.534Z] --- PASS: TestDaemonWithBipAndDefaultNetworkPool (0.61s)
16:14:45 [2019-10-22T16:14:45.534Z]     service_test.go:181: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonWithBipAndDefaultNetworkPool"
16:14:45 [2019-10-22T16:14:45.534Z] === RUN   TestServiceWithPredefinedNetwork
16:14:48 [2019-10-22T16:14:48.218Z] --- PASS: TestServiceWithPredefinedNetwork (2.44s)
16:14:48 [2019-10-22T16:14:48.219Z]     service_test.go:203: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithPredefinedNetwork"
16:14:48 [2019-10-22T16:14:48.219Z] === RUN   TestServiceRemoveKeepsIngressNetwork
16:14:48 [2019-10-22T16:14:48.219Z] --- SKIP: TestServiceRemoveKeepsIngressNetwork (0.00s)
16:14:48 [2019-10-22T16:14:48.219Z]     service_test.go:230: FLAKY_TEST
16:14:48 [2019-10-22T16:14:48.219Z] === RUN   TestServiceWithDataPathPortInit
16:15:06 [2019-10-22T16:15:06.681Z] --- PASS: TestServiceWithDataPathPortInit (15.65s)
16:15:06 [2019-10-22T16:15:06.681Z]     service_test.go:323: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithDataPathPortInit"
16:15:06 [2019-10-22T16:15:06.681Z]     service_test.go:355: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithDataPathPortInit"
16:15:06 [2019-10-22T16:15:06.681Z] === RUN   TestServiceWithDefaultAddressPoolInit
16:15:11 [2019-10-22T16:15:11.060Z] --- PASS: TestServiceWithDefaultAddressPoolInit (7.32s)
16:15:11 [2019-10-22T16:15:11.060Z]     service_test.go:388: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithDefaultAddressPoolInit"
16:15:11 [2019-10-22T16:15:11.060Z]     service_test.go:418: TestServiceWithDefaultAddressPoolInit: NetworkInspect: {Name:sthiraTestServiceWithDefaultAddressPoolInit ID:f3te69ync2jjr4z6taf6lqq9u Created:2019-10-22 16:15:04.764738329 +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[f09ebbfcf5c2ee0ab6e5aa6cfd248bf8ec1e2f6d9fcc9a6a7dc6eff0d2393989:{Name:TestServiceTestServiceWithDefaultAddressPoolInit.1.qrx368abzw9gwadck1w9upw4h EndpointID:14dc11d2597454c0c6c851b4137ee16dc7f202d713357bdf33f42f0acb163495 MacAddress:02:42:14:14:00:03 IPv4Address:20.20.0.3/24 IPv6Address:} lb-sthiraTestServiceWithDefaultAddressPoolInit:{Name:sthiraTestServiceWithDefaultAddressPoolInit-endpoint EndpointID:0798d4f6de440ab10ff794fcd64ba39f7c7f376ae54f0aeafc498a4e44d05a7a 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:1bf3e2373590 IP:127.0.0.1}] Services:map[TestServiceTestServiceWithDefaultAddressPoolInit:{VIP:20.20.0.2 Ports:[] LocalLBIndex:256 Tasks:[{Name:TestServiceTestServiceWithDefaultAddressPoolInit.1.qrx368abzw9gwadck1w9upw4h EndpointID:14dc11d2597454c0c6c851b4137ee16dc7f202d713357bdf33f42f0acb163495 EndpointIP:20.20.0.3 Info:map[Host IP:127.0.0.1]}]}]}
16:15:11 [2019-10-22T16:15:11.060Z] PASS
16:15:11 [2019-10-22T16:15:11.060Z] 
16:15:11 [2019-10-22T16:15:11.060Z] === Skipped
16:15:11 [2019-10-22T16:15:11.060Z] === SKIP: ppc64le.integration.network TestServiceRemoveKeepsIngressNetwork (0.00s)
16:15:11 [2019-10-22T16:15:11.060Z]     service_test.go:230: FLAKY_TEST
16:15:11 [2019-10-22T16:15:11.060Z] 
16:15:11 [2019-10-22T16:15:11.060Z] 
16:15:11 [2019-10-22T16:15:11.060Z] DONE 21 tests, 1 skipped in 42.351s
16:15:11 [2019-10-22T16:15:11.060Z] Running /go/src/github.com/docker/docker/integration/network/ipvlan (ppc64le.integration.network.ipvlan) flags=-test.v -test.timeout=120m 
16:15:11 [2019-10-22T16:15:11.060Z] ++ 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
16:15:11 [2019-10-22T16:15:11.060Z] ++ set -e
16:15:11 [2019-10-22T16:15:11.060Z] ++ '[' -n 0 ']'
16:15:11 [2019-10-22T16:15:11.060Z] ++ set -x
16:15:11 [2019-10-22T16:15:11.060Z] ++ 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
16:15:11 [2019-10-22T16:15:11.060Z] INFO: Testing against a local daemon
16:15:11 [2019-10-22T16:15:11.060Z] === RUN   TestDockerNetworkIpvlanPersistance
16:15:11 [2019-10-22T16:15:11.060Z] --- SKIP: TestDockerNetworkIpvlanPersistance (0.00s)
16:15:11 [2019-10-22T16:15:11.060Z]     ipvlan_test.go:26: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
16:15:11 [2019-10-22T16:15:11.060Z] === RUN   TestDockerNetworkIpvlan
16:15:11 [2019-10-22T16:15:11.060Z] --- SKIP: TestDockerNetworkIpvlan (0.00s)
16:15:11 [2019-10-22T16:15:11.060Z]     ipvlan_test.go:53: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
16:15:11 [2019-10-22T16:15:11.060Z] PASS
16:15:11 [2019-10-22T16:15:11.060Z] 
16:15:11 [2019-10-22T16:15:11.060Z] === Skipped
16:15:11 [2019-10-22T16:15:11.060Z] === SKIP: ppc64le.integration.network.ipvlan TestDockerNetworkIpvlanPersistance (0.00s)
16:15:11 [2019-10-22T16:15:11.060Z]     ipvlan_test.go:26: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
16:15:11 [2019-10-22T16:15:11.060Z] 
16:15:11 [2019-10-22T16:15:11.061Z] === SKIP: ppc64le.integration.network.ipvlan TestDockerNetworkIpvlan (0.00s)
16:15:11 [2019-10-22T16:15:11.061Z]     ipvlan_test.go:53: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
16:15:11 [2019-10-22T16:15:11.061Z] 
16:15:11 [2019-10-22T16:15:11.061Z] 
16:15:11 [2019-10-22T16:15:11.061Z] DONE 2 tests, 2 skipped in 0.106s
16:15:11 [2019-10-22T16:15:11.061Z] Running /go/src/github.com/docker/docker/integration/network/macvlan (ppc64le.integration.network.macvlan) flags=-test.v -test.timeout=120m 
16:15:11 [2019-10-22T16:15:11.061Z] ++ 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
16:15:11 [2019-10-22T16:15:11.061Z] ++ set -e
16:15:11 [2019-10-22T16:15:11.061Z] ++ '[' -n 0 ']'
16:15:11 [2019-10-22T16:15:11.061Z] ++ set -x
16:15:11 [2019-10-22T16:15:11.061Z] ++ 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
16:15:11 [2019-10-22T16:15:11.061Z] INFO: Testing against a local daemon
16:15:11 [2019-10-22T16:15:11.061Z] === RUN   TestDockerNetworkMacvlanPersistance
16:15:13 [2019-10-22T16:15:13.091Z] --- PASS: TestDockerNetworkMacvlanPersistance (1.49s)
16:15:13 [2019-10-22T16:15:13.091Z]     macvlan_test.go:24: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlanPersistance"
16:15:13 [2019-10-22T16:15:13.091Z] === RUN   TestDockerNetworkMacvlan
16:15:13 [2019-10-22T16:15:13.709Z] === RUN   TestDockerNetworkMacvlan/Subinterface
16:15:14 [2019-10-22T16:15:14.721Z] === RUN   TestDockerNetworkMacvlan/OverlapParent
16:15:15 [2019-10-22T16:15:15.737Z] === RUN   TestDockerNetworkMacvlan/NilParent
16:15:18 [2019-10-22T16:15:18.430Z] === RUN   TestDockerNetworkMacvlan/InternalMode
16:15:21 [2019-10-22T16:15:21.889Z] === RUN   TestDockerNetworkMacvlan/MultiSubnet
16:15:26 [2019-10-22T16:15:26.282Z] === RUN   TestDockerNetworkMacvlan/Addressing
16:15:27 [2019-10-22T16:15:27.761Z] --- PASS: TestDockerNetworkMacvlan (14.94s)
16:15:27 [2019-10-22T16:15:27.761Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
16:15:27 [2019-10-22T16:15:27.761Z]     --- PASS: TestDockerNetworkMacvlan/Subinterface (0.07s)
16:15:27 [2019-10-22T16:15:27.761Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
16:15:27 [2019-10-22T16:15:27.761Z]     --- PASS: TestDockerNetworkMacvlan/OverlapParent (0.09s)
16:15:27 [2019-10-22T16:15:27.761Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
16:15:27 [2019-10-22T16:15:27.761Z]     --- PASS: TestDockerNetworkMacvlan/NilParent (1.19s)
16:15:27 [2019-10-22T16:15:27.761Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
16:15:27 [2019-10-22T16:15:27.761Z]     --- PASS: TestDockerNetworkMacvlan/InternalMode (2.17s)
16:15:27 [2019-10-22T16:15:27.761Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
16:15:27 [2019-10-22T16:15:27.761Z]     --- PASS: TestDockerNetworkMacvlan/MultiSubnet (3.15s)
16:15:27 [2019-10-22T16:15:27.761Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
16:15:27 [2019-10-22T16:15:27.761Z]     --- PASS: TestDockerNetworkMacvlan/Addressing (0.94s)
16:15:27 [2019-10-22T16:15:27.761Z] PASS
16:15:27 [2019-10-22T16:15:27.761Z] 
16:15:27 [2019-10-22T16:15:27.761Z] DONE 8 tests in 16.524s
16:15:27 [2019-10-22T16:15:27.761Z] Running /go/src/github.com/docker/docker/integration/plugin (ppc64le.integration.plugin) flags=-test.v -test.timeout=120m 
16:15:27 [2019-10-22T16:15:27.761Z] ++ 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
16:15:27 [2019-10-22T16:15:27.761Z] ++ set -e
16:15:27 [2019-10-22T16:15:27.761Z] ++ '[' -n 0 ']'
16:15:27 [2019-10-22T16:15:27.761Z] ++ set -x
16:15:27 [2019-10-22T16:15:27.761Z] ++ 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
16:15:27 [2019-10-22T16:15:27.761Z] testing: warning: no tests to run
16:15:27 [2019-10-22T16:15:27.761Z] PASS
16:15:27 [2019-10-22T16:15:27.761Z] 
16:15:27 [2019-10-22T16:15:27.761Z] DONE 0 tests in 0.014s
16:15:27 [2019-10-22T16:15:27.761Z] Running /go/src/github.com/docker/docker/integration/plugin/authz (ppc64le.integration.plugin.authz) flags=-test.v -test.timeout=120m 
16:15:27 [2019-10-22T16:15:27.761Z] ++ 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
16:15:27 [2019-10-22T16:15:27.761Z] ++ set -e
16:15:27 [2019-10-22T16:15:27.761Z] ++ '[' -n 0 ']'
16:15:27 [2019-10-22T16:15:27.761Z] ++ set -x
16:15:27 [2019-10-22T16:15:27.761Z] ++ 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
16:15:27 [2019-10-22T16:15:27.761Z] INFO: Testing against a local daemon
16:15:27 [2019-10-22T16:15:27.761Z] === RUN   TestAuthZPluginAllowRequest
16:15:29 [2019-10-22T16:15:29.797Z] --- PASS: TestAuthZPluginAllowRequest (1.65s)
16:15:29 [2019-10-22T16:15:29.797Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginAllowRequest"
16:15:29 [2019-10-22T16:15:29.797Z] === RUN   TestAuthZPluginTLS
16:15:30 [2019-10-22T16:15:30.081Z] --- PASS: TestAuthZPluginTLS (0.58s)
16:15:30 [2019-10-22T16:15:30.081Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginTLS"
16:15:30 [2019-10-22T16:15:30.081Z] === RUN   TestAuthZPluginDenyRequest
16:15:30 [2019-10-22T16:15:30.697Z] --- PASS: TestAuthZPluginDenyRequest (0.56s)
16:15:30 [2019-10-22T16:15:30.697Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginDenyRequest"
16:15:30 [2019-10-22T16:15:30.697Z] === RUN   TestAuthZPluginAPIDenyResponse
16:15:31 [2019-10-22T16:15:31.315Z] --- PASS: TestAuthZPluginAPIDenyResponse (0.58s)
16:15:31 [2019-10-22T16:15:31.315Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginAPIDenyResponse"
16:15:31 [2019-10-22T16:15:31.315Z] === RUN   TestAuthZPluginDenyResponse
16:15:31 [2019-10-22T16:15:31.599Z] --- PASS: TestAuthZPluginDenyResponse (0.57s)
16:15:31 [2019-10-22T16:15:31.599Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginDenyResponse"
16:15:31 [2019-10-22T16:15:31.599Z] === RUN   TestAuthZPluginAllowEventStream
16:15:33 [2019-10-22T16:15:33.628Z] --- PASS: TestAuthZPluginAllowEventStream (1.63s)
16:15:33 [2019-10-22T16:15:33.628Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginAllowEventStream"
16:15:33 [2019-10-22T16:15:33.628Z] === RUN   TestAuthZPluginErrorResponse
16:15:33 [2019-10-22T16:15:33.911Z] --- PASS: TestAuthZPluginErrorResponse (0.57s)
16:15:33 [2019-10-22T16:15:33.911Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginErrorResponse"
16:15:33 [2019-10-22T16:15:33.911Z] === RUN   TestAuthZPluginErrorRequest
16:15:34 [2019-10-22T16:15:34.529Z] --- PASS: TestAuthZPluginErrorRequest (0.58s)
16:15:34 [2019-10-22T16:15:34.529Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginErrorRequest"
16:15:34 [2019-10-22T16:15:34.529Z] === RUN   TestAuthZPluginEnsureNoDuplicatePluginRegistration
16:15:35 [2019-10-22T16:15:35.148Z] --- PASS: TestAuthZPluginEnsureNoDuplicatePluginRegistration (0.58s)
16:15:35 [2019-10-22T16:15:35.148Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginEnsureNoDuplicatePluginRegistration"
16:15:35 [2019-10-22T16:15:35.148Z] === RUN   TestAuthZPluginEnsureLoadImportWorking
16:15:37 [2019-10-22T16:15:37.183Z] --- PASS: TestAuthZPluginEnsureLoadImportWorking (2.11s)
16:15:37 [2019-10-22T16:15:37.183Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginEnsureLoadImportWorking"
16:15:37 [2019-10-22T16:15:37.183Z] === RUN   TestAuthzPluginEnsureContainerCopyToFrom
16:15:39 [2019-10-22T16:15:39.215Z] --- PASS: TestAuthzPluginEnsureContainerCopyToFrom (2.09s)
16:15:39 [2019-10-22T16:15:39.215Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthzPluginEnsureContainerCopyToFrom"
16:15:39 [2019-10-22T16:15:39.215Z] === RUN   TestAuthZPluginHeader
16:15:40 [2019-10-22T16:15:40.225Z] --- PASS: TestAuthZPluginHeader (0.95s)
16:15:40 [2019-10-22T16:15:40.225Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginHeader"
16:15:40 [2019-10-22T16:15:40.225Z] === RUN   TestAuthZPluginV2AllowNonVolumeRequest
16:15:40 [2019-10-22T16:15:40.225Z] --- SKIP: TestAuthZPluginV2AllowNonVolumeRequest (0.00s)
16:15:40 [2019-10-22T16:15:40.225Z]     authz_plugin_v2_test.go:43: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
16:15:40 [2019-10-22T16:15:40.225Z] === RUN   TestAuthZPluginV2Disable
16:15:40 [2019-10-22T16:15:40.225Z] --- SKIP: TestAuthZPluginV2Disable (0.00s)
16:15:40 [2019-10-22T16:15:40.225Z]     authz_plugin_v2_test.go:65: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
16:15:40 [2019-10-22T16:15:40.225Z] === RUN   TestAuthZPluginV2RejectVolumeRequests
16:15:40 [2019-10-22T16:15:40.225Z] --- SKIP: TestAuthZPluginV2RejectVolumeRequests (0.00s)
16:15:40 [2019-10-22T16:15:40.225Z]     authz_plugin_v2_test.go:91: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
16:15:40 [2019-10-22T16:15:40.225Z] === RUN   TestAuthZPluginV2BadManifestFailsDaemonStart
16:15:40 [2019-10-22T16:15:40.225Z] --- SKIP: TestAuthZPluginV2BadManifestFailsDaemonStart (0.00s)
16:15:40 [2019-10-22T16:15:40.225Z]     authz_plugin_v2_test.go:126: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
16:15:40 [2019-10-22T16:15:40.225Z] === RUN   TestAuthZPluginV2NonexistentFailsDaemonStart
16:15:58 [2019-10-22T16:15:58.673Z] --- PASS: TestAuthZPluginV2NonexistentFailsDaemonStart (16.87s)
16:15:58 [2019-10-22T16:15:58.673Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginV2NonexistentFailsDaemonStart"
16:15:58 [2019-10-22T16:15:58.673Z] PASS
16:15:58 [2019-10-22T16:15:58.673Z] 
16:15:58 [2019-10-22T16:15:58.673Z] === Skipped
16:15:58 [2019-10-22T16:15:58.673Z] === SKIP: ppc64le.integration.plugin.authz TestAuthZPluginV2AllowNonVolumeRequest (0.00s)
16:15:58 [2019-10-22T16:15:58.673Z]     authz_plugin_v2_test.go:43: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
16:15:58 [2019-10-22T16:15:58.673Z] 
16:15:58 [2019-10-22T16:15:58.673Z] === SKIP: ppc64le.integration.plugin.authz TestAuthZPluginV2Disable (0.00s)
16:15:58 [2019-10-22T16:15:58.673Z]     authz_plugin_v2_test.go:65: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
16:15:58 [2019-10-22T16:15:58.673Z] 
16:15:58 [2019-10-22T16:15:58.673Z] === SKIP: ppc64le.integration.plugin.authz TestAuthZPluginV2RejectVolumeRequests (0.00s)
16:15:58 [2019-10-22T16:15:58.673Z]     authz_plugin_v2_test.go:91: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
16:15:58 [2019-10-22T16:15:58.673Z] 
16:15:58 [2019-10-22T16:15:58.673Z] === SKIP: ppc64le.integration.plugin.authz TestAuthZPluginV2BadManifestFailsDaemonStart (0.00s)
16:15:58 [2019-10-22T16:15:58.673Z]     authz_plugin_v2_test.go:126: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
16:15:58 [2019-10-22T16:15:58.673Z] 
16:15:58 [2019-10-22T16:15:58.673Z] 
16:15:58 [2019-10-22T16:15:58.673Z] DONE 17 tests, 4 skipped in 29.451s
16:15:58 [2019-10-22T16:15:58.673Z] Running /go/src/github.com/docker/docker/integration/plugin/common (ppc64le.integration.plugin.common) flags=-test.v -test.timeout=120m 
16:15:58 [2019-10-22T16:15:58.673Z] ++ 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
16:15:58 [2019-10-22T16:15:58.673Z] ++ set -e
16:15:58 [2019-10-22T16:15:58.673Z] ++ '[' -n 0 ']'
16:15:58 [2019-10-22T16:15:58.673Z] ++ set -x
16:15:58 [2019-10-22T16:15:58.674Z] ++ 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
16:15:58 [2019-10-22T16:15:58.674Z] INFO: Testing against a local daemon
16:15:58 [2019-10-22T16:15:58.674Z] === RUN   TestPluginInvalidJSON
16:15:58 [2019-10-22T16:15:58.674Z] === RUN   TestPluginInvalidJSON//plugins/foobar/set
16:15:58 [2019-10-22T16:15:58.674Z] === PAUSE TestPluginInvalidJSON//plugins/foobar/set
16:15:58 [2019-10-22T16:15:58.674Z] === CONT  TestPluginInvalidJSON//plugins/foobar/set
16:15:58 [2019-10-22T16:15:58.674Z] --- PASS: TestPluginInvalidJSON (0.04s)
16:15:58 [2019-10-22T16:15:58.674Z]     --- PASS: TestPluginInvalidJSON//plugins/foobar/set (0.00s)
16:15:58 [2019-10-22T16:15:58.674Z] PASS
16:15:58 [2019-10-22T16:15:58.674Z] 
16:15:58 [2019-10-22T16:15:58.674Z] DONE 2 tests in 0.122s
16:15:58 [2019-10-22T16:15:58.674Z] Running /go/src/github.com/docker/docker/integration/plugin/graphdriver (ppc64le.integration.plugin.graphdriver) flags=-test.v -test.timeout=120m 
16:15:58 [2019-10-22T16:15:58.674Z] ++ 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
16:15:58 [2019-10-22T16:15:58.674Z] ++ set -e
16:15:58 [2019-10-22T16:15:58.674Z] ++ '[' -n 0 ']'
16:15:58 [2019-10-22T16:15:58.674Z] ++ set -x
16:15:58 [2019-10-22T16:15:58.674Z] ++ 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
16:15:58 [2019-10-22T16:15:58.674Z] INFO: Testing against a local daemon
16:15:58 [2019-10-22T16:15:58.674Z] === RUN   TestExternalGraphDriver
16:15:58 [2019-10-22T16:15:58.674Z] === RUN   TestExternalGraphDriver/json
16:15:59 [2019-10-22T16:15:59.685Z] === RUN   TestExternalGraphDriver/spec
16:16:01 [2019-10-22T16:16:01.717Z] === RUN   TestExternalGraphDriver/pull
16:16:03 [2019-10-22T16:16:03.743Z] --- PASS: TestExternalGraphDriver (6.40s)
16:16:03 [2019-10-22T16:16:03.743Z]     external_test.go:57: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestExternalGraphDriver"
16:16:03 [2019-10-22T16:16:03.743Z]     --- PASS: TestExternalGraphDriver/json (2.07s)
16:16:03 [2019-10-22T16:16:03.743Z]     --- PASS: TestExternalGraphDriver/spec (2.02s)
16:16:03 [2019-10-22T16:16:03.743Z]     --- PASS: TestExternalGraphDriver/pull (2.07s)
16:16:03 [2019-10-22T16:16:03.743Z] === RUN   TestGraphdriverPluginV2
16:16:04 [2019-10-22T16:16:04.027Z] --- SKIP: TestGraphdriverPluginV2 (0.08s)
16:16:04 [2019-10-22T16:16:04.027Z]     external_test.go:410: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
16:16:04 [2019-10-22T16:16:04.027Z] PASS
16:16:04 [2019-10-22T16:16:04.027Z] 
16:16:04 [2019-10-22T16:16:04.027Z] === Skipped
16:16:04 [2019-10-22T16:16:04.027Z] === SKIP: ppc64le.integration.plugin.graphdriver TestGraphdriverPluginV2 (0.08s)
16:16:04 [2019-10-22T16:16:04.027Z]     external_test.go:410: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
16:16:04 [2019-10-22T16:16:04.027Z] 
16:16:04 [2019-10-22T16:16:04.027Z] 
16:16:04 [2019-10-22T16:16:04.027Z] DONE 5 tests, 1 skipped in 6.579s
16:16:04 [2019-10-22T16:16:04.027Z] Running /go/src/github.com/docker/docker/integration/plugin/logging (ppc64le.integration.plugin.logging) flags=-test.v -test.timeout=120m 
16:16:04 [2019-10-22T16:16:04.027Z] ++ 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
16:16:04 [2019-10-22T16:16:04.027Z] ++ set -e
16:16:04 [2019-10-22T16:16:04.027Z] ++ '[' -n 0 ']'
16:16:04 [2019-10-22T16:16:04.027Z] ++ set -x
16:16:04 [2019-10-22T16:16:04.027Z] ++ 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
16:16:04 [2019-10-22T16:16:04.027Z] INFO: Testing against a local daemon
16:16:04 [2019-10-22T16:16:04.027Z] === RUN   TestContinueAfterPluginCrash
16:16:04 [2019-10-22T16:16:04.027Z] === PAUSE TestContinueAfterPluginCrash
16:16:04 [2019-10-22T16:16:04.027Z] === RUN   TestDaemonStartWithLogOpt
16:16:04 [2019-10-22T16:16:04.027Z] === PAUSE TestDaemonStartWithLogOpt
16:16:04 [2019-10-22T16:16:04.027Z] === CONT  TestContinueAfterPluginCrash
16:16:04 [2019-10-22T16:16:04.027Z] === CONT  TestDaemonStartWithLogOpt
16:16:19 [2019-10-22T16:16:19.291Z] --- PASS: TestDaemonStartWithLogOpt (15.33s)
16:16:19 [2019-10-22T16:16:19.291Z]     validation_test.go:23: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonStartWithLogOpt"
16:16:24 [2019-10-22T16:16:24.773Z] --- PASS: TestContinueAfterPluginCrash (20.16s)
16:16:24 [2019-10-22T16:16:24.774Z]     logging_linux_test.go:22: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestContinueAfterPluginCrash"
16:16:24 [2019-10-22T16:16:24.774Z] PASS
16:16:24 [2019-10-22T16:16:24.774Z] 
16:16:24 [2019-10-22T16:16:24.774Z] DONE 2 tests in 20.255s
16:16:24 [2019-10-22T16:16:24.774Z] Running /go/src/github.com/docker/docker/integration/plugin/volumes (ppc64le.integration.plugin.volumes) flags=-test.v -test.timeout=120m 
16:16:24 [2019-10-22T16:16:24.774Z] ++ 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
16:16:24 [2019-10-22T16:16:24.774Z] ++ set -e
16:16:24 [2019-10-22T16:16:24.774Z] ++ '[' -n 0 ']'
16:16:24 [2019-10-22T16:16:24.774Z] ++ set -x
16:16:24 [2019-10-22T16:16:24.774Z] ++ 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
16:16:24 [2019-10-22T16:16:24.774Z] INFO: Testing against a local daemon
16:16:24 [2019-10-22T16:16:24.774Z] === RUN   TestPluginWithDevMounts
16:16:24 [2019-10-22T16:16:24.774Z] === PAUSE TestPluginWithDevMounts
16:16:24 [2019-10-22T16:16:24.774Z] === CONT  TestPluginWithDevMounts
16:16:26 [2019-10-22T16:16:26.797Z] --- PASS: TestPluginWithDevMounts (2.31s)
16:16:26 [2019-10-22T16:16:26.797Z]     mounts_test.go:23: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestPluginWithDevMounts"
16:16:26 [2019-10-22T16:16:26.797Z] PASS
16:16:26 [2019-10-22T16:16:26.797Z] 
16:16:26 [2019-10-22T16:16:26.797Z] DONE 1 tests in 2.405s
16:16:26 [2019-10-22T16:16:26.797Z] Running /go/src/github.com/docker/docker/integration/secret (ppc64le.integration.secret) flags=-test.v -test.timeout=120m 
16:16:26 [2019-10-22T16:16:26.797Z] ++ 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
16:16:26 [2019-10-22T16:16:26.797Z] ++ set -e
16:16:26 [2019-10-22T16:16:26.797Z] ++ '[' -n 0 ']'
16:16:26 [2019-10-22T16:16:26.797Z] ++ set -x
16:16:26 [2019-10-22T16:16:26.797Z] ++ 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
16:16:26 [2019-10-22T16:16:26.797Z] INFO: Testing against a local daemon
16:16:26 [2019-10-22T16:16:26.797Z] === RUN   TestSecretInspect
16:16:28 [2019-10-22T16:16:28.831Z] --- PASS: TestSecretInspect (2.23s)
16:16:28 [2019-10-22T16:16:28.831Z]     secret_test.go:25: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestSecretInspect"
16:16:28 [2019-10-22T16:16:28.831Z] === RUN   TestSecretList
16:16:31 [2019-10-22T16:16:31.524Z] --- PASS: TestSecretList (2.22s)
16:16:31 [2019-10-22T16:16:31.525Z]     secret_test.go:48: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestSecretList"
16:16:31 [2019-10-22T16:16:31.525Z] === RUN   TestSecretsCreateAndDelete
16:16:33 [2019-10-22T16:16:33.555Z] --- PASS: TestSecretsCreateAndDelete (2.25s)
16:16:33 [2019-10-22T16:16:33.555Z]     secret_test.go:125: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestSecretsCreateAndDelete"
16:16:33 [2019-10-22T16:16:33.555Z] === RUN   TestSecretsUpdate
16:16:35 [2019-10-22T16:16:35.587Z] --- PASS: TestSecretsUpdate (2.17s)
16:16:35 [2019-10-22T16:16:35.587Z]     secret_test.go:172: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestSecretsUpdate"
16:16:35 [2019-10-22T16:16:35.587Z] === RUN   TestTemplatedSecret
16:16:39 [2019-10-22T16:16:39.074Z] --- PASS: TestTemplatedSecret (2.86s)
16:16:39 [2019-10-22T16:16:39.074Z]     secret_test.go:221: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestTemplatedSecret"
16:16:39 [2019-10-22T16:16:39.074Z] === RUN   TestSecretCreateResolve
16:16:40 [2019-10-22T16:16:40.551Z] --- PASS: TestSecretCreateResolve (2.19s)
16:16:40 [2019-10-22T16:16:40.551Z]     secret_test.go:342: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestSecretCreateResolve"
16:16:40 [2019-10-22T16:16:40.551Z] PASS
16:16:40 [2019-10-22T16:16:40.551Z] 
16:16:40 [2019-10-22T16:16:40.551Z] DONE 6 tests in 14.012s
16:16:40 [2019-10-22T16:16:40.551Z] Running /go/src/github.com/docker/docker/integration/service (ppc64le.integration.service) flags=-test.v -test.timeout=120m 
16:16:40 [2019-10-22T16:16:40.551Z] ++ 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
16:16:40 [2019-10-22T16:16:40.551Z] ++ set -e
16:16:40 [2019-10-22T16:16:40.551Z] ++ '[' -n 0 ']'
16:16:40 [2019-10-22T16:16:40.551Z] ++ set -x
16:16:40 [2019-10-22T16:16:40.551Z] ++ 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
16:16:40 [2019-10-22T16:16:40.833Z] INFO: Testing against a local daemon
16:16:40 [2019-10-22T16:16:40.833Z] === RUN   TestServiceCreateInit
16:16:40 [2019-10-22T16:16:40.833Z] === RUN   TestServiceCreateInit/daemonInitDisabled
16:16:45 [2019-10-22T16:16:45.221Z] === RUN   TestServiceCreateInit/daemonInitEnabled
16:16:49 [2019-10-22T16:16:49.613Z] --- PASS: TestServiceCreateInit (8.37s)
16:16:49 [2019-10-22T16:16:49.613Z]     --- PASS: TestServiceCreateInit/daemonInitDisabled (4.12s)
16:16:49 [2019-10-22T16:16:49.613Z]         create_test.go:38: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceCreateInit/daemonInitDisabled"
16:16:49 [2019-10-22T16:16:49.613Z]     --- PASS: TestServiceCreateInit/daemonInitEnabled (4.21s)
16:16:49 [2019-10-22T16:16:49.613Z]         create_test.go:38: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceCreateInit/daemonInitEnabled"
16:16:49 [2019-10-22T16:16:49.613Z] === RUN   TestCreateServiceMultipleTimes
16:17:08 [2019-10-22T16:17:08.088Z] --- PASS: TestCreateServiceMultipleTimes (16.93s)
16:17:08 [2019-10-22T16:17:08.088Z]     create_test.go:80: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceMultipleTimes"
16:17:08 [2019-10-22T16:17:08.088Z] === RUN   TestCreateServiceConflict
16:17:08 [2019-10-22T16:17:08.370Z] --- PASS: TestCreateServiceConflict (2.20s)
16:17:08 [2019-10-22T16:17:08.370Z]     create_test.go:129: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceConflict"
16:17:08 [2019-10-22T16:17:08.370Z] === RUN   TestCreateServiceMaxReplicas
16:17:11 [2019-10-22T16:17:11.842Z] --- PASS: TestCreateServiceMaxReplicas (3.04s)
16:17:11 [2019-10-22T16:17:11.842Z]     create_test.go:150: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceMaxReplicas"
16:17:11 [2019-10-22T16:17:11.842Z] === RUN   TestCreateWithDuplicateNetworkNames
16:17:27 [2019-10-22T16:17:27.092Z] --- PASS: TestCreateWithDuplicateNetworkNames (13.40s)
16:17:27 [2019-10-22T16:17:27.092Z]     create_test.go:171: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateWithDuplicateNetworkNames"
16:17:27 [2019-10-22T16:17:27.092Z] === RUN   TestCreateServiceSecretFileMode
16:17:27 [2019-10-22T16:17:27.375Z] --- PASS: TestCreateServiceSecretFileMode (2.64s)
16:17:27 [2019-10-22T16:17:27.375Z]     create_test.go:224: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceSecretFileMode"
16:17:27 [2019-10-22T16:17:27.375Z] === RUN   TestCreateServiceConfigFileMode
16:17:30 [2019-10-22T16:17:30.050Z] --- PASS: TestCreateServiceConfigFileMode (2.53s)
16:17:30 [2019-10-22T16:17:30.050Z]     create_test.go:288: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceConfigFileMode"
16:17:30 [2019-10-22T16:17:30.050Z] === RUN   TestCreateServiceSysctls
16:17:33 [2019-10-22T16:17:33.515Z] --- PASS: TestCreateServiceSysctls (3.57s)
16:17:33 [2019-10-22T16:17:33.515Z]     create_test.go:378: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceSysctls"
16:17:33 [2019-10-22T16:17:33.515Z] === RUN   TestCreateServiceCapabilities
16:17:36 [2019-10-22T16:17:36.202Z] --- PASS: TestCreateServiceCapabilities (2.61s)
16:17:36 [2019-10-22T16:17:36.202Z]     create_test.go:462: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceCapabilities"
16:17:36 [2019-10-22T16:17:36.202Z] === RUN   TestInspect
16:17:38 [2019-10-22T16:17:38.885Z] --- PASS: TestInspect (2.88s)
16:17:38 [2019-10-22T16:17:38.885Z]     inspect_test.go:23: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestInspect"
16:17:38 [2019-10-22T16:17:38.885Z] === RUN   TestServiceListWithStatuses
16:17:38 [2019-10-22T16:17:38.885Z] --- SKIP: TestServiceListWithStatuses (0.00s)
16:17:38 [2019-10-22T16:17:38.885Z]     list_test.go:34: versions.LessThan(testEnv.DaemonInfo.ServerVersion, "1.41")
16:17:38 [2019-10-22T16:17:38.885Z] === RUN   TestDockerNetworkConnectAlias
16:17:44 [2019-10-22T16:17:44.390Z] --- PASS: TestDockerNetworkConnectAlias (4.60s)
16:17:44 [2019-10-22T16:17:44.390Z]     network_test.go:20: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkConnectAlias"
16:17:44 [2019-10-22T16:17:44.390Z] === RUN   TestDockerNetworkReConnect
16:17:47 [2019-10-22T16:17:47.073Z] --- PASS: TestDockerNetworkReConnect (3.64s)
16:17:47 [2019-10-22T16:17:47.073Z]     network_test.go:82: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkReConnect"
16:17:47 [2019-10-22T16:17:47.073Z] === RUN   TestServicePlugin
16:17:47 [2019-10-22T16:17:47.073Z] --- SKIP: TestServicePlugin (0.00s)
16:17:47 [2019-10-22T16:17:47.073Z]     plugin_test.go:28: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
16:17:47 [2019-10-22T16:17:47.073Z] === RUN   TestServiceUpdateLabel
16:17:49 [2019-10-22T16:17:49.755Z] --- PASS: TestServiceUpdateLabel (2.23s)
16:17:49 [2019-10-22T16:17:49.755Z]     update_test.go:21: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateLabel"
16:17:49 [2019-10-22T16:17:49.755Z] === RUN   TestServiceUpdateSecrets
16:18:04 [2019-10-22T16:18:04.987Z] --- PASS: TestServiceUpdateSecrets (14.91s)
16:18:04 [2019-10-22T16:18:04.987Z]     update_test.go:77: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateSecrets"
16:18:04 [2019-10-22T16:18:04.987Z] === RUN   TestServiceUpdateConfigs
16:18:20 [2019-10-22T16:18:20.204Z] --- PASS: TestServiceUpdateConfigs (14.83s)
16:18:20 [2019-10-22T16:18:20.204Z]     update_test.go:139: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateConfigs"
16:18:20 [2019-10-22T16:18:20.204Z] === RUN   TestServiceUpdateNetwork
16:18:32 [2019-10-22T16:18:32.725Z] --- PASS: TestServiceUpdateNetwork (13.04s)
16:18:32 [2019-10-22T16:18:32.725Z]     update_test.go:201: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateNetwork"
16:18:32 [2019-10-22T16:18:32.725Z] PASS
16:18:32 [2019-10-22T16:18:32.725Z] 
16:18:32 [2019-10-22T16:18:32.725Z] === Skipped
16:18:32 [2019-10-22T16:18:32.725Z] === SKIP: ppc64le.integration.service TestServiceListWithStatuses (0.00s)
16:18:32 [2019-10-22T16:18:32.725Z]     list_test.go:34: versions.LessThan(testEnv.DaemonInfo.ServerVersion, "1.41")
16:18:32 [2019-10-22T16:18:32.725Z] 
16:18:32 [2019-10-22T16:18:32.725Z] === SKIP: ppc64le.integration.service TestServicePlugin (0.00s)
16:18:32 [2019-10-22T16:18:32.725Z]     plugin_test.go:28: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
16:18:32 [2019-10-22T16:18:32.725Z] 
16:18:32 [2019-10-22T16:18:32.725Z] 
16:18:32 [2019-10-22T16:18:32.725Z] DONE 20 tests, 2 skipped in 111.543s
16:18:32 [2019-10-22T16:18:32.725Z] Running /go/src/github.com/docker/docker/integration/session (ppc64le.integration.session) flags=-test.v -test.timeout=120m 
16:18:32 [2019-10-22T16:18:32.725Z] ++ 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
16:18:32 [2019-10-22T16:18:32.725Z] ++ set -e
16:18:32 [2019-10-22T16:18:32.725Z] ++ '[' -n 0 ']'
16:18:32 [2019-10-22T16:18:32.725Z] ++ set -x
16:18:32 [2019-10-22T16:18:32.725Z] ++ 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
16:18:32 [2019-10-22T16:18:32.725Z] INFO: Testing against a local daemon
16:18:32 [2019-10-22T16:18:32.725Z] === RUN   TestSessionCreate
16:18:32 [2019-10-22T16:18:32.725Z] --- PASS: TestSessionCreate (0.05s)
16:18:32 [2019-10-22T16:18:32.725Z] === RUN   TestSessionCreateWithBadUpgrade
16:18:32 [2019-10-22T16:18:32.725Z] --- PASS: TestSessionCreateWithBadUpgrade (0.05s)
16:18:32 [2019-10-22T16:18:32.725Z] PASS
16:18:32 [2019-10-22T16:18:32.725Z] 
16:18:32 [2019-10-22T16:18:32.725Z] DONE 2 tests in 0.187s
16:18:32 [2019-10-22T16:18:32.725Z] Running /go/src/github.com/docker/docker/integration/system (ppc64le.integration.system) flags=-test.v -test.timeout=120m 
16:18:32 [2019-10-22T16:18:32.725Z] ++ 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
16:18:32 [2019-10-22T16:18:32.725Z] ++ set -e
16:18:32 [2019-10-22T16:18:32.725Z] ++ '[' -n 0 ']'
16:18:32 [2019-10-22T16:18:32.725Z] ++ set -x
16:18:32 [2019-10-22T16:18:32.725Z] ++ 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
16:18:32 [2019-10-22T16:18:32.725Z] INFO: Testing against a local daemon
16:18:32 [2019-10-22T16:18:32.725Z] === RUN   TestCgroupDriverSystemdMemoryLimit
16:18:32 [2019-10-22T16:18:32.725Z] --- SKIP: TestCgroupDriverSystemdMemoryLimit (0.00s)
16:18:32 [2019-10-22T16:18:32.725Z]     cgroupdriver_systemd_test.go:32: !hasSystemd()
16:18:32 [2019-10-22T16:18:32.725Z] === RUN   TestEventsExecDie
16:18:33 [2019-10-22T16:18:33.345Z] --- PASS: TestEventsExecDie (0.86s)
16:18:33 [2019-10-22T16:18:33.345Z] === RUN   TestEventsBackwardsCompatible
16:18:33 [2019-10-22T16:18:33.629Z] --- PASS: TestEventsBackwardsCompatible (0.11s)
16:18:33 [2019-10-22T16:18:33.629Z] === RUN   TestInfoBinaryCommits
16:18:33 [2019-10-22T16:18:33.629Z] --- PASS: TestInfoBinaryCommits (0.05s)
16:18:33 [2019-10-22T16:18:33.629Z] === RUN   TestInfoAPIVersioned
16:18:33 [2019-10-22T16:18:33.629Z] --- PASS: TestInfoAPIVersioned (0.01s)
16:18:33 [2019-10-22T16:18:33.629Z] === RUN   TestInfoDiscoveryBackend
16:18:34 [2019-10-22T16:18:34.244Z] --- PASS: TestInfoDiscoveryBackend (0.54s)
16:18:34 [2019-10-22T16:18:34.245Z]     info_linux_test.go:61: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestInfoDiscoveryBackend"
16:18:34 [2019-10-22T16:18:34.245Z] === RUN   TestInfoDiscoveryInvalidAdvertise
16:18:35 [2019-10-22T16:18:35.259Z] --- PASS: TestInfoDiscoveryInvalidAdvertise (1.00s)
16:18:35 [2019-10-22T16:18:35.259Z]     info_linux_test.go:74: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestInfoDiscoveryInvalidAdvertise"
16:18:35 [2019-10-22T16:18:35.259Z] === RUN   TestInfoDiscoveryAdvertiseInterfaceName
16:18:35 [2019-10-22T16:18:35.543Z] --- PASS: TestInfoDiscoveryAdvertiseInterfaceName (0.54s)
16:18:35 [2019-10-22T16:18:35.543Z]     info_linux_test.go:97: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestInfoDiscoveryAdvertiseInterfaceName"
16:18:35 [2019-10-22T16:18:35.543Z] === RUN   TestInfoAPI
16:18:35 [2019-10-22T16:18:35.828Z] --- PASS: TestInfoAPI (0.07s)
16:18:35 [2019-10-22T16:18:35.828Z] === RUN   TestInfoAPIWarnings
16:18:36 [2019-10-22T16:18:36.113Z] --- PASS: TestInfoAPIWarnings (0.54s)
16:18:36 [2019-10-22T16:18:36.113Z]     info_test.go:51: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestInfoAPIWarnings"
16:18:36 [2019-10-22T16:18:36.113Z] === RUN   TestInfoDebug
16:18:36 [2019-10-22T16:18:36.733Z] --- PASS: TestInfoDebug (0.55s)
16:18:36 [2019-10-22T16:18:36.733Z]     info_test.go:74: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestInfoDebug"
16:18:36 [2019-10-22T16:18:36.733Z] === RUN   TestInfoInsecureRegistries
16:18:37 [2019-10-22T16:18:37.348Z] --- PASS: TestInfoInsecureRegistries (0.54s)
16:18:37 [2019-10-22T16:18:37.348Z]     info_test.go:99: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestInfoInsecureRegistries"
16:18:37 [2019-10-22T16:18:37.348Z] === RUN   TestInfoRegistryMirrors
16:18:37 [2019-10-22T16:18:37.991Z] --- PASS: TestInfoRegistryMirrors (0.54s)
16:18:37 [2019-10-22T16:18:37.991Z]     info_test.go:123: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestInfoRegistryMirrors"
16:18:37 [2019-10-22T16:18:37.991Z] === RUN   TestLoginFailsWithBadCredentials
16:18:38 [2019-10-22T16:18:38.607Z] --- PASS: TestLoginFailsWithBadCredentials (0.61s)
16:18:38 [2019-10-22T16:18:38.607Z] === RUN   TestPingCacheHeaders
16:18:38 [2019-10-22T16:18:38.607Z] --- PASS: TestPingCacheHeaders (0.05s)
16:18:38 [2019-10-22T16:18:38.607Z] === RUN   TestPingGet
16:18:38 [2019-10-22T16:18:38.607Z] --- PASS: TestPingGet (0.05s)
16:18:38 [2019-10-22T16:18:38.607Z] === RUN   TestPingHead
16:18:38 [2019-10-22T16:18:38.607Z] --- PASS: TestPingHead (0.05s)
16:18:38 [2019-10-22T16:18:38.607Z] === RUN   TestVersion
16:18:38 [2019-10-22T16:18:38.607Z] --- PASS: TestVersion (0.05s)
16:18:38 [2019-10-22T16:18:38.607Z] PASS
16:18:38 [2019-10-22T16:18:38.607Z] 
16:18:38 [2019-10-22T16:18:38.607Z] === Skipped
16:18:38 [2019-10-22T16:18:38.607Z] === SKIP: ppc64le.integration.system TestCgroupDriverSystemdMemoryLimit (0.00s)
16:18:38 [2019-10-22T16:18:38.607Z]     cgroupdriver_systemd_test.go:32: !hasSystemd()
16:18:38 [2019-10-22T16:18:38.607Z] 
16:18:38 [2019-10-22T16:18:38.607Z] 
16:18:38 [2019-10-22T16:18:38.607Z] DONE 18 tests, 1 skipped in 6.252s
16:18:38 [2019-10-22T16:18:38.607Z] Running /go/src/github.com/docker/docker/integration/volume (ppc64le.integration.volume) flags=-test.v -test.timeout=120m 
16:18:38 [2019-10-22T16:18:38.607Z] ++ 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
16:18:38 [2019-10-22T16:18:38.607Z] ++ set -e
16:18:38 [2019-10-22T16:18:38.607Z] ++ '[' -n 0 ']'
16:18:38 [2019-10-22T16:18:38.607Z] ++ set -x
16:18:38 [2019-10-22T16:18:38.607Z] ++ 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
16:18:38 [2019-10-22T16:18:38.891Z] INFO: Testing against a local daemon
16:18:38 [2019-10-22T16:18:38.891Z] === RUN   TestVolumesCreateAndList
16:18:38 [2019-10-22T16:18:38.891Z] --- PASS: TestVolumesCreateAndList (0.04s)
16:18:38 [2019-10-22T16:18:38.891Z] === RUN   TestVolumesRemove
16:18:38 [2019-10-22T16:18:38.891Z] --- PASS: TestVolumesRemove (0.09s)
16:18:38 [2019-10-22T16:18:38.891Z] === RUN   TestVolumesInspect
16:18:38 [2019-10-22T16:18:38.891Z] --- PASS: TestVolumesInspect (0.04s)
16:18:38 [2019-10-22T16:18:38.891Z] === RUN   TestVolumesInvalidJSON
16:18:38 [2019-10-22T16:18:38.891Z] === RUN   TestVolumesInvalidJSON//volumes/create
16:18:38 [2019-10-22T16:18:38.891Z] === PAUSE TestVolumesInvalidJSON//volumes/create
16:18:38 [2019-10-22T16:18:38.891Z] === CONT  TestVolumesInvalidJSON//volumes/create
16:18:38 [2019-10-22T16:18:38.891Z] --- PASS: TestVolumesInvalidJSON (0.03s)
16:18:38 [2019-10-22T16:18:38.891Z]     --- PASS: TestVolumesInvalidJSON//volumes/create (0.00s)
16:18:38 [2019-10-22T16:18:38.891Z] PASS
16:18:38 [2019-10-22T16:18:38.891Z] 
16:18:38 [2019-10-22T16:18:38.891Z] DONE 5 tests in 0.304s
16:18:38 [2019-10-22T16:18:38.891Z] ---> Making bundle: .integration-daemon-stop (in bundles/test-integration)
16:18:39 [2019-10-22T16:18:39.175Z] ++++ cat bundles/test-integration/docker.pid
16:18:39 [2019-10-22T16:18:39.175Z] +++ kill 13129
16:18:40 [2019-10-22T16:18:40.649Z] +++ /etc/init.d/apparmor stop
16:18:40 [2019-10-22T16:18:40.650Z] Clearing AppArmor profiles cache:.
16:18:40 [2019-10-22T16:18:40.650Z] All profile caches have been cleared, but no profiles have been unloaded.
16:18:40 [2019-10-22T16:18:40.650Z] Unloading profiles will leave already running processes permanently
16:18:40 [2019-10-22T16:18:40.650Z] unconfined, which can lead to unexpected situations.
16:18:40 [2019-10-22T16:18:40.650Z] 
16:18:40 [2019-10-22T16:18:40.650Z] To set a process to complain mode, use the command line tool
16:18:40 [2019-10-22T16:18:40.650Z] 'aa-complain'. To really tear down all profiles, run the init script
16:18:40 [2019-10-22T16:18:40.650Z] with the 'teardown' option."
16:18:40 [2019-10-22T16:18:40.650Z]