Skip to content

Console Output

21:44:35 [2020-01-10T21:44:35.849Z] + docker run --rm -t --privileged -v /home/docker/workspace/moby_cpuguy-test-sync/bundles:/go/src/github.com/docker/docker/bundles --name docker-pr1 -e DOCKER_EXPERIMENTAL -e DOCKER_GITCOMMIT=4d63209d94276d66d9db39174bfe0127f4b9a8dc -e DOCKER_GRAPHDRIVER -e TESTDEBUG -e TEST_SKIP_INTEGRATION_CLI -e TIMEOUT -e VALIDATE_REPO=https://github.com/moby/moby.git -e VALIDATE_BRANCH= docker:4d63209d94276d66d9db39174bfe0127f4b9a8dc hack/make.sh dynbinary test-integration
21:44:36 [2020-01-10T21:44:36.135Z] 
21:44:36 [2020-01-10T21:44:36.425Z] Removing bundles/
21:44:36 [2020-01-10T21:44:36.425Z] 
21:44:36 [2020-01-10T21:44:36.425Z] ---> Making bundle: dynbinary (in bundles/dynbinary)
21:44:36 [2020-01-10T21:44:36.425Z] Building: bundles/dynbinary-daemon/dockerd-dev
21:44:36 [2020-01-10T21:44:36.425Z] GOOS="" GOARCH="" GOARM=""
21:46:43 [2020-01-10T21:46:43.697Z] Created binary: bundles/dynbinary-daemon/dockerd-dev
21:46:43 [2020-01-10T21:46:43.697Z] 
21:46:43 [2020-01-10T21:46:43.697Z] ---> Making bundle: test-integration (in bundles/test-integration)
21:46:43 [2020-01-10T21:46:43.697Z] SCRIPTDIR=/go/src/github.com/docker/docker/hack
21:46:43 [2020-01-10T21:46:43.697Z] HOSTNAME=989912d603eb
21:46:43 [2020-01-10T21:46:43.697Z] TESTDEBUG=0
21:46:43 [2020-01-10T21:46:43.697Z] DEST=bundles/test-integration
21:46:43 [2020-01-10T21:46:43.697Z] PWD=/go/src/github.com/docker/docker
21:46:43 [2020-01-10T21:46:43.697Z] DOCKER_GITCOMMIT=4d63209d94276d66d9db39174bfe0127f4b9a8dc
21:46:43 [2020-01-10T21:46:43.697Z] container=docker
21:46:43 [2020-01-10T21:46:43.697Z] HOME=/root
21:46:43 [2020-01-10T21:46:43.697Z] GOLANG_VERSION=1.13.5
21:46:43 [2020-01-10T21:46:43.697Z] VALIDATE_REPO=https://github.com/moby/moby.git
21:46:43 [2020-01-10T21:46:43.697Z] VALIDATE_BRANCH=
21:46:43 [2020-01-10T21:46:43.697Z] TERM=xterm
21:46:43 [2020-01-10T21:46:43.697Z] DOCKER_PKG=github.com/docker/docker
21:46:43 [2020-01-10T21:46:43.697Z] SHLVL=1
21:46:43 [2020-01-10T21:46:43.697Z] TIMEOUT=120m
21:46:43 [2020-01-10T21:46:43.697Z] DOCKER_BUILDTAGS=apparmor seccomp selinux journald
21:46:43 [2020-01-10T21:46:43.697Z] DOCKER_GRAPHDRIVER=overlay2
21:46:43 [2020-01-10T21:46:43.697Z] GO111MODULE=off
21:46:43 [2020-01-10T21:46:43.697Z] DOCKER_EXPERIMENTAL=1
21:46:43 [2020-01-10T21:46:43.697Z] TEST_SKIP_INTEGRATION_CLI=1
21:46:43 [2020-01-10T21:46:43.697Z] PATH=/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
21:46:43 [2020-01-10T21:46:43.697Z] MAKEDIR=/go/src/github.com/docker/docker/hack/make
21:46:43 [2020-01-10T21:46:43.697Z] GOPATH=/go
21:46:43 [2020-01-10T21:46:43.697Z] PKG_CONFIG=pkg-config
21:46:43 [2020-01-10T21:46:43.697Z] _=/usr/bin/env
21:46:43 [2020-01-10T21:46:43.697Z] Building test suite binary /go/src/github.com/docker/docker/integration/build/test.main
21:47:40 [2020-01-10T21:47:40.591Z] Building test suite binary /go/src/github.com/docker/docker/integration/config/test.main
21:47:40 [2020-01-10T21:47:40.591Z] Building test suite binary /go/src/github.com/docker/docker/integration/container/test.main
21:47:45 [2020-01-10T21:47:45.012Z] Building test suite binary /go/src/github.com/docker/docker/integration/image/test.main
21:48:24 [2020-01-10T21:48:24.291Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/test.main
21:48:26 [2020-01-10T21:48:26.330Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/ipvlan/test.main
21:48:29 [2020-01-10T21:48:29.050Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/macvlan/test.main
21:48:31 [2020-01-10T21:48:31.744Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/test.main
21:48:32 [2020-01-10T21:48:32.365Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/authz/test.main
21:48:37 [2020-01-10T21:48:37.879Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/common/test.main
21:48:39 [2020-01-10T21:48:39.915Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/graphdriver/test.main
21:48:45 [2020-01-10T21:48:45.422Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/logging/test.main
21:48:49 [2020-01-10T21:48:49.850Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/volumes/test.main
21:48:55 [2020-01-10T21:48:55.367Z] Building test suite binary /go/src/github.com/docker/docker/integration/secret/test.main
21:48:58 [2020-01-10T21:48:58.069Z] Building test suite binary /go/src/github.com/docker/docker/integration/service/test.main
21:49:03 [2020-01-10T21:49:03.588Z] Building test suite binary /go/src/github.com/docker/docker/integration/session/test.main
21:49:05 [2020-01-10T21:49:05.623Z] Building test suite binary /go/src/github.com/docker/docker/integration/system/test.main
21:49:08 [2020-01-10T21:49:08.322Z] Building test suite binary /go/src/github.com/docker/docker/integration/volume/test.main
21:49:11 [2020-01-10T21:49:11.027Z] ---> Making bundle: .integration-daemon-start (in bundles/test-integration)
21:49:11 [2020-01-10T21:49:11.027Z] Using test binary docker
21:49:11 [2020-01-10T21:49:11.027Z] # DOCKER_EXPERIMENTAL is set: starting daemon with experimental features enabled! 
21:49:11 [2020-01-10T21:49:11.027Z] +++ /etc/init.d/apparmor start
21:49:11 [2020-01-10T21:49:11.027Z] Starting: AppArmor: already loaded with profiles.: Skipped. ... (warning).
21:49:11 [2020-01-10T21:49:11.027Z] INFO: Waiting for daemon to start...
21:49:11 [2020-01-10T21:49:11.027Z] Starting dockerd
21:49:11 [2020-01-10T21:49:11.027Z] +++ 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
21:49:13 [2020-01-10T21:49:13.402Z] .
21:49:13 [2020-01-10T21:49:13.402Z] ---> Making bundle: .integration-daemon-setup (in bundles/test-integration)
21:49:13 [2020-01-10T21:49:13.402Z] ---> Making bundle: .ensure-emptyfs (in bundles/test-integration)
21:49:13 [2020-01-10T21:49:13.402Z] Error: No such image: emptyfs
21:49:13 [2020-01-10T21:49:13.402Z] ++++ tar -cC bundles/test-integration/emptyfs .
21:49:13 [2020-01-10T21:49:13.402Z] ++++ docker load
21:49:13 [2020-01-10T21:49:13.782Z] Running integration-test (iteration 1)
21:49:13 [2020-01-10T21:49:13.782Z] Running /go/src/github.com/docker/docker/integration/build (ppc64le.integration.build) flags=-test.v -test.timeout=120m 
21:49:13 [2020-01-10T21:49:13.782Z] ++ 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
21:49:13 [2020-01-10T21:49:13.782Z] ++ set -e
21:49:13 [2020-01-10T21:49:13.782Z] ++ '[' -n 0 ']'
21:49:13 [2020-01-10T21:49:13.782Z] ++ set -x
21:49:13 [2020-01-10T21:49:13.782Z] ++ 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
21:49:29 [2020-01-10T21:49:29.228Z] Loaded image: buildpack-deps:jessie
21:49:29 [2020-01-10T21:49:29.228Z] Loaded image: busybox:latest
21:49:29 [2020-01-10T21:49:29.228Z] Loaded image: busybox:glibc
21:49:29 [2020-01-10T21:49:29.228Z] Loaded image: debian:jessie
21:49:29 [2020-01-10T21:49:29.228Z] Loaded image: hello-world:latest
21:49:29 [2020-01-10T21:49:29.228Z] INFO: Testing against a local daemon
21:49:29 [2020-01-10T21:49:29.228Z] === RUN   TestCgroupNamespacesBuild
21:49:29 [2020-01-10T21:49:29.518Z] --- PASS: TestCgroupNamespacesBuild (1.67s)
21:49:29 [2020-01-10T21:49:29.518Z] === RUN   TestCgroupNamespacesBuildDaemonHostMode
21:49:31 [2020-01-10T21:49:31.554Z] --- PASS: TestCgroupNamespacesBuildDaemonHostMode (1.61s)
21:49:31 [2020-01-10T21:49:31.554Z] === RUN   TestBuildWithSession
21:49:31 [2020-01-10T21:49:31.554Z] --- SKIP: TestBuildWithSession (0.00s)
21:49:31 [2020-01-10T21:49:31.554Z]     build_session_test.go:25: TODO: BuildKit
21:49:31 [2020-01-10T21:49:31.554Z] === RUN   TestBuildSquashParent
21:49:37 [2020-01-10T21:49:37.063Z] --- PASS: TestBuildSquashParent (5.33s)
21:49:37 [2020-01-10T21:49:37.063Z] === RUN   TestBuildWithRemoveAndForceRemove
21:49:37 [2020-01-10T21:49:37.063Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
21:49:37 [2020-01-10T21:49:37.063Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
21:49:37 [2020-01-10T21:49:37.063Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_remove
21:49:37 [2020-01-10T21:49:37.063Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_remove
21:49:37 [2020-01-10T21:49:37.063Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
21:49:37 [2020-01-10T21:49:37.063Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
21:49:37 [2020-01-10T21:49:37.063Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
21:49:37 [2020-01-10T21:49:37.063Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
21:49:37 [2020-01-10T21:49:37.063Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_remove
21:49:37 [2020-01-10T21:49:37.063Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_remove
21:49:37 [2020-01-10T21:49:37.063Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
21:49:37 [2020-01-10T21:49:37.063Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
21:49:37 [2020-01-10T21:49:37.063Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
21:49:37 [2020-01-10T21:49:37.063Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
21:49:37 [2020-01-10T21:49:37.063Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_remove
21:49:37 [2020-01-10T21:49:37.063Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
21:49:39 [2020-01-10T21:49:39.787Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
21:49:39 [2020-01-10T21:49:39.787Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_remove
21:49:41 [2020-01-10T21:49:41.818Z] --- PASS: TestBuildWithRemoveAndForceRemove (0.03s)
21:49:41 [2020-01-10T21:49:41.818Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal (2.87s)
21:49:41 [2020-01-10T21:49:41.818Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal (3.31s)
21:49:41 [2020-01-10T21:49:41.818Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_remove (3.86s)
21:49:41 [2020-01-10T21:49:41.818Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove (3.90s)
21:49:41 [2020-01-10T21:49:41.818Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove (2.44s)
21:49:41 [2020-01-10T21:49:41.818Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_remove (2.05s)
21:49:41 [2020-01-10T21:49:41.818Z] === RUN   TestBuildMultiStageCopy
21:49:41 [2020-01-10T21:49:41.818Z] === RUN   TestBuildMultiStageCopy/copy_to_root
21:49:43 [2020-01-10T21:49:43.858Z] === RUN   TestBuildMultiStageCopy/copy_to_newdir
21:49:44 [2020-01-10T21:49:44.478Z] === RUN   TestBuildMultiStageCopy/copy_to_newdir_nested
21:49:44 [2020-01-10T21:49:44.762Z] === RUN   TestBuildMultiStageCopy/copy_to_existingdir
21:49:45 [2020-01-10T21:49:45.048Z] === RUN   TestBuildMultiStageCopy/copy_to_newsubdir
21:49:45 [2020-01-10T21:49:45.671Z] --- PASS: TestBuildMultiStageCopy (3.69s)
21:49:45 [2020-01-10T21:49:45.671Z]     --- PASS: TestBuildMultiStageCopy/copy_to_root (2.05s)
21:49:45 [2020-01-10T21:49:45.671Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newdir (0.38s)
21:49:45 [2020-01-10T21:49:45.671Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newdir_nested (0.39s)
21:49:45 [2020-01-10T21:49:45.671Z]     --- PASS: TestBuildMultiStageCopy/copy_to_existingdir (0.43s)
21:49:45 [2020-01-10T21:49:45.671Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newsubdir (0.44s)
21:49:45 [2020-01-10T21:49:45.671Z] === RUN   TestBuildMultiStageParentConfig
21:49:46 [2020-01-10T21:49:46.685Z] --- PASS: TestBuildMultiStageParentConfig (1.04s)
21:49:46 [2020-01-10T21:49:46.685Z] === RUN   TestBuildLabelWithTargets
21:49:48 [2020-01-10T21:49:48.190Z] --- PASS: TestBuildLabelWithTargets (1.63s)
21:49:48 [2020-01-10T21:49:48.190Z] === RUN   TestBuildWithEmptyLayers
21:49:49 [2020-01-10T21:49:49.201Z] --- PASS: TestBuildWithEmptyLayers (0.81s)
21:49:49 [2020-01-10T21:49:49.201Z] === RUN   TestBuildMultiStageOnBuild
21:49:51 [2020-01-10T21:49:51.236Z] --- PASS: TestBuildMultiStageOnBuild (2.26s)
21:49:51 [2020-01-10T21:49:51.236Z] === RUN   TestBuildUncleanTarFilenames
21:49:52 [2020-01-10T21:49:52.719Z] --- PASS: TestBuildUncleanTarFilenames (1.18s)
21:49:52 [2020-01-10T21:49:52.719Z] === RUN   TestBuildMultiStageLayerLeak
21:49:54 [2020-01-10T21:49:54.760Z] --- PASS: TestBuildMultiStageLayerLeak (2.34s)
21:49:54 [2020-01-10T21:49:54.760Z] === RUN   TestBuildWithHugeFile
21:51:16 [2020-01-10T21:51:16.813Z] --- PASS: TestBuildWithHugeFile (81.26s)
21:51:16 [2020-01-10T21:51:16.813Z] === RUN   TestBuildWithEmptyDockerfile
21:51:16 [2020-01-10T21:51:16.813Z] === RUN   TestBuildWithEmptyDockerfile/empty-dockerfile
21:51:16 [2020-01-10T21:51:16.813Z] === PAUSE TestBuildWithEmptyDockerfile/empty-dockerfile
21:51:16 [2020-01-10T21:51:16.813Z] === RUN   TestBuildWithEmptyDockerfile/empty-lines-dockerfile
21:51:16 [2020-01-10T21:51:16.813Z] === PAUSE TestBuildWithEmptyDockerfile/empty-lines-dockerfile
21:51:16 [2020-01-10T21:51:16.813Z] === RUN   TestBuildWithEmptyDockerfile/comment-only-dockerfile
21:51:16 [2020-01-10T21:51:16.813Z] === PAUSE TestBuildWithEmptyDockerfile/comment-only-dockerfile
21:51:16 [2020-01-10T21:51:16.813Z] === CONT  TestBuildWithEmptyDockerfile/empty-dockerfile
21:51:16 [2020-01-10T21:51:16.813Z] === CONT  TestBuildWithEmptyDockerfile/comment-only-dockerfile
21:51:16 [2020-01-10T21:51:16.813Z] === CONT  TestBuildWithEmptyDockerfile/empty-lines-dockerfile
21:51:16 [2020-01-10T21:51:16.813Z] --- PASS: TestBuildWithEmptyDockerfile (0.05s)
21:51:16 [2020-01-10T21:51:16.813Z]     --- PASS: TestBuildWithEmptyDockerfile/empty-dockerfile (0.32s)
21:51:16 [2020-01-10T21:51:16.813Z]     --- PASS: TestBuildWithEmptyDockerfile/comment-only-dockerfile (0.32s)
21:51:16 [2020-01-10T21:51:16.813Z]     --- PASS: TestBuildWithEmptyDockerfile/empty-lines-dockerfile (0.33s)
21:51:16 [2020-01-10T21:51:16.813Z] === RUN   TestBuildPreserveOwnership
21:51:16 [2020-01-10T21:51:16.813Z] === RUN   TestBuildPreserveOwnership/copy_from
21:51:19 [2020-01-10T21:51:19.501Z] === RUN   TestBuildPreserveOwnership/copy_from_chowned
21:51:21 [2020-01-10T21:51:21.539Z] --- PASS: TestBuildPreserveOwnership (4.80s)
21:51:21 [2020-01-10T21:51:21.539Z]     --- PASS: TestBuildPreserveOwnership/copy_from (3.14s)
21:51:21 [2020-01-10T21:51:21.539Z]     --- PASS: TestBuildPreserveOwnership/copy_from_chowned (1.65s)
21:51:21 [2020-01-10T21:51:21.539Z] === RUN   TestBuildPlatformInvalid
21:51:21 [2020-01-10T21:51:21.539Z] --- PASS: TestBuildPlatformInvalid (0.17s)
21:51:21 [2020-01-10T21:51:21.539Z] PASS
21:51:21 [2020-01-10T21:51:21.539Z] 
21:51:21 [2020-01-10T21:51:21.539Z] === Skipped
21:51:21 [2020-01-10T21:51:21.539Z] === SKIP: ppc64le.integration.build TestBuildWithSession (0.00s)
21:51:21 [2020-01-10T21:51:21.539Z]     build_session_test.go:25: TODO: BuildKit
21:51:21 [2020-01-10T21:51:21.539Z] 
21:51:21 [2020-01-10T21:51:21.539Z] 
21:51:21 [2020-01-10T21:51:21.539Z] DONE 32 tests, 1 skipped in 127.857s
21:51:21 [2020-01-10T21:51:21.539Z] Running /go/src/github.com/docker/docker/integration/config (ppc64le.integration.config) flags=-test.v -test.timeout=120m 
21:51:21 [2020-01-10T21:51:21.539Z] ++ 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
21:51:21 [2020-01-10T21:51:21.539Z] ++ set -e
21:51:21 [2020-01-10T21:51:21.540Z] ++ '[' -n 0 ']'
21:51:21 [2020-01-10T21:51:21.540Z] ++ set -x
21:51:21 [2020-01-10T21:51:21.540Z] ++ 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
21:51:21 [2020-01-10T21:51:21.540Z] INFO: Testing against a local daemon
21:51:21 [2020-01-10T21:51:21.540Z] === RUN   TestConfigList
21:51:24 [2020-01-10T21:51:24.232Z] --- PASS: TestConfigList (2.27s)
21:51:24 [2020-01-10T21:51:24.232Z] === RUN   TestConfigsCreateAndDelete
21:51:26 [2020-01-10T21:51:26.277Z] --- PASS: TestConfigsCreateAndDelete (2.23s)
21:51:26 [2020-01-10T21:51:26.277Z] === RUN   TestConfigsUpdate
21:51:28 [2020-01-10T21:51:28.314Z] --- PASS: TestConfigsUpdate (2.21s)
21:51:28 [2020-01-10T21:51:28.314Z] === RUN   TestTemplatedConfig
21:51:31 [2020-01-10T21:51:31.176Z] --- PASS: TestTemplatedConfig (2.73s)
21:51:31 [2020-01-10T21:51:31.176Z] === RUN   TestConfigInspect
21:51:33 [2020-01-10T21:51:33.217Z] --- PASS: TestConfigInspect (2.24s)
21:51:33 [2020-01-10T21:51:33.217Z] === RUN   TestConfigCreateWithLabels
21:51:35 [2020-01-10T21:51:35.914Z] --- PASS: TestConfigCreateWithLabels (2.27s)
21:51:35 [2020-01-10T21:51:35.914Z] === RUN   TestConfigCreateResolve
21:51:37 [2020-01-10T21:51:37.943Z] --- PASS: TestConfigCreateResolve (2.25s)
21:51:37 [2020-01-10T21:51:37.943Z] === RUN   TestConfigDaemonLibtrustID
21:51:38 [2020-01-10T21:51:38.227Z] --- PASS: TestConfigDaemonLibtrustID (0.55s)
21:51:38 [2020-01-10T21:51:38.227Z] PASS
21:51:38 [2020-01-10T21:51:38.227Z] 
21:51:38 [2020-01-10T21:51:38.227Z] DONE 8 tests in 16.850s
21:51:38 [2020-01-10T21:51:38.227Z] Running /go/src/github.com/docker/docker/integration/container (ppc64le.integration.container) flags=-test.v -test.timeout=120m 
21:51:38 [2020-01-10T21:51:38.228Z] ++ 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
21:51:38 [2020-01-10T21:51:38.228Z] ++ set -e
21:51:38 [2020-01-10T21:51:38.228Z] ++ '[' -n 0 ']'
21:51:38 [2020-01-10T21:51:38.228Z] ++ set -x
21:51:38 [2020-01-10T21:51:38.228Z] ++ 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
21:51:38 [2020-01-10T21:51:38.511Z] INFO: Testing against a local daemon
21:51:38 [2020-01-10T21:51:38.511Z] === RUN   TestCheckpoint
21:51:38 [2020-01-10T21:51:38.511Z] --- SKIP: TestCheckpoint (0.00s)
21:51:38 [2020-01-10T21:51:38.511Z]     checkpoint_test.go:33: TestCheckpoint is broken; see https://github.com/moby/moby/issues/38963
21:51:38 [2020-01-10T21:51:38.511Z] === RUN   TestContainerInvalidJSON
21:51:38 [2020-01-10T21:51:38.511Z] === RUN   TestContainerInvalidJSON//containers/foobar/copy
21:51:38 [2020-01-10T21:51:38.511Z] === PAUSE TestContainerInvalidJSON//containers/foobar/copy
21:51:38 [2020-01-10T21:51:38.511Z] === RUN   TestContainerInvalidJSON//containers/foobar/exec
21:51:38 [2020-01-10T21:51:38.511Z] === PAUSE TestContainerInvalidJSON//containers/foobar/exec
21:51:38 [2020-01-10T21:51:38.511Z] === RUN   TestContainerInvalidJSON//exec/foobar/start
21:51:38 [2020-01-10T21:51:38.511Z] === PAUSE TestContainerInvalidJSON//exec/foobar/start
21:51:38 [2020-01-10T21:51:38.511Z] === CONT  TestContainerInvalidJSON//containers/foobar/copy
21:51:38 [2020-01-10T21:51:38.511Z] === CONT  TestContainerInvalidJSON//exec/foobar/start
21:51:38 [2020-01-10T21:51:38.511Z] === CONT  TestContainerInvalidJSON//containers/foobar/exec
21:51:38 [2020-01-10T21:51:38.511Z] --- PASS: TestContainerInvalidJSON (0.02s)
21:51:38 [2020-01-10T21:51:38.511Z]     --- PASS: TestContainerInvalidJSON//containers/foobar/exec (0.00s)
21:51:38 [2020-01-10T21:51:38.511Z]     --- PASS: TestContainerInvalidJSON//exec/foobar/start (0.00s)
21:51:38 [2020-01-10T21:51:38.511Z]     --- PASS: TestContainerInvalidJSON//containers/foobar/copy (0.00s)
21:51:38 [2020-01-10T21:51:38.511Z] === RUN   TestCopyFromContainerPathDoesNotExist
21:51:38 [2020-01-10T21:51:38.511Z] --- PASS: TestCopyFromContainerPathDoesNotExist (0.08s)
21:51:38 [2020-01-10T21:51:38.511Z] === RUN   TestCopyFromContainerPathIsNotDir
21:51:38 [2020-01-10T21:51:38.511Z] --- PASS: TestCopyFromContainerPathIsNotDir (0.08s)
21:51:38 [2020-01-10T21:51:38.511Z] === RUN   TestCopyToContainerPathDoesNotExist
21:51:38 [2020-01-10T21:51:38.795Z] --- PASS: TestCopyToContainerPathDoesNotExist (0.07s)
21:51:38 [2020-01-10T21:51:38.795Z] === RUN   TestCopyToContainerPathIsNotDir
21:51:38 [2020-01-10T21:51:38.795Z] --- PASS: TestCopyToContainerPathIsNotDir (0.09s)
21:51:38 [2020-01-10T21:51:38.795Z] === RUN   TestCopyFromContainer
21:51:40 [2020-01-10T21:51:40.274Z] === RUN   TestCopyFromContainer//
21:51:40 [2020-01-10T21:51:40.560Z] === RUN   TestCopyFromContainer//bar/root
21:51:40 [2020-01-10T21:51:40.560Z] === RUN   TestCopyFromContainer//bar/root/
21:51:40 [2020-01-10T21:51:40.560Z] === RUN   TestCopyFromContainer/bar/quux
21:51:41 [2020-01-10T21:51:41.053Z] === RUN   TestCopyFromContainer/bar/quux/
21:51:41 [2020-01-10T21:51:41.053Z] === RUN   TestCopyFromContainer/bar/quux/baz
21:51:41 [2020-01-10T21:51:41.053Z] === RUN   TestCopyFromContainer/bar/filesymlink
21:51:41 [2020-01-10T21:51:41.053Z] === RUN   TestCopyFromContainer/bar/dirsymlink
21:51:41 [2020-01-10T21:51:41.053Z] === RUN   TestCopyFromContainer/bar/dirsymlink/
21:51:41 [2020-01-10T21:51:41.339Z] === RUN   TestCopyFromContainer/bar/notarget
21:51:41 [2020-01-10T21:51:41.339Z] --- PASS: TestCopyFromContainer (2.56s)
21:51:41 [2020-01-10T21:51:41.339Z]     --- PASS: TestCopyFromContainer// (0.10s)
21:51:41 [2020-01-10T21:51:41.339Z]     --- PASS: TestCopyFromContainer//bar/root (0.10s)
21:51:41 [2020-01-10T21:51:41.339Z]     --- PASS: TestCopyFromContainer//bar/root/ (0.10s)
21:51:41 [2020-01-10T21:51:41.339Z]     --- PASS: TestCopyFromContainer/bar/quux (0.12s)
21:51:41 [2020-01-10T21:51:41.339Z]     --- PASS: TestCopyFromContainer/bar/quux/ (0.10s)
21:51:41 [2020-01-10T21:51:41.339Z]     --- PASS: TestCopyFromContainer/bar/quux/baz (0.09s)
21:51:41 [2020-01-10T21:51:41.339Z]     --- PASS: TestCopyFromContainer/bar/filesymlink (0.10s)
21:51:41 [2020-01-10T21:51:41.339Z]     --- PASS: TestCopyFromContainer/bar/dirsymlink (0.10s)
21:51:41 [2020-01-10T21:51:41.339Z]     --- PASS: TestCopyFromContainer/bar/dirsymlink/ (0.09s)
21:51:41 [2020-01-10T21:51:41.339Z]     --- PASS: TestCopyFromContainer/bar/notarget (0.10s)
21:51:41 [2020-01-10T21:51:41.339Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist
21:51:41 [2020-01-10T21:51:41.339Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
21:51:41 [2020-01-10T21:51:41.339Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
21:51:41 [2020-01-10T21:51:41.339Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
21:51:41 [2020-01-10T21:51:41.339Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
21:51:41 [2020-01-10T21:51:41.339Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/digest
21:51:41 [2020-01-10T21:51:41.339Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/digest
21:51:41 [2020-01-10T21:51:41.339Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
21:51:41 [2020-01-10T21:51:41.339Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/digest
21:51:41 [2020-01-10T21:51:41.339Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
21:51:41 [2020-01-10T21:51:41.339Z] --- PASS: TestCreateFailsWhenIdentifierDoesNotExist (0.03s)
21:51:41 [2020-01-10T21:51:41.339Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag (0.00s)
21:51:41 [2020-01-10T21:51:41.339Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/digest (0.01s)
21:51:41 [2020-01-10T21:51:41.339Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag (0.01s)
21:51:41 [2020-01-10T21:51:41.339Z] === RUN   TestCreateLinkToNonExistingContainer
21:51:41 [2020-01-10T21:51:41.339Z] --- PASS: TestCreateLinkToNonExistingContainer (0.06s)
21:51:41 [2020-01-10T21:51:41.339Z] === RUN   TestCreateWithInvalidEnv
21:51:41 [2020-01-10T21:51:41.339Z] === RUN   TestCreateWithInvalidEnv/0
21:51:41 [2020-01-10T21:51:41.339Z] === PAUSE TestCreateWithInvalidEnv/0
21:51:41 [2020-01-10T21:51:41.339Z] === RUN   TestCreateWithInvalidEnv/1
21:51:41 [2020-01-10T21:51:41.339Z] === PAUSE TestCreateWithInvalidEnv/1
21:51:41 [2020-01-10T21:51:41.339Z] === RUN   TestCreateWithInvalidEnv/2
21:51:41 [2020-01-10T21:51:41.339Z] === PAUSE TestCreateWithInvalidEnv/2
21:51:41 [2020-01-10T21:51:41.339Z] === CONT  TestCreateWithInvalidEnv/0
21:51:41 [2020-01-10T21:51:41.339Z] === CONT  TestCreateWithInvalidEnv/2
21:51:41 [2020-01-10T21:51:41.339Z] === CONT  TestCreateWithInvalidEnv/1
21:51:41 [2020-01-10T21:51:41.339Z] --- PASS: TestCreateWithInvalidEnv (0.02s)
21:51:41 [2020-01-10T21:51:41.339Z]     --- PASS: TestCreateWithInvalidEnv/0 (0.01s)
21:51:41 [2020-01-10T21:51:41.339Z]     --- PASS: TestCreateWithInvalidEnv/2 (0.00s)
21:51:41 [2020-01-10T21:51:41.339Z]     --- PASS: TestCreateWithInvalidEnv/1 (0.00s)
21:51:41 [2020-01-10T21:51:41.339Z] === RUN   TestCreateTmpfsMountsTarget
21:51:41 [2020-01-10T21:51:41.624Z] --- PASS: TestCreateTmpfsMountsTarget (0.03s)
21:51:41 [2020-01-10T21:51:41.624Z] === RUN   TestCreateWithCustomMaskedPaths
21:51:43 [2020-01-10T21:51:43.656Z] --- PASS: TestCreateWithCustomMaskedPaths (1.87s)
21:51:43 [2020-01-10T21:51:43.656Z] === RUN   TestCreateWithCapabilities
21:51:43 [2020-01-10T21:51:43.656Z] === RUN   TestCreateWithCapabilities/no_capabilities
21:51:43 [2020-01-10T21:51:43.656Z] === PAUSE TestCreateWithCapabilities/no_capabilities
21:51:43 [2020-01-10T21:51:43.656Z] === RUN   TestCreateWithCapabilities/empty_capabilities
21:51:43 [2020-01-10T21:51:43.656Z] === PAUSE TestCreateWithCapabilities/empty_capabilities
21:51:43 [2020-01-10T21:51:43.656Z] === RUN   TestCreateWithCapabilities/valid_capabilities
21:51:43 [2020-01-10T21:51:43.656Z] === PAUSE TestCreateWithCapabilities/valid_capabilities
21:51:43 [2020-01-10T21:51:43.656Z] === RUN   TestCreateWithCapabilities/invalid_capabilities
21:51:43 [2020-01-10T21:51:43.656Z] === PAUSE TestCreateWithCapabilities/invalid_capabilities
21:51:43 [2020-01-10T21:51:43.656Z] === RUN   TestCreateWithCapabilities/duplicate_capabilities
21:51:43 [2020-01-10T21:51:43.656Z] === PAUSE TestCreateWithCapabilities/duplicate_capabilities
21:51:43 [2020-01-10T21:51:43.656Z] === RUN   TestCreateWithCapabilities/capabilities_API_v1.39
21:51:43 [2020-01-10T21:51:43.656Z] === PAUSE TestCreateWithCapabilities/capabilities_API_v1.39
21:51:43 [2020-01-10T21:51:43.656Z] === RUN   TestCreateWithCapabilities/empty_capadd
21:51:43 [2020-01-10T21:51:43.656Z] === PAUSE TestCreateWithCapabilities/empty_capadd
21:51:43 [2020-01-10T21:51:43.656Z] === RUN   TestCreateWithCapabilities/empty_capdrop
21:51:43 [2020-01-10T21:51:43.656Z] === PAUSE TestCreateWithCapabilities/empty_capdrop
21:51:43 [2020-01-10T21:51:43.656Z] === RUN   TestCreateWithCapabilities/capadd_capdrop
21:51:43 [2020-01-10T21:51:43.656Z] === PAUSE TestCreateWithCapabilities/capadd_capdrop
21:51:43 [2020-01-10T21:51:43.656Z] === RUN   TestCreateWithCapabilities/conflict_with_capadd
21:51:43 [2020-01-10T21:51:43.656Z] === PAUSE TestCreateWithCapabilities/conflict_with_capadd
21:51:43 [2020-01-10T21:51:43.656Z] === RUN   TestCreateWithCapabilities/conflict_with_capdrop
21:51:43 [2020-01-10T21:51:43.656Z] === PAUSE TestCreateWithCapabilities/conflict_with_capdrop
21:51:43 [2020-01-10T21:51:43.656Z] === CONT  TestCreateWithCapabilities/no_capabilities
21:51:43 [2020-01-10T21:51:43.656Z] === CONT  TestCreateWithCapabilities/empty_capadd
21:51:43 [2020-01-10T21:51:43.656Z] === CONT  TestCreateWithCapabilities/conflict_with_capadd
21:51:43 [2020-01-10T21:51:43.656Z] === CONT  TestCreateWithCapabilities/capadd_capdrop
21:51:43 [2020-01-10T21:51:43.656Z] === CONT  TestCreateWithCapabilities/conflict_with_capdrop
21:51:43 [2020-01-10T21:51:43.656Z] === CONT  TestCreateWithCapabilities/empty_capdrop
21:51:43 [2020-01-10T21:51:43.656Z] === CONT  TestCreateWithCapabilities/invalid_capabilities
21:51:43 [2020-01-10T21:51:43.656Z] === CONT  TestCreateWithCapabilities/capabilities_API_v1.39
21:51:43 [2020-01-10T21:51:43.656Z] === CONT  TestCreateWithCapabilities/duplicate_capabilities
21:51:43 [2020-01-10T21:51:43.656Z] === CONT  TestCreateWithCapabilities/empty_capabilities
21:51:43 [2020-01-10T21:51:43.656Z] === CONT  TestCreateWithCapabilities/valid_capabilities
21:51:43 [2020-01-10T21:51:43.656Z] --- PASS: TestCreateWithCapabilities (0.03s)
21:51:43 [2020-01-10T21:51:43.656Z]     --- PASS: TestCreateWithCapabilities/conflict_with_capadd (0.02s)
21:51:43 [2020-01-10T21:51:43.656Z]     --- PASS: TestCreateWithCapabilities/conflict_with_capdrop (0.00s)
21:51:43 [2020-01-10T21:51:43.656Z]     --- PASS: TestCreateWithCapabilities/capadd_capdrop (0.05s)
21:51:43 [2020-01-10T21:51:43.656Z]     --- PASS: TestCreateWithCapabilities/invalid_capabilities (0.01s)
21:51:43 [2020-01-10T21:51:43.656Z]     --- PASS: TestCreateWithCapabilities/empty_capadd (0.07s)
21:51:43 [2020-01-10T21:51:43.656Z]     --- PASS: TestCreateWithCapabilities/empty_capdrop (0.05s)
21:51:43 [2020-01-10T21:51:43.656Z]     --- PASS: TestCreateWithCapabilities/no_capabilities (0.07s)
21:51:43 [2020-01-10T21:51:43.656Z]     --- PASS: TestCreateWithCapabilities/empty_capabilities (0.04s)
21:51:43 [2020-01-10T21:51:43.656Z]     --- PASS: TestCreateWithCapabilities/capabilities_API_v1.39 (0.05s)
21:51:43 [2020-01-10T21:51:43.656Z]     --- PASS: TestCreateWithCapabilities/valid_capabilities (0.04s)
21:51:43 [2020-01-10T21:51:43.656Z]     --- PASS: TestCreateWithCapabilities/duplicate_capabilities (0.06s)
21:51:43 [2020-01-10T21:51:43.656Z] === RUN   TestCreateWithCustomReadonlyPaths
21:51:45 [2020-01-10T21:51:45.694Z] --- PASS: TestCreateWithCustomReadonlyPaths (1.98s)
21:51:45 [2020-01-10T21:51:45.694Z] === RUN   TestCreateWithInvalidHealthcheckParams
21:51:45 [2020-01-10T21:51:45.694Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
21:51:45 [2020-01-10T21:51:45.694Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
21:51:45 [2020-01-10T21:51:45.694Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
21:51:45 [2020-01-10T21:51:45.694Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
21:51:45 [2020-01-10T21:51:45.694Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
21:51:45 [2020-01-10T21:51:45.694Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
21:51:45 [2020-01-10T21:51:45.694Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
21:51:45 [2020-01-10T21:51:45.694Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
21:51:45 [2020-01-10T21:51:45.694Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
21:51:45 [2020-01-10T21:51:45.694Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
21:51:45 [2020-01-10T21:51:45.694Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
21:51:45 [2020-01-10T21:51:45.694Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
21:51:45 [2020-01-10T21:51:45.694Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
21:51:45 [2020-01-10T21:51:45.694Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
21:51:45 [2020-01-10T21:51:45.694Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
21:51:45 [2020-01-10T21:51:45.694Z] --- PASS: TestCreateWithInvalidHealthcheckParams (0.03s)
21:51:45 [2020-01-10T21:51:45.694Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms (0.03s)
21:51:45 [2020-01-10T21:51:45.694Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s (0.03s)
21:51:45 [2020-01-10T21:51:45.694Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0 (0.04s)
21:51:45 [2020-01-10T21:51:45.694Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms (0.05s)
21:51:45 [2020-01-10T21:51:45.694Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms (0.02s)
21:51:45 [2020-01-10T21:51:45.694Z] === RUN   TestContainerStartOnDaemonRestart
21:51:45 [2020-01-10T21:51:45.694Z] === PAUSE TestContainerStartOnDaemonRestart
21:51:45 [2020-01-10T21:51:45.694Z] === RUN   TestDaemonRestartIpcMode
21:51:45 [2020-01-10T21:51:45.694Z] === PAUSE TestDaemonRestartIpcMode
21:51:45 [2020-01-10T21:51:45.694Z] === RUN   TestDiff
21:51:46 [2020-01-10T21:51:46.324Z] --- PASS: TestDiff (0.69s)
21:51:46 [2020-01-10T21:51:46.324Z] === RUN   TestExecWithCloseStdin
21:51:46 [2020-01-10T21:51:46.948Z] --- PASS: TestExecWithCloseStdin (0.78s)
21:51:46 [2020-01-10T21:51:46.948Z] === RUN   TestExec
21:51:47 [2020-01-10T21:51:47.962Z] --- PASS: TestExec (0.79s)
21:51:47 [2020-01-10T21:51:47.962Z] === RUN   TestExecUser
21:51:48 [2020-01-10T21:51:48.588Z] --- PASS: TestExecUser (0.78s)
21:51:48 [2020-01-10T21:51:48.588Z] === RUN   TestExportContainerAndImportImage
21:51:49 [2020-01-10T21:51:49.614Z] --- PASS: TestExportContainerAndImportImage (0.98s)
21:51:49 [2020-01-10T21:51:49.614Z] === RUN   TestExportContainerAfterDaemonRestart
21:51:51 [2020-01-10T21:51:51.099Z] --- PASS: TestExportContainerAfterDaemonRestart (1.59s)
21:51:51 [2020-01-10T21:51:51.099Z] === RUN   TestHealthCheckWorkdir
21:51:52 [2020-01-10T21:51:52.113Z] --- PASS: TestHealthCheckWorkdir (0.95s)
21:51:52 [2020-01-10T21:51:52.113Z] === RUN   TestHealthKillContainer
21:51:55 [2020-01-10T21:51:55.577Z] --- PASS: TestHealthKillContainer (2.89s)
21:51:55 [2020-01-10T21:51:55.577Z] === RUN   TestInspectCpusetInConfigPre120
21:51:55 [2020-01-10T21:51:55.862Z] --- PASS: TestInspectCpusetInConfigPre120 (0.69s)
21:51:55 [2020-01-10T21:51:55.862Z] === RUN   TestIpcModeNone
21:51:56 [2020-01-10T21:51:56.487Z] --- PASS: TestIpcModeNone (0.80s)
21:51:56 [2020-01-10T21:51:56.487Z] === RUN   TestIpcModePrivate
21:51:57 [2020-01-10T21:51:57.503Z] --- PASS: TestIpcModePrivate (0.79s)
21:51:57 [2020-01-10T21:51:57.503Z]     ipcmode_linux_test.go:90: [testIpcPrivateShareable] ipcmode: private, ipcdev: 0:62, shared: false, mustBeShared: false
21:51:57 [2020-01-10T21:51:57.503Z] === RUN   TestIpcModeShareable
21:51:58 [2020-01-10T21:51:58.127Z] --- PASS: TestIpcModeShareable (0.78s)
21:51:58 [2020-01-10T21:51:58.127Z]     ipcmode_linux_test.go:90: [testIpcPrivateShareable] ipcmode: shareable, ipcdev: 0:56, shared: true, mustBeShared: true
21:51:58 [2020-01-10T21:51:58.127Z] === RUN   TestAPIIpcModeShareableAndContainer
21:52:00 [2020-01-10T21:52:00.823Z] --- PASS: TestAPIIpcModeShareableAndContainer (2.33s)
21:52:00 [2020-01-10T21:52:00.823Z] === RUN   TestAPIIpcModeHost
21:52:01 [2020-01-10T21:52:01.110Z] --- PASS: TestAPIIpcModeHost (0.63s)
21:52:01 [2020-01-10T21:52:01.110Z] === RUN   TestDaemonIpcModeShareable
21:52:03 [2020-01-10T21:52:03.140Z] --- PASS: TestDaemonIpcModeShareable (1.75s)
21:52:03 [2020-01-10T21:52:03.140Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:64, shared: true, mustBeShared: true
21:52:03 [2020-01-10T21:52:03.140Z] === RUN   TestDaemonIpcModePrivate
21:52:04 [2020-01-10T21:52:04.625Z] --- PASS: TestDaemonIpcModePrivate (1.68s)
21:52:04 [2020-01-10T21:52:04.625Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:70, shared: false, mustBeShared: false
21:52:04 [2020-01-10T21:52:04.625Z] === RUN   TestDaemonIpcModePrivateFromConfig
21:52:06 [2020-01-10T21:52:06.109Z] --- PASS: TestDaemonIpcModePrivateFromConfig (1.68s)
21:52:06 [2020-01-10T21:52:06.109Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:70, shared: false, mustBeShared: false
21:52:06 [2020-01-10T21:52:06.109Z] === RUN   TestDaemonIpcModeShareableFromConfig
21:52:07 [2020-01-10T21:52:07.790Z] --- PASS: TestDaemonIpcModeShareableFromConfig (1.72s)
21:52:07 [2020-01-10T21:52:07.790Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:64, shared: true, mustBeShared: true
21:52:07 [2020-01-10T21:52:07.790Z] === RUN   TestIpcModeOlderClient
21:52:07 [2020-01-10T21:52:07.790Z] === PAUSE TestIpcModeOlderClient
21:52:07 [2020-01-10T21:52:07.790Z] === RUN   TestKillContainerInvalidSignal
21:52:08 [2020-01-10T21:52:08.824Z] --- PASS: TestKillContainerInvalidSignal (0.68s)
21:52:08 [2020-01-10T21:52:08.824Z] === RUN   TestKillContainer
21:52:08 [2020-01-10T21:52:08.824Z] === RUN   TestKillContainer/no_signal
21:52:09 [2020-01-10T21:52:09.109Z] === RUN   TestKillContainer/non_killing_signal
21:52:09 [2020-01-10T21:52:09.731Z] === RUN   TestKillContainer/killing_signal
21:52:10 [2020-01-10T21:52:10.748Z] --- PASS: TestKillContainer (2.04s)
21:52:10 [2020-01-10T21:52:10.748Z]     --- PASS: TestKillContainer/no_signal (0.64s)
21:52:10 [2020-01-10T21:52:10.748Z]     --- PASS: TestKillContainer/non_killing_signal (0.48s)
21:52:10 [2020-01-10T21:52:10.748Z]     --- PASS: TestKillContainer/killing_signal (0.65s)
21:52:10 [2020-01-10T21:52:10.748Z] === RUN   TestKillWithStopSignalAndRestartPolicies
21:52:10 [2020-01-10T21:52:10.748Z] === RUN   TestKillWithStopSignalAndRestartPolicies/same-signal-disables-restart-policy
21:52:11 [2020-01-10T21:52:11.369Z] === RUN   TestKillWithStopSignalAndRestartPolicies/different-signal-keep-restart-policy
21:52:11 [2020-01-10T21:52:11.992Z] --- PASS: TestKillWithStopSignalAndRestartPolicies (1.34s)
21:52:11 [2020-01-10T21:52:11.992Z]     --- PASS: TestKillWithStopSignalAndRestartPolicies/same-signal-disables-restart-policy (0.63s)
21:52:11 [2020-01-10T21:52:11.992Z]     --- PASS: TestKillWithStopSignalAndRestartPolicies/different-signal-keep-restart-policy (0.47s)
21:52:11 [2020-01-10T21:52:11.992Z] === RUN   TestKillStoppedContainer
21:52:11 [2020-01-10T21:52:11.992Z] --- PASS: TestKillStoppedContainer (0.08s)
21:52:11 [2020-01-10T21:52:11.992Z] === RUN   TestKillStoppedContainerAPIPre120
21:52:11 [2020-01-10T21:52:11.992Z] --- PASS: TestKillStoppedContainerAPIPre120 (0.08s)
21:52:11 [2020-01-10T21:52:11.992Z] === RUN   TestKillDifferentUserContainer
21:52:13 [2020-01-10T21:52:13.012Z] --- PASS: TestKillDifferentUserContainer (0.68s)
21:52:13 [2020-01-10T21:52:13.012Z] === RUN   TestInspectOomKilledTrue
21:52:14 [2020-01-10T21:52:14.040Z] --- PASS: TestInspectOomKilledTrue (1.21s)
21:52:14 [2020-01-10T21:52:14.040Z] === RUN   TestInspectOomKilledFalse
21:52:14 [2020-01-10T21:52:14.664Z] --- PASS: TestInspectOomKilledFalse (0.66s)
21:52:14 [2020-01-10T21:52:14.664Z] === RUN   TestLinksEtcHostsContentMatch
21:52:15 [2020-01-10T21:52:15.286Z] --- PASS: TestLinksEtcHostsContentMatch (0.57s)
21:52:15 [2020-01-10T21:52:15.286Z] === RUN   TestLinksContainerNames
21:52:16 [2020-01-10T21:52:16.767Z] --- PASS: TestLinksContainerNames (1.30s)
21:52:16 [2020-01-10T21:52:16.767Z] === RUN   TestLogsFollowTailEmpty
21:52:17 [2020-01-10T21:52:17.388Z] --- PASS: TestLogsFollowTailEmpty (0.68s)
21:52:17 [2020-01-10T21:52:17.388Z] === RUN   TestContainerNetworkMountsNoChown
21:52:18 [2020-01-10T21:52:18.010Z] --- PASS: TestContainerNetworkMountsNoChown (0.65s)
21:52:18 [2020-01-10T21:52:18.010Z] === RUN   TestMountDaemonRoot
21:52:18 [2020-01-10T21:52:18.010Z] === RUN   TestMountDaemonRoot/default
21:52:18 [2020-01-10T21:52:18.010Z] === PAUSE TestMountDaemonRoot/default
21:52:18 [2020-01-10T21:52:18.010Z] === RUN   TestMountDaemonRoot/private
21:52:18 [2020-01-10T21:52:18.010Z] === PAUSE TestMountDaemonRoot/private
21:52:18 [2020-01-10T21:52:18.010Z] === RUN   TestMountDaemonRoot/rprivate
21:52:18 [2020-01-10T21:52:18.010Z] === PAUSE TestMountDaemonRoot/rprivate
21:52:18 [2020-01-10T21:52:18.010Z] === RUN   TestMountDaemonRoot/slave
21:52:18 [2020-01-10T21:52:18.010Z] === PAUSE TestMountDaemonRoot/slave
21:52:18 [2020-01-10T21:52:18.010Z] === RUN   TestMountDaemonRoot/rslave
21:52:18 [2020-01-10T21:52:18.010Z] === PAUSE TestMountDaemonRoot/rslave
21:52:18 [2020-01-10T21:52:18.010Z] === RUN   TestMountDaemonRoot/shared
21:52:18 [2020-01-10T21:52:18.010Z] === PAUSE TestMountDaemonRoot/shared
21:52:18 [2020-01-10T21:52:18.010Z] === RUN   TestMountDaemonRoot/rshared
21:52:18 [2020-01-10T21:52:18.010Z] === PAUSE TestMountDaemonRoot/rshared
21:52:18 [2020-01-10T21:52:18.010Z] === CONT  TestMountDaemonRoot/default
21:52:18 [2020-01-10T21:52:18.010Z] === CONT  TestMountDaemonRoot/rslave
21:52:18 [2020-01-10T21:52:18.010Z] === RUN   TestMountDaemonRoot/default/bind_root
21:52:18 [2020-01-10T21:52:18.010Z] === CONT  TestMountDaemonRoot/rshared
21:52:18 [2020-01-10T21:52:18.010Z] === RUN   TestMountDaemonRoot/rslave/bind_root
21:52:18 [2020-01-10T21:52:18.010Z] === PAUSE TestMountDaemonRoot/default/bind_root
21:52:18 [2020-01-10T21:52:18.010Z] === RUN   TestMountDaemonRoot/rshared/mount_subpath
21:52:18 [2020-01-10T21:52:18.010Z] === RUN   TestMountDaemonRoot/default/bind_subpath
21:52:18 [2020-01-10T21:52:18.010Z] === PAUSE TestMountDaemonRoot/rshared/mount_subpath
21:52:18 [2020-01-10T21:52:18.010Z] === PAUSE TestMountDaemonRoot/default/bind_subpath
21:52:18 [2020-01-10T21:52:18.010Z] === PAUSE TestMountDaemonRoot/rslave/bind_root
21:52:18 [2020-01-10T21:52:18.010Z] === CONT  TestMountDaemonRoot/shared
21:52:18 [2020-01-10T21:52:18.010Z] === RUN   TestMountDaemonRoot/rshared/bind_root
21:52:18 [2020-01-10T21:52:18.010Z] === RUN   TestMountDaemonRoot/default/mount_root
21:52:18 [2020-01-10T21:52:18.010Z] === RUN   TestMountDaemonRoot/shared/mount_subpath
21:52:18 [2020-01-10T21:52:18.010Z] === PAUSE TestMountDaemonRoot/default/mount_root
21:52:18 [2020-01-10T21:52:18.010Z] === PAUSE TestMountDaemonRoot/rshared/bind_root
21:52:18 [2020-01-10T21:52:18.010Z] === PAUSE TestMountDaemonRoot/shared/mount_subpath
21:52:18 [2020-01-10T21:52:18.010Z] === RUN   TestMountDaemonRoot/default/mount_subpath
21:52:18 [2020-01-10T21:52:18.010Z] === PAUSE TestMountDaemonRoot/default/mount_subpath
21:52:18 [2020-01-10T21:52:18.010Z] === RUN   TestMountDaemonRoot/rshared/bind_subpath
21:52:18 [2020-01-10T21:52:18.010Z] === RUN   TestMountDaemonRoot/rslave/bind_subpath
21:52:18 [2020-01-10T21:52:18.010Z] === PAUSE TestMountDaemonRoot/rshared/bind_subpath
21:52:18 [2020-01-10T21:52:18.010Z] === CONT  TestMountDaemonRoot/rprivate
21:52:18 [2020-01-10T21:52:18.010Z] === RUN   TestMountDaemonRoot/rshared/mount_root
21:52:18 [2020-01-10T21:52:18.010Z] === PAUSE TestMountDaemonRoot/rshared/mount_root
21:52:18 [2020-01-10T21:52:18.010Z] === CONT  TestMountDaemonRoot/slave
21:52:18 [2020-01-10T21:52:18.010Z] === RUN   TestMountDaemonRoot/slave/mount_root
21:52:18 [2020-01-10T21:52:18.010Z] === PAUSE TestMountDaemonRoot/slave/mount_root
21:52:18 [2020-01-10T21:52:18.010Z] === RUN   TestMountDaemonRoot/slave/mount_subpath
21:52:18 [2020-01-10T21:52:18.010Z] === PAUSE TestMountDaemonRoot/slave/mount_subpath
21:52:18 [2020-01-10T21:52:18.010Z] === RUN   TestMountDaemonRoot/slave/bind_root
21:52:18 [2020-01-10T21:52:18.010Z] === PAUSE TestMountDaemonRoot/slave/bind_root
21:52:18 [2020-01-10T21:52:18.010Z] === RUN   TestMountDaemonRoot/rprivate/bind_root
21:52:18 [2020-01-10T21:52:18.010Z] === RUN   TestMountDaemonRoot/slave/bind_subpath
21:52:18 [2020-01-10T21:52:18.010Z] === PAUSE TestMountDaemonRoot/slave/bind_subpath
21:52:18 [2020-01-10T21:52:18.010Z] === PAUSE TestMountDaemonRoot/rprivate/bind_root
21:52:18 [2020-01-10T21:52:18.010Z] === RUN   TestMountDaemonRoot/rprivate/bind_subpath
21:52:18 [2020-01-10T21:52:18.010Z] === PAUSE TestMountDaemonRoot/rprivate/bind_subpath
21:52:18 [2020-01-10T21:52:18.010Z] === RUN   TestMountDaemonRoot/rprivate/mount_root
21:52:18 [2020-01-10T21:52:18.010Z] === PAUSE TestMountDaemonRoot/rprivate/mount_root
21:52:18 [2020-01-10T21:52:18.010Z] === RUN   TestMountDaemonRoot/rprivate/mount_subpath
21:52:18 [2020-01-10T21:52:18.010Z] === PAUSE TestMountDaemonRoot/rprivate/mount_subpath
21:52:18 [2020-01-10T21:52:18.010Z] === CONT  TestMountDaemonRoot/private
21:52:18 [2020-01-10T21:52:18.010Z] === RUN   TestMountDaemonRoot/private/bind_subpath
21:52:18 [2020-01-10T21:52:18.010Z] === PAUSE TestMountDaemonRoot/private/bind_subpath
21:52:18 [2020-01-10T21:52:18.010Z] === RUN   TestMountDaemonRoot/private/mount_root
21:52:18 [2020-01-10T21:52:18.010Z] === PAUSE TestMountDaemonRoot/private/mount_root
21:52:18 [2020-01-10T21:52:18.010Z] === RUN   TestMountDaemonRoot/private/mount_subpath
21:52:18 [2020-01-10T21:52:18.010Z] === PAUSE TestMountDaemonRoot/private/mount_subpath
21:52:18 [2020-01-10T21:52:18.010Z] === RUN   TestMountDaemonRoot/private/bind_root
21:52:18 [2020-01-10T21:52:18.010Z] === PAUSE TestMountDaemonRoot/private/bind_root
21:52:18 [2020-01-10T21:52:18.010Z] === RUN   TestMountDaemonRoot/shared/bind_root
21:52:18 [2020-01-10T21:52:18.010Z] === PAUSE TestMountDaemonRoot/shared/bind_root
21:52:18 [2020-01-10T21:52:18.011Z] === RUN   TestMountDaemonRoot/shared/bind_subpath
21:52:18 [2020-01-10T21:52:18.011Z] === PAUSE TestMountDaemonRoot/shared/bind_subpath
21:52:18 [2020-01-10T21:52:18.011Z] === RUN   TestMountDaemonRoot/shared/mount_root
21:52:18 [2020-01-10T21:52:18.011Z] === PAUSE TestMountDaemonRoot/shared/mount_root
21:52:18 [2020-01-10T21:52:18.011Z] === CONT  TestMountDaemonRoot/default/bind_root
21:52:18 [2020-01-10T21:52:18.011Z] === CONT  TestMountDaemonRoot/default/mount_subpath
21:52:18 [2020-01-10T21:52:18.011Z] === PAUSE TestMountDaemonRoot/rslave/bind_subpath
21:52:18 [2020-01-10T21:52:18.011Z] === RUN   TestMountDaemonRoot/rslave/mount_root
21:52:18 [2020-01-10T21:52:18.011Z] === PAUSE TestMountDaemonRoot/rslave/mount_root
21:52:18 [2020-01-10T21:52:18.011Z] === RUN   TestMountDaemonRoot/rslave/mount_subpath
21:52:18 [2020-01-10T21:52:18.011Z] === PAUSE TestMountDaemonRoot/rslave/mount_subpath
21:52:18 [2020-01-10T21:52:18.011Z] === CONT  TestMountDaemonRoot/default/mount_root
21:52:18 [2020-01-10T21:52:18.011Z] === CONT  TestMountDaemonRoot/default/bind_subpath
21:52:18 [2020-01-10T21:52:18.011Z] === CONT  TestMountDaemonRoot/rshared/mount_subpath
21:52:18 [2020-01-10T21:52:18.011Z] === CONT  TestMountDaemonRoot/rshared/bind_subpath
21:52:18 [2020-01-10T21:52:18.011Z] === CONT  TestMountDaemonRoot/rshared/bind_root
21:52:18 [2020-01-10T21:52:18.011Z] === CONT  TestMountDaemonRoot/rshared/mount_root
21:52:18 [2020-01-10T21:52:18.011Z] === CONT  TestMountDaemonRoot/slave/mount_root
21:52:18 [2020-01-10T21:52:18.011Z] === CONT  TestMountDaemonRoot/rprivate/bind_root
21:52:18 [2020-01-10T21:52:18.011Z] === CONT  TestMountDaemonRoot/private/bind_subpath
21:52:18 [2020-01-10T21:52:18.011Z] === CONT  TestMountDaemonRoot/slave/bind_subpath
21:52:18 [2020-01-10T21:52:18.011Z] === CONT  TestMountDaemonRoot/slave/bind_root
21:52:18 [2020-01-10T21:52:18.011Z] === CONT  TestMountDaemonRoot/slave/mount_subpath
21:52:18 [2020-01-10T21:52:18.011Z] === CONT  TestMountDaemonRoot/shared/mount_subpath
21:52:18 [2020-01-10T21:52:18.011Z] === CONT  TestMountDaemonRoot/rprivate/mount_subpath
21:52:18 [2020-01-10T21:52:18.011Z] === CONT  TestMountDaemonRoot/rprivate/mount_root
21:52:18 [2020-01-10T21:52:18.011Z] === CONT  TestMountDaemonRoot/rprivate/bind_subpath
21:52:18 [2020-01-10T21:52:18.011Z] === CONT  TestMountDaemonRoot/private/bind_root
21:52:18 [2020-01-10T21:52:18.011Z] === CONT  TestMountDaemonRoot/private/mount_subpath
21:52:18 [2020-01-10T21:52:18.011Z] === CONT  TestMountDaemonRoot/private/mount_root
21:52:18 [2020-01-10T21:52:18.297Z] === CONT  TestMountDaemonRoot/rslave/bind_root
21:52:18 [2020-01-10T21:52:18.297Z] === CONT  TestMountDaemonRoot/shared/mount_root
21:52:18 [2020-01-10T21:52:18.297Z] === CONT  TestMountDaemonRoot/shared/bind_subpath
21:52:18 [2020-01-10T21:52:18.297Z] === CONT  TestMountDaemonRoot/shared/bind_root
21:52:18 [2020-01-10T21:52:18.297Z] === CONT  TestMountDaemonRoot/rslave/mount_subpath
21:52:18 [2020-01-10T21:52:18.297Z] === CONT  TestMountDaemonRoot/rslave/mount_root
21:52:18 [2020-01-10T21:52:18.297Z] === CONT  TestMountDaemonRoot/rslave/bind_subpath
21:52:18 [2020-01-10T21:52:18.297Z] --- PASS: TestMountDaemonRoot (0.04s)
21:52:18 [2020-01-10T21:52:18.297Z]     --- PASS: TestMountDaemonRoot/default (0.00s)
21:52:18 [2020-01-10T21:52:18.297Z]         --- PASS: TestMountDaemonRoot/default/mount_root (0.08s)
21:52:18 [2020-01-10T21:52:18.297Z]         --- PASS: TestMountDaemonRoot/default/mount_subpath (0.08s)
21:52:18 [2020-01-10T21:52:18.297Z]         --- PASS: TestMountDaemonRoot/default/bind_root (0.10s)
21:52:18 [2020-01-10T21:52:18.297Z]         --- PASS: TestMountDaemonRoot/default/bind_subpath (0.10s)
21:52:18 [2020-01-10T21:52:18.297Z]     --- PASS: TestMountDaemonRoot/rshared (0.00s)
21:52:18 [2020-01-10T21:52:18.297Z]         --- PASS: TestMountDaemonRoot/rshared/bind_subpath (0.06s)
21:52:18 [2020-01-10T21:52:18.297Z]         --- PASS: TestMountDaemonRoot/rshared/mount_subpath (0.07s)
21:52:18 [2020-01-10T21:52:18.297Z]         --- PASS: TestMountDaemonRoot/rshared/bind_root (0.06s)
21:52:18 [2020-01-10T21:52:18.297Z]         --- PASS: TestMountDaemonRoot/rshared/mount_root (0.06s)
21:52:18 [2020-01-10T21:52:18.297Z]     --- PASS: TestMountDaemonRoot/slave (0.00s)
21:52:18 [2020-01-10T21:52:18.297Z]         --- PASS: TestMountDaemonRoot/slave/mount_root (0.02s)
21:52:18 [2020-01-10T21:52:18.297Z]         --- PASS: TestMountDaemonRoot/slave/bind_subpath (0.02s)
21:52:18 [2020-01-10T21:52:18.297Z]         --- PASS: TestMountDaemonRoot/slave/bind_root (0.03s)
21:52:18 [2020-01-10T21:52:18.297Z]         --- PASS: TestMountDaemonRoot/slave/mount_subpath (0.03s)
21:52:18 [2020-01-10T21:52:18.297Z]     --- PASS: TestMountDaemonRoot/rprivate (0.00s)
21:52:18 [2020-01-10T21:52:18.297Z]         --- PASS: TestMountDaemonRoot/rprivate/bind_root (0.03s)
21:52:18 [2020-01-10T21:52:18.297Z]         --- PASS: TestMountDaemonRoot/rprivate/mount_subpath (0.04s)
21:52:18 [2020-01-10T21:52:18.297Z]         --- PASS: TestMountDaemonRoot/rprivate/mount_root (0.04s)
21:52:18 [2020-01-10T21:52:18.297Z]         --- PASS: TestMountDaemonRoot/rprivate/bind_subpath (0.04s)
21:52:18 [2020-01-10T21:52:18.297Z]     --- PASS: TestMountDaemonRoot/private (0.00s)
21:52:18 [2020-01-10T21:52:18.297Z]         --- PASS: TestMountDaemonRoot/private/bind_subpath (0.03s)
21:52:18 [2020-01-10T21:52:18.297Z]         --- PASS: TestMountDaemonRoot/private/bind_root (0.05s)
21:52:18 [2020-01-10T21:52:18.297Z]         --- PASS: TestMountDaemonRoot/private/mount_root (0.03s)
21:52:18 [2020-01-10T21:52:18.297Z]         --- PASS: TestMountDaemonRoot/private/mount_subpath (0.04s)
21:52:18 [2020-01-10T21:52:18.297Z]     --- PASS: TestMountDaemonRoot/shared (0.00s)
21:52:18 [2020-01-10T21:52:18.297Z]         --- PASS: TestMountDaemonRoot/shared/mount_subpath (0.03s)
21:52:18 [2020-01-10T21:52:18.297Z]         --- PASS: TestMountDaemonRoot/shared/mount_root (0.03s)
21:52:18 [2020-01-10T21:52:18.297Z]         --- PASS: TestMountDaemonRoot/shared/bind_subpath (0.03s)
21:52:18 [2020-01-10T21:52:18.297Z]         --- PASS: TestMountDaemonRoot/shared/bind_root (0.03s)
21:52:18 [2020-01-10T21:52:18.297Z]     --- PASS: TestMountDaemonRoot/rslave (0.00s)
21:52:18 [2020-01-10T21:52:18.297Z]         --- PASS: TestMountDaemonRoot/rslave/bind_root (0.07s)
21:52:18 [2020-01-10T21:52:18.297Z]         --- PASS: TestMountDaemonRoot/rslave/bind_subpath (0.05s)
21:52:18 [2020-01-10T21:52:18.297Z]         --- PASS: TestMountDaemonRoot/rslave/mount_subpath (0.05s)
21:52:18 [2020-01-10T21:52:18.297Z]         --- PASS: TestMountDaemonRoot/rslave/mount_root (0.06s)
21:52:18 [2020-01-10T21:52:18.297Z] === RUN   TestContainerBindMountNonRecursive
21:52:20 [2020-01-10T21:52:20.333Z] --- PASS: TestContainerBindMountNonRecursive (1.73s)
21:52:20 [2020-01-10T21:52:20.333Z] === RUN   TestNetworkNat
21:52:20 [2020-01-10T21:52:20.622Z] --- PASS: TestNetworkNat (0.72s)
21:52:20 [2020-01-10T21:52:20.622Z] === RUN   TestNetworkLocalhostTCPNat
21:52:21 [2020-01-10T21:52:21.647Z] --- PASS: TestNetworkLocalhostTCPNat (0.73s)
21:52:21 [2020-01-10T21:52:21.647Z] === RUN   TestNetworkLoopbackNat
21:52:22 [2020-01-10T21:52:22.269Z] --- PASS: TestNetworkLoopbackNat (0.95s)
21:52:22 [2020-01-10T21:52:22.269Z] === RUN   TestPause
21:52:23 [2020-01-10T21:52:23.288Z] --- PASS: TestPause (0.71s)
21:52:23 [2020-01-10T21:52:23.288Z] === RUN   TestPauseFailsOnWindowsServerContainers
21:52:23 [2020-01-10T21:52:23.288Z] --- SKIP: TestPauseFailsOnWindowsServerContainers (0.00s)
21:52:23 [2020-01-10T21:52:23.288Z]     pause_test.go:54: testEnv.DaemonInfo.OSType != "windows" || testEnv.DaemonInfo.Isolation != "process"
21:52:23 [2020-01-10T21:52:23.288Z] === RUN   TestPauseStopPausedContainer
21:52:23 [2020-01-10T21:52:23.906Z] --- PASS: TestPauseStopPausedContainer (0.70s)
21:52:23 [2020-01-10T21:52:23.906Z] === RUN   TestPsFilter
21:52:23 [2020-01-10T21:52:23.906Z] --- PASS: TestPsFilter (0.20s)
21:52:23 [2020-01-10T21:52:23.906Z] === RUN   TestRemoveContainerWithRemovedVolume
21:52:24 [2020-01-10T21:52:24.924Z] --- PASS: TestRemoveContainerWithRemovedVolume (0.68s)
21:52:24 [2020-01-10T21:52:24.924Z] === RUN   TestRemoveContainerWithVolume
21:52:25 [2020-01-10T21:52:25.554Z] --- PASS: TestRemoveContainerWithVolume (0.67s)
21:52:25 [2020-01-10T21:52:25.554Z] === RUN   TestRemoveContainerRunning
21:52:26 [2020-01-10T21:52:26.175Z] --- PASS: TestRemoveContainerRunning (0.69s)
21:52:26 [2020-01-10T21:52:26.175Z] === RUN   TestRemoveContainerForceRemoveRunning
21:52:26 [2020-01-10T21:52:26.793Z] --- PASS: TestRemoveContainerForceRemoveRunning (0.66s)
21:52:26 [2020-01-10T21:52:26.793Z] === RUN   TestRemoveInvalidContainer
21:52:26 [2020-01-10T21:52:26.793Z] --- PASS: TestRemoveInvalidContainer (0.04s)
21:52:26 [2020-01-10T21:52:26.793Z] === RUN   TestRenameLinkedContainer
21:52:29 [2020-01-10T21:52:29.524Z] --- PASS: TestRenameLinkedContainer (2.58s)
21:52:29 [2020-01-10T21:52:29.524Z] === RUN   TestRenameStoppedContainer
21:52:30 [2020-01-10T21:52:30.154Z] --- PASS: TestRenameStoppedContainer (0.68s)
21:52:30 [2020-01-10T21:52:30.154Z] === RUN   TestRenameRunningContainerAndReuse
21:52:31 [2020-01-10T21:52:31.660Z] --- PASS: TestRenameRunningContainerAndReuse (1.34s)
21:52:31 [2020-01-10T21:52:31.660Z] === RUN   TestRenameInvalidName
21:52:31 [2020-01-10T21:52:31.946Z] --- PASS: TestRenameInvalidName (0.72s)
21:52:31 [2020-01-10T21:52:31.946Z] === RUN   TestRenameAnonymousContainer
21:52:34 [2020-01-10T21:52:34.645Z] --- PASS: TestRenameAnonymousContainer (2.42s)
21:52:34 [2020-01-10T21:52:34.645Z] === RUN   TestRenameContainerWithSameName
21:52:35 [2020-01-10T21:52:35.268Z] --- PASS: TestRenameContainerWithSameName (0.67s)
21:52:35 [2020-01-10T21:52:35.268Z] === RUN   TestRenameContainerWithLinkedContainer
21:52:36 [2020-01-10T21:52:36.778Z] --- PASS: TestRenameContainerWithLinkedContainer (1.39s)
21:52:36 [2020-01-10T21:52:36.778Z] === RUN   TestResize
21:52:37 [2020-01-10T21:52:37.463Z] --- PASS: TestResize (0.88s)
21:52:37 [2020-01-10T21:52:37.463Z] === RUN   TestResizeWithInvalidSize
21:52:38 [2020-01-10T21:52:38.127Z] --- PASS: TestResizeWithInvalidSize (0.72s)
21:52:38 [2020-01-10T21:52:38.127Z] === RUN   TestResizeWhenContainerNotStarted
21:52:38 [2020-01-10T21:52:38.778Z] --- PASS: TestResizeWhenContainerNotStarted (0.68s)
21:52:38 [2020-01-10T21:52:38.778Z] === RUN   TestDaemonRestartKillContainers
21:52:38 [2020-01-10T21:52:38.778Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
21:52:38 [2020-01-10T21:52:38.778Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
21:52:38 [2020-01-10T21:52:38.778Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
21:52:38 [2020-01-10T21:52:38.778Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
21:52:38 [2020-01-10T21:52:38.778Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
21:52:38 [2020-01-10T21:52:38.778Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
21:52:38 [2020-01-10T21:52:38.778Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
21:52:38 [2020-01-10T21:52:38.778Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
21:52:38 [2020-01-10T21:52:38.778Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
21:52:38 [2020-01-10T21:52:38.778Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
21:52:38 [2020-01-10T21:52:38.778Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
21:52:38 [2020-01-10T21:52:38.778Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
21:52:38 [2020-01-10T21:52:38.778Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
21:52:38 [2020-01-10T21:52:38.778Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
21:52:38 [2020-01-10T21:52:38.778Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
21:52:38 [2020-01-10T21:52:38.778Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
21:52:38 [2020-01-10T21:52:38.778Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
21:52:38 [2020-01-10T21:52:38.778Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
21:52:38 [2020-01-10T21:52:38.778Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
21:52:38 [2020-01-10T21:52:38.778Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
21:52:38 [2020-01-10T21:52:38.778Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
21:52:38 [2020-01-10T21:52:38.778Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
21:52:38 [2020-01-10T21:52:38.778Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
21:52:38 [2020-01-10T21:52:38.778Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
21:52:38 [2020-01-10T21:52:38.778Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
21:52:38 [2020-01-10T21:52:38.778Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
21:52:38 [2020-01-10T21:52:38.778Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
21:52:38 [2020-01-10T21:52:38.778Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
21:52:41 [2020-01-10T21:52:41.526Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
21:52:41 [2020-01-10T21:52:41.526Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
21:52:42 [2020-01-10T21:52:42.158Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
21:52:42 [2020-01-10T21:52:42.158Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
21:52:43 [2020-01-10T21:52:43.228Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
21:52:43 [2020-01-10T21:52:43.228Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
21:52:45 [2020-01-10T21:52:45.349Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
21:52:45 [2020-01-10T21:52:45.648Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
21:52:48 [2020-01-10T21:52:48.432Z] --- PASS: TestDaemonRestartKillContainers (0.00s)
21:52:48 [2020-01-10T21:52:48.432Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon (2.22s)
21:52:48 [2020-01-10T21:52:48.432Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon (2.30s)
21:52:48 [2020-01-10T21:52:48.432Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon (3.12s)
21:52:48 [2020-01-10T21:52:48.432Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon (3.37s)
21:52:48 [2020-01-10T21:52:48.432Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon (1.96s)
21:52:48 [2020-01-10T21:52:48.432Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon (2.03s)
21:52:48 [2020-01-10T21:52:48.432Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon (3.40s)
21:52:48 [2020-01-10T21:52:48.432Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon (3.42s)
21:52:48 [2020-01-10T21:52:48.432Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon (4.39s)
21:52:48 [2020-01-10T21:52:48.432Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon (4.47s)
21:52:48 [2020-01-10T21:52:48.432Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon (2.95s)
21:52:48 [2020-01-10T21:52:48.432Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon (2.67s)
21:52:48 [2020-01-10T21:52:48.432Z] === RUN   TestCgroupNamespacesRun
21:52:49 [2020-01-10T21:52:49.975Z] --- PASS: TestCgroupNamespacesRun (1.63s)
21:52:49 [2020-01-10T21:52:49.975Z] === RUN   TestCgroupNamespacesRunPrivileged
21:52:51 [2020-01-10T21:52:51.470Z] --- PASS: TestCgroupNamespacesRunPrivileged (1.62s)
21:52:51 [2020-01-10T21:52:51.470Z] === RUN   TestCgroupNamespacesRunDaemonHostMode
21:52:53 [2020-01-10T21:52:53.544Z] --- PASS: TestCgroupNamespacesRunDaemonHostMode (1.63s)
21:52:53 [2020-01-10T21:52:53.544Z] === RUN   TestCgroupNamespacesRunHostMode
21:52:55 [2020-01-10T21:52:55.043Z] --- PASS: TestCgroupNamespacesRunHostMode (1.64s)
21:52:55 [2020-01-10T21:52:55.044Z] === RUN   TestCgroupNamespacesRunPrivateMode
21:52:56 [2020-01-10T21:52:56.534Z] --- PASS: TestCgroupNamespacesRunPrivateMode (1.60s)
21:52:56 [2020-01-10T21:52:56.534Z] === RUN   TestCgroupNamespacesRunPrivilegedAndPrivate
21:52:57 [2020-01-10T21:52:57.555Z] --- PASS: TestCgroupNamespacesRunPrivilegedAndPrivate (0.94s)
21:52:57 [2020-01-10T21:52:57.556Z] === RUN   TestCgroupNamespacesRunInvalidMode
21:52:58 [2020-01-10T21:52:58.179Z] --- PASS: TestCgroupNamespacesRunInvalidMode (0.92s)
21:52:58 [2020-01-10T21:52:58.179Z] === RUN   TestCgroupNamespacesRunOlderClient
21:53:00 [2020-01-10T21:53:00.225Z] --- PASS: TestCgroupNamespacesRunOlderClient (1.68s)
21:53:00 [2020-01-10T21:53:00.225Z] === RUN   TestKernelTCPMemory
21:53:00 [2020-01-10T21:53:00.851Z] --- PASS: TestKernelTCPMemory (0.79s)
21:53:00 [2020-01-10T21:53:00.851Z] === RUN   TestNISDomainname
21:53:01 [2020-01-10T21:53:01.866Z] --- PASS: TestNISDomainname (0.91s)
21:53:01 [2020-01-10T21:53:01.866Z] === RUN   TestHostnameDnsResolution
21:53:02 [2020-01-10T21:53:02.880Z] --- PASS: TestHostnameDnsResolution (1.06s)
21:53:02 [2020-01-10T21:53:02.880Z] === RUN   TestStats
21:53:04 [2020-01-10T21:53:04.912Z] --- PASS: TestStats (1.96s)
21:53:04 [2020-01-10T21:53:04.912Z] === RUN   TestStopContainerWithTimeout
21:53:04 [2020-01-10T21:53:04.912Z] === RUN   TestStopContainerWithTimeout/0
21:53:04 [2020-01-10T21:53:04.912Z] === PAUSE TestStopContainerWithTimeout/0
21:53:04 [2020-01-10T21:53:04.912Z] === RUN   TestStopContainerWithTimeout/1
21:53:04 [2020-01-10T21:53:04.912Z] === PAUSE TestStopContainerWithTimeout/1
21:53:04 [2020-01-10T21:53:04.912Z] === RUN   TestStopContainerWithTimeout/3
21:53:04 [2020-01-10T21:53:04.912Z] === PAUSE TestStopContainerWithTimeout/3
21:53:04 [2020-01-10T21:53:04.912Z] === RUN   TestStopContainerWithTimeout/-1
21:53:04 [2020-01-10T21:53:04.912Z] === PAUSE TestStopContainerWithTimeout/-1
21:53:04 [2020-01-10T21:53:04.912Z] === CONT  TestStopContainerWithTimeout/-1
21:53:04 [2020-01-10T21:53:04.912Z] === CONT  TestStopContainerWithTimeout/1
21:53:04 [2020-01-10T21:53:04.912Z] === CONT  TestStopContainerWithTimeout/0
21:53:04 [2020-01-10T21:53:04.912Z] === CONT  TestStopContainerWithTimeout/3
21:53:08 [2020-01-10T21:53:08.396Z] --- PASS: TestStopContainerWithTimeout (0.03s)
21:53:08 [2020-01-10T21:53:08.396Z]     --- PASS: TestStopContainerWithTimeout/0 (1.31s)
21:53:08 [2020-01-10T21:53:08.396Z]     --- PASS: TestStopContainerWithTimeout/1 (2.26s)
21:53:08 [2020-01-10T21:53:08.396Z]     --- PASS: TestStopContainerWithTimeout/-1 (2.74s)
21:53:08 [2020-01-10T21:53:08.396Z]     --- PASS: TestStopContainerWithTimeout/3 (3.27s)
21:53:08 [2020-01-10T21:53:08.396Z] === RUN   TestDeleteDevicemapper
21:53:08 [2020-01-10T21:53:08.396Z] --- SKIP: TestDeleteDevicemapper (0.00s)
21:53:08 [2020-01-10T21:53:08.396Z]     stop_linux_test.go:74: testEnv.DaemonInfo.Driver != "devicemapper"
21:53:08 [2020-01-10T21:53:08.396Z] === RUN   TestStopContainerWithRestartPolicyAlways
21:53:09 [2020-01-10T21:53:09.901Z] --- PASS: TestStopContainerWithRestartPolicyAlways (1.97s)
21:53:09 [2020-01-10T21:53:09.902Z] === RUN   TestUpdateMemory
21:53:10 [2020-01-10T21:53:10.920Z] --- PASS: TestUpdateMemory (0.90s)
21:53:10 [2020-01-10T21:53:10.920Z] === RUN   TestUpdateCPUQuota
21:53:11 [2020-01-10T21:53:11.935Z] --- PASS: TestUpdateCPUQuota (1.14s)
21:53:11 [2020-01-10T21:53:11.935Z] === RUN   TestUpdatePidsLimit
21:53:11 [2020-01-10T21:53:11.935Z] === RUN   TestUpdatePidsLimit/update_from_none
21:53:12 [2020-01-10T21:53:12.560Z] === RUN   TestUpdatePidsLimit/no_change
21:53:12 [2020-01-10T21:53:12.560Z] === RUN   TestUpdatePidsLimit/update_lower
21:53:12 [2020-01-10T21:53:12.878Z] === RUN   TestUpdatePidsLimit/update_on_old_api_ignores_value
21:53:13 [2020-01-10T21:53:13.500Z] === RUN   TestUpdatePidsLimit/unset_limit_with_zero
21:53:13 [2020-01-10T21:53:13.787Z] === RUN   TestUpdatePidsLimit/unset_limit_with_minus_one
21:53:14 [2020-01-10T21:53:14.073Z] === RUN   TestUpdatePidsLimit/unset_limit_with_minus_two
21:53:15 [2020-01-10T21:53:15.565Z] --- PASS: TestUpdatePidsLimit (3.36s)
21:53:15 [2020-01-10T21:53:15.565Z]     --- PASS: TestUpdatePidsLimit/update_from_none (0.34s)
21:53:15 [2020-01-10T21:53:15.565Z]     --- PASS: TestUpdatePidsLimit/no_change (0.31s)
21:53:15 [2020-01-10T21:53:15.565Z]     --- PASS: TestUpdatePidsLimit/update_lower (0.30s)
21:53:15 [2020-01-10T21:53:15.565Z]     --- PASS: TestUpdatePidsLimit/update_on_old_api_ignores_value (0.34s)
21:53:15 [2020-01-10T21:53:15.565Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_zero (0.35s)
21:53:15 [2020-01-10T21:53:15.565Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_minus_one (0.38s)
21:53:15 [2020-01-10T21:53:15.565Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_minus_two (0.33s)
21:53:15 [2020-01-10T21:53:15.565Z] === RUN   TestUpdateRestartPolicy
21:53:28 [2020-01-10T21:53:28.264Z] --- PASS: TestUpdateRestartPolicy (12.02s)
21:53:28 [2020-01-10T21:53:28.264Z] === RUN   TestUpdateRestartWithAutoRemove
21:53:28 [2020-01-10T21:53:28.264Z] --- PASS: TestUpdateRestartWithAutoRemove (0.71s)
21:53:28 [2020-01-10T21:53:28.264Z] === RUN   TestWaitNonBlocked
21:53:28 [2020-01-10T21:53:28.264Z] === RUN   TestWaitNonBlocked/wait-nonblocking-exit-0
21:53:28 [2020-01-10T21:53:28.264Z] === PAUSE TestWaitNonBlocked/wait-nonblocking-exit-0
21:53:28 [2020-01-10T21:53:28.264Z] === RUN   TestWaitNonBlocked/wait-nonblocking-exit-random
21:53:28 [2020-01-10T21:53:28.264Z] === PAUSE TestWaitNonBlocked/wait-nonblocking-exit-random
21:53:28 [2020-01-10T21:53:28.264Z] === CONT  TestWaitNonBlocked/wait-nonblocking-exit-0
21:53:28 [2020-01-10T21:53:28.264Z] === CONT  TestWaitNonBlocked/wait-nonblocking-exit-random
21:53:28 [2020-01-10T21:53:28.885Z] --- PASS: TestWaitNonBlocked (0.03s)
21:53:28 [2020-01-10T21:53:28.885Z]     --- PASS: TestWaitNonBlocked/wait-nonblocking-exit-random (0.85s)
21:53:28 [2020-01-10T21:53:28.885Z]     --- PASS: TestWaitNonBlocked/wait-nonblocking-exit-0 (0.88s)
21:53:28 [2020-01-10T21:53:28.885Z] === RUN   TestWaitBlocked
21:53:29 [2020-01-10T21:53:29.171Z] === RUN   TestWaitBlocked/test-wait-blocked-exit-zero
21:53:29 [2020-01-10T21:53:29.171Z] === PAUSE TestWaitBlocked/test-wait-blocked-exit-zero
21:53:29 [2020-01-10T21:53:29.171Z] === RUN   TestWaitBlocked/test-wait-blocked-exit-random
21:53:29 [2020-01-10T21:53:29.171Z] === PAUSE TestWaitBlocked/test-wait-blocked-exit-random
21:53:29 [2020-01-10T21:53:29.171Z] === CONT  TestWaitBlocked/test-wait-blocked-exit-zero
21:53:29 [2020-01-10T21:53:29.171Z] === CONT  TestWaitBlocked/test-wait-blocked-exit-random
21:53:30 [2020-01-10T21:53:30.187Z] --- PASS: TestWaitBlocked (0.04s)
21:53:30 [2020-01-10T21:53:30.187Z]     --- PASS: TestWaitBlocked/test-wait-blocked-exit-zero (0.94s)
21:53:30 [2020-01-10T21:53:30.187Z]     --- PASS: TestWaitBlocked/test-wait-blocked-exit-random (1.01s)
21:53:30 [2020-01-10T21:53:30.187Z] === CONT  TestContainerStartOnDaemonRestart
21:53:30 [2020-01-10T21:53:30.187Z] === CONT  TestIpcModeOlderClient
21:53:30 [2020-01-10T21:53:30.187Z] === CONT  TestDaemonRestartIpcMode
21:53:30 [2020-01-10T21:53:30.187Z] --- PASS: TestIpcModeOlderClient (0.17s)
21:53:33 [2020-01-10T21:53:33.683Z] --- PASS: TestContainerStartOnDaemonRestart (3.33s)
21:53:33 [2020-01-10T21:53:33.967Z] --- PASS: TestDaemonRestartIpcMode (3.87s)
21:53:33 [2020-01-10T21:53:33.967Z] PASS
21:53:33 [2020-01-10T21:53:33.967Z] 
21:53:33 [2020-01-10T21:53:33.967Z] === Skipped
21:53:33 [2020-01-10T21:53:33.967Z] === SKIP: ppc64le.integration.container TestCheckpoint (0.00s)
21:53:33 [2020-01-10T21:53:33.967Z]     checkpoint_test.go:33: TestCheckpoint is broken; see https://github.com/moby/moby/issues/38963
21:53:33 [2020-01-10T21:53:33.967Z] 
21:53:33 [2020-01-10T21:53:33.967Z] === SKIP: ppc64le.integration.container TestPauseFailsOnWindowsServerContainers (0.00s)
21:53:33 [2020-01-10T21:53:33.967Z]     pause_test.go:54: testEnv.DaemonInfo.OSType != "windows" || testEnv.DaemonInfo.Isolation != "process"
21:53:33 [2020-01-10T21:53:33.967Z] 
21:53:33 [2020-01-10T21:53:33.967Z] === SKIP: ppc64le.integration.container TestDeleteDevicemapper (0.00s)
21:53:33 [2020-01-10T21:53:33.967Z]     stop_linux_test.go:74: testEnv.DaemonInfo.Driver != "devicemapper"
21:53:33 [2020-01-10T21:53:33.967Z] 
21:53:33 [2020-01-10T21:53:33.967Z] 
21:53:33 [2020-01-10T21:53:33.967Z] DONE 197 tests, 3 skipped in 115.589s
21:53:33 [2020-01-10T21:53:33.967Z] Running /go/src/github.com/docker/docker/integration/image (ppc64le.integration.image) flags=-test.v -test.timeout=120m 
21:53:33 [2020-01-10T21:53:33.967Z] ++ 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
21:53:33 [2020-01-10T21:53:33.967Z] ++ set -e
21:53:33 [2020-01-10T21:53:33.967Z] ++ '[' -n 0 ']'
21:53:33 [2020-01-10T21:53:33.967Z] ++ set -x
21:53:33 [2020-01-10T21:53:33.967Z] ++ 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
21:53:33 [2020-01-10T21:53:33.967Z] INFO: Testing against a local daemon
21:53:33 [2020-01-10T21:53:33.967Z] === RUN   TestCommitInheritsEnv
21:53:34 [2020-01-10T21:53:34.587Z] --- PASS: TestCommitInheritsEnv (0.41s)
21:53:34 [2020-01-10T21:53:34.587Z] === RUN   TestImportExtremelyLargeImageWorks
21:53:34 [2020-01-10T21:53:34.587Z] === PAUSE TestImportExtremelyLargeImageWorks
21:53:34 [2020-01-10T21:53:34.587Z] === RUN   TestImagesFilterMultiReference
21:53:34 [2020-01-10T21:53:34.587Z] --- PASS: TestImagesFilterMultiReference (0.07s)
21:53:34 [2020-01-10T21:53:34.587Z] === RUN   TestImagePullPlatformInvalid
21:53:34 [2020-01-10T21:53:34.587Z] --- PASS: TestImagePullPlatformInvalid (0.05s)
21:53:34 [2020-01-10T21:53:34.587Z] === RUN   TestRemoveImageOrphaning
21:53:35 [2020-01-10T21:53:35.208Z] --- PASS: TestRemoveImageOrphaning (0.43s)
21:53:35 [2020-01-10T21:53:35.208Z] === RUN   TestRemoveImageGarbageCollector
21:53:35 [2020-01-10T21:53:35.208Z] --- SKIP: TestRemoveImageGarbageCollector (0.00s)
21:53:35 [2020-01-10T21:53:35.208Z]     remove_unix_test.go:36: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
21:53:35 [2020-01-10T21:53:35.208Z] === RUN   TestTagUnprefixedRepoByNameOrName
21:53:35 [2020-01-10T21:53:35.208Z] --- PASS: TestTagUnprefixedRepoByNameOrName (0.04s)
21:53:35 [2020-01-10T21:53:35.208Z] === RUN   TestTagInvalidReference
21:53:35 [2020-01-10T21:53:35.208Z] --- PASS: TestTagInvalidReference (0.04s)
21:53:35 [2020-01-10T21:53:35.208Z] === RUN   TestTagValidPrefixedRepo
21:53:35 [2020-01-10T21:53:35.208Z] --- PASS: TestTagValidPrefixedRepo (0.07s)
21:53:35 [2020-01-10T21:53:35.208Z] === RUN   TestTagExistedNameWithoutForce
21:53:35 [2020-01-10T21:53:35.208Z] --- PASS: TestTagExistedNameWithoutForce (0.04s)
21:53:35 [2020-01-10T21:53:35.208Z] === RUN   TestTagOfficialNames
21:53:35 [2020-01-10T21:53:35.208Z] --- PASS: TestTagOfficialNames (0.05s)
21:53:35 [2020-01-10T21:53:35.208Z] === RUN   TestTagMatchesDigest
21:53:35 [2020-01-10T21:53:35.208Z] --- PASS: TestTagMatchesDigest (0.03s)
21:53:35 [2020-01-10T21:53:35.208Z] === CONT  TestImportExtremelyLargeImageWorks
21:58:42 [2020-01-10T21:58:42.861Z] --- PASS: TestImportExtremelyLargeImageWorks (298.80s)
21:58:42 [2020-01-10T21:58:42.861Z] PASS
21:58:42 [2020-01-10T21:58:42.861Z] 
21:58:42 [2020-01-10T21:58:42.861Z] === Skipped
21:58:42 [2020-01-10T21:58:42.861Z] === SKIP: ppc64le.integration.image TestRemoveImageGarbageCollector (0.00s)
21:58:42 [2020-01-10T21:58:42.861Z]     remove_unix_test.go:36: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
21:58:42 [2020-01-10T21:58:42.861Z] 
21:58:42 [2020-01-10T21:58:42.861Z] 
21:58:42 [2020-01-10T21:58:42.861Z] DONE 12 tests, 1 skipped in 300.158s
21:58:42 [2020-01-10T21:58:42.861Z] Running /go/src/github.com/docker/docker/integration/network (ppc64le.integration.network) flags=-test.v -test.timeout=120m 
21:58:42 [2020-01-10T21:58:42.861Z] ++ 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
21:58:42 [2020-01-10T21:58:42.861Z] ++ set -e
21:58:42 [2020-01-10T21:58:42.861Z] ++ '[' -n 0 ']'
21:58:42 [2020-01-10T21:58:42.861Z] ++ set -x
21:58:42 [2020-01-10T21:58:42.861Z] ++ 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
21:58:42 [2020-01-10T21:58:42.861Z] INFO: Testing against a local daemon
21:58:42 [2020-01-10T21:58:42.861Z] === RUN   TestNetworkCreateDelete
21:58:42 [2020-01-10T21:58:42.861Z] --- PASS: TestNetworkCreateDelete (0.22s)
21:58:42 [2020-01-10T21:58:42.861Z] === RUN   TestDockerNetworkDeletePreferID
21:58:42 [2020-01-10T21:58:42.861Z] --- PASS: TestDockerNetworkDeletePreferID (0.59s)
21:58:42 [2020-01-10T21:58:42.861Z] === RUN   TestInspectNetwork
21:58:42 [2020-01-10T21:58:42.861Z] === RUN   TestInspectNetwork/full_network_id
21:58:42 [2020-01-10T21:58:42.861Z] === RUN   TestInspectNetwork/partial_network_id
21:58:42 [2020-01-10T21:58:42.861Z] === RUN   TestInspectNetwork/network_name
21:58:42 [2020-01-10T21:58:42.861Z] === RUN   TestInspectNetwork/network_name_and_swarm_scope
21:58:42 [2020-01-10T21:58:42.861Z] --- PASS: TestInspectNetwork (7.80s)
21:58:42 [2020-01-10T21:58:42.861Z]     --- PASS: TestInspectNetwork/full_network_id (0.00s)
21:58:42 [2020-01-10T21:58:42.861Z]     --- PASS: TestInspectNetwork/partial_network_id (0.00s)
21:58:42 [2020-01-10T21:58:42.861Z]     --- PASS: TestInspectNetwork/network_name (0.00s)
21:58:42 [2020-01-10T21:58:42.861Z]     --- PASS: TestInspectNetwork/network_name_and_swarm_scope (0.00s)
21:58:42 [2020-01-10T21:58:42.861Z] === RUN   TestRunContainerWithBridgeNone
21:58:45 [2020-01-10T21:58:45.559Z] --- PASS: TestRunContainerWithBridgeNone (2.30s)
21:58:45 [2020-01-10T21:58:45.559Z] === RUN   TestNetworkInvalidJSON
21:58:45 [2020-01-10T21:58:45.559Z] === RUN   TestNetworkInvalidJSON//networks/create
21:58:45 [2020-01-10T21:58:45.559Z] === PAUSE TestNetworkInvalidJSON//networks/create
21:58:45 [2020-01-10T21:58:45.559Z] === RUN   TestNetworkInvalidJSON//networks/bridge/connect
21:58:45 [2020-01-10T21:58:45.559Z] === PAUSE TestNetworkInvalidJSON//networks/bridge/connect
21:58:45 [2020-01-10T21:58:45.559Z] === RUN   TestNetworkInvalidJSON//networks/bridge/disconnect
21:58:45 [2020-01-10T21:58:45.559Z] === PAUSE TestNetworkInvalidJSON//networks/bridge/disconnect
21:58:45 [2020-01-10T21:58:45.559Z] === CONT  TestNetworkInvalidJSON//networks/create
21:58:45 [2020-01-10T21:58:45.559Z] === CONT  TestNetworkInvalidJSON//networks/bridge/disconnect
21:58:45 [2020-01-10T21:58:45.559Z] === CONT  TestNetworkInvalidJSON//networks/bridge/connect
21:58:45 [2020-01-10T21:58:45.559Z] --- PASS: TestNetworkInvalidJSON (0.04s)
21:58:45 [2020-01-10T21:58:45.559Z]     --- PASS: TestNetworkInvalidJSON//networks/bridge/disconnect (0.00s)
21:58:45 [2020-01-10T21:58:45.559Z]     --- PASS: TestNetworkInvalidJSON//networks/bridge/connect (0.00s)
21:58:45 [2020-01-10T21:58:45.559Z]     --- PASS: TestNetworkInvalidJSON//networks/create (0.00s)
21:58:45 [2020-01-10T21:58:45.559Z] === RUN   TestDaemonRestartWithLiveRestore
21:58:46 [2020-01-10T21:58:46.188Z] --- PASS: TestDaemonRestartWithLiveRestore (1.07s)
21:58:46 [2020-01-10T21:58:46.188Z] === RUN   TestDaemonDefaultNetworkPools
21:58:47 [2020-01-10T21:58:47.209Z] --- PASS: TestDaemonDefaultNetworkPools (0.82s)
21:58:47 [2020-01-10T21:58:47.209Z] === RUN   TestDaemonRestartWithExistingNetwork
21:58:48 [2020-01-10T21:58:48.236Z] --- PASS: TestDaemonRestartWithExistingNetwork (1.24s)
21:58:48 [2020-01-10T21:58:48.236Z] === RUN   TestDaemonRestartWithExistingNetworkWithDefaultPoolRange
21:58:50 [2020-01-10T21:58:50.289Z] --- PASS: TestDaemonRestartWithExistingNetworkWithDefaultPoolRange (1.58s)
21:58:50 [2020-01-10T21:58:50.289Z] === RUN   TestDaemonWithBipAndDefaultNetworkPool
21:58:50 [2020-01-10T21:58:50.574Z] --- PASS: TestDaemonWithBipAndDefaultNetworkPool (0.58s)
21:58:50 [2020-01-10T21:58:50.574Z] === RUN   TestServiceWithPredefinedNetwork
21:58:53 [2020-01-10T21:58:53.282Z] --- PASS: TestServiceWithPredefinedNetwork (2.36s)
21:58:53 [2020-01-10T21:58:53.282Z] === RUN   TestServiceRemoveKeepsIngressNetwork
21:58:53 [2020-01-10T21:58:53.282Z] --- SKIP: TestServiceRemoveKeepsIngressNetwork (0.00s)
21:58:53 [2020-01-10T21:58:53.282Z]     service_test.go:230: FLAKY_TEST
21:58:53 [2020-01-10T21:58:53.282Z] === RUN   TestServiceWithDataPathPortInit
21:59:08 [2020-01-10T21:59:08.645Z] --- PASS: TestServiceWithDataPathPortInit (14.79s)
21:59:08 [2020-01-10T21:59:08.645Z] === RUN   TestServiceWithDefaultAddressPoolInit
21:59:15 [2020-01-10T21:59:15.499Z] --- PASS: TestServiceWithDefaultAddressPoolInit (7.35s)
21:59:15 [2020-01-10T21:59:15.499Z]     service_test.go:418: TestServiceWithDefaultAddressPoolInit: NetworkInspect: {Name:sthiraTestServiceWithDefaultAddressPoolInit ID:gp1t39sxemd975ppa2h9qest2 Created:2020-01-10 21:59:08.753715892 +0000 UTC Scope:swarm Driver:overlay EnableIPv6:false IPAM:{Driver:default Options:map[] Config:[{Subnet:20.20.1.0/24 IPRange: Gateway:20.20.1.1 AuxAddress:map[]}]} Internal:false Attachable:false Ingress:false ConfigFrom:{Network:} ConfigOnly:false Containers:map[619b0ffa6915c35c9110dcacc06977b1fc1ecbe561d73d13f3c9c99725507730:{Name:TestServiceTestServiceWithDefaultAddressPoolInit.1.8kqkgiwunrr7xuo4wnwfxteyg EndpointID:418d6e5151d17aad02a9418228cf959a84136f74dad920b44c3d60c0eaa37b9b MacAddress:02:42:14:14:01:03 IPv4Address:20.20.1.3/24 IPv6Address:} lb-sthiraTestServiceWithDefaultAddressPoolInit:{Name:sthiraTestServiceWithDefaultAddressPoolInit-endpoint EndpointID:37e36ed74139b8b3bffecf88b1039bc5f6f6959c46c23163702117e0bee69ee5 MacAddress:02:42:14:14:01:04 IPv4Address:20.20.1.4/24 IPv6Address:}] Options:map[com.docker.network.driver.overlay.vxlanid_list:4097] Labels:map[] Peers:[{Name:9c46dd8854b9 IP:127.0.0.1}] Services:map[TestServiceTestServiceWithDefaultAddressPoolInit:{VIP:20.20.1.2 Ports:[] LocalLBIndex:256 Tasks:[{Name:TestServiceTestServiceWithDefaultAddressPoolInit.1.8kqkgiwunrr7xuo4wnwfxteyg EndpointID:418d6e5151d17aad02a9418228cf959a84136f74dad920b44c3d60c0eaa37b9b EndpointIP:20.20.1.3 Info:map[Host IP:127.0.0.1]}]}]}
21:59:15 [2020-01-10T21:59:15.499Z] PASS
21:59:15 [2020-01-10T21:59:15.499Z] 
21:59:15 [2020-01-10T21:59:15.499Z] === Skipped
21:59:15 [2020-01-10T21:59:15.499Z] === SKIP: ppc64le.integration.network TestServiceRemoveKeepsIngressNetwork (0.00s)
21:59:15 [2020-01-10T21:59:15.499Z]     service_test.go:230: FLAKY_TEST
21:59:15 [2020-01-10T21:59:15.499Z] 
21:59:15 [2020-01-10T21:59:15.499Z] 
21:59:15 [2020-01-10T21:59:15.499Z] DONE 21 tests, 1 skipped in 40.828s
21:59:15 [2020-01-10T21:59:15.499Z] Running /go/src/github.com/docker/docker/integration/network/ipvlan (ppc64le.integration.network.ipvlan) flags=-test.v -test.timeout=120m 
21:59:15 [2020-01-10T21:59:15.499Z] ++ 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
21:59:15 [2020-01-10T21:59:15.499Z] ++ set -e
21:59:15 [2020-01-10T21:59:15.499Z] ++ '[' -n 0 ']'
21:59:15 [2020-01-10T21:59:15.499Z] ++ set -x
21:59:15 [2020-01-10T21:59:15.499Z] ++ 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
21:59:15 [2020-01-10T21:59:15.499Z] INFO: Testing against a local daemon
21:59:15 [2020-01-10T21:59:15.499Z] === RUN   TestDockerNetworkIpvlanPersistance
21:59:15 [2020-01-10T21:59:15.499Z] --- SKIP: TestDockerNetworkIpvlanPersistance (0.00s)
21:59:15 [2020-01-10T21:59:15.499Z]     ipvlan_test.go:26: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
21:59:15 [2020-01-10T21:59:15.499Z] === RUN   TestDockerNetworkIpvlan
21:59:15 [2020-01-10T21:59:15.499Z] --- SKIP: TestDockerNetworkIpvlan (0.00s)
21:59:15 [2020-01-10T21:59:15.499Z]     ipvlan_test.go:53: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
21:59:15 [2020-01-10T21:59:15.499Z] PASS
21:59:15 [2020-01-10T21:59:15.499Z] 
21:59:15 [2020-01-10T21:59:15.499Z] === Skipped
21:59:15 [2020-01-10T21:59:15.499Z] === SKIP: ppc64le.integration.network.ipvlan TestDockerNetworkIpvlanPersistance (0.00s)
21:59:15 [2020-01-10T21:59:15.499Z]     ipvlan_test.go:26: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
21:59:15 [2020-01-10T21:59:15.499Z] 
21:59:15 [2020-01-10T21:59:15.499Z] === SKIP: ppc64le.integration.network.ipvlan TestDockerNetworkIpvlan (0.00s)
21:59:15 [2020-01-10T21:59:15.499Z]     ipvlan_test.go:53: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
21:59:15 [2020-01-10T21:59:15.499Z] 
21:59:15 [2020-01-10T21:59:15.499Z] 
21:59:15 [2020-01-10T21:59:15.499Z] DONE 2 tests, 2 skipped in 0.106s
21:59:15 [2020-01-10T21:59:15.499Z] Running /go/src/github.com/docker/docker/integration/network/macvlan (ppc64le.integration.network.macvlan) flags=-test.v -test.timeout=120m 
21:59:15 [2020-01-10T21:59:15.499Z] ++ 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
21:59:15 [2020-01-10T21:59:15.499Z] ++ set -e
21:59:15 [2020-01-10T21:59:15.499Z] ++ '[' -n 0 ']'
21:59:15 [2020-01-10T21:59:15.499Z] ++ set -x
21:59:15 [2020-01-10T21:59:15.500Z] ++ 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
21:59:15 [2020-01-10T21:59:15.500Z] INFO: Testing against a local daemon
21:59:15 [2020-01-10T21:59:15.500Z] === RUN   TestDockerNetworkMacvlanPersistance
21:59:16 [2020-01-10T21:59:16.987Z] --- PASS: TestDockerNetworkMacvlanPersistance (1.50s)
21:59:16 [2020-01-10T21:59:16.987Z] === RUN   TestDockerNetworkMacvlan
21:59:17 [2020-01-10T21:59:17.609Z] === RUN   TestDockerNetworkMacvlan/Subinterface
21:59:18 [2020-01-10T21:59:18.626Z] === RUN   TestDockerNetworkMacvlan/OverlapParent
21:59:19 [2020-01-10T21:59:19.646Z] === RUN   TestDockerNetworkMacvlan/NilParent
21:59:22 [2020-01-10T21:59:22.337Z] === RUN   TestDockerNetworkMacvlan/InternalMode
21:59:25 [2020-01-10T21:59:25.809Z] === RUN   TestDockerNetworkMacvlan/MultiSubnet
21:59:30 [2020-01-10T21:59:30.226Z] === RUN   TestDockerNetworkMacvlan/Addressing
21:59:31 [2020-01-10T21:59:31.246Z] --- PASS: TestDockerNetworkMacvlan (14.58s)
21:59:31 [2020-01-10T21:59:31.246Z]     --- PASS: TestDockerNetworkMacvlan/Subinterface (0.08s)
21:59:31 [2020-01-10T21:59:31.246Z]     --- PASS: TestDockerNetworkMacvlan/OverlapParent (0.10s)
21:59:31 [2020-01-10T21:59:31.246Z]     --- PASS: TestDockerNetworkMacvlan/NilParent (1.18s)
21:59:31 [2020-01-10T21:59:31.246Z]     --- PASS: TestDockerNetworkMacvlan/InternalMode (2.18s)
21:59:31 [2020-01-10T21:59:31.246Z]     --- PASS: TestDockerNetworkMacvlan/MultiSubnet (3.09s)
21:59:31 [2020-01-10T21:59:31.246Z]     --- PASS: TestDockerNetworkMacvlan/Addressing (0.90s)
21:59:31 [2020-01-10T21:59:31.246Z] PASS
21:59:31 [2020-01-10T21:59:31.246Z] 
21:59:31 [2020-01-10T21:59:31.246Z] DONE 8 tests in 16.179s
21:59:31 [2020-01-10T21:59:31.246Z] Running /go/src/github.com/docker/docker/integration/plugin (ppc64le.integration.plugin) flags=-test.v -test.timeout=120m 
21:59:31 [2020-01-10T21:59:31.246Z] ++ 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
21:59:31 [2020-01-10T21:59:31.246Z] ++ set -e
21:59:31 [2020-01-10T21:59:31.246Z] ++ '[' -n 0 ']'
21:59:31 [2020-01-10T21:59:31.246Z] ++ set -x
21:59:31 [2020-01-10T21:59:31.246Z] ++ 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
21:59:31 [2020-01-10T21:59:31.246Z] testing: warning: no tests to run
21:59:31 [2020-01-10T21:59:31.246Z] PASS
21:59:31 [2020-01-10T21:59:31.246Z] 
21:59:31 [2020-01-10T21:59:31.246Z] DONE 0 tests in 0.016s
21:59:31 [2020-01-10T21:59:31.246Z] Running /go/src/github.com/docker/docker/integration/plugin/authz (ppc64le.integration.plugin.authz) flags=-test.v -test.timeout=120m 
21:59:31 [2020-01-10T21:59:31.246Z] ++ 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
21:59:31 [2020-01-10T21:59:31.246Z] ++ set -e
21:59:31 [2020-01-10T21:59:31.246Z] ++ '[' -n 0 ']'
21:59:31 [2020-01-10T21:59:31.246Z] ++ set -x
21:59:31 [2020-01-10T21:59:31.246Z] ++ 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
21:59:31 [2020-01-10T21:59:31.535Z] INFO: Testing against a local daemon
21:59:31 [2020-01-10T21:59:31.535Z] === RUN   TestAuthZPluginAllowRequest
21:59:33 [2020-01-10T21:59:33.026Z] --- PASS: TestAuthZPluginAllowRequest (1.59s)
21:59:33 [2020-01-10T21:59:33.026Z] === RUN   TestAuthZPluginTLS
21:59:33 [2020-01-10T21:59:33.648Z] --- PASS: TestAuthZPluginTLS (0.59s)
21:59:33 [2020-01-10T21:59:33.648Z] === RUN   TestAuthZPluginDenyRequest
21:59:34 [2020-01-10T21:59:34.269Z] --- PASS: TestAuthZPluginDenyRequest (0.56s)
21:59:34 [2020-01-10T21:59:34.270Z] === RUN   TestAuthZPluginAPIDenyResponse
21:59:34 [2020-01-10T21:59:34.889Z] --- PASS: TestAuthZPluginAPIDenyResponse (0.58s)
21:59:34 [2020-01-10T21:59:34.889Z] === RUN   TestAuthZPluginDenyResponse
21:59:35 [2020-01-10T21:59:35.517Z] --- PASS: TestAuthZPluginDenyResponse (0.58s)
21:59:35 [2020-01-10T21:59:35.517Z] === RUN   TestAuthZPluginAllowEventStream
21:59:37 [2020-01-10T21:59:37.029Z] --- PASS: TestAuthZPluginAllowEventStream (1.57s)
21:59:37 [2020-01-10T21:59:37.029Z] === RUN   TestAuthZPluginErrorResponse
21:59:37 [2020-01-10T21:59:37.655Z] --- PASS: TestAuthZPluginErrorResponse (0.57s)
21:59:37 [2020-01-10T21:59:37.655Z] === RUN   TestAuthZPluginErrorRequest
21:59:37 [2020-01-10T21:59:37.941Z] --- PASS: TestAuthZPluginErrorRequest (0.56s)
21:59:37 [2020-01-10T21:59:37.941Z] === RUN   TestAuthZPluginEnsureNoDuplicatePluginRegistration
21:59:38 [2020-01-10T21:59:38.563Z] --- PASS: TestAuthZPluginEnsureNoDuplicatePluginRegistration (0.57s)
21:59:38 [2020-01-10T21:59:38.563Z] === RUN   TestAuthZPluginEnsureLoadImportWorking
21:59:40 [2020-01-10T21:59:40.648Z] --- PASS: TestAuthZPluginEnsureLoadImportWorking (2.09s)
21:59:40 [2020-01-10T21:59:40.648Z] === RUN   TestAuthzPluginEnsureContainerCopyToFrom
21:59:42 [2020-01-10T21:59:42.687Z] --- PASS: TestAuthzPluginEnsureContainerCopyToFrom (2.07s)
21:59:42 [2020-01-10T21:59:42.687Z] === RUN   TestAuthZPluginHeader
21:59:43 [2020-01-10T21:59:43.701Z] --- PASS: TestAuthZPluginHeader (0.94s)
21:59:43 [2020-01-10T21:59:43.701Z] === RUN   TestAuthZPluginV2AllowNonVolumeRequest
21:59:43 [2020-01-10T21:59:43.701Z] --- SKIP: TestAuthZPluginV2AllowNonVolumeRequest (0.00s)
21:59:43 [2020-01-10T21:59:43.701Z]     authz_plugin_v2_test.go:43: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
21:59:43 [2020-01-10T21:59:43.701Z] === RUN   TestAuthZPluginV2Disable
21:59:43 [2020-01-10T21:59:43.701Z] --- SKIP: TestAuthZPluginV2Disable (0.00s)
21:59:43 [2020-01-10T21:59:43.701Z]     authz_plugin_v2_test.go:65: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
21:59:43 [2020-01-10T21:59:43.701Z] === RUN   TestAuthZPluginV2RejectVolumeRequests
21:59:43 [2020-01-10T21:59:43.701Z] --- SKIP: TestAuthZPluginV2RejectVolumeRequests (0.00s)
21:59:43 [2020-01-10T21:59:43.701Z]     authz_plugin_v2_test.go:91: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
21:59:43 [2020-01-10T21:59:43.701Z] === RUN   TestAuthZPluginV2BadManifestFailsDaemonStart
21:59:43 [2020-01-10T21:59:43.701Z] --- SKIP: TestAuthZPluginV2BadManifestFailsDaemonStart (0.00s)
21:59:43 [2020-01-10T21:59:43.701Z]     authz_plugin_v2_test.go:126: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
21:59:43 [2020-01-10T21:59:43.701Z] === RUN   TestAuthZPluginV2NonexistentFailsDaemonStart
22:00:02 [2020-01-10T22:00:02.187Z] --- PASS: TestAuthZPluginV2NonexistentFailsDaemonStart (16.80s)
22:00:02 [2020-01-10T22:00:02.187Z] PASS
22:00:02 [2020-01-10T22:00:02.187Z] 
22:00:02 [2020-01-10T22:00:02.187Z] === Skipped
22:00:02 [2020-01-10T22:00:02.187Z] === SKIP: ppc64le.integration.plugin.authz TestAuthZPluginV2AllowNonVolumeRequest (0.00s)
22:00:02 [2020-01-10T22:00:02.187Z]     authz_plugin_v2_test.go:43: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:00:02 [2020-01-10T22:00:02.187Z] 
22:00:02 [2020-01-10T22:00:02.187Z] === SKIP: ppc64le.integration.plugin.authz TestAuthZPluginV2Disable (0.00s)
22:00:02 [2020-01-10T22:00:02.187Z]     authz_plugin_v2_test.go:65: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:00:02 [2020-01-10T22:00:02.187Z] 
22:00:02 [2020-01-10T22:00:02.187Z] === SKIP: ppc64le.integration.plugin.authz TestAuthZPluginV2RejectVolumeRequests (0.00s)
22:00:02 [2020-01-10T22:00:02.187Z]     authz_plugin_v2_test.go:91: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:00:02 [2020-01-10T22:00:02.187Z] 
22:00:02 [2020-01-10T22:00:02.187Z] === SKIP: ppc64le.integration.plugin.authz TestAuthZPluginV2BadManifestFailsDaemonStart (0.00s)
22:00:02 [2020-01-10T22:00:02.187Z]     authz_plugin_v2_test.go:126: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:00:02 [2020-01-10T22:00:02.187Z] 
22:00:02 [2020-01-10T22:00:02.187Z] 
22:00:02 [2020-01-10T22:00:02.187Z] DONE 17 tests, 4 skipped in 29.180s
22:00:02 [2020-01-10T22:00:02.187Z] Running /go/src/github.com/docker/docker/integration/plugin/common (ppc64le.integration.plugin.common) flags=-test.v -test.timeout=120m 
22:00:02 [2020-01-10T22:00:02.187Z] ++ 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:00:02 [2020-01-10T22:00:02.187Z] ++ set -e
22:00:02 [2020-01-10T22:00:02.187Z] ++ '[' -n 0 ']'
22:00:02 [2020-01-10T22:00:02.187Z] ++ set -x
22:00:02 [2020-01-10T22:00:02.187Z] ++ 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:00:02 [2020-01-10T22:00:02.187Z] INFO: Testing against a local daemon
22:00:02 [2020-01-10T22:00:02.187Z] === RUN   TestPluginInvalidJSON
22:00:02 [2020-01-10T22:00:02.187Z] === RUN   TestPluginInvalidJSON//plugins/foobar/set
22:00:02 [2020-01-10T22:00:02.187Z] === PAUSE TestPluginInvalidJSON//plugins/foobar/set
22:00:02 [2020-01-10T22:00:02.187Z] === CONT  TestPluginInvalidJSON//plugins/foobar/set
22:00:02 [2020-01-10T22:00:02.187Z] --- PASS: TestPluginInvalidJSON (0.05s)
22:00:02 [2020-01-10T22:00:02.187Z]     --- PASS: TestPluginInvalidJSON//plugins/foobar/set (0.00s)
22:00:02 [2020-01-10T22:00:02.187Z] PASS
22:00:02 [2020-01-10T22:00:02.187Z] 
22:00:02 [2020-01-10T22:00:02.187Z] DONE 2 tests in 0.141s
22:00:02 [2020-01-10T22:00:02.187Z] Running /go/src/github.com/docker/docker/integration/plugin/graphdriver (ppc64le.integration.plugin.graphdriver) flags=-test.v -test.timeout=120m 
22:00:02 [2020-01-10T22:00:02.187Z] ++ 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:00:02 [2020-01-10T22:00:02.187Z] ++ set -e
22:00:02 [2020-01-10T22:00:02.187Z] ++ '[' -n 0 ']'
22:00:02 [2020-01-10T22:00:02.187Z] ++ set -x
22:00:02 [2020-01-10T22:00:02.187Z] ++ 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:00:02 [2020-01-10T22:00:02.187Z] INFO: Testing against a local daemon
22:00:02 [2020-01-10T22:00:02.187Z] === RUN   TestExternalGraphDriver
22:00:02 [2020-01-10T22:00:02.187Z] === RUN   TestExternalGraphDriver/json
22:00:03 [2020-01-10T22:00:03.205Z] === RUN   TestExternalGraphDriver/spec
22:00:05 [2020-01-10T22:00:05.255Z] === RUN   TestExternalGraphDriver/pull
22:00:07 [2020-01-10T22:00:07.296Z] --- PASS: TestExternalGraphDriver (6.35s)
22:00:07 [2020-01-10T22:00:07.296Z]     --- PASS: TestExternalGraphDriver/json (2.04s)
22:00:07 [2020-01-10T22:00:07.296Z]     --- PASS: TestExternalGraphDriver/spec (2.07s)
22:00:07 [2020-01-10T22:00:07.296Z]     --- PASS: TestExternalGraphDriver/pull (2.06s)
22:00:07 [2020-01-10T22:00:07.296Z] === RUN   TestGraphdriverPluginV2
22:00:07 [2020-01-10T22:00:07.296Z] --- SKIP: TestGraphdriverPluginV2 (0.08s)
22:00:07 [2020-01-10T22:00:07.296Z]     external_test.go:410: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:00:07 [2020-01-10T22:00:07.296Z] PASS
22:00:07 [2020-01-10T22:00:07.296Z] 
22:00:07 [2020-01-10T22:00:07.296Z] === Skipped
22:00:07 [2020-01-10T22:00:07.296Z] === SKIP: ppc64le.integration.plugin.graphdriver TestGraphdriverPluginV2 (0.08s)
22:00:07 [2020-01-10T22:00:07.296Z]     external_test.go:410: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:00:07 [2020-01-10T22:00:07.296Z] 
22:00:07 [2020-01-10T22:00:07.296Z] 
22:00:07 [2020-01-10T22:00:07.296Z] DONE 5 tests, 1 skipped in 6.538s
22:00:07 [2020-01-10T22:00:07.296Z] Running /go/src/github.com/docker/docker/integration/plugin/logging (ppc64le.integration.plugin.logging) flags=-test.v -test.timeout=120m 
22:00:07 [2020-01-10T22:00:07.296Z] ++ 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:00:07 [2020-01-10T22:00:07.296Z] ++ set -e
22:00:07 [2020-01-10T22:00:07.296Z] ++ '[' -n 0 ']'
22:00:07 [2020-01-10T22:00:07.296Z] ++ set -x
22:00:07 [2020-01-10T22:00:07.296Z] ++ 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:00:07 [2020-01-10T22:00:07.296Z] INFO: Testing against a local daemon
22:00:07 [2020-01-10T22:00:07.296Z] === RUN   TestContinueAfterPluginCrash
22:00:07 [2020-01-10T22:00:07.296Z] === PAUSE TestContinueAfterPluginCrash
22:00:07 [2020-01-10T22:00:07.296Z] === RUN   TestDaemonStartWithLogOpt
22:00:07 [2020-01-10T22:00:07.296Z] === PAUSE TestDaemonStartWithLogOpt
22:00:07 [2020-01-10T22:00:07.296Z] === CONT  TestContinueAfterPluginCrash
22:00:07 [2020-01-10T22:00:07.296Z] === CONT  TestDaemonStartWithLogOpt
22:00:22 [2020-01-10T22:00:22.595Z] --- PASS: TestDaemonStartWithLogOpt (15.28s)
22:00:28 [2020-01-10T22:00:28.100Z] --- PASS: TestContinueAfterPluginCrash (20.13s)
22:00:28 [2020-01-10T22:00:28.100Z] PASS
22:00:28 [2020-01-10T22:00:28.100Z] 
22:00:28 [2020-01-10T22:00:28.100Z] DONE 2 tests in 20.235s
22:00:28 [2020-01-10T22:00:28.100Z] Running /go/src/github.com/docker/docker/integration/plugin/volumes (ppc64le.integration.plugin.volumes) flags=-test.v -test.timeout=120m 
22:00:28 [2020-01-10T22:00:28.100Z] ++ 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:00:28 [2020-01-10T22:00:28.100Z] ++ set -e
22:00:28 [2020-01-10T22:00:28.100Z] ++ '[' -n 0 ']'
22:00:28 [2020-01-10T22:00:28.100Z] ++ set -x
22:00:28 [2020-01-10T22:00:28.100Z] ++ 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:00:28 [2020-01-10T22:00:28.100Z] INFO: Testing against a local daemon
22:00:28 [2020-01-10T22:00:28.100Z] === RUN   TestPluginWithDevMounts
22:00:28 [2020-01-10T22:00:28.100Z] === PAUSE TestPluginWithDevMounts
22:00:28 [2020-01-10T22:00:28.100Z] === CONT  TestPluginWithDevMounts
22:00:30 [2020-01-10T22:00:30.128Z] --- PASS: TestPluginWithDevMounts (2.24s)
22:00:30 [2020-01-10T22:00:30.128Z] PASS
22:00:30 [2020-01-10T22:00:30.128Z] 
22:00:30 [2020-01-10T22:00:30.128Z] DONE 1 tests in 2.338s
22:00:30 [2020-01-10T22:00:30.128Z] Running /go/src/github.com/docker/docker/integration/secret (ppc64le.integration.secret) flags=-test.v -test.timeout=120m 
22:00:30 [2020-01-10T22:00:30.128Z] ++ 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:00:30 [2020-01-10T22:00:30.128Z] ++ set -e
22:00:30 [2020-01-10T22:00:30.128Z] ++ '[' -n 0 ']'
22:00:30 [2020-01-10T22:00:30.128Z] ++ set -x
22:00:30 [2020-01-10T22:00:30.128Z] ++ 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:00:30 [2020-01-10T22:00:30.128Z] INFO: Testing against a local daemon
22:00:30 [2020-01-10T22:00:30.128Z] === RUN   TestSecretInspect
22:00:32 [2020-01-10T22:00:32.164Z] --- PASS: TestSecretInspect (2.26s)
22:00:32 [2020-01-10T22:00:32.164Z] === RUN   TestSecretList
22:00:34 [2020-01-10T22:00:34.857Z] --- PASS: TestSecretList (2.35s)
22:00:34 [2020-01-10T22:00:34.857Z] === RUN   TestSecretsCreateAndDelete
22:00:36 [2020-01-10T22:00:36.892Z] --- PASS: TestSecretsCreateAndDelete (2.31s)
22:00:36 [2020-01-10T22:00:36.892Z] === RUN   TestSecretsUpdate
22:00:39 [2020-01-10T22:00:39.585Z] --- PASS: TestSecretsUpdate (2.27s)
22:00:39 [2020-01-10T22:00:39.585Z] === RUN   TestTemplatedSecret
22:00:42 [2020-01-10T22:00:42.280Z] --- PASS: TestTemplatedSecret (2.76s)
22:00:42 [2020-01-10T22:00:42.280Z] === RUN   TestSecretCreateResolve
22:00:44 [2020-01-10T22:00:44.337Z] --- PASS: TestSecretCreateResolve (2.39s)
22:00:44 [2020-01-10T22:00:44.337Z] PASS
22:00:44 [2020-01-10T22:00:44.337Z] 
22:00:44 [2020-01-10T22:00:44.337Z] DONE 6 tests in 14.425s
22:00:44 [2020-01-10T22:00:44.337Z] Running /go/src/github.com/docker/docker/integration/service (ppc64le.integration.service) flags=-test.v -test.timeout=120m 
22:00:44 [2020-01-10T22:00:44.337Z] ++ 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:00:44 [2020-01-10T22:00:44.337Z] ++ set -e
22:00:44 [2020-01-10T22:00:44.337Z] ++ '[' -n 0 ']'
22:00:44 [2020-01-10T22:00:44.337Z] ++ set -x
22:00:44 [2020-01-10T22:00:44.337Z] ++ 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:00:44 [2020-01-10T22:00:44.337Z] INFO: Testing against a local daemon
22:00:44 [2020-01-10T22:00:44.337Z] === RUN   TestServiceCreateInit
22:00:44 [2020-01-10T22:00:44.337Z] === RUN   TestServiceCreateInit/daemonInitDisabled
22:00:48 [2020-01-10T22:00:48.732Z] === RUN   TestServiceCreateInit/daemonInitEnabled
22:00:53 [2020-01-10T22:00:53.133Z] --- PASS: TestServiceCreateInit (8.20s)
22:00:53 [2020-01-10T22:00:53.133Z]     --- PASS: TestServiceCreateInit/daemonInitDisabled (4.14s)
22:00:53 [2020-01-10T22:00:53.133Z]     --- PASS: TestServiceCreateInit/daemonInitEnabled (4.02s)
22:00:53 [2020-01-10T22:00:53.133Z] === RUN   TestCreateServiceMultipleTimes
22:01:11 [2020-01-10T22:01:11.647Z] --- PASS: TestCreateServiceMultipleTimes (16.35s)
22:01:11 [2020-01-10T22:01:11.647Z] === RUN   TestCreateServiceConflict
22:01:11 [2020-01-10T22:01:11.647Z] --- PASS: TestCreateServiceConflict (2.27s)
22:01:11 [2020-01-10T22:01:11.647Z] === RUN   TestCreateServiceMaxReplicas
22:01:14 [2020-01-10T22:01:14.360Z] --- PASS: TestCreateServiceMaxReplicas (3.15s)
22:01:14 [2020-01-10T22:01:14.360Z] === RUN   TestCreateWithDuplicateNetworkNames
22:01:29 [2020-01-10T22:01:29.634Z] --- PASS: TestCreateWithDuplicateNetworkNames (13.42s)
22:01:29 [2020-01-10T22:01:29.634Z] === RUN   TestCreateServiceSecretFileMode
22:01:30 [2020-01-10T22:01:30.255Z] --- PASS: TestCreateServiceSecretFileMode (2.53s)
22:01:30 [2020-01-10T22:01:30.256Z] === RUN   TestCreateServiceConfigFileMode
22:01:33 [2020-01-10T22:01:33.735Z] --- PASS: TestCreateServiceConfigFileMode (2.78s)
22:01:33 [2020-01-10T22:01:33.735Z] === RUN   TestCreateServiceSysctls
22:01:36 [2020-01-10T22:01:36.458Z] --- PASS: TestCreateServiceSysctls (3.36s)
22:01:36 [2020-01-10T22:01:36.458Z] === RUN   TestCreateServiceCapabilities
22:01:39 [2020-01-10T22:01:39.159Z] --- PASS: TestCreateServiceCapabilities (2.70s)
22:01:39 [2020-01-10T22:01:39.159Z] === RUN   TestInspect
22:01:42 [2020-01-10T22:01:42.634Z] --- PASS: TestInspect (2.90s)
22:01:42 [2020-01-10T22:01:42.634Z] === RUN   TestServiceListWithStatuses
22:01:42 [2020-01-10T22:01:42.634Z] --- SKIP: TestServiceListWithStatuses (0.01s)
22:01:42 [2020-01-10T22:01:42.634Z]     list_test.go:34: versions.LessThan(testEnv.DaemonInfo.ServerVersion, "1.41")
22:01:42 [2020-01-10T22:01:42.634Z] === RUN   TestDockerNetworkConnectAlias
22:01:47 [2020-01-10T22:01:47.051Z] --- PASS: TestDockerNetworkConnectAlias (4.76s)
22:01:47 [2020-01-10T22:01:47.051Z] === RUN   TestDockerNetworkReConnect
22:01:50 [2020-01-10T22:01:50.531Z] --- PASS: TestDockerNetworkReConnect (3.75s)
22:01:50 [2020-01-10T22:01:50.531Z] === RUN   TestServicePlugin
22:01:50 [2020-01-10T22:01:50.531Z] --- SKIP: TestServicePlugin (0.00s)
22:01:50 [2020-01-10T22:01:50.531Z]     plugin_test.go:28: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:01:50 [2020-01-10T22:01:50.531Z] === RUN   TestServiceUpdateLabel
22:01:53 [2020-01-10T22:01:53.229Z] --- PASS: TestServiceUpdateLabel (2.33s)
22:01:53 [2020-01-10T22:01:53.229Z] === RUN   TestServiceUpdateSecrets
22:02:08 [2020-01-10T22:02:08.569Z] --- PASS: TestServiceUpdateSecrets (14.85s)
22:02:08 [2020-01-10T22:02:08.569Z] === RUN   TestServiceUpdateConfigs
22:02:23 [2020-01-10T22:02:23.813Z] --- PASS: TestServiceUpdateConfigs (14.76s)
22:02:23 [2020-01-10T22:02:23.813Z] === RUN   TestServiceUpdateNetwork
22:02:36 [2020-01-10T22:02:36.343Z] --- PASS: TestServiceUpdateNetwork (13.10s)
22:02:36 [2020-01-10T22:02:36.343Z] PASS
22:02:36 [2020-01-10T22:02:36.343Z] 
22:02:36 [2020-01-10T22:02:36.343Z] === Skipped
22:02:36 [2020-01-10T22:02:36.343Z] === SKIP: ppc64le.integration.service TestServiceListWithStatuses (0.01s)
22:02:36 [2020-01-10T22:02:36.343Z]     list_test.go:34: versions.LessThan(testEnv.DaemonInfo.ServerVersion, "1.41")
22:02:36 [2020-01-10T22:02:36.343Z] 
22:02:36 [2020-01-10T22:02:36.343Z] === SKIP: ppc64le.integration.service TestServicePlugin (0.00s)
22:02:36 [2020-01-10T22:02:36.343Z]     plugin_test.go:28: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:02:36 [2020-01-10T22:02:36.343Z] 
22:02:36 [2020-01-10T22:02:36.343Z] 
22:02:36 [2020-01-10T22:02:36.343Z] DONE 20 tests, 2 skipped in 111.305s
22:02:36 [2020-01-10T22:02:36.343Z] Running /go/src/github.com/docker/docker/integration/session (ppc64le.integration.session) flags=-test.v -test.timeout=120m 
22:02:36 [2020-01-10T22:02:36.343Z] ++ 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:02:36 [2020-01-10T22:02:36.343Z] ++ set -e
22:02:36 [2020-01-10T22:02:36.343Z] ++ '[' -n 0 ']'
22:02:36 [2020-01-10T22:02:36.343Z] ++ set -x
22:02:36 [2020-01-10T22:02:36.343Z] ++ 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:02:36 [2020-01-10T22:02:36.343Z] INFO: Testing against a local daemon
22:02:36 [2020-01-10T22:02:36.343Z] === RUN   TestSessionCreate
22:02:36 [2020-01-10T22:02:36.343Z] --- PASS: TestSessionCreate (0.05s)
22:02:36 [2020-01-10T22:02:36.343Z] === RUN   TestSessionCreateWithBadUpgrade
22:02:36 [2020-01-10T22:02:36.343Z] --- PASS: TestSessionCreateWithBadUpgrade (0.05s)
22:02:36 [2020-01-10T22:02:36.343Z] PASS
22:02:36 [2020-01-10T22:02:36.343Z] 
22:02:36 [2020-01-10T22:02:36.343Z] DONE 2 tests in 0.193s
22:02:36 [2020-01-10T22:02:36.343Z] Running /go/src/github.com/docker/docker/integration/system (ppc64le.integration.system) flags=-test.v -test.timeout=120m 
22:02:36 [2020-01-10T22:02:36.343Z] ++ 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:02:36 [2020-01-10T22:02:36.343Z] ++ set -e
22:02:36 [2020-01-10T22:02:36.343Z] ++ '[' -n 0 ']'
22:02:36 [2020-01-10T22:02:36.343Z] ++ set -x
22:02:36 [2020-01-10T22:02:36.344Z] ++ 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:02:36 [2020-01-10T22:02:36.344Z] INFO: Testing against a local daemon
22:02:36 [2020-01-10T22:02:36.344Z] === RUN   TestCgroupDriverSystemdMemoryLimit
22:02:36 [2020-01-10T22:02:36.344Z] --- SKIP: TestCgroupDriverSystemdMemoryLimit (0.00s)
22:02:36 [2020-01-10T22:02:36.344Z]     cgroupdriver_systemd_test.go:32: !hasSystemd()
22:02:36 [2020-01-10T22:02:36.344Z] === RUN   TestEventsExecDie
22:02:36 [2020-01-10T22:02:36.961Z] --- PASS: TestEventsExecDie (0.86s)
22:02:36 [2020-01-10T22:02:36.961Z] === RUN   TestEventsBackwardsCompatible
22:02:36 [2020-01-10T22:02:36.961Z] --- PASS: TestEventsBackwardsCompatible (0.11s)
22:02:36 [2020-01-10T22:02:36.961Z] === RUN   TestInfoBinaryCommits
22:02:36 [2020-01-10T22:02:36.961Z] --- PASS: TestInfoBinaryCommits (0.05s)
22:02:36 [2020-01-10T22:02:36.961Z] === RUN   TestInfoAPIVersioned
22:02:36 [2020-01-10T22:02:36.961Z] --- PASS: TestInfoAPIVersioned (0.02s)
22:02:36 [2020-01-10T22:02:36.961Z] === RUN   TestInfoDiscoveryBackend
22:02:37 [2020-01-10T22:02:37.592Z] --- PASS: TestInfoDiscoveryBackend (0.54s)
22:02:37 [2020-01-10T22:02:37.592Z] === RUN   TestInfoDiscoveryInvalidAdvertise
22:02:38 [2020-01-10T22:02:38.627Z] --- PASS: TestInfoDiscoveryInvalidAdvertise (1.00s)
22:02:38 [2020-01-10T22:02:38.627Z] === RUN   TestInfoDiscoveryAdvertiseInterfaceName
22:02:39 [2020-01-10T22:02:39.248Z] --- PASS: TestInfoDiscoveryAdvertiseInterfaceName (0.56s)
22:02:39 [2020-01-10T22:02:39.248Z] === RUN   TestInfoAPI
22:02:39 [2020-01-10T22:02:39.248Z] --- PASS: TestInfoAPI (0.07s)
22:02:39 [2020-01-10T22:02:39.248Z] === RUN   TestInfoAPIWarnings
22:02:39 [2020-01-10T22:02:39.867Z] --- PASS: TestInfoAPIWarnings (0.56s)
22:02:39 [2020-01-10T22:02:39.867Z] === RUN   TestInfoDebug
22:02:40 [2020-01-10T22:02:40.152Z] --- PASS: TestInfoDebug (0.54s)
22:02:40 [2020-01-10T22:02:40.152Z] === RUN   TestInfoInsecureRegistries
22:02:40 [2020-01-10T22:02:40.769Z] --- PASS: TestInfoInsecureRegistries (0.54s)
22:02:40 [2020-01-10T22:02:40.769Z] === RUN   TestInfoRegistryMirrors
22:02:41 [2020-01-10T22:02:41.386Z] --- PASS: TestInfoRegistryMirrors (0.54s)
22:02:41 [2020-01-10T22:02:41.386Z] === RUN   TestLoginFailsWithBadCredentials
22:02:41 [2020-01-10T22:02:41.670Z] --- PASS: TestLoginFailsWithBadCredentials (0.42s)
22:02:41 [2020-01-10T22:02:41.670Z] === RUN   TestPingCacheHeaders
22:02:41 [2020-01-10T22:02:41.670Z] --- PASS: TestPingCacheHeaders (0.05s)
22:02:41 [2020-01-10T22:02:41.670Z] === RUN   TestPingGet
22:02:41 [2020-01-10T22:02:41.956Z] --- PASS: TestPingGet (0.03s)
22:02:41 [2020-01-10T22:02:41.956Z] === RUN   TestPingHead
22:02:41 [2020-01-10T22:02:41.956Z] --- PASS: TestPingHead (0.05s)
22:02:41 [2020-01-10T22:02:41.956Z] === RUN   TestVersion
22:02:41 [2020-01-10T22:02:41.956Z] --- PASS: TestVersion (0.05s)
22:02:41 [2020-01-10T22:02:41.956Z] PASS
22:02:41 [2020-01-10T22:02:41.956Z] 
22:02:41 [2020-01-10T22:02:41.956Z] === Skipped
22:02:41 [2020-01-10T22:02:41.956Z] === SKIP: ppc64le.integration.system TestCgroupDriverSystemdMemoryLimit (0.00s)
22:02:41 [2020-01-10T22:02:41.956Z]     cgroupdriver_systemd_test.go:32: !hasSystemd()
22:02:41 [2020-01-10T22:02:41.956Z] 
22:02:41 [2020-01-10T22:02:41.956Z] 
22:02:41 [2020-01-10T22:02:41.956Z] DONE 18 tests, 1 skipped in 6.074s
22:02:41 [2020-01-10T22:02:41.956Z] Running /go/src/github.com/docker/docker/integration/volume (ppc64le.integration.volume) flags=-test.v -test.timeout=120m 
22:02:41 [2020-01-10T22:02:41.956Z] ++ 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:02:41 [2020-01-10T22:02:41.956Z] ++ set -e
22:02:41 [2020-01-10T22:02:41.956Z] ++ '[' -n 0 ']'
22:02:41 [2020-01-10T22:02:41.956Z] ++ set -x
22:02:41 [2020-01-10T22:02:41.956Z] ++ 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:02:41 [2020-01-10T22:02:41.956Z] INFO: Testing against a local daemon
22:02:41 [2020-01-10T22:02:41.956Z] === RUN   TestVolumesCreateAndList
22:02:42 [2020-01-10T22:02:42.241Z] --- PASS: TestVolumesCreateAndList (0.06s)
22:02:42 [2020-01-10T22:02:42.241Z] === RUN   TestVolumesRemove
22:02:42 [2020-01-10T22:02:42.241Z] --- PASS: TestVolumesRemove (0.09s)
22:02:42 [2020-01-10T22:02:42.241Z] === RUN   TestVolumesInspect
22:02:42 [2020-01-10T22:02:42.241Z] --- PASS: TestVolumesInspect (0.04s)
22:02:42 [2020-01-10T22:02:42.241Z] === RUN   TestVolumesInvalidJSON
22:02:42 [2020-01-10T22:02:42.241Z] === RUN   TestVolumesInvalidJSON//volumes/create
22:02:42 [2020-01-10T22:02:42.241Z] === PAUSE TestVolumesInvalidJSON//volumes/create
22:02:42 [2020-01-10T22:02:42.241Z] === CONT  TestVolumesInvalidJSON//volumes/create
22:02:42 [2020-01-10T22:02:42.241Z] --- PASS: TestVolumesInvalidJSON (0.04s)
22:02:42 [2020-01-10T22:02:42.241Z]     --- PASS: TestVolumesInvalidJSON//volumes/create (0.00s)
22:02:42 [2020-01-10T22:02:42.241Z] PASS
22:02:42 [2020-01-10T22:02:42.241Z] 
22:02:42 [2020-01-10T22:02:42.241Z] DONE 5 tests in 0.316s
22:02:42 [2020-01-10T22:02:42.241Z] ---> Making bundle: .integration-daemon-stop (in bundles/test-integration)
22:02:42 [2020-01-10T22:02:42.525Z] ++++ cat bundles/test-integration/docker.pid
22:02:42 [2020-01-10T22:02:42.525Z] +++ kill 13055
22:02:44 [2020-01-10T22:02:44.011Z] +++ /etc/init.d/apparmor stop
22:02:44 [2020-01-10T22:02:44.011Z] Leaving: AppArmorNo profiles have been unloaded.
22:02:44 [2020-01-10T22:02:44.011Z] 
22:02:44 [2020-01-10T22:02:44.011Z] Unloading profiles will leave already running processes permanently
22:02:44 [2020-01-10T22:02:44.011Z] unconfined, which can lead to unexpected situations.
22:02:44 [2020-01-10T22:02:44.011Z] 
22:02:44 [2020-01-10T22:02:44.011Z] To set a process to complain mode, use the command line tool
22:02:44 [2020-01-10T22:02:44.011Z] 'aa-complain'. To really tear down all profiles, run 'aa-teardown'."
22:02:44 [2020-01-10T22:02:44.011Z] +++ true
22:02:44 [2020-01-10T22:02:44.011Z]