Console Output

09:03:29 [2019-11-26T09:03:29.262Z] + docker run --rm -t --privileged -v /home/docker/workspace/moby_PR-40254/bundles:/go/src/github.com/docker/docker/bundles --name docker-pr2 -e DOCKER_EXPERIMENTAL -e DOCKER_GITCOMMIT=4952248d0886d747afcbf6f8d13157f7300cc451 -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:4952248d0886d747afcbf6f8d13157f7300cc451 hack/make.sh dynbinary test-integration
09:03:29 [2019-11-26T09:03:29.600Z] 
09:03:29 [2019-11-26T09:03:29.600Z] Removing bundles/
09:03:29 [2019-11-26T09:03:29.600Z] 
09:03:29 [2019-11-26T09:03:29.600Z] ---> Making bundle: dynbinary (in bundles/dynbinary)
09:03:29 [2019-11-26T09:03:29.600Z] Building: bundles/dynbinary-daemon/dockerd-dev
09:03:29 [2019-11-26T09:03:29.600Z] GOOS="" GOARCH="" GOARM=""
09:05:23 [2019-11-26T09:05:23.160Z] Created binary: bundles/dynbinary-daemon/dockerd-dev
09:05:23 [2019-11-26T09:05:23.498Z] 
09:05:23 [2019-11-26T09:05:23.498Z] ---> Making bundle: test-integration (in bundles/test-integration)
09:05:24 [2019-11-26T09:05:24.225Z] PKG_CONFIG=pkg-config
09:05:24 [2019-11-26T09:05:24.225Z] GOLANG_VERSION=1.13.4
09:05:24 [2019-11-26T09:05:24.225Z] HOSTNAME=5eab471baa73
09:05:24 [2019-11-26T09:05:24.225Z] DOCKER_EXPERIMENTAL=1
09:05:24 [2019-11-26T09:05:24.225Z] container=docker
09:05:24 [2019-11-26T09:05:24.225Z] TEST_SKIP_INTEGRATION_CLI=1
09:05:24 [2019-11-26T09:05:24.225Z] GO111MODULE=off
09:05:24 [2019-11-26T09:05:24.225Z] GOPATH=/go
09:05:24 [2019-11-26T09:05:24.225Z] PWD=/go/src/github.com/docker/docker
09:05:24 [2019-11-26T09:05:24.225Z] HOME=/root
09:05:24 [2019-11-26T09:05:24.225Z] VALIDATE_REPO=https://github.com/moby/moby.git
09:05:24 [2019-11-26T09:05:24.225Z] SCRIPTDIR=/go/src/github.com/docker/docker/hack
09:05:24 [2019-11-26T09:05:24.225Z] MAKEDIR=/go/src/github.com/docker/docker/hack/make
09:05:24 [2019-11-26T09:05:24.225Z] DOCKER_GITCOMMIT=4952248d0886d747afcbf6f8d13157f7300cc451
09:05:24 [2019-11-26T09:05:24.225Z] DOCKER_BUILDTAGS=apparmor seccomp selinux journald
09:05:24 [2019-11-26T09:05:24.225Z] DOCKER_GRAPHDRIVER=overlay2
09:05:24 [2019-11-26T09:05:24.225Z] TERM=xterm
09:05:24 [2019-11-26T09:05:24.225Z] VALIDATE_BRANCH=master
09:05:24 [2019-11-26T09:05:24.225Z] DEST=bundles/test-integration
09:05:24 [2019-11-26T09:05:24.225Z] SHLVL=1
09:05:24 [2019-11-26T09:05:24.225Z] TIMEOUT=120m
09:05:24 [2019-11-26T09:05:24.225Z] PATH=/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
09:05:24 [2019-11-26T09:05:24.225Z] DOCKER_PKG=github.com/docker/docker
09:05:24 [2019-11-26T09:05:24.225Z] TESTDEBUG=0
09:05:24 [2019-11-26T09:05:24.225Z] _=/usr/bin/env
09:05:24 [2019-11-26T09:05:24.225Z] Building test suite binary /go/src/github.com/docker/docker/integration/build/test.main
09:06:22 [2019-11-26T09:06:22.388Z] Building test suite binary /go/src/github.com/docker/docker/integration/config/test.main
09:06:22 [2019-11-26T09:06:22.388Z] Building test suite binary /go/src/github.com/docker/docker/integration/container/test.main
09:06:22 [2019-11-26T09:06:22.388Z] Building test suite binary /go/src/github.com/docker/docker/integration/image/test.main
09:06:56 [2019-11-26T09:06:56.001Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/test.main
09:06:58 [2019-11-26T09:06:58.386Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/ipvlan/test.main
09:07:00 [2019-11-26T09:07:00.075Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/macvlan/test.main
09:07:02 [2019-11-26T09:07:02.383Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/test.main
09:07:02 [2019-11-26T09:07:02.722Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/authz/test.main
09:07:05 [2019-11-26T09:07:05.730Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/common/test.main
09:07:08 [2019-11-26T09:07:08.024Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/graphdriver/test.main
09:07:11 [2019-11-26T09:07:11.026Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/logging/test.main
09:07:14 [2019-11-26T09:07:14.862Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/volumes/test.main
09:07:17 [2019-11-26T09:07:17.865Z] Building test suite binary /go/src/github.com/docker/docker/integration/secret/test.main
09:07:19 [2019-11-26T09:07:19.553Z] Building test suite binary /go/src/github.com/docker/docker/integration/service/test.main
09:07:23 [2019-11-26T09:07:23.442Z] Building test suite binary /go/src/github.com/docker/docker/integration/session/test.main
09:07:25 [2019-11-26T09:07:25.132Z] Building test suite binary /go/src/github.com/docker/docker/integration/system/test.main
09:07:26 [2019-11-26T09:07:26.825Z] Building test suite binary /go/src/github.com/docker/docker/integration/volume/test.main
09:07:29 [2019-11-26T09:07:29.118Z] ---> Making bundle: .integration-daemon-start (in bundles/test-integration)
09:07:29 [2019-11-26T09:07:29.118Z] Using test binary docker
09:07:29 [2019-11-26T09:07:29.118Z] # DOCKER_EXPERIMENTAL is set: starting daemon with experimental features enabled! 
09:07:29 [2019-11-26T09:07:29.118Z] +++ /etc/init.d/apparmor start
09:07:29 [2019-11-26T09:07:29.118Z] /etc/init.d/apparmor: 130: /etc/init.d/apparmor: systemd-detect-virt: not found
09:07:29 [2019-11-26T09:07:29.118Z] Starting AppArmor profiles:Warning from stdin (line 1): /sbin/apparmor_parser: cannot use or update cache, disable, or force-complain via stdin
09:07:29 [2019-11-26T09:07:29.118Z] Warning failed to create cache: (null)
09:07:29 [2019-11-26T09:07:29.118Z] .
09:07:29 [2019-11-26T09:07:29.118Z] INFO: Waiting for daemon to start...
09:07:29 [2019-11-26T09:07:29.118Z] Starting dockerd
09:07:29 [2019-11-26T09:07:29.118Z] +++ 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
09:07:30 [2019-11-26T09:07:30.808Z] .
09:07:30 [2019-11-26T09:07:30.808Z] ---> Making bundle: .integration-daemon-setup (in bundles/test-integration)
09:07:30 [2019-11-26T09:07:30.808Z] ---> Making bundle: .ensure-emptyfs (in bundles/test-integration)
09:07:30 [2019-11-26T09:07:30.808Z] Error: No such image: emptyfs
09:07:30 [2019-11-26T09:07:30.808Z] ++++ tar -cC bundles/test-integration/emptyfs .
09:07:30 [2019-11-26T09:07:30.808Z] ++++ docker load
09:07:31 [2019-11-26T09:07:31.145Z] Running integration-test (iteration 1)
09:07:31 [2019-11-26T09:07:31.145Z] Running /go/src/github.com/docker/docker/integration/build (ppc64le.integration.build) flags=-test.v -test.timeout=120m 
09:07:31 [2019-11-26T09:07:31.145Z] ++ 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
09:07:31 [2019-11-26T09:07:31.145Z] ++ set -e
09:07:31 [2019-11-26T09:07:31.145Z] ++ '[' -n 0 ']'
09:07:31 [2019-11-26T09:07:31.145Z] ++ set -x
09:07:31 [2019-11-26T09:07:31.145Z] ++ 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
09:07:47 [2019-11-26T09:07:47.174Z] Loaded image: buildpack-deps:jessie
09:07:47 [2019-11-26T09:07:47.174Z] Loaded image: busybox:latest
09:07:47 [2019-11-26T09:07:47.174Z] Loaded image: busybox:glibc
09:07:47 [2019-11-26T09:07:47.174Z] Loaded image: debian:jessie
09:07:47 [2019-11-26T09:07:47.174Z] Loaded image: hello-world:latest
09:07:47 [2019-11-26T09:07:47.174Z] INFO: Testing against a local daemon
09:07:47 [2019-11-26T09:07:47.174Z] === RUN   TestCgroupNamespacesBuild
09:07:47 [2019-11-26T09:07:47.174Z] --- PASS: TestCgroupNamespacesBuild (1.63s)
09:07:47 [2019-11-26T09:07:47.174Z] === RUN   TestCgroupNamespacesBuildDaemonHostMode
09:07:48 [2019-11-26T09:07:48.342Z] --- PASS: TestCgroupNamespacesBuildDaemonHostMode (1.61s)
09:07:48 [2019-11-26T09:07:48.342Z] === RUN   TestBuildWithSession
09:07:48 [2019-11-26T09:07:48.342Z] --- SKIP: TestBuildWithSession (0.00s)
09:07:48 [2019-11-26T09:07:48.342Z]     build_session_test.go:25: TODO: BuildKit
09:07:48 [2019-11-26T09:07:48.342Z] === RUN   TestBuildSquashParent
09:07:54 [2019-11-26T09:07:54.317Z] --- PASS: TestBuildSquashParent (5.15s)
09:07:54 [2019-11-26T09:07:54.317Z] === RUN   TestBuildWithRemoveAndForceRemove
09:07:54 [2019-11-26T09:07:54.317Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
09:07:54 [2019-11-26T09:07:54.317Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
09:07:54 [2019-11-26T09:07:54.317Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_remove
09:07:54 [2019-11-26T09:07:54.317Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_remove
09:07:54 [2019-11-26T09:07:54.317Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
09:07:54 [2019-11-26T09:07:54.317Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
09:07:54 [2019-11-26T09:07:54.317Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
09:07:54 [2019-11-26T09:07:54.317Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
09:07:54 [2019-11-26T09:07:54.317Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_remove
09:07:54 [2019-11-26T09:07:54.317Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_remove
09:07:54 [2019-11-26T09:07:54.317Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
09:07:54 [2019-11-26T09:07:54.317Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
09:07:54 [2019-11-26T09:07:54.317Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
09:07:54 [2019-11-26T09:07:54.317Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
09:07:54 [2019-11-26T09:07:54.317Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
09:07:54 [2019-11-26T09:07:54.317Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_remove
09:07:57 [2019-11-26T09:07:57.331Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
09:07:57 [2019-11-26T09:07:57.331Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_remove
09:07:59 [2019-11-26T09:07:59.628Z] --- PASS: TestBuildWithRemoveAndForceRemove (0.02s)
09:07:59 [2019-11-26T09:07:59.628Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_remove (3.30s)
09:07:59 [2019-11-26T09:07:59.628Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal (3.30s)
09:07:59 [2019-11-26T09:07:59.628Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal (3.30s)
09:07:59 [2019-11-26T09:07:59.628Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove (3.39s)
09:07:59 [2019-11-26T09:07:59.628Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_remove (2.34s)
09:07:59 [2019-11-26T09:07:59.628Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove (2.40s)
09:07:59 [2019-11-26T09:07:59.628Z] === RUN   TestBuildMultiStageCopy
09:07:59 [2019-11-26T09:07:59.628Z] === RUN   TestBuildMultiStageCopy/copy_to_root
09:08:01 [2019-11-26T09:08:01.314Z] === RUN   TestBuildMultiStageCopy/copy_to_newdir
09:08:01 [2019-11-26T09:08:01.652Z] === RUN   TestBuildMultiStageCopy/copy_to_newdir_nested
09:08:01 [2019-11-26T09:08:01.991Z] === RUN   TestBuildMultiStageCopy/copy_to_existingdir
09:08:02 [2019-11-26T09:08:02.329Z] === RUN   TestBuildMultiStageCopy/copy_to_newsubdir
09:08:02 [2019-11-26T09:08:02.667Z] --- PASS: TestBuildMultiStageCopy (3.56s)
09:08:02 [2019-11-26T09:08:02.667Z]     --- PASS: TestBuildMultiStageCopy/copy_to_root (1.96s)
09:08:02 [2019-11-26T09:08:02.667Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newdir (0.38s)
09:08:02 [2019-11-26T09:08:02.667Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newdir_nested (0.36s)
09:08:02 [2019-11-26T09:08:02.667Z]     --- PASS: TestBuildMultiStageCopy/copy_to_existingdir (0.43s)
09:08:02 [2019-11-26T09:08:02.667Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newsubdir (0.42s)
09:08:02 [2019-11-26T09:08:02.667Z] === RUN   TestBuildMultiStageParentConfig
09:08:03 [2019-11-26T09:08:03.844Z] --- PASS: TestBuildMultiStageParentConfig (0.98s)
09:08:03 [2019-11-26T09:08:03.844Z] === RUN   TestBuildLabelWithTargets
09:08:05 [2019-11-26T09:08:05.611Z] --- PASS: TestBuildLabelWithTargets (1.58s)
09:08:05 [2019-11-26T09:08:05.611Z] === RUN   TestBuildWithEmptyLayers
09:08:06 [2019-11-26T09:08:06.334Z] --- PASS: TestBuildWithEmptyLayers (0.75s)
09:08:06 [2019-11-26T09:08:06.334Z] === RUN   TestBuildMultiStageOnBuild
09:08:08 [2019-11-26T09:08:08.626Z] --- PASS: TestBuildMultiStageOnBuild (2.17s)
09:08:08 [2019-11-26T09:08:08.626Z] === RUN   TestBuildUncleanTarFilenames
09:08:09 [2019-11-26T09:08:09.349Z] --- PASS: TestBuildUncleanTarFilenames (1.12s)
09:08:09 [2019-11-26T09:08:09.349Z] === RUN   TestBuildMultiStageLayerLeak
09:08:11 [2019-11-26T09:08:11.698Z] --- PASS: TestBuildMultiStageLayerLeak (2.29s)
09:08:11 [2019-11-26T09:08:11.698Z] === RUN   TestBuildWithHugeFile
09:09:34 [2019-11-26T09:09:34.926Z] --- PASS: TestBuildWithHugeFile (79.86s)
09:09:34 [2019-11-26T09:09:34.926Z] === RUN   TestBuildWithEmptyDockerfile
09:09:34 [2019-11-26T09:09:34.926Z] === RUN   TestBuildWithEmptyDockerfile/empty-dockerfile
09:09:34 [2019-11-26T09:09:34.926Z] === PAUSE TestBuildWithEmptyDockerfile/empty-dockerfile
09:09:34 [2019-11-26T09:09:34.926Z] === RUN   TestBuildWithEmptyDockerfile/empty-lines-dockerfile
09:09:34 [2019-11-26T09:09:34.926Z] === PAUSE TestBuildWithEmptyDockerfile/empty-lines-dockerfile
09:09:34 [2019-11-26T09:09:34.926Z] === RUN   TestBuildWithEmptyDockerfile/comment-only-dockerfile
09:09:34 [2019-11-26T09:09:34.926Z] === PAUSE TestBuildWithEmptyDockerfile/comment-only-dockerfile
09:09:34 [2019-11-26T09:09:34.926Z] === CONT  TestBuildWithEmptyDockerfile/empty-dockerfile
09:09:34 [2019-11-26T09:09:34.926Z] === CONT  TestBuildWithEmptyDockerfile/comment-only-dockerfile
09:09:34 [2019-11-26T09:09:34.926Z] === CONT  TestBuildWithEmptyDockerfile/empty-lines-dockerfile
09:09:34 [2019-11-26T09:09:34.926Z] --- PASS: TestBuildWithEmptyDockerfile (0.04s)
09:09:34 [2019-11-26T09:09:34.926Z]     --- PASS: TestBuildWithEmptyDockerfile/empty-lines-dockerfile (0.30s)
09:09:34 [2019-11-26T09:09:34.926Z]     --- PASS: TestBuildWithEmptyDockerfile/empty-dockerfile (0.30s)
09:09:34 [2019-11-26T09:09:34.926Z]     --- PASS: TestBuildWithEmptyDockerfile/comment-only-dockerfile (0.30s)
09:09:34 [2019-11-26T09:09:34.926Z] === RUN   TestBuildPreserveOwnership
09:09:34 [2019-11-26T09:09:34.926Z] === RUN   TestBuildPreserveOwnership/copy_from
09:09:34 [2019-11-26T09:09:34.926Z] === RUN   TestBuildPreserveOwnership/copy_from_chowned
09:09:36 [2019-11-26T09:09:36.615Z] --- PASS: TestBuildPreserveOwnership (4.71s)
09:09:36 [2019-11-26T09:09:36.615Z]     --- PASS: TestBuildPreserveOwnership/copy_from (3.10s)
09:09:36 [2019-11-26T09:09:36.615Z]     --- PASS: TestBuildPreserveOwnership/copy_from_chowned (1.60s)
09:09:36 [2019-11-26T09:09:36.615Z] === RUN   TestBuildPlatformInvalid
09:09:36 [2019-11-26T09:09:36.952Z] --- PASS: TestBuildPlatformInvalid (0.15s)
09:09:36 [2019-11-26T09:09:36.952Z] PASS
09:09:36 [2019-11-26T09:09:36.952Z] 
09:09:36 [2019-11-26T09:09:36.952Z] === Skipped
09:09:36 [2019-11-26T09:09:36.952Z] === SKIP: ppc64le.integration.build TestBuildWithSession (0.00s)
09:09:36 [2019-11-26T09:09:36.952Z]     build_session_test.go:25: TODO: BuildKit
09:09:36 [2019-11-26T09:09:36.952Z] 
09:09:36 [2019-11-26T09:09:36.952Z] 
09:09:36 [2019-11-26T09:09:36.952Z] DONE 32 tests, 1 skipped in 125.623s
09:09:36 [2019-11-26T09:09:36.952Z] Running /go/src/github.com/docker/docker/integration/config (ppc64le.integration.config) flags=-test.v -test.timeout=120m 
09:09:36 [2019-11-26T09:09:36.952Z] ++ 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
09:09:36 [2019-11-26T09:09:36.952Z] ++ set -e
09:09:36 [2019-11-26T09:09:36.952Z] ++ '[' -n 0 ']'
09:09:36 [2019-11-26T09:09:36.952Z] ++ set -x
09:09:36 [2019-11-26T09:09:36.952Z] ++ 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
09:09:36 [2019-11-26T09:09:36.952Z] INFO: Testing against a local daemon
09:09:36 [2019-11-26T09:09:36.952Z] === RUN   TestConfigList
09:09:39 [2019-11-26T09:09:39.262Z] --- PASS: TestConfigList (2.20s)
09:09:39 [2019-11-26T09:09:39.262Z] === RUN   TestConfigsCreateAndDelete
09:09:41 [2019-11-26T09:09:41.582Z] --- PASS: TestConfigsCreateAndDelete (2.17s)
09:09:41 [2019-11-26T09:09:41.582Z] === RUN   TestConfigsUpdate
09:09:43 [2019-11-26T09:09:43.873Z] --- PASS: TestConfigsUpdate (2.17s)
09:09:43 [2019-11-26T09:09:43.873Z] === RUN   TestTemplatedConfig
09:09:46 [2019-11-26T09:09:46.175Z] --- PASS: TestTemplatedConfig (2.83s)
09:09:46 [2019-11-26T09:09:46.175Z] === RUN   TestConfigInspect
09:09:48 [2019-11-26T09:09:48.467Z] --- PASS: TestConfigInspect (2.16s)
09:09:48 [2019-11-26T09:09:48.467Z] === RUN   TestConfigCreateWithLabels
09:09:50 [2019-11-26T09:09:50.754Z] --- PASS: TestConfigCreateWithLabels (2.16s)
09:09:50 [2019-11-26T09:09:50.754Z] === RUN   TestConfigCreateResolve
09:09:53 [2019-11-26T09:09:53.041Z] --- PASS: TestConfigCreateResolve (2.15s)
09:09:53 [2019-11-26T09:09:53.041Z] === RUN   TestConfigDaemonLibtrustID
09:09:53 [2019-11-26T09:09:53.376Z] --- PASS: TestConfigDaemonLibtrustID (0.55s)
09:09:53 [2019-11-26T09:09:53.376Z] PASS
09:09:53 [2019-11-26T09:09:53.376Z] 
09:09:53 [2019-11-26T09:09:53.376Z] DONE 8 tests in 16.488s
09:09:53 [2019-11-26T09:09:53.376Z] Running /go/src/github.com/docker/docker/integration/container (ppc64le.integration.container) flags=-test.v -test.timeout=120m 
09:09:53 [2019-11-26T09:09:53.376Z] ++ 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
09:09:53 [2019-11-26T09:09:53.376Z] ++ set -e
09:09:53 [2019-11-26T09:09:53.376Z] ++ '[' -n 0 ']'
09:09:53 [2019-11-26T09:09:53.376Z] ++ set -x
09:09:53 [2019-11-26T09:09:53.376Z] ++ 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
09:09:53 [2019-11-26T09:09:53.376Z] INFO: Testing against a local daemon
09:09:53 [2019-11-26T09:09:53.376Z] === RUN   TestCheckpoint
09:09:53 [2019-11-26T09:09:53.376Z] --- SKIP: TestCheckpoint (0.00s)
09:09:53 [2019-11-26T09:09:53.377Z]     checkpoint_test.go:33: TestCheckpoint is broken; see https://github.com/moby/moby/issues/38963
09:09:53 [2019-11-26T09:09:53.377Z] === RUN   TestContainerInvalidJSON
09:09:53 [2019-11-26T09:09:53.377Z] === RUN   TestContainerInvalidJSON//containers/foobar/copy
09:09:53 [2019-11-26T09:09:53.377Z] === PAUSE TestContainerInvalidJSON//containers/foobar/copy
09:09:53 [2019-11-26T09:09:53.377Z] === RUN   TestContainerInvalidJSON//containers/foobar/exec
09:09:53 [2019-11-26T09:09:53.377Z] === PAUSE TestContainerInvalidJSON//containers/foobar/exec
09:09:53 [2019-11-26T09:09:53.377Z] === RUN   TestContainerInvalidJSON//exec/foobar/start
09:09:53 [2019-11-26T09:09:53.377Z] === PAUSE TestContainerInvalidJSON//exec/foobar/start
09:09:53 [2019-11-26T09:09:53.377Z] === CONT  TestContainerInvalidJSON//containers/foobar/copy
09:09:53 [2019-11-26T09:09:53.377Z] === CONT  TestContainerInvalidJSON//exec/foobar/start
09:09:53 [2019-11-26T09:09:53.377Z] === CONT  TestContainerInvalidJSON//containers/foobar/exec
09:09:53 [2019-11-26T09:09:53.377Z] --- PASS: TestContainerInvalidJSON (0.02s)
09:09:53 [2019-11-26T09:09:53.377Z]     --- PASS: TestContainerInvalidJSON//exec/foobar/start (0.00s)
09:09:53 [2019-11-26T09:09:53.377Z]     --- PASS: TestContainerInvalidJSON//containers/foobar/copy (0.00s)
09:09:53 [2019-11-26T09:09:53.377Z]     --- PASS: TestContainerInvalidJSON//containers/foobar/exec (0.00s)
09:09:53 [2019-11-26T09:09:53.377Z] === RUN   TestCopyFromContainerPathDoesNotExist
09:09:53 [2019-11-26T09:09:53.377Z] --- PASS: TestCopyFromContainerPathDoesNotExist (0.08s)
09:09:53 [2019-11-26T09:09:53.377Z] === RUN   TestCopyFromContainerPathIsNotDir
09:09:53 [2019-11-26T09:09:53.711Z] --- PASS: TestCopyFromContainerPathIsNotDir (0.08s)
09:09:53 [2019-11-26T09:09:53.711Z] === RUN   TestCopyToContainerPathDoesNotExist
09:09:53 [2019-11-26T09:09:53.711Z] --- PASS: TestCopyToContainerPathDoesNotExist (0.08s)
09:09:53 [2019-11-26T09:09:53.711Z] === RUN   TestCopyToContainerPathIsNotDir
09:09:53 [2019-11-26T09:09:53.711Z] --- PASS: TestCopyToContainerPathIsNotDir (0.08s)
09:09:53 [2019-11-26T09:09:53.711Z] === RUN   TestCopyFromContainer
09:09:55 [2019-11-26T09:09:55.423Z] === RUN   TestCopyFromContainer//
09:09:55 [2019-11-26T09:09:55.423Z] === RUN   TestCopyFromContainer//bar/root
09:09:55 [2019-11-26T09:09:55.423Z] === RUN   TestCopyFromContainer//bar/root/
09:09:55 [2019-11-26T09:09:55.423Z] === RUN   TestCopyFromContainer/bar/quux
09:09:55 [2019-11-26T09:09:55.759Z] === RUN   TestCopyFromContainer/bar/quux/
09:09:55 [2019-11-26T09:09:55.759Z] === RUN   TestCopyFromContainer/bar/quux/baz
09:09:55 [2019-11-26T09:09:55.759Z] === RUN   TestCopyFromContainer/bar/filesymlink
09:09:56 [2019-11-26T09:09:56.096Z] === RUN   TestCopyFromContainer/bar/dirsymlink
09:09:56 [2019-11-26T09:09:56.096Z] === RUN   TestCopyFromContainer/bar/dirsymlink/
09:09:56 [2019-11-26T09:09:56.096Z] === RUN   TestCopyFromContainer/bar/notarget
09:09:56 [2019-11-26T09:09:56.096Z] --- PASS: TestCopyFromContainer (2.47s)
09:09:56 [2019-11-26T09:09:56.096Z]     --- PASS: TestCopyFromContainer// (0.09s)
09:09:56 [2019-11-26T09:09:56.096Z]     --- PASS: TestCopyFromContainer//bar/root (0.10s)
09:09:56 [2019-11-26T09:09:56.096Z]     --- PASS: TestCopyFromContainer//bar/root/ (0.08s)
09:09:56 [2019-11-26T09:09:56.096Z]     --- PASS: TestCopyFromContainer/bar/quux (0.10s)
09:09:56 [2019-11-26T09:09:56.096Z]     --- PASS: TestCopyFromContainer/bar/quux/ (0.09s)
09:09:56 [2019-11-26T09:09:56.096Z]     --- PASS: TestCopyFromContainer/bar/quux/baz (0.10s)
09:09:56 [2019-11-26T09:09:56.096Z]     --- PASS: TestCopyFromContainer/bar/filesymlink (0.10s)
09:09:56 [2019-11-26T09:09:56.096Z]     --- PASS: TestCopyFromContainer/bar/dirsymlink (0.10s)
09:09:56 [2019-11-26T09:09:56.096Z]     --- PASS: TestCopyFromContainer/bar/dirsymlink/ (0.08s)
09:09:56 [2019-11-26T09:09:56.096Z]     --- PASS: TestCopyFromContainer/bar/notarget (0.08s)
09:09:56 [2019-11-26T09:09:56.096Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist
09:09:56 [2019-11-26T09:09:56.434Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
09:09:56 [2019-11-26T09:09:56.434Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
09:09:56 [2019-11-26T09:09:56.434Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
09:09:56 [2019-11-26T09:09:56.434Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
09:09:56 [2019-11-26T09:09:56.434Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/digest
09:09:56 [2019-11-26T09:09:56.434Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/digest
09:09:56 [2019-11-26T09:09:56.434Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
09:09:56 [2019-11-26T09:09:56.434Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/digest
09:09:56 [2019-11-26T09:09:56.434Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
09:09:56 [2019-11-26T09:09:56.434Z] --- PASS: TestCreateFailsWhenIdentifierDoesNotExist (0.03s)
09:09:56 [2019-11-26T09:09:56.434Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag (0.00s)
09:09:56 [2019-11-26T09:09:56.434Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag (0.00s)
09:09:56 [2019-11-26T09:09:56.434Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/digest (0.01s)
09:09:56 [2019-11-26T09:09:56.434Z] === RUN   TestCreateLinkToNonExistingContainer
09:09:56 [2019-11-26T09:09:56.434Z] --- PASS: TestCreateLinkToNonExistingContainer (0.07s)
09:09:56 [2019-11-26T09:09:56.434Z] === RUN   TestCreateWithInvalidEnv
09:09:56 [2019-11-26T09:09:56.434Z] === RUN   TestCreateWithInvalidEnv/0
09:09:56 [2019-11-26T09:09:56.434Z] === PAUSE TestCreateWithInvalidEnv/0
09:09:56 [2019-11-26T09:09:56.434Z] === RUN   TestCreateWithInvalidEnv/1
09:09:56 [2019-11-26T09:09:56.434Z] === PAUSE TestCreateWithInvalidEnv/1
09:09:56 [2019-11-26T09:09:56.434Z] === RUN   TestCreateWithInvalidEnv/2
09:09:56 [2019-11-26T09:09:56.434Z] === PAUSE TestCreateWithInvalidEnv/2
09:09:56 [2019-11-26T09:09:56.434Z] === CONT  TestCreateWithInvalidEnv/0
09:09:56 [2019-11-26T09:09:56.434Z] === CONT  TestCreateWithInvalidEnv/2
09:09:56 [2019-11-26T09:09:56.434Z] === CONT  TestCreateWithInvalidEnv/1
09:09:56 [2019-11-26T09:09:56.434Z] --- PASS: TestCreateWithInvalidEnv (0.02s)
09:09:56 [2019-11-26T09:09:56.434Z]     --- PASS: TestCreateWithInvalidEnv/2 (0.00s)
09:09:56 [2019-11-26T09:09:56.434Z]     --- PASS: TestCreateWithInvalidEnv/1 (0.00s)
09:09:56 [2019-11-26T09:09:56.434Z]     --- PASS: TestCreateWithInvalidEnv/0 (0.00s)
09:09:56 [2019-11-26T09:09:56.434Z] === RUN   TestCreateTmpfsMountsTarget
09:09:56 [2019-11-26T09:09:56.434Z] --- PASS: TestCreateTmpfsMountsTarget (0.03s)
09:09:56 [2019-11-26T09:09:56.434Z] === RUN   TestCreateWithCustomMaskedPaths
09:09:58 [2019-11-26T09:09:58.721Z] --- PASS: TestCreateWithCustomMaskedPaths (1.92s)
09:09:58 [2019-11-26T09:09:58.721Z] === RUN   TestCreateWithCapabilities
09:09:58 [2019-11-26T09:09:58.721Z] === RUN   TestCreateWithCapabilities/no_capabilities
09:09:58 [2019-11-26T09:09:58.721Z] === PAUSE TestCreateWithCapabilities/no_capabilities
09:09:58 [2019-11-26T09:09:58.721Z] === RUN   TestCreateWithCapabilities/empty_capabilities
09:09:58 [2019-11-26T09:09:58.721Z] === PAUSE TestCreateWithCapabilities/empty_capabilities
09:09:58 [2019-11-26T09:09:58.721Z] === RUN   TestCreateWithCapabilities/valid_capabilities
09:09:58 [2019-11-26T09:09:58.721Z] === PAUSE TestCreateWithCapabilities/valid_capabilities
09:09:58 [2019-11-26T09:09:58.721Z] === RUN   TestCreateWithCapabilities/invalid_capabilities
09:09:58 [2019-11-26T09:09:58.721Z] === PAUSE TestCreateWithCapabilities/invalid_capabilities
09:09:58 [2019-11-26T09:09:58.721Z] === RUN   TestCreateWithCapabilities/duplicate_capabilities
09:09:58 [2019-11-26T09:09:58.721Z] === PAUSE TestCreateWithCapabilities/duplicate_capabilities
09:09:58 [2019-11-26T09:09:58.721Z] === RUN   TestCreateWithCapabilities/capabilities_API_v1.39
09:09:58 [2019-11-26T09:09:58.721Z] === PAUSE TestCreateWithCapabilities/capabilities_API_v1.39
09:09:58 [2019-11-26T09:09:58.721Z] === RUN   TestCreateWithCapabilities/empty_capadd
09:09:58 [2019-11-26T09:09:58.721Z] === PAUSE TestCreateWithCapabilities/empty_capadd
09:09:58 [2019-11-26T09:09:58.721Z] === RUN   TestCreateWithCapabilities/empty_capdrop
09:09:58 [2019-11-26T09:09:58.721Z] === PAUSE TestCreateWithCapabilities/empty_capdrop
09:09:58 [2019-11-26T09:09:58.721Z] === RUN   TestCreateWithCapabilities/capadd_capdrop
09:09:58 [2019-11-26T09:09:58.721Z] === PAUSE TestCreateWithCapabilities/capadd_capdrop
09:09:58 [2019-11-26T09:09:58.721Z] === RUN   TestCreateWithCapabilities/conflict_with_capadd
09:09:58 [2019-11-26T09:09:58.721Z] === PAUSE TestCreateWithCapabilities/conflict_with_capadd
09:09:58 [2019-11-26T09:09:58.721Z] === RUN   TestCreateWithCapabilities/conflict_with_capdrop
09:09:58 [2019-11-26T09:09:58.721Z] === PAUSE TestCreateWithCapabilities/conflict_with_capdrop
09:09:58 [2019-11-26T09:09:58.721Z] === CONT  TestCreateWithCapabilities/no_capabilities
09:09:58 [2019-11-26T09:09:58.721Z] === CONT  TestCreateWithCapabilities/empty_capdrop
09:09:58 [2019-11-26T09:09:58.721Z] === CONT  TestCreateWithCapabilities/conflict_with_capdrop
09:09:58 [2019-11-26T09:09:58.721Z] === CONT  TestCreateWithCapabilities/conflict_with_capadd
09:09:58 [2019-11-26T09:09:58.721Z] === CONT  TestCreateWithCapabilities/capadd_capdrop
09:09:58 [2019-11-26T09:09:58.721Z] === CONT  TestCreateWithCapabilities/valid_capabilities
09:09:58 [2019-11-26T09:09:58.721Z] === CONT  TestCreateWithCapabilities/invalid_capabilities
09:09:58 [2019-11-26T09:09:58.721Z] === CONT  TestCreateWithCapabilities/duplicate_capabilities
09:09:58 [2019-11-26T09:09:58.721Z] === CONT  TestCreateWithCapabilities/empty_capadd
09:09:58 [2019-11-26T09:09:58.721Z] === CONT  TestCreateWithCapabilities/capabilities_API_v1.39
09:09:58 [2019-11-26T09:09:58.721Z] === CONT  TestCreateWithCapabilities/empty_capabilities
09:09:58 [2019-11-26T09:09:58.721Z] --- PASS: TestCreateWithCapabilities (0.03s)
09:09:58 [2019-11-26T09:09:58.721Z]     --- PASS: TestCreateWithCapabilities/conflict_with_capadd (0.00s)
09:09:58 [2019-11-26T09:09:58.721Z]     --- PASS: TestCreateWithCapabilities/conflict_with_capdrop (0.01s)
09:09:58 [2019-11-26T09:09:58.721Z]     --- PASS: TestCreateWithCapabilities/no_capabilities (0.05s)
09:09:58 [2019-11-26T09:09:58.721Z]     --- PASS: TestCreateWithCapabilities/capadd_capdrop (0.04s)
09:09:58 [2019-11-26T09:09:58.721Z]     --- PASS: TestCreateWithCapabilities/valid_capabilities (0.04s)
09:09:58 [2019-11-26T09:09:58.721Z]     --- PASS: TestCreateWithCapabilities/invalid_capabilities (0.01s)
09:09:58 [2019-11-26T09:09:58.721Z]     --- PASS: TestCreateWithCapabilities/empty_capdrop (0.06s)
09:09:58 [2019-11-26T09:09:58.721Z]     --- PASS: TestCreateWithCapabilities/duplicate_capabilities (0.05s)
09:09:58 [2019-11-26T09:09:58.721Z]     --- PASS: TestCreateWithCapabilities/empty_capabilities (0.05s)
09:09:58 [2019-11-26T09:09:58.721Z]     --- PASS: TestCreateWithCapabilities/capabilities_API_v1.39 (0.05s)
09:09:58 [2019-11-26T09:09:58.721Z]     --- PASS: TestCreateWithCapabilities/empty_capadd (0.05s)
09:09:58 [2019-11-26T09:09:58.721Z] === RUN   TestCreateWithCustomReadonlyPaths
09:10:00 [2019-11-26T09:10:00.410Z] --- PASS: TestCreateWithCustomReadonlyPaths (1.96s)
09:10:00 [2019-11-26T09:10:00.410Z] === RUN   TestCreateWithInvalidHealthcheckParams
09:10:00 [2019-11-26T09:10:00.410Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
09:10:00 [2019-11-26T09:10:00.410Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
09:10:00 [2019-11-26T09:10:00.410Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
09:10:00 [2019-11-26T09:10:00.410Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
09:10:00 [2019-11-26T09:10:00.410Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
09:10:00 [2019-11-26T09:10:00.410Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
09:10:00 [2019-11-26T09:10:00.410Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
09:10:00 [2019-11-26T09:10:00.410Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
09:10:00 [2019-11-26T09:10:00.410Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
09:10:00 [2019-11-26T09:10:00.410Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
09:10:00 [2019-11-26T09:10:00.410Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
09:10:00 [2019-11-26T09:10:00.410Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
09:10:00 [2019-11-26T09:10:00.410Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
09:10:00 [2019-11-26T09:10:00.410Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
09:10:00 [2019-11-26T09:10:00.410Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
09:10:00 [2019-11-26T09:10:00.410Z] --- PASS: TestCreateWithInvalidHealthcheckParams (0.03s)
09:10:00 [2019-11-26T09:10:00.410Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms (0.03s)
09:10:00 [2019-11-26T09:10:00.410Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s (0.03s)
09:10:00 [2019-11-26T09:10:00.410Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0 (0.03s)
09:10:00 [2019-11-26T09:10:00.410Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms (0.03s)
09:10:00 [2019-11-26T09:10:00.410Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms (0.02s)
09:10:00 [2019-11-26T09:10:00.410Z] === RUN   TestContainerStartOnDaemonRestart
09:10:00 [2019-11-26T09:10:00.410Z] === PAUSE TestContainerStartOnDaemonRestart
09:10:00 [2019-11-26T09:10:00.410Z] === RUN   TestDaemonRestartIpcMode
09:10:00 [2019-11-26T09:10:00.410Z] === PAUSE TestDaemonRestartIpcMode
09:10:00 [2019-11-26T09:10:00.410Z] === RUN   TestDiff
09:10:01 [2019-11-26T09:10:01.132Z] --- PASS: TestDiff (0.70s)
09:10:01 [2019-11-26T09:10:01.132Z] === RUN   TestExecWithCloseStdin
09:10:02 [2019-11-26T09:10:02.303Z] --- PASS: TestExecWithCloseStdin (0.92s)
09:10:02 [2019-11-26T09:10:02.303Z] === RUN   TestExec
09:10:03 [2019-11-26T09:10:03.032Z] --- PASS: TestExec (0.86s)
09:10:03 [2019-11-26T09:10:03.032Z] === RUN   TestExecUser
09:10:03 [2019-11-26T09:10:03.754Z] --- PASS: TestExecUser (0.87s)
09:10:03 [2019-11-26T09:10:03.754Z] === RUN   TestExportContainerAndImportImage
09:10:04 [2019-11-26T09:10:04.924Z] --- PASS: TestExportContainerAndImportImage (0.99s)
09:10:04 [2019-11-26T09:10:04.924Z] === RUN   TestExportContainerAfterDaemonRestart
09:10:06 [2019-11-26T09:10:06.610Z] --- PASS: TestExportContainerAfterDaemonRestart (1.56s)
09:10:06 [2019-11-26T09:10:06.610Z] === RUN   TestHealthCheckWorkdir
09:10:07 [2019-11-26T09:10:07.332Z] --- PASS: TestHealthCheckWorkdir (1.04s)
09:10:07 [2019-11-26T09:10:07.332Z] === RUN   TestHealthKillContainer
09:10:10 [2019-11-26T09:10:10.320Z] --- PASS: TestHealthKillContainer (2.91s)
09:10:10 [2019-11-26T09:10:10.320Z] === RUN   TestInspectCpusetInConfigPre120
09:10:11 [2019-11-26T09:10:11.109Z] --- PASS: TestInspectCpusetInConfigPre120 (0.70s)
09:10:11 [2019-11-26T09:10:11.109Z] === RUN   TestIpcModeNone
09:10:11 [2019-11-26T09:10:11.833Z] --- PASS: TestIpcModeNone (0.84s)
09:10:11 [2019-11-26T09:10:11.833Z] === RUN   TestIpcModePrivate
09:10:13 [2019-11-26T09:10:13.000Z] --- PASS: TestIpcModePrivate (0.85s)
09:10:13 [2019-11-26T09:10:13.000Z]     ipcmode_linux_test.go:90: [testIpcPrivateShareable] ipcmode: private, ipcdev: 0:62, shared: false, mustBeShared: false
09:10:13 [2019-11-26T09:10:13.000Z] === RUN   TestIpcModeShareable
09:10:13 [2019-11-26T09:10:13.721Z] --- PASS: TestIpcModeShareable (0.83s)
09:10:13 [2019-11-26T09:10:13.721Z]     ipcmode_linux_test.go:90: [testIpcPrivateShareable] ipcmode: shareable, ipcdev: 0:56, shared: true, mustBeShared: true
09:10:13 [2019-11-26T09:10:13.721Z] === RUN   TestAPIIpcModeShareableAndContainer
09:10:16 [2019-11-26T09:10:16.012Z] --- PASS: TestAPIIpcModeShareableAndContainer (2.39s)
09:10:16 [2019-11-26T09:10:16.012Z] === RUN   TestAPIIpcModeHost
09:10:16 [2019-11-26T09:10:16.739Z] --- PASS: TestAPIIpcModeHost (0.70s)
09:10:16 [2019-11-26T09:10:16.739Z] === RUN   TestDaemonIpcModeShareable
09:10:18 [2019-11-26T09:10:18.429Z] --- PASS: TestDaemonIpcModeShareable (1.74s)
09:10:18 [2019-11-26T09:10:18.429Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:64, shared: true, mustBeShared: true
09:10:18 [2019-11-26T09:10:18.429Z] === RUN   TestDaemonIpcModePrivate
09:10:20 [2019-11-26T09:10:20.115Z] --- PASS: TestDaemonIpcModePrivate (1.66s)
09:10:20 [2019-11-26T09:10:20.115Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:70, shared: false, mustBeShared: false
09:10:20 [2019-11-26T09:10:20.115Z] === RUN   TestDaemonIpcModePrivateFromConfig
09:10:21 [2019-11-26T09:10:21.804Z] --- PASS: TestDaemonIpcModePrivateFromConfig (1.70s)
09:10:21 [2019-11-26T09:10:21.804Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:70, shared: false, mustBeShared: false
09:10:21 [2019-11-26T09:10:21.804Z] === RUN   TestDaemonIpcModeShareableFromConfig
09:10:23 [2019-11-26T09:10:23.514Z] --- PASS: TestDaemonIpcModeShareableFromConfig (1.70s)
09:10:23 [2019-11-26T09:10:23.514Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:64, shared: true, mustBeShared: true
09:10:23 [2019-11-26T09:10:23.514Z] === RUN   TestIpcModeOlderClient
09:10:23 [2019-11-26T09:10:23.514Z] === PAUSE TestIpcModeOlderClient
09:10:23 [2019-11-26T09:10:23.514Z] === RUN   TestKillContainerInvalidSignal
09:10:24 [2019-11-26T09:10:24.238Z] --- PASS: TestKillContainerInvalidSignal (0.67s)
09:10:24 [2019-11-26T09:10:24.238Z] === RUN   TestKillContainer
09:10:24 [2019-11-26T09:10:24.238Z] === RUN   TestKillContainer/no_signal
09:10:24 [2019-11-26T09:10:24.960Z] === RUN   TestKillContainer/non_killing_signal
09:10:25 [2019-11-26T09:10:25.298Z] === RUN   TestKillContainer/killing_signal
09:10:26 [2019-11-26T09:10:26.467Z] --- PASS: TestKillContainer (2.04s)
09:10:26 [2019-11-26T09:10:26.467Z]     --- PASS: TestKillContainer/no_signal (0.65s)
09:10:26 [2019-11-26T09:10:26.467Z]     --- PASS: TestKillContainer/non_killing_signal (0.49s)
09:10:26 [2019-11-26T09:10:26.467Z]     --- PASS: TestKillContainer/killing_signal (0.63s)
09:10:26 [2019-11-26T09:10:26.467Z] === RUN   TestKillWithStopSignalAndRestartPolicies
09:10:26 [2019-11-26T09:10:26.467Z] === RUN   TestKillWithStopSignalAndRestartPolicies/same-signal-disables-restart-policy
09:10:26 [2019-11-26T09:10:26.810Z] === RUN   TestKillWithStopSignalAndRestartPolicies/different-signal-keep-restart-policy
09:10:27 [2019-11-26T09:10:27.559Z] --- PASS: TestKillWithStopSignalAndRestartPolicies (1.42s)
09:10:27 [2019-11-26T09:10:27.559Z]     --- PASS: TestKillWithStopSignalAndRestartPolicies/same-signal-disables-restart-policy (0.67s)
09:10:27 [2019-11-26T09:10:27.559Z]     --- PASS: TestKillWithStopSignalAndRestartPolicies/different-signal-keep-restart-policy (0.49s)
09:10:27 [2019-11-26T09:10:27.559Z] === RUN   TestKillStoppedContainer
09:10:27 [2019-11-26T09:10:27.559Z] --- PASS: TestKillStoppedContainer (0.09s)
09:10:27 [2019-11-26T09:10:27.559Z] === RUN   TestKillStoppedContainerAPIPre120
09:10:27 [2019-11-26T09:10:27.896Z] --- PASS: TestKillStoppedContainerAPIPre120 (0.08s)
09:10:27 [2019-11-26T09:10:27.896Z] === RUN   TestKillDifferentUserContainer
09:10:28 [2019-11-26T09:10:28.618Z] --- PASS: TestKillDifferentUserContainer (0.71s)
09:10:28 [2019-11-26T09:10:28.618Z] === RUN   TestInspectOomKilledTrue
09:10:29 [2019-11-26T09:10:29.785Z] --- PASS: TestInspectOomKilledTrue (1.15s)
09:10:29 [2019-11-26T09:10:29.785Z] === RUN   TestInspectOomKilledFalse
09:10:30 [2019-11-26T09:10:30.506Z] --- PASS: TestInspectOomKilledFalse (0.65s)
09:10:30 [2019-11-26T09:10:30.506Z] === RUN   TestLinksEtcHostsContentMatch
09:10:30 [2019-11-26T09:10:30.842Z] --- PASS: TestLinksEtcHostsContentMatch (0.66s)
09:10:30 [2019-11-26T09:10:30.842Z] === RUN   TestLinksContainerNames
09:10:32 [2019-11-26T09:10:32.531Z] --- PASS: TestLinksContainerNames (1.31s)
09:10:32 [2019-11-26T09:10:32.531Z] === RUN   TestLogsFollowTailEmpty
09:10:32 [2019-11-26T09:10:32.892Z] --- PASS: TestLogsFollowTailEmpty (0.69s)
09:10:32 [2019-11-26T09:10:32.892Z] === RUN   TestContainerNetworkMountsNoChown
09:10:33 [2019-11-26T09:10:33.618Z] --- PASS: TestContainerNetworkMountsNoChown (0.69s)
09:10:33 [2019-11-26T09:10:33.618Z] === RUN   TestMountDaemonRoot
09:10:33 [2019-11-26T09:10:33.618Z] === RUN   TestMountDaemonRoot/default
09:10:33 [2019-11-26T09:10:33.618Z] === PAUSE TestMountDaemonRoot/default
09:10:33 [2019-11-26T09:10:33.618Z] === RUN   TestMountDaemonRoot/private
09:10:33 [2019-11-26T09:10:33.618Z] === PAUSE TestMountDaemonRoot/private
09:10:33 [2019-11-26T09:10:33.618Z] === RUN   TestMountDaemonRoot/rprivate
09:10:33 [2019-11-26T09:10:33.618Z] === PAUSE TestMountDaemonRoot/rprivate
09:10:33 [2019-11-26T09:10:33.618Z] === RUN   TestMountDaemonRoot/slave
09:10:33 [2019-11-26T09:10:33.618Z] === PAUSE TestMountDaemonRoot/slave
09:10:33 [2019-11-26T09:10:33.618Z] === RUN   TestMountDaemonRoot/rslave
09:10:33 [2019-11-26T09:10:33.618Z] === PAUSE TestMountDaemonRoot/rslave
09:10:33 [2019-11-26T09:10:33.618Z] === RUN   TestMountDaemonRoot/shared
09:10:33 [2019-11-26T09:10:33.618Z] === PAUSE TestMountDaemonRoot/shared
09:10:33 [2019-11-26T09:10:33.618Z] === RUN   TestMountDaemonRoot/rshared
09:10:33 [2019-11-26T09:10:33.618Z] === PAUSE TestMountDaemonRoot/rshared
09:10:33 [2019-11-26T09:10:33.618Z] === CONT  TestMountDaemonRoot/default
09:10:33 [2019-11-26T09:10:33.618Z] === CONT  TestMountDaemonRoot/rshared
09:10:33 [2019-11-26T09:10:33.618Z] === CONT  TestMountDaemonRoot/shared
09:10:33 [2019-11-26T09:10:33.618Z] === CONT  TestMountDaemonRoot/rslave
09:10:33 [2019-11-26T09:10:33.618Z] === RUN   TestMountDaemonRoot/rshared/bind_subpath
09:10:33 [2019-11-26T09:10:33.618Z] === RUN   TestMountDaemonRoot/rslave/bind_root
09:10:33 [2019-11-26T09:10:33.618Z] === PAUSE TestMountDaemonRoot/rshared/bind_subpath
09:10:33 [2019-11-26T09:10:33.618Z] === RUN   TestMountDaemonRoot/default/bind_root
09:10:33 [2019-11-26T09:10:33.618Z] === RUN   TestMountDaemonRoot/shared/bind_root
09:10:33 [2019-11-26T09:10:33.618Z] === PAUSE TestMountDaemonRoot/rslave/bind_root
09:10:33 [2019-11-26T09:10:33.618Z] === PAUSE TestMountDaemonRoot/default/bind_root
09:10:33 [2019-11-26T09:10:33.618Z] === RUN   TestMountDaemonRoot/rslave/bind_subpath
09:10:33 [2019-11-26T09:10:33.618Z] === PAUSE TestMountDaemonRoot/shared/bind_root
09:10:33 [2019-11-26T09:10:33.618Z] === RUN   TestMountDaemonRoot/default/bind_subpath
09:10:33 [2019-11-26T09:10:33.618Z] === PAUSE TestMountDaemonRoot/rslave/bind_subpath
09:10:33 [2019-11-26T09:10:33.618Z] === RUN   TestMountDaemonRoot/shared/bind_subpath
09:10:33 [2019-11-26T09:10:33.618Z] === PAUSE TestMountDaemonRoot/default/bind_subpath
09:10:33 [2019-11-26T09:10:33.618Z] === RUN   TestMountDaemonRoot/rslave/mount_root
09:10:33 [2019-11-26T09:10:33.618Z] === PAUSE TestMountDaemonRoot/shared/bind_subpath
09:10:33 [2019-11-26T09:10:33.618Z] === RUN   TestMountDaemonRoot/rshared/mount_root
09:10:33 [2019-11-26T09:10:33.618Z] === RUN   TestMountDaemonRoot/shared/mount_root
09:10:33 [2019-11-26T09:10:33.618Z] === PAUSE TestMountDaemonRoot/rshared/mount_root
09:10:33 [2019-11-26T09:10:33.618Z] === RUN   TestMountDaemonRoot/default/mount_root
09:10:33 [2019-11-26T09:10:33.618Z] === PAUSE TestMountDaemonRoot/shared/mount_root
09:10:33 [2019-11-26T09:10:33.618Z] === RUN   TestMountDaemonRoot/rshared/mount_subpath
09:10:33 [2019-11-26T09:10:33.618Z] === RUN   TestMountDaemonRoot/shared/mount_subpath
09:10:33 [2019-11-26T09:10:33.618Z] === PAUSE TestMountDaemonRoot/default/mount_root
09:10:33 [2019-11-26T09:10:33.618Z] === PAUSE TestMountDaemonRoot/shared/mount_subpath
09:10:33 [2019-11-26T09:10:33.618Z] === PAUSE TestMountDaemonRoot/rshared/mount_subpath
09:10:33 [2019-11-26T09:10:33.618Z] === CONT  TestMountDaemonRoot/rprivate
09:10:33 [2019-11-26T09:10:33.618Z] === RUN   TestMountDaemonRoot/rshared/bind_root
09:10:33 [2019-11-26T09:10:33.618Z] === RUN   TestMountDaemonRoot/rprivate/bind_subpath
09:10:33 [2019-11-26T09:10:33.618Z] === PAUSE TestMountDaemonRoot/rshared/bind_root
09:10:33 [2019-11-26T09:10:33.618Z] === PAUSE TestMountDaemonRoot/rprivate/bind_subpath
09:10:33 [2019-11-26T09:10:33.618Z] === RUN   TestMountDaemonRoot/default/mount_subpath
09:10:33 [2019-11-26T09:10:33.618Z] === RUN   TestMountDaemonRoot/rprivate/mount_root
09:10:33 [2019-11-26T09:10:33.618Z] === PAUSE TestMountDaemonRoot/default/mount_subpath
09:10:33 [2019-11-26T09:10:33.618Z] === CONT  TestMountDaemonRoot/private
09:10:33 [2019-11-26T09:10:33.618Z] === CONT  TestMountDaemonRoot/slave
09:10:33 [2019-11-26T09:10:33.618Z] === RUN   TestMountDaemonRoot/private/bind_root
09:10:33 [2019-11-26T09:10:33.618Z] === RUN   TestMountDaemonRoot/slave/bind_root
09:10:33 [2019-11-26T09:10:33.618Z] === PAUSE TestMountDaemonRoot/private/bind_root
09:10:33 [2019-11-26T09:10:33.618Z] === PAUSE TestMountDaemonRoot/rslave/mount_root
09:10:33 [2019-11-26T09:10:33.618Z] === RUN   TestMountDaemonRoot/private/bind_subpath
09:10:33 [2019-11-26T09:10:33.618Z] === RUN   TestMountDaemonRoot/rslave/mount_subpath
09:10:33 [2019-11-26T09:10:33.618Z] === PAUSE TestMountDaemonRoot/rslave/mount_subpath
09:10:33 [2019-11-26T09:10:33.618Z] === PAUSE TestMountDaemonRoot/rprivate/mount_root
09:10:33 [2019-11-26T09:10:33.618Z] === RUN   TestMountDaemonRoot/rprivate/mount_subpath
09:10:33 [2019-11-26T09:10:33.618Z] === PAUSE TestMountDaemonRoot/rprivate/mount_subpath
09:10:33 [2019-11-26T09:10:33.618Z] === RUN   TestMountDaemonRoot/rprivate/bind_root
09:10:33 [2019-11-26T09:10:33.618Z] === PAUSE TestMountDaemonRoot/rprivate/bind_root
09:10:33 [2019-11-26T09:10:33.618Z] === CONT  TestMountDaemonRoot/shared/bind_root
09:10:33 [2019-11-26T09:10:33.618Z] === PAUSE TestMountDaemonRoot/slave/bind_root
09:10:33 [2019-11-26T09:10:33.618Z] === RUN   TestMountDaemonRoot/slave/bind_subpath
09:10:33 [2019-11-26T09:10:33.618Z] === PAUSE TestMountDaemonRoot/slave/bind_subpath
09:10:33 [2019-11-26T09:10:33.618Z] === RUN   TestMountDaemonRoot/slave/mount_root
09:10:33 [2019-11-26T09:10:33.618Z] === PAUSE TestMountDaemonRoot/slave/mount_root
09:10:33 [2019-11-26T09:10:33.618Z] === RUN   TestMountDaemonRoot/slave/mount_subpath
09:10:33 [2019-11-26T09:10:33.618Z] === PAUSE TestMountDaemonRoot/slave/mount_subpath
09:10:33 [2019-11-26T09:10:33.618Z] === PAUSE TestMountDaemonRoot/private/bind_subpath
09:10:33 [2019-11-26T09:10:33.618Z] === RUN   TestMountDaemonRoot/private/mount_root
09:10:33 [2019-11-26T09:10:33.618Z] === PAUSE TestMountDaemonRoot/private/mount_root
09:10:33 [2019-11-26T09:10:33.618Z] === RUN   TestMountDaemonRoot/private/mount_subpath
09:10:33 [2019-11-26T09:10:33.618Z] === PAUSE TestMountDaemonRoot/private/mount_subpath
09:10:33 [2019-11-26T09:10:33.618Z] === CONT  TestMountDaemonRoot/default/bind_root
09:10:33 [2019-11-26T09:10:33.618Z] === CONT  TestMountDaemonRoot/shared/mount_subpath
09:10:33 [2019-11-26T09:10:33.618Z] === CONT  TestMountDaemonRoot/rshared/bind_subpath
09:10:33 [2019-11-26T09:10:33.618Z] === CONT  TestMountDaemonRoot/shared/mount_root
09:10:33 [2019-11-26T09:10:33.618Z] === CONT  TestMountDaemonRoot/shared/bind_subpath
09:10:33 [2019-11-26T09:10:33.618Z] === CONT  TestMountDaemonRoot/rshared/bind_root
09:10:33 [2019-11-26T09:10:33.618Z] === CONT  TestMountDaemonRoot/rshared/mount_subpath
09:10:33 [2019-11-26T09:10:33.618Z] === CONT  TestMountDaemonRoot/rshared/mount_root
09:10:33 [2019-11-26T09:10:33.618Z] === CONT  TestMountDaemonRoot/default/bind_subpath
09:10:33 [2019-11-26T09:10:33.953Z] === CONT  TestMountDaemonRoot/default/mount_subpath
09:10:33 [2019-11-26T09:10:33.953Z] === CONT  TestMountDaemonRoot/default/mount_root
09:10:33 [2019-11-26T09:10:33.953Z] === CONT  TestMountDaemonRoot/rslave/bind_root
09:10:33 [2019-11-26T09:10:33.953Z] === CONT  TestMountDaemonRoot/rprivate/bind_subpath
09:10:33 [2019-11-26T09:10:33.953Z] === CONT  TestMountDaemonRoot/slave/bind_root
09:10:33 [2019-11-26T09:10:33.953Z] === CONT  TestMountDaemonRoot/rslave/mount_subpath
09:10:33 [2019-11-26T09:10:33.953Z] === CONT  TestMountDaemonRoot/rslave/mount_root
09:10:33 [2019-11-26T09:10:33.953Z] === CONT  TestMountDaemonRoot/rslave/bind_subpath
09:10:33 [2019-11-26T09:10:33.953Z] === CONT  TestMountDaemonRoot/private/bind_root
09:10:33 [2019-11-26T09:10:33.953Z] === CONT  TestMountDaemonRoot/slave/mount_subpath
09:10:33 [2019-11-26T09:10:33.953Z] === CONT  TestMountDaemonRoot/slave/mount_root
09:10:33 [2019-11-26T09:10:33.953Z] === CONT  TestMountDaemonRoot/slave/bind_subpath
09:10:33 [2019-11-26T09:10:33.953Z] === CONT  TestMountDaemonRoot/private/mount_subpath
09:10:33 [2019-11-26T09:10:33.953Z] === CONT  TestMountDaemonRoot/private/mount_root
09:10:33 [2019-11-26T09:10:33.953Z] === CONT  TestMountDaemonRoot/private/bind_subpath
09:10:33 [2019-11-26T09:10:33.953Z] === CONT  TestMountDaemonRoot/rprivate/bind_root
09:10:33 [2019-11-26T09:10:33.953Z] === CONT  TestMountDaemonRoot/rprivate/mount_subpath
09:10:33 [2019-11-26T09:10:33.953Z] === CONT  TestMountDaemonRoot/rprivate/mount_root
09:10:33 [2019-11-26T09:10:33.953Z] --- PASS: TestMountDaemonRoot (0.04s)
09:10:33 [2019-11-26T09:10:33.953Z]     --- PASS: TestMountDaemonRoot/shared (0.00s)
09:10:33 [2019-11-26T09:10:33.953Z]         --- PASS: TestMountDaemonRoot/shared/bind_root (0.04s)
09:10:33 [2019-11-26T09:10:33.953Z]         --- PASS: TestMountDaemonRoot/shared/mount_subpath (0.04s)
09:10:33 [2019-11-26T09:10:33.953Z]         --- PASS: TestMountDaemonRoot/shared/mount_root (0.02s)
09:10:33 [2019-11-26T09:10:33.953Z]         --- PASS: TestMountDaemonRoot/shared/bind_subpath (0.03s)
09:10:33 [2019-11-26T09:10:33.953Z]     --- PASS: TestMountDaemonRoot/rshared (0.00s)
09:10:33 [2019-11-26T09:10:33.953Z]         --- PASS: TestMountDaemonRoot/rshared/bind_subpath (0.08s)
09:10:33 [2019-11-26T09:10:33.953Z]         --- PASS: TestMountDaemonRoot/rshared/bind_root (0.06s)
09:10:33 [2019-11-26T09:10:33.953Z]         --- PASS: TestMountDaemonRoot/rshared/mount_root (0.06s)
09:10:33 [2019-11-26T09:10:33.953Z]         --- PASS: TestMountDaemonRoot/rshared/mount_subpath (0.08s)
09:10:33 [2019-11-26T09:10:33.953Z]     --- PASS: TestMountDaemonRoot/default (0.00s)
09:10:33 [2019-11-26T09:10:33.953Z]         --- PASS: TestMountDaemonRoot/default/bind_root (0.08s)
09:10:33 [2019-11-26T09:10:33.953Z]         --- PASS: TestMountDaemonRoot/default/bind_subpath (0.06s)
09:10:33 [2019-11-26T09:10:33.953Z]         --- PASS: TestMountDaemonRoot/default/mount_subpath (0.05s)
09:10:33 [2019-11-26T09:10:33.953Z]         --- PASS: TestMountDaemonRoot/default/mount_root (0.06s)
09:10:33 [2019-11-26T09:10:33.953Z]     --- PASS: TestMountDaemonRoot/rslave (0.00s)
09:10:33 [2019-11-26T09:10:33.953Z]         --- PASS: TestMountDaemonRoot/rslave/bind_root (0.06s)
09:10:33 [2019-11-26T09:10:33.953Z]         --- PASS: TestMountDaemonRoot/rslave/mount_subpath (0.08s)
09:10:33 [2019-11-26T09:10:33.953Z]         --- PASS: TestMountDaemonRoot/rslave/mount_root (0.07s)
09:10:33 [2019-11-26T09:10:33.953Z]         --- PASS: TestMountDaemonRoot/rslave/bind_subpath (0.07s)
09:10:33 [2019-11-26T09:10:33.953Z]     --- PASS: TestMountDaemonRoot/slave (0.00s)
09:10:33 [2019-11-26T09:10:33.953Z]         --- PASS: TestMountDaemonRoot/slave/bind_root (0.05s)
09:10:33 [2019-11-26T09:10:33.953Z]         --- PASS: TestMountDaemonRoot/slave/mount_subpath (0.02s)
09:10:33 [2019-11-26T09:10:33.953Z]         --- PASS: TestMountDaemonRoot/slave/mount_root (0.03s)
09:10:33 [2019-11-26T09:10:33.953Z]         --- PASS: TestMountDaemonRoot/slave/bind_subpath (0.04s)
09:10:33 [2019-11-26T09:10:33.953Z]     --- PASS: TestMountDaemonRoot/private (0.00s)
09:10:33 [2019-11-26T09:10:33.953Z]         --- PASS: TestMountDaemonRoot/private/bind_root (0.04s)
09:10:33 [2019-11-26T09:10:33.953Z]         --- PASS: TestMountDaemonRoot/private/mount_subpath (0.03s)
09:10:33 [2019-11-26T09:10:33.953Z]         --- PASS: TestMountDaemonRoot/private/mount_root (0.03s)
09:10:33 [2019-11-26T09:10:33.953Z]         --- PASS: TestMountDaemonRoot/private/bind_subpath (0.04s)
09:10:33 [2019-11-26T09:10:33.953Z]     --- PASS: TestMountDaemonRoot/rprivate (0.00s)
09:10:33 [2019-11-26T09:10:33.953Z]         --- PASS: TestMountDaemonRoot/rprivate/bind_subpath (0.04s)
09:10:33 [2019-11-26T09:10:33.953Z]         --- PASS: TestMountDaemonRoot/rprivate/bind_root (0.02s)
09:10:33 [2019-11-26T09:10:33.953Z]         --- PASS: TestMountDaemonRoot/rprivate/mount_subpath (0.04s)
09:10:33 [2019-11-26T09:10:33.953Z]         --- PASS: TestMountDaemonRoot/rprivate/mount_root (0.04s)
09:10:33 [2019-11-26T09:10:33.953Z] === RUN   TestContainerBindMountNonRecursive
09:10:35 [2019-11-26T09:10:35.640Z] --- PASS: TestContainerBindMountNonRecursive (1.69s)
09:10:35 [2019-11-26T09:10:35.640Z] === RUN   TestNetworkNat
09:10:36 [2019-11-26T09:10:36.361Z] --- PASS: TestNetworkNat (0.74s)
09:10:36 [2019-11-26T09:10:36.361Z] === RUN   TestNetworkLocalhostTCPNat
09:10:37 [2019-11-26T09:10:37.083Z] --- PASS: TestNetworkLocalhostTCPNat (0.74s)
09:10:37 [2019-11-26T09:10:37.083Z] === RUN   TestNetworkLoopbackNat
09:10:38 [2019-11-26T09:10:38.250Z] --- PASS: TestNetworkLoopbackNat (0.92s)
09:10:38 [2019-11-26T09:10:38.251Z] === RUN   TestPause
09:10:38 [2019-11-26T09:10:38.972Z] --- PASS: TestPause (0.76s)
09:10:38 [2019-11-26T09:10:38.972Z] === RUN   TestPauseFailsOnWindowsServerContainers
09:10:38 [2019-11-26T09:10:38.972Z] --- SKIP: TestPauseFailsOnWindowsServerContainers (0.00s)
09:10:38 [2019-11-26T09:10:38.972Z]     pause_test.go:54: testEnv.DaemonInfo.OSType != "windows" || testEnv.DaemonInfo.Isolation != "process"
09:10:38 [2019-11-26T09:10:38.972Z] === RUN   TestPauseStopPausedContainer
09:10:39 [2019-11-26T09:10:39.693Z] --- PASS: TestPauseStopPausedContainer (0.71s)
09:10:39 [2019-11-26T09:10:39.693Z] === RUN   TestPsFilter
09:10:39 [2019-11-26T09:10:39.693Z] --- PASS: TestPsFilter (0.18s)
09:10:39 [2019-11-26T09:10:39.693Z] === RUN   TestRemoveContainerWithRemovedVolume
09:10:40 [2019-11-26T09:10:40.416Z] --- PASS: TestRemoveContainerWithRemovedVolume (0.67s)
09:10:40 [2019-11-26T09:10:40.416Z] === RUN   TestRemoveContainerWithVolume
09:10:41 [2019-11-26T09:10:41.138Z] --- PASS: TestRemoveContainerWithVolume (0.69s)
09:10:41 [2019-11-26T09:10:41.138Z] === RUN   TestRemoveContainerRunning
09:10:41 [2019-11-26T09:10:41.917Z] --- PASS: TestRemoveContainerRunning (0.69s)
09:10:41 [2019-11-26T09:10:41.917Z] === RUN   TestRemoveContainerForceRemoveRunning
09:10:42 [2019-11-26T09:10:42.642Z] --- PASS: TestRemoveContainerForceRemoveRunning (0.73s)
09:10:42 [2019-11-26T09:10:42.642Z] === RUN   TestRemoveInvalidContainer
09:10:42 [2019-11-26T09:10:42.642Z] --- PASS: TestRemoveInvalidContainer (0.03s)
09:10:42 [2019-11-26T09:10:42.642Z] === RUN   TestRenameLinkedContainer
09:10:45 [2019-11-26T09:10:45.643Z] --- PASS: TestRenameLinkedContainer (2.74s)
09:10:45 [2019-11-26T09:10:45.643Z] === RUN   TestRenameStoppedContainer
09:10:45 [2019-11-26T09:10:45.979Z] --- PASS: TestRenameStoppedContainer (0.67s)
09:10:45 [2019-11-26T09:10:45.979Z] === RUN   TestRenameRunningContainerAndReuse
09:10:47 [2019-11-26T09:10:47.662Z] --- PASS: TestRenameRunningContainerAndReuse (1.37s)
09:10:47 [2019-11-26T09:10:47.663Z] === RUN   TestRenameInvalidName
09:10:47 [2019-11-26T09:10:47.998Z] --- PASS: TestRenameInvalidName (0.68s)
09:10:47 [2019-11-26T09:10:47.998Z] === RUN   TestRenameAnonymousContainer
09:10:51 [2019-11-26T09:10:51.074Z] --- PASS: TestRenameAnonymousContainer (2.53s)
09:10:51 [2019-11-26T09:10:51.074Z] === RUN   TestRenameContainerWithSameName
09:10:51 [2019-11-26T09:10:51.415Z] --- PASS: TestRenameContainerWithSameName (0.69s)
09:10:51 [2019-11-26T09:10:51.415Z] === RUN   TestRenameContainerWithLinkedContainer
09:10:52 [2019-11-26T09:10:52.585Z] --- PASS: TestRenameContainerWithLinkedContainer (1.39s)
09:10:52 [2019-11-26T09:10:52.585Z] === RUN   TestResize
09:10:53 [2019-11-26T09:10:53.308Z] --- PASS: TestResize (0.71s)
09:10:53 [2019-11-26T09:10:53.308Z] === RUN   TestResizeWithInvalidSize
09:10:54 [2019-11-26T09:10:54.030Z] --- PASS: TestResizeWithInvalidSize (0.69s)
09:10:54 [2019-11-26T09:10:54.030Z] === RUN   TestResizeWhenContainerNotStarted
09:10:54 [2019-11-26T09:10:54.755Z] --- PASS: TestResizeWhenContainerNotStarted (0.68s)
09:10:54 [2019-11-26T09:10:54.755Z] === RUN   TestDaemonRestartKillContainers
09:10:54 [2019-11-26T09:10:54.755Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
09:10:54 [2019-11-26T09:10:54.755Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
09:10:54 [2019-11-26T09:10:54.755Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
09:10:54 [2019-11-26T09:10:54.755Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
09:10:54 [2019-11-26T09:10:54.755Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
09:10:54 [2019-11-26T09:10:54.756Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
09:10:54 [2019-11-26T09:10:54.756Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
09:10:54 [2019-11-26T09:10:54.756Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
09:10:54 [2019-11-26T09:10:54.756Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
09:10:54 [2019-11-26T09:10:54.756Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
09:10:54 [2019-11-26T09:10:54.756Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
09:10:54 [2019-11-26T09:10:54.756Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
09:10:54 [2019-11-26T09:10:54.756Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
09:10:54 [2019-11-26T09:10:54.756Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
09:10:54 [2019-11-26T09:10:54.756Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
09:10:54 [2019-11-26T09:10:54.756Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
09:10:54 [2019-11-26T09:10:54.756Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
09:10:54 [2019-11-26T09:10:54.756Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
09:10:54 [2019-11-26T09:10:54.756Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
09:10:54 [2019-11-26T09:10:54.756Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
09:10:54 [2019-11-26T09:10:54.756Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
09:10:54 [2019-11-26T09:10:54.756Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
09:10:54 [2019-11-26T09:10:54.756Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
09:10:54 [2019-11-26T09:10:54.756Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
09:10:54 [2019-11-26T09:10:54.756Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
09:10:54 [2019-11-26T09:10:54.756Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
09:10:54 [2019-11-26T09:10:54.756Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
09:10:54 [2019-11-26T09:10:54.756Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
09:10:57 [2019-11-26T09:10:57.055Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
09:10:58 [2019-11-26T09:10:58.755Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
09:10:59 [2019-11-26T09:10:59.095Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
09:11:00 [2019-11-26T09:11:00.310Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
09:11:00 [2019-11-26T09:11:00.310Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
09:11:00 [2019-11-26T09:11:00.649Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
09:11:00 [2019-11-26T09:11:00.989Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
09:11:01 [2019-11-26T09:11:01.718Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
09:11:05 [2019-11-26T09:11:05.554Z] --- PASS: TestDaemonRestartKillContainers (0.00s)
09:11:05 [2019-11-26T09:11:05.554Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon (2.27s)
09:11:05 [2019-11-26T09:11:05.554Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon (4.08s)
09:11:05 [2019-11-26T09:11:05.554Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon (4.22s)
09:11:05 [2019-11-26T09:11:05.554Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon (5.36s)
09:11:05 [2019-11-26T09:11:05.554Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon (3.09s)
09:11:05 [2019-11-26T09:11:05.554Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon (1.96s)
09:11:05 [2019-11-26T09:11:05.554Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon (1.99s)
09:11:05 [2019-11-26T09:11:05.554Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon (1.74s)
09:11:05 [2019-11-26T09:11:05.554Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon (3.06s)
09:11:05 [2019-11-26T09:11:05.554Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon (3.06s)
09:11:05 [2019-11-26T09:11:05.554Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon (3.71s)
09:11:05 [2019-11-26T09:11:05.554Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon (3.39s)
09:11:05 [2019-11-26T09:11:05.554Z] === RUN   TestCgroupNamespacesRun
09:11:07 [2019-11-26T09:11:07.240Z] --- PASS: TestCgroupNamespacesRun (1.69s)
09:11:07 [2019-11-26T09:11:07.240Z] === RUN   TestCgroupNamespacesRunPrivileged
09:11:08 [2019-11-26T09:11:08.921Z] --- PASS: TestCgroupNamespacesRunPrivileged (1.68s)
09:11:08 [2019-11-26T09:11:08.921Z] === RUN   TestCgroupNamespacesRunDaemonHostMode
09:11:10 [2019-11-26T09:11:10.086Z] --- PASS: TestCgroupNamespacesRunDaemonHostMode (1.63s)
09:11:10 [2019-11-26T09:11:10.086Z] === RUN   TestCgroupNamespacesRunHostMode
09:11:11 [2019-11-26T09:11:11.772Z] --- PASS: TestCgroupNamespacesRunHostMode (1.68s)
09:11:11 [2019-11-26T09:11:11.772Z] === RUN   TestCgroupNamespacesRunPrivateMode
09:11:13 [2019-11-26T09:11:13.549Z] --- PASS: TestCgroupNamespacesRunPrivateMode (1.68s)
09:11:13 [2019-11-26T09:11:13.549Z] === RUN   TestCgroupNamespacesRunPrivilegedAndPrivate
09:11:14 [2019-11-26T09:11:14.713Z] --- PASS: TestCgroupNamespacesRunPrivilegedAndPrivate (0.88s)
09:11:14 [2019-11-26T09:11:14.713Z] === RUN   TestCgroupNamespacesRunInvalidMode
09:11:15 [2019-11-26T09:11:15.436Z] --- PASS: TestCgroupNamespacesRunInvalidMode (0.90s)
09:11:15 [2019-11-26T09:11:15.436Z] === RUN   TestCgroupNamespacesRunOlderClient
09:11:17 [2019-11-26T09:11:17.154Z] --- PASS: TestCgroupNamespacesRunOlderClient (1.71s)
09:11:17 [2019-11-26T09:11:17.154Z] === RUN   TestKernelTCPMemory
09:11:17 [2019-11-26T09:11:17.875Z] --- PASS: TestKernelTCPMemory (0.87s)
09:11:17 [2019-11-26T09:11:17.875Z] === RUN   TestNISDomainname
09:11:19 [2019-11-26T09:11:19.047Z] --- PASS: TestNISDomainname (1.02s)
09:11:19 [2019-11-26T09:11:19.047Z] === RUN   TestHostnameDnsResolution
09:11:20 [2019-11-26T09:11:20.214Z] --- PASS: TestHostnameDnsResolution (1.14s)
09:11:20 [2019-11-26T09:11:20.214Z] === RUN   TestStats
09:11:22 [2019-11-26T09:11:22.500Z] --- PASS: TestStats (2.20s)
09:11:22 [2019-11-26T09:11:22.500Z] === RUN   TestStopContainerWithTimeout
09:11:22 [2019-11-26T09:11:22.500Z] === RUN   TestStopContainerWithTimeout/0
09:11:22 [2019-11-26T09:11:22.500Z] === PAUSE TestStopContainerWithTimeout/0
09:11:22 [2019-11-26T09:11:22.500Z] === RUN   TestStopContainerWithTimeout/1
09:11:22 [2019-11-26T09:11:22.500Z] === PAUSE TestStopContainerWithTimeout/1
09:11:22 [2019-11-26T09:11:22.500Z] === RUN   TestStopContainerWithTimeout/3
09:11:22 [2019-11-26T09:11:22.500Z] === PAUSE TestStopContainerWithTimeout/3
09:11:22 [2019-11-26T09:11:22.500Z] === RUN   TestStopContainerWithTimeout/-1
09:11:22 [2019-11-26T09:11:22.500Z] === PAUSE TestStopContainerWithTimeout/-1
09:11:22 [2019-11-26T09:11:22.500Z] === CONT  TestStopContainerWithTimeout/0
09:11:22 [2019-11-26T09:11:22.500Z] === CONT  TestStopContainerWithTimeout/3
09:11:22 [2019-11-26T09:11:22.500Z] === CONT  TestStopContainerWithTimeout/-1
09:11:22 [2019-11-26T09:11:22.500Z] === CONT  TestStopContainerWithTimeout/1
09:11:26 [2019-11-26T09:11:26.334Z] --- PASS: TestStopContainerWithTimeout (0.03s)
09:11:26 [2019-11-26T09:11:26.334Z]     --- PASS: TestStopContainerWithTimeout/0 (1.48s)
09:11:26 [2019-11-26T09:11:26.334Z]     --- PASS: TestStopContainerWithTimeout/1 (2.49s)
09:11:26 [2019-11-26T09:11:26.334Z]     --- PASS: TestStopContainerWithTimeout/-1 (2.85s)
09:11:26 [2019-11-26T09:11:26.334Z]     --- PASS: TestStopContainerWithTimeout/3 (3.36s)
09:11:26 [2019-11-26T09:11:26.334Z] === RUN   TestDeleteDevicemapper
09:11:26 [2019-11-26T09:11:26.334Z] --- SKIP: TestDeleteDevicemapper (0.00s)
09:11:26 [2019-11-26T09:11:26.334Z]     stop_linux_test.go:74: testEnv.DaemonInfo.Driver != "devicemapper"
09:11:26 [2019-11-26T09:11:26.334Z] === RUN   TestStopContainerWithRestartPolicyAlways
09:11:28 [2019-11-26T09:11:28.628Z] --- PASS: TestStopContainerWithRestartPolicyAlways (3.04s)
09:11:28 [2019-11-26T09:11:28.628Z] === RUN   TestUpdateMemory
09:11:29 [2019-11-26T09:11:29.798Z] --- PASS: TestUpdateMemory (1.07s)
09:11:29 [2019-11-26T09:11:29.798Z] === RUN   TestUpdateCPUQuota
09:11:31 [2019-11-26T09:11:31.483Z] --- PASS: TestUpdateCPUQuota (1.50s)
09:11:31 [2019-11-26T09:11:31.483Z] === RUN   TestUpdatePidsLimit
09:11:31 [2019-11-26T09:11:31.483Z] === RUN   TestUpdatePidsLimit/update_from_none
09:11:31 [2019-11-26T09:11:31.819Z] === RUN   TestUpdatePidsLimit/no_change
09:11:32 [2019-11-26T09:11:32.155Z] === RUN   TestUpdatePidsLimit/update_lower
09:11:32 [2019-11-26T09:11:32.490Z] === RUN   TestUpdatePidsLimit/update_on_old_api_ignores_value
09:11:32 [2019-11-26T09:11:32.826Z] === RUN   TestUpdatePidsLimit/unset_limit_with_zero
09:11:33 [2019-11-26T09:11:33.162Z] === RUN   TestUpdatePidsLimit/unset_limit_with_minus_one
09:11:33 [2019-11-26T09:11:33.498Z] === RUN   TestUpdatePidsLimit/unset_limit_with_minus_two
09:11:35 [2019-11-26T09:11:35.246Z] --- PASS: TestUpdatePidsLimit (3.91s)
09:11:35 [2019-11-26T09:11:35.246Z]     --- PASS: TestUpdatePidsLimit/update_from_none (0.36s)
09:11:35 [2019-11-26T09:11:35.246Z]     --- PASS: TestUpdatePidsLimit/no_change (0.37s)
09:11:35 [2019-11-26T09:11:35.246Z]     --- PASS: TestUpdatePidsLimit/update_lower (0.40s)
09:11:35 [2019-11-26T09:11:35.246Z]     --- PASS: TestUpdatePidsLimit/update_on_old_api_ignores_value (0.38s)
09:11:35 [2019-11-26T09:11:35.246Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_zero (0.39s)
09:11:35 [2019-11-26T09:11:35.246Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_minus_one (0.38s)
09:11:35 [2019-11-26T09:11:35.246Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_minus_two (0.37s)
09:11:35 [2019-11-26T09:11:35.246Z] === RUN   TestUpdateRestartPolicy
09:11:48 [2019-11-26T09:11:48.443Z] --- PASS: TestUpdateRestartPolicy (12.13s)
09:11:48 [2019-11-26T09:11:48.443Z] === RUN   TestUpdateRestartWithAutoRemove
09:11:48 [2019-11-26T09:11:48.443Z] --- PASS: TestUpdateRestartWithAutoRemove (0.72s)
09:11:48 [2019-11-26T09:11:48.443Z] === RUN   TestWaitNonBlocked
09:11:48 [2019-11-26T09:11:48.443Z] === RUN   TestWaitNonBlocked/wait-nonblocking-exit-0
09:11:48 [2019-11-26T09:11:48.443Z] === PAUSE TestWaitNonBlocked/wait-nonblocking-exit-0
09:11:48 [2019-11-26T09:11:48.443Z] === RUN   TestWaitNonBlocked/wait-nonblocking-exit-random
09:11:48 [2019-11-26T09:11:48.443Z] === PAUSE TestWaitNonBlocked/wait-nonblocking-exit-random
09:11:48 [2019-11-26T09:11:48.443Z] === CONT  TestWaitNonBlocked/wait-nonblocking-exit-0
09:11:48 [2019-11-26T09:11:48.443Z] === CONT  TestWaitNonBlocked/wait-nonblocking-exit-random
09:11:48 [2019-11-26T09:11:48.779Z] --- PASS: TestWaitNonBlocked (0.05s)
09:11:48 [2019-11-26T09:11:48.779Z]     --- PASS: TestWaitNonBlocked/wait-nonblocking-exit-random (0.75s)
09:11:48 [2019-11-26T09:11:48.779Z]     --- PASS: TestWaitNonBlocked/wait-nonblocking-exit-0 (0.81s)
09:11:48 [2019-11-26T09:11:48.779Z] === RUN   TestWaitBlocked
09:11:48 [2019-11-26T09:11:48.779Z] === RUN   TestWaitBlocked/test-wait-blocked-exit-zero
09:11:48 [2019-11-26T09:11:48.779Z] === PAUSE TestWaitBlocked/test-wait-blocked-exit-zero
09:11:48 [2019-11-26T09:11:48.779Z] === RUN   TestWaitBlocked/test-wait-blocked-exit-random
09:11:48 [2019-11-26T09:11:48.779Z] === PAUSE TestWaitBlocked/test-wait-blocked-exit-random
09:11:49 [2019-11-26T09:11:49.147Z] === CONT  TestWaitBlocked/test-wait-blocked-exit-zero
09:11:49 [2019-11-26T09:11:49.147Z] === CONT  TestWaitBlocked/test-wait-blocked-exit-random
09:11:49 [2019-11-26T09:11:49.873Z] --- PASS: TestWaitBlocked (0.03s)
09:11:49 [2019-11-26T09:11:49.873Z]     --- PASS: TestWaitBlocked/test-wait-blocked-exit-random (0.97s)
09:11:49 [2019-11-26T09:11:49.873Z]     --- PASS: TestWaitBlocked/test-wait-blocked-exit-zero (1.02s)
09:11:49 [2019-11-26T09:11:49.873Z] === CONT  TestContainerStartOnDaemonRestart
09:11:49 [2019-11-26T09:11:49.873Z] === CONT  TestIpcModeOlderClient
09:11:49 [2019-11-26T09:11:49.873Z] === CONT  TestDaemonRestartIpcMode
09:11:50 [2019-11-26T09:11:50.209Z] --- PASS: TestIpcModeOlderClient (0.17s)
09:11:54 [2019-11-26T09:11:54.043Z] --- PASS: TestDaemonRestartIpcMode (3.61s)
09:11:54 [2019-11-26T09:11:54.043Z] --- PASS: TestContainerStartOnDaemonRestart (3.90s)
09:11:54 [2019-11-26T09:11:54.043Z] PASS
09:11:54 [2019-11-26T09:11:54.043Z] 
09:11:54 [2019-11-26T09:11:54.043Z] === Skipped
09:11:54 [2019-11-26T09:11:54.043Z] === SKIP: ppc64le.integration.container TestCheckpoint (0.00s)
09:11:54 [2019-11-26T09:11:54.043Z]     checkpoint_test.go:33: TestCheckpoint is broken; see https://github.com/moby/moby/issues/38963
09:11:54 [2019-11-26T09:11:54.043Z] 
09:11:54 [2019-11-26T09:11:54.043Z] === SKIP: ppc64le.integration.container TestPauseFailsOnWindowsServerContainers (0.00s)
09:11:54 [2019-11-26T09:11:54.043Z]     pause_test.go:54: testEnv.DaemonInfo.OSType != "windows" || testEnv.DaemonInfo.Isolation != "process"
09:11:54 [2019-11-26T09:11:54.043Z] 
09:11:54 [2019-11-26T09:11:54.043Z] === SKIP: ppc64le.integration.container TestDeleteDevicemapper (0.00s)
09:11:54 [2019-11-26T09:11:54.043Z]     stop_linux_test.go:74: testEnv.DaemonInfo.Driver != "devicemapper"
09:11:54 [2019-11-26T09:11:54.043Z] 
09:11:54 [2019-11-26T09:11:54.043Z] 
09:11:54 [2019-11-26T09:11:54.043Z] DONE 197 tests, 3 skipped in 120.549s
09:11:54 [2019-11-26T09:11:54.043Z] Running /go/src/github.com/docker/docker/integration/image (ppc64le.integration.image) flags=-test.v -test.timeout=120m 
09:11:54 [2019-11-26T09:11:54.043Z] ++ 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
09:11:54 [2019-11-26T09:11:54.043Z] ++ set -e
09:11:54 [2019-11-26T09:11:54.043Z] ++ '[' -n 0 ']'
09:11:54 [2019-11-26T09:11:54.043Z] ++ set -x
09:11:54 [2019-11-26T09:11:54.043Z] ++ 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
09:11:54 [2019-11-26T09:11:54.043Z] INFO: Testing against a local daemon
09:11:54 [2019-11-26T09:11:54.043Z] === RUN   TestCommitInheritsEnv
09:11:54 [2019-11-26T09:11:54.381Z] --- PASS: TestCommitInheritsEnv (0.40s)
09:11:54 [2019-11-26T09:11:54.381Z] === RUN   TestImportExtremelyLargeImageWorks
09:11:54 [2019-11-26T09:11:54.381Z] === PAUSE TestImportExtremelyLargeImageWorks
09:11:54 [2019-11-26T09:11:54.381Z] === RUN   TestImagesFilterMultiReference
09:11:54 [2019-11-26T09:11:54.381Z] --- PASS: TestImagesFilterMultiReference (0.07s)
09:11:54 [2019-11-26T09:11:54.381Z] === RUN   TestImagePullPlatformInvalid
09:11:54 [2019-11-26T09:11:54.717Z] --- PASS: TestImagePullPlatformInvalid (0.05s)
09:11:54 [2019-11-26T09:11:54.717Z] === RUN   TestRemoveImageOrphaning
09:11:55 [2019-11-26T09:11:55.053Z] --- PASS: TestRemoveImageOrphaning (0.40s)
09:11:55 [2019-11-26T09:11:55.053Z] === RUN   TestRemoveImageGarbageCollector
09:11:55 [2019-11-26T09:11:55.053Z] --- SKIP: TestRemoveImageGarbageCollector (0.00s)
09:11:55 [2019-11-26T09:11:55.053Z]     remove_unix_test.go:36: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
09:11:55 [2019-11-26T09:11:55.053Z] === RUN   TestTagUnprefixedRepoByNameOrName
09:11:55 [2019-11-26T09:11:55.053Z] --- PASS: TestTagUnprefixedRepoByNameOrName (0.05s)
09:11:55 [2019-11-26T09:11:55.053Z] === RUN   TestTagInvalidReference
09:11:55 [2019-11-26T09:11:55.053Z] --- PASS: TestTagInvalidReference (0.04s)
09:11:55 [2019-11-26T09:11:55.053Z] === RUN   TestTagValidPrefixedRepo
09:11:55 [2019-11-26T09:11:55.053Z] --- PASS: TestTagValidPrefixedRepo (0.05s)
09:11:55 [2019-11-26T09:11:55.053Z] === RUN   TestTagExistedNameWithoutForce
09:11:55 [2019-11-26T09:11:55.053Z] --- PASS: TestTagExistedNameWithoutForce (0.04s)
09:11:55 [2019-11-26T09:11:55.053Z] === RUN   TestTagOfficialNames
09:11:55 [2019-11-26T09:11:55.053Z] --- PASS: TestTagOfficialNames (0.06s)
09:11:55 [2019-11-26T09:11:55.053Z] === RUN   TestTagMatchesDigest
09:11:55 [2019-11-26T09:11:55.390Z] --- PASS: TestTagMatchesDigest (0.03s)
09:11:55 [2019-11-26T09:11:55.390Z] === CONT  TestImportExtremelyLargeImageWorks
09:17:05 [2019-11-26T09:17:05.086Z] --- PASS: TestImportExtremelyLargeImageWorks (299.57s)
09:17:05 [2019-11-26T09:17:05.086Z] PASS
09:17:05 [2019-11-26T09:17:05.086Z] 
09:17:05 [2019-11-26T09:17:05.086Z] === Skipped
09:17:05 [2019-11-26T09:17:05.086Z] === SKIP: ppc64le.integration.image TestRemoveImageGarbageCollector (0.00s)
09:17:05 [2019-11-26T09:17:05.086Z]     remove_unix_test.go:36: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
09:17:05 [2019-11-26T09:17:05.086Z] 
09:17:05 [2019-11-26T09:17:05.086Z] 
09:17:05 [2019-11-26T09:17:05.086Z] DONE 12 tests, 1 skipped in 300.899s
09:17:05 [2019-11-26T09:17:05.086Z] Running /go/src/github.com/docker/docker/integration/network (ppc64le.integration.network) flags=-test.v -test.timeout=120m 
09:17:05 [2019-11-26T09:17:05.086Z] ++ 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
09:17:05 [2019-11-26T09:17:05.086Z] ++ set -e
09:17:05 [2019-11-26T09:17:05.086Z] ++ '[' -n 0 ']'
09:17:05 [2019-11-26T09:17:05.086Z] ++ set -x
09:17:05 [2019-11-26T09:17:05.087Z] ++ 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
09:17:05 [2019-11-26T09:17:05.087Z] INFO: Testing against a local daemon
09:17:05 [2019-11-26T09:17:05.087Z] === RUN   TestNetworkCreateDelete
09:17:05 [2019-11-26T09:17:05.087Z] --- PASS: TestNetworkCreateDelete (0.22s)
09:17:05 [2019-11-26T09:17:05.087Z] === RUN   TestDockerNetworkDeletePreferID
09:17:05 [2019-11-26T09:17:05.087Z] --- PASS: TestDockerNetworkDeletePreferID (0.61s)
09:17:05 [2019-11-26T09:17:05.087Z] === RUN   TestInspectNetwork
09:17:05 [2019-11-26T09:17:05.087Z] === RUN   TestInspectNetwork/full_network_id
09:17:05 [2019-11-26T09:17:05.087Z] === RUN   TestInspectNetwork/partial_network_id
09:17:05 [2019-11-26T09:17:05.087Z] === RUN   TestInspectNetwork/network_name
09:17:05 [2019-11-26T09:17:05.087Z] === RUN   TestInspectNetwork/network_name_and_swarm_scope
09:17:05 [2019-11-26T09:17:05.087Z] --- PASS: TestInspectNetwork (8.48s)
09:17:05 [2019-11-26T09:17:05.087Z]     --- PASS: TestInspectNetwork/full_network_id (0.00s)
09:17:05 [2019-11-26T09:17:05.087Z]     --- PASS: TestInspectNetwork/partial_network_id (0.00s)
09:17:05 [2019-11-26T09:17:05.087Z]     --- PASS: TestInspectNetwork/network_name (0.00s)
09:17:05 [2019-11-26T09:17:05.087Z]     --- PASS: TestInspectNetwork/network_name_and_swarm_scope (0.00s)
09:17:05 [2019-11-26T09:17:05.087Z] === RUN   TestRunContainerWithBridgeNone
09:17:06 [2019-11-26T09:17:06.779Z] --- PASS: TestRunContainerWithBridgeNone (2.60s)
09:17:06 [2019-11-26T09:17:06.779Z] === RUN   TestNetworkInvalidJSON
09:17:06 [2019-11-26T09:17:06.779Z] === RUN   TestNetworkInvalidJSON//networks/create
09:17:06 [2019-11-26T09:17:06.779Z] === PAUSE TestNetworkInvalidJSON//networks/create
09:17:06 [2019-11-26T09:17:06.779Z] === RUN   TestNetworkInvalidJSON//networks/bridge/connect
09:17:06 [2019-11-26T09:17:06.779Z] === PAUSE TestNetworkInvalidJSON//networks/bridge/connect
09:17:06 [2019-11-26T09:17:06.780Z] === RUN   TestNetworkInvalidJSON//networks/bridge/disconnect
09:17:06 [2019-11-26T09:17:06.780Z] === PAUSE TestNetworkInvalidJSON//networks/bridge/disconnect
09:17:06 [2019-11-26T09:17:06.780Z] === CONT  TestNetworkInvalidJSON//networks/create
09:17:06 [2019-11-26T09:17:06.780Z] === CONT  TestNetworkInvalidJSON//networks/bridge/connect
09:17:06 [2019-11-26T09:17:06.780Z] === CONT  TestNetworkInvalidJSON//networks/bridge/disconnect
09:17:06 [2019-11-26T09:17:06.780Z] --- PASS: TestNetworkInvalidJSON (0.04s)
09:17:06 [2019-11-26T09:17:06.780Z]     --- PASS: TestNetworkInvalidJSON//networks/create (0.00s)
09:17:06 [2019-11-26T09:17:06.780Z]     --- PASS: TestNetworkInvalidJSON//networks/bridge/disconnect (0.00s)
09:17:06 [2019-11-26T09:17:06.780Z]     --- PASS: TestNetworkInvalidJSON//networks/bridge/connect (0.00s)
09:17:06 [2019-11-26T09:17:06.780Z] === RUN   TestDaemonRestartWithLiveRestore
09:17:07 [2019-11-26T09:17:07.951Z] --- PASS: TestDaemonRestartWithLiveRestore (1.06s)
09:17:07 [2019-11-26T09:17:07.951Z] === RUN   TestDaemonDefaultNetworkPools
09:17:08 [2019-11-26T09:17:08.750Z] --- PASS: TestDaemonDefaultNetworkPools (0.81s)
09:17:08 [2019-11-26T09:17:08.750Z] === RUN   TestDaemonRestartWithExistingNetwork
09:17:09 [2019-11-26T09:17:09.922Z] --- PASS: TestDaemonRestartWithExistingNetwork (1.24s)
09:17:09 [2019-11-26T09:17:09.922Z] === RUN   TestDaemonRestartWithExistingNetworkWithDefaultPoolRange
09:17:11 [2019-11-26T09:17:11.617Z] --- PASS: TestDaemonRestartWithExistingNetworkWithDefaultPoolRange (1.48s)
09:17:11 [2019-11-26T09:17:11.617Z] === RUN   TestDaemonWithBipAndDefaultNetworkPool
09:17:11 [2019-11-26T09:17:11.955Z] --- PASS: TestDaemonWithBipAndDefaultNetworkPool (0.57s)
09:17:11 [2019-11-26T09:17:11.955Z] === RUN   TestServiceWithPredefinedNetwork
09:17:14 [2019-11-26T09:17:14.251Z] --- PASS: TestServiceWithPredefinedNetwork (2.33s)
09:17:14 [2019-11-26T09:17:14.251Z] === RUN   TestServiceRemoveKeepsIngressNetwork
09:17:14 [2019-11-26T09:17:14.251Z] --- SKIP: TestServiceRemoveKeepsIngressNetwork (0.00s)
09:17:14 [2019-11-26T09:17:14.251Z]     service_test.go:230: FLAKY_TEST
09:17:14 [2019-11-26T09:17:14.251Z] === RUN   TestServiceWithDataPathPortInit
09:17:30 [2019-11-26T09:17:30.233Z] --- PASS: TestServiceWithDataPathPortInit (15.52s)
09:17:30 [2019-11-26T09:17:30.233Z] === RUN   TestServiceWithDefaultAddressPoolInit
09:17:37 [2019-11-26T09:17:37.578Z] --- PASS: TestServiceWithDefaultAddressPoolInit (7.17s)
09:17:37 [2019-11-26T09:17:37.578Z]     service_test.go:418: TestServiceWithDefaultAddressPoolInit: NetworkInspect: {Name:sthiraTestServiceWithDefaultAddressPoolInit ID:ys3kp8in4g71pivfg8x9i7zli Created:2019-11-26 09:17:30.957046404 +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[441b419c8c10e07e50c499779f25e6f7e1e9c4635a1082e02cc4fac3869f4b39:{Name:TestServiceTestServiceWithDefaultAddressPoolInit.1.oaa8rnp52qsh25mfldt3m010s EndpointID:7bd0b91d20beb2270d04a2bb6284430ba5e5d9a0816d30fa6373e23b11eba0a0 MacAddress:02:42:14:14:00:03 IPv4Address:20.20.0.3/24 IPv6Address:} lb-sthiraTestServiceWithDefaultAddressPoolInit:{Name:sthiraTestServiceWithDefaultAddressPoolInit-endpoint EndpointID:347e3736dfc84f77eea1680b49ac9f571a7b259fc6b4980f6f7abdb771511fd7 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:90abe37cebf7 IP:127.0.0.1}] Services:map[TestServiceTestServiceWithDefaultAddressPoolInit:{VIP:20.20.0.2 Ports:[] LocalLBIndex:256 Tasks:[{Name:TestServiceTestServiceWithDefaultAddressPoolInit.1.oaa8rnp52qsh25mfldt3m010s EndpointID:7bd0b91d20beb2270d04a2bb6284430ba5e5d9a0816d30fa6373e23b11eba0a0 EndpointIP:20.20.0.3 Info:map[Host IP:127.0.0.1]}]}]}
09:17:37 [2019-11-26T09:17:37.578Z] PASS
09:17:37 [2019-11-26T09:17:37.578Z] 
09:17:37 [2019-11-26T09:17:37.578Z] === Skipped
09:17:37 [2019-11-26T09:17:37.578Z] === SKIP: ppc64le.integration.network TestServiceRemoveKeepsIngressNetwork (0.00s)
09:17:37 [2019-11-26T09:17:37.578Z]     service_test.go:230: FLAKY_TEST
09:17:37 [2019-11-26T09:17:37.578Z] 
09:17:37 [2019-11-26T09:17:37.578Z] 
09:17:37 [2019-11-26T09:17:37.578Z] DONE 21 tests, 1 skipped in 42.231s
09:17:37 [2019-11-26T09:17:37.578Z] Running /go/src/github.com/docker/docker/integration/network/ipvlan (ppc64le.integration.network.ipvlan) flags=-test.v -test.timeout=120m 
09:17:37 [2019-11-26T09:17:37.578Z] ++ 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
09:17:37 [2019-11-26T09:17:37.578Z] ++ set -e
09:17:37 [2019-11-26T09:17:37.578Z] ++ '[' -n 0 ']'
09:17:37 [2019-11-26T09:17:37.578Z] ++ set -x
09:17:37 [2019-11-26T09:17:37.578Z] ++ 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
09:17:37 [2019-11-26T09:17:37.578Z] INFO: Testing against a local daemon
09:17:37 [2019-11-26T09:17:37.578Z] === RUN   TestDockerNetworkIpvlanPersistance
09:17:37 [2019-11-26T09:17:37.578Z] --- SKIP: TestDockerNetworkIpvlanPersistance (0.01s)
09:17:37 [2019-11-26T09:17:37.578Z]     ipvlan_test.go:26: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
09:17:37 [2019-11-26T09:17:37.578Z] === RUN   TestDockerNetworkIpvlan
09:17:37 [2019-11-26T09:17:37.578Z] --- SKIP: TestDockerNetworkIpvlan (0.00s)
09:17:37 [2019-11-26T09:17:37.578Z]     ipvlan_test.go:53: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
09:17:37 [2019-11-26T09:17:37.578Z] PASS
09:17:37 [2019-11-26T09:17:37.578Z] 
09:17:37 [2019-11-26T09:17:37.578Z] === Skipped
09:17:37 [2019-11-26T09:17:37.578Z] === SKIP: ppc64le.integration.network.ipvlan TestDockerNetworkIpvlanPersistance (0.01s)
09:17:37 [2019-11-26T09:17:37.578Z]     ipvlan_test.go:26: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
09:17:37 [2019-11-26T09:17:37.578Z] 
09:17:37 [2019-11-26T09:17:37.578Z] === SKIP: ppc64le.integration.network.ipvlan TestDockerNetworkIpvlan (0.00s)
09:17:37 [2019-11-26T09:17:37.578Z]     ipvlan_test.go:53: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
09:17:37 [2019-11-26T09:17:37.578Z] 
09:17:37 [2019-11-26T09:17:37.578Z] 
09:17:37 [2019-11-26T09:17:37.578Z] DONE 2 tests, 2 skipped in 0.106s
09:17:37 [2019-11-26T09:17:37.578Z] Running /go/src/github.com/docker/docker/integration/network/macvlan (ppc64le.integration.network.macvlan) flags=-test.v -test.timeout=120m 
09:17:37 [2019-11-26T09:17:37.578Z] ++ 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
09:17:37 [2019-11-26T09:17:37.578Z] ++ set -e
09:17:37 [2019-11-26T09:17:37.578Z] ++ '[' -n 0 ']'
09:17:37 [2019-11-26T09:17:37.578Z] ++ set -x
09:17:37 [2019-11-26T09:17:37.578Z] ++ 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
09:17:37 [2019-11-26T09:17:37.578Z] INFO: Testing against a local daemon
09:17:37 [2019-11-26T09:17:37.578Z] === RUN   TestDockerNetworkMacvlanPersistance
09:17:38 [2019-11-26T09:17:38.783Z] --- PASS: TestDockerNetworkMacvlanPersistance (1.48s)
09:17:38 [2019-11-26T09:17:38.783Z] === RUN   TestDockerNetworkMacvlan
09:17:39 [2019-11-26T09:17:39.535Z] === RUN   TestDockerNetworkMacvlan/Subinterface
09:17:40 [2019-11-26T09:17:40.707Z] === RUN   TestDockerNetworkMacvlan/OverlapParent
09:17:41 [2019-11-26T09:17:41.878Z] === RUN   TestDockerNetworkMacvlan/NilParent
09:17:44 [2019-11-26T09:17:44.180Z] === RUN   TestDockerNetworkMacvlan/InternalMode
09:17:48 [2019-11-26T09:17:48.047Z] === RUN   TestDockerNetworkMacvlan/MultiSubnet
09:17:52 [2019-11-26T09:17:52.864Z] === RUN   TestDockerNetworkMacvlan/Addressing
09:17:54 [2019-11-26T09:17:54.037Z] --- PASS: TestDockerNetworkMacvlan (15.00s)
09:17:54 [2019-11-26T09:17:54.037Z]     --- PASS: TestDockerNetworkMacvlan/Subinterface (0.09s)
09:17:54 [2019-11-26T09:17:54.037Z]     --- PASS: TestDockerNetworkMacvlan/OverlapParent (0.11s)
09:17:54 [2019-11-26T09:17:54.037Z]     --- PASS: TestDockerNetworkMacvlan/NilParent (1.19s)
09:17:54 [2019-11-26T09:17:54.037Z]     --- PASS: TestDockerNetworkMacvlan/InternalMode (2.17s)
09:17:54 [2019-11-26T09:17:54.037Z]     --- PASS: TestDockerNetworkMacvlan/MultiSubnet (3.25s)
09:17:54 [2019-11-26T09:17:54.037Z]     --- PASS: TestDockerNetworkMacvlan/Addressing (0.95s)
09:17:54 [2019-11-26T09:17:54.037Z] PASS
09:17:54 [2019-11-26T09:17:54.037Z] 
09:17:54 [2019-11-26T09:17:54.037Z] DONE 8 tests in 16.569s
09:17:54 [2019-11-26T09:17:54.037Z] Running /go/src/github.com/docker/docker/integration/plugin (ppc64le.integration.plugin) flags=-test.v -test.timeout=120m 
09:17:54 [2019-11-26T09:17:54.037Z] ++ 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
09:17:54 [2019-11-26T09:17:54.037Z] ++ set -e
09:17:54 [2019-11-26T09:17:54.037Z] ++ '[' -n 0 ']'
09:17:54 [2019-11-26T09:17:54.037Z] ++ set -x
09:17:54 [2019-11-26T09:17:54.037Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=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
09:17:54 [2019-11-26T09:17:54.037Z] testing: warning: no tests to run
09:17:54 [2019-11-26T09:17:54.037Z] PASS
09:17:54 [2019-11-26T09:17:54.037Z] 
09:17:54 [2019-11-26T09:17:54.037Z] DONE 0 tests in 0.015s
09:17:54 [2019-11-26T09:17:54.037Z] Running /go/src/github.com/docker/docker/integration/plugin/authz (ppc64le.integration.plugin.authz) flags=-test.v -test.timeout=120m 
09:17:54 [2019-11-26T09:17:54.037Z] ++ 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
09:17:54 [2019-11-26T09:17:54.037Z] ++ set -e
09:17:54 [2019-11-26T09:17:54.037Z] ++ '[' -n 0 ']'
09:17:54 [2019-11-26T09:17:54.037Z] ++ set -x
09:17:54 [2019-11-26T09:17:54.037Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=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
09:17:54 [2019-11-26T09:17:54.037Z] INFO: Testing against a local daemon
09:17:54 [2019-11-26T09:17:54.037Z] === RUN   TestAuthZPluginAllowRequest
09:17:55 [2019-11-26T09:17:55.728Z] --- PASS: TestAuthZPluginAllowRequest (1.63s)
09:17:55 [2019-11-26T09:17:55.728Z] === RUN   TestAuthZPluginTLS
09:17:56 [2019-11-26T09:17:56.065Z] --- PASS: TestAuthZPluginTLS (0.59s)
09:17:56 [2019-11-26T09:17:56.065Z] === RUN   TestAuthZPluginDenyRequest
09:17:56 [2019-11-26T09:17:56.789Z] --- PASS: TestAuthZPluginDenyRequest (0.56s)
09:17:56 [2019-11-26T09:17:56.789Z] === RUN   TestAuthZPluginAPIDenyResponse
09:17:57 [2019-11-26T09:17:57.126Z] --- PASS: TestAuthZPluginAPIDenyResponse (0.58s)
09:17:57 [2019-11-26T09:17:57.126Z] === RUN   TestAuthZPluginDenyResponse
09:17:57 [2019-11-26T09:17:57.879Z] --- PASS: TestAuthZPluginDenyResponse (0.59s)
09:17:57 [2019-11-26T09:17:57.880Z] === RUN   TestAuthZPluginAllowEventStream
09:17:59 [2019-11-26T09:17:59.572Z] --- PASS: TestAuthZPluginAllowEventStream (1.60s)
09:17:59 [2019-11-26T09:17:59.572Z] === RUN   TestAuthZPluginErrorResponse
09:18:00 [2019-11-26T09:18:00.303Z] --- PASS: TestAuthZPluginErrorResponse (0.65s)
09:18:00 [2019-11-26T09:18:00.303Z] === RUN   TestAuthZPluginErrorRequest
09:18:00 [2019-11-26T09:18:00.642Z] --- PASS: TestAuthZPluginErrorRequest (0.57s)
09:18:00 [2019-11-26T09:18:00.642Z] === RUN   TestAuthZPluginEnsureNoDuplicatePluginRegistration
09:18:01 [2019-11-26T09:18:01.366Z] --- PASS: TestAuthZPluginEnsureNoDuplicatePluginRegistration (0.58s)
09:18:01 [2019-11-26T09:18:01.366Z] === RUN   TestAuthZPluginEnsureLoadImportWorking
09:18:03 [2019-11-26T09:18:03.665Z] --- PASS: TestAuthZPluginEnsureLoadImportWorking (2.14s)
09:18:03 [2019-11-26T09:18:03.665Z] === RUN   TestAuthzPluginEnsureContainerCopyToFrom
09:18:05 [2019-11-26T09:18:05.354Z] --- PASS: TestAuthzPluginEnsureContainerCopyToFrom (2.08s)
09:18:05 [2019-11-26T09:18:05.355Z] === RUN   TestAuthZPluginHeader
09:18:06 [2019-11-26T09:18:06.611Z] --- PASS: TestAuthZPluginHeader (0.95s)
09:18:06 [2019-11-26T09:18:06.611Z] === RUN   TestAuthZPluginV2AllowNonVolumeRequest
09:18:06 [2019-11-26T09:18:06.611Z] --- SKIP: TestAuthZPluginV2AllowNonVolumeRequest (0.00s)
09:18:06 [2019-11-26T09:18:06.611Z]     authz_plugin_v2_test.go:43: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
09:18:06 [2019-11-26T09:18:06.611Z] === RUN   TestAuthZPluginV2Disable
09:18:06 [2019-11-26T09:18:06.611Z] --- SKIP: TestAuthZPluginV2Disable (0.00s)
09:18:06 [2019-11-26T09:18:06.611Z]     authz_plugin_v2_test.go:65: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
09:18:06 [2019-11-26T09:18:06.611Z] === RUN   TestAuthZPluginV2RejectVolumeRequests
09:18:06 [2019-11-26T09:18:06.611Z] --- SKIP: TestAuthZPluginV2RejectVolumeRequests (0.00s)
09:18:06 [2019-11-26T09:18:06.611Z]     authz_plugin_v2_test.go:91: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
09:18:06 [2019-11-26T09:18:06.611Z] === RUN   TestAuthZPluginV2BadManifestFailsDaemonStart
09:18:06 [2019-11-26T09:18:06.611Z] --- SKIP: TestAuthZPluginV2BadManifestFailsDaemonStart (0.00s)
09:18:06 [2019-11-26T09:18:06.611Z]     authz_plugin_v2_test.go:126: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
09:18:06 [2019-11-26T09:18:06.611Z] === RUN   TestAuthZPluginV2NonexistentFailsDaemonStart
09:18:25 [2019-11-26T09:18:25.851Z] --- PASS: TestAuthZPluginV2NonexistentFailsDaemonStart (16.87s)
09:18:25 [2019-11-26T09:18:25.851Z] PASS
09:18:25 [2019-11-26T09:18:25.851Z] 
09:18:25 [2019-11-26T09:18:25.851Z] === Skipped
09:18:25 [2019-11-26T09:18:25.851Z] === SKIP: ppc64le.integration.plugin.authz TestAuthZPluginV2AllowNonVolumeRequest (0.00s)
09:18:25 [2019-11-26T09:18:25.851Z]     authz_plugin_v2_test.go:43: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
09:18:25 [2019-11-26T09:18:25.851Z] 
09:18:25 [2019-11-26T09:18:25.851Z] === SKIP: ppc64le.integration.plugin.authz TestAuthZPluginV2Disable (0.00s)
09:18:25 [2019-11-26T09:18:25.851Z]     authz_plugin_v2_test.go:65: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
09:18:25 [2019-11-26T09:18:25.851Z] 
09:18:25 [2019-11-26T09:18:25.851Z] === SKIP: ppc64le.integration.plugin.authz TestAuthZPluginV2RejectVolumeRequests (0.00s)
09:18:25 [2019-11-26T09:18:25.851Z]     authz_plugin_v2_test.go:91: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
09:18:25 [2019-11-26T09:18:25.851Z] 
09:18:25 [2019-11-26T09:18:25.851Z] === SKIP: ppc64le.integration.plugin.authz TestAuthZPluginV2BadManifestFailsDaemonStart (0.00s)
09:18:25 [2019-11-26T09:18:25.851Z]     authz_plugin_v2_test.go:126: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
09:18:25 [2019-11-26T09:18:25.851Z] 
09:18:25 [2019-11-26T09:18:25.851Z] 
09:18:25 [2019-11-26T09:18:25.851Z] DONE 17 tests, 4 skipped in 29.488s
09:18:25 [2019-11-26T09:18:25.851Z] Running /go/src/github.com/docker/docker/integration/plugin/common (ppc64le.integration.plugin.common) flags=-test.v -test.timeout=120m 
09:18:25 [2019-11-26T09:18:25.851Z] ++ 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
09:18:25 [2019-11-26T09:18:25.851Z] ++ set -e
09:18:25 [2019-11-26T09:18:25.851Z] ++ '[' -n 0 ']'
09:18:25 [2019-11-26T09:18:25.851Z] ++ set -x
09:18:25 [2019-11-26T09:18:25.851Z] ++ 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
09:18:25 [2019-11-26T09:18:25.851Z] INFO: Testing against a local daemon
09:18:25 [2019-11-26T09:18:25.851Z] === RUN   TestPluginInvalidJSON
09:18:25 [2019-11-26T09:18:25.851Z] === RUN   TestPluginInvalidJSON//plugins/foobar/set
09:18:25 [2019-11-26T09:18:25.851Z] === PAUSE TestPluginInvalidJSON//plugins/foobar/set
09:18:25 [2019-11-26T09:18:25.851Z] === CONT  TestPluginInvalidJSON//plugins/foobar/set
09:18:25 [2019-11-26T09:18:25.851Z] --- PASS: TestPluginInvalidJSON (0.04s)
09:18:25 [2019-11-26T09:18:25.851Z]     --- PASS: TestPluginInvalidJSON//plugins/foobar/set (0.00s)
09:18:25 [2019-11-26T09:18:25.851Z] PASS
09:18:25 [2019-11-26T09:18:25.851Z] 
09:18:25 [2019-11-26T09:18:25.851Z] DONE 2 tests in 0.122s
09:18:25 [2019-11-26T09:18:25.851Z] Running /go/src/github.com/docker/docker/integration/plugin/graphdriver (ppc64le.integration.plugin.graphdriver) flags=-test.v -test.timeout=120m 
09:18:25 [2019-11-26T09:18:25.851Z] ++ 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
09:18:25 [2019-11-26T09:18:25.851Z] ++ set -e
09:18:25 [2019-11-26T09:18:25.851Z] ++ '[' -n 0 ']'
09:18:25 [2019-11-26T09:18:25.851Z] ++ set -x
09:18:25 [2019-11-26T09:18:25.851Z] ++ 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
09:18:25 [2019-11-26T09:18:25.851Z] INFO: Testing against a local daemon
09:18:25 [2019-11-26T09:18:25.851Z] === RUN   TestExternalGraphDriver
09:18:25 [2019-11-26T09:18:25.851Z] === RUN   TestExternalGraphDriver/json
09:18:25 [2019-11-26T09:18:25.851Z] === RUN   TestExternalGraphDriver/spec
09:18:28 [2019-11-26T09:18:28.145Z] === RUN   TestExternalGraphDriver/pull
09:18:30 [2019-11-26T09:18:30.440Z] --- PASS: TestExternalGraphDriver (6.77s)
09:18:30 [2019-11-26T09:18:30.440Z]     --- PASS: TestExternalGraphDriver/json (2.02s)
09:18:30 [2019-11-26T09:18:30.440Z]     --- PASS: TestExternalGraphDriver/spec (2.02s)
09:18:30 [2019-11-26T09:18:30.440Z]     --- PASS: TestExternalGraphDriver/pull (2.52s)
09:18:30 [2019-11-26T09:18:30.440Z] === RUN   TestGraphdriverPluginV2
09:18:30 [2019-11-26T09:18:30.440Z] --- SKIP: TestGraphdriverPluginV2 (0.07s)
09:18:30 [2019-11-26T09:18:30.440Z]     external_test.go:410: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
09:18:30 [2019-11-26T09:18:30.440Z] PASS
09:18:30 [2019-11-26T09:18:30.440Z] 
09:18:30 [2019-11-26T09:18:30.440Z] === Skipped
09:18:30 [2019-11-26T09:18:30.440Z] === SKIP: ppc64le.integration.plugin.graphdriver TestGraphdriverPluginV2 (0.07s)
09:18:30 [2019-11-26T09:18:30.440Z]     external_test.go:410: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
09:18:30 [2019-11-26T09:18:30.440Z] 
09:18:30 [2019-11-26T09:18:30.440Z] 
09:18:30 [2019-11-26T09:18:30.440Z] DONE 5 tests, 1 skipped in 6.928s
09:18:30 [2019-11-26T09:18:30.440Z] Running /go/src/github.com/docker/docker/integration/plugin/logging (ppc64le.integration.plugin.logging) flags=-test.v -test.timeout=120m 
09:18:30 [2019-11-26T09:18:30.440Z] ++ 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
09:18:30 [2019-11-26T09:18:30.440Z] ++ set -e
09:18:30 [2019-11-26T09:18:30.440Z] ++ '[' -n 0 ']'
09:18:30 [2019-11-26T09:18:30.440Z] ++ set -x
09:18:30 [2019-11-26T09:18:30.440Z] ++ 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
09:18:30 [2019-11-26T09:18:30.440Z] INFO: Testing against a local daemon
09:18:30 [2019-11-26T09:18:30.440Z] === RUN   TestContinueAfterPluginCrash
09:18:30 [2019-11-26T09:18:30.440Z] === PAUSE TestContinueAfterPluginCrash
09:18:30 [2019-11-26T09:18:30.440Z] === RUN   TestDaemonStartWithLogOpt
09:18:30 [2019-11-26T09:18:30.440Z] === PAUSE TestDaemonStartWithLogOpt
09:18:30 [2019-11-26T09:18:30.440Z] === CONT  TestContinueAfterPluginCrash
09:18:30 [2019-11-26T09:18:30.440Z] === CONT  TestDaemonStartWithLogOpt
09:18:46 [2019-11-26T09:18:46.452Z] --- PASS: TestDaemonStartWithLogOpt (15.67s)
09:18:51 [2019-11-26T09:18:51.276Z] --- PASS: TestContinueAfterPluginCrash (20.42s)
09:18:51 [2019-11-26T09:18:51.276Z] PASS
09:18:51 [2019-11-26T09:18:51.276Z] 
09:18:51 [2019-11-26T09:18:51.276Z] DONE 2 tests in 20.513s
09:18:51 [2019-11-26T09:18:51.276Z] Running /go/src/github.com/docker/docker/integration/plugin/volumes (ppc64le.integration.plugin.volumes) flags=-test.v -test.timeout=120m 
09:18:51 [2019-11-26T09:18:51.276Z] ++ 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
09:18:51 [2019-11-26T09:18:51.276Z] ++ set -e
09:18:51 [2019-11-26T09:18:51.276Z] ++ '[' -n 0 ']'
09:18:51 [2019-11-26T09:18:51.276Z] ++ set -x
09:18:51 [2019-11-26T09:18:51.276Z] ++ 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
09:18:51 [2019-11-26T09:18:51.276Z] INFO: Testing against a local daemon
09:18:51 [2019-11-26T09:18:51.276Z] === RUN   TestPluginWithDevMounts
09:18:51 [2019-11-26T09:18:51.276Z] === PAUSE TestPluginWithDevMounts
09:18:51 [2019-11-26T09:18:51.276Z] === CONT  TestPluginWithDevMounts
09:18:53 [2019-11-26T09:18:53.565Z] --- PASS: TestPluginWithDevMounts (2.25s)
09:18:53 [2019-11-26T09:18:53.565Z] PASS
09:18:53 [2019-11-26T09:18:53.565Z] 
09:18:53 [2019-11-26T09:18:53.565Z] DONE 1 tests in 2.347s
09:18:53 [2019-11-26T09:18:53.565Z] Running /go/src/github.com/docker/docker/integration/secret (ppc64le.integration.secret) flags=-test.v -test.timeout=120m 
09:18:53 [2019-11-26T09:18:53.565Z] ++ 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
09:18:53 [2019-11-26T09:18:53.565Z] ++ set -e
09:18:53 [2019-11-26T09:18:53.565Z] ++ '[' -n 0 ']'
09:18:53 [2019-11-26T09:18:53.565Z] ++ set -x
09:18:53 [2019-11-26T09:18:53.566Z] ++ 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
09:18:53 [2019-11-26T09:18:53.566Z] INFO: Testing against a local daemon
09:18:53 [2019-11-26T09:18:53.566Z] === RUN   TestSecretInspect
09:18:55 [2019-11-26T09:18:55.858Z] --- PASS: TestSecretInspect (2.15s)
09:18:55 [2019-11-26T09:18:55.858Z] === RUN   TestSecretList
09:18:58 [2019-11-26T09:18:58.202Z] --- PASS: TestSecretList (2.23s)
09:18:58 [2019-11-26T09:18:58.202Z] === RUN   TestSecretsCreateAndDelete
09:18:59 [2019-11-26T09:18:59.893Z] --- PASS: TestSecretsCreateAndDelete (2.25s)
09:18:59 [2019-11-26T09:18:59.893Z] === RUN   TestSecretsUpdate
09:19:02 [2019-11-26T09:19:02.188Z] --- PASS: TestSecretsUpdate (2.22s)
09:19:02 [2019-11-26T09:19:02.188Z] === RUN   TestTemplatedSecret
09:19:05 [2019-11-26T09:19:05.191Z] --- PASS: TestTemplatedSecret (2.85s)
09:19:05 [2019-11-26T09:19:05.191Z] === RUN   TestSecretCreateResolve
09:19:07 [2019-11-26T09:19:07.493Z] --- PASS: TestSecretCreateResolve (2.23s)
09:19:07 [2019-11-26T09:19:07.493Z] PASS
09:19:07 [2019-11-26T09:19:07.493Z] 
09:19:07 [2019-11-26T09:19:07.493Z] DONE 6 tests in 14.007s
09:19:07 [2019-11-26T09:19:07.493Z] Running /go/src/github.com/docker/docker/integration/service (ppc64le.integration.service) flags=-test.v -test.timeout=120m 
09:19:07 [2019-11-26T09:19:07.493Z] ++ 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
09:19:07 [2019-11-26T09:19:07.493Z] ++ set -e
09:19:07 [2019-11-26T09:19:07.493Z] ++ '[' -n 0 ']'
09:19:07 [2019-11-26T09:19:07.493Z] ++ set -x
09:19:07 [2019-11-26T09:19:07.493Z] ++ 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
09:19:07 [2019-11-26T09:19:07.493Z] INFO: Testing against a local daemon
09:19:07 [2019-11-26T09:19:07.493Z] === RUN   TestServiceCreateInit
09:19:07 [2019-11-26T09:19:07.493Z] === RUN   TestServiceCreateInit/daemonInitDisabled
09:19:12 [2019-11-26T09:19:12.341Z] === RUN   TestServiceCreateInit/daemonInitEnabled
09:19:16 [2019-11-26T09:19:16.172Z] --- PASS: TestServiceCreateInit (8.51s)
09:19:16 [2019-11-26T09:19:16.172Z]     --- PASS: TestServiceCreateInit/daemonInitDisabled (4.17s)
09:19:16 [2019-11-26T09:19:16.172Z]     --- PASS: TestServiceCreateInit/daemonInitEnabled (4.29s)
09:19:16 [2019-11-26T09:19:16.172Z] === RUN   TestCreateServiceMultipleTimes
09:19:35 [2019-11-26T09:19:35.496Z] --- PASS: TestCreateServiceMultipleTimes (18.53s)
09:19:35 [2019-11-26T09:19:35.496Z] === RUN   TestCreateServiceConflict
09:19:36 [2019-11-26T09:19:36.667Z] --- PASS: TestCreateServiceConflict (2.18s)
09:19:36 [2019-11-26T09:19:36.667Z] === RUN   TestCreateServiceMaxReplicas
09:19:39 [2019-11-26T09:19:39.741Z] --- PASS: TestCreateServiceMaxReplicas (3.04s)
09:19:39 [2019-11-26T09:19:39.741Z] === RUN   TestCreateWithDuplicateNetworkNames
09:19:52 [2019-11-26T09:19:52.965Z] --- PASS: TestCreateWithDuplicateNetworkNames (13.27s)
09:19:52 [2019-11-26T09:19:52.965Z] === RUN   TestCreateServiceSecretFileMode
09:19:55 [2019-11-26T09:19:55.974Z] --- PASS: TestCreateServiceSecretFileMode (2.48s)
09:19:55 [2019-11-26T09:19:55.974Z] === RUN   TestCreateServiceConfigFileMode
09:19:58 [2019-11-26T09:19:58.298Z] --- PASS: TestCreateServiceConfigFileMode (2.50s)
09:19:58 [2019-11-26T09:19:58.298Z] === RUN   TestCreateServiceSysctls
09:20:01 [2019-11-26T09:20:01.305Z] --- PASS: TestCreateServiceSysctls (3.40s)
09:20:01 [2019-11-26T09:20:01.305Z] === RUN   TestCreateServiceCapabilities
09:20:04 [2019-11-26T09:20:04.310Z] --- PASS: TestCreateServiceCapabilities (2.61s)
09:20:04 [2019-11-26T09:20:04.310Z] === RUN   TestInspect
09:20:07 [2019-11-26T09:20:07.322Z] --- PASS: TestInspect (2.95s)
09:20:07 [2019-11-26T09:20:07.322Z] === RUN   TestServiceListWithStatuses
09:20:07 [2019-11-26T09:20:07.322Z] --- SKIP: TestServiceListWithStatuses (0.00s)
09:20:07 [2019-11-26T09:20:07.322Z]     list_test.go:34: versions.LessThan(testEnv.DaemonInfo.ServerVersion, "1.41")
09:20:07 [2019-11-26T09:20:07.322Z] === RUN   TestDockerNetworkConnectAlias
09:20:12 [2019-11-26T09:20:12.143Z] --- PASS: TestDockerNetworkConnectAlias (4.60s)
09:20:12 [2019-11-26T09:20:12.143Z] === RUN   TestDockerNetworkReConnect
09:20:15 [2019-11-26T09:20:15.987Z] --- PASS: TestDockerNetworkReConnect (4.55s)
09:20:15 [2019-11-26T09:20:15.987Z] === RUN   TestServicePlugin
09:20:15 [2019-11-26T09:20:15.987Z] --- SKIP: TestServicePlugin (0.00s)
09:20:15 [2019-11-26T09:20:15.987Z]     plugin_test.go:28: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
09:20:15 [2019-11-26T09:20:15.987Z] === RUN   TestServiceUpdateLabel
09:20:18 [2019-11-26T09:20:18.341Z] --- PASS: TestServiceUpdateLabel (2.29s)
09:20:18 [2019-11-26T09:20:18.341Z] === RUN   TestServiceUpdateSecrets
09:20:34 [2019-11-26T09:20:34.310Z] --- PASS: TestServiceUpdateSecrets (14.65s)
09:20:34 [2019-11-26T09:20:34.310Z] === RUN   TestServiceUpdateConfigs
09:20:50 [2019-11-26T09:20:50.330Z] --- PASS: TestServiceUpdateConfigs (14.81s)
09:20:50 [2019-11-26T09:20:50.330Z] === RUN   TestServiceUpdateNetwork
09:21:01 [2019-11-26T09:21:01.254Z] --- PASS: TestServiceUpdateNetwork (13.05s)
09:21:01 [2019-11-26T09:21:01.254Z] PASS
09:21:01 [2019-11-26T09:21:01.254Z] 
09:21:01 [2019-11-26T09:21:01.254Z] === Skipped
09:21:01 [2019-11-26T09:21:01.254Z] === SKIP: ppc64le.integration.service TestServiceListWithStatuses (0.00s)
09:21:01 [2019-11-26T09:21:01.254Z]     list_test.go:34: versions.LessThan(testEnv.DaemonInfo.ServerVersion, "1.41")
09:21:01 [2019-11-26T09:21:01.254Z] 
09:21:01 [2019-11-26T09:21:01.254Z] === SKIP: ppc64le.integration.service TestServicePlugin (0.00s)
09:21:01 [2019-11-26T09:21:01.254Z]     plugin_test.go:28: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
09:21:01 [2019-11-26T09:21:01.254Z] 
09:21:01 [2019-11-26T09:21:01.254Z] 
09:21:01 [2019-11-26T09:21:01.254Z] DONE 20 tests, 2 skipped in 113.507s
09:21:01 [2019-11-26T09:21:01.254Z] Running /go/src/github.com/docker/docker/integration/session (ppc64le.integration.session) flags=-test.v -test.timeout=120m 
09:21:01 [2019-11-26T09:21:01.254Z] ++ 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
09:21:01 [2019-11-26T09:21:01.254Z] ++ set -e
09:21:01 [2019-11-26T09:21:01.254Z] ++ '[' -n 0 ']'
09:21:01 [2019-11-26T09:21:01.254Z] ++ set -x
09:21:01 [2019-11-26T09:21:01.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-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
09:21:01 [2019-11-26T09:21:01.254Z] INFO: Testing against a local daemon
09:21:01 [2019-11-26T09:21:01.254Z] === RUN   TestSessionCreate
09:21:01 [2019-11-26T09:21:01.254Z] --- PASS: TestSessionCreate (0.05s)
09:21:01 [2019-11-26T09:21:01.254Z] === RUN   TestSessionCreateWithBadUpgrade
09:21:01 [2019-11-26T09:21:01.254Z] --- PASS: TestSessionCreateWithBadUpgrade (0.05s)
09:21:01 [2019-11-26T09:21:01.254Z] PASS
09:21:01 [2019-11-26T09:21:01.254Z] 
09:21:01 [2019-11-26T09:21:01.254Z] DONE 2 tests in 0.199s
09:21:01 [2019-11-26T09:21:01.254Z] Running /go/src/github.com/docker/docker/integration/system (ppc64le.integration.system) flags=-test.v -test.timeout=120m 
09:21:01 [2019-11-26T09:21:01.254Z] ++ 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
09:21:01 [2019-11-26T09:21:01.254Z] ++ set -e
09:21:01 [2019-11-26T09:21:01.254Z] ++ '[' -n 0 ']'
09:21:01 [2019-11-26T09:21:01.254Z] ++ set -x
09:21:01 [2019-11-26T09:21:01.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-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
09:21:01 [2019-11-26T09:21:01.254Z] INFO: Testing against a local daemon
09:21:01 [2019-11-26T09:21:01.255Z] === RUN   TestCgroupDriverSystemdMemoryLimit
09:21:01 [2019-11-26T09:21:01.255Z] --- SKIP: TestCgroupDriverSystemdMemoryLimit (0.00s)
09:21:01 [2019-11-26T09:21:01.255Z]     cgroupdriver_systemd_test.go:32: !hasSystemd()
09:21:01 [2019-11-26T09:21:01.255Z] === RUN   TestEventsExecDie
09:21:01 [2019-11-26T09:21:01.978Z] --- PASS: TestEventsExecDie (0.88s)
09:21:01 [2019-11-26T09:21:01.978Z] === RUN   TestEventsBackwardsCompatible
09:21:02 [2019-11-26T09:21:02.316Z] --- PASS: TestEventsBackwardsCompatible (0.10s)
09:21:02 [2019-11-26T09:21:02.316Z] === RUN   TestInfoBinaryCommits
09:21:02 [2019-11-26T09:21:02.316Z] --- PASS: TestInfoBinaryCommits (0.05s)
09:21:02 [2019-11-26T09:21:02.316Z] === RUN   TestInfoAPIVersioned
09:21:02 [2019-11-26T09:21:02.316Z] --- PASS: TestInfoAPIVersioned (0.01s)
09:21:02 [2019-11-26T09:21:02.316Z] === RUN   TestInfoDiscoveryBackend
09:21:02 [2019-11-26T09:21:02.654Z] --- PASS: TestInfoDiscoveryBackend (0.54s)
09:21:02 [2019-11-26T09:21:02.654Z] === RUN   TestInfoDiscoveryInvalidAdvertise
09:21:03 [2019-11-26T09:21:03.821Z] --- PASS: TestInfoDiscoveryInvalidAdvertise (1.00s)
09:21:03 [2019-11-26T09:21:03.821Z] === RUN   TestInfoDiscoveryAdvertiseInterfaceName
09:21:04 [2019-11-26T09:21:04.546Z] --- PASS: TestInfoDiscoveryAdvertiseInterfaceName (0.54s)
09:21:04 [2019-11-26T09:21:04.546Z] === RUN   TestInfoAPI
09:21:04 [2019-11-26T09:21:04.546Z] --- PASS: TestInfoAPI (0.07s)
09:21:04 [2019-11-26T09:21:04.546Z] === RUN   TestInfoAPIWarnings
09:21:04 [2019-11-26T09:21:04.883Z] --- PASS: TestInfoAPIWarnings (0.55s)
09:21:04 [2019-11-26T09:21:04.883Z] === RUN   TestInfoDebug
09:21:05 [2019-11-26T09:21:05.606Z] --- PASS: TestInfoDebug (0.54s)
09:21:05 [2019-11-26T09:21:05.606Z] === RUN   TestInfoInsecureRegistries
09:21:05 [2019-11-26T09:21:05.944Z] --- PASS: TestInfoInsecureRegistries (0.54s)
09:21:05 [2019-11-26T09:21:05.944Z] === RUN   TestInfoRegistryMirrors
09:21:06 [2019-11-26T09:21:06.666Z] --- PASS: TestInfoRegistryMirrors (0.54s)
09:21:06 [2019-11-26T09:21:06.666Z] === RUN   TestLoginFailsWithBadCredentials
09:21:07 [2019-11-26T09:21:07.388Z] --- PASS: TestLoginFailsWithBadCredentials (0.66s)
09:21:07 [2019-11-26T09:21:07.388Z] === RUN   TestPingCacheHeaders
09:21:07 [2019-11-26T09:21:07.388Z] --- PASS: TestPingCacheHeaders (0.05s)
09:21:07 [2019-11-26T09:21:07.388Z] === RUN   TestPingGet
09:21:07 [2019-11-26T09:21:07.388Z] --- PASS: TestPingGet (0.03s)
09:21:07 [2019-11-26T09:21:07.388Z] === RUN   TestPingHead
09:21:07 [2019-11-26T09:21:07.388Z] --- PASS: TestPingHead (0.06s)
09:21:07 [2019-11-26T09:21:07.388Z] === RUN   TestVersion
09:21:07 [2019-11-26T09:21:07.388Z] --- PASS: TestVersion (0.05s)
09:21:07 [2019-11-26T09:21:07.388Z] PASS
09:21:07 [2019-11-26T09:21:07.388Z] 
09:21:07 [2019-11-26T09:21:07.388Z] === Skipped
09:21:07 [2019-11-26T09:21:07.388Z] === SKIP: ppc64le.integration.system TestCgroupDriverSystemdMemoryLimit (0.00s)
09:21:07 [2019-11-26T09:21:07.388Z]     cgroupdriver_systemd_test.go:32: !hasSystemd()
09:21:07 [2019-11-26T09:21:07.388Z] 
09:21:07 [2019-11-26T09:21:07.388Z] 
09:21:07 [2019-11-26T09:21:07.388Z] DONE 18 tests, 1 skipped in 6.289s
09:21:07 [2019-11-26T09:21:07.388Z] Running /go/src/github.com/docker/docker/integration/volume (ppc64le.integration.volume) flags=-test.v -test.timeout=120m 
09:21:07 [2019-11-26T09:21:07.388Z] ++ 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
09:21:07 [2019-11-26T09:21:07.388Z] ++ set -e
09:21:07 [2019-11-26T09:21:07.388Z] ++ '[' -n 0 ']'
09:21:07 [2019-11-26T09:21:07.388Z] ++ set -x
09:21:07 [2019-11-26T09:21:07.388Z] ++ 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
09:21:07 [2019-11-26T09:21:07.388Z] INFO: Testing against a local daemon
09:21:07 [2019-11-26T09:21:07.388Z] === RUN   TestVolumesCreateAndList
09:21:07 [2019-11-26T09:21:07.724Z] --- PASS: TestVolumesCreateAndList (0.04s)
09:21:07 [2019-11-26T09:21:07.724Z] === RUN   TestVolumesRemove
09:21:07 [2019-11-26T09:21:07.724Z] --- PASS: TestVolumesRemove (0.09s)
09:21:07 [2019-11-26T09:21:07.724Z] === RUN   TestVolumesInspect
09:21:07 [2019-11-26T09:21:07.724Z] --- PASS: TestVolumesInspect (0.05s)
09:21:07 [2019-11-26T09:21:07.724Z] === RUN   TestVolumesInvalidJSON
09:21:07 [2019-11-26T09:21:07.724Z] === RUN   TestVolumesInvalidJSON//volumes/create
09:21:07 [2019-11-26T09:21:07.724Z] === PAUSE TestVolumesInvalidJSON//volumes/create
09:21:07 [2019-11-26T09:21:07.724Z] === CONT  TestVolumesInvalidJSON//volumes/create
09:21:07 [2019-11-26T09:21:07.724Z] --- PASS: TestVolumesInvalidJSON (0.03s)
09:21:07 [2019-11-26T09:21:07.724Z]     --- PASS: TestVolumesInvalidJSON//volumes/create (0.00s)
09:21:07 [2019-11-26T09:21:07.724Z] PASS
09:21:07 [2019-11-26T09:21:07.724Z] 
09:21:07 [2019-11-26T09:21:07.724Z] DONE 5 tests in 0.303s
09:21:07 [2019-11-26T09:21:07.724Z] ---> Making bundle: .integration-daemon-stop (in bundles/test-integration)
09:21:08 [2019-11-26T09:21:08.087Z] ++++ cat bundles/test-integration/docker.pid
09:21:08 [2019-11-26T09:21:08.087Z] +++ kill 13121
09:21:09 [2019-11-26T09:21:09.282Z] +++ /etc/init.d/apparmor stop
09:21:09 [2019-11-26T09:21:09.282Z] Clearing AppArmor profiles cache:.
09:21:09 [2019-11-26T09:21:09.618Z] All profile caches have been cleared, but no profiles have been unloaded.
09:21:09 [2019-11-26T09:21:09.618Z] Unloading profiles will leave already running processes permanently
09:21:09 [2019-11-26T09:21:09.618Z] unconfined, which can lead to unexpected situations.
09:21:09 [2019-11-26T09:21:09.618Z] 
09:21:09 [2019-11-26T09:21:09.618Z] To set a process to complain mode, use the command line tool
09:21:09 [2019-11-26T09:21:09.618Z] 'aa-complain'. To really tear down all profiles, run the init script
09:21:09 [2019-11-26T09:21:09.618Z] with the 'teardown' option."
09:21:09 [2019-11-26T09:21:09.618Z]