Skip to content

Console Output

22:07:36 [2019-10-15T22:07:36.469Z] + docker run --rm -t --privileged -v /home/docker/workspace/moby_PR-40095/bundles:/go/src/github.com/docker/docker/bundles --name docker-pr2 -e DOCKER_EXPERIMENTAL -e DOCKER_GITCOMMIT=af3f576b1bd24f21ba62c6e99030913c67bfefc5 -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:af3f576b1bd24f21ba62c6e99030913c67bfefc5 hack/make.sh dynbinary test-integration
22:07:37 [2019-10-15T22:07:37.089Z] 
22:07:37 [2019-10-15T22:07:37.089Z] Removing bundles/
22:07:37 [2019-10-15T22:07:37.089Z] 
22:07:37 [2019-10-15T22:07:37.089Z] ---> Making bundle: dynbinary (in bundles/dynbinary)
22:07:37 [2019-10-15T22:07:37.089Z] Building: bundles/dynbinary-daemon/dockerd-dev
22:07:37 [2019-10-15T22:07:37.089Z] GOOS="" GOARCH="" GOARM=""
22:09:44 [2019-10-15T22:09:44.283Z] Created binary: bundles/dynbinary-daemon/dockerd-dev
22:09:44 [2019-10-15T22:09:44.283Z] 
22:09:44 [2019-10-15T22:09:44.283Z] ---> Making bundle: test-integration (in bundles/test-integration)
22:09:44 [2019-10-15T22:09:44.283Z] PKG_CONFIG=pkg-config
22:09:44 [2019-10-15T22:09:44.283Z] GOLANG_VERSION=1.13.1
22:09:44 [2019-10-15T22:09:44.283Z] HOSTNAME=039a3f6e384d
22:09:44 [2019-10-15T22:09:44.283Z] DOCKER_EXPERIMENTAL=1
22:09:44 [2019-10-15T22:09:44.283Z] container=docker
22:09:44 [2019-10-15T22:09:44.283Z] TEST_SKIP_INTEGRATION_CLI=1
22:09:44 [2019-10-15T22:09:44.283Z] GO111MODULE=off
22:09:44 [2019-10-15T22:09:44.283Z] GOPATH=/go
22:09:44 [2019-10-15T22:09:44.283Z] PWD=/go/src/github.com/docker/docker
22:09:44 [2019-10-15T22:09:44.283Z] HOME=/root
22:09:44 [2019-10-15T22:09:44.283Z] VALIDATE_REPO=https://github.com/moby/moby.git
22:09:44 [2019-10-15T22:09:44.283Z] SCRIPTDIR=/go/src/github.com/docker/docker/hack
22:09:44 [2019-10-15T22:09:44.283Z] MAKEDIR=/go/src/github.com/docker/docker/hack/make
22:09:44 [2019-10-15T22:09:44.283Z] DOCKER_GITCOMMIT=af3f576b1bd24f21ba62c6e99030913c67bfefc5
22:09:44 [2019-10-15T22:09:44.283Z] DOCKER_BUILDTAGS=apparmor seccomp selinux journald
22:09:44 [2019-10-15T22:09:44.283Z] DOCKER_GRAPHDRIVER=overlay2
22:09:44 [2019-10-15T22:09:44.283Z] TERM=xterm
22:09:44 [2019-10-15T22:09:44.283Z] VALIDATE_BRANCH=master
22:09:44 [2019-10-15T22:09:44.283Z] DEST=bundles/test-integration
22:09:44 [2019-10-15T22:09:44.283Z] SHLVL=1
22:09:44 [2019-10-15T22:09:44.283Z] TIMEOUT=120m
22:09:44 [2019-10-15T22:09:44.283Z] PATH=/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
22:09:44 [2019-10-15T22:09:44.283Z] DOCKER_PKG=github.com/docker/docker
22:09:44 [2019-10-15T22:09:44.283Z] TESTDEBUG=0
22:09:44 [2019-10-15T22:09:44.283Z] _=/usr/bin/env
22:09:44 [2019-10-15T22:09:44.283Z] Building test suite binary /go/src/github.com/docker/docker/integration/build/test.main
22:10:31 [2019-10-15T22:10:31.544Z] Building test suite binary /go/src/github.com/docker/docker/integration/config/test.main
22:10:31 [2019-10-15T22:10:31.544Z] Building test suite binary /go/src/github.com/docker/docker/integration/container/test.main
22:10:31 [2019-10-15T22:10:31.544Z] Building test suite binary /go/src/github.com/docker/docker/integration/image/test.main
22:11:10 [2019-10-15T22:11:10.926Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/test.main
22:11:10 [2019-10-15T22:11:10.926Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/ipvlan/test.main
22:11:10 [2019-10-15T22:11:10.926Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/macvlan/test.main
22:11:10 [2019-10-15T22:11:10.926Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/test.main
22:11:11 [2019-10-15T22:11:11.545Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/authz/test.main
22:11:15 [2019-10-15T22:11:15.018Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/common/test.main
22:11:17 [2019-10-15T22:11:17.054Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/graphdriver/test.main
22:11:19 [2019-10-15T22:11:19.755Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/logging/test.main
22:11:24 [2019-10-15T22:11:24.156Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/volumes/test.main
22:11:26 [2019-10-15T22:11:26.881Z] Building test suite binary /go/src/github.com/docker/docker/integration/secret/test.main
22:11:28 [2019-10-15T22:11:28.930Z] Building test suite binary /go/src/github.com/docker/docker/integration/service/test.main
22:11:32 [2019-10-15T22:11:32.407Z] Building test suite binary /go/src/github.com/docker/docker/integration/session/test.main
22:11:33 [2019-10-15T22:11:33.888Z] Building test suite binary /go/src/github.com/docker/docker/integration/system/test.main
22:11:35 [2019-10-15T22:11:35.918Z] Building test suite binary /go/src/github.com/docker/docker/integration/volume/test.main
22:11:37 [2019-10-15T22:11:37.949Z] ---> Making bundle: .integration-daemon-start (in bundles/test-integration)
22:11:37 [2019-10-15T22:11:37.949Z] Using test binary docker
22:11:37 [2019-10-15T22:11:37.949Z] # DOCKER_EXPERIMENTAL is set: starting daemon with experimental features enabled! 
22:11:37 [2019-10-15T22:11:37.949Z] +++ /etc/init.d/apparmor start
22:11:37 [2019-10-15T22:11:37.949Z] /etc/init.d/apparmor: 130: /etc/init.d/apparmor: systemd-detect-virt: not found
22:11:37 [2019-10-15T22:11:37.949Z] Starting AppArmor profiles:Warning from stdin (line 1): /sbin/apparmor_parser: cannot use or update cache, disable, or force-complain via stdin
22:11:37 [2019-10-15T22:11:37.949Z] Warning failed to create cache: (null)
22:11:37 [2019-10-15T22:11:37.949Z] .
22:11:37 [2019-10-15T22:11:37.949Z] INFO: Waiting for daemon to start...
22:11:37 [2019-10-15T22:11:37.949Z] Starting dockerd
22:11:37 [2019-10-15T22:11:37.949Z] +++ 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
22:11:39 [2019-10-15T22:11:39.971Z] .
22:11:39 [2019-10-15T22:11:39.971Z] ---> Making bundle: .integration-daemon-setup (in bundles/test-integration)
22:11:39 [2019-10-15T22:11:39.971Z] ---> Making bundle: .ensure-emptyfs (in bundles/test-integration)
22:11:39 [2019-10-15T22:11:39.971Z] Error: No such image: emptyfs
22:11:39 [2019-10-15T22:11:39.971Z] ++++ tar -cC bundles/test-integration/emptyfs .
22:11:39 [2019-10-15T22:11:39.971Z] ++++ docker load
22:11:40 [2019-10-15T22:11:40.254Z] Running integration-test (iteration 1)
22:11:40 [2019-10-15T22:11:40.254Z] Running /go/src/github.com/docker/docker/integration/build (ppc64le.integration.build) flags=-test.v -test.timeout=120m 
22:11:40 [2019-10-15T22:11:40.254Z] ++ 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
22:11:40 [2019-10-15T22:11:40.254Z] ++ set -e
22:11:40 [2019-10-15T22:11:40.254Z] ++ '[' -n 0 ']'
22:11:40 [2019-10-15T22:11:40.254Z] ++ set -x
22:11:40 [2019-10-15T22:11:40.254Z] ++ 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
22:11:55 [2019-10-15T22:11:55.576Z] Loaded image: buildpack-deps:jessie
22:11:55 [2019-10-15T22:11:55.576Z] Loaded image: busybox:latest
22:11:55 [2019-10-15T22:11:55.576Z] Loaded image: busybox:glibc
22:11:55 [2019-10-15T22:11:55.576Z] Loaded image: debian:jessie
22:11:55 [2019-10-15T22:11:55.576Z] Loaded image: hello-world:latest
22:11:55 [2019-10-15T22:11:55.576Z] INFO: Testing against a local daemon
22:11:55 [2019-10-15T22:11:55.576Z] === RUN   TestCgroupNamespacesBuild
22:11:56 [2019-10-15T22:11:56.589Z] --- PASS: TestCgroupNamespacesBuild (1.64s)
22:11:56 [2019-10-15T22:11:56.589Z]     build_cgroupns_linux_test.go:42: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesBuild"
22:11:56 [2019-10-15T22:11:56.589Z] === RUN   TestCgroupNamespacesBuildDaemonHostMode
22:11:58 [2019-10-15T22:11:58.064Z] --- PASS: TestCgroupNamespacesBuildDaemonHostMode (1.61s)
22:11:58 [2019-10-15T22:11:58.064Z]     build_cgroupns_linux_test.go:42: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesBuildDaemonHostMode"
22:11:58 [2019-10-15T22:11:58.064Z] === RUN   TestBuildWithSession
22:11:58 [2019-10-15T22:11:58.064Z] --- SKIP: TestBuildWithSession (0.00s)
22:11:58 [2019-10-15T22:11:58.064Z]     build_session_test.go:25: TODO: BuildKit
22:11:58 [2019-10-15T22:11:58.064Z] === RUN   TestBuildSquashParent
22:12:03 [2019-10-15T22:12:03.559Z] --- PASS: TestBuildSquashParent (5.43s)
22:12:03 [2019-10-15T22:12:03.559Z] === RUN   TestBuildWithRemoveAndForceRemove
22:12:03 [2019-10-15T22:12:03.559Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
22:12:03 [2019-10-15T22:12:03.559Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
22:12:03 [2019-10-15T22:12:03.559Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_remove
22:12:03 [2019-10-15T22:12:03.559Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_remove
22:12:03 [2019-10-15T22:12:03.559Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
22:12:03 [2019-10-15T22:12:03.559Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
22:12:03 [2019-10-15T22:12:03.559Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
22:12:03 [2019-10-15T22:12:03.559Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
22:12:03 [2019-10-15T22:12:03.559Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_remove
22:12:03 [2019-10-15T22:12:03.559Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_remove
22:12:03 [2019-10-15T22:12:03.559Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
22:12:03 [2019-10-15T22:12:03.559Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
22:12:03 [2019-10-15T22:12:03.559Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
22:12:03 [2019-10-15T22:12:03.559Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
22:12:03 [2019-10-15T22:12:03.559Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
22:12:03 [2019-10-15T22:12:03.559Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
22:12:07 [2019-10-15T22:12:07.061Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_remove
22:12:07 [2019-10-15T22:12:07.061Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_remove
22:12:09 [2019-10-15T22:12:09.087Z] --- PASS: TestBuildWithRemoveAndForceRemove (0.02s)
22:12:09 [2019-10-15T22:12:09.087Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove (3.05s)
22:12:09 [2019-10-15T22:12:09.087Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove (3.26s)
22:12:09 [2019-10-15T22:12:09.087Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal (3.29s)
22:12:09 [2019-10-15T22:12:09.087Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal (3.35s)
22:12:09 [2019-10-15T22:12:09.087Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_remove (2.07s)
22:12:09 [2019-10-15T22:12:09.087Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_remove (2.33s)
22:12:09 [2019-10-15T22:12:09.087Z] === RUN   TestBuildMultiStageCopy
22:12:09 [2019-10-15T22:12:09.087Z] === RUN   TestBuildMultiStageCopy/copy_to_root
22:12:11 [2019-10-15T22:12:11.137Z] === RUN   TestBuildMultiStageCopy/copy_to_newdir
22:12:11 [2019-10-15T22:12:11.137Z] === RUN   TestBuildMultiStageCopy/copy_to_newdir_nested
22:12:11 [2019-10-15T22:12:11.421Z] === RUN   TestBuildMultiStageCopy/copy_to_existingdir
22:12:12 [2019-10-15T22:12:12.036Z] === RUN   TestBuildMultiStageCopy/copy_to_newsubdir
22:12:12 [2019-10-15T22:12:12.319Z] --- PASS: TestBuildMultiStageCopy (3.38s)
22:12:12 [2019-10-15T22:12:12.319Z]     --- PASS: TestBuildMultiStageCopy/copy_to_root (1.85s)
22:12:12 [2019-10-15T22:12:12.319Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newdir (0.36s)
22:12:12 [2019-10-15T22:12:12.319Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newdir_nested (0.36s)
22:12:12 [2019-10-15T22:12:12.319Z]     --- PASS: TestBuildMultiStageCopy/copy_to_existingdir (0.40s)
22:12:12 [2019-10-15T22:12:12.319Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newsubdir (0.42s)
22:12:12 [2019-10-15T22:12:12.319Z] === RUN   TestBuildMultiStageParentConfig
22:12:13 [2019-10-15T22:12:13.333Z] --- PASS: TestBuildMultiStageParentConfig (0.93s)
22:12:13 [2019-10-15T22:12:13.333Z] === RUN   TestBuildLabelWithTargets
22:12:14 [2019-10-15T22:12:14.824Z] --- PASS: TestBuildLabelWithTargets (1.53s)
22:12:14 [2019-10-15T22:12:14.824Z] === RUN   TestBuildWithEmptyLayers
22:12:15 [2019-10-15T22:12:15.440Z] --- PASS: TestBuildWithEmptyLayers (0.76s)
22:12:15 [2019-10-15T22:12:15.440Z] === RUN   TestBuildMultiStageOnBuild
22:12:18 [2019-10-15T22:12:18.126Z] --- PASS: TestBuildMultiStageOnBuild (2.13s)
22:12:18 [2019-10-15T22:12:18.126Z] === RUN   TestBuildUncleanTarFilenames
22:12:18 [2019-10-15T22:12:18.744Z] --- PASS: TestBuildUncleanTarFilenames (1.10s)
22:12:18 [2019-10-15T22:12:18.745Z] === RUN   TestBuildMultiStageLayerLeak
22:12:21 [2019-10-15T22:12:21.426Z] --- PASS: TestBuildMultiStageLayerLeak (2.18s)
22:12:21 [2019-10-15T22:12:21.426Z] === RUN   TestBuildWithHugeFile
22:13:58 [2019-10-15T22:13:58.662Z] --- PASS: TestBuildWithHugeFile (83.85s)
22:13:58 [2019-10-15T22:13:58.662Z] === RUN   TestBuildWithEmptyDockerfile
22:13:58 [2019-10-15T22:13:58.662Z] === RUN   TestBuildWithEmptyDockerfile/empty-dockerfile
22:13:58 [2019-10-15T22:13:58.662Z] === PAUSE TestBuildWithEmptyDockerfile/empty-dockerfile
22:13:58 [2019-10-15T22:13:58.662Z] === RUN   TestBuildWithEmptyDockerfile/empty-lines-dockerfile
22:13:58 [2019-10-15T22:13:58.662Z] === PAUSE TestBuildWithEmptyDockerfile/empty-lines-dockerfile
22:13:58 [2019-10-15T22:13:58.662Z] === RUN   TestBuildWithEmptyDockerfile/comment-only-dockerfile
22:13:58 [2019-10-15T22:13:58.663Z] === PAUSE TestBuildWithEmptyDockerfile/comment-only-dockerfile
22:13:58 [2019-10-15T22:13:58.663Z] === CONT  TestBuildWithEmptyDockerfile/empty-dockerfile
22:13:58 [2019-10-15T22:13:58.663Z] === CONT  TestBuildWithEmptyDockerfile/comment-only-dockerfile
22:13:58 [2019-10-15T22:13:58.663Z] === CONT  TestBuildWithEmptyDockerfile/empty-lines-dockerfile
22:13:58 [2019-10-15T22:13:58.663Z] --- PASS: TestBuildWithEmptyDockerfile (0.07s)
22:13:58 [2019-10-15T22:13:58.663Z]     --- PASS: TestBuildWithEmptyDockerfile/empty-lines-dockerfile (0.30s)
22:13:58 [2019-10-15T22:13:58.663Z]     --- PASS: TestBuildWithEmptyDockerfile/comment-only-dockerfile (0.30s)
22:13:58 [2019-10-15T22:13:58.663Z]     --- PASS: TestBuildWithEmptyDockerfile/empty-dockerfile (0.31s)
22:13:58 [2019-10-15T22:13:58.663Z] === RUN   TestBuildPreserveOwnership
22:13:58 [2019-10-15T22:13:58.663Z] === RUN   TestBuildPreserveOwnership/copy_from
22:13:58 [2019-10-15T22:13:58.663Z] === RUN   TestBuildPreserveOwnership/copy_from_chowned
22:13:58 [2019-10-15T22:13:58.663Z] --- PASS: TestBuildPreserveOwnership (4.75s)
22:13:58 [2019-10-15T22:13:58.663Z]     --- PASS: TestBuildPreserveOwnership/copy_from (3.14s)
22:13:58 [2019-10-15T22:13:58.663Z]     --- PASS: TestBuildPreserveOwnership/copy_from_chowned (1.60s)
22:13:58 [2019-10-15T22:13:58.663Z] === RUN   TestBuildPlatformInvalid
22:13:58 [2019-10-15T22:13:58.663Z] --- PASS: TestBuildPlatformInvalid (0.14s)
22:13:58 [2019-10-15T22:13:58.663Z] PASS
22:13:58 [2019-10-15T22:13:58.663Z] 
22:13:58 [2019-10-15T22:13:58.663Z] === Skipped
22:13:58 [2019-10-15T22:13:58.663Z] === SKIP: ppc64le.integration.build TestBuildWithSession (0.00s)
22:13:58 [2019-10-15T22:13:58.663Z]     build_session_test.go:25: TODO: BuildKit
22:13:58 [2019-10-15T22:13:58.663Z] 
22:13:58 [2019-10-15T22:13:58.663Z] 
22:13:58 [2019-10-15T22:13:58.663Z] DONE 32 tests, 1 skipped in 129.786s
22:13:58 [2019-10-15T22:13:58.663Z] Running /go/src/github.com/docker/docker/integration/config (ppc64le.integration.config) flags=-test.v -test.timeout=120m 
22:13:58 [2019-10-15T22:13:58.663Z] ++ 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
22:13:58 [2019-10-15T22:13:58.663Z] ++ set -e
22:13:58 [2019-10-15T22:13:58.663Z] ++ '[' -n 0 ']'
22:13:58 [2019-10-15T22:13:58.663Z] ++ set -x
22:13:58 [2019-10-15T22:13:58.663Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=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
22:13:58 [2019-10-15T22:13:58.663Z] INFO: Testing against a local daemon
22:13:58 [2019-10-15T22:13:58.663Z] === RUN   TestConfigList
22:13:58 [2019-10-15T22:13:58.663Z] --- PASS: TestConfigList (2.18s)
22:13:58 [2019-10-15T22:13:58.663Z]     config_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigList"
22:13:58 [2019-10-15T22:13:58.663Z] === RUN   TestConfigsCreateAndDelete
22:13:58 [2019-10-15T22:13:58.663Z] --- PASS: TestConfigsCreateAndDelete (2.15s)
22:13:58 [2019-10-15T22:13:58.663Z]     config_test.go:112: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigsCreateAndDelete"
22:13:58 [2019-10-15T22:13:58.663Z] === RUN   TestConfigsUpdate
22:13:58 [2019-10-15T22:13:58.663Z] --- PASS: TestConfigsUpdate (2.18s)
22:13:58 [2019-10-15T22:13:58.663Z]     config_test.go:140: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigsUpdate"
22:13:58 [2019-10-15T22:13:58.663Z] === RUN   TestTemplatedConfig
22:13:59 [2019-10-15T22:13:59.670Z] --- PASS: TestTemplatedConfig (2.76s)
22:13:59 [2019-10-15T22:13:59.670Z]     config_test.go:192: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestTemplatedConfig"
22:13:59 [2019-10-15T22:13:59.670Z] === RUN   TestConfigInspect
22:14:01 [2019-10-15T22:14:01.699Z] --- PASS: TestConfigInspect (2.15s)
22:14:01 [2019-10-15T22:14:01.699Z]     config_test.go:326: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigInspect"
22:14:01 [2019-10-15T22:14:01.699Z] === RUN   TestConfigCreateWithLabels
22:14:03 [2019-10-15T22:14:03.726Z] --- PASS: TestConfigCreateWithLabels (2.20s)
22:14:03 [2019-10-15T22:14:03.726Z]     config_test.go:350: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigCreateWithLabels"
22:14:03 [2019-10-15T22:14:03.726Z] === RUN   TestConfigCreateResolve
22:14:06 [2019-10-15T22:14:06.434Z] --- PASS: TestConfigCreateResolve (2.16s)
22:14:06 [2019-10-15T22:14:06.434Z]     config_test.go:377: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigCreateResolve"
22:14:06 [2019-10-15T22:14:06.434Z] === RUN   TestConfigDaemonLibtrustID
22:14:06 [2019-10-15T22:14:06.434Z] --- PASS: TestConfigDaemonLibtrustID (0.56s)
22:14:06 [2019-10-15T22:14:06.434Z]     config_test.go:427: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigDaemonLibtrustID"
22:14:06 [2019-10-15T22:14:06.434Z] PASS
22:14:06 [2019-10-15T22:14:06.434Z] 
22:14:06 [2019-10-15T22:14:06.434Z] DONE 8 tests in 16.440s
22:14:06 [2019-10-15T22:14:06.434Z] Running /go/src/github.com/docker/docker/integration/container (ppc64le.integration.container) flags=-test.v -test.timeout=120m 
22:14:06 [2019-10-15T22:14:06.434Z] ++ 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
22:14:06 [2019-10-15T22:14:06.434Z] ++ set -e
22:14:06 [2019-10-15T22:14:06.434Z] ++ '[' -n 0 ']'
22:14:06 [2019-10-15T22:14:06.434Z] ++ set -x
22:14:06 [2019-10-15T22:14:06.434Z] ++ 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
22:14:06 [2019-10-15T22:14:06.717Z] INFO: Testing against a local daemon
22:14:06 [2019-10-15T22:14:06.717Z] === RUN   TestCheckpoint
22:14:06 [2019-10-15T22:14:06.717Z] --- SKIP: TestCheckpoint (0.00s)
22:14:06 [2019-10-15T22:14:06.717Z]     checkpoint_test.go:33: TestCheckpoint is broken; see https://github.com/moby/moby/issues/38963
22:14:06 [2019-10-15T22:14:06.717Z] === RUN   TestContainerInvalidJSON
22:14:06 [2019-10-15T22:14:06.717Z] === RUN   TestContainerInvalidJSON//containers/foobar/copy
22:14:06 [2019-10-15T22:14:06.717Z] === PAUSE TestContainerInvalidJSON//containers/foobar/copy
22:14:06 [2019-10-15T22:14:06.717Z] === RUN   TestContainerInvalidJSON//containers/foobar/exec
22:14:06 [2019-10-15T22:14:06.717Z] === PAUSE TestContainerInvalidJSON//containers/foobar/exec
22:14:06 [2019-10-15T22:14:06.717Z] === RUN   TestContainerInvalidJSON//exec/foobar/start
22:14:06 [2019-10-15T22:14:06.717Z] === PAUSE TestContainerInvalidJSON//exec/foobar/start
22:14:06 [2019-10-15T22:14:06.717Z] === CONT  TestContainerInvalidJSON//containers/foobar/copy
22:14:06 [2019-10-15T22:14:06.717Z] === CONT  TestContainerInvalidJSON//exec/foobar/start
22:14:06 [2019-10-15T22:14:06.717Z] === CONT  TestContainerInvalidJSON//containers/foobar/exec
22:14:06 [2019-10-15T22:14:06.717Z] --- PASS: TestContainerInvalidJSON (0.03s)
22:14:06 [2019-10-15T22:14:06.717Z]     --- PASS: TestContainerInvalidJSON//containers/foobar/exec (0.00s)
22:14:06 [2019-10-15T22:14:06.717Z]     --- PASS: TestContainerInvalidJSON//containers/foobar/copy (0.00s)
22:14:06 [2019-10-15T22:14:06.717Z]     --- PASS: TestContainerInvalidJSON//exec/foobar/start (0.00s)
22:14:06 [2019-10-15T22:14:06.717Z] === RUN   TestCopyFromContainerPathDoesNotExist
22:14:06 [2019-10-15T22:14:06.717Z] --- PASS: TestCopyFromContainerPathDoesNotExist (0.08s)
22:14:06 [2019-10-15T22:14:06.717Z] === RUN   TestCopyFromContainerPathIsNotDir
22:14:07 [2019-10-15T22:14:07.004Z] --- PASS: TestCopyFromContainerPathIsNotDir (0.09s)
22:14:07 [2019-10-15T22:14:07.004Z] === RUN   TestCopyToContainerPathDoesNotExist
22:14:07 [2019-10-15T22:14:07.004Z] --- PASS: TestCopyToContainerPathDoesNotExist (0.08s)
22:14:07 [2019-10-15T22:14:07.004Z] === RUN   TestCopyToContainerPathIsNotDir
22:14:07 [2019-10-15T22:14:07.004Z] --- PASS: TestCopyToContainerPathIsNotDir (0.08s)
22:14:07 [2019-10-15T22:14:07.004Z] === RUN   TestCopyFromContainer
22:14:08 [2019-10-15T22:14:08.478Z] === RUN   TestCopyFromContainer//
22:14:08 [2019-10-15T22:14:08.763Z] === RUN   TestCopyFromContainer//bar/root
22:14:08 [2019-10-15T22:14:08.763Z] === RUN   TestCopyFromContainer//bar/root/
22:14:08 [2019-10-15T22:14:08.763Z] === RUN   TestCopyFromContainer/bar/quux
22:14:09 [2019-10-15T22:14:09.047Z] === RUN   TestCopyFromContainer/bar/quux/
22:14:09 [2019-10-15T22:14:09.047Z] === RUN   TestCopyFromContainer/bar/quux/baz
22:14:09 [2019-10-15T22:14:09.047Z] === RUN   TestCopyFromContainer/bar/filesymlink
22:14:09 [2019-10-15T22:14:09.047Z] === RUN   TestCopyFromContainer/bar/dirsymlink
22:14:09 [2019-10-15T22:14:09.332Z] === RUN   TestCopyFromContainer/bar/dirsymlink/
22:14:09 [2019-10-15T22:14:09.332Z] === RUN   TestCopyFromContainer/bar/notarget
22:14:09 [2019-10-15T22:14:09.617Z] --- PASS: TestCopyFromContainer (2.47s)
22:14:09 [2019-10-15T22:14:09.618Z]     --- PASS: TestCopyFromContainer// (0.09s)
22:14:09 [2019-10-15T22:14:09.618Z]     --- PASS: TestCopyFromContainer//bar/root (0.10s)
22:14:09 [2019-10-15T22:14:09.618Z]     --- PASS: TestCopyFromContainer//bar/root/ (0.09s)
22:14:09 [2019-10-15T22:14:09.618Z]     --- PASS: TestCopyFromContainer/bar/quux (0.11s)
22:14:09 [2019-10-15T22:14:09.618Z]     --- PASS: TestCopyFromContainer/bar/quux/ (0.09s)
22:14:09 [2019-10-15T22:14:09.618Z]     --- PASS: TestCopyFromContainer/bar/quux/baz (0.08s)
22:14:09 [2019-10-15T22:14:09.618Z]     --- PASS: TestCopyFromContainer/bar/filesymlink (0.08s)
22:14:09 [2019-10-15T22:14:09.618Z]     --- PASS: TestCopyFromContainer/bar/dirsymlink (0.08s)
22:14:09 [2019-10-15T22:14:09.618Z]     --- PASS: TestCopyFromContainer/bar/dirsymlink/ (0.08s)
22:14:09 [2019-10-15T22:14:09.618Z]     --- PASS: TestCopyFromContainer/bar/notarget (0.08s)
22:14:09 [2019-10-15T22:14:09.618Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist
22:14:09 [2019-10-15T22:14:09.618Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
22:14:09 [2019-10-15T22:14:09.618Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
22:14:09 [2019-10-15T22:14:09.618Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
22:14:09 [2019-10-15T22:14:09.618Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
22:14:09 [2019-10-15T22:14:09.618Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/digest
22:14:09 [2019-10-15T22:14:09.618Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/digest
22:14:09 [2019-10-15T22:14:09.618Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
22:14:09 [2019-10-15T22:14:09.618Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
22:14:09 [2019-10-15T22:14:09.618Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/digest
22:14:09 [2019-10-15T22:14:09.618Z] --- PASS: TestCreateFailsWhenIdentifierDoesNotExist (0.03s)
22:14:09 [2019-10-15T22:14:09.618Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag (0.01s)
22:14:09 [2019-10-15T22:14:09.618Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/digest (0.00s)
22:14:09 [2019-10-15T22:14:09.618Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag (0.01s)
22:14:09 [2019-10-15T22:14:09.618Z] === RUN   TestCreateLinkToNonExistingContainer
22:14:09 [2019-10-15T22:14:09.618Z] --- PASS: TestCreateLinkToNonExistingContainer (0.05s)
22:14:09 [2019-10-15T22:14:09.618Z] === RUN   TestCreateWithInvalidEnv
22:14:09 [2019-10-15T22:14:09.618Z] === RUN   TestCreateWithInvalidEnv/0
22:14:09 [2019-10-15T22:14:09.618Z] === PAUSE TestCreateWithInvalidEnv/0
22:14:09 [2019-10-15T22:14:09.618Z] === RUN   TestCreateWithInvalidEnv/1
22:14:09 [2019-10-15T22:14:09.618Z] === PAUSE TestCreateWithInvalidEnv/1
22:14:09 [2019-10-15T22:14:09.618Z] === RUN   TestCreateWithInvalidEnv/2
22:14:09 [2019-10-15T22:14:09.618Z] === PAUSE TestCreateWithInvalidEnv/2
22:14:09 [2019-10-15T22:14:09.618Z] === CONT  TestCreateWithInvalidEnv/0
22:14:09 [2019-10-15T22:14:09.618Z] === CONT  TestCreateWithInvalidEnv/2
22:14:09 [2019-10-15T22:14:09.618Z] === CONT  TestCreateWithInvalidEnv/1
22:14:09 [2019-10-15T22:14:09.618Z] --- PASS: TestCreateWithInvalidEnv (0.02s)
22:14:09 [2019-10-15T22:14:09.618Z]     --- PASS: TestCreateWithInvalidEnv/0 (0.00s)
22:14:09 [2019-10-15T22:14:09.618Z]     --- PASS: TestCreateWithInvalidEnv/2 (0.00s)
22:14:09 [2019-10-15T22:14:09.618Z]     --- PASS: TestCreateWithInvalidEnv/1 (0.00s)
22:14:09 [2019-10-15T22:14:09.618Z] === RUN   TestCreateTmpfsMountsTarget
22:14:09 [2019-10-15T22:14:09.618Z] --- PASS: TestCreateTmpfsMountsTarget (0.03s)
22:14:09 [2019-10-15T22:14:09.618Z] === RUN   TestCreateWithCustomMaskedPaths
22:14:11 [2019-10-15T22:14:11.646Z] --- PASS: TestCreateWithCustomMaskedPaths (1.84s)
22:14:11 [2019-10-15T22:14:11.646Z] === RUN   TestCreateWithCapabilities
22:14:11 [2019-10-15T22:14:11.646Z] === RUN   TestCreateWithCapabilities/no_capabilities
22:14:11 [2019-10-15T22:14:11.646Z] === PAUSE TestCreateWithCapabilities/no_capabilities
22:14:11 [2019-10-15T22:14:11.646Z] === RUN   TestCreateWithCapabilities/empty_capabilities
22:14:11 [2019-10-15T22:14:11.646Z] === PAUSE TestCreateWithCapabilities/empty_capabilities
22:14:11 [2019-10-15T22:14:11.646Z] === RUN   TestCreateWithCapabilities/valid_capabilities
22:14:11 [2019-10-15T22:14:11.646Z] === PAUSE TestCreateWithCapabilities/valid_capabilities
22:14:11 [2019-10-15T22:14:11.646Z] === RUN   TestCreateWithCapabilities/invalid_capabilities
22:14:11 [2019-10-15T22:14:11.646Z] === PAUSE TestCreateWithCapabilities/invalid_capabilities
22:14:11 [2019-10-15T22:14:11.646Z] === RUN   TestCreateWithCapabilities/duplicate_capabilities
22:14:11 [2019-10-15T22:14:11.646Z] === PAUSE TestCreateWithCapabilities/duplicate_capabilities
22:14:11 [2019-10-15T22:14:11.646Z] === RUN   TestCreateWithCapabilities/capabilities_API_v1.39
22:14:11 [2019-10-15T22:14:11.646Z] === PAUSE TestCreateWithCapabilities/capabilities_API_v1.39
22:14:11 [2019-10-15T22:14:11.646Z] === RUN   TestCreateWithCapabilities/empty_capadd
22:14:11 [2019-10-15T22:14:11.646Z] === PAUSE TestCreateWithCapabilities/empty_capadd
22:14:11 [2019-10-15T22:14:11.646Z] === RUN   TestCreateWithCapabilities/empty_capdrop
22:14:11 [2019-10-15T22:14:11.646Z] === PAUSE TestCreateWithCapabilities/empty_capdrop
22:14:11 [2019-10-15T22:14:11.646Z] === RUN   TestCreateWithCapabilities/capadd_capdrop
22:14:11 [2019-10-15T22:14:11.646Z] === PAUSE TestCreateWithCapabilities/capadd_capdrop
22:14:11 [2019-10-15T22:14:11.646Z] === RUN   TestCreateWithCapabilities/conflict_with_capadd
22:14:11 [2019-10-15T22:14:11.646Z] === PAUSE TestCreateWithCapabilities/conflict_with_capadd
22:14:11 [2019-10-15T22:14:11.646Z] === RUN   TestCreateWithCapabilities/conflict_with_capdrop
22:14:11 [2019-10-15T22:14:11.646Z] === PAUSE TestCreateWithCapabilities/conflict_with_capdrop
22:14:11 [2019-10-15T22:14:11.646Z] === CONT  TestCreateWithCapabilities/no_capabilities
22:14:11 [2019-10-15T22:14:11.646Z] === CONT  TestCreateWithCapabilities/empty_capadd
22:14:11 [2019-10-15T22:14:11.646Z] === CONT  TestCreateWithCapabilities/invalid_capabilities
22:14:11 [2019-10-15T22:14:11.646Z] === CONT  TestCreateWithCapabilities/conflict_with_capdrop
22:14:11 [2019-10-15T22:14:11.646Z] === CONT  TestCreateWithCapabilities/valid_capabilities
22:14:11 [2019-10-15T22:14:11.646Z] === CONT  TestCreateWithCapabilities/empty_capabilities
22:14:11 [2019-10-15T22:14:11.646Z] === CONT  TestCreateWithCapabilities/conflict_with_capadd
22:14:11 [2019-10-15T22:14:11.646Z] === CONT  TestCreateWithCapabilities/capadd_capdrop
22:14:11 [2019-10-15T22:14:11.646Z] === CONT  TestCreateWithCapabilities/empty_capdrop
22:14:11 [2019-10-15T22:14:11.646Z] === CONT  TestCreateWithCapabilities/duplicate_capabilities
22:14:11 [2019-10-15T22:14:11.646Z] === CONT  TestCreateWithCapabilities/capabilities_API_v1.39
22:14:11 [2019-10-15T22:14:11.646Z] --- PASS: TestCreateWithCapabilities (0.03s)
22:14:11 [2019-10-15T22:14:11.646Z]     --- PASS: TestCreateWithCapabilities/invalid_capabilities (0.00s)
22:14:11 [2019-10-15T22:14:11.646Z]     --- PASS: TestCreateWithCapabilities/conflict_with_capdrop (0.01s)
22:14:11 [2019-10-15T22:14:11.646Z]     --- PASS: TestCreateWithCapabilities/empty_capadd (0.05s)
22:14:11 [2019-10-15T22:14:11.646Z]     --- PASS: TestCreateWithCapabilities/empty_capabilities (0.04s)
22:14:11 [2019-10-15T22:14:11.646Z]     --- PASS: TestCreateWithCapabilities/conflict_with_capadd (0.00s)
22:14:11 [2019-10-15T22:14:11.646Z]     --- PASS: TestCreateWithCapabilities/no_capabilities (0.05s)
22:14:11 [2019-10-15T22:14:11.646Z]     --- PASS: TestCreateWithCapabilities/valid_capabilities (0.05s)
22:14:11 [2019-10-15T22:14:11.646Z]     --- PASS: TestCreateWithCapabilities/capadd_capdrop (0.05s)
22:14:11 [2019-10-15T22:14:11.646Z]     --- PASS: TestCreateWithCapabilities/duplicate_capabilities (0.05s)
22:14:11 [2019-10-15T22:14:11.646Z]     --- PASS: TestCreateWithCapabilities/empty_capdrop (0.05s)
22:14:11 [2019-10-15T22:14:11.646Z]     --- PASS: TestCreateWithCapabilities/capabilities_API_v1.39 (0.05s)
22:14:11 [2019-10-15T22:14:11.646Z] === RUN   TestCreateWithCustomReadonlyPaths
22:14:13 [2019-10-15T22:14:13.683Z] --- PASS: TestCreateWithCustomReadonlyPaths (1.90s)
22:14:13 [2019-10-15T22:14:13.683Z] === RUN   TestCreateWithInvalidHealthcheckParams
22:14:13 [2019-10-15T22:14:13.683Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
22:14:13 [2019-10-15T22:14:13.683Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
22:14:13 [2019-10-15T22:14:13.683Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
22:14:13 [2019-10-15T22:14:13.683Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
22:14:13 [2019-10-15T22:14:13.683Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
22:14:13 [2019-10-15T22:14:13.683Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
22:14:13 [2019-10-15T22:14:13.683Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
22:14:13 [2019-10-15T22:14:13.683Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
22:14:13 [2019-10-15T22:14:13.683Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
22:14:13 [2019-10-15T22:14:13.683Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
22:14:13 [2019-10-15T22:14:13.683Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
22:14:13 [2019-10-15T22:14:13.683Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
22:14:13 [2019-10-15T22:14:13.683Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
22:14:13 [2019-10-15T22:14:13.683Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
22:14:13 [2019-10-15T22:14:13.683Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
22:14:13 [2019-10-15T22:14:13.683Z] --- PASS: TestCreateWithInvalidHealthcheckParams (0.03s)
22:14:13 [2019-10-15T22:14:13.683Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms (0.02s)
22:14:13 [2019-10-15T22:14:13.683Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms (0.03s)
22:14:13 [2019-10-15T22:14:13.683Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0 (0.03s)
22:14:13 [2019-10-15T22:14:13.683Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s (0.04s)
22:14:13 [2019-10-15T22:14:13.683Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms (0.02s)
22:14:13 [2019-10-15T22:14:13.683Z] === RUN   TestContainerStartOnDaemonRestart
22:14:13 [2019-10-15T22:14:13.683Z] === PAUSE TestContainerStartOnDaemonRestart
22:14:13 [2019-10-15T22:14:13.683Z] === RUN   TestDaemonRestartIpcMode
22:14:13 [2019-10-15T22:14:13.683Z] === PAUSE TestDaemonRestartIpcMode
22:14:13 [2019-10-15T22:14:13.683Z] === RUN   TestDiff
22:14:14 [2019-10-15T22:14:14.304Z] --- PASS: TestDiff (0.70s)
22:14:14 [2019-10-15T22:14:14.304Z] === RUN   TestExecWithCloseStdin
22:14:15 [2019-10-15T22:14:15.313Z] --- PASS: TestExecWithCloseStdin (0.86s)
22:14:15 [2019-10-15T22:14:15.313Z] === RUN   TestExec
22:14:15 [2019-10-15T22:14:15.933Z] --- PASS: TestExec (0.81s)
22:14:15 [2019-10-15T22:14:15.933Z] === RUN   TestExecUser
22:14:16 [2019-10-15T22:14:16.944Z] --- PASS: TestExecUser (0.85s)
22:14:16 [2019-10-15T22:14:16.944Z] === RUN   TestExportContainerAndImportImage
22:14:17 [2019-10-15T22:14:17.954Z] --- PASS: TestExportContainerAndImportImage (0.97s)
22:14:17 [2019-10-15T22:14:17.954Z] === RUN   TestExportContainerAfterDaemonRestart
22:14:19 [2019-10-15T22:14:19.433Z] --- PASS: TestExportContainerAfterDaemonRestart (1.55s)
22:14:19 [2019-10-15T22:14:19.433Z]     export_test.go:63: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestExportContainerAfterDaemonRestart"
22:14:19 [2019-10-15T22:14:19.433Z] === RUN   TestHealthCheckWorkdir
22:14:20 [2019-10-15T22:14:20.574Z] --- PASS: TestHealthCheckWorkdir (1.07s)
22:14:20 [2019-10-15T22:14:20.574Z] === RUN   TestHealthKillContainer
22:14:23 [2019-10-15T22:14:23.245Z] --- PASS: TestHealthKillContainer (2.87s)
22:14:23 [2019-10-15T22:14:23.245Z] === RUN   TestInspectCpusetInConfigPre120
22:14:23 [2019-10-15T22:14:23.866Z] --- PASS: TestInspectCpusetInConfigPre120 (0.64s)
22:14:23 [2019-10-15T22:14:23.866Z] === RUN   TestIpcModeNone
22:14:24 [2019-10-15T22:14:24.875Z] --- PASS: TestIpcModeNone (0.83s)
22:14:24 [2019-10-15T22:14:24.875Z] === RUN   TestIpcModePrivate
22:14:25 [2019-10-15T22:14:25.494Z] --- PASS: TestIpcModePrivate (0.82s)
22:14:25 [2019-10-15T22:14:25.494Z]     ipcmode_linux_test.go:90: [testIpcPrivateShareable] ipcmode: private, ipcdev: 0:63, shared: false, mustBeShared: false
22:14:25 [2019-10-15T22:14:25.494Z] === RUN   TestIpcModeShareable
22:14:26 [2019-10-15T22:14:26.506Z] --- PASS: TestIpcModeShareable (0.83s)
22:14:26 [2019-10-15T22:14:26.506Z]     ipcmode_linux_test.go:90: [testIpcPrivateShareable] ipcmode: shareable, ipcdev: 0:57, shared: true, mustBeShared: true
22:14:26 [2019-10-15T22:14:26.506Z] === RUN   TestAPIIpcModeShareableAndContainer
22:14:29 [2019-10-15T22:14:29.194Z] --- PASS: TestAPIIpcModeShareableAndContainer (2.36s)
22:14:29 [2019-10-15T22:14:29.194Z] === RUN   TestAPIIpcModeHost
22:14:29 [2019-10-15T22:14:29.479Z] --- PASS: TestAPIIpcModeHost (0.68s)
22:14:29 [2019-10-15T22:14:29.479Z] === RUN   TestDaemonIpcModeShareable
22:14:31 [2019-10-15T22:14:31.503Z] --- PASS: TestDaemonIpcModeShareable (1.72s)
22:14:31 [2019-10-15T22:14:31.503Z]     ipcmode_linux_test.go:230: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModeShareable"
22:14:31 [2019-10-15T22:14:31.503Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:65, shared: true, mustBeShared: true
22:14:31 [2019-10-15T22:14:31.503Z] === RUN   TestDaemonIpcModePrivate
22:14:32 [2019-10-15T22:14:32.981Z] --- PASS: TestDaemonIpcModePrivate (1.74s)
22:14:32 [2019-10-15T22:14:32.981Z]     ipcmode_linux_test.go:230: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModePrivate"
22:14:32 [2019-10-15T22:14:32.981Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:71, shared: false, mustBeShared: false
22:14:32 [2019-10-15T22:14:32.981Z] === RUN   TestDaemonIpcModePrivateFromConfig
22:14:34 [2019-10-15T22:14:34.482Z] --- PASS: TestDaemonIpcModePrivateFromConfig (1.70s)
22:14:34 [2019-10-15T22:14:34.482Z]     ipcmode_linux_test.go:230: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModePrivateFromConfig"
22:14:34 [2019-10-15T22:14:34.482Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:71, shared: false, mustBeShared: false
22:14:34 [2019-10-15T22:14:34.482Z] === RUN   TestDaemonIpcModeShareableFromConfig
22:14:36 [2019-10-15T22:14:36.508Z] --- PASS: TestDaemonIpcModeShareableFromConfig (1.73s)
22:14:36 [2019-10-15T22:14:36.508Z]     ipcmode_linux_test.go:230: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModeShareableFromConfig"
22:14:36 [2019-10-15T22:14:36.508Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:65, shared: true, mustBeShared: true
22:14:36 [2019-10-15T22:14:36.508Z] === RUN   TestIpcModeOlderClient
22:14:36 [2019-10-15T22:14:36.508Z] === PAUSE TestIpcModeOlderClient
22:14:36 [2019-10-15T22:14:36.508Z] === RUN   TestKillContainerInvalidSignal
22:14:37 [2019-10-15T22:14:37.130Z] --- PASS: TestKillContainerInvalidSignal (0.70s)
22:14:37 [2019-10-15T22:14:37.130Z] === RUN   TestKillContainer
22:14:37 [2019-10-15T22:14:37.130Z] === RUN   TestKillContainer/no_signal
22:14:37 [2019-10-15T22:14:37.748Z] === RUN   TestKillContainer/non_killing_signal
22:14:38 [2019-10-15T22:14:38.031Z] === RUN   TestKillContainer/killing_signal
22:14:39 [2019-10-15T22:14:39.040Z] --- PASS: TestKillContainer (2.04s)
22:14:39 [2019-10-15T22:14:39.040Z]     --- PASS: TestKillContainer/no_signal (0.68s)
22:14:39 [2019-10-15T22:14:39.040Z]     --- PASS: TestKillContainer/non_killing_signal (0.44s)
22:14:39 [2019-10-15T22:14:39.040Z]     --- PASS: TestKillContainer/killing_signal (0.66s)
22:14:39 [2019-10-15T22:14:39.040Z] === RUN   TestKillWithStopSignalAndRestartPolicies
22:14:39 [2019-10-15T22:14:39.040Z] === RUN   TestKillWithStopSignalAndRestartPolicies/same-signal-disables-restart-policy
22:14:39 [2019-10-15T22:14:39.657Z] === RUN   TestKillWithStopSignalAndRestartPolicies/different-signal-keep-restart-policy
22:14:40 [2019-10-15T22:14:40.667Z] --- PASS: TestKillWithStopSignalAndRestartPolicies (1.38s)
22:14:40 [2019-10-15T22:14:40.667Z]     --- PASS: TestKillWithStopSignalAndRestartPolicies/same-signal-disables-restart-policy (0.67s)
22:14:40 [2019-10-15T22:14:40.667Z]     --- PASS: TestKillWithStopSignalAndRestartPolicies/different-signal-keep-restart-policy (0.44s)
22:14:40 [2019-10-15T22:14:40.667Z] === RUN   TestKillStoppedContainer
22:14:40 [2019-10-15T22:14:40.667Z] --- PASS: TestKillStoppedContainer (0.10s)
22:14:40 [2019-10-15T22:14:40.667Z] === RUN   TestKillStoppedContainerAPIPre120
22:14:40 [2019-10-15T22:14:40.667Z] --- PASS: TestKillStoppedContainerAPIPre120 (0.08s)
22:14:40 [2019-10-15T22:14:40.667Z] === RUN   TestKillDifferentUserContainer
22:14:41 [2019-10-15T22:14:41.284Z] --- PASS: TestKillDifferentUserContainer (0.70s)
22:14:41 [2019-10-15T22:14:41.284Z] === RUN   TestInspectOomKilledTrue
22:14:42 [2019-10-15T22:14:42.760Z] --- PASS: TestInspectOomKilledTrue (1.24s)
22:14:42 [2019-10-15T22:14:42.760Z] === RUN   TestInspectOomKilledFalse
22:14:43 [2019-10-15T22:14:43.375Z] --- PASS: TestInspectOomKilledFalse (0.66s)
22:14:43 [2019-10-15T22:14:43.375Z] === RUN   TestLinksEtcHostsContentMatch
22:14:44 [2019-10-15T22:14:44.011Z] --- PASS: TestLinksEtcHostsContentMatch (0.64s)
22:14:44 [2019-10-15T22:14:44.012Z] === RUN   TestLinksContainerNames
22:14:45 [2019-10-15T22:14:45.489Z] --- PASS: TestLinksContainerNames (1.35s)
22:14:45 [2019-10-15T22:14:45.489Z] === RUN   TestLogsFollowTailEmpty
22:14:45 [2019-10-15T22:14:45.772Z] --- PASS: TestLogsFollowTailEmpty (0.65s)
22:14:45 [2019-10-15T22:14:45.772Z] === RUN   TestContainerNetworkMountsNoChown
22:14:46 [2019-10-15T22:14:46.387Z] --- PASS: TestContainerNetworkMountsNoChown (0.66s)
22:14:46 [2019-10-15T22:14:46.387Z] === RUN   TestMountDaemonRoot
22:14:46 [2019-10-15T22:14:46.674Z] === RUN   TestMountDaemonRoot/default
22:14:46 [2019-10-15T22:14:46.674Z] === PAUSE TestMountDaemonRoot/default
22:14:46 [2019-10-15T22:14:46.674Z] === RUN   TestMountDaemonRoot/private
22:14:46 [2019-10-15T22:14:46.674Z] === PAUSE TestMountDaemonRoot/private
22:14:46 [2019-10-15T22:14:46.674Z] === RUN   TestMountDaemonRoot/rprivate
22:14:46 [2019-10-15T22:14:46.674Z] === PAUSE TestMountDaemonRoot/rprivate
22:14:46 [2019-10-15T22:14:46.674Z] === RUN   TestMountDaemonRoot/slave
22:14:46 [2019-10-15T22:14:46.674Z] === PAUSE TestMountDaemonRoot/slave
22:14:46 [2019-10-15T22:14:46.674Z] === RUN   TestMountDaemonRoot/rslave
22:14:46 [2019-10-15T22:14:46.674Z] === PAUSE TestMountDaemonRoot/rslave
22:14:46 [2019-10-15T22:14:46.674Z] === RUN   TestMountDaemonRoot/shared
22:14:46 [2019-10-15T22:14:46.674Z] === PAUSE TestMountDaemonRoot/shared
22:14:46 [2019-10-15T22:14:46.674Z] === RUN   TestMountDaemonRoot/rshared
22:14:46 [2019-10-15T22:14:46.674Z] === PAUSE TestMountDaemonRoot/rshared
22:14:46 [2019-10-15T22:14:46.674Z] === CONT  TestMountDaemonRoot/default
22:14:46 [2019-10-15T22:14:46.674Z] === CONT  TestMountDaemonRoot/rshared
22:14:46 [2019-10-15T22:14:46.674Z] === CONT  TestMountDaemonRoot/shared
22:14:46 [2019-10-15T22:14:46.674Z] === CONT  TestMountDaemonRoot/rslave
22:14:46 [2019-10-15T22:14:46.674Z] === RUN   TestMountDaemonRoot/rshared/mount_root
22:14:46 [2019-10-15T22:14:46.674Z] === RUN   TestMountDaemonRoot/rslave/bind_root
22:14:46 [2019-10-15T22:14:46.674Z] === PAUSE TestMountDaemonRoot/rshared/mount_root
22:14:46 [2019-10-15T22:14:46.674Z] === RUN   TestMountDaemonRoot/rshared/mount_subpath
22:14:46 [2019-10-15T22:14:46.674Z] === PAUSE TestMountDaemonRoot/rshared/mount_subpath
22:14:46 [2019-10-15T22:14:46.674Z] === RUN   TestMountDaemonRoot/rshared/bind_root
22:14:46 [2019-10-15T22:14:46.674Z] === PAUSE TestMountDaemonRoot/rshared/bind_root
22:14:46 [2019-10-15T22:14:46.674Z] === RUN   TestMountDaemonRoot/rshared/bind_subpath
22:14:46 [2019-10-15T22:14:46.674Z] === PAUSE TestMountDaemonRoot/rshared/bind_subpath
22:14:46 [2019-10-15T22:14:46.674Z] === RUN   TestMountDaemonRoot/default/bind_root
22:14:46 [2019-10-15T22:14:46.674Z] === PAUSE TestMountDaemonRoot/default/bind_root
22:14:46 [2019-10-15T22:14:46.674Z] === RUN   TestMountDaemonRoot/default/bind_subpath
22:14:46 [2019-10-15T22:14:46.674Z] === PAUSE TestMountDaemonRoot/default/bind_subpath
22:14:46 [2019-10-15T22:14:46.674Z] === RUN   TestMountDaemonRoot/default/mount_root
22:14:46 [2019-10-15T22:14:46.674Z] === PAUSE TestMountDaemonRoot/default/mount_root
22:14:46 [2019-10-15T22:14:46.674Z] === RUN   TestMountDaemonRoot/default/mount_subpath
22:14:46 [2019-10-15T22:14:46.674Z] === PAUSE TestMountDaemonRoot/default/mount_subpath
22:14:46 [2019-10-15T22:14:46.674Z] === PAUSE TestMountDaemonRoot/rslave/bind_root
22:14:46 [2019-10-15T22:14:46.674Z] === RUN   TestMountDaemonRoot/rslave/bind_subpath
22:14:46 [2019-10-15T22:14:46.674Z] === PAUSE TestMountDaemonRoot/rslave/bind_subpath
22:14:46 [2019-10-15T22:14:46.674Z] === RUN   TestMountDaemonRoot/rslave/mount_root
22:14:46 [2019-10-15T22:14:46.674Z] === PAUSE TestMountDaemonRoot/rslave/mount_root
22:14:46 [2019-10-15T22:14:46.674Z] === RUN   TestMountDaemonRoot/rslave/mount_subpath
22:14:46 [2019-10-15T22:14:46.674Z] === PAUSE TestMountDaemonRoot/rslave/mount_subpath
22:14:46 [2019-10-15T22:14:46.674Z] === CONT  TestMountDaemonRoot/rprivate
22:14:46 [2019-10-15T22:14:46.674Z] === RUN   TestMountDaemonRoot/rprivate/bind_root
22:14:46 [2019-10-15T22:14:46.674Z] === PAUSE TestMountDaemonRoot/rprivate/bind_root
22:14:46 [2019-10-15T22:14:46.674Z] === RUN   TestMountDaemonRoot/rprivate/bind_subpath
22:14:46 [2019-10-15T22:14:46.674Z] === PAUSE TestMountDaemonRoot/rprivate/bind_subpath
22:14:46 [2019-10-15T22:14:46.674Z] === RUN   TestMountDaemonRoot/rprivate/mount_root
22:14:46 [2019-10-15T22:14:46.674Z] === PAUSE TestMountDaemonRoot/rprivate/mount_root
22:14:46 [2019-10-15T22:14:46.674Z] === RUN   TestMountDaemonRoot/rprivate/mount_subpath
22:14:46 [2019-10-15T22:14:46.674Z] === PAUSE TestMountDaemonRoot/rprivate/mount_subpath
22:14:46 [2019-10-15T22:14:46.674Z] === RUN   TestMountDaemonRoot/shared/bind_root
22:14:46 [2019-10-15T22:14:46.674Z] === PAUSE TestMountDaemonRoot/shared/bind_root
22:14:46 [2019-10-15T22:14:46.674Z] === RUN   TestMountDaemonRoot/shared/bind_subpath
22:14:46 [2019-10-15T22:14:46.675Z] === PAUSE TestMountDaemonRoot/shared/bind_subpath
22:14:46 [2019-10-15T22:14:46.675Z] === RUN   TestMountDaemonRoot/shared/mount_root
22:14:46 [2019-10-15T22:14:46.675Z] === PAUSE TestMountDaemonRoot/shared/mount_root
22:14:46 [2019-10-15T22:14:46.675Z] === RUN   TestMountDaemonRoot/shared/mount_subpath
22:14:46 [2019-10-15T22:14:46.675Z] === PAUSE TestMountDaemonRoot/shared/mount_subpath
22:14:46 [2019-10-15T22:14:46.675Z] === CONT  TestMountDaemonRoot/slave
22:14:46 [2019-10-15T22:14:46.675Z] === RUN   TestMountDaemonRoot/slave/bind_root
22:14:46 [2019-10-15T22:14:46.675Z] === PAUSE TestMountDaemonRoot/slave/bind_root
22:14:46 [2019-10-15T22:14:46.675Z] === RUN   TestMountDaemonRoot/slave/bind_subpath
22:14:46 [2019-10-15T22:14:46.675Z] === PAUSE TestMountDaemonRoot/slave/bind_subpath
22:14:46 [2019-10-15T22:14:46.675Z] === RUN   TestMountDaemonRoot/slave/mount_root
22:14:46 [2019-10-15T22:14:46.675Z] === PAUSE TestMountDaemonRoot/slave/mount_root
22:14:46 [2019-10-15T22:14:46.675Z] === RUN   TestMountDaemonRoot/slave/mount_subpath
22:14:46 [2019-10-15T22:14:46.675Z] === PAUSE TestMountDaemonRoot/slave/mount_subpath
22:14:46 [2019-10-15T22:14:46.675Z] === CONT  TestMountDaemonRoot/private
22:14:46 [2019-10-15T22:14:46.675Z] === RUN   TestMountDaemonRoot/private/bind_root
22:14:46 [2019-10-15T22:14:46.675Z] === PAUSE TestMountDaemonRoot/private/bind_root
22:14:46 [2019-10-15T22:14:46.675Z] === RUN   TestMountDaemonRoot/private/bind_subpath
22:14:46 [2019-10-15T22:14:46.675Z] === PAUSE TestMountDaemonRoot/private/bind_subpath
22:14:46 [2019-10-15T22:14:46.675Z] === RUN   TestMountDaemonRoot/private/mount_root
22:14:46 [2019-10-15T22:14:46.675Z] === PAUSE TestMountDaemonRoot/private/mount_root
22:14:46 [2019-10-15T22:14:46.675Z] === RUN   TestMountDaemonRoot/private/mount_subpath
22:14:46 [2019-10-15T22:14:46.675Z] === PAUSE TestMountDaemonRoot/private/mount_subpath
22:14:46 [2019-10-15T22:14:46.675Z] === CONT  TestMountDaemonRoot/rshared/mount_root
22:14:46 [2019-10-15T22:14:46.675Z] === CONT  TestMountDaemonRoot/default/bind_root
22:14:46 [2019-10-15T22:14:46.675Z] === CONT  TestMountDaemonRoot/rslave/bind_root
22:14:46 [2019-10-15T22:14:46.675Z] === CONT  TestMountDaemonRoot/rprivate/bind_root
22:14:46 [2019-10-15T22:14:46.675Z] === CONT  TestMountDaemonRoot/rshared/bind_subpath
22:14:46 [2019-10-15T22:14:46.675Z] === CONT  TestMountDaemonRoot/rshared/bind_root
22:14:46 [2019-10-15T22:14:46.675Z] === CONT  TestMountDaemonRoot/rshared/mount_subpath
22:14:46 [2019-10-15T22:14:46.675Z] === CONT  TestMountDaemonRoot/shared/bind_root
22:14:46 [2019-10-15T22:14:46.675Z] === CONT  TestMountDaemonRoot/slave/bind_root
22:14:46 [2019-10-15T22:14:46.675Z] === CONT  TestMountDaemonRoot/default/mount_subpath
22:14:46 [2019-10-15T22:14:46.675Z] === CONT  TestMountDaemonRoot/default/mount_root
22:14:46 [2019-10-15T22:14:46.675Z] === CONT  TestMountDaemonRoot/default/bind_subpath
22:14:46 [2019-10-15T22:14:46.675Z] === CONT  TestMountDaemonRoot/private/bind_root
22:14:46 [2019-10-15T22:14:46.675Z] === CONT  TestMountDaemonRoot/rslave/mount_subpath
22:14:46 [2019-10-15T22:14:46.675Z] === CONT  TestMountDaemonRoot/rslave/mount_root
22:14:46 [2019-10-15T22:14:46.675Z] === CONT  TestMountDaemonRoot/rslave/bind_subpath
22:14:46 [2019-10-15T22:14:46.675Z] === CONT  TestMountDaemonRoot/rprivate/mount_subpath
22:14:46 [2019-10-15T22:14:46.675Z] === CONT  TestMountDaemonRoot/rprivate/mount_root
22:14:46 [2019-10-15T22:14:46.959Z] === CONT  TestMountDaemonRoot/rprivate/bind_subpath
22:14:46 [2019-10-15T22:14:46.959Z] === CONT  TestMountDaemonRoot/shared/mount_subpath
22:14:46 [2019-10-15T22:14:46.959Z] === CONT  TestMountDaemonRoot/shared/mount_root
22:14:46 [2019-10-15T22:14:46.959Z] === CONT  TestMountDaemonRoot/shared/bind_subpath
22:14:46 [2019-10-15T22:14:46.959Z] === CONT  TestMountDaemonRoot/slave/mount_subpath
22:14:46 [2019-10-15T22:14:46.959Z] === CONT  TestMountDaemonRoot/slave/mount_root
22:14:46 [2019-10-15T22:14:46.959Z] === CONT  TestMountDaemonRoot/slave/bind_subpath
22:14:46 [2019-10-15T22:14:46.959Z] === CONT  TestMountDaemonRoot/private/mount_subpath
22:14:46 [2019-10-15T22:14:46.959Z] === CONT  TestMountDaemonRoot/private/mount_root
22:14:46 [2019-10-15T22:14:46.959Z] === CONT  TestMountDaemonRoot/private/bind_subpath
22:14:46 [2019-10-15T22:14:46.959Z] --- PASS: TestMountDaemonRoot (0.06s)
22:14:46 [2019-10-15T22:14:46.959Z]     --- PASS: TestMountDaemonRoot/rshared (0.00s)
22:14:46 [2019-10-15T22:14:46.959Z]         --- PASS: TestMountDaemonRoot/rshared/mount_root (0.07s)
22:14:46 [2019-10-15T22:14:46.959Z]         --- PASS: TestMountDaemonRoot/rshared/bind_subpath (0.06s)
22:14:46 [2019-10-15T22:14:46.959Z]         --- PASS: TestMountDaemonRoot/rshared/bind_root (0.06s)
22:14:46 [2019-10-15T22:14:46.959Z]         --- PASS: TestMountDaemonRoot/rshared/mount_subpath (0.06s)
22:14:46 [2019-10-15T22:14:46.959Z]     --- PASS: TestMountDaemonRoot/default (0.00s)
22:14:46 [2019-10-15T22:14:46.959Z]         --- PASS: TestMountDaemonRoot/default/bind_root (0.08s)
22:14:46 [2019-10-15T22:14:46.959Z]         --- PASS: TestMountDaemonRoot/default/mount_subpath (0.06s)
22:14:46 [2019-10-15T22:14:46.959Z]         --- PASS: TestMountDaemonRoot/default/mount_root (0.05s)
22:14:46 [2019-10-15T22:14:46.959Z]         --- PASS: TestMountDaemonRoot/default/bind_subpath (0.06s)
22:14:46 [2019-10-15T22:14:46.959Z]     --- PASS: TestMountDaemonRoot/rslave (0.00s)
22:14:46 [2019-10-15T22:14:46.959Z]         --- PASS: TestMountDaemonRoot/rslave/bind_root (0.08s)
22:14:46 [2019-10-15T22:14:46.959Z]         --- PASS: TestMountDaemonRoot/rslave/mount_subpath (0.05s)
22:14:46 [2019-10-15T22:14:46.959Z]         --- PASS: TestMountDaemonRoot/rslave/mount_root (0.07s)
22:14:46 [2019-10-15T22:14:46.959Z]         --- PASS: TestMountDaemonRoot/rslave/bind_subpath (0.08s)
22:14:46 [2019-10-15T22:14:46.959Z]     --- PASS: TestMountDaemonRoot/rprivate (0.00s)
22:14:46 [2019-10-15T22:14:46.959Z]         --- PASS: TestMountDaemonRoot/rprivate/bind_root (0.03s)
22:14:46 [2019-10-15T22:14:46.959Z]         --- PASS: TestMountDaemonRoot/rprivate/mount_subpath (0.04s)
22:14:46 [2019-10-15T22:14:46.959Z]         --- PASS: TestMountDaemonRoot/rprivate/mount_root (0.04s)
22:14:46 [2019-10-15T22:14:46.959Z]         --- PASS: TestMountDaemonRoot/rprivate/bind_subpath (0.04s)
22:14:46 [2019-10-15T22:14:46.959Z]     --- PASS: TestMountDaemonRoot/shared (0.00s)
22:14:46 [2019-10-15T22:14:46.959Z]         --- PASS: TestMountDaemonRoot/shared/bind_root (0.03s)
22:14:46 [2019-10-15T22:14:46.959Z]         --- PASS: TestMountDaemonRoot/shared/mount_subpath (0.04s)
22:14:46 [2019-10-15T22:14:46.959Z]         --- PASS: TestMountDaemonRoot/shared/mount_root (0.03s)
22:14:46 [2019-10-15T22:14:46.959Z]         --- PASS: TestMountDaemonRoot/shared/bind_subpath (0.03s)
22:14:46 [2019-10-15T22:14:46.959Z]     --- PASS: TestMountDaemonRoot/slave (0.00s)
22:14:46 [2019-10-15T22:14:46.959Z]         --- PASS: TestMountDaemonRoot/slave/bind_root (0.03s)
22:14:46 [2019-10-15T22:14:46.959Z]         --- PASS: TestMountDaemonRoot/slave/mount_subpath (0.03s)
22:14:46 [2019-10-15T22:14:46.959Z]         --- PASS: TestMountDaemonRoot/slave/bind_subpath (0.02s)
22:14:46 [2019-10-15T22:14:46.959Z]         --- PASS: TestMountDaemonRoot/slave/mount_root (0.04s)
22:14:46 [2019-10-15T22:14:46.959Z]     --- PASS: TestMountDaemonRoot/private (0.00s)
22:14:46 [2019-10-15T22:14:46.959Z]         --- PASS: TestMountDaemonRoot/private/bind_root (0.03s)
22:14:46 [2019-10-15T22:14:46.959Z]         --- PASS: TestMountDaemonRoot/private/mount_subpath (0.03s)
22:14:46 [2019-10-15T22:14:46.960Z]         --- PASS: TestMountDaemonRoot/private/mount_root (0.02s)
22:14:46 [2019-10-15T22:14:46.960Z]         --- PASS: TestMountDaemonRoot/private/bind_subpath (0.03s)
22:14:46 [2019-10-15T22:14:46.960Z] === RUN   TestContainerBindMountNonRecursive
22:14:48 [2019-10-15T22:14:48.437Z] --- PASS: TestContainerBindMountNonRecursive (1.61s)
22:14:48 [2019-10-15T22:14:48.437Z] === RUN   TestNetworkNat
22:14:49 [2019-10-15T22:14:49.448Z] --- PASS: TestNetworkNat (0.73s)
22:14:49 [2019-10-15T22:14:49.448Z] === RUN   TestNetworkLocalhostTCPNat
22:14:50 [2019-10-15T22:14:50.066Z] --- PASS: TestNetworkLocalhostTCPNat (0.75s)
22:14:50 [2019-10-15T22:14:50.066Z] === RUN   TestNetworkLoopbackNat
22:14:51 [2019-10-15T22:14:51.090Z] --- PASS: TestNetworkLoopbackNat (0.93s)
22:14:51 [2019-10-15T22:14:51.090Z] === RUN   TestPause
22:14:51 [2019-10-15T22:14:51.708Z] --- PASS: TestPause (0.74s)
22:14:51 [2019-10-15T22:14:51.708Z] === RUN   TestPauseFailsOnWindowsServerContainers
22:14:51 [2019-10-15T22:14:51.708Z] --- SKIP: TestPauseFailsOnWindowsServerContainers (0.00s)
22:14:51 [2019-10-15T22:14:51.708Z]     pause_test.go:54: testEnv.DaemonInfo.OSType != "windows" || testEnv.DaemonInfo.Isolation != "process"
22:14:51 [2019-10-15T22:14:51.708Z] === RUN   TestPauseStopPausedContainer
22:14:52 [2019-10-15T22:14:52.325Z] --- PASS: TestPauseStopPausedContainer (0.73s)
22:14:52 [2019-10-15T22:14:52.325Z] === RUN   TestPsFilter
22:14:52 [2019-10-15T22:14:52.609Z] --- PASS: TestPsFilter (0.20s)
22:14:52 [2019-10-15T22:14:52.610Z] === RUN   TestRemoveContainerWithRemovedVolume
22:14:53 [2019-10-15T22:14:53.238Z] --- PASS: TestRemoveContainerWithRemovedVolume (0.67s)
22:14:53 [2019-10-15T22:14:53.238Z] === RUN   TestRemoveContainerWithVolume
22:14:53 [2019-10-15T22:14:53.855Z] --- PASS: TestRemoveContainerWithVolume (0.68s)
22:14:53 [2019-10-15T22:14:53.855Z] === RUN   TestRemoveContainerRunning
22:14:54 [2019-10-15T22:14:54.863Z] --- PASS: TestRemoveContainerRunning (0.68s)
22:14:54 [2019-10-15T22:14:54.863Z] === RUN   TestRemoveContainerForceRemoveRunning
22:14:55 [2019-10-15T22:14:55.481Z] --- PASS: TestRemoveContainerForceRemoveRunning (0.68s)
22:14:55 [2019-10-15T22:14:55.481Z] === RUN   TestRemoveInvalidContainer
22:14:55 [2019-10-15T22:14:55.481Z] --- PASS: TestRemoveInvalidContainer (0.03s)
22:14:55 [2019-10-15T22:14:55.481Z] === RUN   TestRenameLinkedContainer
22:14:58 [2019-10-15T22:14:58.166Z] --- PASS: TestRenameLinkedContainer (2.64s)
22:14:58 [2019-10-15T22:14:58.166Z] === RUN   TestRenameStoppedContainer
22:14:58 [2019-10-15T22:14:58.788Z] --- PASS: TestRenameStoppedContainer (0.66s)
22:14:58 [2019-10-15T22:14:58.788Z] === RUN   TestRenameRunningContainerAndReuse
22:15:00 [2019-10-15T22:15:00.263Z] --- PASS: TestRenameRunningContainerAndReuse (1.33s)
22:15:00 [2019-10-15T22:15:00.263Z] === RUN   TestRenameInvalidName
22:15:00 [2019-10-15T22:15:00.546Z] --- PASS: TestRenameInvalidName (0.62s)
22:15:00 [2019-10-15T22:15:00.546Z] === RUN   TestRenameAnonymousContainer
22:15:03 [2019-10-15T22:15:03.229Z] --- PASS: TestRenameAnonymousContainer (2.46s)
22:15:03 [2019-10-15T22:15:03.229Z] === RUN   TestRenameContainerWithSameName
22:15:03 [2019-10-15T22:15:03.845Z] --- PASS: TestRenameContainerWithSameName (0.69s)
22:15:03 [2019-10-15T22:15:03.845Z] === RUN   TestRenameContainerWithLinkedContainer
22:15:05 [2019-10-15T22:15:05.321Z] --- PASS: TestRenameContainerWithLinkedContainer (1.33s)
22:15:05 [2019-10-15T22:15:05.321Z] === RUN   TestResize
22:15:05 [2019-10-15T22:15:05.947Z] --- PASS: TestResize (0.75s)
22:15:05 [2019-10-15T22:15:05.947Z] === RUN   TestResizeWithInvalidSize
22:15:06 [2019-10-15T22:15:06.565Z] --- PASS: TestResizeWithInvalidSize (0.70s)
22:15:06 [2019-10-15T22:15:06.565Z] === RUN   TestResizeWhenContainerNotStarted
22:15:07 [2019-10-15T22:15:07.185Z] --- PASS: TestResizeWhenContainerNotStarted (0.66s)
22:15:07 [2019-10-15T22:15:07.185Z] === RUN   TestDaemonRestartKillContainers
22:15:07 [2019-10-15T22:15:07.185Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
22:15:07 [2019-10-15T22:15:07.185Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
22:15:07 [2019-10-15T22:15:07.185Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
22:15:07 [2019-10-15T22:15:07.185Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
22:15:07 [2019-10-15T22:15:07.185Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
22:15:07 [2019-10-15T22:15:07.185Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
22:15:07 [2019-10-15T22:15:07.185Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
22:15:07 [2019-10-15T22:15:07.185Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
22:15:07 [2019-10-15T22:15:07.185Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
22:15:07 [2019-10-15T22:15:07.185Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
22:15:07 [2019-10-15T22:15:07.185Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
22:15:07 [2019-10-15T22:15:07.185Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
22:15:07 [2019-10-15T22:15:07.185Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
22:15:07 [2019-10-15T22:15:07.185Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
22:15:07 [2019-10-15T22:15:07.185Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
22:15:07 [2019-10-15T22:15:07.185Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
22:15:07 [2019-10-15T22:15:07.185Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
22:15:07 [2019-10-15T22:15:07.185Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
22:15:07 [2019-10-15T22:15:07.185Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
22:15:07 [2019-10-15T22:15:07.185Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
22:15:07 [2019-10-15T22:15:07.185Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
22:15:07 [2019-10-15T22:15:07.185Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
22:15:07 [2019-10-15T22:15:07.185Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
22:15:07 [2019-10-15T22:15:07.185Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
22:15:07 [2019-10-15T22:15:07.185Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
22:15:07 [2019-10-15T22:15:07.185Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
22:15:07 [2019-10-15T22:15:07.185Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
22:15:07 [2019-10-15T22:15:07.185Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
22:15:09 [2019-10-15T22:15:09.238Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
22:15:10 [2019-10-15T22:15:10.729Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
22:15:10 [2019-10-15T22:15:10.729Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
22:15:10 [2019-10-15T22:15:10.729Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
22:15:12 [2019-10-15T22:15:12.810Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
22:15:12 [2019-10-15T22:15:12.810Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
22:15:12 [2019-10-15T22:15:12.810Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
22:15:13 [2019-10-15T22:15:13.849Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
22:15:17 [2019-10-15T22:15:17.335Z] --- PASS: TestDaemonRestartKillContainers (0.00s)
22:15:17 [2019-10-15T22:15:17.335Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon (2.12s)
22:15:17 [2019-10-15T22:15:17.335Z]         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"
22:15:17 [2019-10-15T22:15:17.335Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon (3.34s)
22:15:17 [2019-10-15T22:15:17.335Z]         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"
22:15:17 [2019-10-15T22:15:17.335Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon (3.43s)
22:15:17 [2019-10-15T22:15:17.335Z]         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"
22:15:17 [2019-10-15T22:15:17.335Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon (3.53s)
22:15:17 [2019-10-15T22:15:17.335Z]         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"
22:15:17 [2019-10-15T22:15:17.335Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon (3.09s)
22:15:17 [2019-10-15T22:15:17.335Z]         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"
22:15:17 [2019-10-15T22:15:17.335Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon (1.96s)
22:15:17 [2019-10-15T22:15:17.335Z]         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"
22:15:17 [2019-10-15T22:15:17.335Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon (1.96s)
22:15:17 [2019-10-15T22:15:17.335Z]         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"
22:15:17 [2019-10-15T22:15:17.335Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon (3.09s)
22:15:17 [2019-10-15T22:15:17.335Z]         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"
22:15:17 [2019-10-15T22:15:17.335Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon (2.07s)
22:15:17 [2019-10-15T22:15:17.335Z]         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"
22:15:17 [2019-10-15T22:15:17.335Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon (3.07s)
22:15:17 [2019-10-15T22:15:17.335Z]         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"
22:15:17 [2019-10-15T22:15:17.335Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon (3.72s)
22:15:17 [2019-10-15T22:15:17.335Z]         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"
22:15:17 [2019-10-15T22:15:17.335Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon (3.15s)
22:15:17 [2019-10-15T22:15:17.335Z]         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"
22:15:17 [2019-10-15T22:15:17.335Z] === RUN   TestCgroupNamespacesRun
22:15:18 [2019-10-15T22:15:18.346Z] --- PASS: TestCgroupNamespacesRun (1.68s)
22:15:18 [2019-10-15T22:15:18.346Z]     run_cgroupns_linux_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRun"
22:15:18 [2019-10-15T22:15:18.346Z] === RUN   TestCgroupNamespacesRunPrivileged
22:15:20 [2019-10-15T22:15:20.391Z] --- PASS: TestCgroupNamespacesRunPrivileged (1.65s)
22:15:20 [2019-10-15T22:15:20.391Z]     run_cgroupns_linux_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunPrivileged"
22:15:20 [2019-10-15T22:15:20.391Z] === RUN   TestCgroupNamespacesRunDaemonHostMode
22:15:21 [2019-10-15T22:15:21.871Z] --- PASS: TestCgroupNamespacesRunDaemonHostMode (1.68s)
22:15:21 [2019-10-15T22:15:21.871Z]     run_cgroupns_linux_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunDaemonHostMode"
22:15:21 [2019-10-15T22:15:21.871Z] === RUN   TestCgroupNamespacesRunHostMode
22:15:23 [2019-10-15T22:15:23.360Z] --- PASS: TestCgroupNamespacesRunHostMode (1.69s)
22:15:23 [2019-10-15T22:15:23.360Z]     run_cgroupns_linux_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunHostMode"
22:15:23 [2019-10-15T22:15:23.360Z] === RUN   TestCgroupNamespacesRunPrivateMode
22:15:25 [2019-10-15T22:15:25.388Z] --- PASS: TestCgroupNamespacesRunPrivateMode (1.69s)
22:15:25 [2019-10-15T22:15:25.389Z]     run_cgroupns_linux_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunPrivateMode"
22:15:25 [2019-10-15T22:15:25.389Z] === RUN   TestCgroupNamespacesRunPrivilegedAndPrivate
22:15:26 [2019-10-15T22:15:26.008Z] --- PASS: TestCgroupNamespacesRunPrivilegedAndPrivate (0.90s)
22:15:26 [2019-10-15T22:15:26.008Z]     run_cgroupns_linux_test.go:48: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunPrivilegedAndPrivate"
22:15:26 [2019-10-15T22:15:26.008Z] === RUN   TestCgroupNamespacesRunInvalidMode
22:15:27 [2019-10-15T22:15:27.043Z] --- PASS: TestCgroupNamespacesRunInvalidMode (0.89s)
22:15:27 [2019-10-15T22:15:27.043Z]     run_cgroupns_linux_test.go:48: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunInvalidMode"
22:15:27 [2019-10-15T22:15:27.043Z] === RUN   TestCgroupNamespacesRunOlderClient
22:15:29 [2019-10-15T22:15:29.066Z] --- PASS: TestCgroupNamespacesRunOlderClient (1.74s)
22:15:29 [2019-10-15T22:15:29.066Z]     run_cgroupns_linux_test.go:139: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunOlderClient"
22:15:29 [2019-10-15T22:15:29.066Z] === RUN   TestKernelTCPMemory
22:15:29 [2019-10-15T22:15:29.682Z] --- PASS: TestKernelTCPMemory (0.88s)
22:15:29 [2019-10-15T22:15:29.682Z] === RUN   TestNISDomainname
22:15:30 [2019-10-15T22:15:30.707Z] --- PASS: TestNISDomainname (0.99s)
22:15:30 [2019-10-15T22:15:30.707Z] === RUN   TestHostnameDnsResolution
22:15:31 [2019-10-15T22:15:31.729Z] --- PASS: TestHostnameDnsResolution (1.10s)
22:15:31 [2019-10-15T22:15:31.729Z] === RUN   TestStats
22:15:33 [2019-10-15T22:15:33.759Z] --- PASS: TestStats (1.83s)
22:15:33 [2019-10-15T22:15:33.759Z] === RUN   TestStopContainerWithTimeout
22:15:33 [2019-10-15T22:15:33.759Z] === RUN   TestStopContainerWithTimeout/0
22:15:33 [2019-10-15T22:15:33.759Z] === PAUSE TestStopContainerWithTimeout/0
22:15:33 [2019-10-15T22:15:33.759Z] === RUN   TestStopContainerWithTimeout/1
22:15:33 [2019-10-15T22:15:33.759Z] === PAUSE TestStopContainerWithTimeout/1
22:15:33 [2019-10-15T22:15:33.759Z] === RUN   TestStopContainerWithTimeout/3
22:15:33 [2019-10-15T22:15:33.759Z] === PAUSE TestStopContainerWithTimeout/3
22:15:33 [2019-10-15T22:15:33.759Z] === RUN   TestStopContainerWithTimeout/-1
22:15:33 [2019-10-15T22:15:33.759Z] === PAUSE TestStopContainerWithTimeout/-1
22:15:33 [2019-10-15T22:15:33.759Z] === CONT  TestStopContainerWithTimeout/0
22:15:33 [2019-10-15T22:15:33.759Z] === CONT  TestStopContainerWithTimeout/-1
22:15:33 [2019-10-15T22:15:33.759Z] === CONT  TestStopContainerWithTimeout/1
22:15:33 [2019-10-15T22:15:33.759Z] === CONT  TestStopContainerWithTimeout/3
22:15:36 [2019-10-15T22:15:36.578Z] --- PASS: TestStopContainerWithTimeout (0.03s)
22:15:36 [2019-10-15T22:15:36.579Z]     --- PASS: TestStopContainerWithTimeout/0 (1.28s)
22:15:36 [2019-10-15T22:15:36.579Z]     --- PASS: TestStopContainerWithTimeout/1 (2.24s)
22:15:36 [2019-10-15T22:15:36.579Z]     --- PASS: TestStopContainerWithTimeout/3 (2.72s)
22:15:36 [2019-10-15T22:15:36.579Z]     --- PASS: TestStopContainerWithTimeout/-1 (3.07s)
22:15:36 [2019-10-15T22:15:36.579Z] === RUN   TestDeleteDevicemapper
22:15:36 [2019-10-15T22:15:36.579Z] --- SKIP: TestDeleteDevicemapper (0.00s)
22:15:36 [2019-10-15T22:15:36.579Z]     stop_linux_test.go:74: testEnv.DaemonInfo.Driver != "devicemapper"
22:15:36 [2019-10-15T22:15:36.579Z] === RUN   TestStopContainerWithRestartPolicyAlways
22:15:38 [2019-10-15T22:15:38.608Z] --- PASS: TestStopContainerWithRestartPolicyAlways (1.97s)
22:15:38 [2019-10-15T22:15:38.608Z] === RUN   TestUpdateMemory
22:15:39 [2019-10-15T22:15:39.624Z] --- PASS: TestUpdateMemory (1.08s)
22:15:39 [2019-10-15T22:15:39.624Z] === RUN   TestUpdateCPUQuota
22:15:41 [2019-10-15T22:15:41.100Z] --- PASS: TestUpdateCPUQuota (1.53s)
22:15:41 [2019-10-15T22:15:41.100Z] === RUN   TestUpdatePidsLimit
22:15:41 [2019-10-15T22:15:41.100Z] === RUN   TestUpdatePidsLimit/update_from_none
22:15:41 [2019-10-15T22:15:41.719Z] === RUN   TestUpdatePidsLimit/no_change
22:15:42 [2019-10-15T22:15:42.003Z] === RUN   TestUpdatePidsLimit/update_lower
22:15:42 [2019-10-15T22:15:42.286Z] === RUN   TestUpdatePidsLimit/update_on_old_api_ignores_value
22:15:42 [2019-10-15T22:15:42.569Z] === RUN   TestUpdatePidsLimit/unset_limit_with_zero
22:15:43 [2019-10-15T22:15:43.185Z] === RUN   TestUpdatePidsLimit/unset_limit_with_minus_one
22:15:43 [2019-10-15T22:15:43.468Z] === RUN   TestUpdatePidsLimit/unset_limit_with_minus_two
22:15:44 [2019-10-15T22:15:44.940Z] --- PASS: TestUpdatePidsLimit (3.88s)
22:15:44 [2019-10-15T22:15:44.941Z]     --- PASS: TestUpdatePidsLimit/update_from_none (0.37s)
22:15:44 [2019-10-15T22:15:44.941Z]     --- PASS: TestUpdatePidsLimit/no_change (0.35s)
22:15:44 [2019-10-15T22:15:44.941Z]     --- PASS: TestUpdatePidsLimit/update_lower (0.36s)
22:15:44 [2019-10-15T22:15:44.941Z]     --- PASS: TestUpdatePidsLimit/update_on_old_api_ignores_value (0.40s)
22:15:44 [2019-10-15T22:15:44.941Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_zero (0.40s)
22:15:44 [2019-10-15T22:15:44.941Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_minus_one (0.37s)
22:15:44 [2019-10-15T22:15:44.941Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_minus_two (0.40s)
22:15:44 [2019-10-15T22:15:44.941Z] === RUN   TestUpdateRestartPolicy
22:15:57 [2019-10-15T22:15:57.469Z] --- PASS: TestUpdateRestartPolicy (12.17s)
22:15:57 [2019-10-15T22:15:57.469Z] === RUN   TestUpdateRestartWithAutoRemove
22:15:58 [2019-10-15T22:15:58.085Z] --- PASS: TestUpdateRestartWithAutoRemove (0.71s)
22:15:58 [2019-10-15T22:15:58.085Z] === RUN   TestWaitNonBlocked
22:15:58 [2019-10-15T22:15:58.085Z] === RUN   TestWaitNonBlocked/wait-nonblocking-exit-0
22:15:58 [2019-10-15T22:15:58.085Z] === PAUSE TestWaitNonBlocked/wait-nonblocking-exit-0
22:15:58 [2019-10-15T22:15:58.085Z] === RUN   TestWaitNonBlocked/wait-nonblocking-exit-random
22:15:58 [2019-10-15T22:15:58.085Z] === PAUSE TestWaitNonBlocked/wait-nonblocking-exit-random
22:15:58 [2019-10-15T22:15:58.085Z] === CONT  TestWaitNonBlocked/wait-nonblocking-exit-0
22:15:58 [2019-10-15T22:15:58.085Z] === CONT  TestWaitNonBlocked/wait-nonblocking-exit-random
22:15:59 [2019-10-15T22:15:59.095Z] --- PASS: TestWaitNonBlocked (0.03s)
22:15:59 [2019-10-15T22:15:59.095Z]     --- PASS: TestWaitNonBlocked/wait-nonblocking-exit-random (0.93s)
22:15:59 [2019-10-15T22:15:59.095Z]     --- PASS: TestWaitNonBlocked/wait-nonblocking-exit-0 (0.97s)
22:15:59 [2019-10-15T22:15:59.095Z] === RUN   TestWaitBlocked
22:15:59 [2019-10-15T22:15:59.095Z] === RUN   TestWaitBlocked/test-wait-blocked-exit-zero
22:15:59 [2019-10-15T22:15:59.095Z] === PAUSE TestWaitBlocked/test-wait-blocked-exit-zero
22:15:59 [2019-10-15T22:15:59.095Z] === RUN   TestWaitBlocked/test-wait-blocked-exit-random
22:15:59 [2019-10-15T22:15:59.095Z] === PAUSE TestWaitBlocked/test-wait-blocked-exit-random
22:15:59 [2019-10-15T22:15:59.095Z] === CONT  TestWaitBlocked/test-wait-blocked-exit-zero
22:15:59 [2019-10-15T22:15:59.095Z] === CONT  TestWaitBlocked/test-wait-blocked-exit-random
22:16:00 [2019-10-15T22:16:00.106Z] --- PASS: TestWaitBlocked (0.04s)
22:16:00 [2019-10-15T22:16:00.106Z]     --- PASS: TestWaitBlocked/test-wait-blocked-exit-random (1.00s)
22:16:00 [2019-10-15T22:16:00.106Z]     --- PASS: TestWaitBlocked/test-wait-blocked-exit-zero (1.06s)
22:16:00 [2019-10-15T22:16:00.106Z] === CONT  TestContainerStartOnDaemonRestart
22:16:00 [2019-10-15T22:16:00.106Z] === CONT  TestDaemonRestartIpcMode
22:16:00 [2019-10-15T22:16:00.106Z] === CONT  TestIpcModeOlderClient
22:16:00 [2019-10-15T22:16:00.106Z] --- PASS: TestIpcModeOlderClient (0.16s)
22:16:03 [2019-10-15T22:16:03.584Z] --- PASS: TestContainerStartOnDaemonRestart (3.08s)
22:16:03 [2019-10-15T22:16:03.584Z]     daemon_linux_test.go:35: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestContainerStartOnDaemonRestart"
22:16:03 [2019-10-15T22:16:03.869Z] --- PASS: TestDaemonRestartIpcMode (3.88s)
22:16:03 [2019-10-15T22:16:03.870Z]     daemon_linux_test.go:89: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartIpcMode"
22:16:03 [2019-10-15T22:16:03.870Z] PASS
22:16:03 [2019-10-15T22:16:03.870Z] 
22:16:03 [2019-10-15T22:16:03.870Z] === Skipped
22:16:03 [2019-10-15T22:16:03.870Z] === SKIP: ppc64le.integration.container TestCheckpoint (0.00s)
22:16:03 [2019-10-15T22:16:03.870Z]     checkpoint_test.go:33: TestCheckpoint is broken; see https://github.com/moby/moby/issues/38963
22:16:03 [2019-10-15T22:16:03.870Z] 
22:16:03 [2019-10-15T22:16:03.870Z] === SKIP: ppc64le.integration.container TestPauseFailsOnWindowsServerContainers (0.00s)
22:16:03 [2019-10-15T22:16:03.870Z]     pause_test.go:54: testEnv.DaemonInfo.OSType != "windows" || testEnv.DaemonInfo.Isolation != "process"
22:16:03 [2019-10-15T22:16:03.870Z] 
22:16:03 [2019-10-15T22:16:03.870Z] === SKIP: ppc64le.integration.container TestDeleteDevicemapper (0.00s)
22:16:03 [2019-10-15T22:16:03.870Z]     stop_linux_test.go:74: testEnv.DaemonInfo.Driver != "devicemapper"
22:16:03 [2019-10-15T22:16:03.870Z] 
22:16:03 [2019-10-15T22:16:03.870Z] 
22:16:03 [2019-10-15T22:16:03.870Z] DONE 197 tests, 3 skipped in 117.352s
22:16:03 [2019-10-15T22:16:03.870Z] Running /go/src/github.com/docker/docker/integration/image (ppc64le.integration.image) flags=-test.v -test.timeout=120m 
22:16:03 [2019-10-15T22:16:03.870Z] ++ 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
22:16:03 [2019-10-15T22:16:03.870Z] ++ set -e
22:16:03 [2019-10-15T22:16:03.870Z] ++ '[' -n 0 ']'
22:16:03 [2019-10-15T22:16:03.870Z] ++ set -x
22:16:03 [2019-10-15T22:16:03.870Z] ++ 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
22:16:04 [2019-10-15T22:16:04.153Z] INFO: Testing against a local daemon
22:16:04 [2019-10-15T22:16:04.153Z] === RUN   TestCommitInheritsEnv
22:16:04 [2019-10-15T22:16:04.437Z] --- PASS: TestCommitInheritsEnv (0.41s)
22:16:04 [2019-10-15T22:16:04.437Z] === RUN   TestImportExtremelyLargeImageWorks
22:16:04 [2019-10-15T22:16:04.437Z] === PAUSE TestImportExtremelyLargeImageWorks
22:16:04 [2019-10-15T22:16:04.437Z] === RUN   TestImagesFilterMultiReference
22:16:04 [2019-10-15T22:16:04.437Z] --- PASS: TestImagesFilterMultiReference (0.07s)
22:16:04 [2019-10-15T22:16:04.437Z] === RUN   TestImagePullPlatformInvalid
22:16:04 [2019-10-15T22:16:04.723Z] --- PASS: TestImagePullPlatformInvalid (0.05s)
22:16:04 [2019-10-15T22:16:04.723Z] === RUN   TestRemoveImageOrphaning
22:16:05 [2019-10-15T22:16:05.008Z] --- PASS: TestRemoveImageOrphaning (0.40s)
22:16:05 [2019-10-15T22:16:05.008Z] === RUN   TestRemoveImageGarbageCollector
22:16:05 [2019-10-15T22:16:05.008Z] --- SKIP: TestRemoveImageGarbageCollector (0.00s)
22:16:05 [2019-10-15T22:16:05.008Z]     remove_unix_test.go:36: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:16:05 [2019-10-15T22:16:05.008Z] === RUN   TestTagUnprefixedRepoByNameOrName
22:16:05 [2019-10-15T22:16:05.008Z] --- PASS: TestTagUnprefixedRepoByNameOrName (0.05s)
22:16:05 [2019-10-15T22:16:05.008Z] === RUN   TestTagInvalidReference
22:16:05 [2019-10-15T22:16:05.008Z] --- PASS: TestTagInvalidReference (0.03s)
22:16:05 [2019-10-15T22:16:05.008Z] === RUN   TestTagValidPrefixedRepo
22:16:05 [2019-10-15T22:16:05.298Z] --- PASS: TestTagValidPrefixedRepo (0.06s)
22:16:05 [2019-10-15T22:16:05.298Z] === RUN   TestTagExistedNameWithoutForce
22:16:05 [2019-10-15T22:16:05.298Z] --- PASS: TestTagExistedNameWithoutForce (0.04s)
22:16:05 [2019-10-15T22:16:05.298Z] === RUN   TestTagOfficialNames
22:16:05 [2019-10-15T22:16:05.298Z] --- PASS: TestTagOfficialNames (0.14s)
22:16:05 [2019-10-15T22:16:05.298Z] === RUN   TestTagMatchesDigest
22:16:05 [2019-10-15T22:16:05.298Z] --- PASS: TestTagMatchesDigest (0.07s)
22:16:05 [2019-10-15T22:16:05.298Z] === CONT  TestImportExtremelyLargeImageWorks
22:21:12 [2019-10-15T22:21:12.841Z] --- PASS: TestImportExtremelyLargeImageWorks (296.55s)
22:21:12 [2019-10-15T22:21:12.841Z]     import_test.go:26: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestImportExtremelyLargeImageWorks"
22:21:12 [2019-10-15T22:21:12.841Z] PASS
22:21:12 [2019-10-15T22:21:12.841Z] 
22:21:12 [2019-10-15T22:21:12.841Z] === Skipped
22:21:12 [2019-10-15T22:21:12.841Z] === SKIP: ppc64le.integration.image TestRemoveImageGarbageCollector (0.00s)
22:21:12 [2019-10-15T22:21:12.841Z]     remove_unix_test.go:36: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:21:12 [2019-10-15T22:21:12.841Z] 
22:21:12 [2019-10-15T22:21:12.841Z] 
22:21:12 [2019-10-15T22:21:12.841Z] DONE 12 tests, 1 skipped in 298.020s
22:21:12 [2019-10-15T22:21:12.841Z] Running /go/src/github.com/docker/docker/integration/network (ppc64le.integration.network) flags=-test.v -test.timeout=120m 
22:21:12 [2019-10-15T22:21:12.841Z] ++ 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
22:21:12 [2019-10-15T22:21:12.841Z] ++ set -e
22:21:12 [2019-10-15T22:21:12.841Z] ++ '[' -n 0 ']'
22:21:12 [2019-10-15T22:21:12.841Z] ++ set -x
22:21:12 [2019-10-15T22:21:12.841Z] ++ 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
22:21:12 [2019-10-15T22:21:12.841Z] INFO: Testing against a local daemon
22:21:12 [2019-10-15T22:21:12.841Z] === RUN   TestNetworkCreateDelete
22:21:12 [2019-10-15T22:21:12.841Z] --- PASS: TestNetworkCreateDelete (0.20s)
22:21:12 [2019-10-15T22:21:12.841Z] === RUN   TestDockerNetworkDeletePreferID
22:21:12 [2019-10-15T22:21:12.841Z] --- PASS: TestDockerNetworkDeletePreferID (0.55s)
22:21:12 [2019-10-15T22:21:12.841Z] === RUN   TestInspectNetwork
22:21:12 [2019-10-15T22:21:12.841Z] === RUN   TestInspectNetwork/full_network_id
22:21:12 [2019-10-15T22:21:12.841Z] === RUN   TestInspectNetwork/partial_network_id
22:21:12 [2019-10-15T22:21:12.841Z] === RUN   TestInspectNetwork/network_name
22:21:12 [2019-10-15T22:21:12.841Z] === RUN   TestInspectNetwork/network_name_and_swarm_scope
22:21:12 [2019-10-15T22:21:12.841Z] --- PASS: TestInspectNetwork (8.35s)
22:21:12 [2019-10-15T22:21:12.841Z]     inspect_test.go:18: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestInspectNetwork"
22:21:12 [2019-10-15T22:21:12.841Z]     --- PASS: TestInspectNetwork/full_network_id (0.00s)
22:21:12 [2019-10-15T22:21:12.841Z]     --- PASS: TestInspectNetwork/partial_network_id (0.00s)
22:21:12 [2019-10-15T22:21:12.841Z]     --- PASS: TestInspectNetwork/network_name (0.00s)
22:21:12 [2019-10-15T22:21:12.841Z]     --- PASS: TestInspectNetwork/network_name_and_swarm_scope (0.00s)
22:21:12 [2019-10-15T22:21:12.841Z] === RUN   TestRunContainerWithBridgeNone
22:21:13 [2019-10-15T22:21:13.855Z] --- PASS: TestRunContainerWithBridgeNone (2.59s)
22:21:13 [2019-10-15T22:21:13.856Z]     network_test.go:25: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestRunContainerWithBridgeNone"
22:21:13 [2019-10-15T22:21:13.856Z] === RUN   TestNetworkInvalidJSON
22:21:13 [2019-10-15T22:21:13.856Z] === RUN   TestNetworkInvalidJSON//networks/create
22:21:13 [2019-10-15T22:21:13.856Z] === PAUSE TestNetworkInvalidJSON//networks/create
22:21:13 [2019-10-15T22:21:13.856Z] === RUN   TestNetworkInvalidJSON//networks/bridge/connect
22:21:13 [2019-10-15T22:21:13.856Z] === PAUSE TestNetworkInvalidJSON//networks/bridge/connect
22:21:13 [2019-10-15T22:21:13.856Z] === RUN   TestNetworkInvalidJSON//networks/bridge/disconnect
22:21:13 [2019-10-15T22:21:13.856Z] === PAUSE TestNetworkInvalidJSON//networks/bridge/disconnect
22:21:13 [2019-10-15T22:21:13.856Z] === CONT  TestNetworkInvalidJSON//networks/create
22:21:13 [2019-10-15T22:21:13.856Z] === CONT  TestNetworkInvalidJSON//networks/bridge/connect
22:21:13 [2019-10-15T22:21:13.856Z] === CONT  TestNetworkInvalidJSON//networks/bridge/disconnect
22:21:13 [2019-10-15T22:21:13.856Z] --- PASS: TestNetworkInvalidJSON (0.04s)
22:21:13 [2019-10-15T22:21:13.856Z]     --- PASS: TestNetworkInvalidJSON//networks/create (0.00s)
22:21:13 [2019-10-15T22:21:13.856Z]     --- PASS: TestNetworkInvalidJSON//networks/bridge/disconnect (0.00s)
22:21:13 [2019-10-15T22:21:13.856Z]     --- PASS: TestNetworkInvalidJSON//networks/bridge/connect (0.00s)
22:21:13 [2019-10-15T22:21:13.856Z] === RUN   TestDaemonRestartWithLiveRestore
22:21:14 [2019-10-15T22:21:14.871Z] --- PASS: TestDaemonRestartWithLiveRestore (1.06s)
22:21:14 [2019-10-15T22:21:14.871Z]     service_test.go:32: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartWithLiveRestore"
22:21:14 [2019-10-15T22:21:14.871Z] === RUN   TestDaemonDefaultNetworkPools
22:21:15 [2019-10-15T22:21:15.880Z] --- PASS: TestDaemonDefaultNetworkPools (0.76s)
22:21:15 [2019-10-15T22:21:15.880Z]     service_test.go:57: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonDefaultNetworkPools"
22:21:15 [2019-10-15T22:21:15.880Z] === RUN   TestDaemonRestartWithExistingNetwork
22:21:16 [2019-10-15T22:21:16.894Z] --- PASS: TestDaemonRestartWithExistingNetwork (1.19s)
22:21:16 [2019-10-15T22:21:16.894Z]     service_test.go:98: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartWithExistingNetwork"
22:21:16 [2019-10-15T22:21:16.894Z] === RUN   TestDaemonRestartWithExistingNetworkWithDefaultPoolRange
22:21:18 [2019-10-15T22:21:18.382Z] --- PASS: TestDaemonRestartWithExistingNetworkWithDefaultPoolRange (1.42s)
22:21:18 [2019-10-15T22:21:18.382Z]     service_test.go:131: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartWithExistingNetworkWithDefaultPoolRange"
22:21:18 [2019-10-15T22:21:18.382Z] === RUN   TestDaemonWithBipAndDefaultNetworkPool
22:21:19 [2019-10-15T22:21:19.002Z] --- PASS: TestDaemonWithBipAndDefaultNetworkPool (0.57s)
22:21:19 [2019-10-15T22:21:19.002Z]     service_test.go:181: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonWithBipAndDefaultNetworkPool"
22:21:19 [2019-10-15T22:21:19.002Z] === RUN   TestServiceWithPredefinedNetwork
22:21:21 [2019-10-15T22:21:21.686Z] --- PASS: TestServiceWithPredefinedNetwork (2.40s)
22:21:21 [2019-10-15T22:21:21.686Z]     service_test.go:203: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithPredefinedNetwork"
22:21:21 [2019-10-15T22:21:21.686Z] === RUN   TestServiceRemoveKeepsIngressNetwork
22:21:21 [2019-10-15T22:21:21.686Z] --- SKIP: TestServiceRemoveKeepsIngressNetwork (0.00s)
22:21:21 [2019-10-15T22:21:21.686Z]     service_test.go:230: FLAKY_TEST
22:21:21 [2019-10-15T22:21:21.686Z] === RUN   TestServiceWithDataPathPortInit
22:21:36 [2019-10-15T22:21:36.932Z] --- PASS: TestServiceWithDataPathPortInit (14.52s)
22:21:36 [2019-10-15T22:21:36.932Z]     service_test.go:323: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithDataPathPortInit"
22:21:36 [2019-10-15T22:21:36.932Z]     service_test.go:355: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithDataPathPortInit"
22:21:36 [2019-10-15T22:21:36.932Z] === RUN   TestServiceWithDefaultAddressPoolInit
22:21:43 [2019-10-15T22:21:43.754Z] --- PASS: TestServiceWithDefaultAddressPoolInit (7.29s)
22:21:43 [2019-10-15T22:21:43.754Z]     service_test.go:388: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithDefaultAddressPoolInit"
22:21:43 [2019-10-15T22:21:43.754Z]     service_test.go:418: TestServiceWithDefaultAddressPoolInit: NetworkInspect: {Name:sthiraTestServiceWithDefaultAddressPoolInit ID:q7flyluj7ii1l7x8c7y185ere Created:2019-10-15 22:21:36.881413668 +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[a9890cced81626e154a186cd67db404d74a02a8adf5d88b37ecfb95433169d65:{Name:TestServiceTestServiceWithDefaultAddressPoolInit.1.vg3htzzefc1zmduehz1cpcs9z EndpointID:af3f93c76b7f0ee066edc22d3fc0e174686347f97bafe2818baf7adaae5e0e65 MacAddress:02:42:14:14:00:03 IPv4Address:20.20.0.3/24 IPv6Address:} lb-sthiraTestServiceWithDefaultAddressPoolInit:{Name:sthiraTestServiceWithDefaultAddressPoolInit-endpoint EndpointID:cf5b415fae2c210849acd9d09b07d6e005f5d2f4724019778a90f2d34e46ac49 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:d3978b8ed55d IP:127.0.0.1}] Services:map[TestServiceTestServiceWithDefaultAddressPoolInit:{VIP:20.20.0.2 Ports:[] LocalLBIndex:256 Tasks:[{Name:TestServiceTestServiceWithDefaultAddressPoolInit.1.vg3htzzefc1zmduehz1cpcs9z EndpointID:af3f93c76b7f0ee066edc22d3fc0e174686347f97bafe2818baf7adaae5e0e65 EndpointIP:20.20.0.3 Info:map[Host IP:127.0.0.1]}]}]}
22:21:43 [2019-10-15T22:21:43.754Z] PASS
22:21:43 [2019-10-15T22:21:43.754Z] 
22:21:43 [2019-10-15T22:21:43.754Z] === Skipped
22:21:43 [2019-10-15T22:21:43.754Z] === SKIP: ppc64le.integration.network TestServiceRemoveKeepsIngressNetwork (0.00s)
22:21:43 [2019-10-15T22:21:43.754Z]     service_test.go:230: FLAKY_TEST
22:21:43 [2019-10-15T22:21:43.754Z] 
22:21:43 [2019-10-15T22:21:43.754Z] 
22:21:43 [2019-10-15T22:21:43.754Z] DONE 21 tests, 1 skipped in 41.050s
22:21:43 [2019-10-15T22:21:43.754Z] Running /go/src/github.com/docker/docker/integration/network/ipvlan (ppc64le.integration.network.ipvlan) flags=-test.v -test.timeout=120m 
22:21:43 [2019-10-15T22:21:43.754Z] ++ 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
22:21:43 [2019-10-15T22:21:43.754Z] ++ set -e
22:21:43 [2019-10-15T22:21:43.754Z] ++ '[' -n 0 ']'
22:21:43 [2019-10-15T22:21:43.754Z] ++ set -x
22:21:43 [2019-10-15T22:21:43.754Z] ++ 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
22:21:43 [2019-10-15T22:21:43.754Z] INFO: Testing against a local daemon
22:21:43 [2019-10-15T22:21:43.754Z] === RUN   TestDockerNetworkIpvlanPersistance
22:21:44 [2019-10-15T22:21:44.765Z] --- PASS: TestDockerNetworkIpvlanPersistance (1.45s)
22:21:44 [2019-10-15T22:21:44.765Z]     ipvlan_test.go:28: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkIpvlanPersistance"
22:21:44 [2019-10-15T22:21:44.765Z] === RUN   TestDockerNetworkIpvlan
22:21:45 [2019-10-15T22:21:45.381Z] === RUN   TestDockerNetworkIpvlan/Subinterface
22:21:46 [2019-10-15T22:21:46.407Z] === RUN   TestDockerNetworkIpvlan/OverlapParent
22:21:47 [2019-10-15T22:21:47.418Z] === RUN   TestDockerNetworkIpvlan/L2NilParent
22:21:50 [2019-10-15T22:21:50.105Z] === RUN   TestDockerNetworkIpvlan/L2InternalMode
22:21:53 [2019-10-15T22:21:53.569Z] === RUN   TestDockerNetworkIpvlan/L3NilParent
22:21:56 [2019-10-15T22:21:56.285Z] === RUN   TestDockerNetworkIpvlan/L3InternalMode
22:21:59 [2019-10-15T22:21:59.744Z] === RUN   TestDockerNetworkIpvlan/L2MultiSubnet
22:22:05 [2019-10-15T22:22:05.261Z] === RUN   TestDockerNetworkIpvlan/L3MultiSubnet
22:22:09 [2019-10-15T22:22:09.689Z] === RUN   TestDockerNetworkIpvlan/Addressing
22:22:12 [2019-10-15T22:22:12.372Z] --- PASS: TestDockerNetworkIpvlan (27.42s)
22:22:12 [2019-10-15T22:22:12.372Z]     ipvlan_test.go:88: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkIpvlan"
22:22:12 [2019-10-15T22:22:12.372Z]     --- PASS: TestDockerNetworkIpvlan/Subinterface (0.08s)
22:22:12 [2019-10-15T22:22:12.372Z]     ipvlan_test.go:88: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkIpvlan"
22:22:12 [2019-10-15T22:22:12.372Z]     --- PASS: TestDockerNetworkIpvlan/OverlapParent (0.05s)
22:22:12 [2019-10-15T22:22:12.372Z]     ipvlan_test.go:88: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkIpvlan"
22:22:12 [2019-10-15T22:22:12.372Z]     --- PASS: TestDockerNetworkIpvlan/L2NilParent (1.17s)
22:22:12 [2019-10-15T22:22:12.372Z]     ipvlan_test.go:88: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkIpvlan"
22:22:12 [2019-10-15T22:22:12.372Z]     --- PASS: TestDockerNetworkIpvlan/L2InternalMode (2.20s)
22:22:12 [2019-10-15T22:22:12.372Z]     ipvlan_test.go:88: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkIpvlan"
22:22:12 [2019-10-15T22:22:12.372Z]     --- PASS: TestDockerNetworkIpvlan/L3NilParent (1.26s)
22:22:12 [2019-10-15T22:22:12.372Z]     ipvlan_test.go:88: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkIpvlan"
22:22:12 [2019-10-15T22:22:12.372Z]     --- PASS: TestDockerNetworkIpvlan/L3InternalMode (2.21s)
22:22:12 [2019-10-15T22:22:12.372Z]     ipvlan_test.go:88: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkIpvlan"
22:22:12 [2019-10-15T22:22:12.372Z]     --- PASS: TestDockerNetworkIpvlan/L2MultiSubnet (3.33s)
22:22:12 [2019-10-15T22:22:12.372Z]     ipvlan_test.go:88: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkIpvlan"
22:22:12 [2019-10-15T22:22:12.372Z]     --- PASS: TestDockerNetworkIpvlan/L3MultiSubnet (3.66s)
22:22:12 [2019-10-15T22:22:12.372Z]     ipvlan_test.go:88: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkIpvlan"
22:22:12 [2019-10-15T22:22:12.372Z]     --- PASS: TestDockerNetworkIpvlan/Addressing (1.95s)
22:22:12 [2019-10-15T22:22:12.372Z] PASS
22:22:12 [2019-10-15T22:22:12.372Z] 
22:22:12 [2019-10-15T22:22:12.372Z] DONE 11 tests in 28.964s
22:22:12 [2019-10-15T22:22:12.372Z] Running /go/src/github.com/docker/docker/integration/network/macvlan (ppc64le.integration.network.macvlan) flags=-test.v -test.timeout=120m 
22:22:12 [2019-10-15T22:22:12.372Z] ++ 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
22:22:12 [2019-10-15T22:22:12.372Z] ++ set -e
22:22:12 [2019-10-15T22:22:12.372Z] ++ '[' -n 0 ']'
22:22:12 [2019-10-15T22:22:12.372Z] ++ set -x
22:22:12 [2019-10-15T22:22:12.372Z] ++ 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
22:22:12 [2019-10-15T22:22:12.372Z] INFO: Testing against a local daemon
22:22:12 [2019-10-15T22:22:12.372Z] === RUN   TestDockerNetworkMacvlanPersistance
22:22:13 [2019-10-15T22:22:13.849Z] --- PASS: TestDockerNetworkMacvlanPersistance (1.52s)
22:22:13 [2019-10-15T22:22:13.849Z]     macvlan_test.go:24: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlanPersistance"
22:22:13 [2019-10-15T22:22:13.849Z] === RUN   TestDockerNetworkMacvlan
22:22:14 [2019-10-15T22:22:14.471Z] === RUN   TestDockerNetworkMacvlan/Subinterface
22:22:15 [2019-10-15T22:22:15.486Z] === RUN   TestDockerNetworkMacvlan/OverlapParent
22:22:16 [2019-10-15T22:22:16.498Z] === RUN   TestDockerNetworkMacvlan/NilParent
22:22:19 [2019-10-15T22:22:19.290Z] === RUN   TestDockerNetworkMacvlan/InternalMode
22:22:22 [2019-10-15T22:22:22.746Z] === RUN   TestDockerNetworkMacvlan/MultiSubnet
22:22:28 [2019-10-15T22:22:28.263Z] === RUN   TestDockerNetworkMacvlan/Addressing
22:22:28 [2019-10-15T22:22:28.881Z] --- PASS: TestDockerNetworkMacvlan (15.04s)
22:22:28 [2019-10-15T22:22:28.881Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
22:22:28 [2019-10-15T22:22:28.881Z]     --- PASS: TestDockerNetworkMacvlan/Subinterface (0.07s)
22:22:28 [2019-10-15T22:22:28.881Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
22:22:28 [2019-10-15T22:22:28.881Z]     --- PASS: TestDockerNetworkMacvlan/OverlapParent (0.09s)
22:22:28 [2019-10-15T22:22:28.881Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
22:22:28 [2019-10-15T22:22:28.881Z]     --- PASS: TestDockerNetworkMacvlan/NilParent (1.25s)
22:22:28 [2019-10-15T22:22:28.881Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
22:22:28 [2019-10-15T22:22:28.881Z]     --- PASS: TestDockerNetworkMacvlan/InternalMode (2.16s)
22:22:28 [2019-10-15T22:22:28.881Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
22:22:28 [2019-10-15T22:22:28.881Z]     --- PASS: TestDockerNetworkMacvlan/MultiSubnet (3.23s)
22:22:28 [2019-10-15T22:22:28.881Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
22:22:28 [2019-10-15T22:22:28.881Z]     --- PASS: TestDockerNetworkMacvlan/Addressing (0.97s)
22:22:28 [2019-10-15T22:22:28.881Z] PASS
22:22:28 [2019-10-15T22:22:28.881Z] 
22:22:28 [2019-10-15T22:22:28.881Z] DONE 8 tests in 16.653s
22:22:28 [2019-10-15T22:22:28.882Z] Running /go/src/github.com/docker/docker/integration/plugin (ppc64le.integration.plugin) flags=-test.v -test.timeout=120m 
22:22:28 [2019-10-15T22:22:28.882Z] ++ 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
22:22:28 [2019-10-15T22:22:28.882Z] ++ set -e
22:22:28 [2019-10-15T22:22:28.882Z] ++ '[' -n 0 ']'
22:22:28 [2019-10-15T22:22:28.882Z] ++ set -x
22:22:28 [2019-10-15T22:22:28.882Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=ppc64le DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-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
22:22:28 [2019-10-15T22:22:28.882Z] testing: warning: no tests to run
22:22:28 [2019-10-15T22:22:28.882Z] PASS
22:22:28 [2019-10-15T22:22:28.882Z] 
22:22:28 [2019-10-15T22:22:28.882Z] DONE 0 tests in 0.016s
22:22:28 [2019-10-15T22:22:28.882Z] Running /go/src/github.com/docker/docker/integration/plugin/authz (ppc64le.integration.plugin.authz) flags=-test.v -test.timeout=120m 
22:22:28 [2019-10-15T22:22:28.882Z] ++ 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
22:22:28 [2019-10-15T22:22:28.882Z] ++ set -e
22:22:28 [2019-10-15T22:22:28.882Z] ++ '[' -n 0 ']'
22:22:28 [2019-10-15T22:22:28.882Z] ++ set -x
22:22:28 [2019-10-15T22:22:28.882Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=ppc64le DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-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
22:22:28 [2019-10-15T22:22:28.882Z] INFO: Testing against a local daemon
22:22:28 [2019-10-15T22:22:28.882Z] === RUN   TestAuthZPluginAllowRequest
22:22:30 [2019-10-15T22:22:30.360Z] --- PASS: TestAuthZPluginAllowRequest (1.59s)
22:22:30 [2019-10-15T22:22:30.360Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginAllowRequest"
22:22:30 [2019-10-15T22:22:30.360Z] === RUN   TestAuthZPluginTLS
22:22:30 [2019-10-15T22:22:30.983Z] --- PASS: TestAuthZPluginTLS (0.59s)
22:22:30 [2019-10-15T22:22:30.984Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginTLS"
22:22:30 [2019-10-15T22:22:30.984Z] === RUN   TestAuthZPluginDenyRequest
22:22:31 [2019-10-15T22:22:31.604Z] --- PASS: TestAuthZPluginDenyRequest (0.56s)
22:22:31 [2019-10-15T22:22:31.604Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginDenyRequest"
22:22:31 [2019-10-15T22:22:31.604Z] === RUN   TestAuthZPluginAPIDenyResponse
22:22:32 [2019-10-15T22:22:32.221Z] --- PASS: TestAuthZPluginAPIDenyResponse (0.57s)
22:22:32 [2019-10-15T22:22:32.221Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginAPIDenyResponse"
22:22:32 [2019-10-15T22:22:32.221Z] === RUN   TestAuthZPluginDenyResponse
22:22:32 [2019-10-15T22:22:32.839Z] --- PASS: TestAuthZPluginDenyResponse (0.59s)
22:22:32 [2019-10-15T22:22:32.839Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginDenyResponse"
22:22:32 [2019-10-15T22:22:32.839Z] === RUN   TestAuthZPluginAllowEventStream
22:22:34 [2019-10-15T22:22:34.315Z] --- PASS: TestAuthZPluginAllowEventStream (1.60s)
22:22:34 [2019-10-15T22:22:34.315Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginAllowEventStream"
22:22:34 [2019-10-15T22:22:34.315Z] === RUN   TestAuthZPluginErrorResponse
22:22:34 [2019-10-15T22:22:34.943Z] --- PASS: TestAuthZPluginErrorResponse (0.57s)
22:22:34 [2019-10-15T22:22:34.943Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginErrorResponse"
22:22:34 [2019-10-15T22:22:34.943Z] === RUN   TestAuthZPluginErrorRequest
22:22:35 [2019-10-15T22:22:35.562Z] --- PASS: TestAuthZPluginErrorRequest (0.56s)
22:22:35 [2019-10-15T22:22:35.562Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginErrorRequest"
22:22:35 [2019-10-15T22:22:35.562Z] === RUN   TestAuthZPluginEnsureNoDuplicatePluginRegistration
22:22:36 [2019-10-15T22:22:36.179Z] --- PASS: TestAuthZPluginEnsureNoDuplicatePluginRegistration (0.58s)
22:22:36 [2019-10-15T22:22:36.179Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginEnsureNoDuplicatePluginRegistration"
22:22:36 [2019-10-15T22:22:36.179Z] === RUN   TestAuthZPluginEnsureLoadImportWorking
22:22:38 [2019-10-15T22:22:38.215Z] --- PASS: TestAuthZPluginEnsureLoadImportWorking (2.16s)
22:22:38 [2019-10-15T22:22:38.215Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginEnsureLoadImportWorking"
22:22:38 [2019-10-15T22:22:38.215Z] === RUN   TestAuthzPluginEnsureContainerCopyToFrom
22:22:40 [2019-10-15T22:22:40.243Z] --- PASS: TestAuthzPluginEnsureContainerCopyToFrom (2.09s)
22:22:40 [2019-10-15T22:22:40.243Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthzPluginEnsureContainerCopyToFrom"
22:22:40 [2019-10-15T22:22:40.243Z] === RUN   TestAuthZPluginHeader
22:22:41 [2019-10-15T22:22:41.258Z] --- PASS: TestAuthZPluginHeader (0.93s)
22:22:41 [2019-10-15T22:22:41.258Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginHeader"
22:22:41 [2019-10-15T22:22:41.258Z] === RUN   TestAuthZPluginV2AllowNonVolumeRequest
22:22:41 [2019-10-15T22:22:41.258Z] --- SKIP: TestAuthZPluginV2AllowNonVolumeRequest (0.00s)
22:22:41 [2019-10-15T22:22:41.258Z]     authz_plugin_v2_test.go:43: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:22:41 [2019-10-15T22:22:41.258Z] === RUN   TestAuthZPluginV2Disable
22:22:41 [2019-10-15T22:22:41.258Z] --- SKIP: TestAuthZPluginV2Disable (0.00s)
22:22:41 [2019-10-15T22:22:41.258Z]     authz_plugin_v2_test.go:65: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:22:41 [2019-10-15T22:22:41.258Z] === RUN   TestAuthZPluginV2RejectVolumeRequests
22:22:41 [2019-10-15T22:22:41.258Z] --- SKIP: TestAuthZPluginV2RejectVolumeRequests (0.00s)
22:22:41 [2019-10-15T22:22:41.258Z]     authz_plugin_v2_test.go:91: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:22:41 [2019-10-15T22:22:41.258Z] === RUN   TestAuthZPluginV2BadManifestFailsDaemonStart
22:22:41 [2019-10-15T22:22:41.258Z] --- SKIP: TestAuthZPluginV2BadManifestFailsDaemonStart (0.00s)
22:22:41 [2019-10-15T22:22:41.258Z]     authz_plugin_v2_test.go:126: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:22:41 [2019-10-15T22:22:41.258Z] === RUN   TestAuthZPluginV2NonexistentFailsDaemonStart
22:22:59 [2019-10-15T22:22:59.727Z] --- PASS: TestAuthZPluginV2NonexistentFailsDaemonStart (16.89s)
22:22:59 [2019-10-15T22:22:59.727Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginV2NonexistentFailsDaemonStart"
22:22:59 [2019-10-15T22:22:59.727Z] PASS
22:22:59 [2019-10-15T22:22:59.727Z] 
22:22:59 [2019-10-15T22:22:59.727Z] === Skipped
22:22:59 [2019-10-15T22:22:59.727Z] === SKIP: ppc64le.integration.plugin.authz TestAuthZPluginV2AllowNonVolumeRequest (0.00s)
22:22:59 [2019-10-15T22:22:59.727Z]     authz_plugin_v2_test.go:43: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:22:59 [2019-10-15T22:22:59.727Z] 
22:22:59 [2019-10-15T22:22:59.727Z] === SKIP: ppc64le.integration.plugin.authz TestAuthZPluginV2Disable (0.00s)
22:22:59 [2019-10-15T22:22:59.727Z]     authz_plugin_v2_test.go:65: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:22:59 [2019-10-15T22:22:59.727Z] 
22:22:59 [2019-10-15T22:22:59.727Z] === SKIP: ppc64le.integration.plugin.authz TestAuthZPluginV2RejectVolumeRequests (0.00s)
22:22:59 [2019-10-15T22:22:59.727Z]     authz_plugin_v2_test.go:91: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:22:59 [2019-10-15T22:22:59.727Z] 
22:22:59 [2019-10-15T22:22:59.727Z] === SKIP: ppc64le.integration.plugin.authz TestAuthZPluginV2BadManifestFailsDaemonStart (0.00s)
22:22:59 [2019-10-15T22:22:59.727Z]     authz_plugin_v2_test.go:126: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:22:59 [2019-10-15T22:22:59.727Z] 
22:22:59 [2019-10-15T22:22:59.727Z] 
22:22:59 [2019-10-15T22:22:59.727Z] DONE 17 tests, 4 skipped in 29.380s
22:22:59 [2019-10-15T22:22:59.727Z] Running /go/src/github.com/docker/docker/integration/plugin/common (ppc64le.integration.plugin.common) flags=-test.v -test.timeout=120m 
22:22:59 [2019-10-15T22:22:59.727Z] ++ 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
22:22:59 [2019-10-15T22:22:59.727Z] ++ set -e
22:22:59 [2019-10-15T22:22:59.727Z] ++ '[' -n 0 ']'
22:22:59 [2019-10-15T22:22:59.727Z] ++ set -x
22:22:59 [2019-10-15T22:22:59.727Z] ++ 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
22:22:59 [2019-10-15T22:22:59.727Z] INFO: Testing against a local daemon
22:22:59 [2019-10-15T22:22:59.727Z] === RUN   TestPluginInvalidJSON
22:22:59 [2019-10-15T22:22:59.727Z] === RUN   TestPluginInvalidJSON//plugins/foobar/set
22:22:59 [2019-10-15T22:22:59.727Z] === PAUSE TestPluginInvalidJSON//plugins/foobar/set
22:22:59 [2019-10-15T22:22:59.727Z] === CONT  TestPluginInvalidJSON//plugins/foobar/set
22:22:59 [2019-10-15T22:22:59.727Z] --- PASS: TestPluginInvalidJSON (0.04s)
22:22:59 [2019-10-15T22:22:59.727Z]     --- PASS: TestPluginInvalidJSON//plugins/foobar/set (0.00s)
22:22:59 [2019-10-15T22:22:59.727Z] PASS
22:22:59 [2019-10-15T22:22:59.727Z] 
22:22:59 [2019-10-15T22:22:59.727Z] DONE 2 tests in 0.124s
22:22:59 [2019-10-15T22:22:59.727Z] Running /go/src/github.com/docker/docker/integration/plugin/graphdriver (ppc64le.integration.plugin.graphdriver) flags=-test.v -test.timeout=120m 
22:22:59 [2019-10-15T22:22:59.727Z] ++ 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
22:22:59 [2019-10-15T22:22:59.727Z] ++ set -e
22:22:59 [2019-10-15T22:22:59.727Z] ++ '[' -n 0 ']'
22:22:59 [2019-10-15T22:22:59.727Z] ++ set -x
22:22:59 [2019-10-15T22:22:59.727Z] ++ 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
22:22:59 [2019-10-15T22:22:59.727Z] INFO: Testing against a local daemon
22:22:59 [2019-10-15T22:22:59.727Z] === RUN   TestExternalGraphDriver
22:22:59 [2019-10-15T22:22:59.727Z] === RUN   TestExternalGraphDriver/json
22:23:00 [2019-10-15T22:23:00.743Z] === RUN   TestExternalGraphDriver/spec
22:23:02 [2019-10-15T22:23:02.796Z] === RUN   TestExternalGraphDriver/pull
22:23:05 [2019-10-15T22:23:05.496Z] --- PASS: TestExternalGraphDriver (6.61s)
22:23:05 [2019-10-15T22:23:05.496Z]     external_test.go:57: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestExternalGraphDriver"
22:23:05 [2019-10-15T22:23:05.496Z]     --- PASS: TestExternalGraphDriver/json (2.05s)
22:23:05 [2019-10-15T22:23:05.496Z]     --- PASS: TestExternalGraphDriver/spec (2.02s)
22:23:05 [2019-10-15T22:23:05.496Z]     --- PASS: TestExternalGraphDriver/pull (2.32s)
22:23:05 [2019-10-15T22:23:05.496Z] === RUN   TestGraphdriverPluginV2
22:23:05 [2019-10-15T22:23:05.496Z] --- SKIP: TestGraphdriverPluginV2 (0.07s)
22:23:05 [2019-10-15T22:23:05.496Z]     external_test.go:410: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:23:05 [2019-10-15T22:23:05.496Z] PASS
22:23:05 [2019-10-15T22:23:05.496Z] 
22:23:05 [2019-10-15T22:23:05.496Z] === Skipped
22:23:05 [2019-10-15T22:23:05.496Z] === SKIP: ppc64le.integration.plugin.graphdriver TestGraphdriverPluginV2 (0.07s)
22:23:05 [2019-10-15T22:23:05.496Z]     external_test.go:410: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:23:05 [2019-10-15T22:23:05.496Z] 
22:23:05 [2019-10-15T22:23:05.496Z] 
22:23:05 [2019-10-15T22:23:05.496Z] DONE 5 tests, 1 skipped in 6.786s
22:23:05 [2019-10-15T22:23:05.496Z] Running /go/src/github.com/docker/docker/integration/plugin/logging (ppc64le.integration.plugin.logging) flags=-test.v -test.timeout=120m 
22:23:05 [2019-10-15T22:23:05.496Z] ++ 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
22:23:05 [2019-10-15T22:23:05.496Z] ++ set -e
22:23:05 [2019-10-15T22:23:05.496Z] ++ '[' -n 0 ']'
22:23:05 [2019-10-15T22:23:05.496Z] ++ set -x
22:23:05 [2019-10-15T22:23:05.496Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=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
22:23:05 [2019-10-15T22:23:05.496Z] INFO: Testing against a local daemon
22:23:05 [2019-10-15T22:23:05.496Z] === RUN   TestContinueAfterPluginCrash
22:23:05 [2019-10-15T22:23:05.496Z] === PAUSE TestContinueAfterPluginCrash
22:23:05 [2019-10-15T22:23:05.496Z] === RUN   TestDaemonStartWithLogOpt
22:23:05 [2019-10-15T22:23:05.496Z] === PAUSE TestDaemonStartWithLogOpt
22:23:05 [2019-10-15T22:23:05.496Z] === CONT  TestContinueAfterPluginCrash
22:23:05 [2019-10-15T22:23:05.496Z] === CONT  TestDaemonStartWithLogOpt
22:23:20 [2019-10-15T22:23:20.777Z] --- PASS: TestDaemonStartWithLogOpt (15.69s)
22:23:20 [2019-10-15T22:23:20.777Z]     validation_test.go:23: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonStartWithLogOpt"
22:23:26 [2019-10-15T22:23:26.271Z] --- PASS: TestContinueAfterPluginCrash (20.51s)
22:23:26 [2019-10-15T22:23:26.271Z]     logging_linux_test.go:22: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestContinueAfterPluginCrash"
22:23:26 [2019-10-15T22:23:26.271Z] PASS
22:23:26 [2019-10-15T22:23:26.271Z] 
22:23:26 [2019-10-15T22:23:26.271Z] DONE 2 tests in 20.604s
22:23:26 [2019-10-15T22:23:26.271Z] Running /go/src/github.com/docker/docker/integration/plugin/volumes (ppc64le.integration.plugin.volumes) flags=-test.v -test.timeout=120m 
22:23:26 [2019-10-15T22:23:26.271Z] ++ 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
22:23:26 [2019-10-15T22:23:26.271Z] ++ set -e
22:23:26 [2019-10-15T22:23:26.271Z] ++ '[' -n 0 ']'
22:23:26 [2019-10-15T22:23:26.271Z] ++ set -x
22:23:26 [2019-10-15T22:23:26.271Z] ++ 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
22:23:26 [2019-10-15T22:23:26.271Z] INFO: Testing against a local daemon
22:23:26 [2019-10-15T22:23:26.271Z] === RUN   TestPluginWithDevMounts
22:23:26 [2019-10-15T22:23:26.271Z] === PAUSE TestPluginWithDevMounts
22:23:26 [2019-10-15T22:23:26.271Z] === CONT  TestPluginWithDevMounts
22:23:28 [2019-10-15T22:23:28.296Z] --- PASS: TestPluginWithDevMounts (2.31s)
22:23:28 [2019-10-15T22:23:28.296Z]     mounts_test.go:23: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestPluginWithDevMounts"
22:23:28 [2019-10-15T22:23:28.296Z] PASS
22:23:28 [2019-10-15T22:23:28.296Z] 
22:23:28 [2019-10-15T22:23:28.296Z] DONE 1 tests in 2.407s
22:23:28 [2019-10-15T22:23:28.296Z] Running /go/src/github.com/docker/docker/integration/secret (ppc64le.integration.secret) flags=-test.v -test.timeout=120m 
22:23:28 [2019-10-15T22:23:28.296Z] ++ 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
22:23:28 [2019-10-15T22:23:28.296Z] ++ set -e
22:23:28 [2019-10-15T22:23:28.296Z] ++ '[' -n 0 ']'
22:23:28 [2019-10-15T22:23:28.296Z] ++ set -x
22:23:28 [2019-10-15T22:23:28.297Z] ++ 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
22:23:28 [2019-10-15T22:23:28.297Z] INFO: Testing against a local daemon
22:23:28 [2019-10-15T22:23:28.297Z] === RUN   TestSecretInspect
22:23:30 [2019-10-15T22:23:30.330Z] --- PASS: TestSecretInspect (2.19s)
22:23:30 [2019-10-15T22:23:30.330Z]     secret_test.go:25: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestSecretInspect"
22:23:30 [2019-10-15T22:23:30.330Z] === RUN   TestSecretList
22:23:33 [2019-10-15T22:23:33.026Z] --- PASS: TestSecretList (2.18s)
22:23:33 [2019-10-15T22:23:33.026Z]     secret_test.go:48: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestSecretList"
22:23:33 [2019-10-15T22:23:33.026Z] === RUN   TestSecretsCreateAndDelete
22:23:35 [2019-10-15T22:23:35.074Z] --- PASS: TestSecretsCreateAndDelete (2.22s)
22:23:35 [2019-10-15T22:23:35.074Z]     secret_test.go:125: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestSecretsCreateAndDelete"
22:23:35 [2019-10-15T22:23:35.074Z] === RUN   TestSecretsUpdate
22:23:37 [2019-10-15T22:23:37.102Z] --- PASS: TestSecretsUpdate (2.17s)
22:23:37 [2019-10-15T22:23:37.102Z]     secret_test.go:172: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestSecretsUpdate"
22:23:37 [2019-10-15T22:23:37.102Z] === RUN   TestTemplatedSecret
22:23:39 [2019-10-15T22:23:39.789Z] --- PASS: TestTemplatedSecret (2.85s)
22:23:39 [2019-10-15T22:23:39.789Z]     secret_test.go:221: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestTemplatedSecret"
22:23:39 [2019-10-15T22:23:39.789Z] === RUN   TestSecretCreateResolve
22:23:42 [2019-10-15T22:23:42.478Z] --- PASS: TestSecretCreateResolve (2.23s)
22:23:42 [2019-10-15T22:23:42.478Z]     secret_test.go:342: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestSecretCreateResolve"
22:23:42 [2019-10-15T22:23:42.478Z] PASS
22:23:42 [2019-10-15T22:23:42.478Z] 
22:23:42 [2019-10-15T22:23:42.478Z] DONE 6 tests in 13.919s
22:23:42 [2019-10-15T22:23:42.478Z] Running /go/src/github.com/docker/docker/integration/service (ppc64le.integration.service) flags=-test.v -test.timeout=120m 
22:23:42 [2019-10-15T22:23:42.478Z] ++ 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
22:23:42 [2019-10-15T22:23:42.478Z] ++ set -e
22:23:42 [2019-10-15T22:23:42.478Z] ++ '[' -n 0 ']'
22:23:42 [2019-10-15T22:23:42.478Z] ++ set -x
22:23:42 [2019-10-15T22:23:42.478Z] ++ 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
22:23:42 [2019-10-15T22:23:42.478Z] INFO: Testing against a local daemon
22:23:42 [2019-10-15T22:23:42.478Z] === RUN   TestServiceCreateInit
22:23:42 [2019-10-15T22:23:42.478Z] === RUN   TestServiceCreateInit/daemonInitDisabled
22:23:46 [2019-10-15T22:23:46.869Z] === RUN   TestServiceCreateInit/daemonInitEnabled
22:23:50 [2019-10-15T22:23:50.340Z] --- PASS: TestServiceCreateInit (8.23s)
22:23:50 [2019-10-15T22:23:50.340Z]     --- PASS: TestServiceCreateInit/daemonInitDisabled (4.14s)
22:23:50 [2019-10-15T22:23:50.340Z]         create_test.go:38: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceCreateInit/daemonInitDisabled"
22:23:50 [2019-10-15T22:23:50.340Z]     --- PASS: TestServiceCreateInit/daemonInitEnabled (4.06s)
22:23:50 [2019-10-15T22:23:50.340Z]         create_test.go:38: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceCreateInit/daemonInitEnabled"
22:23:50 [2019-10-15T22:23:50.340Z] === RUN   TestCreateServiceMultipleTimes
22:24:08 [2019-10-15T22:24:08.819Z] --- PASS: TestCreateServiceMultipleTimes (16.87s)
22:24:08 [2019-10-15T22:24:08.819Z]     create_test.go:80: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceMultipleTimes"
22:24:08 [2019-10-15T22:24:08.819Z] === RUN   TestCreateServiceConflict
22:24:09 [2019-10-15T22:24:09.436Z] --- PASS: TestCreateServiceConflict (2.19s)
22:24:09 [2019-10-15T22:24:09.436Z]     create_test.go:129: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceConflict"
22:24:09 [2019-10-15T22:24:09.436Z] === RUN   TestCreateServiceMaxReplicas
22:24:12 [2019-10-15T22:24:12.905Z] --- PASS: TestCreateServiceMaxReplicas (3.01s)
22:24:12 [2019-10-15T22:24:12.905Z]     create_test.go:150: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceMaxReplicas"
22:24:12 [2019-10-15T22:24:12.905Z] === RUN   TestCreateWithDuplicateNetworkNames
22:24:28 [2019-10-15T22:24:28.132Z] --- PASS: TestCreateWithDuplicateNetworkNames (13.27s)
22:24:28 [2019-10-15T22:24:28.132Z]     create_test.go:171: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateWithDuplicateNetworkNames"
22:24:28 [2019-10-15T22:24:28.132Z] === RUN   TestCreateServiceSecretFileMode
22:24:28 [2019-10-15T22:24:28.415Z] --- PASS: TestCreateServiceSecretFileMode (2.53s)
22:24:28 [2019-10-15T22:24:28.415Z]     create_test.go:224: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceSecretFileMode"
22:24:28 [2019-10-15T22:24:28.415Z] === RUN   TestCreateServiceConfigFileMode
22:24:31 [2019-10-15T22:24:31.096Z] --- PASS: TestCreateServiceConfigFileMode (2.53s)
22:24:31 [2019-10-15T22:24:31.096Z]     create_test.go:288: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceConfigFileMode"
22:24:31 [2019-10-15T22:24:31.096Z] === RUN   TestCreateServiceSysctls
22:24:34 [2019-10-15T22:24:34.572Z] --- PASS: TestCreateServiceSysctls (3.31s)
22:24:34 [2019-10-15T22:24:34.572Z]     create_test.go:378: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceSysctls"
22:24:34 [2019-10-15T22:24:34.572Z] === RUN   TestCreateServiceCapabilities
22:24:36 [2019-10-15T22:24:36.611Z] --- PASS: TestCreateServiceCapabilities (2.55s)
22:24:36 [2019-10-15T22:24:36.611Z]     create_test.go:462: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceCapabilities"
22:24:36 [2019-10-15T22:24:36.611Z] === RUN   TestInspect
22:24:40 [2019-10-15T22:24:40.074Z] --- PASS: TestInspect (2.88s)
22:24:40 [2019-10-15T22:24:40.074Z]     inspect_test.go:23: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestInspect"
22:24:40 [2019-10-15T22:24:40.074Z] === RUN   TestServiceListWithStatuses
22:24:40 [2019-10-15T22:24:40.074Z] --- SKIP: TestServiceListWithStatuses (0.00s)
22:24:40 [2019-10-15T22:24:40.074Z]     list_test.go:34: versions.LessThan(testEnv.DaemonInfo.ServerVersion, "1.41")
22:24:40 [2019-10-15T22:24:40.074Z] === RUN   TestDockerNetworkConnectAlias
22:24:44 [2019-10-15T22:24:44.472Z] --- PASS: TestDockerNetworkConnectAlias (4.53s)
22:24:44 [2019-10-15T22:24:44.472Z]     network_test.go:20: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkConnectAlias"
22:24:44 [2019-10-15T22:24:44.472Z] === RUN   TestDockerNetworkReConnect
22:24:48 [2019-10-15T22:24:48.868Z] --- PASS: TestDockerNetworkReConnect (4.57s)
22:24:48 [2019-10-15T22:24:48.868Z]     network_test.go:82: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkReConnect"
22:24:48 [2019-10-15T22:24:48.868Z] === RUN   TestServicePlugin
22:24:48 [2019-10-15T22:24:48.868Z] --- SKIP: TestServicePlugin (0.00s)
22:24:48 [2019-10-15T22:24:48.868Z]     plugin_test.go:28: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:24:48 [2019-10-15T22:24:48.868Z] === RUN   TestServiceUpdateLabel
22:24:50 [2019-10-15T22:24:50.902Z] --- PASS: TestServiceUpdateLabel (2.22s)
22:24:50 [2019-10-15T22:24:50.902Z]     update_test.go:21: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateLabel"
22:24:50 [2019-10-15T22:24:50.902Z] === RUN   TestServiceUpdateSecrets
22:25:06 [2019-10-15T22:25:06.278Z] --- PASS: TestServiceUpdateSecrets (14.81s)
22:25:06 [2019-10-15T22:25:06.278Z]     update_test.go:77: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateSecrets"
22:25:06 [2019-10-15T22:25:06.278Z] === RUN   TestServiceUpdateConfigs
22:25:21 [2019-10-15T22:25:21.511Z] --- PASS: TestServiceUpdateConfigs (14.74s)
22:25:21 [2019-10-15T22:25:21.511Z]     update_test.go:139: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateConfigs"
22:25:21 [2019-10-15T22:25:21.511Z] === RUN   TestServiceUpdateNetwork
22:25:34 [2019-10-15T22:25:34.062Z] --- PASS: TestServiceUpdateNetwork (12.95s)
22:25:34 [2019-10-15T22:25:34.062Z]     update_test.go:201: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateNetwork"
22:25:34 [2019-10-15T22:25:34.062Z] PASS
22:25:34 [2019-10-15T22:25:34.062Z] 
22:25:34 [2019-10-15T22:25:34.062Z] === Skipped
22:25:34 [2019-10-15T22:25:34.062Z] === SKIP: ppc64le.integration.service TestServiceListWithStatuses (0.00s)
22:25:34 [2019-10-15T22:25:34.062Z]     list_test.go:34: versions.LessThan(testEnv.DaemonInfo.ServerVersion, "1.41")
22:25:34 [2019-10-15T22:25:34.062Z] 
22:25:34 [2019-10-15T22:25:34.062Z] === SKIP: ppc64le.integration.service TestServicePlugin (0.00s)
22:25:34 [2019-10-15T22:25:34.062Z]     plugin_test.go:28: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:25:34 [2019-10-15T22:25:34.062Z] 
22:25:34 [2019-10-15T22:25:34.062Z] 
22:25:34 [2019-10-15T22:25:34.062Z] DONE 20 tests, 2 skipped in 111.316s
22:25:34 [2019-10-15T22:25:34.062Z] Running /go/src/github.com/docker/docker/integration/session (ppc64le.integration.session) flags=-test.v -test.timeout=120m 
22:25:34 [2019-10-15T22:25:34.062Z] ++ 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
22:25:34 [2019-10-15T22:25:34.062Z] ++ set -e
22:25:34 [2019-10-15T22:25:34.062Z] ++ '[' -n 0 ']'
22:25:34 [2019-10-15T22:25:34.062Z] ++ set -x
22:25:34 [2019-10-15T22:25:34.062Z] ++ 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
22:25:34 [2019-10-15T22:25:34.062Z] INFO: Testing against a local daemon
22:25:34 [2019-10-15T22:25:34.062Z] === RUN   TestSessionCreate
22:25:34 [2019-10-15T22:25:34.062Z] --- PASS: TestSessionCreate (0.05s)
22:25:34 [2019-10-15T22:25:34.062Z] === RUN   TestSessionCreateWithBadUpgrade
22:25:34 [2019-10-15T22:25:34.062Z] --- PASS: TestSessionCreateWithBadUpgrade (0.05s)
22:25:34 [2019-10-15T22:25:34.062Z] PASS
22:25:34 [2019-10-15T22:25:34.062Z] 
22:25:34 [2019-10-15T22:25:34.062Z] DONE 2 tests in 0.202s
22:25:34 [2019-10-15T22:25:34.062Z] Running /go/src/github.com/docker/docker/integration/system (ppc64le.integration.system) flags=-test.v -test.timeout=120m 
22:25:34 [2019-10-15T22:25:34.062Z] ++ 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
22:25:34 [2019-10-15T22:25:34.062Z] ++ set -e
22:25:34 [2019-10-15T22:25:34.062Z] ++ '[' -n 0 ']'
22:25:34 [2019-10-15T22:25:34.062Z] ++ set -x
22:25:34 [2019-10-15T22:25:34.062Z] ++ 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
22:25:34 [2019-10-15T22:25:34.062Z] INFO: Testing against a local daemon
22:25:34 [2019-10-15T22:25:34.062Z] === RUN   TestCgroupDriverSystemdMemoryLimit
22:25:34 [2019-10-15T22:25:34.062Z] --- SKIP: TestCgroupDriverSystemdMemoryLimit (0.00s)
22:25:34 [2019-10-15T22:25:34.062Z]     cgroupdriver_systemd_test.go:32: !hasSystemd()
22:25:34 [2019-10-15T22:25:34.062Z] === RUN   TestEventsExecDie
22:25:34 [2019-10-15T22:25:34.682Z] --- PASS: TestEventsExecDie (0.90s)
22:25:34 [2019-10-15T22:25:34.682Z] === RUN   TestEventsBackwardsCompatible
22:25:34 [2019-10-15T22:25:34.682Z] --- PASS: TestEventsBackwardsCompatible (0.09s)
22:25:34 [2019-10-15T22:25:34.682Z] === RUN   TestInfoBinaryCommits
22:25:34 [2019-10-15T22:25:34.967Z] --- PASS: TestInfoBinaryCommits (0.05s)
22:25:34 [2019-10-15T22:25:34.968Z] === RUN   TestInfoAPIVersioned
22:25:34 [2019-10-15T22:25:34.968Z] --- PASS: TestInfoAPIVersioned (0.02s)
22:25:34 [2019-10-15T22:25:34.968Z] === RUN   TestInfoAPI
22:25:34 [2019-10-15T22:25:34.968Z] --- PASS: TestInfoAPI (0.05s)
22:25:34 [2019-10-15T22:25:34.968Z] === RUN   TestInfoAPIWarnings
22:25:35 [2019-10-15T22:25:35.990Z] --- PASS: TestInfoAPIWarnings (0.97s)
22:25:35 [2019-10-15T22:25:35.990Z]     info_test.go:49: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestInfoAPIWarnings"
22:25:35 [2019-10-15T22:25:35.990Z] === RUN   TestLoginFailsWithBadCredentials
22:25:36 [2019-10-15T22:25:36.606Z] --- PASS: TestLoginFailsWithBadCredentials (0.60s)
22:25:36 [2019-10-15T22:25:36.606Z] === RUN   TestPingCacheHeaders
22:25:36 [2019-10-15T22:25:36.606Z] --- PASS: TestPingCacheHeaders (0.07s)
22:25:36 [2019-10-15T22:25:36.606Z] === RUN   TestPingGet
22:25:36 [2019-10-15T22:25:36.606Z] --- PASS: TestPingGet (0.03s)
22:25:36 [2019-10-15T22:25:36.606Z] === RUN   TestPingHead
22:25:36 [2019-10-15T22:25:36.606Z] --- PASS: TestPingHead (0.05s)
22:25:36 [2019-10-15T22:25:36.606Z] === RUN   TestVersion
22:25:36 [2019-10-15T22:25:36.606Z] --- PASS: TestVersion (0.05s)
22:25:36 [2019-10-15T22:25:36.606Z] PASS
22:25:36 [2019-10-15T22:25:36.606Z] 
22:25:36 [2019-10-15T22:25:36.606Z] === Skipped
22:25:36 [2019-10-15T22:25:36.606Z] === SKIP: ppc64le.integration.system TestCgroupDriverSystemdMemoryLimit (0.00s)
22:25:36 [2019-10-15T22:25:36.606Z]     cgroupdriver_systemd_test.go:32: !hasSystemd()
22:25:36 [2019-10-15T22:25:36.606Z] 
22:25:36 [2019-10-15T22:25:36.606Z] 
22:25:36 [2019-10-15T22:25:36.606Z] DONE 12 tests, 1 skipped in 2.981s
22:25:36 [2019-10-15T22:25:36.606Z] Running /go/src/github.com/docker/docker/integration/volume (ppc64le.integration.volume) flags=-test.v -test.timeout=120m 
22:25:36 [2019-10-15T22:25:36.606Z] ++ 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
22:25:36 [2019-10-15T22:25:36.606Z] ++ set -e
22:25:36 [2019-10-15T22:25:36.606Z] ++ '[' -n 0 ']'
22:25:36 [2019-10-15T22:25:36.606Z] ++ set -x
22:25:36 [2019-10-15T22:25:36.606Z] ++ 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
22:25:36 [2019-10-15T22:25:36.889Z] INFO: Testing against a local daemon
22:25:36 [2019-10-15T22:25:36.889Z] === RUN   TestVolumesCreateAndList
22:25:36 [2019-10-15T22:25:36.889Z] --- PASS: TestVolumesCreateAndList (0.04s)
22:25:36 [2019-10-15T22:25:36.889Z] === RUN   TestVolumesRemove
22:25:36 [2019-10-15T22:25:36.889Z] --- PASS: TestVolumesRemove (0.09s)
22:25:36 [2019-10-15T22:25:36.889Z] === RUN   TestVolumesInspect
22:25:36 [2019-10-15T22:25:36.889Z] --- PASS: TestVolumesInspect (0.04s)
22:25:36 [2019-10-15T22:25:36.889Z] === RUN   TestVolumesInvalidJSON
22:25:36 [2019-10-15T22:25:36.889Z] === RUN   TestVolumesInvalidJSON//volumes/create
22:25:36 [2019-10-15T22:25:36.889Z] === PAUSE TestVolumesInvalidJSON//volumes/create
22:25:36 [2019-10-15T22:25:36.889Z] === CONT  TestVolumesInvalidJSON//volumes/create
22:25:36 [2019-10-15T22:25:36.889Z] --- PASS: TestVolumesInvalidJSON (0.03s)
22:25:36 [2019-10-15T22:25:36.889Z]     --- PASS: TestVolumesInvalidJSON//volumes/create (0.00s)
22:25:36 [2019-10-15T22:25:36.889Z] PASS
22:25:36 [2019-10-15T22:25:36.889Z] 
22:25:36 [2019-10-15T22:25:36.889Z] DONE 5 tests in 0.293s
22:25:36 [2019-10-15T22:25:36.889Z] ---> Making bundle: .integration-daemon-stop (in bundles/test-integration)
22:25:37 [2019-10-15T22:25:37.506Z] ++++ cat bundles/test-integration/docker.pid
22:25:37 [2019-10-15T22:25:37.507Z] +++ kill 13105
22:25:38 [2019-10-15T22:25:38.979Z] +++ /etc/init.d/apparmor stop
22:25:38 [2019-10-15T22:25:38.979Z] Clearing AppArmor profiles cache:.
22:25:38 [2019-10-15T22:25:38.979Z] All profile caches have been cleared, but no profiles have been unloaded.
22:25:38 [2019-10-15T22:25:38.979Z] Unloading profiles will leave already running processes permanently
22:25:38 [2019-10-15T22:25:38.979Z] unconfined, which can lead to unexpected situations.
22:25:38 [2019-10-15T22:25:38.979Z] 
22:25:38 [2019-10-15T22:25:38.979Z] To set a process to complain mode, use the command line tool
22:25:38 [2019-10-15T22:25:38.979Z] 'aa-complain'. To really tear down all profiles, run the init script
22:25:38 [2019-10-15T22:25:38.979Z] with the 'teardown' option."
22:25:38 [2019-10-15T22:25:38.979Z]