Console Output

21:55:30 [2019-10-15T21:55:30.340Z] + docker run --rm -t --privileged -v /home/ubuntu/workspace/moby_PR-40095/bundles:/go/src/github.com/docker/docker/bundles --name docker-pr2 -e DOCKER_EXPERIMENTAL -e DOCKER_GITCOMMIT=af3f576b1bd24f21ba62c6e99030913c67bfefc5 -e DOCKER_GRAPHDRIVER -e TESTDEBUG -e TEST_SKIP_INTEGRATION_CLI -e TIMEOUT -e VALIDATE_REPO=https://github.com/moby/moby.git -e VALIDATE_BRANCH=master docker:af3f576b1bd24f21ba62c6e99030913c67bfefc5 hack/make.sh dynbinary test-integration
21:55:31 [2019-10-15T21:55:31.277Z] 
21:55:31 [2019-10-15T21:55:31.277Z] Removing bundles/
21:55:31 [2019-10-15T21:55:31.277Z] 
21:55:31 [2019-10-15T21:55:31.277Z] ---> Making bundle: dynbinary (in bundles/dynbinary)
21:55:31 [2019-10-15T21:55:31.277Z] Building: bundles/dynbinary-daemon/dockerd-dev
21:55:31 [2019-10-15T21:55:31.277Z] GOOS="" GOARCH="" GOARM=""
21:56:38 [2019-10-15T21:56:38.997Z] Created binary: bundles/dynbinary-daemon/dockerd-dev
21:56:38 [2019-10-15T21:56:38.997Z] 
21:56:38 [2019-10-15T21:56:38.997Z] ---> Making bundle: test-integration (in bundles/test-integration)
21:56:38 [2019-10-15T21:56:38.997Z] PKG_CONFIG=pkg-config
21:56:38 [2019-10-15T21:56:38.997Z] GOLANG_VERSION=1.13.1
21:56:38 [2019-10-15T21:56:38.997Z] HOSTNAME=2f7971efc2c4
21:56:38 [2019-10-15T21:56:38.997Z] DOCKER_EXPERIMENTAL=1
21:56:38 [2019-10-15T21:56:38.997Z] container=docker
21:56:38 [2019-10-15T21:56:38.997Z] TEST_SKIP_INTEGRATION_CLI=1
21:56:38 [2019-10-15T21:56:38.997Z] GO111MODULE=off
21:56:38 [2019-10-15T21:56:38.997Z] GOPATH=/go
21:56:38 [2019-10-15T21:56:38.997Z] PWD=/go/src/github.com/docker/docker
21:56:38 [2019-10-15T21:56:38.997Z] HOME=/root
21:56:38 [2019-10-15T21:56:38.997Z] VALIDATE_REPO=https://github.com/moby/moby.git
21:56:38 [2019-10-15T21:56:38.997Z] SCRIPTDIR=/go/src/github.com/docker/docker/hack
21:56:38 [2019-10-15T21:56:38.997Z] MAKEDIR=/go/src/github.com/docker/docker/hack/make
21:56:38 [2019-10-15T21:56:38.997Z] DOCKER_GITCOMMIT=af3f576b1bd24f21ba62c6e99030913c67bfefc5
21:56:38 [2019-10-15T21:56:38.997Z] DOCKER_BUILDTAGS=apparmor seccomp selinux journald
21:56:38 [2019-10-15T21:56:38.997Z] DOCKER_GRAPHDRIVER=overlay2
21:56:38 [2019-10-15T21:56:38.997Z] TERM=xterm
21:56:38 [2019-10-15T21:56:38.997Z] VALIDATE_BRANCH=master
21:56:38 [2019-10-15T21:56:38.997Z] DEST=bundles/test-integration
21:56:38 [2019-10-15T21:56:38.997Z] SHLVL=1
21:56:38 [2019-10-15T21:56:38.997Z] TIMEOUT=120m
21:56:38 [2019-10-15T21:56:38.997Z] PATH=/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
21:56:38 [2019-10-15T21:56:38.997Z] DOCKER_PKG=github.com/docker/docker
21:56:38 [2019-10-15T21:56:38.997Z] TESTDEBUG=0
21:56:38 [2019-10-15T21:56:38.997Z] _=/usr/bin/env
21:56:38 [2019-10-15T21:56:38.997Z] Building test suite binary /go/src/github.com/docker/docker/integration/build/test.main
21:57:05 [2019-10-15T21:57:05.568Z] Building test suite binary /go/src/github.com/docker/docker/integration/config/test.main
21:57:05 [2019-10-15T21:57:05.568Z] Building test suite binary /go/src/github.com/docker/docker/integration/container/test.main
21:57:06 [2019-10-15T21:57:06.504Z] Building test suite binary /go/src/github.com/docker/docker/integration/image/test.main
21:57:24 [2019-10-15T21:57:24.607Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/test.main
21:57:25 [2019-10-15T21:57:25.987Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/ipvlan/test.main
21:57:27 [2019-10-15T21:57:27.369Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/macvlan/test.main
21:57:28 [2019-10-15T21:57:28.746Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/test.main
21:57:29 [2019-10-15T21:57:29.006Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/authz/test.main
21:57:31 [2019-10-15T21:57:31.544Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/common/test.main
21:57:32 [2019-10-15T21:57:32.480Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/graphdriver/test.main
21:57:34 [2019-10-15T21:57:34.386Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/logging/test.main
21:57:37 [2019-10-15T21:57:37.676Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/volumes/test.main
21:57:39 [2019-10-15T21:57:39.582Z] Building test suite binary /go/src/github.com/docker/docker/integration/secret/test.main
21:57:40 [2019-10-15T21:57:40.519Z] Building test suite binary /go/src/github.com/docker/docker/integration/service/test.main
21:57:43 [2019-10-15T21:57:43.058Z] Building test suite binary /go/src/github.com/docker/docker/integration/session/test.main
21:57:44 [2019-10-15T21:57:44.439Z] Building test suite binary /go/src/github.com/docker/docker/integration/system/test.main
21:57:45 [2019-10-15T21:57:45.816Z] Building test suite binary /go/src/github.com/docker/docker/integration/volume/test.main
21:57:46 [2019-10-15T21:57:46.753Z] ---> Making bundle: .integration-daemon-start (in bundles/test-integration)
21:57:46 [2019-10-15T21:57:46.753Z] Using test binary docker
21:57:46 [2019-10-15T21:57:46.753Z] # DOCKER_EXPERIMENTAL is set: starting daemon with experimental features enabled! 
21:57:46 [2019-10-15T21:57:46.753Z] +++ /etc/init.d/apparmor start
21:57:47 [2019-10-15T21:57:47.012Z] /etc/init.d/apparmor: 130: /etc/init.d/apparmor: systemd-detect-virt: not found
21:57:47 [2019-10-15T21:57:47.012Z] Starting AppArmor profiles:Warning from stdin (line 1): /sbin/apparmor_parser: cannot use or update cache, disable, or force-complain via stdin
21:57:47 [2019-10-15T21:57:47.012Z] Warning failed to create cache: (null)
21:57:47 [2019-10-15T21:57:47.012Z] .
21:57:47 [2019-10-15T21:57:47.012Z] INFO: Waiting for daemon to start...
21:57:47 [2019-10-15T21:57:47.012Z] Starting dockerd
21:57:47 [2019-10-15T21:57:47.012Z] +++ 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:57:53 [2019-10-15T21:57:53.575Z] .
21:57:53 [2019-10-15T21:57:53.575Z] ---> Making bundle: .integration-daemon-setup (in bundles/test-integration)
21:57:53 [2019-10-15T21:57:53.575Z] ---> Making bundle: .ensure-emptyfs (in bundles/test-integration)
21:57:53 [2019-10-15T21:57:53.575Z] Error: No such image: emptyfs
21:57:53 [2019-10-15T21:57:53.575Z] ++++ tar -cC bundles/test-integration/emptyfs .
21:57:53 [2019-10-15T21:57:53.575Z] ++++ docker load
21:57:53 [2019-10-15T21:57:53.575Z] Running integration-test (iteration 1)
21:57:53 [2019-10-15T21:57:53.575Z] Running /go/src/github.com/docker/docker/integration/build (arm64.integration.build) flags=-test.v -test.timeout=120m 
21:57:53 [2019-10-15T21:57:53.575Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-build-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-build-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.build -t ./test.main -test.v -test.timeout=120m
21:57:53 [2019-10-15T21:57:53.575Z] ++ set -e
21:57:53 [2019-10-15T21:57:53.575Z] ++ '[' -n 0 ']'
21:57:53 [2019-10-15T21:57:53.575Z] ++ set -x
21:57:53 [2019-10-15T21:57:53.575Z] ++ 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=arm64 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/arm64-integration-build-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-build-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.build -t ./test.main -test.v -test.timeout=120m
21:58:03 [2019-10-15T21:58:03.554Z] Loaded image: buildpack-deps:jessie
21:58:03 [2019-10-15T21:58:03.555Z] Loaded image: busybox:latest
21:58:03 [2019-10-15T21:58:03.555Z] Loaded image: busybox:glibc
21:58:03 [2019-10-15T21:58:03.555Z] Loaded image: debian:jessie
21:58:03 [2019-10-15T21:58:03.555Z] Loaded image: hello-world:latest
21:58:03 [2019-10-15T21:58:03.555Z] INFO: Testing against a local daemon
21:58:03 [2019-10-15T21:58:03.555Z] === RUN   TestCgroupNamespacesBuild
21:58:10 [2019-10-15T21:58:10.108Z] --- PASS: TestCgroupNamespacesBuild (4.38s)
21:58:10 [2019-10-15T21:58:10.108Z]     build_cgroupns_linux_test.go:42: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesBuild"
21:58:10 [2019-10-15T21:58:10.108Z] === RUN   TestCgroupNamespacesBuildDaemonHostMode
21:58:10 [2019-10-15T21:58:10.108Z] --- PASS: TestCgroupNamespacesBuildDaemonHostMode (1.72s)
21:58:10 [2019-10-15T21:58:10.108Z]     build_cgroupns_linux_test.go:42: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesBuildDaemonHostMode"
21:58:10 [2019-10-15T21:58:10.108Z] === RUN   TestBuildWithSession
21:58:10 [2019-10-15T21:58:10.108Z] --- SKIP: TestBuildWithSession (0.00s)
21:58:10 [2019-10-15T21:58:10.108Z]     build_session_test.go:25: TODO: BuildKit
21:58:10 [2019-10-15T21:58:10.108Z] === RUN   TestBuildSquashParent
21:58:15 [2019-10-15T21:58:15.382Z] --- PASS: TestBuildSquashParent (6.01s)
21:58:15 [2019-10-15T21:58:15.382Z] === RUN   TestBuildWithRemoveAndForceRemove
21:58:15 [2019-10-15T21:58:15.382Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
21:58:15 [2019-10-15T21:58:15.382Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
21:58:15 [2019-10-15T21:58:15.382Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_remove
21:58:15 [2019-10-15T21:58:15.382Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_remove
21:58:15 [2019-10-15T21:58:15.382Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
21:58:15 [2019-10-15T21:58:15.382Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
21:58:15 [2019-10-15T21:58:15.382Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
21:58:15 [2019-10-15T21:58:15.382Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
21:58:15 [2019-10-15T21:58:15.382Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_remove
21:58:15 [2019-10-15T21:58:15.382Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_remove
21:58:15 [2019-10-15T21:58:15.382Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
21:58:15 [2019-10-15T21:58:15.382Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
21:58:15 [2019-10-15T21:58:15.382Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
21:58:15 [2019-10-15T21:58:15.382Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
21:58:15 [2019-10-15T21:58:15.382Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
21:58:15 [2019-10-15T21:58:15.382Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_remove
21:58:17 [2019-10-15T21:58:17.917Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_remove
21:58:17 [2019-10-15T21:58:17.917Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
21:58:19 [2019-10-15T21:58:19.822Z] --- PASS: TestBuildWithRemoveAndForceRemove (0.02s)
21:58:19 [2019-10-15T21:58:19.822Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal (2.71s)
21:58:19 [2019-10-15T21:58:19.822Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_remove (2.88s)
21:58:19 [2019-10-15T21:58:19.822Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove (2.88s)
21:58:19 [2019-10-15T21:58:19.822Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal (2.94s)
21:58:19 [2019-10-15T21:58:19.822Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_remove (2.09s)
21:58:19 [2019-10-15T21:58:19.822Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove (2.13s)
21:58:19 [2019-10-15T21:58:19.822Z] === RUN   TestBuildMultiStageCopy
21:58:19 [2019-10-15T21:58:19.822Z] === RUN   TestBuildMultiStageCopy/copy_to_root
21:58:22 [2019-10-15T21:58:22.354Z] === RUN   TestBuildMultiStageCopy/copy_to_newdir
21:58:22 [2019-10-15T21:58:22.613Z] === RUN   TestBuildMultiStageCopy/copy_to_newdir_nested
21:58:23 [2019-10-15T21:58:23.180Z] === RUN   TestBuildMultiStageCopy/copy_to_existingdir
21:58:23 [2019-10-15T21:58:23.439Z] === RUN   TestBuildMultiStageCopy/copy_to_newsubdir
21:58:24 [2019-10-15T21:58:24.007Z] --- PASS: TestBuildMultiStageCopy (4.30s)
21:58:24 [2019-10-15T21:58:24.007Z]     --- PASS: TestBuildMultiStageCopy/copy_to_root (2.23s)
21:58:24 [2019-10-15T21:58:24.007Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newdir (0.49s)
21:58:24 [2019-10-15T21:58:24.007Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newdir_nested (0.50s)
21:58:24 [2019-10-15T21:58:24.007Z]     --- PASS: TestBuildMultiStageCopy/copy_to_existingdir (0.54s)
21:58:24 [2019-10-15T21:58:24.007Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newsubdir (0.55s)
21:58:24 [2019-10-15T21:58:24.007Z] === RUN   TestBuildMultiStageParentConfig
21:58:25 [2019-10-15T21:58:25.912Z] --- PASS: TestBuildMultiStageParentConfig (1.42s)
21:58:25 [2019-10-15T21:58:25.912Z] === RUN   TestBuildLabelWithTargets
21:58:27 [2019-10-15T21:58:27.815Z] --- PASS: TestBuildLabelWithTargets (2.39s)
21:58:27 [2019-10-15T21:58:27.815Z] === RUN   TestBuildWithEmptyLayers
21:58:29 [2019-10-15T21:58:29.214Z] --- PASS: TestBuildWithEmptyLayers (1.01s)
21:58:29 [2019-10-15T21:58:29.214Z] === RUN   TestBuildMultiStageOnBuild
21:58:31 [2019-10-15T21:58:31.747Z] --- PASS: TestBuildMultiStageOnBuild (2.76s)
21:58:31 [2019-10-15T21:58:31.747Z] === RUN   TestBuildUncleanTarFilenames
21:58:33 [2019-10-15T21:58:33.128Z] --- PASS: TestBuildUncleanTarFilenames (1.32s)
21:58:33 [2019-10-15T21:58:33.128Z] === RUN   TestBuildMultiStageLayerLeak
21:58:36 [2019-10-15T21:58:36.416Z] --- PASS: TestBuildMultiStageLayerLeak (2.96s)
21:58:36 [2019-10-15T21:58:36.416Z] === RUN   TestBuildWithHugeFile
21:59:23 [2019-10-15T21:59:23.114Z] --- PASS: TestBuildWithHugeFile (43.85s)
21:59:23 [2019-10-15T21:59:23.114Z] === RUN   TestBuildWithEmptyDockerfile
21:59:23 [2019-10-15T21:59:23.114Z] === RUN   TestBuildWithEmptyDockerfile/empty-dockerfile
21:59:23 [2019-10-15T21:59:23.114Z] === PAUSE TestBuildWithEmptyDockerfile/empty-dockerfile
21:59:23 [2019-10-15T21:59:23.114Z] === RUN   TestBuildWithEmptyDockerfile/empty-lines-dockerfile
21:59:23 [2019-10-15T21:59:23.114Z] === PAUSE TestBuildWithEmptyDockerfile/empty-lines-dockerfile
21:59:23 [2019-10-15T21:59:23.114Z] === RUN   TestBuildWithEmptyDockerfile/comment-only-dockerfile
21:59:23 [2019-10-15T21:59:23.114Z] === PAUSE TestBuildWithEmptyDockerfile/comment-only-dockerfile
21:59:23 [2019-10-15T21:59:23.114Z] === CONT  TestBuildWithEmptyDockerfile/empty-dockerfile
21:59:23 [2019-10-15T21:59:23.114Z] === CONT  TestBuildWithEmptyDockerfile/empty-lines-dockerfile
21:59:23 [2019-10-15T21:59:23.114Z] === CONT  TestBuildWithEmptyDockerfile/comment-only-dockerfile
21:59:23 [2019-10-15T21:59:23.114Z] --- PASS: TestBuildWithEmptyDockerfile (0.13s)
21:59:23 [2019-10-15T21:59:23.114Z]     --- PASS: TestBuildWithEmptyDockerfile/comment-only-dockerfile (0.25s)
21:59:23 [2019-10-15T21:59:23.114Z]     --- PASS: TestBuildWithEmptyDockerfile/empty-lines-dockerfile (0.25s)
21:59:23 [2019-10-15T21:59:23.114Z]     --- PASS: TestBuildWithEmptyDockerfile/empty-dockerfile (0.26s)
21:59:23 [2019-10-15T21:59:23.114Z] === RUN   TestBuildPreserveOwnership
21:59:23 [2019-10-15T21:59:23.114Z] === RUN   TestBuildPreserveOwnership/copy_from
21:59:24 [2019-10-15T21:59:24.490Z] === RUN   TestBuildPreserveOwnership/copy_from_chowned
21:59:26 [2019-10-15T21:59:26.394Z] --- PASS: TestBuildPreserveOwnership (6.13s)
21:59:26 [2019-10-15T21:59:26.394Z]     --- PASS: TestBuildPreserveOwnership/copy_from (3.99s)
21:59:26 [2019-10-15T21:59:26.394Z]     --- PASS: TestBuildPreserveOwnership/copy_from_chowned (2.10s)
21:59:26 [2019-10-15T21:59:26.394Z] === RUN   TestBuildPlatformInvalid
21:59:26 [2019-10-15T21:59:26.394Z] --- PASS: TestBuildPlatformInvalid (0.17s)
21:59:26 [2019-10-15T21:59:26.394Z] PASS
21:59:26 [2019-10-15T21:59:26.653Z] 
21:59:26 [2019-10-15T21:59:26.653Z] === Skipped
21:59:26 [2019-10-15T21:59:26.653Z] === SKIP: arm64.integration.build TestBuildWithSession (0.00s)
21:59:26 [2019-10-15T21:59:26.653Z]     build_session_test.go:25: TODO: BuildKit
21:59:26 [2019-10-15T21:59:26.653Z] 
21:59:26 [2019-10-15T21:59:26.653Z] 
21:59:26 [2019-10-15T21:59:26.653Z] DONE 32 tests, 1 skipped in 93.372s
21:59:26 [2019-10-15T21:59:26.653Z] Running /go/src/github.com/docker/docker/integration/config (arm64.integration.config) flags=-test.v -test.timeout=120m 
21:59:26 [2019-10-15T21:59:26.653Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-config-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-config-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.config -t ./test.main -test.v -test.timeout=120m
21:59:26 [2019-10-15T21:59:26.653Z] ++ set -e
21:59:26 [2019-10-15T21:59:26.653Z] ++ '[' -n 0 ']'
21:59:26 [2019-10-15T21:59:26.653Z] ++ set -x
21:59:26 [2019-10-15T21:59:26.653Z] ++ 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=arm64 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/arm64-integration-config-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-config-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.config -t ./test.main -test.v -test.timeout=120m
21:59:26 [2019-10-15T21:59:26.653Z] INFO: Testing against a local daemon
21:59:26 [2019-10-15T21:59:26.653Z] === RUN   TestConfigList
21:59:30 [2019-10-15T21:59:30.842Z] --- PASS: TestConfigList (3.33s)
21:59:30 [2019-10-15T21:59:30.842Z]     config_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigList"
21:59:30 [2019-10-15T21:59:30.842Z] === RUN   TestConfigsCreateAndDelete
21:59:33 [2019-10-15T21:59:33.374Z] --- PASS: TestConfigsCreateAndDelete (3.24s)
21:59:33 [2019-10-15T21:59:33.374Z]     config_test.go:112: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigsCreateAndDelete"
21:59:33 [2019-10-15T21:59:33.374Z] === RUN   TestConfigsUpdate
21:59:36 [2019-10-15T21:59:36.661Z] --- PASS: TestConfigsUpdate (3.24s)
21:59:36 [2019-10-15T21:59:36.661Z]     config_test.go:140: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigsUpdate"
21:59:36 [2019-10-15T21:59:36.661Z] === RUN   TestTemplatedConfig
21:59:39 [2019-10-15T21:59:39.947Z] --- PASS: TestTemplatedConfig (3.50s)
21:59:39 [2019-10-15T21:59:39.947Z]     config_test.go:192: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestTemplatedConfig"
21:59:39 [2019-10-15T21:59:39.947Z] === RUN   TestConfigInspect
21:59:43 [2019-10-15T21:59:43.232Z] --- PASS: TestConfigInspect (3.16s)
21:59:43 [2019-10-15T21:59:43.232Z]     config_test.go:326: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigInspect"
21:59:43 [2019-10-15T21:59:43.232Z] === RUN   TestConfigCreateWithLabels
21:59:46 [2019-10-15T21:59:46.518Z] --- PASS: TestConfigCreateWithLabels (3.06s)
21:59:46 [2019-10-15T21:59:46.518Z]     config_test.go:350: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigCreateWithLabels"
21:59:46 [2019-10-15T21:59:46.518Z] === RUN   TestConfigCreateResolve
21:59:49 [2019-10-15T21:59:49.803Z] --- PASS: TestConfigCreateResolve (3.16s)
21:59:49 [2019-10-15T21:59:49.803Z]     config_test.go:377: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigCreateResolve"
21:59:49 [2019-10-15T21:59:49.803Z] === RUN   TestConfigDaemonLibtrustID
21:59:50 [2019-10-15T21:59:50.062Z] --- PASS: TestConfigDaemonLibtrustID (0.57s)
21:59:50 [2019-10-15T21:59:50.062Z]     config_test.go:427: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigDaemonLibtrustID"
21:59:50 [2019-10-15T21:59:50.062Z] PASS
21:59:50 [2019-10-15T21:59:50.062Z] 
21:59:50 [2019-10-15T21:59:50.062Z] DONE 8 tests in 23.410s
21:59:50 [2019-10-15T21:59:50.062Z] Running /go/src/github.com/docker/docker/integration/container (arm64.integration.container) flags=-test.v -test.timeout=120m 
21:59:50 [2019-10-15T21:59:50.062Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-container-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-container-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.container -t ./test.main -test.v -test.timeout=120m
21:59:50 [2019-10-15T21:59:50.062Z] ++ set -e
21:59:50 [2019-10-15T21:59:50.062Z] ++ '[' -n 0 ']'
21:59:50 [2019-10-15T21:59:50.062Z] ++ set -x
21:59:50 [2019-10-15T21:59:50.062Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=arm64 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/arm64-integration-container-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-container-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.container -t ./test.main -test.v -test.timeout=120m
21:59:50 [2019-10-15T21:59:50.321Z] INFO: Testing against a local daemon
21:59:50 [2019-10-15T21:59:50.321Z] === RUN   TestCheckpoint
21:59:50 [2019-10-15T21:59:50.321Z] --- SKIP: TestCheckpoint (0.00s)
21:59:50 [2019-10-15T21:59:50.321Z]     checkpoint_test.go:33: TestCheckpoint is broken; see https://github.com/moby/moby/issues/38963
21:59:50 [2019-10-15T21:59:50.321Z] === RUN   TestContainerInvalidJSON
21:59:50 [2019-10-15T21:59:50.321Z] === RUN   TestContainerInvalidJSON//containers/foobar/copy
21:59:50 [2019-10-15T21:59:50.321Z] === PAUSE TestContainerInvalidJSON//containers/foobar/copy
21:59:50 [2019-10-15T21:59:50.321Z] === RUN   TestContainerInvalidJSON//containers/foobar/exec
21:59:50 [2019-10-15T21:59:50.321Z] === PAUSE TestContainerInvalidJSON//containers/foobar/exec
21:59:50 [2019-10-15T21:59:50.321Z] === RUN   TestContainerInvalidJSON//exec/foobar/start
21:59:50 [2019-10-15T21:59:50.321Z] === PAUSE TestContainerInvalidJSON//exec/foobar/start
21:59:50 [2019-10-15T21:59:50.321Z] === CONT  TestContainerInvalidJSON//containers/foobar/copy
21:59:50 [2019-10-15T21:59:50.321Z] === CONT  TestContainerInvalidJSON//exec/foobar/start
21:59:50 [2019-10-15T21:59:50.321Z] === CONT  TestContainerInvalidJSON//containers/foobar/exec
21:59:50 [2019-10-15T21:59:50.321Z] --- PASS: TestContainerInvalidJSON (0.03s)
21:59:50 [2019-10-15T21:59:50.321Z]     --- PASS: TestContainerInvalidJSON//containers/foobar/copy (0.00s)
21:59:50 [2019-10-15T21:59:50.321Z]     --- PASS: TestContainerInvalidJSON//exec/foobar/start (0.00s)
21:59:50 [2019-10-15T21:59:50.321Z]     --- PASS: TestContainerInvalidJSON//containers/foobar/exec (0.00s)
21:59:50 [2019-10-15T21:59:50.321Z] === RUN   TestCopyFromContainerPathDoesNotExist
21:59:50 [2019-10-15T21:59:50.321Z] --- PASS: TestCopyFromContainerPathDoesNotExist (0.15s)
21:59:50 [2019-10-15T21:59:50.321Z] === RUN   TestCopyFromContainerPathIsNotDir
21:59:50 [2019-10-15T21:59:50.579Z] --- PASS: TestCopyFromContainerPathIsNotDir (0.15s)
21:59:50 [2019-10-15T21:59:50.579Z] === RUN   TestCopyToContainerPathDoesNotExist
21:59:50 [2019-10-15T21:59:50.579Z] --- PASS: TestCopyToContainerPathDoesNotExist (0.14s)
21:59:50 [2019-10-15T21:59:50.579Z] === RUN   TestCopyToContainerPathIsNotDir
21:59:50 [2019-10-15T21:59:50.838Z] --- PASS: TestCopyToContainerPathIsNotDir (0.12s)
21:59:50 [2019-10-15T21:59:50.838Z] === RUN   TestCopyFromContainer
21:59:52 [2019-10-15T21:59:52.740Z] === RUN   TestCopyFromContainer//
21:59:53 [2019-10-15T21:59:53.000Z] === RUN   TestCopyFromContainer//bar/root
21:59:53 [2019-10-15T21:59:53.000Z] === RUN   TestCopyFromContainer//bar/root/
21:59:53 [2019-10-15T21:59:53.258Z] === RUN   TestCopyFromContainer/bar/quux
21:59:53 [2019-10-15T21:59:53.258Z] === RUN   TestCopyFromContainer/bar/quux/
21:59:53 [2019-10-15T21:59:53.516Z] === RUN   TestCopyFromContainer/bar/quux/baz
21:59:53 [2019-10-15T21:59:53.516Z] === RUN   TestCopyFromContainer/bar/filesymlink
21:59:53 [2019-10-15T21:59:53.776Z] === RUN   TestCopyFromContainer/bar/dirsymlink
21:59:53 [2019-10-15T21:59:53.776Z] === RUN   TestCopyFromContainer/bar/dirsymlink/
21:59:53 [2019-10-15T21:59:53.776Z] === RUN   TestCopyFromContainer/bar/notarget
21:59:54 [2019-10-15T21:59:54.035Z] --- PASS: TestCopyFromContainer (3.24s)
21:59:54 [2019-10-15T21:59:54.035Z]     --- PASS: TestCopyFromContainer// (0.10s)
21:59:54 [2019-10-15T21:59:54.035Z]     --- PASS: TestCopyFromContainer//bar/root (0.16s)
21:59:54 [2019-10-15T21:59:54.035Z]     --- PASS: TestCopyFromContainer//bar/root/ (0.10s)
21:59:54 [2019-10-15T21:59:54.035Z]     --- PASS: TestCopyFromContainer/bar/quux (0.12s)
21:59:54 [2019-10-15T21:59:54.035Z]     --- PASS: TestCopyFromContainer/bar/quux/ (0.12s)
21:59:54 [2019-10-15T21:59:54.035Z]     --- PASS: TestCopyFromContainer/bar/quux/baz (0.11s)
21:59:54 [2019-10-15T21:59:54.035Z]     --- PASS: TestCopyFromContainer/bar/filesymlink (0.10s)
21:59:54 [2019-10-15T21:59:54.035Z]     --- PASS: TestCopyFromContainer/bar/dirsymlink (0.10s)
21:59:54 [2019-10-15T21:59:54.035Z]     --- PASS: TestCopyFromContainer/bar/dirsymlink/ (0.11s)
21:59:54 [2019-10-15T21:59:54.035Z]     --- PASS: TestCopyFromContainer/bar/notarget (0.11s)
21:59:54 [2019-10-15T21:59:54.035Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist
21:59:54 [2019-10-15T21:59:54.035Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
21:59:54 [2019-10-15T21:59:54.035Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
21:59:54 [2019-10-15T21:59:54.035Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
21:59:54 [2019-10-15T21:59:54.035Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
21:59:54 [2019-10-15T21:59:54.035Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/digest
21:59:54 [2019-10-15T21:59:54.035Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/digest
21:59:54 [2019-10-15T21:59:54.035Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
21:59:54 [2019-10-15T21:59:54.035Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
21:59:54 [2019-10-15T21:59:54.035Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/digest
21:59:54 [2019-10-15T21:59:54.035Z] --- PASS: TestCreateFailsWhenIdentifierDoesNotExist (0.02s)
21:59:54 [2019-10-15T21:59:54.035Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag (0.00s)
21:59:54 [2019-10-15T21:59:54.035Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag (0.00s)
21:59:54 [2019-10-15T21:59:54.035Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/digest (0.00s)
21:59:54 [2019-10-15T21:59:54.035Z] === RUN   TestCreateLinkToNonExistingContainer
21:59:54 [2019-10-15T21:59:54.035Z] --- PASS: TestCreateLinkToNonExistingContainer (0.07s)
21:59:54 [2019-10-15T21:59:54.035Z] === RUN   TestCreateWithInvalidEnv
21:59:54 [2019-10-15T21:59:54.035Z] === RUN   TestCreateWithInvalidEnv/0
21:59:54 [2019-10-15T21:59:54.035Z] === PAUSE TestCreateWithInvalidEnv/0
21:59:54 [2019-10-15T21:59:54.035Z] === RUN   TestCreateWithInvalidEnv/1
21:59:54 [2019-10-15T21:59:54.035Z] === PAUSE TestCreateWithInvalidEnv/1
21:59:54 [2019-10-15T21:59:54.035Z] === RUN   TestCreateWithInvalidEnv/2
21:59:54 [2019-10-15T21:59:54.035Z] === PAUSE TestCreateWithInvalidEnv/2
21:59:54 [2019-10-15T21:59:54.294Z] === CONT  TestCreateWithInvalidEnv/0
21:59:54 [2019-10-15T21:59:54.294Z] === CONT  TestCreateWithInvalidEnv/2
21:59:54 [2019-10-15T21:59:54.294Z] === CONT  TestCreateWithInvalidEnv/1
21:59:54 [2019-10-15T21:59:54.294Z] --- PASS: TestCreateWithInvalidEnv (0.02s)
21:59:54 [2019-10-15T21:59:54.294Z]     --- PASS: TestCreateWithInvalidEnv/2 (0.00s)
21:59:54 [2019-10-15T21:59:54.294Z]     --- PASS: TestCreateWithInvalidEnv/0 (0.00s)
21:59:54 [2019-10-15T21:59:54.294Z]     --- PASS: TestCreateWithInvalidEnv/1 (0.01s)
21:59:54 [2019-10-15T21:59:54.294Z] === RUN   TestCreateTmpfsMountsTarget
21:59:54 [2019-10-15T21:59:54.294Z] --- PASS: TestCreateTmpfsMountsTarget (0.03s)
21:59:54 [2019-10-15T21:59:54.294Z] === RUN   TestCreateWithCustomMaskedPaths
21:59:56 [2019-10-15T21:59:56.901Z] --- PASS: TestCreateWithCustomMaskedPaths (2.20s)
21:59:56 [2019-10-15T21:59:56.901Z] === RUN   TestCreateWithCapabilities
21:59:56 [2019-10-15T21:59:56.901Z] === RUN   TestCreateWithCapabilities/no_capabilities
21:59:56 [2019-10-15T21:59:56.901Z] === PAUSE TestCreateWithCapabilities/no_capabilities
21:59:56 [2019-10-15T21:59:56.901Z] === RUN   TestCreateWithCapabilities/empty_capabilities
21:59:56 [2019-10-15T21:59:56.901Z] === PAUSE TestCreateWithCapabilities/empty_capabilities
21:59:56 [2019-10-15T21:59:56.901Z] === RUN   TestCreateWithCapabilities/valid_capabilities
21:59:56 [2019-10-15T21:59:56.901Z] === PAUSE TestCreateWithCapabilities/valid_capabilities
21:59:56 [2019-10-15T21:59:56.901Z] === RUN   TestCreateWithCapabilities/invalid_capabilities
21:59:56 [2019-10-15T21:59:56.901Z] === PAUSE TestCreateWithCapabilities/invalid_capabilities
21:59:56 [2019-10-15T21:59:56.901Z] === RUN   TestCreateWithCapabilities/duplicate_capabilities
21:59:56 [2019-10-15T21:59:56.901Z] === PAUSE TestCreateWithCapabilities/duplicate_capabilities
21:59:56 [2019-10-15T21:59:56.901Z] === RUN   TestCreateWithCapabilities/capabilities_API_v1.39
21:59:56 [2019-10-15T21:59:56.901Z] === PAUSE TestCreateWithCapabilities/capabilities_API_v1.39
21:59:56 [2019-10-15T21:59:56.901Z] === RUN   TestCreateWithCapabilities/empty_capadd
21:59:56 [2019-10-15T21:59:56.901Z] === PAUSE TestCreateWithCapabilities/empty_capadd
21:59:56 [2019-10-15T21:59:56.901Z] === RUN   TestCreateWithCapabilities/empty_capdrop
21:59:56 [2019-10-15T21:59:56.901Z] === PAUSE TestCreateWithCapabilities/empty_capdrop
21:59:56 [2019-10-15T21:59:56.901Z] === RUN   TestCreateWithCapabilities/capadd_capdrop
21:59:56 [2019-10-15T21:59:56.901Z] === PAUSE TestCreateWithCapabilities/capadd_capdrop
21:59:56 [2019-10-15T21:59:56.901Z] === RUN   TestCreateWithCapabilities/conflict_with_capadd
21:59:56 [2019-10-15T21:59:56.901Z] === PAUSE TestCreateWithCapabilities/conflict_with_capadd
21:59:56 [2019-10-15T21:59:56.901Z] === RUN   TestCreateWithCapabilities/conflict_with_capdrop
21:59:56 [2019-10-15T21:59:56.901Z] === PAUSE TestCreateWithCapabilities/conflict_with_capdrop
21:59:56 [2019-10-15T21:59:56.901Z] === CONT  TestCreateWithCapabilities/no_capabilities
21:59:56 [2019-10-15T21:59:56.901Z] === CONT  TestCreateWithCapabilities/empty_capadd
21:59:56 [2019-10-15T21:59:56.901Z] === CONT  TestCreateWithCapabilities/conflict_with_capdrop
21:59:56 [2019-10-15T21:59:56.901Z] === CONT  TestCreateWithCapabilities/empty_capdrop
21:59:56 [2019-10-15T21:59:56.901Z] === CONT  TestCreateWithCapabilities/conflict_with_capadd
21:59:56 [2019-10-15T21:59:56.901Z] === CONT  TestCreateWithCapabilities/invalid_capabilities
21:59:56 [2019-10-15T21:59:56.901Z] === CONT  TestCreateWithCapabilities/capabilities_API_v1.39
21:59:56 [2019-10-15T21:59:56.901Z] === CONT  TestCreateWithCapabilities/valid_capabilities
21:59:56 [2019-10-15T21:59:56.901Z] === CONT  TestCreateWithCapabilities/empty_capabilities
21:59:56 [2019-10-15T21:59:56.901Z] === CONT  TestCreateWithCapabilities/duplicate_capabilities
21:59:56 [2019-10-15T21:59:56.901Z] === CONT  TestCreateWithCapabilities/capadd_capdrop
21:59:56 [2019-10-15T21:59:56.901Z] --- PASS: TestCreateWithCapabilities (0.04s)
21:59:56 [2019-10-15T21:59:56.901Z]     --- PASS: TestCreateWithCapabilities/conflict_with_capdrop (0.00s)
21:59:56 [2019-10-15T21:59:56.901Z]     --- PASS: TestCreateWithCapabilities/conflict_with_capadd (0.01s)
21:59:56 [2019-10-15T21:59:56.901Z]     --- PASS: TestCreateWithCapabilities/invalid_capabilities (0.00s)
21:59:56 [2019-10-15T21:59:56.901Z]     --- PASS: TestCreateWithCapabilities/empty_capdrop (0.08s)
21:59:56 [2019-10-15T21:59:56.901Z]     --- PASS: TestCreateWithCapabilities/no_capabilities (0.08s)
21:59:56 [2019-10-15T21:59:56.901Z]     --- PASS: TestCreateWithCapabilities/empty_capadd (0.08s)
21:59:56 [2019-10-15T21:59:56.901Z]     --- PASS: TestCreateWithCapabilities/capabilities_API_v1.39 (0.10s)
21:59:56 [2019-10-15T21:59:56.901Z]     --- PASS: TestCreateWithCapabilities/valid_capabilities (0.07s)
21:59:56 [2019-10-15T21:59:56.901Z]     --- PASS: TestCreateWithCapabilities/empty_capabilities (0.09s)
21:59:56 [2019-10-15T21:59:56.901Z]     --- PASS: TestCreateWithCapabilities/duplicate_capabilities (0.10s)
21:59:56 [2019-10-15T21:59:56.901Z]     --- PASS: TestCreateWithCapabilities/capadd_capdrop (0.09s)
21:59:56 [2019-10-15T21:59:56.901Z] === RUN   TestCreateWithCustomReadonlyPaths
21:59:59 [2019-10-15T21:59:59.434Z] --- PASS: TestCreateWithCustomReadonlyPaths (2.46s)
21:59:59 [2019-10-15T21:59:59.434Z] === RUN   TestCreateWithInvalidHealthcheckParams
21:59:59 [2019-10-15T21:59:59.434Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
21:59:59 [2019-10-15T21:59:59.434Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
21:59:59 [2019-10-15T21:59:59.434Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
21:59:59 [2019-10-15T21:59:59.434Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
21:59:59 [2019-10-15T21:59:59.434Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
21:59:59 [2019-10-15T21:59:59.434Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
21:59:59 [2019-10-15T21:59:59.434Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
21:59:59 [2019-10-15T21:59:59.434Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
21:59:59 [2019-10-15T21:59:59.434Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
21:59:59 [2019-10-15T21:59:59.434Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
21:59:59 [2019-10-15T21:59:59.434Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
21:59:59 [2019-10-15T21:59:59.434Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
21:59:59 [2019-10-15T21:59:59.434Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
21:59:59 [2019-10-15T21:59:59.434Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
21:59:59 [2019-10-15T21:59:59.434Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
21:59:59 [2019-10-15T21:59:59.434Z] --- PASS: TestCreateWithInvalidHealthcheckParams (0.03s)
21:59:59 [2019-10-15T21:59:59.434Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0 (0.03s)
21:59:59 [2019-10-15T21:59:59.434Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms (0.03s)
21:59:59 [2019-10-15T21:59:59.434Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s (0.04s)
21:59:59 [2019-10-15T21:59:59.434Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms (0.04s)
21:59:59 [2019-10-15T21:59:59.434Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms (0.02s)
21:59:59 [2019-10-15T21:59:59.434Z] === RUN   TestContainerStartOnDaemonRestart
21:59:59 [2019-10-15T21:59:59.434Z] === PAUSE TestContainerStartOnDaemonRestart
21:59:59 [2019-10-15T21:59:59.434Z] === RUN   TestDaemonRestartIpcMode
21:59:59 [2019-10-15T21:59:59.434Z] === PAUSE TestDaemonRestartIpcMode
21:59:59 [2019-10-15T21:59:59.434Z] === RUN   TestDiff
22:00:00 [2019-10-15T22:00:00.001Z] --- PASS: TestDiff (0.82s)
22:00:00 [2019-10-15T22:00:00.001Z] === RUN   TestExecWithCloseStdin
22:00:01 [2019-10-15T22:00:01.377Z] --- PASS: TestExecWithCloseStdin (1.08s)
22:00:01 [2019-10-15T22:00:01.377Z] === RUN   TestExec
22:00:02 [2019-10-15T22:00:02.314Z] --- PASS: TestExec (1.02s)
22:00:02 [2019-10-15T22:00:02.314Z] === RUN   TestExecUser
22:00:03 [2019-10-15T22:00:03.250Z] --- PASS: TestExecUser (1.01s)
22:00:03 [2019-10-15T22:00:03.250Z] === RUN   TestExportContainerAndImportImage
22:00:04 [2019-10-15T22:00:04.187Z] --- PASS: TestExportContainerAndImportImage (1.08s)
22:00:04 [2019-10-15T22:00:04.187Z] === RUN   TestExportContainerAfterDaemonRestart
22:00:06 [2019-10-15T22:00:06.094Z] --- PASS: TestExportContainerAfterDaemonRestart (1.85s)
22:00:06 [2019-10-15T22:00:06.094Z]     export_test.go:63: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestExportContainerAfterDaemonRestart"
22:00:06 [2019-10-15T22:00:06.094Z] === RUN   TestHealthCheckWorkdir
22:00:07 [2019-10-15T22:00:07.476Z] --- PASS: TestHealthCheckWorkdir (1.20s)
22:00:07 [2019-10-15T22:00:07.476Z] === RUN   TestHealthKillContainer
22:00:10 [2019-10-15T22:00:10.764Z] --- PASS: TestHealthKillContainer (3.12s)
22:00:10 [2019-10-15T22:00:10.764Z] === RUN   TestInspectCpusetInConfigPre120
22:00:11 [2019-10-15T22:00:11.332Z] --- PASS: TestInspectCpusetInConfigPre120 (0.82s)
22:00:11 [2019-10-15T22:00:11.332Z] === RUN   TestIpcModeNone
22:00:12 [2019-10-15T22:00:12.271Z] --- PASS: TestIpcModeNone (1.00s)
22:00:12 [2019-10-15T22:00:12.271Z] === RUN   TestIpcModePrivate
22:00:13 [2019-10-15T22:00:13.207Z] --- PASS: TestIpcModePrivate (1.01s)
22:00:13 [2019-10-15T22:00:13.207Z]     ipcmode_linux_test.go:90: [testIpcPrivateShareable] ipcmode: private, ipcdev: 0:101, shared: false, mustBeShared: false
22:00:13 [2019-10-15T22:00:13.207Z] === RUN   TestIpcModeShareable
22:00:14 [2019-10-15T22:00:14.144Z] --- PASS: TestIpcModeShareable (1.00s)
22:00:14 [2019-10-15T22:00:14.144Z]     ipcmode_linux_test.go:90: [testIpcPrivateShareable] ipcmode: shareable, ipcdev: 0:95, shared: true, mustBeShared: true
22:00:14 [2019-10-15T22:00:14.144Z] === RUN   TestAPIIpcModeShareableAndContainer
22:00:17 [2019-10-15T22:00:17.431Z] --- PASS: TestAPIIpcModeShareableAndContainer (2.98s)
22:00:17 [2019-10-15T22:00:17.431Z] === RUN   TestAPIIpcModeHost
22:00:17 [2019-10-15T22:00:17.999Z] --- PASS: TestAPIIpcModeHost (0.78s)
22:00:17 [2019-10-15T22:00:17.999Z] === RUN   TestDaemonIpcModeShareable
22:00:20 [2019-10-15T22:00:20.530Z] --- PASS: TestDaemonIpcModeShareable (2.09s)
22:00:20 [2019-10-15T22:00:20.530Z]     ipcmode_linux_test.go:230: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModeShareable"
22:00:20 [2019-10-15T22:00:20.530Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:106, shared: true, mustBeShared: true
22:00:20 [2019-10-15T22:00:20.530Z] === RUN   TestDaemonIpcModePrivate
22:00:21 [2019-10-15T22:00:21.936Z] --- PASS: TestDaemonIpcModePrivate (1.92s)
22:00:21 [2019-10-15T22:00:21.936Z]     ipcmode_linux_test.go:230: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModePrivate"
22:00:21 [2019-10-15T22:00:21.936Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:112, shared: false, mustBeShared: false
22:00:21 [2019-10-15T22:00:21.936Z] === RUN   TestDaemonIpcModePrivateFromConfig
22:00:23 [2019-10-15T22:00:23.856Z] --- PASS: TestDaemonIpcModePrivateFromConfig (1.95s)
22:00:23 [2019-10-15T22:00:23.856Z]     ipcmode_linux_test.go:230: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModePrivateFromConfig"
22:00:23 [2019-10-15T22:00:23.856Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:112, shared: false, mustBeShared: false
22:00:23 [2019-10-15T22:00:23.856Z] === RUN   TestDaemonIpcModeShareableFromConfig
22:00:25 [2019-10-15T22:00:25.778Z] --- PASS: TestDaemonIpcModeShareableFromConfig (1.93s)
22:00:25 [2019-10-15T22:00:25.778Z]     ipcmode_linux_test.go:230: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModeShareableFromConfig"
22:00:25 [2019-10-15T22:00:25.778Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:106, shared: true, mustBeShared: true
22:00:25 [2019-10-15T22:00:25.778Z] === RUN   TestIpcModeOlderClient
22:00:25 [2019-10-15T22:00:25.778Z] === PAUSE TestIpcModeOlderClient
22:00:25 [2019-10-15T22:00:25.778Z] === RUN   TestKillContainerInvalidSignal
22:00:26 [2019-10-15T22:00:26.714Z] --- PASS: TestKillContainerInvalidSignal (0.84s)
22:00:26 [2019-10-15T22:00:26.714Z] === RUN   TestKillContainer
22:00:26 [2019-10-15T22:00:26.714Z] === RUN   TestKillContainer/no_signal
22:00:27 [2019-10-15T22:00:27.651Z] === RUN   TestKillContainer/non_killing_signal
22:00:28 [2019-10-15T22:00:28.219Z] === RUN   TestKillContainer/killing_signal
22:00:29 [2019-10-15T22:00:29.155Z] --- PASS: TestKillContainer (2.51s)
22:00:29 [2019-10-15T22:00:29.155Z]     --- PASS: TestKillContainer/no_signal (0.78s)
22:00:29 [2019-10-15T22:00:29.155Z]     --- PASS: TestKillContainer/non_killing_signal (0.55s)
22:00:29 [2019-10-15T22:00:29.155Z]     --- PASS: TestKillContainer/killing_signal (0.83s)
22:00:29 [2019-10-15T22:00:29.155Z] === RUN   TestKillWithStopSignalAndRestartPolicies
22:00:29 [2019-10-15T22:00:29.155Z] === RUN   TestKillWithStopSignalAndRestartPolicies/same-signal-disables-restart-policy
22:00:30 [2019-10-15T22:00:30.093Z] === RUN   TestKillWithStopSignalAndRestartPolicies/different-signal-keep-restart-policy
22:00:31 [2019-10-15T22:00:31.029Z] --- PASS: TestKillWithStopSignalAndRestartPolicies (1.67s)
22:00:31 [2019-10-15T22:00:31.029Z]     --- PASS: TestKillWithStopSignalAndRestartPolicies/same-signal-disables-restart-policy (0.82s)
22:00:31 [2019-10-15T22:00:31.029Z]     --- PASS: TestKillWithStopSignalAndRestartPolicies/different-signal-keep-restart-policy (0.54s)
22:00:31 [2019-10-15T22:00:31.029Z] === RUN   TestKillStoppedContainer
22:00:31 [2019-10-15T22:00:31.029Z] --- PASS: TestKillStoppedContainer (0.11s)
22:00:31 [2019-10-15T22:00:31.029Z] === RUN   TestKillStoppedContainerAPIPre120
22:00:31 [2019-10-15T22:00:31.029Z] --- PASS: TestKillStoppedContainerAPIPre120 (0.12s)
22:00:31 [2019-10-15T22:00:31.029Z] === RUN   TestKillDifferentUserContainer
22:00:31 [2019-10-15T22:00:31.965Z] --- PASS: TestKillDifferentUserContainer (0.91s)
22:00:31 [2019-10-15T22:00:31.965Z] === RUN   TestInspectOomKilledTrue
22:00:31 [2019-10-15T22:00:31.965Z] --- SKIP: TestInspectOomKilledTrue (0.00s)
22:00:31 [2019-10-15T22:00:31.965Z]     kill_test.go:151: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
22:00:31 [2019-10-15T22:00:31.965Z] === RUN   TestInspectOomKilledFalse
22:00:31 [2019-10-15T22:00:31.965Z] --- SKIP: TestInspectOomKilledFalse (0.00s)
22:00:31 [2019-10-15T22:00:31.965Z]     kill_test.go:169: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
22:00:31 [2019-10-15T22:00:31.965Z] === RUN   TestLinksEtcHostsContentMatch
22:00:32 [2019-10-15T22:00:32.901Z] --- PASS: TestLinksEtcHostsContentMatch (0.76s)
22:00:32 [2019-10-15T22:00:32.901Z] === RUN   TestLinksContainerNames
22:00:34 [2019-10-15T22:00:34.807Z] --- PASS: TestLinksContainerNames (1.70s)
22:00:34 [2019-10-15T22:00:34.807Z] === RUN   TestLogsFollowTailEmpty
22:00:35 [2019-10-15T22:00:35.375Z] --- PASS: TestLogsFollowTailEmpty (0.87s)
22:00:35 [2019-10-15T22:00:35.375Z] === RUN   TestContainerNetworkMountsNoChown
22:00:36 [2019-10-15T22:00:36.311Z] --- PASS: TestContainerNetworkMountsNoChown (0.81s)
22:00:36 [2019-10-15T22:00:36.311Z] === RUN   TestMountDaemonRoot
22:00:36 [2019-10-15T22:00:36.311Z] === RUN   TestMountDaemonRoot/default
22:00:36 [2019-10-15T22:00:36.311Z] === PAUSE TestMountDaemonRoot/default
22:00:36 [2019-10-15T22:00:36.311Z] === RUN   TestMountDaemonRoot/private
22:00:36 [2019-10-15T22:00:36.311Z] === PAUSE TestMountDaemonRoot/private
22:00:36 [2019-10-15T22:00:36.311Z] === RUN   TestMountDaemonRoot/rprivate
22:00:36 [2019-10-15T22:00:36.311Z] === PAUSE TestMountDaemonRoot/rprivate
22:00:36 [2019-10-15T22:00:36.311Z] === RUN   TestMountDaemonRoot/slave
22:00:36 [2019-10-15T22:00:36.311Z] === PAUSE TestMountDaemonRoot/slave
22:00:36 [2019-10-15T22:00:36.311Z] === RUN   TestMountDaemonRoot/rslave
22:00:36 [2019-10-15T22:00:36.311Z] === PAUSE TestMountDaemonRoot/rslave
22:00:36 [2019-10-15T22:00:36.311Z] === RUN   TestMountDaemonRoot/shared
22:00:36 [2019-10-15T22:00:36.311Z] === PAUSE TestMountDaemonRoot/shared
22:00:36 [2019-10-15T22:00:36.311Z] === RUN   TestMountDaemonRoot/rshared
22:00:36 [2019-10-15T22:00:36.311Z] === PAUSE TestMountDaemonRoot/rshared
22:00:36 [2019-10-15T22:00:36.311Z] === CONT  TestMountDaemonRoot/default
22:00:36 [2019-10-15T22:00:36.311Z] === RUN   TestMountDaemonRoot/default/mount_subpath
22:00:36 [2019-10-15T22:00:36.311Z] === CONT  TestMountDaemonRoot/rslave
22:00:36 [2019-10-15T22:00:36.311Z] === RUN   TestMountDaemonRoot/rslave/bind_root
22:00:36 [2019-10-15T22:00:36.311Z] === PAUSE TestMountDaemonRoot/rslave/bind_root
22:00:36 [2019-10-15T22:00:36.311Z] === RUN   TestMountDaemonRoot/rslave/bind_subpath
22:00:36 [2019-10-15T22:00:36.311Z] === PAUSE TestMountDaemonRoot/rslave/bind_subpath
22:00:36 [2019-10-15T22:00:36.311Z] === RUN   TestMountDaemonRoot/rslave/mount_root
22:00:36 [2019-10-15T22:00:36.311Z] === PAUSE TestMountDaemonRoot/rslave/mount_root
22:00:36 [2019-10-15T22:00:36.311Z] === RUN   TestMountDaemonRoot/rslave/mount_subpath
22:00:36 [2019-10-15T22:00:36.311Z] === PAUSE TestMountDaemonRoot/rslave/mount_subpath
22:00:36 [2019-10-15T22:00:36.311Z] === CONT  TestMountDaemonRoot/rshared
22:00:36 [2019-10-15T22:00:36.311Z] === RUN   TestMountDaemonRoot/rshared/mount_root
22:00:36 [2019-10-15T22:00:36.311Z] === PAUSE TestMountDaemonRoot/rshared/mount_root
22:00:36 [2019-10-15T22:00:36.311Z] === RUN   TestMountDaemonRoot/rshared/mount_subpath
22:00:36 [2019-10-15T22:00:36.311Z] === PAUSE TestMountDaemonRoot/rshared/mount_subpath
22:00:36 [2019-10-15T22:00:36.311Z] === RUN   TestMountDaemonRoot/rshared/bind_root
22:00:36 [2019-10-15T22:00:36.311Z] === PAUSE TestMountDaemonRoot/rshared/bind_root
22:00:36 [2019-10-15T22:00:36.311Z] === CONT  TestMountDaemonRoot/slave
22:00:36 [2019-10-15T22:00:36.311Z] === RUN   TestMountDaemonRoot/slave/bind_root
22:00:36 [2019-10-15T22:00:36.311Z] === PAUSE TestMountDaemonRoot/slave/bind_root
22:00:36 [2019-10-15T22:00:36.311Z] === RUN   TestMountDaemonRoot/slave/bind_subpath
22:00:36 [2019-10-15T22:00:36.311Z] === PAUSE TestMountDaemonRoot/slave/bind_subpath
22:00:36 [2019-10-15T22:00:36.311Z] === RUN   TestMountDaemonRoot/slave/mount_root
22:00:36 [2019-10-15T22:00:36.311Z] === PAUSE TestMountDaemonRoot/slave/mount_root
22:00:36 [2019-10-15T22:00:36.311Z] === RUN   TestMountDaemonRoot/slave/mount_subpath
22:00:36 [2019-10-15T22:00:36.311Z] === PAUSE TestMountDaemonRoot/slave/mount_subpath
22:00:36 [2019-10-15T22:00:36.311Z] === CONT  TestMountDaemonRoot/private
22:00:36 [2019-10-15T22:00:36.311Z] === RUN   TestMountDaemonRoot/private/mount_subpath
22:00:36 [2019-10-15T22:00:36.311Z] === PAUSE TestMountDaemonRoot/private/mount_subpath
22:00:36 [2019-10-15T22:00:36.311Z] === RUN   TestMountDaemonRoot/private/bind_root
22:00:36 [2019-10-15T22:00:36.311Z] === PAUSE TestMountDaemonRoot/private/bind_root
22:00:36 [2019-10-15T22:00:36.311Z] === RUN   TestMountDaemonRoot/private/bind_subpath
22:00:36 [2019-10-15T22:00:36.311Z] === PAUSE TestMountDaemonRoot/private/bind_subpath
22:00:36 [2019-10-15T22:00:36.311Z] === RUN   TestMountDaemonRoot/private/mount_root
22:00:36 [2019-10-15T22:00:36.311Z] === PAUSE TestMountDaemonRoot/private/mount_root
22:00:36 [2019-10-15T22:00:36.311Z] === CONT  TestMountDaemonRoot/rprivate
22:00:36 [2019-10-15T22:00:36.311Z] === RUN   TestMountDaemonRoot/rprivate/bind_subpath
22:00:36 [2019-10-15T22:00:36.311Z] === PAUSE TestMountDaemonRoot/rprivate/bind_subpath
22:00:36 [2019-10-15T22:00:36.311Z] === RUN   TestMountDaemonRoot/rprivate/mount_root
22:00:36 [2019-10-15T22:00:36.311Z] === PAUSE TestMountDaemonRoot/rprivate/mount_root
22:00:36 [2019-10-15T22:00:36.311Z] === RUN   TestMountDaemonRoot/rprivate/mount_subpath
22:00:36 [2019-10-15T22:00:36.311Z] === PAUSE TestMountDaemonRoot/rprivate/mount_subpath
22:00:36 [2019-10-15T22:00:36.311Z] === RUN   TestMountDaemonRoot/rprivate/bind_root
22:00:36 [2019-10-15T22:00:36.311Z] === PAUSE TestMountDaemonRoot/rprivate/bind_root
22:00:36 [2019-10-15T22:00:36.311Z] === CONT  TestMountDaemonRoot/rslave/bind_root
22:00:36 [2019-10-15T22:00:36.311Z] === CONT  TestMountDaemonRoot/shared
22:00:36 [2019-10-15T22:00:36.311Z] === RUN   TestMountDaemonRoot/shared/mount_subpath
22:00:36 [2019-10-15T22:00:36.311Z] === PAUSE TestMountDaemonRoot/shared/mount_subpath
22:00:36 [2019-10-15T22:00:36.311Z] === RUN   TestMountDaemonRoot/shared/bind_root
22:00:36 [2019-10-15T22:00:36.311Z] === PAUSE TestMountDaemonRoot/shared/bind_root
22:00:36 [2019-10-15T22:00:36.311Z] === RUN   TestMountDaemonRoot/shared/bind_subpath
22:00:36 [2019-10-15T22:00:36.311Z] === PAUSE TestMountDaemonRoot/shared/bind_subpath
22:00:36 [2019-10-15T22:00:36.311Z] === RUN   TestMountDaemonRoot/shared/mount_root
22:00:36 [2019-10-15T22:00:36.311Z] === PAUSE TestMountDaemonRoot/shared/mount_root
22:00:36 [2019-10-15T22:00:36.311Z] === PAUSE TestMountDaemonRoot/default/mount_subpath
22:00:36 [2019-10-15T22:00:36.311Z] === RUN   TestMountDaemonRoot/default/bind_root
22:00:36 [2019-10-15T22:00:36.311Z] === PAUSE TestMountDaemonRoot/default/bind_root
22:00:36 [2019-10-15T22:00:36.311Z] === RUN   TestMountDaemonRoot/default/bind_subpath
22:00:36 [2019-10-15T22:00:36.311Z] === PAUSE TestMountDaemonRoot/default/bind_subpath
22:00:36 [2019-10-15T22:00:36.311Z] === RUN   TestMountDaemonRoot/default/mount_root
22:00:36 [2019-10-15T22:00:36.311Z] === PAUSE TestMountDaemonRoot/default/mount_root
22:00:36 [2019-10-15T22:00:36.311Z] === CONT  TestMountDaemonRoot/rslave/mount_root
22:00:36 [2019-10-15T22:00:36.311Z] === CONT  TestMountDaemonRoot/slave/bind_root
22:00:36 [2019-10-15T22:00:36.311Z] === RUN   TestMountDaemonRoot/rshared/bind_subpath
22:00:36 [2019-10-15T22:00:36.311Z] === PAUSE TestMountDaemonRoot/rshared/bind_subpath
22:00:36 [2019-10-15T22:00:36.311Z] === CONT  TestMountDaemonRoot/rslave/mount_subpath
22:00:36 [2019-10-15T22:00:36.311Z] === CONT  TestMountDaemonRoot/private/mount_subpath
22:00:36 [2019-10-15T22:00:36.311Z] === CONT  TestMountDaemonRoot/slave/mount_subpath
22:00:36 [2019-10-15T22:00:36.311Z] === CONT  TestMountDaemonRoot/slave/mount_root
22:00:36 [2019-10-15T22:00:36.311Z] === CONT  TestMountDaemonRoot/slave/bind_subpath
22:00:36 [2019-10-15T22:00:36.311Z] === CONT  TestMountDaemonRoot/rprivate/bind_subpath
22:00:36 [2019-10-15T22:00:36.311Z] === CONT  TestMountDaemonRoot/private/mount_root
22:00:36 [2019-10-15T22:00:36.311Z] === CONT  TestMountDaemonRoot/private/bind_subpath
22:00:36 [2019-10-15T22:00:36.311Z] === CONT  TestMountDaemonRoot/private/bind_root
22:00:36 [2019-10-15T22:00:36.311Z] === CONT  TestMountDaemonRoot/rprivate/bind_root
22:00:36 [2019-10-15T22:00:36.311Z] === CONT  TestMountDaemonRoot/rprivate/mount_subpath
22:00:36 [2019-10-15T22:00:36.311Z] === CONT  TestMountDaemonRoot/rprivate/mount_root
22:00:36 [2019-10-15T22:00:36.311Z] === CONT  TestMountDaemonRoot/rslave/bind_subpath
22:00:36 [2019-10-15T22:00:36.570Z] === CONT  TestMountDaemonRoot/shared/mount_subpath
22:00:36 [2019-10-15T22:00:36.570Z] === CONT  TestMountDaemonRoot/default/mount_subpath
22:00:36 [2019-10-15T22:00:36.570Z] === CONT  TestMountDaemonRoot/shared/mount_root
22:00:36 [2019-10-15T22:00:36.570Z] === CONT  TestMountDaemonRoot/shared/bind_subpath
22:00:36 [2019-10-15T22:00:36.570Z] === CONT  TestMountDaemonRoot/shared/bind_root
22:00:36 [2019-10-15T22:00:36.570Z] === CONT  TestMountDaemonRoot/default/mount_root
22:00:36 [2019-10-15T22:00:36.570Z] === CONT  TestMountDaemonRoot/default/bind_subpath
22:00:36 [2019-10-15T22:00:36.570Z] === CONT  TestMountDaemonRoot/default/bind_root
22:00:36 [2019-10-15T22:00:36.570Z] === CONT  TestMountDaemonRoot/rshared/mount_root
22:00:36 [2019-10-15T22:00:36.570Z] === CONT  TestMountDaemonRoot/rshared/bind_root
22:00:36 [2019-10-15T22:00:36.570Z] === CONT  TestMountDaemonRoot/rshared/bind_subpath
22:00:36 [2019-10-15T22:00:36.570Z] === CONT  TestMountDaemonRoot/rshared/mount_subpath
22:00:36 [2019-10-15T22:00:36.829Z] --- PASS: TestMountDaemonRoot (0.04s)
22:00:36 [2019-10-15T22:00:36.829Z]     --- PASS: TestMountDaemonRoot/slave (0.00s)
22:00:36 [2019-10-15T22:00:36.829Z]         --- PASS: TestMountDaemonRoot/slave/bind_root (0.06s)
22:00:36 [2019-10-15T22:00:36.829Z]         --- PASS: TestMountDaemonRoot/slave/mount_subpath (0.05s)
22:00:36 [2019-10-15T22:00:36.829Z]         --- PASS: TestMountDaemonRoot/slave/bind_subpath (0.04s)
22:00:36 [2019-10-15T22:00:36.829Z]         --- PASS: TestMountDaemonRoot/slave/mount_root (0.05s)
22:00:36 [2019-10-15T22:00:36.829Z]     --- PASS: TestMountDaemonRoot/private (0.00s)
22:00:36 [2019-10-15T22:00:36.829Z]         --- PASS: TestMountDaemonRoot/private/mount_subpath (0.06s)
22:00:36 [2019-10-15T22:00:36.829Z]         --- PASS: TestMountDaemonRoot/private/mount_root (0.05s)
22:00:36 [2019-10-15T22:00:36.829Z]         --- PASS: TestMountDaemonRoot/private/bind_subpath (0.05s)
22:00:36 [2019-10-15T22:00:36.829Z]         --- PASS: TestMountDaemonRoot/private/bind_root (0.05s)
22:00:36 [2019-10-15T22:00:36.829Z]     --- PASS: TestMountDaemonRoot/rprivate (0.00s)
22:00:36 [2019-10-15T22:00:36.829Z]         --- PASS: TestMountDaemonRoot/rprivate/bind_subpath (0.04s)
22:00:36 [2019-10-15T22:00:36.829Z]         --- PASS: TestMountDaemonRoot/rprivate/bind_root (0.06s)
22:00:36 [2019-10-15T22:00:36.829Z]         --- PASS: TestMountDaemonRoot/rprivate/mount_root (0.05s)
22:00:36 [2019-10-15T22:00:36.829Z]         --- PASS: TestMountDaemonRoot/rprivate/mount_subpath (0.06s)
22:00:36 [2019-10-15T22:00:36.829Z]     --- PASS: TestMountDaemonRoot/rslave (0.00s)
22:00:36 [2019-10-15T22:00:36.829Z]         --- PASS: TestMountDaemonRoot/rslave/bind_root (0.09s)
22:00:36 [2019-10-15T22:00:36.829Z]         --- PASS: TestMountDaemonRoot/rslave/mount_root (0.10s)
22:00:36 [2019-10-15T22:00:36.829Z]         --- PASS: TestMountDaemonRoot/rslave/mount_subpath (0.11s)
22:00:36 [2019-10-15T22:00:36.829Z]         --- PASS: TestMountDaemonRoot/rslave/bind_subpath (0.10s)
22:00:36 [2019-10-15T22:00:36.829Z]     --- PASS: TestMountDaemonRoot/shared (0.00s)
22:00:36 [2019-10-15T22:00:36.829Z]         --- PASS: TestMountDaemonRoot/shared/mount_subpath (0.06s)
22:00:36 [2019-10-15T22:00:36.829Z]         --- PASS: TestMountDaemonRoot/shared/mount_root (0.06s)
22:00:36 [2019-10-15T22:00:36.829Z]         --- PASS: TestMountDaemonRoot/shared/bind_subpath (0.06s)
22:00:36 [2019-10-15T22:00:36.829Z]         --- PASS: TestMountDaemonRoot/shared/bind_root (0.04s)
22:00:36 [2019-10-15T22:00:36.829Z]     --- PASS: TestMountDaemonRoot/default (0.00s)
22:00:36 [2019-10-15T22:00:36.829Z]         --- PASS: TestMountDaemonRoot/default/mount_subpath (0.09s)
22:00:36 [2019-10-15T22:00:36.829Z]         --- PASS: TestMountDaemonRoot/default/mount_root (0.11s)
22:00:36 [2019-10-15T22:00:36.829Z]         --- PASS: TestMountDaemonRoot/default/bind_subpath (0.10s)
22:00:36 [2019-10-15T22:00:36.829Z]         --- PASS: TestMountDaemonRoot/default/bind_root (0.10s)
22:00:36 [2019-10-15T22:00:36.829Z]     --- PASS: TestMountDaemonRoot/rshared (0.00s)
22:00:36 [2019-10-15T22:00:36.829Z]         --- PASS: TestMountDaemonRoot/rshared/mount_root (0.11s)
22:00:36 [2019-10-15T22:00:36.829Z]         --- PASS: TestMountDaemonRoot/rshared/bind_root (0.11s)
22:00:36 [2019-10-15T22:00:36.829Z]         --- PASS: TestMountDaemonRoot/rshared/bind_subpath (0.10s)
22:00:36 [2019-10-15T22:00:36.829Z]         --- PASS: TestMountDaemonRoot/rshared/mount_subpath (0.12s)
22:00:36 [2019-10-15T22:00:36.829Z] === RUN   TestContainerBindMountNonRecursive
22:00:38 [2019-10-15T22:00:38.733Z] --- PASS: TestContainerBindMountNonRecursive (2.07s)
22:00:38 [2019-10-15T22:00:38.733Z] === RUN   TestNetworkNat
22:00:40 [2019-10-15T22:00:40.115Z] --- PASS: TestNetworkNat (0.98s)
22:00:40 [2019-10-15T22:00:40.115Z] === RUN   TestNetworkLocalhostTCPNat
22:00:40 [2019-10-15T22:00:40.684Z] --- PASS: TestNetworkLocalhostTCPNat (0.93s)
22:00:40 [2019-10-15T22:00:40.684Z] === RUN   TestNetworkLoopbackNat
22:00:42 [2019-10-15T22:00:42.064Z] --- PASS: TestNetworkLoopbackNat (1.20s)
22:00:42 [2019-10-15T22:00:42.064Z] === RUN   TestPause
22:00:43 [2019-10-15T22:00:43.001Z] --- PASS: TestPause (0.93s)
22:00:43 [2019-10-15T22:00:43.001Z] === RUN   TestPauseFailsOnWindowsServerContainers
22:00:43 [2019-10-15T22:00:43.001Z] --- SKIP: TestPauseFailsOnWindowsServerContainers (0.00s)
22:00:43 [2019-10-15T22:00:43.001Z]     pause_test.go:54: testEnv.DaemonInfo.OSType != "windows" || testEnv.DaemonInfo.Isolation != "process"
22:00:43 [2019-10-15T22:00:43.001Z] === RUN   TestPauseStopPausedContainer
22:00:43 [2019-10-15T22:00:43.937Z] --- PASS: TestPauseStopPausedContainer (0.95s)
22:00:43 [2019-10-15T22:00:43.937Z] === RUN   TestPsFilter
22:00:44 [2019-10-15T22:00:44.197Z] --- PASS: TestPsFilter (0.29s)
22:00:44 [2019-10-15T22:00:44.197Z] === RUN   TestRemoveContainerWithRemovedVolume
22:00:45 [2019-10-15T22:00:45.133Z] --- PASS: TestRemoveContainerWithRemovedVolume (0.83s)
22:00:45 [2019-10-15T22:00:45.133Z] === RUN   TestRemoveContainerWithVolume
22:00:45 [2019-10-15T22:00:45.701Z] --- PASS: TestRemoveContainerWithVolume (0.84s)
22:00:45 [2019-10-15T22:00:45.701Z] === RUN   TestRemoveContainerRunning
22:00:46 [2019-10-15T22:00:46.638Z] --- PASS: TestRemoveContainerRunning (0.84s)
22:00:46 [2019-10-15T22:00:46.638Z] === RUN   TestRemoveContainerForceRemoveRunning
22:00:47 [2019-10-15T22:00:47.574Z] --- PASS: TestRemoveContainerForceRemoveRunning (0.83s)
22:00:47 [2019-10-15T22:00:47.574Z] === RUN   TestRemoveInvalidContainer
22:00:47 [2019-10-15T22:00:47.574Z] --- PASS: TestRemoveInvalidContainer (0.03s)
22:00:47 [2019-10-15T22:00:47.574Z] === RUN   TestRenameLinkedContainer
22:00:50 [2019-10-15T22:00:50.862Z] --- PASS: TestRenameLinkedContainer (3.38s)
22:00:50 [2019-10-15T22:00:50.862Z] === RUN   TestRenameStoppedContainer
22:00:51 [2019-10-15T22:00:51.799Z] --- PASS: TestRenameStoppedContainer (0.82s)
22:00:51 [2019-10-15T22:00:51.799Z] === RUN   TestRenameRunningContainerAndReuse
22:00:53 [2019-10-15T22:00:53.703Z] --- PASS: TestRenameRunningContainerAndReuse (1.67s)
22:00:53 [2019-10-15T22:00:53.703Z] === RUN   TestRenameInvalidName
22:00:54 [2019-10-15T22:00:54.270Z] --- PASS: TestRenameInvalidName (0.87s)
22:00:54 [2019-10-15T22:00:54.270Z] === RUN   TestRenameAnonymousContainer
22:00:58 [2019-10-15T22:00:58.460Z] --- PASS: TestRenameAnonymousContainer (4.08s)
22:00:58 [2019-10-15T22:00:58.460Z] === RUN   TestRenameContainerWithSameName
22:00:59 [2019-10-15T22:00:59.398Z] --- PASS: TestRenameContainerWithSameName (0.87s)
22:00:59 [2019-10-15T22:00:59.398Z] === RUN   TestRenameContainerWithLinkedContainer
22:01:00 [2019-10-15T22:01:00.774Z] --- PASS: TestRenameContainerWithLinkedContainer (1.72s)
22:01:00 [2019-10-15T22:01:00.774Z] === RUN   TestResize
22:01:01 [2019-10-15T22:01:01.711Z] --- PASS: TestResize (0.85s)
22:01:01 [2019-10-15T22:01:01.711Z] === RUN   TestResizeWithInvalidSize
22:01:02 [2019-10-15T22:01:02.804Z] --- PASS: TestResizeWithInvalidSize (1.05s)
22:01:02 [2019-10-15T22:01:02.804Z] === RUN   TestResizeWhenContainerNotStarted
22:01:03 [2019-10-15T22:01:03.740Z] --- PASS: TestResizeWhenContainerNotStarted (0.85s)
22:01:03 [2019-10-15T22:01:03.740Z] === RUN   TestDaemonRestartKillContainers
22:01:03 [2019-10-15T22:01:03.740Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
22:01:03 [2019-10-15T22:01:03.740Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
22:01:03 [2019-10-15T22:01:03.740Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
22:01:03 [2019-10-15T22:01:03.740Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
22:01:03 [2019-10-15T22:01:03.740Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
22:01:03 [2019-10-15T22:01:03.740Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
22:01:03 [2019-10-15T22:01:03.740Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
22:01:03 [2019-10-15T22:01:03.740Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
22:01:03 [2019-10-15T22:01:03.740Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
22:01:03 [2019-10-15T22:01:03.740Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
22:01:03 [2019-10-15T22:01:03.740Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
22:01:03 [2019-10-15T22:01:03.740Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
22:01:03 [2019-10-15T22:01:03.740Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
22:01:03 [2019-10-15T22:01:03.740Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
22:01:03 [2019-10-15T22:01:03.740Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
22:01:03 [2019-10-15T22:01:03.740Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
22:01:03 [2019-10-15T22:01:03.740Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
22:01:03 [2019-10-15T22:01:03.740Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
22:01:03 [2019-10-15T22:01:03.740Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
22:01:03 [2019-10-15T22:01:03.740Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
22:01:03 [2019-10-15T22:01:03.740Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
22:01:03 [2019-10-15T22:01:03.740Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
22:01:03 [2019-10-15T22:01:03.740Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
22:01:03 [2019-10-15T22:01:03.740Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
22:01:03 [2019-10-15T22:01:03.740Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
22:01:03 [2019-10-15T22:01:03.740Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
22:01:03 [2019-10-15T22:01:03.740Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
22:01:03 [2019-10-15T22:01:03.740Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
22:01:06 [2019-10-15T22:01:06.279Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
22:01:06 [2019-10-15T22:01:06.538Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
22:01:06 [2019-10-15T22:01:06.798Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
22:01:07 [2019-10-15T22:01:07.368Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
22:01:09 [2019-10-15T22:01:09.277Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
22:01:09 [2019-10-15T22:01:09.277Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
22:01:09 [2019-10-15T22:01:09.536Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
22:01:09 [2019-10-15T22:01:09.796Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
22:01:12 [2019-10-15T22:01:12.330Z] --- PASS: TestDaemonRestartKillContainers (0.00s)
22:01:12 [2019-10-15T22:01:12.331Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon (2.60s)
22:01:12 [2019-10-15T22:01:12.331Z]         restart_test.go:67: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon"
22:01:12 [2019-10-15T22:01:12.331Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon (2.78s)
22:01:12 [2019-10-15T22:01:12.331Z]         restart_test.go:67: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon"
22:01:12 [2019-10-15T22:01:12.331Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon (3.01s)
22:01:12 [2019-10-15T22:01:12.331Z]         restart_test.go:67: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon"
22:01:12 [2019-10-15T22:01:12.331Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon (3.64s)
22:01:12 [2019-10-15T22:01:12.331Z]         restart_test.go:67: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon"
22:01:12 [2019-10-15T22:01:12.331Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon (1.62s)
22:01:12 [2019-10-15T22:01:12.331Z]         restart_test.go:67: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon"
22:01:12 [2019-10-15T22:01:12.331Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon (2.72s)
22:01:12 [2019-10-15T22:01:12.331Z]         restart_test.go:67: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon"
22:01:12 [2019-10-15T22:01:12.331Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon (2.92s)
22:01:12 [2019-10-15T22:01:12.331Z]         restart_test.go:67: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon"
22:01:12 [2019-10-15T22:01:12.331Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon (3.51s)
22:01:12 [2019-10-15T22:01:12.331Z]         restart_test.go:67: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon"
22:01:12 [2019-10-15T22:01:12.331Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon (1.64s)
22:01:12 [2019-10-15T22:01:12.331Z]         restart_test.go:67: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon"
22:01:12 [2019-10-15T22:01:12.331Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon (1.64s)
22:01:12 [2019-10-15T22:01:12.331Z]         restart_test.go:67: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon"
22:01:12 [2019-10-15T22:01:12.331Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon (1.55s)
22:01:12 [2019-10-15T22:01:12.331Z]         restart_test.go:67: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon"
22:01:12 [2019-10-15T22:01:12.331Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon (2.33s)
22:01:12 [2019-10-15T22:01:12.331Z]         restart_test.go:67: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon"
22:01:12 [2019-10-15T22:01:12.331Z] === RUN   TestCgroupNamespacesRun
22:01:14 [2019-10-15T22:01:14.233Z] --- PASS: TestCgroupNamespacesRun (1.84s)
22:01:14 [2019-10-15T22:01:14.233Z]     run_cgroupns_linux_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRun"
22:01:14 [2019-10-15T22:01:14.233Z] === RUN   TestCgroupNamespacesRunPrivileged
22:01:15 [2019-10-15T22:01:15.610Z] --- PASS: TestCgroupNamespacesRunPrivileged (1.79s)
22:01:15 [2019-10-15T22:01:15.610Z]     run_cgroupns_linux_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunPrivileged"
22:01:15 [2019-10-15T22:01:15.610Z] === RUN   TestCgroupNamespacesRunDaemonHostMode
22:01:17 [2019-10-15T22:01:17.515Z] --- PASS: TestCgroupNamespacesRunDaemonHostMode (1.82s)
22:01:17 [2019-10-15T22:01:17.515Z]     run_cgroupns_linux_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunDaemonHostMode"
22:01:17 [2019-10-15T22:01:17.515Z] === RUN   TestCgroupNamespacesRunHostMode
22:01:19 [2019-10-15T22:01:19.419Z] --- PASS: TestCgroupNamespacesRunHostMode (1.82s)
22:01:19 [2019-10-15T22:01:19.419Z]     run_cgroupns_linux_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunHostMode"
22:01:19 [2019-10-15T22:01:19.419Z] === RUN   TestCgroupNamespacesRunPrivateMode
22:01:21 [2019-10-15T22:01:21.325Z] --- PASS: TestCgroupNamespacesRunPrivateMode (1.87s)
22:01:21 [2019-10-15T22:01:21.325Z]     run_cgroupns_linux_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunPrivateMode"
22:01:21 [2019-10-15T22:01:21.325Z] === RUN   TestCgroupNamespacesRunPrivilegedAndPrivate
22:01:22 [2019-10-15T22:01:22.262Z] --- PASS: TestCgroupNamespacesRunPrivilegedAndPrivate (0.88s)
22:01:22 [2019-10-15T22:01:22.262Z]     run_cgroupns_linux_test.go:48: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunPrivilegedAndPrivate"
22:01:22 [2019-10-15T22:01:22.262Z] === RUN   TestCgroupNamespacesRunInvalidMode
22:01:23 [2019-10-15T22:01:23.198Z] --- PASS: TestCgroupNamespacesRunInvalidMode (0.86s)
22:01:23 [2019-10-15T22:01:23.198Z]     run_cgroupns_linux_test.go:48: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunInvalidMode"
22:01:23 [2019-10-15T22:01:23.198Z] === RUN   TestCgroupNamespacesRunOlderClient
22:01:25 [2019-10-15T22:01:25.100Z] --- PASS: TestCgroupNamespacesRunOlderClient (1.86s)
22:01:25 [2019-10-15T22:01:25.100Z]     run_cgroupns_linux_test.go:139: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunOlderClient"
22:01:25 [2019-10-15T22:01:25.100Z] === RUN   TestKernelTCPMemory
22:01:26 [2019-10-15T22:01:26.036Z] --- PASS: TestKernelTCPMemory (1.01s)
22:01:26 [2019-10-15T22:01:26.036Z] === RUN   TestNISDomainname
22:01:26 [2019-10-15T22:01:26.972Z] --- PASS: TestNISDomainname (1.14s)
22:01:26 [2019-10-15T22:01:26.972Z] === RUN   TestHostnameDnsResolution
22:01:28 [2019-10-15T22:01:28.876Z] --- PASS: TestHostnameDnsResolution (1.78s)
22:01:28 [2019-10-15T22:01:28.876Z] === RUN   TestStats
22:01:32 [2019-10-15T22:01:32.160Z] --- PASS: TestStats (2.80s)
22:01:32 [2019-10-15T22:01:32.160Z] === RUN   TestStopContainerWithTimeout
22:01:32 [2019-10-15T22:01:32.160Z] === RUN   TestStopContainerWithTimeout/0
22:01:32 [2019-10-15T22:01:32.160Z] === PAUSE TestStopContainerWithTimeout/0
22:01:32 [2019-10-15T22:01:32.160Z] === RUN   TestStopContainerWithTimeout/1
22:01:32 [2019-10-15T22:01:32.160Z] === PAUSE TestStopContainerWithTimeout/1
22:01:32 [2019-10-15T22:01:32.160Z] === RUN   TestStopContainerWithTimeout/3
22:01:32 [2019-10-15T22:01:32.160Z] === PAUSE TestStopContainerWithTimeout/3
22:01:32 [2019-10-15T22:01:32.160Z] === RUN   TestStopContainerWithTimeout/-1
22:01:32 [2019-10-15T22:01:32.160Z] === PAUSE TestStopContainerWithTimeout/-1
22:01:32 [2019-10-15T22:01:32.160Z] === CONT  TestStopContainerWithTimeout/0
22:01:32 [2019-10-15T22:01:32.160Z] === CONT  TestStopContainerWithTimeout/3
22:01:32 [2019-10-15T22:01:32.160Z] === CONT  TestStopContainerWithTimeout/1
22:01:32 [2019-10-15T22:01:32.160Z] === CONT  TestStopContainerWithTimeout/-1
22:01:35 [2019-10-15T22:01:35.449Z] --- PASS: TestStopContainerWithTimeout (0.02s)
22:01:35 [2019-10-15T22:01:35.449Z]     --- PASS: TestStopContainerWithTimeout/0 (1.19s)
22:01:35 [2019-10-15T22:01:35.449Z]     --- PASS: TestStopContainerWithTimeout/1 (2.35s)
22:01:35 [2019-10-15T22:01:35.449Z]     --- PASS: TestStopContainerWithTimeout/3 (3.14s)
22:01:35 [2019-10-15T22:01:35.449Z]     --- PASS: TestStopContainerWithTimeout/-1 (3.23s)
22:01:35 [2019-10-15T22:01:35.449Z] === RUN   TestDeleteDevicemapper
22:01:35 [2019-10-15T22:01:35.449Z] --- SKIP: TestDeleteDevicemapper (0.00s)
22:01:35 [2019-10-15T22:01:35.449Z]     stop_linux_test.go:74: testEnv.DaemonInfo.Driver != "devicemapper"
22:01:35 [2019-10-15T22:01:35.449Z] === RUN   TestStopContainerWithRestartPolicyAlways
22:01:38 [2019-10-15T22:01:38.737Z] --- PASS: TestStopContainerWithRestartPolicyAlways (3.45s)
22:01:38 [2019-10-15T22:01:38.737Z] === RUN   TestUpdateMemory
22:01:38 [2019-10-15T22:01:38.737Z] --- SKIP: TestUpdateMemory (0.00s)
22:01:38 [2019-10-15T22:01:38.737Z]     update_linux_test.go:23: !testEnv.DaemonInfo.SwapLimit
22:01:38 [2019-10-15T22:01:38.737Z] === RUN   TestUpdateCPUQuota
22:01:40 [2019-10-15T22:01:40.119Z] --- PASS: TestUpdateCPUQuota (1.72s)
22:01:40 [2019-10-15T22:01:40.119Z] === RUN   TestUpdatePidsLimit
22:01:40 [2019-10-15T22:01:40.119Z] === RUN   TestUpdatePidsLimit/update_from_none
22:01:40 [2019-10-15T22:01:40.378Z] === RUN   TestUpdatePidsLimit/no_change
22:01:40 [2019-10-15T22:01:40.945Z] === RUN   TestUpdatePidsLimit/update_lower
22:01:41 [2019-10-15T22:01:41.513Z] === RUN   TestUpdatePidsLimit/update_on_old_api_ignores_value
22:01:41 [2019-10-15T22:01:41.771Z] === RUN   TestUpdatePidsLimit/unset_limit_with_zero
22:01:42 [2019-10-15T22:01:42.338Z] === RUN   TestUpdatePidsLimit/unset_limit_with_minus_one
22:01:42 [2019-10-15T22:01:42.906Z] === RUN   TestUpdatePidsLimit/unset_limit_with_minus_two
22:01:44 [2019-10-15T22:01:44.808Z] --- PASS: TestUpdatePidsLimit (4.83s)
22:01:44 [2019-10-15T22:01:44.808Z]     --- PASS: TestUpdatePidsLimit/update_from_none (0.46s)
22:01:44 [2019-10-15T22:01:44.808Z]     --- PASS: TestUpdatePidsLimit/no_change (0.46s)
22:01:44 [2019-10-15T22:01:44.808Z]     --- PASS: TestUpdatePidsLimit/update_lower (0.48s)
22:01:44 [2019-10-15T22:01:44.808Z]     --- PASS: TestUpdatePidsLimit/update_on_old_api_ignores_value (0.46s)
22:01:44 [2019-10-15T22:01:44.808Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_zero (0.50s)
22:01:44 [2019-10-15T22:01:44.808Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_minus_one (0.47s)
22:01:44 [2019-10-15T22:01:44.808Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_minus_two (0.52s)
22:01:44 [2019-10-15T22:01:44.808Z] === RUN   TestUpdateRestartPolicy
22:01:59 [2019-10-15T22:01:59.683Z] --- PASS: TestUpdateRestartPolicy (12.58s)
22:01:59 [2019-10-15T22:01:59.683Z] === RUN   TestUpdateRestartWithAutoRemove
22:01:59 [2019-10-15T22:01:59.683Z] --- PASS: TestUpdateRestartWithAutoRemove (0.86s)
22:01:59 [2019-10-15T22:01:59.683Z] === RUN   TestWaitNonBlocked
22:01:59 [2019-10-15T22:01:59.683Z] === RUN   TestWaitNonBlocked/wait-nonblocking-exit-0
22:01:59 [2019-10-15T22:01:59.683Z] === PAUSE TestWaitNonBlocked/wait-nonblocking-exit-0
22:01:59 [2019-10-15T22:01:59.683Z] === RUN   TestWaitNonBlocked/wait-nonblocking-exit-random
22:01:59 [2019-10-15T22:01:59.683Z] === PAUSE TestWaitNonBlocked/wait-nonblocking-exit-random
22:01:59 [2019-10-15T22:01:59.683Z] === CONT  TestWaitNonBlocked/wait-nonblocking-exit-0
22:01:59 [2019-10-15T22:01:59.683Z] === CONT  TestWaitNonBlocked/wait-nonblocking-exit-random
22:01:59 [2019-10-15T22:01:59.683Z] --- PASS: TestWaitNonBlocked (0.03s)
22:01:59 [2019-10-15T22:01:59.683Z]     --- PASS: TestWaitNonBlocked/wait-nonblocking-exit-random (0.93s)
22:01:59 [2019-10-15T22:01:59.684Z]     --- PASS: TestWaitNonBlocked/wait-nonblocking-exit-0 (0.99s)
22:01:59 [2019-10-15T22:01:59.684Z] === RUN   TestWaitBlocked
22:01:59 [2019-10-15T22:01:59.684Z] === RUN   TestWaitBlocked/test-wait-blocked-exit-zero
22:01:59 [2019-10-15T22:01:59.684Z] === PAUSE TestWaitBlocked/test-wait-blocked-exit-zero
22:01:59 [2019-10-15T22:01:59.684Z] === RUN   TestWaitBlocked/test-wait-blocked-exit-random
22:01:59 [2019-10-15T22:01:59.684Z] === PAUSE TestWaitBlocked/test-wait-blocked-exit-random
22:01:59 [2019-10-15T22:01:59.684Z] === CONT  TestWaitBlocked/test-wait-blocked-exit-zero
22:01:59 [2019-10-15T22:01:59.684Z] === CONT  TestWaitBlocked/test-wait-blocked-exit-random
22:02:00 [2019-10-15T22:02:00.620Z] --- PASS: TestWaitBlocked (0.03s)
22:02:00 [2019-10-15T22:02:00.620Z]     --- PASS: TestWaitBlocked/test-wait-blocked-exit-random (1.09s)
22:02:00 [2019-10-15T22:02:00.620Z]     --- PASS: TestWaitBlocked/test-wait-blocked-exit-zero (1.13s)
22:02:00 [2019-10-15T22:02:00.620Z] === CONT  TestContainerStartOnDaemonRestart
22:02:00 [2019-10-15T22:02:00.620Z] === CONT  TestIpcModeOlderClient
22:02:00 [2019-10-15T22:02:00.620Z] === CONT  TestDaemonRestartIpcMode
22:02:00 [2019-10-15T22:02:00.620Z] --- PASS: TestIpcModeOlderClient (0.18s)
22:02:03 [2019-10-15T22:02:03.920Z] --- PASS: TestContainerStartOnDaemonRestart (3.14s)
22:02:03 [2019-10-15T22:02:03.920Z]     daemon_linux_test.go:35: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestContainerStartOnDaemonRestart"
22:02:04 [2019-10-15T22:02:04.487Z] --- PASS: TestDaemonRestartIpcMode (3.91s)
22:02:04 [2019-10-15T22:02:04.487Z]     daemon_linux_test.go:89: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartIpcMode"
22:02:04 [2019-10-15T22:02:04.487Z] PASS
22:02:04 [2019-10-15T22:02:04.487Z] 
22:02:04 [2019-10-15T22:02:04.487Z] === Skipped
22:02:04 [2019-10-15T22:02:04.487Z] === SKIP: arm64.integration.container TestCheckpoint (0.00s)
22:02:04 [2019-10-15T22:02:04.487Z]     checkpoint_test.go:33: TestCheckpoint is broken; see https://github.com/moby/moby/issues/38963
22:02:04 [2019-10-15T22:02:04.487Z] 
22:02:04 [2019-10-15T22:02:04.487Z] === SKIP: arm64.integration.container TestInspectOomKilledTrue (0.00s)
22:02:04 [2019-10-15T22:02:04.487Z]     kill_test.go:151: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
22:02:04 [2019-10-15T22:02:04.487Z] 
22:02:04 [2019-10-15T22:02:04.487Z] === SKIP: arm64.integration.container TestInspectOomKilledFalse (0.00s)
22:02:04 [2019-10-15T22:02:04.487Z]     kill_test.go:169: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
22:02:04 [2019-10-15T22:02:04.487Z] 
22:02:04 [2019-10-15T22:02:04.487Z] === SKIP: arm64.integration.container TestPauseFailsOnWindowsServerContainers (0.00s)
22:02:04 [2019-10-15T22:02:04.487Z]     pause_test.go:54: testEnv.DaemonInfo.OSType != "windows" || testEnv.DaemonInfo.Isolation != "process"
22:02:04 [2019-10-15T22:02:04.487Z] 
22:02:04 [2019-10-15T22:02:04.487Z] === SKIP: arm64.integration.container TestDeleteDevicemapper (0.00s)
22:02:04 [2019-10-15T22:02:04.487Z]     stop_linux_test.go:74: testEnv.DaemonInfo.Driver != "devicemapper"
22:02:04 [2019-10-15T22:02:04.487Z] 
22:02:04 [2019-10-15T22:02:04.487Z] === SKIP: arm64.integration.container TestUpdateMemory (0.00s)
22:02:04 [2019-10-15T22:02:04.487Z]     update_linux_test.go:23: !testEnv.DaemonInfo.SwapLimit
22:02:04 [2019-10-15T22:02:04.487Z] 
22:02:04 [2019-10-15T22:02:04.487Z] 
22:02:04 [2019-10-15T22:02:04.487Z] DONE 197 tests, 6 skipped in 134.297s
22:02:04 [2019-10-15T22:02:04.487Z] Running /go/src/github.com/docker/docker/integration/image (arm64.integration.image) flags=-test.v -test.timeout=120m 
22:02:04 [2019-10-15T22:02:04.487Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-image-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-image-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.image -t ./test.main -test.v -test.timeout=120m
22:02:04 [2019-10-15T22:02:04.487Z] ++ set -e
22:02:04 [2019-10-15T22:02:04.487Z] ++ '[' -n 0 ']'
22:02:04 [2019-10-15T22:02:04.487Z] ++ set -x
22:02:04 [2019-10-15T22:02:04.487Z] ++ 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=arm64 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/arm64-integration-image-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-image-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.image -t ./test.main -test.v -test.timeout=120m
22:02:04 [2019-10-15T22:02:04.487Z] INFO: Testing against a local daemon
22:02:04 [2019-10-15T22:02:04.487Z] === RUN   TestCommitInheritsEnv
22:02:05 [2019-10-15T22:02:05.423Z] --- PASS: TestCommitInheritsEnv (0.57s)
22:02:05 [2019-10-15T22:02:05.424Z] === RUN   TestImportExtremelyLargeImageWorks
22:02:05 [2019-10-15T22:02:05.424Z] --- SKIP: TestImportExtremelyLargeImageWorks (0.00s)
22:02:05 [2019-10-15T22:02:05.424Z]     import_test.go:21: runtime.GOARCH == "arm64": effective test will be time out
22:02:05 [2019-10-15T22:02:05.424Z] === RUN   TestImagesFilterMultiReference
22:02:05 [2019-10-15T22:02:05.424Z] --- PASS: TestImagesFilterMultiReference (0.11s)
22:02:05 [2019-10-15T22:02:05.424Z] === RUN   TestImagePullPlatformInvalid
22:02:05 [2019-10-15T22:02:05.424Z] --- PASS: TestImagePullPlatformInvalid (0.05s)
22:02:05 [2019-10-15T22:02:05.424Z] === RUN   TestRemoveImageOrphaning
22:02:05 [2019-10-15T22:02:05.991Z] --- PASS: TestRemoveImageOrphaning (0.54s)
22:02:05 [2019-10-15T22:02:05.991Z] === RUN   TestRemoveImageGarbageCollector
22:02:05 [2019-10-15T22:02:05.991Z] --- SKIP: TestRemoveImageGarbageCollector (0.00s)
22:02:05 [2019-10-15T22:02:05.991Z]     remove_unix_test.go:36: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:02:05 [2019-10-15T22:02:05.991Z] === RUN   TestTagUnprefixedRepoByNameOrName
22:02:05 [2019-10-15T22:02:05.991Z] --- PASS: TestTagUnprefixedRepoByNameOrName (0.05s)
22:02:05 [2019-10-15T22:02:05.991Z] === RUN   TestTagInvalidReference
22:02:05 [2019-10-15T22:02:05.991Z] --- PASS: TestTagInvalidReference (0.03s)
22:02:05 [2019-10-15T22:02:05.991Z] === RUN   TestTagValidPrefixedRepo
22:02:05 [2019-10-15T22:02:05.991Z] --- PASS: TestTagValidPrefixedRepo (0.08s)
22:02:05 [2019-10-15T22:02:05.991Z] === RUN   TestTagExistedNameWithoutForce
22:02:05 [2019-10-15T22:02:05.991Z] --- PASS: TestTagExistedNameWithoutForce (0.05s)
22:02:05 [2019-10-15T22:02:05.991Z] === RUN   TestTagOfficialNames
22:02:06 [2019-10-15T22:02:06.250Z] --- PASS: TestTagOfficialNames (0.08s)
22:02:06 [2019-10-15T22:02:06.250Z] === RUN   TestTagMatchesDigest
22:02:06 [2019-10-15T22:02:06.250Z] --- PASS: TestTagMatchesDigest (0.03s)
22:02:06 [2019-10-15T22:02:06.250Z] PASS
22:02:06 [2019-10-15T22:02:06.250Z] 
22:02:06 [2019-10-15T22:02:06.250Z] === Skipped
22:02:06 [2019-10-15T22:02:06.250Z] === SKIP: arm64.integration.image TestImportExtremelyLargeImageWorks (0.00s)
22:02:06 [2019-10-15T22:02:06.250Z]     import_test.go:21: runtime.GOARCH == "arm64": effective test will be time out
22:02:06 [2019-10-15T22:02:06.250Z] 
22:02:06 [2019-10-15T22:02:06.250Z] === SKIP: arm64.integration.image TestRemoveImageGarbageCollector (0.00s)
22:02:06 [2019-10-15T22:02:06.250Z]     remove_unix_test.go:36: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:02:06 [2019-10-15T22:02:06.250Z] 
22:02:06 [2019-10-15T22:02:06.250Z] 
22:02:06 [2019-10-15T22:02:06.250Z] DONE 12 tests, 2 skipped in 1.844s
22:02:06 [2019-10-15T22:02:06.250Z] Running /go/src/github.com/docker/docker/integration/network (arm64.integration.network) flags=-test.v -test.timeout=120m 
22:02:06 [2019-10-15T22:02:06.250Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-network-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-network-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.network -t ./test.main -test.v -test.timeout=120m
22:02:06 [2019-10-15T22:02:06.250Z] ++ set -e
22:02:06 [2019-10-15T22:02:06.250Z] ++ '[' -n 0 ']'
22:02:06 [2019-10-15T22:02:06.250Z] ++ set -x
22:02:06 [2019-10-15T22:02:06.250Z] ++ 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=arm64 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/arm64-integration-network-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-network-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.network -t ./test.main -test.v -test.timeout=120m
22:02:06 [2019-10-15T22:02:06.250Z] INFO: Testing against a local daemon
22:02:06 [2019-10-15T22:02:06.250Z] === RUN   TestNetworkCreateDelete
22:02:06 [2019-10-15T22:02:06.818Z] --- PASS: TestNetworkCreateDelete (0.37s)
22:02:06 [2019-10-15T22:02:06.818Z] === RUN   TestDockerNetworkDeletePreferID
22:02:07 [2019-10-15T22:02:07.756Z] --- PASS: TestDockerNetworkDeletePreferID (1.07s)
22:02:07 [2019-10-15T22:02:07.756Z] === RUN   TestInspectNetwork
22:02:14 [2019-10-15T22:02:14.358Z] === RUN   TestInspectNetwork/full_network_id
22:02:14 [2019-10-15T22:02:14.358Z] === RUN   TestInspectNetwork/partial_network_id
22:02:14 [2019-10-15T22:02:14.358Z] === RUN   TestInspectNetwork/network_name
22:02:14 [2019-10-15T22:02:14.358Z] === RUN   TestInspectNetwork/network_name_and_swarm_scope
22:02:19 [2019-10-15T22:02:19.626Z] --- PASS: TestInspectNetwork (10.96s)
22:02:19 [2019-10-15T22:02:19.626Z]     inspect_test.go:18: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestInspectNetwork"
22:02:19 [2019-10-15T22:02:19.626Z]     --- PASS: TestInspectNetwork/full_network_id (0.00s)
22:02:19 [2019-10-15T22:02:19.626Z]     --- PASS: TestInspectNetwork/partial_network_id (0.00s)
22:02:19 [2019-10-15T22:02:19.626Z]     --- PASS: TestInspectNetwork/network_name (0.00s)
22:02:19 [2019-10-15T22:02:19.626Z]     --- PASS: TestInspectNetwork/network_name_and_swarm_scope (0.00s)
22:02:19 [2019-10-15T22:02:19.626Z] === RUN   TestRunContainerWithBridgeNone
22:02:21 [2019-10-15T22:02:21.530Z] --- PASS: TestRunContainerWithBridgeNone (2.89s)
22:02:21 [2019-10-15T22:02:21.530Z]     network_test.go:25: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestRunContainerWithBridgeNone"
22:02:21 [2019-10-15T22:02:21.530Z] === RUN   TestNetworkInvalidJSON
22:02:21 [2019-10-15T22:02:21.790Z] === RUN   TestNetworkInvalidJSON//networks/create
22:02:21 [2019-10-15T22:02:21.790Z] === PAUSE TestNetworkInvalidJSON//networks/create
22:02:21 [2019-10-15T22:02:21.790Z] === RUN   TestNetworkInvalidJSON//networks/bridge/connect
22:02:21 [2019-10-15T22:02:21.790Z] === PAUSE TestNetworkInvalidJSON//networks/bridge/connect
22:02:21 [2019-10-15T22:02:21.790Z] === RUN   TestNetworkInvalidJSON//networks/bridge/disconnect
22:02:21 [2019-10-15T22:02:21.790Z] === PAUSE TestNetworkInvalidJSON//networks/bridge/disconnect
22:02:21 [2019-10-15T22:02:21.790Z] === CONT  TestNetworkInvalidJSON//networks/create
22:02:21 [2019-10-15T22:02:21.790Z] === CONT  TestNetworkInvalidJSON//networks/bridge/connect
22:02:21 [2019-10-15T22:02:21.790Z] === CONT  TestNetworkInvalidJSON//networks/bridge/disconnect
22:02:21 [2019-10-15T22:02:21.790Z] --- PASS: TestNetworkInvalidJSON (0.03s)
22:02:21 [2019-10-15T22:02:21.790Z]     --- PASS: TestNetworkInvalidJSON//networks/bridge/connect (0.00s)
22:02:21 [2019-10-15T22:02:21.790Z]     --- PASS: TestNetworkInvalidJSON//networks/bridge/disconnect (0.00s)
22:02:21 [2019-10-15T22:02:21.790Z]     --- PASS: TestNetworkInvalidJSON//networks/create (0.00s)
22:02:21 [2019-10-15T22:02:21.790Z] === RUN   TestDaemonRestartWithLiveRestore
22:02:23 [2019-10-15T22:02:23.166Z] --- PASS: TestDaemonRestartWithLiveRestore (1.34s)
22:02:23 [2019-10-15T22:02:23.166Z]     service_test.go:32: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartWithLiveRestore"
22:02:23 [2019-10-15T22:02:23.166Z] === RUN   TestDaemonDefaultNetworkPools
22:02:24 [2019-10-15T22:02:24.103Z] --- PASS: TestDaemonDefaultNetworkPools (1.08s)
22:02:24 [2019-10-15T22:02:24.103Z]     service_test.go:57: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonDefaultNetworkPools"
22:02:24 [2019-10-15T22:02:24.103Z] === RUN   TestDaemonRestartWithExistingNetwork
22:02:26 [2019-10-15T22:02:26.006Z] --- PASS: TestDaemonRestartWithExistingNetwork (1.68s)
22:02:26 [2019-10-15T22:02:26.006Z]     service_test.go:98: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartWithExistingNetwork"
22:02:26 [2019-10-15T22:02:26.006Z] === RUN   TestDaemonRestartWithExistingNetworkWithDefaultPoolRange
22:02:27 [2019-10-15T22:02:27.912Z] --- PASS: TestDaemonRestartWithExistingNetworkWithDefaultPoolRange (2.08s)
22:02:27 [2019-10-15T22:02:27.912Z]     service_test.go:131: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartWithExistingNetworkWithDefaultPoolRange"
22:02:27 [2019-10-15T22:02:27.912Z] === RUN   TestDaemonWithBipAndDefaultNetworkPool
22:02:28 [2019-10-15T22:02:28.480Z] --- PASS: TestDaemonWithBipAndDefaultNetworkPool (0.71s)
22:02:28 [2019-10-15T22:02:28.480Z]     service_test.go:181: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonWithBipAndDefaultNetworkPool"
22:02:28 [2019-10-15T22:02:28.480Z] === RUN   TestServiceWithPredefinedNetwork
22:02:31 [2019-10-15T22:02:31.768Z] --- PASS: TestServiceWithPredefinedNetwork (3.27s)
22:02:31 [2019-10-15T22:02:31.768Z]     service_test.go:203: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithPredefinedNetwork"
22:02:31 [2019-10-15T22:02:31.768Z] === RUN   TestServiceRemoveKeepsIngressNetwork
22:02:31 [2019-10-15T22:02:31.768Z] --- SKIP: TestServiceRemoveKeepsIngressNetwork (0.00s)
22:02:31 [2019-10-15T22:02:31.768Z]     service_test.go:230: FLAKY_TEST
22:02:31 [2019-10-15T22:02:31.768Z] === RUN   TestServiceWithDataPathPortInit
22:02:53 [2019-10-15T22:02:53.700Z] --- PASS: TestServiceWithDataPathPortInit (19.62s)
22:02:53 [2019-10-15T22:02:53.700Z]     service_test.go:323: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithDataPathPortInit"
22:02:53 [2019-10-15T22:02:53.700Z]     service_test.go:355: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithDataPathPortInit"
22:02:53 [2019-10-15T22:02:53.700Z] === RUN   TestServiceWithDefaultAddressPoolInit
22:03:01 [2019-10-15T22:03:01.814Z] --- PASS: TestServiceWithDefaultAddressPoolInit (9.81s)
22:03:01 [2019-10-15T22:03:01.814Z]     service_test.go:388: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithDefaultAddressPoolInit"
22:03:01 [2019-10-15T22:03:01.814Z]     service_test.go:418: TestServiceWithDefaultAddressPoolInit: NetworkInspect: {Name:sthiraTestServiceWithDefaultAddressPoolInit ID:6c7vefpoxgdale5ir4kx093xl Created:2019-10-15 22:02:53.103169921 +0000 UTC Scope:swarm Driver:overlay EnableIPv6:false IPAM:{Driver:default Options:map[] Config:[{Subnet:20.20.0.0/24 IPRange: Gateway:20.20.0.1 AuxAddress:map[]}]} Internal:false Attachable:false Ingress:false ConfigFrom:{Network:} ConfigOnly:false Containers:map[85255545afd6651ca22e70f02414e8f18046fa10e3517c973f2f3552dba2ec6d:{Name:TestServiceTestServiceWithDefaultAddressPoolInit.1.ft3kjd087mi1111n6gchwg6gt EndpointID:ac40887604f9f346829bdb3c9a6b999829dae39b6763b64b0d56e7107187e39f MacAddress:02:42:14:14:00:03 IPv4Address:20.20.0.3/24 IPv6Address:} lb-sthiraTestServiceWithDefaultAddressPoolInit:{Name:sthiraTestServiceWithDefaultAddressPoolInit-endpoint EndpointID:b5828a9ec1424dffc6be1f0f2f6aecfcda4a7bbdc04a336553aade1dcf6fc6a4 MacAddress:02:42:14:14:00:04 IPv4Address:20.20.0.4/24 IPv6Address:}] Options:map[com.docker.network.driver.overlay.vxlanid_list:4097] Labels:map[] Peers:[{Name:f788d0bf7f5c IP:127.0.0.1}] Services:map[TestServiceTestServiceWithDefaultAddressPoolInit:{VIP:20.20.0.2 Ports:[] LocalLBIndex:256 Tasks:[{Name:TestServiceTestServiceWithDefaultAddressPoolInit.1.ft3kjd087mi1111n6gchwg6gt EndpointID:ac40887604f9f346829bdb3c9a6b999829dae39b6763b64b0d56e7107187e39f EndpointIP:20.20.0.3 Info:map[Host IP:127.0.0.1]}]}]}
22:03:01 [2019-10-15T22:03:01.814Z] PASS
22:03:01 [2019-10-15T22:03:01.814Z] 
22:03:01 [2019-10-15T22:03:01.814Z] === Skipped
22:03:01 [2019-10-15T22:03:01.814Z] === SKIP: arm64.integration.network TestServiceRemoveKeepsIngressNetwork (0.00s)
22:03:01 [2019-10-15T22:03:01.814Z]     service_test.go:230: FLAKY_TEST
22:03:01 [2019-10-15T22:03:01.814Z] 
22:03:01 [2019-10-15T22:03:01.814Z] 
22:03:01 [2019-10-15T22:03:01.814Z] DONE 21 tests, 1 skipped in 55.053s
22:03:01 [2019-10-15T22:03:01.814Z] Running /go/src/github.com/docker/docker/integration/network/ipvlan (arm64.integration.network.ipvlan) flags=-test.v -test.timeout=120m 
22:03:01 [2019-10-15T22:03:01.814Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-network-ipvlan-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-network-ipvlan-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.network.ipvlan -t ./test.main -test.v -test.timeout=120m
22:03:01 [2019-10-15T22:03:01.814Z] ++ set -e
22:03:01 [2019-10-15T22:03:01.814Z] ++ '[' -n 0 ']'
22:03:01 [2019-10-15T22:03:01.814Z] ++ set -x
22:03:01 [2019-10-15T22:03:01.814Z] ++ 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=arm64 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/arm64-integration-network-ipvlan-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-network-ipvlan-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.network.ipvlan -t ./test.main -test.v -test.timeout=120m
22:03:01 [2019-10-15T22:03:01.814Z] INFO: Testing against a local daemon
22:03:01 [2019-10-15T22:03:01.814Z] === RUN   TestDockerNetworkIpvlanPersistance
22:03:01 [2019-10-15T22:03:01.814Z] --- SKIP: TestDockerNetworkIpvlanPersistance (0.00s)
22:03:01 [2019-10-15T22:03:01.814Z]     ipvlan_test.go:26: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
22:03:01 [2019-10-15T22:03:01.814Z] === RUN   TestDockerNetworkIpvlan
22:03:01 [2019-10-15T22:03:01.814Z] --- SKIP: TestDockerNetworkIpvlan (0.00s)
22:03:01 [2019-10-15T22:03:01.814Z]     ipvlan_test.go:53: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
22:03:01 [2019-10-15T22:03:01.814Z] PASS
22:03:01 [2019-10-15T22:03:01.814Z] 
22:03:01 [2019-10-15T22:03:01.814Z] === Skipped
22:03:01 [2019-10-15T22:03:01.814Z] === SKIP: arm64.integration.network.ipvlan TestDockerNetworkIpvlanPersistance (0.00s)
22:03:01 [2019-10-15T22:03:01.814Z]     ipvlan_test.go:26: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
22:03:01 [2019-10-15T22:03:01.814Z] 
22:03:01 [2019-10-15T22:03:01.814Z] === SKIP: arm64.integration.network.ipvlan TestDockerNetworkIpvlan (0.00s)
22:03:01 [2019-10-15T22:03:01.814Z]     ipvlan_test.go:53: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
22:03:01 [2019-10-15T22:03:01.814Z] 
22:03:01 [2019-10-15T22:03:01.814Z] 
22:03:01 [2019-10-15T22:03:01.814Z] DONE 2 tests, 2 skipped in 0.159s
22:03:01 [2019-10-15T22:03:01.814Z] Running /go/src/github.com/docker/docker/integration/network/macvlan (arm64.integration.network.macvlan) flags=-test.v -test.timeout=120m 
22:03:01 [2019-10-15T22:03:01.814Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-network-macvlan-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-network-macvlan-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.network.macvlan -t ./test.main -test.v -test.timeout=120m
22:03:01 [2019-10-15T22:03:01.814Z] ++ set -e
22:03:01 [2019-10-15T22:03:01.814Z] ++ '[' -n 0 ']'
22:03:01 [2019-10-15T22:03:01.814Z] ++ set -x
22:03:01 [2019-10-15T22:03:01.814Z] ++ 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=arm64 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/arm64-integration-network-macvlan-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-network-macvlan-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.network.macvlan -t ./test.main -test.v -test.timeout=120m
22:03:01 [2019-10-15T22:03:01.814Z] INFO: Testing against a local daemon
22:03:01 [2019-10-15T22:03:01.814Z] === RUN   TestDockerNetworkMacvlanPersistance
22:03:03 [2019-10-15T22:03:03.717Z] --- PASS: TestDockerNetworkMacvlanPersistance (1.88s)
22:03:03 [2019-10-15T22:03:03.717Z]     macvlan_test.go:24: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlanPersistance"
22:03:03 [2019-10-15T22:03:03.717Z] === RUN   TestDockerNetworkMacvlan
22:03:04 [2019-10-15T22:03:04.653Z] === RUN   TestDockerNetworkMacvlan/Subinterface
22:03:05 [2019-10-15T22:03:05.590Z] === RUN   TestDockerNetworkMacvlan/OverlapParent
22:03:06 [2019-10-15T22:03:06.967Z] === RUN   TestDockerNetworkMacvlan/NilParent
22:03:10 [2019-10-15T22:03:10.253Z] === RUN   TestDockerNetworkMacvlan/InternalMode
22:03:14 [2019-10-15T22:03:14.439Z] === RUN   TestDockerNetworkMacvlan/MultiSubnet
22:03:21 [2019-10-15T22:03:21.003Z] === RUN   TestDockerNetworkMacvlan/Addressing
22:03:22 [2019-10-15T22:03:22.947Z] --- PASS: TestDockerNetworkMacvlan (19.36s)
22:03:22 [2019-10-15T22:03:22.947Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
22:03:22 [2019-10-15T22:03:22.947Z]     --- PASS: TestDockerNetworkMacvlan/Subinterface (0.09s)
22:03:22 [2019-10-15T22:03:22.947Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
22:03:22 [2019-10-15T22:03:22.947Z]     --- PASS: TestDockerNetworkMacvlan/OverlapParent (0.14s)
22:03:22 [2019-10-15T22:03:22.947Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
22:03:22 [2019-10-15T22:03:22.947Z]     --- PASS: TestDockerNetworkMacvlan/NilParent (1.98s)
22:03:22 [2019-10-15T22:03:22.947Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
22:03:22 [2019-10-15T22:03:22.947Z]     --- PASS: TestDockerNetworkMacvlan/InternalMode (3.05s)
22:03:22 [2019-10-15T22:03:22.947Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
22:03:22 [2019-10-15T22:03:22.947Z]     --- PASS: TestDockerNetworkMacvlan/MultiSubnet (4.86s)
22:03:22 [2019-10-15T22:03:22.947Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
22:03:22 [2019-10-15T22:03:22.947Z]     --- PASS: TestDockerNetworkMacvlan/Addressing (1.39s)
22:03:22 [2019-10-15T22:03:22.947Z] PASS
22:03:22 [2019-10-15T22:03:22.947Z] 
22:03:22 [2019-10-15T22:03:22.947Z] DONE 8 tests in 21.384s
22:03:22 [2019-10-15T22:03:22.947Z] Running /go/src/github.com/docker/docker/integration/plugin (arm64.integration.plugin) flags=-test.v -test.timeout=120m 
22:03:22 [2019-10-15T22:03:22.947Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-plugin-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-plugin-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.plugin -t ./test.main -test.v -test.timeout=120m
22:03:22 [2019-10-15T22:03:22.947Z] ++ set -e
22:03:22 [2019-10-15T22:03:22.947Z] ++ '[' -n 0 ']'
22:03:22 [2019-10-15T22:03:22.947Z] ++ set -x
22:03:22 [2019-10-15T22:03:22.947Z] ++ 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=arm64 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/arm64-integration-plugin-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-plugin-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.plugin -t ./test.main -test.v -test.timeout=120m
22:03:22 [2019-10-15T22:03:22.947Z] testing: warning: no tests to run
22:03:22 [2019-10-15T22:03:22.947Z] PASS
22:03:22 [2019-10-15T22:03:22.947Z] 
22:03:22 [2019-10-15T22:03:22.947Z] DONE 0 tests in 0.027s
22:03:22 [2019-10-15T22:03:22.947Z] Running /go/src/github.com/docker/docker/integration/plugin/authz (arm64.integration.plugin.authz) flags=-test.v -test.timeout=120m 
22:03:22 [2019-10-15T22:03:22.947Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-plugin-authz-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-plugin-authz-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.plugin.authz -t ./test.main -test.v -test.timeout=120m
22:03:22 [2019-10-15T22:03:22.947Z] ++ set -e
22:03:22 [2019-10-15T22:03:22.947Z] ++ '[' -n 0 ']'
22:03:22 [2019-10-15T22:03:22.947Z] ++ set -x
22:03:22 [2019-10-15T22:03:22.947Z] ++ 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=arm64 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/arm64-integration-plugin-authz-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-plugin-authz-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.plugin.authz -t ./test.main -test.v -test.timeout=120m
22:03:23 [2019-10-15T22:03:23.206Z] INFO: Testing against a local daemon
22:03:23 [2019-10-15T22:03:23.206Z] === RUN   TestAuthZPluginAllowRequest
22:03:25 [2019-10-15T22:03:25.109Z] --- PASS: TestAuthZPluginAllowRequest (1.75s)
22:03:25 [2019-10-15T22:03:25.109Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginAllowRequest"
22:03:25 [2019-10-15T22:03:25.109Z] === RUN   TestAuthZPluginTLS
22:03:25 [2019-10-15T22:03:25.368Z] --- PASS: TestAuthZPluginTLS (0.59s)
22:03:25 [2019-10-15T22:03:25.368Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginTLS"
22:03:25 [2019-10-15T22:03:25.368Z] === RUN   TestAuthZPluginDenyRequest
22:03:25 [2019-10-15T22:03:25.936Z] --- PASS: TestAuthZPluginDenyRequest (0.57s)
22:03:25 [2019-10-15T22:03:25.936Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginDenyRequest"
22:03:25 [2019-10-15T22:03:25.936Z] === RUN   TestAuthZPluginAPIDenyResponse
22:03:26 [2019-10-15T22:03:26.502Z] --- PASS: TestAuthZPluginAPIDenyResponse (0.57s)
22:03:26 [2019-10-15T22:03:26.502Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginAPIDenyResponse"
22:03:26 [2019-10-15T22:03:26.502Z] === RUN   TestAuthZPluginDenyResponse
22:03:27 [2019-10-15T22:03:27.070Z] --- PASS: TestAuthZPluginDenyResponse (0.59s)
22:03:27 [2019-10-15T22:03:27.070Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginDenyResponse"
22:03:27 [2019-10-15T22:03:27.070Z] === RUN   TestAuthZPluginAllowEventStream
22:03:28 [2019-10-15T22:03:28.974Z] --- PASS: TestAuthZPluginAllowEventStream (1.69s)
22:03:28 [2019-10-15T22:03:28.974Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginAllowEventStream"
22:03:28 [2019-10-15T22:03:28.974Z] === RUN   TestAuthZPluginErrorResponse
22:03:29 [2019-10-15T22:03:29.541Z] --- PASS: TestAuthZPluginErrorResponse (0.58s)
22:03:29 [2019-10-15T22:03:29.541Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginErrorResponse"
22:03:29 [2019-10-15T22:03:29.541Z] === RUN   TestAuthZPluginErrorRequest
22:03:30 [2019-10-15T22:03:30.109Z] --- PASS: TestAuthZPluginErrorRequest (0.57s)
22:03:30 [2019-10-15T22:03:30.109Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginErrorRequest"
22:03:30 [2019-10-15T22:03:30.109Z] === RUN   TestAuthZPluginEnsureNoDuplicatePluginRegistration
22:03:30 [2019-10-15T22:03:30.676Z] --- PASS: TestAuthZPluginEnsureNoDuplicatePluginRegistration (0.58s)
22:03:30 [2019-10-15T22:03:30.676Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginEnsureNoDuplicatePluginRegistration"
22:03:30 [2019-10-15T22:03:30.676Z] === RUN   TestAuthZPluginEnsureLoadImportWorking
22:03:33 [2019-10-15T22:03:33.209Z] --- PASS: TestAuthZPluginEnsureLoadImportWorking (2.17s)
22:03:33 [2019-10-15T22:03:33.209Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginEnsureLoadImportWorking"
22:03:33 [2019-10-15T22:03:33.209Z] === RUN   TestAuthzPluginEnsureContainerCopyToFrom
22:03:35 [2019-10-15T22:03:35.114Z] --- PASS: TestAuthzPluginEnsureContainerCopyToFrom (2.27s)
22:03:35 [2019-10-15T22:03:35.114Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthzPluginEnsureContainerCopyToFrom"
22:03:35 [2019-10-15T22:03:35.114Z] === RUN   TestAuthZPluginHeader
22:03:36 [2019-10-15T22:03:36.052Z] --- PASS: TestAuthZPluginHeader (0.90s)
22:03:36 [2019-10-15T22:03:36.052Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginHeader"
22:03:36 [2019-10-15T22:03:36.052Z] === RUN   TestAuthZPluginV2AllowNonVolumeRequest
22:03:36 [2019-10-15T22:03:36.052Z] --- SKIP: TestAuthZPluginV2AllowNonVolumeRequest (0.00s)
22:03:36 [2019-10-15T22:03:36.052Z]     authz_plugin_v2_test.go:43: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:03:36 [2019-10-15T22:03:36.052Z] === RUN   TestAuthZPluginV2Disable
22:03:36 [2019-10-15T22:03:36.052Z] --- SKIP: TestAuthZPluginV2Disable (0.00s)
22:03:36 [2019-10-15T22:03:36.052Z]     authz_plugin_v2_test.go:65: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:03:36 [2019-10-15T22:03:36.052Z] === RUN   TestAuthZPluginV2RejectVolumeRequests
22:03:36 [2019-10-15T22:03:36.052Z] --- SKIP: TestAuthZPluginV2RejectVolumeRequests (0.00s)
22:03:36 [2019-10-15T22:03:36.052Z]     authz_plugin_v2_test.go:91: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:03:36 [2019-10-15T22:03:36.052Z] === RUN   TestAuthZPluginV2BadManifestFailsDaemonStart
22:03:36 [2019-10-15T22:03:36.052Z] --- SKIP: TestAuthZPluginV2BadManifestFailsDaemonStart (0.00s)
22:03:36 [2019-10-15T22:03:36.052Z]     authz_plugin_v2_test.go:126: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:03:36 [2019-10-15T22:03:36.052Z] === RUN   TestAuthZPluginV2NonexistentFailsDaemonStart
22:03:54 [2019-10-15T22:03:54.151Z] --- PASS: TestAuthZPluginV2NonexistentFailsDaemonStart (17.90s)
22:03:54 [2019-10-15T22:03:54.151Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginV2NonexistentFailsDaemonStart"
22:03:54 [2019-10-15T22:03:54.151Z] PASS
22:03:54 [2019-10-15T22:03:54.151Z] 
22:03:54 [2019-10-15T22:03:54.151Z] === Skipped
22:03:54 [2019-10-15T22:03:54.151Z] === SKIP: arm64.integration.plugin.authz TestAuthZPluginV2AllowNonVolumeRequest (0.00s)
22:03:54 [2019-10-15T22:03:54.151Z]     authz_plugin_v2_test.go:43: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:03:54 [2019-10-15T22:03:54.151Z] 
22:03:54 [2019-10-15T22:03:54.151Z] === SKIP: arm64.integration.plugin.authz TestAuthZPluginV2Disable (0.00s)
22:03:54 [2019-10-15T22:03:54.151Z]     authz_plugin_v2_test.go:65: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:03:54 [2019-10-15T22:03:54.151Z] 
22:03:54 [2019-10-15T22:03:54.151Z] === SKIP: arm64.integration.plugin.authz TestAuthZPluginV2RejectVolumeRequests (0.00s)
22:03:54 [2019-10-15T22:03:54.151Z]     authz_plugin_v2_test.go:91: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:03:54 [2019-10-15T22:03:54.151Z] 
22:03:54 [2019-10-15T22:03:54.151Z] === SKIP: arm64.integration.plugin.authz TestAuthZPluginV2BadManifestFailsDaemonStart (0.00s)
22:03:54 [2019-10-15T22:03:54.151Z]     authz_plugin_v2_test.go:126: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:03:54 [2019-10-15T22:03:54.151Z] 
22:03:54 [2019-10-15T22:03:54.151Z] 
22:03:54 [2019-10-15T22:03:54.151Z] DONE 17 tests, 4 skipped in 30.880s
22:03:54 [2019-10-15T22:03:54.151Z] Running /go/src/github.com/docker/docker/integration/plugin/common (arm64.integration.plugin.common) flags=-test.v -test.timeout=120m 
22:03:54 [2019-10-15T22:03:54.151Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-plugin-common-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-plugin-common-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.plugin.common -t ./test.main -test.v -test.timeout=120m
22:03:54 [2019-10-15T22:03:54.151Z] ++ set -e
22:03:54 [2019-10-15T22:03:54.151Z] ++ '[' -n 0 ']'
22:03:54 [2019-10-15T22:03:54.151Z] ++ set -x
22:03:54 [2019-10-15T22:03:54.151Z] ++ 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=arm64 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/arm64-integration-plugin-common-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-plugin-common-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.plugin.common -t ./test.main -test.v -test.timeout=120m
22:03:54 [2019-10-15T22:03:54.151Z] INFO: Testing against a local daemon
22:03:54 [2019-10-15T22:03:54.151Z] === RUN   TestPluginInvalidJSON
22:03:54 [2019-10-15T22:03:54.151Z] === RUN   TestPluginInvalidJSON//plugins/foobar/set
22:03:54 [2019-10-15T22:03:54.151Z] === PAUSE TestPluginInvalidJSON//plugins/foobar/set
22:03:54 [2019-10-15T22:03:54.151Z] === CONT  TestPluginInvalidJSON//plugins/foobar/set
22:03:54 [2019-10-15T22:03:54.151Z] --- PASS: TestPluginInvalidJSON (0.03s)
22:03:54 [2019-10-15T22:03:54.151Z]     --- PASS: TestPluginInvalidJSON//plugins/foobar/set (0.00s)
22:03:54 [2019-10-15T22:03:54.151Z] PASS
22:03:54 [2019-10-15T22:03:54.151Z] 
22:03:54 [2019-10-15T22:03:54.151Z] DONE 2 tests in 0.173s
22:03:54 [2019-10-15T22:03:54.151Z] Running /go/src/github.com/docker/docker/integration/plugin/graphdriver (arm64.integration.plugin.graphdriver) flags=-test.v -test.timeout=120m 
22:03:54 [2019-10-15T22:03:54.151Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-plugin-graphdriver-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-plugin-graphdriver-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.plugin.graphdriver -t ./test.main -test.v -test.timeout=120m
22:03:54 [2019-10-15T22:03:54.151Z] ++ set -e
22:03:54 [2019-10-15T22:03:54.151Z] ++ '[' -n 0 ']'
22:03:54 [2019-10-15T22:03:54.151Z] ++ set -x
22:03:54 [2019-10-15T22:03:54.151Z] ++ 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=arm64 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/arm64-integration-plugin-graphdriver-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-plugin-graphdriver-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.plugin.graphdriver -t ./test.main -test.v -test.timeout=120m
22:03:54 [2019-10-15T22:03:54.151Z] INFO: Testing against a local daemon
22:03:54 [2019-10-15T22:03:54.151Z] === RUN   TestExternalGraphDriver
22:03:54 [2019-10-15T22:03:54.413Z] === RUN   TestExternalGraphDriver/json
22:03:56 [2019-10-15T22:03:56.954Z] === RUN   TestExternalGraphDriver/spec
22:03:59 [2019-10-15T22:03:59.488Z] === RUN   TestExternalGraphDriver/pull
22:04:02 [2019-10-15T22:04:02.023Z] --- PASS: TestExternalGraphDriver (7.50s)
22:04:02 [2019-10-15T22:04:02.023Z]     external_test.go:57: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestExternalGraphDriver"
22:04:02 [2019-10-15T22:04:02.023Z]     --- PASS: TestExternalGraphDriver/json (2.45s)
22:04:02 [2019-10-15T22:04:02.023Z]     --- PASS: TestExternalGraphDriver/spec (2.61s)
22:04:02 [2019-10-15T22:04:02.023Z]     --- PASS: TestExternalGraphDriver/pull (2.27s)
22:04:02 [2019-10-15T22:04:02.023Z] === RUN   TestGraphdriverPluginV2
22:04:02 [2019-10-15T22:04:02.023Z] --- SKIP: TestGraphdriverPluginV2 (0.09s)
22:04:02 [2019-10-15T22:04:02.023Z]     external_test.go:410: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:04:02 [2019-10-15T22:04:02.023Z] PASS
22:04:02 [2019-10-15T22:04:02.023Z] 
22:04:02 [2019-10-15T22:04:02.023Z] === Skipped
22:04:02 [2019-10-15T22:04:02.023Z] === SKIP: arm64.integration.plugin.graphdriver TestGraphdriverPluginV2 (0.09s)
22:04:02 [2019-10-15T22:04:02.023Z]     external_test.go:410: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:04:02 [2019-10-15T22:04:02.023Z] 
22:04:02 [2019-10-15T22:04:02.023Z] 
22:04:02 [2019-10-15T22:04:02.023Z] DONE 5 tests, 1 skipped in 7.760s
22:04:02 [2019-10-15T22:04:02.023Z] Running /go/src/github.com/docker/docker/integration/plugin/logging (arm64.integration.plugin.logging) flags=-test.v -test.timeout=120m 
22:04:02 [2019-10-15T22:04:02.023Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-plugin-logging-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-plugin-logging-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.plugin.logging -t ./test.main -test.v -test.timeout=120m
22:04:02 [2019-10-15T22:04:02.023Z] ++ set -e
22:04:02 [2019-10-15T22:04:02.023Z] ++ '[' -n 0 ']'
22:04:02 [2019-10-15T22:04:02.023Z] ++ set -x
22:04:02 [2019-10-15T22:04:02.023Z] ++ 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=arm64 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/arm64-integration-plugin-logging-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-plugin-logging-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.plugin.logging -t ./test.main -test.v -test.timeout=120m
22:04:02 [2019-10-15T22:04:02.023Z] INFO: Testing against a local daemon
22:04:02 [2019-10-15T22:04:02.023Z] === RUN   TestContinueAfterPluginCrash
22:04:02 [2019-10-15T22:04:02.023Z] === PAUSE TestContinueAfterPluginCrash
22:04:02 [2019-10-15T22:04:02.023Z] === RUN   TestDaemonStartWithLogOpt
22:04:02 [2019-10-15T22:04:02.023Z] === PAUSE TestDaemonStartWithLogOpt
22:04:02 [2019-10-15T22:04:02.023Z] === CONT  TestContinueAfterPluginCrash
22:04:02 [2019-10-15T22:04:02.023Z] === CONT  TestDaemonStartWithLogOpt
22:04:14 [2019-10-15T22:04:14.239Z] --- PASS: TestDaemonStartWithLogOpt (10.44s)
22:04:14 [2019-10-15T22:04:14.239Z]     validation_test.go:23: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonStartWithLogOpt"
22:04:17 [2019-10-15T22:04:17.524Z] --- PASS: TestContinueAfterPluginCrash (15.33s)
22:04:17 [2019-10-15T22:04:17.524Z]     logging_linux_test.go:22: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestContinueAfterPluginCrash"
22:04:17 [2019-10-15T22:04:17.524Z] PASS
22:04:17 [2019-10-15T22:04:17.524Z] 
22:04:17 [2019-10-15T22:04:17.524Z] DONE 2 tests in 15.582s
22:04:17 [2019-10-15T22:04:17.524Z] Running /go/src/github.com/docker/docker/integration/plugin/volumes (arm64.integration.plugin.volumes) flags=-test.v -test.timeout=120m 
22:04:17 [2019-10-15T22:04:17.524Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-plugin-volumes-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-plugin-volumes-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.plugin.volumes -t ./test.main -test.v -test.timeout=120m
22:04:17 [2019-10-15T22:04:17.524Z] ++ set -e
22:04:17 [2019-10-15T22:04:17.524Z] ++ '[' -n 0 ']'
22:04:17 [2019-10-15T22:04:17.524Z] ++ set -x
22:04:17 [2019-10-15T22:04:17.525Z] ++ 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=arm64 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/arm64-integration-plugin-volumes-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-plugin-volumes-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.plugin.volumes -t ./test.main -test.v -test.timeout=120m
22:04:17 [2019-10-15T22:04:17.525Z] INFO: Testing against a local daemon
22:04:17 [2019-10-15T22:04:17.525Z] === RUN   TestPluginWithDevMounts
22:04:17 [2019-10-15T22:04:17.525Z] === PAUSE TestPluginWithDevMounts
22:04:17 [2019-10-15T22:04:17.525Z] === CONT  TestPluginWithDevMounts
22:04:20 [2019-10-15T22:04:20.058Z] --- PASS: TestPluginWithDevMounts (2.24s)
22:04:20 [2019-10-15T22:04:20.058Z]     mounts_test.go:23: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestPluginWithDevMounts"
22:04:20 [2019-10-15T22:04:20.058Z] PASS
22:04:20 [2019-10-15T22:04:20.058Z] 
22:04:20 [2019-10-15T22:04:20.058Z] DONE 1 tests in 2.394s
22:04:20 [2019-10-15T22:04:20.058Z] Running /go/src/github.com/docker/docker/integration/secret (arm64.integration.secret) flags=-test.v -test.timeout=120m 
22:04:20 [2019-10-15T22:04:20.058Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-secret-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-secret-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.secret -t ./test.main -test.v -test.timeout=120m
22:04:20 [2019-10-15T22:04:20.058Z] ++ set -e
22:04:20 [2019-10-15T22:04:20.058Z] ++ '[' -n 0 ']'
22:04:20 [2019-10-15T22:04:20.058Z] ++ set -x
22:04:20 [2019-10-15T22:04:20.058Z] ++ 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=arm64 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/arm64-integration-secret-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-secret-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.secret -t ./test.main -test.v -test.timeout=120m
22:04:20 [2019-10-15T22:04:20.058Z] INFO: Testing against a local daemon
22:04:20 [2019-10-15T22:04:20.058Z] === RUN   TestSecretInspect
22:04:23 [2019-10-15T22:04:23.462Z] --- PASS: TestSecretInspect (3.22s)
22:04:23 [2019-10-15T22:04:23.462Z]     secret_test.go:25: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestSecretInspect"
22:04:23 [2019-10-15T22:04:23.462Z] === RUN   TestSecretList
22:04:26 [2019-10-15T22:04:26.751Z] --- PASS: TestSecretList (3.12s)
22:04:26 [2019-10-15T22:04:26.751Z]     secret_test.go:48: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestSecretList"
22:04:26 [2019-10-15T22:04:26.751Z] === RUN   TestSecretsCreateAndDelete
22:04:30 [2019-10-15T22:04:30.038Z] --- PASS: TestSecretsCreateAndDelete (3.20s)
22:04:30 [2019-10-15T22:04:30.038Z]     secret_test.go:125: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestSecretsCreateAndDelete"
22:04:30 [2019-10-15T22:04:30.038Z] === RUN   TestSecretsUpdate
22:04:33 [2019-10-15T22:04:33.325Z] --- PASS: TestSecretsUpdate (3.21s)
22:04:33 [2019-10-15T22:04:33.325Z]     secret_test.go:172: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestSecretsUpdate"
22:04:33 [2019-10-15T22:04:33.325Z] === RUN   TestTemplatedSecret
22:04:36 [2019-10-15T22:04:36.612Z] --- PASS: TestTemplatedSecret (3.55s)
22:04:36 [2019-10-15T22:04:36.612Z]     secret_test.go:221: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestTemplatedSecret"
22:04:36 [2019-10-15T22:04:36.612Z] === RUN   TestSecretCreateResolve
22:04:39 [2019-10-15T22:04:39.898Z] --- PASS: TestSecretCreateResolve (3.19s)
22:04:39 [2019-10-15T22:04:39.899Z]     secret_test.go:342: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestSecretCreateResolve"
22:04:39 [2019-10-15T22:04:39.899Z] PASS
22:04:39 [2019-10-15T22:04:39.899Z] 
22:04:39 [2019-10-15T22:04:39.899Z] DONE 6 tests in 19.635s
22:04:39 [2019-10-15T22:04:39.899Z] Running /go/src/github.com/docker/docker/integration/service (arm64.integration.service) flags=-test.v -test.timeout=120m 
22:04:39 [2019-10-15T22:04:39.899Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-service-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-service-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.service -t ./test.main -test.v -test.timeout=120m
22:04:39 [2019-10-15T22:04:39.899Z] ++ set -e
22:04:39 [2019-10-15T22:04:39.899Z] ++ '[' -n 0 ']'
22:04:39 [2019-10-15T22:04:39.899Z] ++ set -x
22:04:39 [2019-10-15T22:04:39.899Z] ++ 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=arm64 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/arm64-integration-service-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-service-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.service -t ./test.main -test.v -test.timeout=120m
22:04:39 [2019-10-15T22:04:39.899Z] INFO: Testing against a local daemon
22:04:39 [2019-10-15T22:04:39.899Z] === RUN   TestServiceCreateInit
22:04:39 [2019-10-15T22:04:39.899Z] === RUN   TestServiceCreateInit/daemonInitDisabled
22:04:45 [2019-10-15T22:04:45.168Z] === RUN   TestServiceCreateInit/daemonInitEnabled
22:04:50 [2019-10-15T22:04:50.437Z] --- PASS: TestServiceCreateInit (10.41s)
22:04:50 [2019-10-15T22:04:50.437Z]     --- PASS: TestServiceCreateInit/daemonInitDisabled (5.12s)
22:04:50 [2019-10-15T22:04:50.437Z]         create_test.go:38: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceCreateInit/daemonInitDisabled"
22:04:50 [2019-10-15T22:04:50.437Z]     --- PASS: TestServiceCreateInit/daemonInitEnabled (5.26s)
22:04:50 [2019-10-15T22:04:50.437Z]         create_test.go:38: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceCreateInit/daemonInitEnabled"
22:04:50 [2019-10-15T22:04:50.437Z] === RUN   TestCreateServiceMultipleTimes
22:05:16 [2019-10-15T22:05:16.984Z] --- PASS: TestCreateServiceMultipleTimes (23.17s)
22:05:16 [2019-10-15T22:05:16.984Z]     create_test.go:80: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceMultipleTimes"
22:05:16 [2019-10-15T22:05:16.984Z] === RUN   TestCreateServiceConflict
22:05:16 [2019-10-15T22:05:16.984Z] --- PASS: TestCreateServiceConflict (3.12s)
22:05:16 [2019-10-15T22:05:16.984Z]     create_test.go:129: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceConflict"
22:05:16 [2019-10-15T22:05:16.984Z] === RUN   TestCreateServiceMaxReplicas
22:05:20 [2019-10-15T22:05:20.270Z] --- PASS: TestCreateServiceMaxReplicas (3.68s)
22:05:20 [2019-10-15T22:05:20.270Z]     create_test.go:150: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceMaxReplicas"
22:05:20 [2019-10-15T22:05:20.270Z] === RUN   TestCreateWithDuplicateNetworkNames
22:05:38 [2019-10-15T22:05:38.354Z] --- PASS: TestCreateWithDuplicateNetworkNames (15.70s)
22:05:38 [2019-10-15T22:05:38.355Z]     create_test.go:171: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateWithDuplicateNetworkNames"
22:05:38 [2019-10-15T22:05:38.355Z] === RUN   TestCreateServiceSecretFileMode
22:05:39 [2019-10-15T22:05:39.290Z] --- PASS: TestCreateServiceSecretFileMode (3.44s)
22:05:39 [2019-10-15T22:05:39.290Z]     create_test.go:224: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceSecretFileMode"
22:05:39 [2019-10-15T22:05:39.290Z] === RUN   TestCreateServiceConfigFileMode
22:05:42 [2019-10-15T22:05:42.577Z] --- PASS: TestCreateServiceConfigFileMode (3.31s)
22:05:42 [2019-10-15T22:05:42.578Z]     create_test.go:288: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceConfigFileMode"
22:05:42 [2019-10-15T22:05:42.578Z] === RUN   TestCreateServiceSysctls
22:05:47 [2019-10-15T22:05:47.849Z] --- PASS: TestCreateServiceSysctls (4.40s)
22:05:47 [2019-10-15T22:05:47.849Z]     create_test.go:378: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceSysctls"
22:05:47 [2019-10-15T22:05:47.849Z] === RUN   TestCreateServiceCapabilities
22:05:50 [2019-10-15T22:05:50.382Z] --- PASS: TestCreateServiceCapabilities (3.40s)
22:05:50 [2019-10-15T22:05:50.383Z]     create_test.go:462: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceCapabilities"
22:05:50 [2019-10-15T22:05:50.383Z] === RUN   TestInspect
22:05:54 [2019-10-15T22:05:54.571Z] --- PASS: TestInspect (3.51s)
22:05:54 [2019-10-15T22:05:54.571Z]     inspect_test.go:23: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestInspect"
22:05:54 [2019-10-15T22:05:54.571Z] === RUN   TestServiceListWithStatuses
22:05:54 [2019-10-15T22:05:54.571Z] --- SKIP: TestServiceListWithStatuses (0.00s)
22:05:54 [2019-10-15T22:05:54.571Z]     list_test.go:34: versions.LessThan(testEnv.DaemonInfo.ServerVersion, "1.41")
22:05:54 [2019-10-15T22:05:54.571Z] === RUN   TestDockerNetworkConnectAlias
22:06:01 [2019-10-15T22:06:01.135Z] --- PASS: TestDockerNetworkConnectAlias (7.23s)
22:06:01 [2019-10-15T22:06:01.135Z]     network_test.go:20: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkConnectAlias"
22:06:01 [2019-10-15T22:06:01.135Z] === RUN   TestDockerNetworkReConnect
22:06:07 [2019-10-15T22:06:07.700Z] --- PASS: TestDockerNetworkReConnect (5.94s)
22:06:07 [2019-10-15T22:06:07.700Z]     network_test.go:82: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkReConnect"
22:06:07 [2019-10-15T22:06:07.700Z] === RUN   TestServicePlugin
22:06:07 [2019-10-15T22:06:07.700Z] --- SKIP: TestServicePlugin (0.00s)
22:06:07 [2019-10-15T22:06:07.700Z]     plugin_test.go:28: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:06:07 [2019-10-15T22:06:07.700Z] === RUN   TestServiceUpdateLabel
22:06:10 [2019-10-15T22:06:10.232Z] --- PASS: TestServiceUpdateLabel (3.14s)
22:06:10 [2019-10-15T22:06:10.232Z]     update_test.go:21: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateLabel"
22:06:10 [2019-10-15T22:06:10.232Z] === RUN   TestServiceUpdateSecrets
22:06:28 [2019-10-15T22:06:28.314Z] --- PASS: TestServiceUpdateSecrets (15.46s)
22:06:28 [2019-10-15T22:06:28.314Z]     update_test.go:77: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateSecrets"
22:06:28 [2019-10-15T22:06:28.314Z] === RUN   TestServiceUpdateConfigs
22:06:43 [2019-10-15T22:06:43.190Z] --- PASS: TestServiceUpdateConfigs (15.60s)
22:06:43 [2019-10-15T22:06:43.190Z]     update_test.go:139: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateConfigs"
22:06:43 [2019-10-15T22:06:43.190Z] === RUN   TestServiceUpdateNetwork
22:06:58 [2019-10-15T22:06:58.067Z] --- PASS: TestServiceUpdateNetwork (15.60s)
22:06:58 [2019-10-15T22:06:58.068Z]     update_test.go:201: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateNetwork"
22:06:58 [2019-10-15T22:06:58.068Z] PASS
22:06:58 [2019-10-15T22:06:58.068Z] 
22:06:58 [2019-10-15T22:06:58.068Z] === Skipped
22:06:58 [2019-10-15T22:06:58.068Z] === SKIP: arm64.integration.service TestServiceListWithStatuses (0.00s)
22:06:58 [2019-10-15T22:06:58.068Z]     list_test.go:34: versions.LessThan(testEnv.DaemonInfo.ServerVersion, "1.41")
22:06:58 [2019-10-15T22:06:58.068Z] 
22:06:58 [2019-10-15T22:06:58.068Z] === SKIP: arm64.integration.service TestServicePlugin (0.00s)
22:06:58 [2019-10-15T22:06:58.068Z]     plugin_test.go:28: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:06:58 [2019-10-15T22:06:58.068Z] 
22:06:58 [2019-10-15T22:06:58.068Z] 
22:06:58 [2019-10-15T22:06:58.068Z] DONE 20 tests, 2 skipped in 137.278s
22:06:58 [2019-10-15T22:06:58.068Z] Running /go/src/github.com/docker/docker/integration/session (arm64.integration.session) flags=-test.v -test.timeout=120m 
22:06:58 [2019-10-15T22:06:58.068Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-session-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-session-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.session -t ./test.main -test.v -test.timeout=120m
22:06:58 [2019-10-15T22:06:58.068Z] ++ set -e
22:06:58 [2019-10-15T22:06:58.068Z] ++ '[' -n 0 ']'
22:06:58 [2019-10-15T22:06:58.068Z] ++ set -x
22:06:58 [2019-10-15T22:06:58.068Z] ++ 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=arm64 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/arm64-integration-session-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-session-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.session -t ./test.main -test.v -test.timeout=120m
22:06:58 [2019-10-15T22:06:58.068Z] INFO: Testing against a local daemon
22:06:58 [2019-10-15T22:06:58.068Z] === RUN   TestSessionCreate
22:06:58 [2019-10-15T22:06:58.068Z] --- PASS: TestSessionCreate (0.05s)
22:06:58 [2019-10-15T22:06:58.068Z] === RUN   TestSessionCreateWithBadUpgrade
22:06:58 [2019-10-15T22:06:58.068Z] --- PASS: TestSessionCreateWithBadUpgrade (0.05s)
22:06:58 [2019-10-15T22:06:58.068Z] PASS
22:06:58 [2019-10-15T22:06:58.068Z] 
22:06:58 [2019-10-15T22:06:58.068Z] DONE 2 tests in 0.242s
22:06:58 [2019-10-15T22:06:58.068Z] Running /go/src/github.com/docker/docker/integration/system (arm64.integration.system) flags=-test.v -test.timeout=120m 
22:06:58 [2019-10-15T22:06:58.068Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-system-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-system-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.system -t ./test.main -test.v -test.timeout=120m
22:06:58 [2019-10-15T22:06:58.068Z] ++ set -e
22:06:58 [2019-10-15T22:06:58.068Z] ++ '[' -n 0 ']'
22:06:58 [2019-10-15T22:06:58.068Z] ++ set -x
22:06:58 [2019-10-15T22:06:58.068Z] ++ 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=arm64 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/arm64-integration-system-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-system-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.system -t ./test.main -test.v -test.timeout=120m
22:06:58 [2019-10-15T22:06:58.068Z] INFO: Testing against a local daemon
22:06:58 [2019-10-15T22:06:58.068Z] === RUN   TestCgroupDriverSystemdMemoryLimit
22:06:58 [2019-10-15T22:06:58.068Z] --- SKIP: TestCgroupDriverSystemdMemoryLimit (0.00s)
22:06:58 [2019-10-15T22:06:58.068Z]     cgroupdriver_systemd_test.go:32: !hasSystemd()
22:06:58 [2019-10-15T22:06:58.068Z] === RUN   TestEventsExecDie
22:06:58 [2019-10-15T22:06:58.326Z] --- PASS: TestEventsExecDie (1.02s)
22:06:58 [2019-10-15T22:06:58.326Z] === RUN   TestEventsBackwardsCompatible
22:06:58 [2019-10-15T22:06:58.326Z] --- PASS: TestEventsBackwardsCompatible (0.12s)
22:06:58 [2019-10-15T22:06:58.326Z] === RUN   TestInfoBinaryCommits
22:06:58 [2019-10-15T22:06:58.326Z] --- PASS: TestInfoBinaryCommits (0.05s)
22:06:58 [2019-10-15T22:06:58.326Z] === RUN   TestInfoAPIVersioned
22:06:58 [2019-10-15T22:06:58.585Z] --- PASS: TestInfoAPIVersioned (0.02s)
22:06:58 [2019-10-15T22:06:58.585Z] === RUN   TestInfoAPI
22:06:58 [2019-10-15T22:06:58.585Z] --- PASS: TestInfoAPI (0.05s)
22:06:58 [2019-10-15T22:06:58.585Z] === RUN   TestInfoAPIWarnings
22:06:59 [2019-10-15T22:06:59.522Z] --- PASS: TestInfoAPIWarnings (0.88s)
22:06:59 [2019-10-15T22:06:59.522Z]     info_test.go:49: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestInfoAPIWarnings"
22:06:59 [2019-10-15T22:06:59.522Z] === RUN   TestLoginFailsWithBadCredentials
22:06:59 [2019-10-15T22:06:59.781Z] --- PASS: TestLoginFailsWithBadCredentials (0.39s)
22:06:59 [2019-10-15T22:06:59.781Z] === RUN   TestPingCacheHeaders
22:06:59 [2019-10-15T22:06:59.781Z] --- PASS: TestPingCacheHeaders (0.05s)
22:06:59 [2019-10-15T22:06:59.781Z] === RUN   TestPingGet
22:06:59 [2019-10-15T22:06:59.781Z] --- PASS: TestPingGet (0.03s)
22:06:59 [2019-10-15T22:06:59.781Z] === RUN   TestPingHead
22:06:59 [2019-10-15T22:06:59.781Z] --- PASS: TestPingHead (0.05s)
22:06:59 [2019-10-15T22:06:59.781Z] === RUN   TestVersion
22:07:00 [2019-10-15T22:07:00.040Z] --- PASS: TestVersion (0.05s)
22:07:00 [2019-10-15T22:07:00.040Z] PASS
22:07:00 [2019-10-15T22:07:00.040Z] 
22:07:00 [2019-10-15T22:07:00.040Z] === Skipped
22:07:00 [2019-10-15T22:07:00.040Z] === SKIP: arm64.integration.system TestCgroupDriverSystemdMemoryLimit (0.00s)
22:07:00 [2019-10-15T22:07:00.040Z]     cgroupdriver_systemd_test.go:32: !hasSystemd()
22:07:00 [2019-10-15T22:07:00.040Z] 
22:07:00 [2019-10-15T22:07:00.040Z] 
22:07:00 [2019-10-15T22:07:00.040Z] DONE 12 tests, 1 skipped in 2.851s
22:07:00 [2019-10-15T22:07:00.040Z] Running /go/src/github.com/docker/docker/integration/volume (arm64.integration.volume) flags=-test.v -test.timeout=120m 
22:07:00 [2019-10-15T22:07:00.040Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-volume-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-volume-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.volume -t ./test.main -test.v -test.timeout=120m
22:07:00 [2019-10-15T22:07:00.040Z] ++ set -e
22:07:00 [2019-10-15T22:07:00.040Z] ++ '[' -n 0 ']'
22:07:00 [2019-10-15T22:07:00.040Z] ++ set -x
22:07:00 [2019-10-15T22:07:00.040Z] ++ 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=arm64 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/arm64-integration-volume-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-volume-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.volume -t ./test.main -test.v -test.timeout=120m
22:07:00 [2019-10-15T22:07:00.040Z] INFO: Testing against a local daemon
22:07:00 [2019-10-15T22:07:00.040Z] === RUN   TestVolumesCreateAndList
22:07:00 [2019-10-15T22:07:00.040Z] --- PASS: TestVolumesCreateAndList (0.04s)
22:07:00 [2019-10-15T22:07:00.040Z] === RUN   TestVolumesRemove
22:07:00 [2019-10-15T22:07:00.298Z] --- PASS: TestVolumesRemove (0.13s)
22:07:00 [2019-10-15T22:07:00.298Z] === RUN   TestVolumesInspect
22:07:00 [2019-10-15T22:07:00.298Z] --- PASS: TestVolumesInspect (0.04s)
22:07:00 [2019-10-15T22:07:00.298Z] === RUN   TestVolumesInvalidJSON
22:07:00 [2019-10-15T22:07:00.298Z] === RUN   TestVolumesInvalidJSON//volumes/create
22:07:00 [2019-10-15T22:07:00.298Z] === PAUSE TestVolumesInvalidJSON//volumes/create
22:07:00 [2019-10-15T22:07:00.298Z] === CONT  TestVolumesInvalidJSON//volumes/create
22:07:00 [2019-10-15T22:07:00.298Z] --- PASS: TestVolumesInvalidJSON (0.03s)
22:07:00 [2019-10-15T22:07:00.298Z]     --- PASS: TestVolumesInvalidJSON//volumes/create (0.00s)
22:07:00 [2019-10-15T22:07:00.298Z] PASS
22:07:00 [2019-10-15T22:07:00.298Z] 
22:07:00 [2019-10-15T22:07:00.298Z] DONE 5 tests in 0.390s
22:07:00 [2019-10-15T22:07:00.298Z] ---> Making bundle: .integration-daemon-stop (in bundles/test-integration)
22:07:00 [2019-10-15T22:07:00.865Z] ++++ cat bundles/test-integration/docker.pid
22:07:00 [2019-10-15T22:07:00.865Z] +++ kill 12997
22:07:02 [2019-10-15T22:07:02.241Z] +++ /etc/init.d/apparmor stop
22:07:02 [2019-10-15T22:07:02.241Z] Clearing AppArmor profiles cache:.
22:07:02 [2019-10-15T22:07:02.241Z] All profile caches have been cleared, but no profiles have been unloaded.
22:07:02 [2019-10-15T22:07:02.241Z] Unloading profiles will leave already running processes permanently
22:07:02 [2019-10-15T22:07:02.241Z] unconfined, which can lead to unexpected situations.
22:07:02 [2019-10-15T22:07:02.241Z] 
22:07:02 [2019-10-15T22:07:02.241Z] To set a process to complain mode, use the command line tool
22:07:02 [2019-10-15T22:07:02.241Z] 'aa-complain'. To really tear down all profiles, run the init script
22:07:02 [2019-10-15T22:07:02.241Z] with the 'teardown' option."
22:07:02 [2019-10-15T22:07:02.241Z]