Console Output

22:18:46 [2019-12-30T22:18:46.616Z] + docker run --rm -t --privileged -v /home/docker/workspace/moby_PR-40331/bundles:/go/src/github.com/docker/docker/bundles --name docker-pr1 -e DOCKER_EXPERIMENTAL -e DOCKER_GITCOMMIT=9177ac322afe2371376591094116be59f3fef054 -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:9177ac322afe2371376591094116be59f3fef054 hack/make.sh dynbinary test-integration
22:18:46 [2019-12-30T22:18:46.903Z] 
22:18:47 [2019-12-30T22:18:47.195Z] Removing bundles/
22:18:47 [2019-12-30T22:18:47.195Z] 
22:18:47 [2019-12-30T22:18:47.195Z] ---> Making bundle: dynbinary (in bundles/dynbinary)
22:18:47 [2019-12-30T22:18:47.195Z] Building: bundles/dynbinary-daemon/dockerd-dev
22:18:47 [2019-12-30T22:18:47.195Z] GOOS="" GOARCH="" GOARM=""
22:20:54 [2019-12-30T22:20:54.437Z] Created binary: bundles/dynbinary-daemon/dockerd-dev
22:20:54 [2019-12-30T22:20:54.437Z] 
22:20:54 [2019-12-30T22:20:54.437Z] ---> Making bundle: test-integration (in bundles/test-integration)
22:20:54 [2019-12-30T22:20:54.437Z] PKG_CONFIG=pkg-config
22:20:54 [2019-12-30T22:20:54.437Z] GOLANG_VERSION=1.13.4
22:20:54 [2019-12-30T22:20:54.437Z] HOSTNAME=01684817e4f6
22:20:54 [2019-12-30T22:20:54.437Z] DOCKER_EXPERIMENTAL=1
22:20:54 [2019-12-30T22:20:54.437Z] container=docker
22:20:54 [2019-12-30T22:20:54.437Z] TEST_SKIP_INTEGRATION_CLI=1
22:20:54 [2019-12-30T22:20:54.437Z] GO111MODULE=off
22:20:54 [2019-12-30T22:20:54.437Z] GOPATH=/go
22:20:54 [2019-12-30T22:20:54.437Z] PWD=/go/src/github.com/docker/docker
22:20:54 [2019-12-30T22:20:54.437Z] HOME=/root
22:20:54 [2019-12-30T22:20:54.437Z] VALIDATE_REPO=https://github.com/moby/moby.git
22:20:54 [2019-12-30T22:20:54.437Z] SCRIPTDIR=/go/src/github.com/docker/docker/hack
22:20:54 [2019-12-30T22:20:54.437Z] MAKEDIR=/go/src/github.com/docker/docker/hack/make
22:20:54 [2019-12-30T22:20:54.437Z] DOCKER_GITCOMMIT=9177ac322afe2371376591094116be59f3fef054
22:20:54 [2019-12-30T22:20:54.437Z] DOCKER_BUILDTAGS=apparmor seccomp selinux journald
22:20:54 [2019-12-30T22:20:54.437Z] DOCKER_GRAPHDRIVER=overlay2
22:20:54 [2019-12-30T22:20:54.437Z] TERM=xterm
22:20:54 [2019-12-30T22:20:54.437Z] VALIDATE_BRANCH=master
22:20:54 [2019-12-30T22:20:54.437Z] DEST=bundles/test-integration
22:20:54 [2019-12-30T22:20:54.437Z] SHLVL=1
22:20:54 [2019-12-30T22:20:54.437Z] TIMEOUT=120m
22:20:54 [2019-12-30T22:20:54.437Z] PATH=/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
22:20:54 [2019-12-30T22:20:54.437Z] DOCKER_PKG=github.com/docker/docker
22:20:54 [2019-12-30T22:20:54.437Z] TESTDEBUG=0
22:20:54 [2019-12-30T22:20:54.437Z] _=/usr/bin/env
22:20:54 [2019-12-30T22:20:54.437Z] Building test suite binary /go/src/github.com/docker/docker/integration/build/test.main
22:21:41 [2019-12-30T22:21:41.756Z] Building test suite binary /go/src/github.com/docker/docker/integration/config/test.main
22:21:45 [2019-12-30T22:21:45.242Z] Building test suite binary /go/src/github.com/docker/docker/integration/container/test.main
22:21:50 [2019-12-30T22:21:50.759Z] Building test suite binary /go/src/github.com/docker/docker/integration/image/test.main
22:22:30 [2019-12-30T22:22:30.042Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/test.main
22:22:30 [2019-12-30T22:22:30.664Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/ipvlan/test.main
22:22:34 [2019-12-30T22:22:34.139Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/macvlan/test.main
22:22:36 [2019-12-30T22:22:36.301Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/test.main
22:22:37 [2019-12-30T22:22:37.317Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/authz/test.main
22:22:41 [2019-12-30T22:22:41.758Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/common/test.main
22:22:44 [2019-12-30T22:22:44.473Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/graphdriver/test.main
22:22:49 [2019-12-30T22:22:49.983Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/logging/test.main
22:22:55 [2019-12-30T22:22:55.547Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/volumes/test.main
22:22:59 [2019-12-30T22:22:59.956Z] Building test suite binary /go/src/github.com/docker/docker/integration/secret/test.main
22:23:02 [2019-12-30T22:23:02.654Z] Building test suite binary /go/src/github.com/docker/docker/integration/service/test.main
22:23:08 [2019-12-30T22:23:08.184Z] Building test suite binary /go/src/github.com/docker/docker/integration/session/test.main
22:23:10 [2019-12-30T22:23:10.228Z] Building test suite binary /go/src/github.com/docker/docker/integration/system/test.main
22:23:12 [2019-12-30T22:23:12.929Z] Building test suite binary /go/src/github.com/docker/docker/integration/volume/test.main
22:23:15 [2019-12-30T22:23:15.627Z] ---> Making bundle: .integration-daemon-start (in bundles/test-integration)
22:23:15 [2019-12-30T22:23:15.627Z] Using test binary docker
22:23:15 [2019-12-30T22:23:15.627Z] # DOCKER_EXPERIMENTAL is set: starting daemon with experimental features enabled! 
22:23:15 [2019-12-30T22:23:15.627Z] +++ /etc/init.d/apparmor start
22:23:15 [2019-12-30T22:23:15.627Z] /etc/init.d/apparmor: 130: /etc/init.d/apparmor: systemd-detect-virt: not found
22:23:15 [2019-12-30T22:23:15.627Z] Starting AppArmor profiles:Warning from stdin (line 1): /sbin/apparmor_parser: cannot use or update cache, disable, or force-complain via stdin
22:23:15 [2019-12-30T22:23:15.627Z] Warning failed to create cache: (null)
22:23:15 [2019-12-30T22:23:15.627Z] .
22:23:15 [2019-12-30T22:23:15.915Z] INFO: Waiting for daemon to start...
22:23:15 [2019-12-30T22:23:15.915Z] Starting dockerd
22:23:15 [2019-12-30T22:23:15.915Z] +++ exec dockerd --debug --host unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock --storage-driver overlay2 --pidfile bundles/test-integration/docker.pid --userland-proxy=true --experimental
22:23:17 [2019-12-30T22:23:17.947Z] .
22:23:17 [2019-12-30T22:23:17.947Z] ---> Making bundle: .integration-daemon-setup (in bundles/test-integration)
22:23:17 [2019-12-30T22:23:17.947Z] ---> Making bundle: .ensure-emptyfs (in bundles/test-integration)
22:23:17 [2019-12-30T22:23:17.947Z] Error: No such image: emptyfs
22:23:17 [2019-12-30T22:23:17.947Z] ++++ tar -cC bundles/test-integration/emptyfs .
22:23:17 [2019-12-30T22:23:17.947Z] ++++ docker load
22:23:18 [2019-12-30T22:23:18.236Z] Running integration-test (iteration 1)
22:23:18 [2019-12-30T22:23:18.236Z] Running /go/src/github.com/docker/docker/integration/build (ppc64le.integration.build) flags=-test.v -test.timeout=120m 
22:23:18 [2019-12-30T22:23:18.236Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-build-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-build-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.build -t ./test.main -test.v -test.timeout=120m
22:23:18 [2019-12-30T22:23:18.236Z] ++ set -e
22:23:18 [2019-12-30T22:23:18.236Z] ++ '[' -n 0 ']'
22:23:18 [2019-12-30T22:23:18.236Z] ++ set -x
22:23:18 [2019-12-30T22:23:18.236Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=ppc64le DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-build-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-build-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.build -t ./test.main -test.v -test.timeout=120m
22:23:33 [2019-12-30T22:23:33.526Z] Loaded image: buildpack-deps:jessie
22:23:33 [2019-12-30T22:23:33.526Z] Loaded image: busybox:latest
22:23:33 [2019-12-30T22:23:33.526Z] Loaded image: busybox:glibc
22:23:33 [2019-12-30T22:23:33.526Z] Loaded image: debian:jessie
22:23:33 [2019-12-30T22:23:33.526Z] Loaded image: hello-world:latest
22:23:33 [2019-12-30T22:23:33.526Z] INFO: Testing against a local daemon
22:23:33 [2019-12-30T22:23:33.526Z] === RUN   TestCgroupNamespacesBuild
22:23:34 [2019-12-30T22:23:34.148Z] --- PASS: TestCgroupNamespacesBuild (1.61s)
22:23:34 [2019-12-30T22:23:34.148Z] === RUN   TestCgroupNamespacesBuildDaemonHostMode
22:23:35 [2019-12-30T22:23:35.652Z] --- PASS: TestCgroupNamespacesBuildDaemonHostMode (1.66s)
22:23:35 [2019-12-30T22:23:35.652Z] === RUN   TestBuildWithSession
22:23:35 [2019-12-30T22:23:35.652Z] --- SKIP: TestBuildWithSession (0.00s)
22:23:35 [2019-12-30T22:23:35.652Z]     build_session_test.go:25: TODO: BuildKit
22:23:35 [2019-12-30T22:23:35.652Z] === RUN   TestBuildSquashParent
22:23:42 [2019-12-30T22:23:42.497Z] --- PASS: TestBuildSquashParent (5.83s)
22:23:42 [2019-12-30T22:23:42.497Z] === RUN   TestBuildWithRemoveAndForceRemove
22:23:42 [2019-12-30T22:23:42.497Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
22:23:42 [2019-12-30T22:23:42.497Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
22:23:42 [2019-12-30T22:23:42.497Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_remove
22:23:42 [2019-12-30T22:23:42.497Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_remove
22:23:42 [2019-12-30T22:23:42.497Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
22:23:42 [2019-12-30T22:23:42.497Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
22:23:42 [2019-12-30T22:23:42.497Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
22:23:42 [2019-12-30T22:23:42.497Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
22:23:42 [2019-12-30T22:23:42.497Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_remove
22:23:42 [2019-12-30T22:23:42.497Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_remove
22:23:42 [2019-12-30T22:23:42.497Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
22:23:42 [2019-12-30T22:23:42.497Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
22:23:42 [2019-12-30T22:23:42.497Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
22:23:42 [2019-12-30T22:23:42.497Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
22:23:42 [2019-12-30T22:23:42.497Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
22:23:42 [2019-12-30T22:23:42.497Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
22:23:44 [2019-12-30T22:23:44.589Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_remove
22:23:44 [2019-12-30T22:23:44.589Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_remove
22:23:46 [2019-12-30T22:23:46.636Z] --- PASS: TestBuildWithRemoveAndForceRemove (0.03s)
22:23:46 [2019-12-30T22:23:46.636Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal (2.97s)
22:23:46 [2019-12-30T22:23:46.636Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal (3.05s)
22:23:46 [2019-12-30T22:23:46.636Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove (3.20s)
22:23:46 [2019-12-30T22:23:46.636Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove (3.25s)
22:23:46 [2019-12-30T22:23:46.636Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_remove (2.06s)
22:23:46 [2019-12-30T22:23:46.636Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_remove (2.23s)
22:23:46 [2019-12-30T22:23:46.636Z] === RUN   TestBuildMultiStageCopy
22:23:46 [2019-12-30T22:23:46.636Z] === RUN   TestBuildMultiStageCopy/copy_to_root
22:23:48 [2019-12-30T22:23:48.675Z] === RUN   TestBuildMultiStageCopy/copy_to_newdir
22:23:48 [2019-12-30T22:23:48.965Z] === RUN   TestBuildMultiStageCopy/copy_to_newdir_nested
22:23:49 [2019-12-30T22:23:49.585Z] === RUN   TestBuildMultiStageCopy/copy_to_existingdir
22:23:49 [2019-12-30T22:23:49.871Z] === RUN   TestBuildMultiStageCopy/copy_to_newsubdir
22:23:50 [2019-12-30T22:23:50.157Z] --- PASS: TestBuildMultiStageCopy (3.53s)
22:23:50 [2019-12-30T22:23:50.158Z]     --- PASS: TestBuildMultiStageCopy/copy_to_root (1.94s)
22:23:50 [2019-12-30T22:23:50.158Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newdir (0.38s)
22:23:50 [2019-12-30T22:23:50.158Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newdir_nested (0.38s)
22:23:50 [2019-12-30T22:23:50.158Z]     --- PASS: TestBuildMultiStageCopy/copy_to_existingdir (0.41s)
22:23:50 [2019-12-30T22:23:50.158Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newsubdir (0.42s)
22:23:50 [2019-12-30T22:23:50.158Z] === RUN   TestBuildMultiStageParentConfig
22:23:51 [2019-12-30T22:23:51.179Z] --- PASS: TestBuildMultiStageParentConfig (1.00s)
22:23:51 [2019-12-30T22:23:51.179Z] === RUN   TestBuildLabelWithTargets
22:23:53 [2019-12-30T22:23:53.219Z] --- PASS: TestBuildLabelWithTargets (1.57s)
22:23:53 [2019-12-30T22:23:53.219Z] === RUN   TestBuildWithEmptyLayers
22:23:53 [2019-12-30T22:23:53.504Z] --- PASS: TestBuildWithEmptyLayers (0.83s)
22:23:53 [2019-12-30T22:23:53.504Z] === RUN   TestBuildMultiStageOnBuild
22:23:56 [2019-12-30T22:23:56.204Z] --- PASS: TestBuildMultiStageOnBuild (2.18s)
22:23:56 [2019-12-30T22:23:56.204Z] === RUN   TestBuildUncleanTarFilenames
22:23:57 [2019-12-30T22:23:57.221Z] --- PASS: TestBuildUncleanTarFilenames (1.14s)
22:23:57 [2019-12-30T22:23:57.222Z] === RUN   TestBuildMultiStageLayerLeak
22:23:59 [2019-12-30T22:23:59.260Z] --- PASS: TestBuildMultiStageLayerLeak (2.20s)
22:23:59 [2019-12-30T22:23:59.260Z] === RUN   TestBuildWithHugeFile
22:25:36 [2019-12-30T22:25:36.379Z] --- PASS: TestBuildWithHugeFile (82.32s)
22:25:36 [2019-12-30T22:25:36.379Z] === RUN   TestBuildWithEmptyDockerfile
22:25:36 [2019-12-30T22:25:36.379Z] === RUN   TestBuildWithEmptyDockerfile/empty-dockerfile
22:25:36 [2019-12-30T22:25:36.379Z] === PAUSE TestBuildWithEmptyDockerfile/empty-dockerfile
22:25:36 [2019-12-30T22:25:36.379Z] === RUN   TestBuildWithEmptyDockerfile/empty-lines-dockerfile
22:25:36 [2019-12-30T22:25:36.379Z] === PAUSE TestBuildWithEmptyDockerfile/empty-lines-dockerfile
22:25:36 [2019-12-30T22:25:36.379Z] === RUN   TestBuildWithEmptyDockerfile/comment-only-dockerfile
22:25:36 [2019-12-30T22:25:36.379Z] === PAUSE TestBuildWithEmptyDockerfile/comment-only-dockerfile
22:25:36 [2019-12-30T22:25:36.379Z] === CONT  TestBuildWithEmptyDockerfile/empty-dockerfile
22:25:36 [2019-12-30T22:25:36.379Z] === CONT  TestBuildWithEmptyDockerfile/empty-lines-dockerfile
22:25:36 [2019-12-30T22:25:36.379Z] === CONT  TestBuildWithEmptyDockerfile/comment-only-dockerfile
22:25:36 [2019-12-30T22:25:36.379Z] --- PASS: TestBuildWithEmptyDockerfile (0.05s)
22:25:36 [2019-12-30T22:25:36.379Z]     --- PASS: TestBuildWithEmptyDockerfile/empty-lines-dockerfile (0.26s)
22:25:36 [2019-12-30T22:25:36.379Z]     --- PASS: TestBuildWithEmptyDockerfile/comment-only-dockerfile (0.26s)
22:25:36 [2019-12-30T22:25:36.379Z]     --- PASS: TestBuildWithEmptyDockerfile/empty-dockerfile (0.26s)
22:25:36 [2019-12-30T22:25:36.379Z] === RUN   TestBuildPreserveOwnership
22:25:36 [2019-12-30T22:25:36.379Z] === RUN   TestBuildPreserveOwnership/copy_from
22:25:36 [2019-12-30T22:25:36.379Z] === RUN   TestBuildPreserveOwnership/copy_from_chowned
22:25:36 [2019-12-30T22:25:36.379Z] --- PASS: TestBuildPreserveOwnership (4.67s)
22:25:36 [2019-12-30T22:25:36.379Z]     --- PASS: TestBuildPreserveOwnership/copy_from (3.00s)
22:25:36 [2019-12-30T22:25:36.379Z]     --- PASS: TestBuildPreserveOwnership/copy_from_chowned (1.66s)
22:25:36 [2019-12-30T22:25:36.379Z] === RUN   TestBuildPlatformInvalid
22:25:36 [2019-12-30T22:25:36.379Z] --- PASS: TestBuildPlatformInvalid (0.15s)
22:25:36 [2019-12-30T22:25:36.379Z] PASS
22:25:36 [2019-12-30T22:25:36.379Z] 
22:25:36 [2019-12-30T22:25:36.379Z] === Skipped
22:25:36 [2019-12-30T22:25:36.379Z] === SKIP: ppc64le.integration.build TestBuildWithSession (0.00s)
22:25:36 [2019-12-30T22:25:36.379Z]     build_session_test.go:25: TODO: BuildKit
22:25:36 [2019-12-30T22:25:36.379Z] 
22:25:36 [2019-12-30T22:25:36.379Z] 
22:25:36 [2019-12-30T22:25:36.379Z] DONE 32 tests, 1 skipped in 128.444s
22:25:36 [2019-12-30T22:25:36.379Z] Running /go/src/github.com/docker/docker/integration/config (ppc64le.integration.config) flags=-test.v -test.timeout=120m 
22:25:36 [2019-12-30T22:25:36.379Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-config-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-config-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.config -t ./test.main -test.v -test.timeout=120m
22:25:36 [2019-12-30T22:25:36.379Z] ++ set -e
22:25:36 [2019-12-30T22:25:36.379Z] ++ '[' -n 0 ']'
22:25:36 [2019-12-30T22:25:36.379Z] ++ set -x
22:25:36 [2019-12-30T22:25:36.379Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=ppc64le DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-config-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-config-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.config -t ./test.main -test.v -test.timeout=120m
22:25:36 [2019-12-30T22:25:36.379Z] INFO: Testing against a local daemon
22:25:36 [2019-12-30T22:25:36.379Z] === RUN   TestConfigList
22:25:36 [2019-12-30T22:25:36.379Z] --- PASS: TestConfigList (2.27s)
22:25:36 [2019-12-30T22:25:36.379Z] === RUN   TestConfigsCreateAndDelete
22:25:36 [2019-12-30T22:25:36.379Z] --- PASS: TestConfigsCreateAndDelete (2.21s)
22:25:36 [2019-12-30T22:25:36.379Z] === RUN   TestConfigsUpdate
22:25:36 [2019-12-30T22:25:36.379Z] --- PASS: TestConfigsUpdate (2.25s)
22:25:36 [2019-12-30T22:25:36.379Z] === RUN   TestTemplatedConfig
22:25:36 [2019-12-30T22:25:36.379Z] --- PASS: TestTemplatedConfig (2.65s)
22:25:36 [2019-12-30T22:25:36.379Z] === RUN   TestConfigInspect
22:25:38 [2019-12-30T22:25:38.419Z] --- PASS: TestConfigInspect (2.29s)
22:25:38 [2019-12-30T22:25:38.419Z] === RUN   TestConfigCreateWithLabels
22:25:41 [2019-12-30T22:25:41.146Z] --- PASS: TestConfigCreateWithLabels (2.27s)
22:25:41 [2019-12-30T22:25:41.146Z] === RUN   TestConfigCreateResolve
22:25:43 [2019-12-30T22:25:43.184Z] --- PASS: TestConfigCreateResolve (2.25s)
22:25:43 [2019-12-30T22:25:43.184Z] === RUN   TestConfigDaemonLibtrustID
22:25:43 [2019-12-30T22:25:43.468Z] --- PASS: TestConfigDaemonLibtrustID (0.55s)
22:25:43 [2019-12-30T22:25:43.468Z] PASS
22:25:43 [2019-12-30T22:25:43.468Z] 
22:25:43 [2019-12-30T22:25:43.468Z] DONE 8 tests in 16.832s
22:25:43 [2019-12-30T22:25:43.469Z] Running /go/src/github.com/docker/docker/integration/container (ppc64le.integration.container) flags=-test.v -test.timeout=120m 
22:25:43 [2019-12-30T22:25:43.469Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-container-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-container-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.container -t ./test.main -test.v -test.timeout=120m
22:25:43 [2019-12-30T22:25:43.469Z] ++ set -e
22:25:43 [2019-12-30T22:25:43.469Z] ++ '[' -n 0 ']'
22:25:43 [2019-12-30T22:25:43.469Z] ++ set -x
22:25:43 [2019-12-30T22:25:43.469Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=ppc64le DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-container-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-container-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.container -t ./test.main -test.v -test.timeout=120m
22:25:43 [2019-12-30T22:25:43.755Z] INFO: Testing against a local daemon
22:25:43 [2019-12-30T22:25:43.755Z] === RUN   TestCheckpoint
22:25:43 [2019-12-30T22:25:43.755Z] --- SKIP: TestCheckpoint (0.00s)
22:25:43 [2019-12-30T22:25:43.755Z]     checkpoint_test.go:33: TestCheckpoint is broken; see https://github.com/moby/moby/issues/38963
22:25:43 [2019-12-30T22:25:43.755Z] === RUN   TestContainerInvalidJSON
22:25:43 [2019-12-30T22:25:43.755Z] === RUN   TestContainerInvalidJSON//containers/foobar/copy
22:25:43 [2019-12-30T22:25:43.755Z] === PAUSE TestContainerInvalidJSON//containers/foobar/copy
22:25:43 [2019-12-30T22:25:43.755Z] === RUN   TestContainerInvalidJSON//containers/foobar/exec
22:25:43 [2019-12-30T22:25:43.755Z] === PAUSE TestContainerInvalidJSON//containers/foobar/exec
22:25:43 [2019-12-30T22:25:43.755Z] === RUN   TestContainerInvalidJSON//exec/foobar/start
22:25:43 [2019-12-30T22:25:43.755Z] === PAUSE TestContainerInvalidJSON//exec/foobar/start
22:25:43 [2019-12-30T22:25:43.755Z] === CONT  TestContainerInvalidJSON//containers/foobar/copy
22:25:43 [2019-12-30T22:25:43.755Z] === CONT  TestContainerInvalidJSON//exec/foobar/start
22:25:43 [2019-12-30T22:25:43.755Z] === CONT  TestContainerInvalidJSON//containers/foobar/exec
22:25:43 [2019-12-30T22:25:43.755Z] --- PASS: TestContainerInvalidJSON (0.02s)
22:25:43 [2019-12-30T22:25:43.755Z]     --- PASS: TestContainerInvalidJSON//containers/foobar/exec (0.00s)
22:25:43 [2019-12-30T22:25:43.755Z]     --- PASS: TestContainerInvalidJSON//exec/foobar/start (0.00s)
22:25:43 [2019-12-30T22:25:43.755Z]     --- PASS: TestContainerInvalidJSON//containers/foobar/copy (0.00s)
22:25:43 [2019-12-30T22:25:43.755Z] === RUN   TestCopyFromContainerPathDoesNotExist
22:25:43 [2019-12-30T22:25:43.755Z] --- PASS: TestCopyFromContainerPathDoesNotExist (0.09s)
22:25:43 [2019-12-30T22:25:43.755Z] === RUN   TestCopyFromContainerPathIsNotDir
22:25:43 [2019-12-30T22:25:43.755Z] --- PASS: TestCopyFromContainerPathIsNotDir (0.08s)
22:25:43 [2019-12-30T22:25:43.755Z] === RUN   TestCopyToContainerPathDoesNotExist
22:25:43 [2019-12-30T22:25:43.755Z] --- PASS: TestCopyToContainerPathDoesNotExist (0.07s)
22:25:43 [2019-12-30T22:25:43.755Z] === RUN   TestCopyToContainerPathIsNotDir
22:25:44 [2019-12-30T22:25:44.041Z] --- PASS: TestCopyToContainerPathIsNotDir (0.08s)
22:25:44 [2019-12-30T22:25:44.041Z] === RUN   TestCopyFromContainer
22:25:45 [2019-12-30T22:25:45.529Z] === RUN   TestCopyFromContainer//
22:25:45 [2019-12-30T22:25:45.529Z] === RUN   TestCopyFromContainer//bar/root
22:25:45 [2019-12-30T22:25:45.815Z] === RUN   TestCopyFromContainer//bar/root/
22:25:45 [2019-12-30T22:25:45.815Z] === RUN   TestCopyFromContainer/bar/quux
22:25:45 [2019-12-30T22:25:45.815Z] === RUN   TestCopyFromContainer/bar/quux/
22:25:46 [2019-12-30T22:25:46.108Z] === RUN   TestCopyFromContainer/bar/quux/baz
22:25:46 [2019-12-30T22:25:46.108Z] === RUN   TestCopyFromContainer/bar/filesymlink
22:25:46 [2019-12-30T22:25:46.108Z] === RUN   TestCopyFromContainer/bar/dirsymlink
22:25:46 [2019-12-30T22:25:46.397Z] === RUN   TestCopyFromContainer/bar/dirsymlink/
22:25:46 [2019-12-30T22:25:46.397Z] === RUN   TestCopyFromContainer/bar/notarget
22:25:46 [2019-12-30T22:25:46.397Z] --- PASS: TestCopyFromContainer (2.54s)
22:25:46 [2019-12-30T22:25:46.397Z]     --- PASS: TestCopyFromContainer// (0.09s)
22:25:46 [2019-12-30T22:25:46.397Z]     --- PASS: TestCopyFromContainer//bar/root (0.11s)
22:25:46 [2019-12-30T22:25:46.397Z]     --- PASS: TestCopyFromContainer//bar/root/ (0.10s)
22:25:46 [2019-12-30T22:25:46.397Z]     --- PASS: TestCopyFromContainer/bar/quux (0.11s)
22:25:46 [2019-12-30T22:25:46.397Z]     --- PASS: TestCopyFromContainer/bar/quux/ (0.09s)
22:25:46 [2019-12-30T22:25:46.397Z]     --- PASS: TestCopyFromContainer/bar/quux/baz (0.09s)
22:25:46 [2019-12-30T22:25:46.397Z]     --- PASS: TestCopyFromContainer/bar/filesymlink (0.10s)
22:25:46 [2019-12-30T22:25:46.397Z]     --- PASS: TestCopyFromContainer/bar/dirsymlink (0.10s)
22:25:46 [2019-12-30T22:25:46.397Z]     --- PASS: TestCopyFromContainer/bar/dirsymlink/ (0.09s)
22:25:46 [2019-12-30T22:25:46.397Z]     --- PASS: TestCopyFromContainer/bar/notarget (0.09s)
22:25:46 [2019-12-30T22:25:46.397Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist
22:25:46 [2019-12-30T22:25:46.397Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
22:25:46 [2019-12-30T22:25:46.397Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
22:25:46 [2019-12-30T22:25:46.397Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
22:25:46 [2019-12-30T22:25:46.397Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
22:25:46 [2019-12-30T22:25:46.397Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/digest
22:25:46 [2019-12-30T22:25:46.397Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/digest
22:25:46 [2019-12-30T22:25:46.397Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
22:25:46 [2019-12-30T22:25:46.397Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/digest
22:25:46 [2019-12-30T22:25:46.397Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
22:25:46 [2019-12-30T22:25:46.397Z] --- PASS: TestCreateFailsWhenIdentifierDoesNotExist (0.03s)
22:25:46 [2019-12-30T22:25:46.397Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/digest (0.00s)
22:25:46 [2019-12-30T22:25:46.397Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag (0.01s)
22:25:46 [2019-12-30T22:25:46.397Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag (0.01s)
22:25:46 [2019-12-30T22:25:46.397Z] === RUN   TestCreateLinkToNonExistingContainer
22:25:46 [2019-12-30T22:25:46.682Z] --- PASS: TestCreateLinkToNonExistingContainer (0.05s)
22:25:46 [2019-12-30T22:25:46.682Z] === RUN   TestCreateWithInvalidEnv
22:25:46 [2019-12-30T22:25:46.682Z] === RUN   TestCreateWithInvalidEnv/0
22:25:46 [2019-12-30T22:25:46.682Z] === PAUSE TestCreateWithInvalidEnv/0
22:25:46 [2019-12-30T22:25:46.682Z] === RUN   TestCreateWithInvalidEnv/1
22:25:46 [2019-12-30T22:25:46.682Z] === PAUSE TestCreateWithInvalidEnv/1
22:25:46 [2019-12-30T22:25:46.682Z] === RUN   TestCreateWithInvalidEnv/2
22:25:46 [2019-12-30T22:25:46.682Z] === PAUSE TestCreateWithInvalidEnv/2
22:25:46 [2019-12-30T22:25:46.682Z] === CONT  TestCreateWithInvalidEnv/0
22:25:46 [2019-12-30T22:25:46.683Z] === CONT  TestCreateWithInvalidEnv/2
22:25:46 [2019-12-30T22:25:46.683Z] === CONT  TestCreateWithInvalidEnv/1
22:25:46 [2019-12-30T22:25:46.683Z] --- PASS: TestCreateWithInvalidEnv (0.02s)
22:25:46 [2019-12-30T22:25:46.683Z]     --- PASS: TestCreateWithInvalidEnv/2 (0.00s)
22:25:46 [2019-12-30T22:25:46.683Z]     --- PASS: TestCreateWithInvalidEnv/1 (0.00s)
22:25:46 [2019-12-30T22:25:46.683Z]     --- PASS: TestCreateWithInvalidEnv/0 (0.00s)
22:25:46 [2019-12-30T22:25:46.683Z] === RUN   TestCreateTmpfsMountsTarget
22:25:46 [2019-12-30T22:25:46.683Z] --- PASS: TestCreateTmpfsMountsTarget (0.04s)
22:25:46 [2019-12-30T22:25:46.683Z] === RUN   TestCreateWithCustomMaskedPaths
22:25:48 [2019-12-30T22:25:48.723Z] --- PASS: TestCreateWithCustomMaskedPaths (1.86s)
22:25:48 [2019-12-30T22:25:48.724Z] === RUN   TestCreateWithCapabilities
22:25:48 [2019-12-30T22:25:48.724Z] === RUN   TestCreateWithCapabilities/no_capabilities
22:25:48 [2019-12-30T22:25:48.724Z] === PAUSE TestCreateWithCapabilities/no_capabilities
22:25:48 [2019-12-30T22:25:48.724Z] === RUN   TestCreateWithCapabilities/empty_capabilities
22:25:48 [2019-12-30T22:25:48.724Z] === PAUSE TestCreateWithCapabilities/empty_capabilities
22:25:48 [2019-12-30T22:25:48.724Z] === RUN   TestCreateWithCapabilities/valid_capabilities
22:25:48 [2019-12-30T22:25:48.724Z] === PAUSE TestCreateWithCapabilities/valid_capabilities
22:25:48 [2019-12-30T22:25:48.724Z] === RUN   TestCreateWithCapabilities/invalid_capabilities
22:25:48 [2019-12-30T22:25:48.724Z] === PAUSE TestCreateWithCapabilities/invalid_capabilities
22:25:48 [2019-12-30T22:25:48.724Z] === RUN   TestCreateWithCapabilities/duplicate_capabilities
22:25:48 [2019-12-30T22:25:48.724Z] === PAUSE TestCreateWithCapabilities/duplicate_capabilities
22:25:48 [2019-12-30T22:25:48.724Z] === RUN   TestCreateWithCapabilities/capabilities_API_v1.39
22:25:48 [2019-12-30T22:25:48.724Z] === PAUSE TestCreateWithCapabilities/capabilities_API_v1.39
22:25:48 [2019-12-30T22:25:48.724Z] === RUN   TestCreateWithCapabilities/empty_capadd
22:25:48 [2019-12-30T22:25:48.724Z] === PAUSE TestCreateWithCapabilities/empty_capadd
22:25:48 [2019-12-30T22:25:48.724Z] === RUN   TestCreateWithCapabilities/empty_capdrop
22:25:48 [2019-12-30T22:25:48.724Z] === PAUSE TestCreateWithCapabilities/empty_capdrop
22:25:48 [2019-12-30T22:25:48.724Z] === RUN   TestCreateWithCapabilities/capadd_capdrop
22:25:48 [2019-12-30T22:25:48.724Z] === PAUSE TestCreateWithCapabilities/capadd_capdrop
22:25:48 [2019-12-30T22:25:48.724Z] === RUN   TestCreateWithCapabilities/conflict_with_capadd
22:25:48 [2019-12-30T22:25:48.724Z] === PAUSE TestCreateWithCapabilities/conflict_with_capadd
22:25:48 [2019-12-30T22:25:48.724Z] === RUN   TestCreateWithCapabilities/conflict_with_capdrop
22:25:48 [2019-12-30T22:25:48.724Z] === PAUSE TestCreateWithCapabilities/conflict_with_capdrop
22:25:48 [2019-12-30T22:25:48.724Z] === CONT  TestCreateWithCapabilities/no_capabilities
22:25:48 [2019-12-30T22:25:48.724Z] === CONT  TestCreateWithCapabilities/empty_capadd
22:25:48 [2019-12-30T22:25:48.724Z] === CONT  TestCreateWithCapabilities/invalid_capabilities
22:25:48 [2019-12-30T22:25:48.724Z] === CONT  TestCreateWithCapabilities/conflict_with_capdrop
22:25:48 [2019-12-30T22:25:48.724Z] === CONT  TestCreateWithCapabilities/capadd_capdrop
22:25:48 [2019-12-30T22:25:48.724Z] === CONT  TestCreateWithCapabilities/conflict_with_capadd
22:25:48 [2019-12-30T22:25:48.724Z] === CONT  TestCreateWithCapabilities/empty_capdrop
22:25:48 [2019-12-30T22:25:48.724Z] === CONT  TestCreateWithCapabilities/empty_capabilities
22:25:48 [2019-12-30T22:25:48.724Z] === CONT  TestCreateWithCapabilities/valid_capabilities
22:25:48 [2019-12-30T22:25:48.724Z] === CONT  TestCreateWithCapabilities/capabilities_API_v1.39
22:25:48 [2019-12-30T22:25:48.724Z] === CONT  TestCreateWithCapabilities/duplicate_capabilities
22:25:48 [2019-12-30T22:25:48.724Z] --- PASS: TestCreateWithCapabilities (0.05s)
22:25:48 [2019-12-30T22:25:48.724Z]     --- PASS: TestCreateWithCapabilities/invalid_capabilities (0.00s)
22:25:48 [2019-12-30T22:25:48.724Z]     --- PASS: TestCreateWithCapabilities/conflict_with_capdrop (0.01s)
22:25:48 [2019-12-30T22:25:48.724Z]     --- PASS: TestCreateWithCapabilities/conflict_with_capadd (0.00s)
22:25:48 [2019-12-30T22:25:48.724Z]     --- PASS: TestCreateWithCapabilities/no_capabilities (0.05s)
22:25:48 [2019-12-30T22:25:48.724Z]     --- PASS: TestCreateWithCapabilities/empty_capadd (0.05s)
22:25:48 [2019-12-30T22:25:48.724Z]     --- PASS: TestCreateWithCapabilities/empty_capdrop (0.04s)
22:25:48 [2019-12-30T22:25:48.724Z]     --- PASS: TestCreateWithCapabilities/capadd_capdrop (0.06s)
22:25:48 [2019-12-30T22:25:48.724Z]     --- PASS: TestCreateWithCapabilities/capabilities_API_v1.39 (0.05s)
22:25:48 [2019-12-30T22:25:48.724Z]     --- PASS: TestCreateWithCapabilities/valid_capabilities (0.05s)
22:25:48 [2019-12-30T22:25:48.724Z]     --- PASS: TestCreateWithCapabilities/duplicate_capabilities (0.04s)
22:25:48 [2019-12-30T22:25:48.724Z]     --- PASS: TestCreateWithCapabilities/empty_capabilities (0.06s)
22:25:48 [2019-12-30T22:25:48.724Z] === RUN   TestCreateWithCustomReadonlyPaths
22:25:50 [2019-12-30T22:25:50.773Z] --- PASS: TestCreateWithCustomReadonlyPaths (1.99s)
22:25:50 [2019-12-30T22:25:50.773Z] === RUN   TestCreateWithInvalidHealthcheckParams
22:25:50 [2019-12-30T22:25:50.773Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
22:25:50 [2019-12-30T22:25:50.773Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
22:25:50 [2019-12-30T22:25:50.773Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
22:25:50 [2019-12-30T22:25:50.773Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
22:25:50 [2019-12-30T22:25:50.773Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
22:25:50 [2019-12-30T22:25:50.773Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
22:25:50 [2019-12-30T22:25:50.773Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
22:25:50 [2019-12-30T22:25:50.773Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
22:25:50 [2019-12-30T22:25:50.773Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
22:25:50 [2019-12-30T22:25:50.773Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
22:25:50 [2019-12-30T22:25:50.773Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
22:25:50 [2019-12-30T22:25:50.773Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
22:25:50 [2019-12-30T22:25:50.773Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
22:25:50 [2019-12-30T22:25:50.773Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
22:25:50 [2019-12-30T22:25:50.773Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
22:25:50 [2019-12-30T22:25:50.773Z] --- PASS: TestCreateWithInvalidHealthcheckParams (0.03s)
22:25:50 [2019-12-30T22:25:50.773Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0 (0.03s)
22:25:50 [2019-12-30T22:25:50.773Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms (0.04s)
22:25:50 [2019-12-30T22:25:50.773Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s (0.04s)
22:25:50 [2019-12-30T22:25:50.773Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms (0.04s)
22:25:50 [2019-12-30T22:25:50.773Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms (0.02s)
22:25:50 [2019-12-30T22:25:50.773Z] === RUN   TestContainerStartOnDaemonRestart
22:25:50 [2019-12-30T22:25:50.773Z] === PAUSE TestContainerStartOnDaemonRestart
22:25:50 [2019-12-30T22:25:50.773Z] === RUN   TestDaemonRestartIpcMode
22:25:50 [2019-12-30T22:25:50.773Z] === PAUSE TestDaemonRestartIpcMode
22:25:50 [2019-12-30T22:25:50.773Z] === RUN   TestDiff
22:25:51 [2019-12-30T22:25:51.396Z] --- PASS: TestDiff (0.64s)
22:25:51 [2019-12-30T22:25:51.396Z] === RUN   TestExecWithCloseStdin
22:25:52 [2019-12-30T22:25:52.418Z] --- PASS: TestExecWithCloseStdin (0.79s)
22:25:52 [2019-12-30T22:25:52.418Z] === RUN   TestExec
22:25:53 [2019-12-30T22:25:53.036Z] --- PASS: TestExec (0.75s)
22:25:53 [2019-12-30T22:25:53.036Z] === RUN   TestExecUser
22:25:53 [2019-12-30T22:25:53.663Z] --- PASS: TestExecUser (0.77s)
22:25:53 [2019-12-30T22:25:53.663Z] === RUN   TestExportContainerAndImportImage
22:25:54 [2019-12-30T22:25:54.686Z] --- PASS: TestExportContainerAndImportImage (1.00s)
22:25:54 [2019-12-30T22:25:54.686Z] === RUN   TestExportContainerAfterDaemonRestart
22:25:56 [2019-12-30T22:25:56.174Z] --- PASS: TestExportContainerAfterDaemonRestart (1.58s)
22:25:56 [2019-12-30T22:25:56.174Z] === RUN   TestHealthCheckWorkdir
22:25:57 [2019-12-30T22:25:57.191Z] --- PASS: TestHealthCheckWorkdir (0.87s)
22:25:57 [2019-12-30T22:25:57.191Z] === RUN   TestHealthKillContainer
22:25:59 [2019-12-30T22:25:59.878Z] --- PASS: TestHealthKillContainer (2.84s)
22:25:59 [2019-12-30T22:25:59.878Z] === RUN   TestInspectCpusetInConfigPre120
22:26:00 [2019-12-30T22:26:00.899Z] --- PASS: TestInspectCpusetInConfigPre120 (0.67s)
22:26:00 [2019-12-30T22:26:00.900Z] === RUN   TestIpcModeNone
22:26:01 [2019-12-30T22:26:01.367Z] --- PASS: TestIpcModeNone (0.77s)
22:26:01 [2019-12-30T22:26:01.367Z] === RUN   TestIpcModePrivate
22:26:02 [2019-12-30T22:26:02.379Z] --- PASS: TestIpcModePrivate (0.76s)
22:26:02 [2019-12-30T22:26:02.379Z]     ipcmode_linux_test.go:90: [testIpcPrivateShareable] ipcmode: private, ipcdev: 0:62, shared: false, mustBeShared: false
22:26:02 [2019-12-30T22:26:02.379Z] === RUN   TestIpcModeShareable
22:26:03 [2019-12-30T22:26:03.000Z] --- PASS: TestIpcModeShareable (0.78s)
22:26:03 [2019-12-30T22:26:03.000Z]     ipcmode_linux_test.go:90: [testIpcPrivateShareable] ipcmode: shareable, ipcdev: 0:56, shared: true, mustBeShared: true
22:26:03 [2019-12-30T22:26:03.000Z] === RUN   TestAPIIpcModeShareableAndContainer
22:26:05 [2019-12-30T22:26:05.725Z] --- PASS: TestAPIIpcModeShareableAndContainer (2.30s)
22:26:05 [2019-12-30T22:26:05.725Z] === RUN   TestAPIIpcModeHost
22:26:06 [2019-12-30T22:26:06.014Z] --- PASS: TestAPIIpcModeHost (0.62s)
22:26:06 [2019-12-30T22:26:06.014Z] === RUN   TestDaemonIpcModeShareable
22:26:07 [2019-12-30T22:26:07.505Z] --- PASS: TestDaemonIpcModeShareable (1.67s)
22:26:07 [2019-12-30T22:26:07.505Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:64, shared: true, mustBeShared: true
22:26:07 [2019-12-30T22:26:07.505Z] === RUN   TestDaemonIpcModePrivate
22:26:09 [2019-12-30T22:26:09.541Z] --- PASS: TestDaemonIpcModePrivate (1.62s)
22:26:09 [2019-12-30T22:26:09.541Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:70, shared: false, mustBeShared: false
22:26:09 [2019-12-30T22:26:09.541Z] === RUN   TestDaemonIpcModePrivateFromConfig
22:26:11 [2019-12-30T22:26:11.032Z] --- PASS: TestDaemonIpcModePrivateFromConfig (1.61s)
22:26:11 [2019-12-30T22:26:11.032Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:70, shared: false, mustBeShared: false
22:26:11 [2019-12-30T22:26:11.032Z] === RUN   TestDaemonIpcModeShareableFromConfig
22:26:12 [2019-12-30T22:26:12.518Z] --- PASS: TestDaemonIpcModeShareableFromConfig (1.69s)
22:26:12 [2019-12-30T22:26:12.518Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:64, shared: true, mustBeShared: true
22:26:12 [2019-12-30T22:26:12.518Z] === RUN   TestIpcModeOlderClient
22:26:12 [2019-12-30T22:26:12.518Z] === PAUSE TestIpcModeOlderClient
22:26:12 [2019-12-30T22:26:12.518Z] === RUN   TestKillContainerInvalidSignal
22:26:13 [2019-12-30T22:26:13.167Z] --- PASS: TestKillContainerInvalidSignal (0.70s)
22:26:13 [2019-12-30T22:26:13.167Z] === RUN   TestKillContainer
22:26:13 [2019-12-30T22:26:13.167Z] === RUN   TestKillContainer/no_signal
22:26:13 [2019-12-30T22:26:13.785Z] === RUN   TestKillContainer/non_killing_signal
22:26:14 [2019-12-30T22:26:14.404Z] === RUN   TestKillContainer/killing_signal
22:26:15 [2019-12-30T22:26:15.421Z] --- PASS: TestKillContainer (1.98s)
22:26:15 [2019-12-30T22:26:15.422Z]     --- PASS: TestKillContainer/no_signal (0.65s)
22:26:15 [2019-12-30T22:26:15.422Z]     --- PASS: TestKillContainer/non_killing_signal (0.44s)
22:26:15 [2019-12-30T22:26:15.422Z]     --- PASS: TestKillContainer/killing_signal (0.61s)
22:26:15 [2019-12-30T22:26:15.422Z] === RUN   TestKillWithStopSignalAndRestartPolicies
22:26:15 [2019-12-30T22:26:15.422Z] === RUN   TestKillWithStopSignalAndRestartPolicies/same-signal-disables-restart-policy
22:26:15 [2019-12-30T22:26:15.714Z] === RUN   TestKillWithStopSignalAndRestartPolicies/different-signal-keep-restart-policy
22:26:16 [2019-12-30T22:26:16.732Z] --- PASS: TestKillWithStopSignalAndRestartPolicies (1.34s)
22:26:16 [2019-12-30T22:26:16.732Z]     --- PASS: TestKillWithStopSignalAndRestartPolicies/same-signal-disables-restart-policy (0.63s)
22:26:16 [2019-12-30T22:26:16.732Z]     --- PASS: TestKillWithStopSignalAndRestartPolicies/different-signal-keep-restart-policy (0.45s)
22:26:16 [2019-12-30T22:26:16.732Z] === RUN   TestKillStoppedContainer
22:26:16 [2019-12-30T22:26:16.732Z] --- PASS: TestKillStoppedContainer (0.09s)
22:26:16 [2019-12-30T22:26:16.732Z] === RUN   TestKillStoppedContainerAPIPre120
22:26:16 [2019-12-30T22:26:16.732Z] --- PASS: TestKillStoppedContainerAPIPre120 (0.07s)
22:26:16 [2019-12-30T22:26:16.732Z] === RUN   TestKillDifferentUserContainer
22:26:17 [2019-12-30T22:26:17.356Z] --- PASS: TestKillDifferentUserContainer (0.67s)
22:26:17 [2019-12-30T22:26:17.356Z] === RUN   TestInspectOomKilledTrue
22:26:18 [2019-12-30T22:26:18.842Z] --- PASS: TestInspectOomKilledTrue (1.16s)
22:26:18 [2019-12-30T22:26:18.842Z] === RUN   TestInspectOomKilledFalse
22:26:19 [2019-12-30T22:26:19.126Z] --- PASS: TestInspectOomKilledFalse (0.70s)
22:26:19 [2019-12-30T22:26:19.126Z] === RUN   TestLinksEtcHostsContentMatch
22:26:19 [2019-12-30T22:26:19.746Z] --- PASS: TestLinksEtcHostsContentMatch (0.53s)
22:26:19 [2019-12-30T22:26:19.746Z] === RUN   TestLinksContainerNames
22:26:21 [2019-12-30T22:26:21.240Z] --- PASS: TestLinksContainerNames (1.29s)
22:26:21 [2019-12-30T22:26:21.240Z] === RUN   TestLogsFollowTailEmpty
22:26:21 [2019-12-30T22:26:21.861Z] --- PASS: TestLogsFollowTailEmpty (0.64s)
22:26:21 [2019-12-30T22:26:21.861Z] === RUN   TestContainerNetworkMountsNoChown
22:26:22 [2019-12-30T22:26:22.480Z] --- PASS: TestContainerNetworkMountsNoChown (0.66s)
22:26:22 [2019-12-30T22:26:22.480Z] === RUN   TestMountDaemonRoot
22:26:22 [2019-12-30T22:26:22.480Z] === RUN   TestMountDaemonRoot/default
22:26:22 [2019-12-30T22:26:22.480Z] === PAUSE TestMountDaemonRoot/default
22:26:22 [2019-12-30T22:26:22.480Z] === RUN   TestMountDaemonRoot/private
22:26:22 [2019-12-30T22:26:22.480Z] === PAUSE TestMountDaemonRoot/private
22:26:22 [2019-12-30T22:26:22.480Z] === RUN   TestMountDaemonRoot/rprivate
22:26:22 [2019-12-30T22:26:22.480Z] === PAUSE TestMountDaemonRoot/rprivate
22:26:22 [2019-12-30T22:26:22.480Z] === RUN   TestMountDaemonRoot/slave
22:26:22 [2019-12-30T22:26:22.480Z] === PAUSE TestMountDaemonRoot/slave
22:26:22 [2019-12-30T22:26:22.480Z] === RUN   TestMountDaemonRoot/rslave
22:26:22 [2019-12-30T22:26:22.480Z] === PAUSE TestMountDaemonRoot/rslave
22:26:22 [2019-12-30T22:26:22.480Z] === RUN   TestMountDaemonRoot/shared
22:26:22 [2019-12-30T22:26:22.480Z] === PAUSE TestMountDaemonRoot/shared
22:26:22 [2019-12-30T22:26:22.480Z] === RUN   TestMountDaemonRoot/rshared
22:26:22 [2019-12-30T22:26:22.480Z] === PAUSE TestMountDaemonRoot/rshared
22:26:22 [2019-12-30T22:26:22.480Z] === CONT  TestMountDaemonRoot/default
22:26:22 [2019-12-30T22:26:22.480Z] === CONT  TestMountDaemonRoot/shared
22:26:22 [2019-12-30T22:26:22.480Z] === RUN   TestMountDaemonRoot/shared/mount_root
22:26:22 [2019-12-30T22:26:22.480Z] === PAUSE TestMountDaemonRoot/shared/mount_root
22:26:22 [2019-12-30T22:26:22.480Z] === RUN   TestMountDaemonRoot/default/bind_subpath
22:26:22 [2019-12-30T22:26:22.480Z] === RUN   TestMountDaemonRoot/shared/mount_subpath
22:26:22 [2019-12-30T22:26:22.480Z] === PAUSE TestMountDaemonRoot/default/bind_subpath
22:26:22 [2019-12-30T22:26:22.480Z] === PAUSE TestMountDaemonRoot/shared/mount_subpath
22:26:22 [2019-12-30T22:26:22.480Z] === RUN   TestMountDaemonRoot/default/mount_root
22:26:22 [2019-12-30T22:26:22.480Z] === RUN   TestMountDaemonRoot/shared/bind_root
22:26:22 [2019-12-30T22:26:22.480Z] === PAUSE TestMountDaemonRoot/default/mount_root
22:26:22 [2019-12-30T22:26:22.480Z] === PAUSE TestMountDaemonRoot/shared/bind_root
22:26:22 [2019-12-30T22:26:22.480Z] === RUN   TestMountDaemonRoot/default/mount_subpath
22:26:22 [2019-12-30T22:26:22.480Z] === PAUSE TestMountDaemonRoot/default/mount_subpath
22:26:22 [2019-12-30T22:26:22.480Z] === RUN   TestMountDaemonRoot/default/bind_root
22:26:22 [2019-12-30T22:26:22.480Z] === PAUSE TestMountDaemonRoot/default/bind_root
22:26:22 [2019-12-30T22:26:22.480Z] === CONT  TestMountDaemonRoot/rslave
22:26:22 [2019-12-30T22:26:22.480Z] === RUN   TestMountDaemonRoot/rslave/bind_root
22:26:22 [2019-12-30T22:26:22.480Z] === PAUSE TestMountDaemonRoot/rslave/bind_root
22:26:22 [2019-12-30T22:26:22.480Z] === RUN   TestMountDaemonRoot/rslave/bind_subpath
22:26:22 [2019-12-30T22:26:22.480Z] === PAUSE TestMountDaemonRoot/rslave/bind_subpath
22:26:22 [2019-12-30T22:26:22.480Z] === RUN   TestMountDaemonRoot/rslave/mount_root
22:26:22 [2019-12-30T22:26:22.480Z] === PAUSE TestMountDaemonRoot/rslave/mount_root
22:26:22 [2019-12-30T22:26:22.480Z] === RUN   TestMountDaemonRoot/rslave/mount_subpath
22:26:22 [2019-12-30T22:26:22.480Z] === PAUSE TestMountDaemonRoot/rslave/mount_subpath
22:26:22 [2019-12-30T22:26:22.480Z] === CONT  TestMountDaemonRoot/rshared
22:26:22 [2019-12-30T22:26:22.480Z] === RUN   TestMountDaemonRoot/rshared/bind_root
22:26:22 [2019-12-30T22:26:22.480Z] === PAUSE TestMountDaemonRoot/rshared/bind_root
22:26:22 [2019-12-30T22:26:22.480Z] === RUN   TestMountDaemonRoot/rshared/bind_subpath
22:26:22 [2019-12-30T22:26:22.480Z] === PAUSE TestMountDaemonRoot/rshared/bind_subpath
22:26:22 [2019-12-30T22:26:22.480Z] === RUN   TestMountDaemonRoot/rshared/mount_root
22:26:22 [2019-12-30T22:26:22.480Z] === PAUSE TestMountDaemonRoot/rshared/mount_root
22:26:22 [2019-12-30T22:26:22.480Z] === RUN   TestMountDaemonRoot/rshared/mount_subpath
22:26:22 [2019-12-30T22:26:22.480Z] === PAUSE TestMountDaemonRoot/rshared/mount_subpath
22:26:22 [2019-12-30T22:26:22.480Z] === RUN   TestMountDaemonRoot/shared/bind_subpath
22:26:22 [2019-12-30T22:26:22.480Z] === PAUSE TestMountDaemonRoot/shared/bind_subpath
22:26:22 [2019-12-30T22:26:22.480Z] === CONT  TestMountDaemonRoot/rprivate
22:26:22 [2019-12-30T22:26:22.480Z] === RUN   TestMountDaemonRoot/rprivate/bind_subpath
22:26:22 [2019-12-30T22:26:22.480Z] === PAUSE TestMountDaemonRoot/rprivate/bind_subpath
22:26:22 [2019-12-30T22:26:22.480Z] === RUN   TestMountDaemonRoot/rprivate/mount_root
22:26:22 [2019-12-30T22:26:22.480Z] === PAUSE TestMountDaemonRoot/rprivate/mount_root
22:26:22 [2019-12-30T22:26:22.480Z] === RUN   TestMountDaemonRoot/rprivate/mount_subpath
22:26:22 [2019-12-30T22:26:22.480Z] === PAUSE TestMountDaemonRoot/rprivate/mount_subpath
22:26:22 [2019-12-30T22:26:22.480Z] === RUN   TestMountDaemonRoot/rprivate/bind_root
22:26:22 [2019-12-30T22:26:22.480Z] === PAUSE TestMountDaemonRoot/rprivate/bind_root
22:26:22 [2019-12-30T22:26:22.480Z] === CONT  TestMountDaemonRoot/slave
22:26:22 [2019-12-30T22:26:22.480Z] === RUN   TestMountDaemonRoot/slave/mount_subpath
22:26:22 [2019-12-30T22:26:22.480Z] === PAUSE TestMountDaemonRoot/slave/mount_subpath
22:26:22 [2019-12-30T22:26:22.480Z] === RUN   TestMountDaemonRoot/slave/bind_root
22:26:22 [2019-12-30T22:26:22.480Z] === PAUSE TestMountDaemonRoot/slave/bind_root
22:26:22 [2019-12-30T22:26:22.480Z] === RUN   TestMountDaemonRoot/slave/bind_subpath
22:26:22 [2019-12-30T22:26:22.480Z] === PAUSE TestMountDaemonRoot/slave/bind_subpath
22:26:22 [2019-12-30T22:26:22.480Z] === RUN   TestMountDaemonRoot/slave/mount_root
22:26:22 [2019-12-30T22:26:22.480Z] === PAUSE TestMountDaemonRoot/slave/mount_root
22:26:22 [2019-12-30T22:26:22.480Z] === CONT  TestMountDaemonRoot/private
22:26:22 [2019-12-30T22:26:22.480Z] === RUN   TestMountDaemonRoot/private/bind_root
22:26:22 [2019-12-30T22:26:22.480Z] === PAUSE TestMountDaemonRoot/private/bind_root
22:26:22 [2019-12-30T22:26:22.480Z] === RUN   TestMountDaemonRoot/private/bind_subpath
22:26:22 [2019-12-30T22:26:22.480Z] === PAUSE TestMountDaemonRoot/private/bind_subpath
22:26:22 [2019-12-30T22:26:22.480Z] === RUN   TestMountDaemonRoot/private/mount_root
22:26:22 [2019-12-30T22:26:22.480Z] === PAUSE TestMountDaemonRoot/private/mount_root
22:26:22 [2019-12-30T22:26:22.480Z] === RUN   TestMountDaemonRoot/private/mount_subpath
22:26:22 [2019-12-30T22:26:22.480Z] === PAUSE TestMountDaemonRoot/private/mount_subpath
22:26:22 [2019-12-30T22:26:22.480Z] === CONT  TestMountDaemonRoot/default/bind_subpath
22:26:22 [2019-12-30T22:26:22.480Z] === CONT  TestMountDaemonRoot/rslave/bind_root
22:26:22 [2019-12-30T22:26:22.480Z] === CONT  TestMountDaemonRoot/rshared/bind_root
22:26:22 [2019-12-30T22:26:22.480Z] === CONT  TestMountDaemonRoot/shared/mount_root
22:26:22 [2019-12-30T22:26:22.480Z] === CONT  TestMountDaemonRoot/rprivate/bind_subpath
22:26:22 [2019-12-30T22:26:22.480Z] === CONT  TestMountDaemonRoot/default/bind_root
22:26:22 [2019-12-30T22:26:22.480Z] === CONT  TestMountDaemonRoot/default/mount_subpath
22:26:22 [2019-12-30T22:26:22.480Z] === CONT  TestMountDaemonRoot/default/mount_root
22:26:22 [2019-12-30T22:26:22.480Z] === CONT  TestMountDaemonRoot/slave/mount_subpath
22:26:22 [2019-12-30T22:26:22.480Z] === CONT  TestMountDaemonRoot/rslave/mount_subpath
22:26:22 [2019-12-30T22:26:22.480Z] === CONT  TestMountDaemonRoot/rslave/mount_root
22:26:22 [2019-12-30T22:26:22.480Z] === CONT  TestMountDaemonRoot/rslave/bind_subpath
22:26:22 [2019-12-30T22:26:22.480Z] === CONT  TestMountDaemonRoot/private/bind_root
22:26:22 [2019-12-30T22:26:22.480Z] === CONT  TestMountDaemonRoot/rshared/mount_subpath
22:26:22 [2019-12-30T22:26:22.480Z] === CONT  TestMountDaemonRoot/rshared/mount_root
22:26:22 [2019-12-30T22:26:22.480Z] === CONT  TestMountDaemonRoot/rshared/bind_subpath
22:26:22 [2019-12-30T22:26:22.480Z] === CONT  TestMountDaemonRoot/shared/bind_subpath
22:26:22 [2019-12-30T22:26:22.480Z] === CONT  TestMountDaemonRoot/shared/bind_root
22:26:22 [2019-12-30T22:26:22.768Z] === CONT  TestMountDaemonRoot/shared/mount_subpath
22:26:22 [2019-12-30T22:26:22.768Z] === CONT  TestMountDaemonRoot/rprivate/bind_root
22:26:22 [2019-12-30T22:26:22.768Z] === CONT  TestMountDaemonRoot/rprivate/mount_subpath
22:26:22 [2019-12-30T22:26:22.768Z] === CONT  TestMountDaemonRoot/rprivate/mount_root
22:26:22 [2019-12-30T22:26:22.768Z] === CONT  TestMountDaemonRoot/slave/mount_root
22:26:22 [2019-12-30T22:26:22.768Z] === CONT  TestMountDaemonRoot/slave/bind_subpath
22:26:22 [2019-12-30T22:26:22.768Z] === CONT  TestMountDaemonRoot/slave/bind_root
22:26:22 [2019-12-30T22:26:22.768Z] === CONT  TestMountDaemonRoot/private/mount_subpath
22:26:22 [2019-12-30T22:26:22.768Z] === CONT  TestMountDaemonRoot/private/bind_subpath
22:26:22 [2019-12-30T22:26:22.768Z] === CONT  TestMountDaemonRoot/private/mount_root
22:26:22 [2019-12-30T22:26:22.768Z] --- PASS: TestMountDaemonRoot (0.05s)
22:26:22 [2019-12-30T22:26:22.768Z]     --- PASS: TestMountDaemonRoot/default (0.00s)
22:26:22 [2019-12-30T22:26:22.768Z]         --- PASS: TestMountDaemonRoot/default/bind_subpath (0.08s)
22:26:22 [2019-12-30T22:26:22.768Z]         --- PASS: TestMountDaemonRoot/default/mount_subpath (0.06s)
22:26:22 [2019-12-30T22:26:22.768Z]         --- PASS: TestMountDaemonRoot/default/bind_root (0.08s)
22:26:22 [2019-12-30T22:26:22.768Z]         --- PASS: TestMountDaemonRoot/default/mount_root (0.07s)
22:26:22 [2019-12-30T22:26:22.768Z]     --- PASS: TestMountDaemonRoot/rslave (0.00s)
22:26:22 [2019-12-30T22:26:22.768Z]         --- PASS: TestMountDaemonRoot/rslave/bind_root (0.07s)
22:26:22 [2019-12-30T22:26:22.768Z]         --- PASS: TestMountDaemonRoot/rslave/mount_subpath (0.06s)
22:26:22 [2019-12-30T22:26:22.768Z]         --- PASS: TestMountDaemonRoot/rslave/mount_root (0.05s)
22:26:22 [2019-12-30T22:26:22.768Z]         --- PASS: TestMountDaemonRoot/rslave/bind_subpath (0.06s)
22:26:22 [2019-12-30T22:26:22.768Z]     --- PASS: TestMountDaemonRoot/rshared (0.00s)
22:26:22 [2019-12-30T22:26:22.768Z]         --- PASS: TestMountDaemonRoot/rshared/bind_root (0.06s)
22:26:22 [2019-12-30T22:26:22.768Z]         --- PASS: TestMountDaemonRoot/rshared/mount_root (0.08s)
22:26:22 [2019-12-30T22:26:22.768Z]         --- PASS: TestMountDaemonRoot/rshared/bind_subpath (0.07s)
22:26:22 [2019-12-30T22:26:22.768Z]         --- PASS: TestMountDaemonRoot/rshared/mount_subpath (0.09s)
22:26:22 [2019-12-30T22:26:22.768Z]     --- PASS: TestMountDaemonRoot/shared (0.00s)
22:26:22 [2019-12-30T22:26:22.768Z]         --- PASS: TestMountDaemonRoot/shared/mount_root (0.03s)
22:26:22 [2019-12-30T22:26:22.768Z]         --- PASS: TestMountDaemonRoot/shared/bind_subpath (0.04s)
22:26:22 [2019-12-30T22:26:22.768Z]         --- PASS: TestMountDaemonRoot/shared/bind_root (0.05s)
22:26:22 [2019-12-30T22:26:22.768Z]         --- PASS: TestMountDaemonRoot/shared/mount_subpath (0.05s)
22:26:22 [2019-12-30T22:26:22.768Z]     --- PASS: TestMountDaemonRoot/rprivate (0.00s)
22:26:22 [2019-12-30T22:26:22.768Z]         --- PASS: TestMountDaemonRoot/rprivate/bind_subpath (0.06s)
22:26:22 [2019-12-30T22:26:22.768Z]         --- PASS: TestMountDaemonRoot/rprivate/mount_subpath (0.04s)
22:26:22 [2019-12-30T22:26:22.768Z]         --- PASS: TestMountDaemonRoot/rprivate/bind_root (0.04s)
22:26:22 [2019-12-30T22:26:22.768Z]         --- PASS: TestMountDaemonRoot/rprivate/mount_root (0.03s)
22:26:22 [2019-12-30T22:26:22.768Z]     --- PASS: TestMountDaemonRoot/slave (0.00s)
22:26:22 [2019-12-30T22:26:22.768Z]         --- PASS: TestMountDaemonRoot/slave/mount_subpath (0.03s)
22:26:22 [2019-12-30T22:26:22.768Z]         --- PASS: TestMountDaemonRoot/slave/bind_subpath (0.03s)
22:26:22 [2019-12-30T22:26:22.768Z]         --- PASS: TestMountDaemonRoot/slave/mount_root (0.03s)
22:26:22 [2019-12-30T22:26:22.768Z]         --- PASS: TestMountDaemonRoot/slave/bind_root (0.03s)
22:26:22 [2019-12-30T22:26:22.768Z]     --- PASS: TestMountDaemonRoot/private (0.00s)
22:26:22 [2019-12-30T22:26:22.768Z]         --- PASS: TestMountDaemonRoot/private/bind_root (0.03s)
22:26:22 [2019-12-30T22:26:22.768Z]         --- PASS: TestMountDaemonRoot/private/mount_subpath (0.03s)
22:26:22 [2019-12-30T22:26:22.768Z]         --- PASS: TestMountDaemonRoot/private/mount_root (0.03s)
22:26:22 [2019-12-30T22:26:22.768Z]         --- PASS: TestMountDaemonRoot/private/bind_subpath (0.03s)
22:26:22 [2019-12-30T22:26:22.768Z] === RUN   TestContainerBindMountNonRecursive
22:26:24 [2019-12-30T22:26:24.252Z] --- PASS: TestContainerBindMountNonRecursive (1.65s)
22:26:24 [2019-12-30T22:26:24.252Z] === RUN   TestNetworkNat
22:26:25 [2019-12-30T22:26:25.271Z] --- PASS: TestNetworkNat (0.71s)
22:26:25 [2019-12-30T22:26:25.271Z] === RUN   TestNetworkLocalhostTCPNat
22:26:25 [2019-12-30T22:26:25.891Z] --- PASS: TestNetworkLocalhostTCPNat (0.68s)
22:26:25 [2019-12-30T22:26:25.891Z] === RUN   TestNetworkLoopbackNat
22:26:26 [2019-12-30T22:26:26.904Z] --- PASS: TestNetworkLoopbackNat (0.92s)
22:26:26 [2019-12-30T22:26:26.904Z] === RUN   TestPause
22:26:27 [2019-12-30T22:26:27.543Z] --- PASS: TestPause (0.72s)
22:26:27 [2019-12-30T22:26:27.543Z] === RUN   TestPauseFailsOnWindowsServerContainers
22:26:27 [2019-12-30T22:26:27.543Z] --- SKIP: TestPauseFailsOnWindowsServerContainers (0.00s)
22:26:27 [2019-12-30T22:26:27.543Z]     pause_test.go:54: testEnv.DaemonInfo.OSType != "windows" || testEnv.DaemonInfo.Isolation != "process"
22:26:27 [2019-12-30T22:26:27.543Z] === RUN   TestPauseStopPausedContainer
22:26:28 [2019-12-30T22:26:28.168Z] --- PASS: TestPauseStopPausedContainer (0.71s)
22:26:28 [2019-12-30T22:26:28.168Z] === RUN   TestPsFilter
22:26:28 [2019-12-30T22:26:28.454Z] --- PASS: TestPsFilter (0.19s)
22:26:28 [2019-12-30T22:26:28.454Z] === RUN   TestRemoveContainerWithRemovedVolume
22:26:29 [2019-12-30T22:26:29.078Z] --- PASS: TestRemoveContainerWithRemovedVolume (0.64s)
22:26:29 [2019-12-30T22:26:29.078Z] === RUN   TestRemoveContainerWithVolume
22:26:29 [2019-12-30T22:26:29.705Z] --- PASS: TestRemoveContainerWithVolume (0.67s)
22:26:29 [2019-12-30T22:26:29.705Z] === RUN   TestRemoveContainerRunning
22:26:30 [2019-12-30T22:26:30.325Z] --- PASS: TestRemoveContainerRunning (0.66s)
22:26:30 [2019-12-30T22:26:30.325Z] === RUN   TestRemoveContainerForceRemoveRunning
22:26:30 [2019-12-30T22:26:30.945Z] --- PASS: TestRemoveContainerForceRemoveRunning (0.66s)
22:26:30 [2019-12-30T22:26:30.945Z] === RUN   TestRemoveInvalidContainer
22:26:30 [2019-12-30T22:26:30.945Z] --- PASS: TestRemoveInvalidContainer (0.04s)
22:26:30 [2019-12-30T22:26:30.945Z] === RUN   TestRenameLinkedContainer
22:26:33 [2019-12-30T22:26:33.634Z] --- PASS: TestRenameLinkedContainer (2.57s)
22:26:33 [2019-12-30T22:26:33.634Z] === RUN   TestRenameStoppedContainer
22:26:34 [2019-12-30T22:26:34.258Z] --- PASS: TestRenameStoppedContainer (0.64s)
22:26:34 [2019-12-30T22:26:34.258Z] === RUN   TestRenameRunningContainerAndReuse
22:26:35 [2019-12-30T22:26:35.744Z] --- PASS: TestRenameRunningContainerAndReuse (1.25s)
22:26:35 [2019-12-30T22:26:35.744Z] === RUN   TestRenameInvalidName
22:26:36 [2019-12-30T22:26:36.030Z] --- PASS: TestRenameInvalidName (0.64s)
22:26:36 [2019-12-30T22:26:36.030Z] === RUN   TestRenameAnonymousContainer
22:26:38 [2019-12-30T22:26:38.731Z] --- PASS: TestRenameAnonymousContainer (2.42s)
22:26:38 [2019-12-30T22:26:38.731Z] === RUN   TestRenameContainerWithSameName
22:26:39 [2019-12-30T22:26:39.348Z] --- PASS: TestRenameContainerWithSameName (0.67s)
22:26:39 [2019-12-30T22:26:39.348Z] === RUN   TestRenameContainerWithLinkedContainer
22:26:40 [2019-12-30T22:26:40.362Z] --- PASS: TestRenameContainerWithLinkedContainer (1.27s)
22:26:40 [2019-12-30T22:26:40.362Z] === RUN   TestResize
22:26:41 [2019-12-30T22:26:41.396Z] --- PASS: TestResize (0.69s)
22:26:41 [2019-12-30T22:26:41.396Z] === RUN   TestResizeWithInvalidSize
22:26:41 [2019-12-30T22:26:41.681Z] --- PASS: TestResizeWithInvalidSize (0.67s)
22:26:41 [2019-12-30T22:26:41.681Z] === RUN   TestResizeWhenContainerNotStarted
22:26:42 [2019-12-30T22:26:42.700Z] --- PASS: TestResizeWhenContainerNotStarted (0.66s)
22:26:42 [2019-12-30T22:26:42.700Z] === RUN   TestDaemonRestartKillContainers
22:26:42 [2019-12-30T22:26:42.700Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
22:26:42 [2019-12-30T22:26:42.700Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
22:26:42 [2019-12-30T22:26:42.700Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
22:26:42 [2019-12-30T22:26:42.700Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
22:26:42 [2019-12-30T22:26:42.700Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
22:26:42 [2019-12-30T22:26:42.700Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
22:26:42 [2019-12-30T22:26:42.700Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
22:26:42 [2019-12-30T22:26:42.700Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
22:26:42 [2019-12-30T22:26:42.700Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
22:26:42 [2019-12-30T22:26:42.700Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
22:26:42 [2019-12-30T22:26:42.700Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
22:26:42 [2019-12-30T22:26:42.700Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
22:26:42 [2019-12-30T22:26:42.700Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
22:26:42 [2019-12-30T22:26:42.700Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
22:26:42 [2019-12-30T22:26:42.700Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
22:26:42 [2019-12-30T22:26:42.700Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
22:26:42 [2019-12-30T22:26:42.700Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
22:26:42 [2019-12-30T22:26:42.700Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
22:26:42 [2019-12-30T22:26:42.700Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
22:26:42 [2019-12-30T22:26:42.700Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
22:26:42 [2019-12-30T22:26:42.700Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
22:26:42 [2019-12-30T22:26:42.700Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
22:26:42 [2019-12-30T22:26:42.700Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
22:26:42 [2019-12-30T22:26:42.700Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
22:26:42 [2019-12-30T22:26:42.700Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
22:26:42 [2019-12-30T22:26:42.700Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
22:26:42 [2019-12-30T22:26:42.700Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
22:26:42 [2019-12-30T22:26:42.700Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
22:26:44 [2019-12-30T22:26:44.745Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
22:26:46 [2019-12-30T22:26:46.268Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
22:26:46 [2019-12-30T22:26:46.268Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
22:26:46 [2019-12-30T22:26:46.562Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
22:26:47 [2019-12-30T22:26:47.591Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
22:26:47 [2019-12-30T22:26:47.883Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
22:26:50 [2019-12-30T22:26:50.791Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
22:26:50 [2019-12-30T22:26:50.791Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
22:26:54 [2019-12-30T22:26:54.268Z] --- PASS: TestDaemonRestartKillContainers (0.00s)
22:26:54 [2019-12-30T22:26:54.268Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon (1.92s)
22:26:54 [2019-12-30T22:26:54.268Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon (3.53s)
22:26:54 [2019-12-30T22:26:54.268Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon (1.99s)
22:26:54 [2019-12-30T22:26:54.268Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon (4.05s)
22:26:54 [2019-12-30T22:26:54.268Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon (5.11s)
22:26:54 [2019-12-30T22:26:54.268Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon (1.96s)
22:26:54 [2019-12-30T22:26:54.268Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon (4.14s)
22:26:54 [2019-12-30T22:26:54.268Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon (4.38s)
22:26:54 [2019-12-30T22:26:54.268Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon (3.41s)
22:26:54 [2019-12-30T22:26:54.268Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon (4.21s)
22:26:54 [2019-12-30T22:26:54.268Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon (2.43s)
22:26:54 [2019-12-30T22:26:54.268Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon (3.22s)
22:26:54 [2019-12-30T22:26:54.268Z] === RUN   TestCgroupNamespacesRun
22:26:55 [2019-12-30T22:26:55.750Z] --- PASS: TestCgroupNamespacesRun (1.62s)
22:26:55 [2019-12-30T22:26:55.750Z] === RUN   TestCgroupNamespacesRunPrivileged
22:26:57 [2019-12-30T22:26:57.232Z] --- PASS: TestCgroupNamespacesRunPrivileged (1.60s)
22:26:57 [2019-12-30T22:26:57.232Z] === RUN   TestCgroupNamespacesRunDaemonHostMode
22:26:58 [2019-12-30T22:26:58.718Z] --- PASS: TestCgroupNamespacesRunDaemonHostMode (1.65s)
22:26:58 [2019-12-30T22:26:58.719Z] === RUN   TestCgroupNamespacesRunHostMode
22:27:00 [2019-12-30T22:27:00.761Z] --- PASS: TestCgroupNamespacesRunHostMode (1.64s)
22:27:00 [2019-12-30T22:27:00.761Z] === RUN   TestCgroupNamespacesRunPrivateMode
22:27:02 [2019-12-30T22:27:02.247Z] --- PASS: TestCgroupNamespacesRunPrivateMode (1.60s)
22:27:02 [2019-12-30T22:27:02.247Z] === RUN   TestCgroupNamespacesRunPrivilegedAndPrivate
22:27:02 [2019-12-30T22:27:02.872Z] --- PASS: TestCgroupNamespacesRunPrivilegedAndPrivate (0.88s)
22:27:02 [2019-12-30T22:27:02.872Z] === RUN   TestCgroupNamespacesRunInvalidMode
22:27:03 [2019-12-30T22:27:03.896Z] --- PASS: TestCgroupNamespacesRunInvalidMode (0.90s)
22:27:03 [2019-12-30T22:27:03.896Z] === RUN   TestCgroupNamespacesRunOlderClient
22:27:05 [2019-12-30T22:27:05.389Z] --- PASS: TestCgroupNamespacesRunOlderClient (1.63s)
22:27:05 [2019-12-30T22:27:05.389Z] === RUN   TestKernelTCPMemory
22:27:06 [2019-12-30T22:27:06.410Z] --- PASS: TestKernelTCPMemory (0.82s)
22:27:06 [2019-12-30T22:27:06.410Z] === RUN   TestNISDomainname
22:27:07 [2019-12-30T22:27:07.033Z] --- PASS: TestNISDomainname (0.89s)
22:27:07 [2019-12-30T22:27:07.033Z] === RUN   TestHostnameDnsResolution
22:27:08 [2019-12-30T22:27:08.531Z] --- PASS: TestHostnameDnsResolution (1.09s)
22:27:08 [2019-12-30T22:27:08.531Z] === RUN   TestStats
22:27:10 [2019-12-30T22:27:10.569Z] --- PASS: TestStats (2.11s)
22:27:10 [2019-12-30T22:27:10.569Z] === RUN   TestStopContainerWithTimeout
22:27:10 [2019-12-30T22:27:10.569Z] === RUN   TestStopContainerWithTimeout/0
22:27:10 [2019-12-30T22:27:10.569Z] === PAUSE TestStopContainerWithTimeout/0
22:27:10 [2019-12-30T22:27:10.569Z] === RUN   TestStopContainerWithTimeout/1
22:27:10 [2019-12-30T22:27:10.569Z] === PAUSE TestStopContainerWithTimeout/1
22:27:10 [2019-12-30T22:27:10.569Z] === RUN   TestStopContainerWithTimeout/3
22:27:10 [2019-12-30T22:27:10.569Z] === PAUSE TestStopContainerWithTimeout/3
22:27:10 [2019-12-30T22:27:10.569Z] === RUN   TestStopContainerWithTimeout/-1
22:27:10 [2019-12-30T22:27:10.569Z] === PAUSE TestStopContainerWithTimeout/-1
22:27:10 [2019-12-30T22:27:10.569Z] === CONT  TestStopContainerWithTimeout/0
22:27:10 [2019-12-30T22:27:10.569Z] === CONT  TestStopContainerWithTimeout/-1
22:27:10 [2019-12-30T22:27:10.569Z] === CONT  TestStopContainerWithTimeout/1
22:27:10 [2019-12-30T22:27:10.569Z] === CONT  TestStopContainerWithTimeout/3
22:27:14 [2019-12-30T22:27:14.051Z] --- PASS: TestStopContainerWithTimeout (0.03s)
22:27:14 [2019-12-30T22:27:14.051Z]     --- PASS: TestStopContainerWithTimeout/0 (1.21s)
22:27:14 [2019-12-30T22:27:14.051Z]     --- PASS: TestStopContainerWithTimeout/1 (2.10s)
22:27:14 [2019-12-30T22:27:14.051Z]     --- PASS: TestStopContainerWithTimeout/-1 (3.15s)
22:27:14 [2019-12-30T22:27:14.051Z]     --- PASS: TestStopContainerWithTimeout/3 (3.24s)
22:27:14 [2019-12-30T22:27:14.051Z] === RUN   TestDeleteDevicemapper
22:27:14 [2019-12-30T22:27:14.051Z] --- SKIP: TestDeleteDevicemapper (0.00s)
22:27:14 [2019-12-30T22:27:14.051Z]     stop_linux_test.go:74: testEnv.DaemonInfo.Driver != "devicemapper"
22:27:14 [2019-12-30T22:27:14.051Z] === RUN   TestStopContainerWithRestartPolicyAlways
22:27:16 [2019-12-30T22:27:16.107Z] --- PASS: TestStopContainerWithRestartPolicyAlways (2.42s)
22:27:16 [2019-12-30T22:27:16.108Z] === RUN   TestUpdateMemory
22:27:17 [2019-12-30T22:27:17.125Z] --- PASS: TestUpdateMemory (0.98s)
22:27:17 [2019-12-30T22:27:17.125Z] === RUN   TestUpdateCPUQuota
22:27:18 [2019-12-30T22:27:18.141Z] --- PASS: TestUpdateCPUQuota (1.23s)
22:27:18 [2019-12-30T22:27:18.141Z] === RUN   TestUpdatePidsLimit
22:27:18 [2019-12-30T22:27:18.141Z] === RUN   TestUpdatePidsLimit/update_from_none
22:27:18 [2019-12-30T22:27:18.762Z] === RUN   TestUpdatePidsLimit/no_change
22:27:18 [2019-12-30T22:27:18.762Z] === RUN   TestUpdatePidsLimit/update_lower
22:27:19 [2019-12-30T22:27:19.403Z] === RUN   TestUpdatePidsLimit/update_on_old_api_ignores_value
22:27:19 [2019-12-30T22:27:19.689Z] === RUN   TestUpdatePidsLimit/unset_limit_with_zero
22:27:19 [2019-12-30T22:27:19.974Z] === RUN   TestUpdatePidsLimit/unset_limit_with_minus_one
22:27:20 [2019-12-30T22:27:20.593Z] === RUN   TestUpdatePidsLimit/unset_limit_with_minus_two
22:27:21 [2019-12-30T22:27:21.609Z] --- PASS: TestUpdatePidsLimit (3.53s)
22:27:21 [2019-12-30T22:27:21.609Z]     --- PASS: TestUpdatePidsLimit/update_from_none (0.34s)
22:27:21 [2019-12-30T22:27:21.609Z]     --- PASS: TestUpdatePidsLimit/no_change (0.31s)
22:27:21 [2019-12-30T22:27:21.609Z]     --- PASS: TestUpdatePidsLimit/update_lower (0.56s)
22:27:21 [2019-12-30T22:27:21.609Z]     --- PASS: TestUpdatePidsLimit/update_on_old_api_ignores_value (0.32s)
22:27:21 [2019-12-30T22:27:21.609Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_zero (0.35s)
22:27:21 [2019-12-30T22:27:21.609Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_minus_one (0.32s)
22:27:21 [2019-12-30T22:27:21.609Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_minus_two (0.31s)
22:27:21 [2019-12-30T22:27:21.609Z] === RUN   TestUpdateRestartPolicy
22:27:34 [2019-12-30T22:27:34.193Z] --- PASS: TestUpdateRestartPolicy (12.03s)
22:27:34 [2019-12-30T22:27:34.193Z] === RUN   TestUpdateRestartWithAutoRemove
22:27:34 [2019-12-30T22:27:34.486Z] --- PASS: TestUpdateRestartWithAutoRemove (0.69s)
22:27:34 [2019-12-30T22:27:34.487Z] === RUN   TestWaitNonBlocked
22:27:34 [2019-12-30T22:27:34.487Z] === RUN   TestWaitNonBlocked/wait-nonblocking-exit-0
22:27:34 [2019-12-30T22:27:34.487Z] === PAUSE TestWaitNonBlocked/wait-nonblocking-exit-0
22:27:34 [2019-12-30T22:27:34.487Z] === RUN   TestWaitNonBlocked/wait-nonblocking-exit-random
22:27:34 [2019-12-30T22:27:34.487Z] === PAUSE TestWaitNonBlocked/wait-nonblocking-exit-random
22:27:34 [2019-12-30T22:27:34.487Z] === CONT  TestWaitNonBlocked/wait-nonblocking-exit-0
22:27:34 [2019-12-30T22:27:34.487Z] === CONT  TestWaitNonBlocked/wait-nonblocking-exit-random
22:27:35 [2019-12-30T22:27:35.507Z] --- PASS: TestWaitNonBlocked (0.03s)
22:27:35 [2019-12-30T22:27:35.507Z]     --- PASS: TestWaitNonBlocked/wait-nonblocking-exit-0 (0.83s)
22:27:35 [2019-12-30T22:27:35.507Z]     --- PASS: TestWaitNonBlocked/wait-nonblocking-exit-random (0.89s)
22:27:35 [2019-12-30T22:27:35.507Z] === RUN   TestWaitBlocked
22:27:35 [2019-12-30T22:27:35.507Z] === RUN   TestWaitBlocked/test-wait-blocked-exit-zero
22:27:35 [2019-12-30T22:27:35.507Z] === PAUSE TestWaitBlocked/test-wait-blocked-exit-zero
22:27:35 [2019-12-30T22:27:35.507Z] === RUN   TestWaitBlocked/test-wait-blocked-exit-random
22:27:35 [2019-12-30T22:27:35.507Z] === PAUSE TestWaitBlocked/test-wait-blocked-exit-random
22:27:35 [2019-12-30T22:27:35.507Z] === CONT  TestWaitBlocked/test-wait-blocked-exit-zero
22:27:35 [2019-12-30T22:27:35.507Z] === CONT  TestWaitBlocked/test-wait-blocked-exit-random
22:27:36 [2019-12-30T22:27:36.523Z] --- PASS: TestWaitBlocked (0.03s)
22:27:36 [2019-12-30T22:27:36.523Z]     --- PASS: TestWaitBlocked/test-wait-blocked-exit-random (0.89s)
22:27:36 [2019-12-30T22:27:36.523Z]     --- PASS: TestWaitBlocked/test-wait-blocked-exit-zero (0.94s)
22:27:36 [2019-12-30T22:27:36.523Z] === CONT  TestContainerStartOnDaemonRestart
22:27:36 [2019-12-30T22:27:36.523Z] === CONT  TestIpcModeOlderClient
22:27:36 [2019-12-30T22:27:36.523Z] === CONT  TestDaemonRestartIpcMode
22:27:36 [2019-12-30T22:27:36.523Z] --- PASS: TestIpcModeOlderClient (0.15s)
22:27:40 [2019-12-30T22:27:40.016Z] --- PASS: TestContainerStartOnDaemonRestart (3.21s)
22:27:40 [2019-12-30T22:27:40.637Z] --- PASS: TestDaemonRestartIpcMode (4.29s)
22:27:40 [2019-12-30T22:27:40.637Z] PASS
22:27:40 [2019-12-30T22:27:40.637Z] 
22:27:40 [2019-12-30T22:27:40.637Z] === Skipped
22:27:40 [2019-12-30T22:27:40.637Z] === SKIP: ppc64le.integration.container TestCheckpoint (0.00s)
22:27:40 [2019-12-30T22:27:40.637Z]     checkpoint_test.go:33: TestCheckpoint is broken; see https://github.com/moby/moby/issues/38963
22:27:40 [2019-12-30T22:27:40.637Z] 
22:27:40 [2019-12-30T22:27:40.637Z] === SKIP: ppc64le.integration.container TestPauseFailsOnWindowsServerContainers (0.00s)
22:27:40 [2019-12-30T22:27:40.637Z]     pause_test.go:54: testEnv.DaemonInfo.OSType != "windows" || testEnv.DaemonInfo.Isolation != "process"
22:27:40 [2019-12-30T22:27:40.637Z] 
22:27:40 [2019-12-30T22:27:40.637Z] === SKIP: ppc64le.integration.container TestDeleteDevicemapper (0.00s)
22:27:40 [2019-12-30T22:27:40.637Z]     stop_linux_test.go:74: testEnv.DaemonInfo.Driver != "devicemapper"
22:27:40 [2019-12-30T22:27:40.637Z] 
22:27:40 [2019-12-30T22:27:40.637Z] 
22:27:40 [2019-12-30T22:27:40.637Z] DONE 197 tests, 3 skipped in 117.134s
22:27:40 [2019-12-30T22:27:40.637Z] Running /go/src/github.com/docker/docker/integration/image (ppc64le.integration.image) flags=-test.v -test.timeout=120m 
22:27:40 [2019-12-30T22:27:40.637Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-image-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-image-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.image -t ./test.main -test.v -test.timeout=120m
22:27:40 [2019-12-30T22:27:40.637Z] ++ set -e
22:27:40 [2019-12-30T22:27:40.637Z] ++ '[' -n 0 ']'
22:27:40 [2019-12-30T22:27:40.637Z] ++ set -x
22:27:40 [2019-12-30T22:27:40.637Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=ppc64le DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-image-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-image-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.image -t ./test.main -test.v -test.timeout=120m
22:27:40 [2019-12-30T22:27:40.924Z] INFO: Testing against a local daemon
22:27:40 [2019-12-30T22:27:40.924Z] === RUN   TestCommitInheritsEnv
22:27:41 [2019-12-30T22:27:41.212Z] --- PASS: TestCommitInheritsEnv (0.42s)
22:27:41 [2019-12-30T22:27:41.212Z] === RUN   TestImportExtremelyLargeImageWorks
22:27:41 [2019-12-30T22:27:41.212Z] === PAUSE TestImportExtremelyLargeImageWorks
22:27:41 [2019-12-30T22:27:41.212Z] === RUN   TestImagesFilterMultiReference
22:27:41 [2019-12-30T22:27:41.212Z] --- PASS: TestImagesFilterMultiReference (0.09s)
22:27:41 [2019-12-30T22:27:41.212Z] === RUN   TestImagePullPlatformInvalid
22:27:41 [2019-12-30T22:27:41.501Z] --- PASS: TestImagePullPlatformInvalid (0.05s)
22:27:41 [2019-12-30T22:27:41.501Z] === RUN   TestRemoveImageOrphaning
22:27:41 [2019-12-30T22:27:41.787Z] --- PASS: TestRemoveImageOrphaning (0.43s)
22:27:41 [2019-12-30T22:27:41.787Z] === RUN   TestRemoveImageGarbageCollector
22:27:41 [2019-12-30T22:27:41.787Z] --- SKIP: TestRemoveImageGarbageCollector (0.00s)
22:27:41 [2019-12-30T22:27:41.787Z]     remove_unix_test.go:36: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:27:41 [2019-12-30T22:27:41.787Z] === RUN   TestTagUnprefixedRepoByNameOrName
22:27:41 [2019-12-30T22:27:41.787Z] --- PASS: TestTagUnprefixedRepoByNameOrName (0.04s)
22:27:41 [2019-12-30T22:27:41.787Z] === RUN   TestTagInvalidReference
22:27:41 [2019-12-30T22:27:41.787Z] --- PASS: TestTagInvalidReference (0.03s)
22:27:41 [2019-12-30T22:27:41.787Z] === RUN   TestTagValidPrefixedRepo
22:27:42 [2019-12-30T22:27:42.072Z] --- PASS: TestTagValidPrefixedRepo (0.06s)
22:27:42 [2019-12-30T22:27:42.072Z] === RUN   TestTagExistedNameWithoutForce
22:27:42 [2019-12-30T22:27:42.072Z] --- PASS: TestTagExistedNameWithoutForce (0.05s)
22:27:42 [2019-12-30T22:27:42.072Z] === RUN   TestTagOfficialNames
22:27:42 [2019-12-30T22:27:42.072Z] --- PASS: TestTagOfficialNames (0.06s)
22:27:42 [2019-12-30T22:27:42.072Z] === RUN   TestTagMatchesDigest
22:27:42 [2019-12-30T22:27:42.072Z] --- PASS: TestTagMatchesDigest (0.03s)
22:27:42 [2019-12-30T22:27:42.072Z] === CONT  TestImportExtremelyLargeImageWorks
22:32:49 [2019-12-30T22:32:49.803Z] --- PASS: TestImportExtremelyLargeImageWorks (298.35s)
22:32:49 [2019-12-30T22:32:49.803Z] PASS
22:32:49 [2019-12-30T22:32:49.803Z] 
22:32:49 [2019-12-30T22:32:49.803Z] === Skipped
22:32:49 [2019-12-30T22:32:49.803Z] === SKIP: ppc64le.integration.image TestRemoveImageGarbageCollector (0.00s)
22:32:49 [2019-12-30T22:32:49.803Z]     remove_unix_test.go:36: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:32:49 [2019-12-30T22:32:49.803Z] 
22:32:49 [2019-12-30T22:32:49.803Z] 
22:32:49 [2019-12-30T22:32:49.803Z] DONE 12 tests, 1 skipped in 299.748s
22:32:49 [2019-12-30T22:32:49.803Z] Running /go/src/github.com/docker/docker/integration/network (ppc64le.integration.network) flags=-test.v -test.timeout=120m 
22:32:49 [2019-12-30T22:32:49.803Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-network-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-network-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.network -t ./test.main -test.v -test.timeout=120m
22:32:49 [2019-12-30T22:32:49.803Z] ++ set -e
22:32:49 [2019-12-30T22:32:49.803Z] ++ '[' -n 0 ']'
22:32:49 [2019-12-30T22:32:49.803Z] ++ set -x
22:32:49 [2019-12-30T22:32:49.803Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=ppc64le DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-network-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-network-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.network -t ./test.main -test.v -test.timeout=120m
22:32:49 [2019-12-30T22:32:49.803Z] INFO: Testing against a local daemon
22:32:49 [2019-12-30T22:32:49.803Z] === RUN   TestNetworkCreateDelete
22:32:49 [2019-12-30T22:32:49.803Z] --- PASS: TestNetworkCreateDelete (0.21s)
22:32:49 [2019-12-30T22:32:49.803Z] === RUN   TestDockerNetworkDeletePreferID
22:32:49 [2019-12-30T22:32:49.803Z] --- PASS: TestDockerNetworkDeletePreferID (0.59s)
22:32:49 [2019-12-30T22:32:49.803Z] === RUN   TestInspectNetwork
22:32:49 [2019-12-30T22:32:49.803Z] === RUN   TestInspectNetwork/full_network_id
22:32:49 [2019-12-30T22:32:49.803Z] === RUN   TestInspectNetwork/partial_network_id
22:32:49 [2019-12-30T22:32:49.803Z] === RUN   TestInspectNetwork/network_name
22:32:49 [2019-12-30T22:32:49.803Z] === RUN   TestInspectNetwork/network_name_and_swarm_scope
22:32:49 [2019-12-30T22:32:49.803Z] --- PASS: TestInspectNetwork (7.58s)
22:32:49 [2019-12-30T22:32:49.803Z]     --- PASS: TestInspectNetwork/full_network_id (0.00s)
22:32:49 [2019-12-30T22:32:49.803Z]     --- PASS: TestInspectNetwork/partial_network_id (0.00s)
22:32:49 [2019-12-30T22:32:49.803Z]     --- PASS: TestInspectNetwork/network_name (0.00s)
22:32:49 [2019-12-30T22:32:49.803Z]     --- PASS: TestInspectNetwork/network_name_and_swarm_scope (0.00s)
22:32:49 [2019-12-30T22:32:49.803Z] === RUN   TestRunContainerWithBridgeNone
22:32:51 [2019-12-30T22:32:51.286Z] --- PASS: TestRunContainerWithBridgeNone (2.30s)
22:32:51 [2019-12-30T22:32:51.286Z] === RUN   TestNetworkInvalidJSON
22:32:51 [2019-12-30T22:32:51.286Z] === RUN   TestNetworkInvalidJSON//networks/create
22:32:51 [2019-12-30T22:32:51.286Z] === PAUSE TestNetworkInvalidJSON//networks/create
22:32:51 [2019-12-30T22:32:51.286Z] === RUN   TestNetworkInvalidJSON//networks/bridge/connect
22:32:51 [2019-12-30T22:32:51.286Z] === PAUSE TestNetworkInvalidJSON//networks/bridge/connect
22:32:51 [2019-12-30T22:32:51.286Z] === RUN   TestNetworkInvalidJSON//networks/bridge/disconnect
22:32:51 [2019-12-30T22:32:51.286Z] === PAUSE TestNetworkInvalidJSON//networks/bridge/disconnect
22:32:51 [2019-12-30T22:32:51.286Z] === CONT  TestNetworkInvalidJSON//networks/create
22:32:51 [2019-12-30T22:32:51.286Z] === CONT  TestNetworkInvalidJSON//networks/bridge/disconnect
22:32:51 [2019-12-30T22:32:51.286Z] === CONT  TestNetworkInvalidJSON//networks/bridge/connect
22:32:51 [2019-12-30T22:32:51.286Z] --- PASS: TestNetworkInvalidJSON (0.04s)
22:32:51 [2019-12-30T22:32:51.286Z]     --- PASS: TestNetworkInvalidJSON//networks/bridge/disconnect (0.00s)
22:32:51 [2019-12-30T22:32:51.286Z]     --- PASS: TestNetworkInvalidJSON//networks/bridge/connect (0.00s)
22:32:51 [2019-12-30T22:32:51.286Z]     --- PASS: TestNetworkInvalidJSON//networks/create (0.00s)
22:32:51 [2019-12-30T22:32:51.286Z] === RUN   TestDaemonRestartWithLiveRestore
22:32:52 [2019-12-30T22:32:52.324Z] --- PASS: TestDaemonRestartWithLiveRestore (1.05s)
22:32:52 [2019-12-30T22:32:52.324Z] === RUN   TestDaemonDefaultNetworkPools
22:32:53 [2019-12-30T22:32:53.341Z] --- PASS: TestDaemonDefaultNetworkPools (0.81s)
22:32:53 [2019-12-30T22:32:53.342Z] === RUN   TestDaemonRestartWithExistingNetwork
22:32:54 [2019-12-30T22:32:54.361Z] --- PASS: TestDaemonRestartWithExistingNetwork (1.22s)
22:32:54 [2019-12-30T22:32:54.361Z] === RUN   TestDaemonRestartWithExistingNetworkWithDefaultPoolRange
22:32:55 [2019-12-30T22:32:55.847Z] --- PASS: TestDaemonRestartWithExistingNetworkWithDefaultPoolRange (1.51s)
22:32:55 [2019-12-30T22:32:55.847Z] === RUN   TestDaemonWithBipAndDefaultNetworkPool
22:32:56 [2019-12-30T22:32:56.468Z] --- PASS: TestDaemonWithBipAndDefaultNetworkPool (0.58s)
22:32:56 [2019-12-30T22:32:56.468Z] === RUN   TestServiceWithPredefinedNetwork
22:32:59 [2019-12-30T22:32:59.163Z] --- PASS: TestServiceWithPredefinedNetwork (2.36s)
22:32:59 [2019-12-30T22:32:59.163Z] === RUN   TestServiceRemoveKeepsIngressNetwork
22:32:59 [2019-12-30T22:32:59.163Z] --- SKIP: TestServiceRemoveKeepsIngressNetwork (0.00s)
22:32:59 [2019-12-30T22:32:59.163Z]     service_test.go:230: FLAKY_TEST
22:32:59 [2019-12-30T22:32:59.163Z] === RUN   TestServiceWithDataPathPortInit
22:33:14 [2019-12-30T22:33:14.421Z] --- PASS: TestServiceWithDataPathPortInit (15.54s)
22:33:14 [2019-12-30T22:33:14.421Z] === RUN   TestServiceWithDefaultAddressPoolInit
22:33:22 [2019-12-30T22:33:22.844Z] --- PASS: TestServiceWithDefaultAddressPoolInit (8.35s)
22:33:22 [2019-12-30T22:33:22.844Z]     service_test.go:418: TestServiceWithDefaultAddressPoolInit: NetworkInspect: {Name:sthiraTestServiceWithDefaultAddressPoolInit ID:qlvm3474oi2t4ix0m95edzya6 Created:2019-12-30 22:33:15.44352596 +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[5f2318cc2198ef0c9073534df45ffbd09d57eacebd7b54da1fc565c4311c2fc6:{Name:TestServiceTestServiceWithDefaultAddressPoolInit.1.vgahfhs562pfjrru50pkhsnnr EndpointID:49fdb4a136d8e3e46aca4b5e011774f43bf196a2d25eed111a1ab0d58ff2c0f9 MacAddress:02:42:14:14:00:03 IPv4Address:20.20.0.3/24 IPv6Address:} lb-sthiraTestServiceWithDefaultAddressPoolInit:{Name:sthiraTestServiceWithDefaultAddressPoolInit-endpoint EndpointID:0713837b9d9804b92fa3418c9f0deed925a062334397d189aca7f1d63a36d8de 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:af9ce7019110 IP:127.0.0.1}] Services:map[TestServiceTestServiceWithDefaultAddressPoolInit:{VIP:20.20.0.2 Ports:[] LocalLBIndex:256 Tasks:[{Name:TestServiceTestServiceWithDefaultAddressPoolInit.1.vgahfhs562pfjrru50pkhsnnr EndpointID:49fdb4a136d8e3e46aca4b5e011774f43bf196a2d25eed111a1ab0d58ff2c0f9 EndpointIP:20.20.0.3 Info:map[Host IP:127.0.0.1]}]}]}
22:33:22 [2019-12-30T22:33:22.844Z] PASS
22:33:22 [2019-12-30T22:33:22.844Z] 
22:33:22 [2019-12-30T22:33:22.844Z] === Skipped
22:33:22 [2019-12-30T22:33:22.844Z] === SKIP: ppc64le.integration.network TestServiceRemoveKeepsIngressNetwork (0.00s)
22:33:22 [2019-12-30T22:33:22.844Z]     service_test.go:230: FLAKY_TEST
22:33:22 [2019-12-30T22:33:22.844Z] 
22:33:22 [2019-12-30T22:33:22.844Z] 
22:33:22 [2019-12-30T22:33:22.844Z] DONE 21 tests, 1 skipped in 42.225s
22:33:22 [2019-12-30T22:33:22.844Z] Running /go/src/github.com/docker/docker/integration/network/ipvlan (ppc64le.integration.network.ipvlan) flags=-test.v -test.timeout=120m 
22:33:22 [2019-12-30T22:33:22.844Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-network-ipvlan-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-network-ipvlan-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.network.ipvlan -t ./test.main -test.v -test.timeout=120m
22:33:22 [2019-12-30T22:33:22.844Z] ++ set -e
22:33:22 [2019-12-30T22:33:22.844Z] ++ '[' -n 0 ']'
22:33:22 [2019-12-30T22:33:22.844Z] ++ set -x
22:33:22 [2019-12-30T22:33:22.844Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=ppc64le DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-network-ipvlan-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-network-ipvlan-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.network.ipvlan -t ./test.main -test.v -test.timeout=120m
22:33:22 [2019-12-30T22:33:22.844Z] INFO: Testing against a local daemon
22:33:22 [2019-12-30T22:33:22.844Z] === RUN   TestDockerNetworkIpvlanPersistance
22:33:22 [2019-12-30T22:33:22.844Z] --- SKIP: TestDockerNetworkIpvlanPersistance (0.00s)
22:33:22 [2019-12-30T22:33:22.844Z]     ipvlan_test.go:26: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
22:33:22 [2019-12-30T22:33:22.844Z] === RUN   TestDockerNetworkIpvlan
22:33:22 [2019-12-30T22:33:22.844Z] --- SKIP: TestDockerNetworkIpvlan (0.00s)
22:33:22 [2019-12-30T22:33:22.844Z]     ipvlan_test.go:53: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
22:33:22 [2019-12-30T22:33:22.844Z] PASS
22:33:22 [2019-12-30T22:33:22.844Z] 
22:33:22 [2019-12-30T22:33:22.844Z] === Skipped
22:33:22 [2019-12-30T22:33:22.844Z] === SKIP: ppc64le.integration.network.ipvlan TestDockerNetworkIpvlanPersistance (0.00s)
22:33:22 [2019-12-30T22:33:22.844Z]     ipvlan_test.go:26: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
22:33:22 [2019-12-30T22:33:22.844Z] 
22:33:22 [2019-12-30T22:33:22.844Z] === SKIP: ppc64le.integration.network.ipvlan TestDockerNetworkIpvlan (0.00s)
22:33:22 [2019-12-30T22:33:22.844Z]     ipvlan_test.go:53: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
22:33:22 [2019-12-30T22:33:22.844Z] 
22:33:22 [2019-12-30T22:33:22.844Z] 
22:33:22 [2019-12-30T22:33:22.844Z] DONE 2 tests, 2 skipped in 0.107s
22:33:22 [2019-12-30T22:33:22.844Z] Running /go/src/github.com/docker/docker/integration/network/macvlan (ppc64le.integration.network.macvlan) flags=-test.v -test.timeout=120m 
22:33:22 [2019-12-30T22:33:22.844Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-network-macvlan-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-network-macvlan-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.network.macvlan -t ./test.main -test.v -test.timeout=120m
22:33:22 [2019-12-30T22:33:22.844Z] ++ set -e
22:33:22 [2019-12-30T22:33:22.844Z] ++ '[' -n 0 ']'
22:33:22 [2019-12-30T22:33:22.844Z] ++ set -x
22:33:22 [2019-12-30T22:33:22.844Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=ppc64le DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-network-macvlan-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-network-macvlan-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.network.macvlan -t ./test.main -test.v -test.timeout=120m
22:33:22 [2019-12-30T22:33:22.844Z] INFO: Testing against a local daemon
22:33:22 [2019-12-30T22:33:22.844Z] === RUN   TestDockerNetworkMacvlanPersistance
22:33:24 [2019-12-30T22:33:24.331Z] --- PASS: TestDockerNetworkMacvlanPersistance (1.48s)
22:33:24 [2019-12-30T22:33:24.331Z] === RUN   TestDockerNetworkMacvlan
22:33:25 [2019-12-30T22:33:25.351Z] === RUN   TestDockerNetworkMacvlan/Subinterface
22:33:26 [2019-12-30T22:33:26.150Z] === RUN   TestDockerNetworkMacvlan/OverlapParent
22:33:27 [2019-12-30T22:33:27.171Z] === RUN   TestDockerNetworkMacvlan/NilParent
22:33:29 [2019-12-30T22:33:29.873Z] === RUN   TestDockerNetworkMacvlan/InternalMode
22:33:33 [2019-12-30T22:33:33.342Z] === RUN   TestDockerNetworkMacvlan/MultiSubnet
22:33:37 [2019-12-30T22:33:37.764Z] === RUN   TestDockerNetworkMacvlan/Addressing
22:33:38 [2019-12-30T22:33:38.781Z] --- PASS: TestDockerNetworkMacvlan (14.52s)
22:33:38 [2019-12-30T22:33:38.781Z]     --- PASS: TestDockerNetworkMacvlan/Subinterface (0.08s)
22:33:38 [2019-12-30T22:33:38.781Z]     --- PASS: TestDockerNetworkMacvlan/OverlapParent (0.09s)
22:33:38 [2019-12-30T22:33:38.782Z]     --- PASS: TestDockerNetworkMacvlan/NilParent (1.14s)
22:33:38 [2019-12-30T22:33:38.782Z]     --- PASS: TestDockerNetworkMacvlan/InternalMode (2.15s)
22:33:38 [2019-12-30T22:33:38.782Z]     --- PASS: TestDockerNetworkMacvlan/MultiSubnet (3.08s)
22:33:38 [2019-12-30T22:33:38.782Z]     --- PASS: TestDockerNetworkMacvlan/Addressing (0.88s)
22:33:38 [2019-12-30T22:33:38.782Z] PASS
22:33:38 [2019-12-30T22:33:38.782Z] 
22:33:38 [2019-12-30T22:33:38.782Z] DONE 8 tests in 16.091s
22:33:39 [2019-12-30T22:33:39.069Z] Running /go/src/github.com/docker/docker/integration/plugin (ppc64le.integration.plugin) flags=-test.v -test.timeout=120m 
22:33:39 [2019-12-30T22:33:39.069Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-plugin-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-plugin-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.plugin -t ./test.main -test.v -test.timeout=120m
22:33:39 [2019-12-30T22:33:39.069Z] ++ set -e
22:33:39 [2019-12-30T22:33:39.069Z] ++ '[' -n 0 ']'
22:33:39 [2019-12-30T22:33:39.069Z] ++ set -x
22:33:39 [2019-12-30T22:33:39.069Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=ppc64le DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-plugin-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-plugin-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.plugin -t ./test.main -test.v -test.timeout=120m
22:33:39 [2019-12-30T22:33:39.069Z] testing: warning: no tests to run
22:33:39 [2019-12-30T22:33:39.069Z] PASS
22:33:39 [2019-12-30T22:33:39.069Z] 
22:33:39 [2019-12-30T22:33:39.069Z] DONE 0 tests in 0.015s
22:33:39 [2019-12-30T22:33:39.069Z] Running /go/src/github.com/docker/docker/integration/plugin/authz (ppc64le.integration.plugin.authz) flags=-test.v -test.timeout=120m 
22:33:39 [2019-12-30T22:33:39.069Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-plugin-authz-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-plugin-authz-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.plugin.authz -t ./test.main -test.v -test.timeout=120m
22:33:39 [2019-12-30T22:33:39.069Z] ++ set -e
22:33:39 [2019-12-30T22:33:39.069Z] ++ '[' -n 0 ']'
22:33:39 [2019-12-30T22:33:39.069Z] ++ set -x
22:33:39 [2019-12-30T22:33:39.069Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=ppc64le DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-plugin-authz-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-plugin-authz-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.plugin.authz -t ./test.main -test.v -test.timeout=120m
22:33:39 [2019-12-30T22:33:39.069Z] INFO: Testing against a local daemon
22:33:39 [2019-12-30T22:33:39.069Z] === RUN   TestAuthZPluginAllowRequest
22:33:40 [2019-12-30T22:33:40.558Z] --- PASS: TestAuthZPluginAllowRequest (1.59s)
22:33:40 [2019-12-30T22:33:40.558Z] === RUN   TestAuthZPluginTLS
22:33:41 [2019-12-30T22:33:41.179Z] --- PASS: TestAuthZPluginTLS (0.60s)
22:33:41 [2019-12-30T22:33:41.179Z] === RUN   TestAuthZPluginDenyRequest
22:33:41 [2019-12-30T22:33:41.797Z] --- PASS: TestAuthZPluginDenyRequest (0.56s)
22:33:41 [2019-12-30T22:33:41.797Z] === RUN   TestAuthZPluginAPIDenyResponse
22:33:42 [2019-12-30T22:33:42.421Z] --- PASS: TestAuthZPluginAPIDenyResponse (0.57s)
22:33:42 [2019-12-30T22:33:42.421Z] === RUN   TestAuthZPluginDenyResponse
22:33:43 [2019-12-30T22:33:43.044Z] --- PASS: TestAuthZPluginDenyResponse (0.58s)
22:33:43 [2019-12-30T22:33:43.044Z] === RUN   TestAuthZPluginAllowEventStream
22:33:44 [2019-12-30T22:33:44.526Z] --- PASS: TestAuthZPluginAllowEventStream (1.59s)
22:33:44 [2019-12-30T22:33:44.526Z] === RUN   TestAuthZPluginErrorResponse
22:33:45 [2019-12-30T22:33:45.153Z] --- PASS: TestAuthZPluginErrorResponse (0.58s)
22:33:45 [2019-12-30T22:33:45.153Z] === RUN   TestAuthZPluginErrorRequest
22:33:45 [2019-12-30T22:33:45.773Z] --- PASS: TestAuthZPluginErrorRequest (0.56s)
22:33:45 [2019-12-30T22:33:45.773Z] === RUN   TestAuthZPluginEnsureNoDuplicatePluginRegistration
22:33:46 [2019-12-30T22:33:46.393Z] --- PASS: TestAuthZPluginEnsureNoDuplicatePluginRegistration (0.58s)
22:33:46 [2019-12-30T22:33:46.393Z] === RUN   TestAuthZPluginEnsureLoadImportWorking
22:33:48 [2019-12-30T22:33:48.445Z] --- PASS: TestAuthZPluginEnsureLoadImportWorking (2.10s)
22:33:48 [2019-12-30T22:33:48.445Z] === RUN   TestAuthzPluginEnsureContainerCopyToFrom
22:33:50 [2019-12-30T22:33:50.496Z] --- PASS: TestAuthzPluginEnsureContainerCopyToFrom (2.06s)
22:33:50 [2019-12-30T22:33:50.496Z] === RUN   TestAuthZPluginHeader
22:33:51 [2019-12-30T22:33:51.511Z] --- PASS: TestAuthZPluginHeader (0.99s)
22:33:51 [2019-12-30T22:33:51.511Z] === RUN   TestAuthZPluginV2AllowNonVolumeRequest
22:33:51 [2019-12-30T22:33:51.511Z] --- SKIP: TestAuthZPluginV2AllowNonVolumeRequest (0.00s)
22:33:51 [2019-12-30T22:33:51.511Z]     authz_plugin_v2_test.go:43: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:33:51 [2019-12-30T22:33:51.511Z] === RUN   TestAuthZPluginV2Disable
22:33:51 [2019-12-30T22:33:51.511Z] --- SKIP: TestAuthZPluginV2Disable (0.00s)
22:33:51 [2019-12-30T22:33:51.511Z]     authz_plugin_v2_test.go:65: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:33:51 [2019-12-30T22:33:51.511Z] === RUN   TestAuthZPluginV2RejectVolumeRequests
22:33:51 [2019-12-30T22:33:51.511Z] --- SKIP: TestAuthZPluginV2RejectVolumeRequests (0.00s)
22:33:51 [2019-12-30T22:33:51.511Z]     authz_plugin_v2_test.go:91: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:33:51 [2019-12-30T22:33:51.511Z] === RUN   TestAuthZPluginV2BadManifestFailsDaemonStart
22:33:51 [2019-12-30T22:33:51.511Z] --- SKIP: TestAuthZPluginV2BadManifestFailsDaemonStart (0.00s)
22:33:51 [2019-12-30T22:33:51.511Z]     authz_plugin_v2_test.go:126: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:33:51 [2019-12-30T22:33:51.511Z] === RUN   TestAuthZPluginV2NonexistentFailsDaemonStart
22:34:10 [2019-12-30T22:34:10.025Z] --- PASS: TestAuthZPluginV2NonexistentFailsDaemonStart (16.86s)
22:34:10 [2019-12-30T22:34:10.026Z] PASS
22:34:10 [2019-12-30T22:34:10.026Z] 
22:34:10 [2019-12-30T22:34:10.026Z] === Skipped
22:34:10 [2019-12-30T22:34:10.026Z] === SKIP: ppc64le.integration.plugin.authz TestAuthZPluginV2AllowNonVolumeRequest (0.00s)
22:34:10 [2019-12-30T22:34:10.026Z]     authz_plugin_v2_test.go:43: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:34:10 [2019-12-30T22:34:10.026Z] 
22:34:10 [2019-12-30T22:34:10.026Z] === SKIP: ppc64le.integration.plugin.authz TestAuthZPluginV2Disable (0.00s)
22:34:10 [2019-12-30T22:34:10.026Z]     authz_plugin_v2_test.go:65: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:34:10 [2019-12-30T22:34:10.026Z] 
22:34:10 [2019-12-30T22:34:10.026Z] === SKIP: ppc64le.integration.plugin.authz TestAuthZPluginV2RejectVolumeRequests (0.00s)
22:34:10 [2019-12-30T22:34:10.026Z]     authz_plugin_v2_test.go:91: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:34:10 [2019-12-30T22:34:10.026Z] 
22:34:10 [2019-12-30T22:34:10.026Z] === SKIP: ppc64le.integration.plugin.authz TestAuthZPluginV2BadManifestFailsDaemonStart (0.00s)
22:34:10 [2019-12-30T22:34:10.026Z]     authz_plugin_v2_test.go:126: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:34:10 [2019-12-30T22:34:10.026Z] 
22:34:10 [2019-12-30T22:34:10.026Z] 
22:34:10 [2019-12-30T22:34:10.026Z] DONE 17 tests, 4 skipped in 29.316s
22:34:10 [2019-12-30T22:34:10.026Z] Running /go/src/github.com/docker/docker/integration/plugin/common (ppc64le.integration.plugin.common) flags=-test.v -test.timeout=120m 
22:34:10 [2019-12-30T22:34:10.026Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-plugin-common-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-plugin-common-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.plugin.common -t ./test.main -test.v -test.timeout=120m
22:34:10 [2019-12-30T22:34:10.026Z] ++ set -e
22:34:10 [2019-12-30T22:34:10.026Z] ++ '[' -n 0 ']'
22:34:10 [2019-12-30T22:34:10.026Z] ++ set -x
22:34:10 [2019-12-30T22:34:10.026Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=ppc64le DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-plugin-common-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-plugin-common-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.plugin.common -t ./test.main -test.v -test.timeout=120m
22:34:10 [2019-12-30T22:34:10.026Z] INFO: Testing against a local daemon
22:34:10 [2019-12-30T22:34:10.026Z] === RUN   TestPluginInvalidJSON
22:34:10 [2019-12-30T22:34:10.026Z] === RUN   TestPluginInvalidJSON//plugins/foobar/set
22:34:10 [2019-12-30T22:34:10.026Z] === PAUSE TestPluginInvalidJSON//plugins/foobar/set
22:34:10 [2019-12-30T22:34:10.026Z] === CONT  TestPluginInvalidJSON//plugins/foobar/set
22:34:10 [2019-12-30T22:34:10.026Z] --- PASS: TestPluginInvalidJSON (0.05s)
22:34:10 [2019-12-30T22:34:10.026Z]     --- PASS: TestPluginInvalidJSON//plugins/foobar/set (0.00s)
22:34:10 [2019-12-30T22:34:10.026Z] PASS
22:34:10 [2019-12-30T22:34:10.026Z] 
22:34:10 [2019-12-30T22:34:10.026Z] DONE 2 tests in 0.131s
22:34:10 [2019-12-30T22:34:10.026Z] Running /go/src/github.com/docker/docker/integration/plugin/graphdriver (ppc64le.integration.plugin.graphdriver) flags=-test.v -test.timeout=120m 
22:34:10 [2019-12-30T22:34:10.026Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-plugin-graphdriver-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-plugin-graphdriver-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.plugin.graphdriver -t ./test.main -test.v -test.timeout=120m
22:34:10 [2019-12-30T22:34:10.026Z] ++ set -e
22:34:10 [2019-12-30T22:34:10.026Z] ++ '[' -n 0 ']'
22:34:10 [2019-12-30T22:34:10.026Z] ++ set -x
22:34:10 [2019-12-30T22:34:10.026Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=ppc64le DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-plugin-graphdriver-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-plugin-graphdriver-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.plugin.graphdriver -t ./test.main -test.v -test.timeout=120m
22:34:10 [2019-12-30T22:34:10.026Z] INFO: Testing against a local daemon
22:34:10 [2019-12-30T22:34:10.026Z] === RUN   TestExternalGraphDriver
22:34:10 [2019-12-30T22:34:10.026Z] === RUN   TestExternalGraphDriver/json
22:34:11 [2019-12-30T22:34:11.042Z] === RUN   TestExternalGraphDriver/spec
22:34:13 [2019-12-30T22:34:13.078Z] === RUN   TestExternalGraphDriver/pull
22:34:15 [2019-12-30T22:34:15.121Z] --- PASS: TestExternalGraphDriver (6.53s)
22:34:15 [2019-12-30T22:34:15.121Z]     --- PASS: TestExternalGraphDriver/json (2.07s)
22:34:15 [2019-12-30T22:34:15.121Z]     --- PASS: TestExternalGraphDriver/spec (2.03s)
22:34:15 [2019-12-30T22:34:15.121Z]     --- PASS: TestExternalGraphDriver/pull (2.16s)
22:34:15 [2019-12-30T22:34:15.121Z] === RUN   TestGraphdriverPluginV2
22:34:15 [2019-12-30T22:34:15.121Z] --- SKIP: TestGraphdriverPluginV2 (0.07s)
22:34:15 [2019-12-30T22:34:15.121Z]     external_test.go:410: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:34:15 [2019-12-30T22:34:15.121Z] PASS
22:34:15 [2019-12-30T22:34:15.121Z] 
22:34:15 [2019-12-30T22:34:15.121Z] === Skipped
22:34:15 [2019-12-30T22:34:15.121Z] === SKIP: ppc64le.integration.plugin.graphdriver TestGraphdriverPluginV2 (0.07s)
22:34:15 [2019-12-30T22:34:15.121Z]     external_test.go:410: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:34:15 [2019-12-30T22:34:15.121Z] 
22:34:15 [2019-12-30T22:34:15.121Z] 
22:34:15 [2019-12-30T22:34:15.121Z] DONE 5 tests, 1 skipped in 6.706s
22:34:15 [2019-12-30T22:34:15.121Z] Running /go/src/github.com/docker/docker/integration/plugin/logging (ppc64le.integration.plugin.logging) flags=-test.v -test.timeout=120m 
22:34:15 [2019-12-30T22:34:15.121Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-plugin-logging-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-plugin-logging-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.plugin.logging -t ./test.main -test.v -test.timeout=120m
22:34:15 [2019-12-30T22:34:15.121Z] ++ set -e
22:34:15 [2019-12-30T22:34:15.121Z] ++ '[' -n 0 ']'
22:34:15 [2019-12-30T22:34:15.121Z] ++ set -x
22:34:15 [2019-12-30T22:34:15.121Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=ppc64le DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-plugin-logging-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-plugin-logging-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.plugin.logging -t ./test.main -test.v -test.timeout=120m
22:34:15 [2019-12-30T22:34:15.407Z] INFO: Testing against a local daemon
22:34:15 [2019-12-30T22:34:15.407Z] === RUN   TestContinueAfterPluginCrash
22:34:15 [2019-12-30T22:34:15.407Z] === PAUSE TestContinueAfterPluginCrash
22:34:15 [2019-12-30T22:34:15.407Z] === RUN   TestDaemonStartWithLogOpt
22:34:15 [2019-12-30T22:34:15.407Z] === PAUSE TestDaemonStartWithLogOpt
22:34:15 [2019-12-30T22:34:15.407Z] === CONT  TestContinueAfterPluginCrash
22:34:15 [2019-12-30T22:34:15.407Z] === CONT  TestDaemonStartWithLogOpt
22:34:34 [2019-12-30T22:34:34.131Z] --- PASS: TestDaemonStartWithLogOpt (16.11s)
22:34:36 [2019-12-30T22:34:36.164Z] --- PASS: TestContinueAfterPluginCrash (20.90s)
22:34:36 [2019-12-30T22:34:36.164Z] PASS
22:34:36 [2019-12-30T22:34:36.164Z] 
22:34:36 [2019-12-30T22:34:36.164Z] DONE 2 tests in 21.000s
22:34:36 [2019-12-30T22:34:36.164Z] Running /go/src/github.com/docker/docker/integration/plugin/volumes (ppc64le.integration.plugin.volumes) flags=-test.v -test.timeout=120m 
22:34:36 [2019-12-30T22:34:36.164Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-plugin-volumes-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-plugin-volumes-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.plugin.volumes -t ./test.main -test.v -test.timeout=120m
22:34:36 [2019-12-30T22:34:36.164Z] ++ set -e
22:34:36 [2019-12-30T22:34:36.164Z] ++ '[' -n 0 ']'
22:34:36 [2019-12-30T22:34:36.164Z] ++ set -x
22:34:36 [2019-12-30T22:34:36.165Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=ppc64le DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-plugin-volumes-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-plugin-volumes-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.plugin.volumes -t ./test.main -test.v -test.timeout=120m
22:34:36 [2019-12-30T22:34:36.452Z] INFO: Testing against a local daemon
22:34:36 [2019-12-30T22:34:36.452Z] === RUN   TestPluginWithDevMounts
22:34:36 [2019-12-30T22:34:36.452Z] === PAUSE TestPluginWithDevMounts
22:34:36 [2019-12-30T22:34:36.452Z] === CONT  TestPluginWithDevMounts
22:34:38 [2019-12-30T22:34:38.503Z] --- PASS: TestPluginWithDevMounts (2.26s)
22:34:38 [2019-12-30T22:34:38.503Z] PASS
22:34:38 [2019-12-30T22:34:38.503Z] 
22:34:38 [2019-12-30T22:34:38.503Z] DONE 1 tests in 2.362s
22:34:38 [2019-12-30T22:34:38.503Z] Running /go/src/github.com/docker/docker/integration/secret (ppc64le.integration.secret) flags=-test.v -test.timeout=120m 
22:34:38 [2019-12-30T22:34:38.503Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-secret-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-secret-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.secret -t ./test.main -test.v -test.timeout=120m
22:34:38 [2019-12-30T22:34:38.503Z] ++ set -e
22:34:38 [2019-12-30T22:34:38.503Z] ++ '[' -n 0 ']'
22:34:38 [2019-12-30T22:34:38.503Z] ++ set -x
22:34:38 [2019-12-30T22:34:38.503Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=ppc64le DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-secret-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-secret-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.secret -t ./test.main -test.v -test.timeout=120m
22:34:38 [2019-12-30T22:34:38.790Z] INFO: Testing against a local daemon
22:34:38 [2019-12-30T22:34:38.790Z] === RUN   TestSecretInspect
22:34:40 [2019-12-30T22:34:40.842Z] --- PASS: TestSecretInspect (2.26s)
22:34:40 [2019-12-30T22:34:40.842Z] === RUN   TestSecretList
22:34:43 [2019-12-30T22:34:43.536Z] --- PASS: TestSecretList (2.30s)
22:34:43 [2019-12-30T22:34:43.536Z] === RUN   TestSecretsCreateAndDelete
22:34:45 [2019-12-30T22:34:45.593Z] --- PASS: TestSecretsCreateAndDelete (2.30s)
22:34:45 [2019-12-30T22:34:45.593Z] === RUN   TestSecretsUpdate
22:34:47 [2019-12-30T22:34:47.634Z] --- PASS: TestSecretsUpdate (2.22s)
22:34:47 [2019-12-30T22:34:47.634Z] === RUN   TestTemplatedSecret
22:34:51 [2019-12-30T22:34:51.124Z] --- PASS: TestTemplatedSecret (2.74s)
22:34:51 [2019-12-30T22:34:51.124Z] === RUN   TestSecretCreateResolve
22:34:53 [2019-12-30T22:34:53.164Z] --- PASS: TestSecretCreateResolve (2.26s)
22:34:53 [2019-12-30T22:34:53.164Z] PASS
22:34:53 [2019-12-30T22:34:53.164Z] 
22:34:53 [2019-12-30T22:34:53.164Z] DONE 6 tests in 14.173s
22:34:53 [2019-12-30T22:34:53.164Z] Running /go/src/github.com/docker/docker/integration/service (ppc64le.integration.service) flags=-test.v -test.timeout=120m 
22:34:53 [2019-12-30T22:34:53.164Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-service-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-service-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.service -t ./test.main -test.v -test.timeout=120m
22:34:53 [2019-12-30T22:34:53.164Z] ++ set -e
22:34:53 [2019-12-30T22:34:53.164Z] ++ '[' -n 0 ']'
22:34:53 [2019-12-30T22:34:53.164Z] ++ set -x
22:34:53 [2019-12-30T22:34:53.164Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=ppc64le DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-service-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-service-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.service -t ./test.main -test.v -test.timeout=120m
22:34:53 [2019-12-30T22:34:53.164Z] INFO: Testing against a local daemon
22:34:53 [2019-12-30T22:34:53.164Z] === RUN   TestServiceCreateInit
22:34:53 [2019-12-30T22:34:53.164Z] === RUN   TestServiceCreateInit/daemonInitDisabled
22:34:57 [2019-12-30T22:34:57.593Z] === RUN   TestServiceCreateInit/daemonInitEnabled
22:35:01 [2019-12-30T22:35:01.092Z] --- PASS: TestServiceCreateInit (8.04s)
22:35:01 [2019-12-30T22:35:01.092Z]     --- PASS: TestServiceCreateInit/daemonInitDisabled (3.98s)
22:35:01 [2019-12-30T22:35:01.092Z]     --- PASS: TestServiceCreateInit/daemonInitEnabled (4.02s)
22:35:01 [2019-12-30T22:35:01.092Z] === RUN   TestCreateServiceMultipleTimes
22:35:19 [2019-12-30T22:35:19.600Z] --- PASS: TestCreateServiceMultipleTimes (17.19s)
22:35:19 [2019-12-30T22:35:19.600Z] === RUN   TestCreateServiceConflict
22:35:20 [2019-12-30T22:35:20.614Z] --- PASS: TestCreateServiceConflict (2.28s)
22:35:20 [2019-12-30T22:35:20.614Z] === RUN   TestCreateServiceMaxReplicas
22:35:23 [2019-12-30T22:35:23.315Z] --- PASS: TestCreateServiceMaxReplicas (3.00s)
22:35:23 [2019-12-30T22:35:23.315Z] === RUN   TestCreateWithDuplicateNetworkNames
22:35:38 [2019-12-30T22:35:38.561Z] --- PASS: TestCreateWithDuplicateNetworkNames (13.39s)
22:35:38 [2019-12-30T22:35:38.561Z] === RUN   TestCreateServiceSecretFileMode
22:35:39 [2019-12-30T22:35:39.576Z] --- PASS: TestCreateServiceSecretFileMode (2.56s)
22:35:39 [2019-12-30T22:35:39.576Z] === RUN   TestCreateServiceConfigFileMode
22:35:42 [2019-12-30T22:35:42.278Z] --- PASS: TestCreateServiceConfigFileMode (2.55s)
22:35:42 [2019-12-30T22:35:42.279Z] === RUN   TestCreateServiceSysctls
22:35:45 [2019-12-30T22:35:45.769Z] --- PASS: TestCreateServiceSysctls (3.49s)
22:35:45 [2019-12-30T22:35:45.769Z] === RUN   TestCreateServiceCapabilities
22:35:48 [2019-12-30T22:35:48.464Z] --- PASS: TestCreateServiceCapabilities (2.59s)
22:35:48 [2019-12-30T22:35:48.464Z] === RUN   TestInspect
22:35:51 [2019-12-30T22:35:51.179Z] --- PASS: TestInspect (2.91s)
22:35:51 [2019-12-30T22:35:51.179Z] === RUN   TestServiceListWithStatuses
22:35:51 [2019-12-30T22:35:51.179Z] --- SKIP: TestServiceListWithStatuses (0.00s)
22:35:51 [2019-12-30T22:35:51.179Z]     list_test.go:34: versions.LessThan(testEnv.DaemonInfo.ServerVersion, "1.41")
22:35:51 [2019-12-30T22:35:51.179Z] === RUN   TestDockerNetworkConnectAlias
22:35:55 [2019-12-30T22:35:55.590Z] --- PASS: TestDockerNetworkConnectAlias (4.56s)
22:35:55 [2019-12-30T22:35:55.590Z] === RUN   TestDockerNetworkReConnect
22:35:59 [2019-12-30T22:35:59.129Z] --- PASS: TestDockerNetworkReConnect (3.71s)
22:35:59 [2019-12-30T22:35:59.129Z] === RUN   TestServicePlugin
22:35:59 [2019-12-30T22:35:59.129Z] --- SKIP: TestServicePlugin (0.00s)
22:35:59 [2019-12-30T22:35:59.129Z]     plugin_test.go:28: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:35:59 [2019-12-30T22:35:59.129Z] === RUN   TestServiceUpdateLabel
22:36:01 [2019-12-30T22:36:01.825Z] --- PASS: TestServiceUpdateLabel (2.29s)
22:36:01 [2019-12-30T22:36:01.825Z] === RUN   TestServiceUpdateSecrets
22:36:17 [2019-12-30T22:36:17.088Z] --- PASS: TestServiceUpdateSecrets (14.72s)
22:36:17 [2019-12-30T22:36:17.088Z] === RUN   TestServiceUpdateConfigs
22:36:32 [2019-12-30T22:36:32.350Z] --- PASS: TestServiceUpdateConfigs (14.75s)
22:36:32 [2019-12-30T22:36:32.351Z] === RUN   TestServiceUpdateNetwork
22:36:44 [2019-12-30T22:36:44.893Z] --- PASS: TestServiceUpdateNetwork (13.96s)
22:36:44 [2019-12-30T22:36:44.893Z] PASS
22:36:44 [2019-12-30T22:36:44.893Z] 
22:36:44 [2019-12-30T22:36:44.893Z] === Skipped
22:36:44 [2019-12-30T22:36:44.893Z] === SKIP: ppc64le.integration.service TestServiceListWithStatuses (0.00s)
22:36:44 [2019-12-30T22:36:44.893Z]     list_test.go:34: versions.LessThan(testEnv.DaemonInfo.ServerVersion, "1.41")
22:36:44 [2019-12-30T22:36:44.893Z] 
22:36:44 [2019-12-30T22:36:44.893Z] === SKIP: ppc64le.integration.service TestServicePlugin (0.00s)
22:36:44 [2019-12-30T22:36:44.893Z]     plugin_test.go:28: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:36:44 [2019-12-30T22:36:44.893Z] 
22:36:44 [2019-12-30T22:36:44.893Z] 
22:36:44 [2019-12-30T22:36:44.893Z] DONE 20 tests, 2 skipped in 112.101s
22:36:44 [2019-12-30T22:36:44.893Z] Running /go/src/github.com/docker/docker/integration/session (ppc64le.integration.session) flags=-test.v -test.timeout=120m 
22:36:44 [2019-12-30T22:36:44.893Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-session-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-session-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.session -t ./test.main -test.v -test.timeout=120m
22:36:44 [2019-12-30T22:36:44.893Z] ++ set -e
22:36:44 [2019-12-30T22:36:44.893Z] ++ '[' -n 0 ']'
22:36:44 [2019-12-30T22:36:44.893Z] ++ set -x
22:36:44 [2019-12-30T22:36:44.893Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=ppc64le DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-session-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-session-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.session -t ./test.main -test.v -test.timeout=120m
22:36:44 [2019-12-30T22:36:44.893Z] INFO: Testing against a local daemon
22:36:44 [2019-12-30T22:36:44.893Z] === RUN   TestSessionCreate
22:36:45 [2019-12-30T22:36:45.179Z] --- PASS: TestSessionCreate (0.06s)
22:36:45 [2019-12-30T22:36:45.179Z] === RUN   TestSessionCreateWithBadUpgrade
22:36:45 [2019-12-30T22:36:45.179Z] --- PASS: TestSessionCreateWithBadUpgrade (0.05s)
22:36:45 [2019-12-30T22:36:45.179Z] PASS
22:36:45 [2019-12-30T22:36:45.179Z] 
22:36:45 [2019-12-30T22:36:45.179Z] DONE 2 tests in 0.205s
22:36:45 [2019-12-30T22:36:45.179Z] Running /go/src/github.com/docker/docker/integration/system (ppc64le.integration.system) flags=-test.v -test.timeout=120m 
22:36:45 [2019-12-30T22:36:45.179Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-system-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-system-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.system -t ./test.main -test.v -test.timeout=120m
22:36:45 [2019-12-30T22:36:45.179Z] ++ set -e
22:36:45 [2019-12-30T22:36:45.179Z] ++ '[' -n 0 ']'
22:36:45 [2019-12-30T22:36:45.179Z] ++ set -x
22:36:45 [2019-12-30T22:36:45.179Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=ppc64le DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-system-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-system-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.system -t ./test.main -test.v -test.timeout=120m
22:36:45 [2019-12-30T22:36:45.179Z] INFO: Testing against a local daemon
22:36:45 [2019-12-30T22:36:45.179Z] === RUN   TestCgroupDriverSystemdMemoryLimit
22:36:45 [2019-12-30T22:36:45.179Z] --- SKIP: TestCgroupDriverSystemdMemoryLimit (0.00s)
22:36:45 [2019-12-30T22:36:45.179Z]     cgroupdriver_systemd_test.go:32: !hasSystemd()
22:36:45 [2019-12-30T22:36:45.179Z] === RUN   TestEventsExecDie
22:36:46 [2019-12-30T22:36:46.193Z] --- PASS: TestEventsExecDie (0.81s)
22:36:46 [2019-12-30T22:36:46.193Z] === RUN   TestEventsBackwardsCompatible
22:36:46 [2019-12-30T22:36:46.193Z] --- PASS: TestEventsBackwardsCompatible (0.09s)
22:36:46 [2019-12-30T22:36:46.193Z] === RUN   TestInfoBinaryCommits
22:36:46 [2019-12-30T22:36:46.193Z] --- PASS: TestInfoBinaryCommits (0.06s)
22:36:46 [2019-12-30T22:36:46.193Z] === RUN   TestInfoAPIVersioned
22:36:46 [2019-12-30T22:36:46.193Z] --- PASS: TestInfoAPIVersioned (0.02s)
22:36:46 [2019-12-30T22:36:46.193Z] === RUN   TestInfoDiscoveryBackend
22:36:46 [2019-12-30T22:36:46.812Z] --- PASS: TestInfoDiscoveryBackend (0.54s)
22:36:46 [2019-12-30T22:36:46.812Z] === RUN   TestInfoDiscoveryInvalidAdvertise
22:36:47 [2019-12-30T22:36:47.825Z] --- PASS: TestInfoDiscoveryInvalidAdvertise (1.00s)
22:36:47 [2019-12-30T22:36:47.825Z] === RUN   TestInfoDiscoveryAdvertiseInterfaceName
22:36:48 [2019-12-30T22:36:48.447Z] --- PASS: TestInfoDiscoveryAdvertiseInterfaceName (0.55s)
22:36:48 [2019-12-30T22:36:48.447Z] === RUN   TestInfoAPI
22:36:48 [2019-12-30T22:36:48.447Z] --- PASS: TestInfoAPI (0.05s)
22:36:48 [2019-12-30T22:36:48.447Z] === RUN   TestInfoAPIWarnings
22:36:49 [2019-12-30T22:36:49.069Z] --- PASS: TestInfoAPIWarnings (0.54s)
22:36:49 [2019-12-30T22:36:49.069Z] === RUN   TestInfoDebug
22:36:49 [2019-12-30T22:36:49.356Z] --- PASS: TestInfoDebug (0.54s)
22:36:49 [2019-12-30T22:36:49.356Z] === RUN   TestInfoInsecureRegistries
22:36:49 [2019-12-30T22:36:49.978Z] --- PASS: TestInfoInsecureRegistries (0.54s)
22:36:49 [2019-12-30T22:36:49.978Z] === RUN   TestInfoRegistryMirrors
22:36:50 [2019-12-30T22:36:50.596Z] --- PASS: TestInfoRegistryMirrors (0.54s)
22:36:50 [2019-12-30T22:36:50.596Z] === RUN   TestLoginFailsWithBadCredentials
22:36:51 [2019-12-30T22:36:51.216Z] --- PASS: TestLoginFailsWithBadCredentials (0.58s)
22:36:51 [2019-12-30T22:36:51.216Z] === RUN   TestPingCacheHeaders
22:36:51 [2019-12-30T22:36:51.216Z] --- PASS: TestPingCacheHeaders (0.05s)
22:36:51 [2019-12-30T22:36:51.216Z] === RUN   TestPingGet
22:36:51 [2019-12-30T22:36:51.216Z] --- PASS: TestPingGet (0.03s)
22:36:51 [2019-12-30T22:36:51.216Z] === RUN   TestPingHead
22:36:51 [2019-12-30T22:36:51.216Z] --- PASS: TestPingHead (0.06s)
22:36:51 [2019-12-30T22:36:51.216Z] === RUN   TestVersion
22:36:51 [2019-12-30T22:36:51.216Z] --- PASS: TestVersion (0.05s)
22:36:51 [2019-12-30T22:36:51.216Z] PASS
22:36:51 [2019-12-30T22:36:51.216Z] 
22:36:51 [2019-12-30T22:36:51.216Z] === Skipped
22:36:51 [2019-12-30T22:36:51.216Z] === SKIP: ppc64le.integration.system TestCgroupDriverSystemdMemoryLimit (0.00s)
22:36:51 [2019-12-30T22:36:51.216Z]     cgroupdriver_systemd_test.go:32: !hasSystemd()
22:36:51 [2019-12-30T22:36:51.216Z] 
22:36:51 [2019-12-30T22:36:51.216Z] 
22:36:51 [2019-12-30T22:36:51.216Z] DONE 18 tests, 1 skipped in 6.140s
22:36:51 [2019-12-30T22:36:51.216Z] Running /go/src/github.com/docker/docker/integration/volume (ppc64le.integration.volume) flags=-test.v -test.timeout=120m 
22:36:51 [2019-12-30T22:36:51.216Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-volume-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-volume-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.volume -t ./test.main -test.v -test.timeout=120m
22:36:51 [2019-12-30T22:36:51.216Z] ++ set -e
22:36:51 [2019-12-30T22:36:51.216Z] ++ '[' -n 0 ']'
22:36:51 [2019-12-30T22:36:51.216Z] ++ set -x
22:36:51 [2019-12-30T22:36:51.216Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=ppc64le DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-volume-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/ppc64le-integration-volume-junit-report.xml --raw-command -- go tool test2json -p ppc64le.integration.volume -t ./test.main -test.v -test.timeout=120m
22:36:51 [2019-12-30T22:36:51.505Z] INFO: Testing against a local daemon
22:36:51 [2019-12-30T22:36:51.505Z] === RUN   TestVolumesCreateAndList
22:36:51 [2019-12-30T22:36:51.505Z] --- PASS: TestVolumesCreateAndList (0.04s)
22:36:51 [2019-12-30T22:36:51.505Z] === RUN   TestVolumesRemove
22:36:51 [2019-12-30T22:36:51.505Z] --- PASS: TestVolumesRemove (0.08s)
22:36:51 [2019-12-30T22:36:51.505Z] === RUN   TestVolumesInspect
22:36:51 [2019-12-30T22:36:51.505Z] --- PASS: TestVolumesInspect (0.05s)
22:36:51 [2019-12-30T22:36:51.505Z] === RUN   TestVolumesInvalidJSON
22:36:51 [2019-12-30T22:36:51.505Z] === RUN   TestVolumesInvalidJSON//volumes/create
22:36:51 [2019-12-30T22:36:51.505Z] === PAUSE TestVolumesInvalidJSON//volumes/create
22:36:51 [2019-12-30T22:36:51.505Z] === CONT  TestVolumesInvalidJSON//volumes/create
22:36:51 [2019-12-30T22:36:51.505Z] --- PASS: TestVolumesInvalidJSON (0.03s)
22:36:51 [2019-12-30T22:36:51.505Z]     --- PASS: TestVolumesInvalidJSON//volumes/create (0.00s)
22:36:51 [2019-12-30T22:36:51.505Z] PASS
22:36:51 [2019-12-30T22:36:51.505Z] 
22:36:51 [2019-12-30T22:36:51.505Z] DONE 5 tests in 0.295s
22:36:51 [2019-12-30T22:36:51.505Z] ---> Making bundle: .integration-daemon-stop (in bundles/test-integration)
22:36:51 [2019-12-30T22:36:51.790Z] ++++ cat bundles/test-integration/docker.pid
22:36:51 [2019-12-30T22:36:51.790Z] +++ kill 13162
22:36:53 [2019-12-30T22:36:53.266Z] +++ /etc/init.d/apparmor stop
22:36:53 [2019-12-30T22:36:53.266Z] Clearing AppArmor profiles cache:.
22:36:53 [2019-12-30T22:36:53.266Z] All profile caches have been cleared, but no profiles have been unloaded.
22:36:53 [2019-12-30T22:36:53.266Z] Unloading profiles will leave already running processes permanently
22:36:53 [2019-12-30T22:36:53.266Z] unconfined, which can lead to unexpected situations.
22:36:53 [2019-12-30T22:36:53.266Z] 
22:36:53 [2019-12-30T22:36:53.266Z] To set a process to complain mode, use the command line tool
22:36:53 [2019-12-30T22:36:53.266Z] 'aa-complain'. To really tear down all profiles, run the init script
22:36:53 [2019-12-30T22:36:53.266Z] with the 'teardown' option."
22:36:53 [2019-12-30T22:36:53.266Z]