Console Output

15:48:50 [2019-10-22T15:48:50.358Z] + docker run --rm -t --privileged -v /home/ubuntu/workspace/moby_PR-38401/bundles:/go/src/github.com/docker/docker/bundles --name docker-pr2 -e DOCKER_EXPERIMENTAL -e DOCKER_GITCOMMIT=73a7c369c6abce6117045332cd011c21db003cda -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:73a7c369c6abce6117045332cd011c21db003cda hack/make.sh dynbinary test-integration
15:48:51 [2019-10-22T15:48:51.294Z] 
15:48:51 [2019-10-22T15:48:51.294Z] Removing bundles/
15:48:51 [2019-10-22T15:48:51.294Z] 
15:48:51 [2019-10-22T15:48:51.294Z] ---> Making bundle: dynbinary (in bundles/dynbinary)
15:48:51 [2019-10-22T15:48:51.294Z] Building: bundles/dynbinary-daemon/dockerd-dev
15:48:51 [2019-10-22T15:48:51.294Z] GOOS="" GOARCH="" GOARM=""
15:49:59 [2019-10-22T15:49:59.009Z] Created binary: bundles/dynbinary-daemon/dockerd-dev
15:49:59 [2019-10-22T15:49:59.009Z] 
15:49:59 [2019-10-22T15:49:59.009Z] ---> Making bundle: test-integration (in bundles/test-integration)
15:49:59 [2019-10-22T15:49:59.009Z] PKG_CONFIG=pkg-config
15:49:59 [2019-10-22T15:49:59.009Z] GOLANG_VERSION=1.13.3
15:49:59 [2019-10-22T15:49:59.009Z] HOSTNAME=88d12badd461
15:49:59 [2019-10-22T15:49:59.009Z] DOCKER_EXPERIMENTAL=1
15:49:59 [2019-10-22T15:49:59.009Z] container=docker
15:49:59 [2019-10-22T15:49:59.009Z] TEST_SKIP_INTEGRATION_CLI=1
15:49:59 [2019-10-22T15:49:59.009Z] GO111MODULE=off
15:49:59 [2019-10-22T15:49:59.009Z] GOPATH=/go
15:49:59 [2019-10-22T15:49:59.009Z] PWD=/go/src/github.com/docker/docker
15:49:59 [2019-10-22T15:49:59.009Z] HOME=/root
15:49:59 [2019-10-22T15:49:59.009Z] VALIDATE_REPO=https://github.com/moby/moby.git
15:49:59 [2019-10-22T15:49:59.009Z] SCRIPTDIR=/go/src/github.com/docker/docker/hack
15:49:59 [2019-10-22T15:49:59.009Z] MAKEDIR=/go/src/github.com/docker/docker/hack/make
15:49:59 [2019-10-22T15:49:59.009Z] DOCKER_GITCOMMIT=73a7c369c6abce6117045332cd011c21db003cda
15:49:59 [2019-10-22T15:49:59.009Z] DOCKER_BUILDTAGS=apparmor seccomp selinux journald
15:49:59 [2019-10-22T15:49:59.009Z] DOCKER_GRAPHDRIVER=overlay2
15:49:59 [2019-10-22T15:49:59.009Z] TERM=xterm
15:49:59 [2019-10-22T15:49:59.009Z] VALIDATE_BRANCH=master
15:49:59 [2019-10-22T15:49:59.009Z] DEST=bundles/test-integration
15:49:59 [2019-10-22T15:49:59.009Z] SHLVL=1
15:49:59 [2019-10-22T15:49:59.009Z] TIMEOUT=120m
15:49:59 [2019-10-22T15:49:59.009Z] PATH=/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
15:49:59 [2019-10-22T15:49:59.009Z] DOCKER_PKG=github.com/docker/docker
15:49:59 [2019-10-22T15:49:59.009Z] TESTDEBUG=0
15:49:59 [2019-10-22T15:49:59.009Z] _=/usr/bin/env
15:49:59 [2019-10-22T15:49:59.009Z] Building test suite binary /go/src/github.com/docker/docker/integration/build/test.main
15:50:25 [2019-10-22T15:50:25.573Z] Building test suite binary /go/src/github.com/docker/docker/integration/config/test.main
15:50:25 [2019-10-22T15:50:25.573Z] Building test suite binary /go/src/github.com/docker/docker/integration/container/test.main
15:50:28 [2019-10-22T15:50:28.109Z] Building test suite binary /go/src/github.com/docker/docker/integration/image/test.main
15:50:46 [2019-10-22T15:50:46.212Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/test.main
15:50:47 [2019-10-22T15:50:47.149Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/ipvlan/test.main
15:50:48 [2019-10-22T15:50:48.528Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/macvlan/test.main
15:50:49 [2019-10-22T15:50:49.465Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/test.main
15:50:50 [2019-10-22T15:50:50.033Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/authz/test.main
15:50:51 [2019-10-22T15:50:51.938Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/common/test.main
15:50:53 [2019-10-22T15:50:53.316Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/graphdriver/test.main
15:50:55 [2019-10-22T15:50:55.220Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/logging/test.main
15:50:58 [2019-10-22T15:50:58.509Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/volumes/test.main
15:51:00 [2019-10-22T15:51:00.414Z] Building test suite binary /go/src/github.com/docker/docker/integration/secret/test.main
15:51:01 [2019-10-22T15:51:01.352Z] Building test suite binary /go/src/github.com/docker/docker/integration/service/test.main
15:51:03 [2019-10-22T15:51:03.888Z] Building test suite binary /go/src/github.com/docker/docker/integration/session/test.main
15:51:05 [2019-10-22T15:51:05.266Z] Building test suite binary /go/src/github.com/docker/docker/integration/system/test.main
15:51:06 [2019-10-22T15:51:06.645Z] Building test suite binary /go/src/github.com/docker/docker/integration/volume/test.main
15:51:08 [2019-10-22T15:51:08.024Z] ---> Making bundle: .integration-daemon-start (in bundles/test-integration)
15:51:08 [2019-10-22T15:51:08.024Z] Using test binary docker
15:51:08 [2019-10-22T15:51:08.024Z] # DOCKER_EXPERIMENTAL is set: starting daemon with experimental features enabled! 
15:51:08 [2019-10-22T15:51:08.024Z] +++ /etc/init.d/apparmor start
15:51:08 [2019-10-22T15:51:08.024Z] /etc/init.d/apparmor: 130: /etc/init.d/apparmor: systemd-detect-virt: not found
15:51:08 [2019-10-22T15:51:08.024Z] Starting AppArmor profiles:Warning from stdin (line 1): /sbin/apparmor_parser: cannot use or update cache, disable, or force-complain via stdin
15:51:08 [2019-10-22T15:51:08.024Z] Warning failed to create cache: (null)
15:51:08 [2019-10-22T15:51:08.024Z] .
15:51:08 [2019-10-22T15:51:08.024Z] INFO: Waiting for daemon to start...
15:51:08 [2019-10-22T15:51:08.024Z] Starting dockerd
15:51:08 [2019-10-22T15:51:08.024Z] +++ 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
15:51:14 [2019-10-22T15:51:14.587Z] .
15:51:14 [2019-10-22T15:51:14.588Z] ---> Making bundle: .integration-daemon-setup (in bundles/test-integration)
15:51:14 [2019-10-22T15:51:14.588Z] ---> Making bundle: .ensure-emptyfs (in bundles/test-integration)
15:51:14 [2019-10-22T15:51:14.588Z] Error: No such image: emptyfs
15:51:14 [2019-10-22T15:51:14.588Z] ++++ tar -cC bundles/test-integration/emptyfs .
15:51:14 [2019-10-22T15:51:14.588Z] ++++ docker load
15:51:14 [2019-10-22T15:51:14.588Z] Running integration-test (iteration 1)
15:51:14 [2019-10-22T15:51:14.588Z] Running /go/src/github.com/docker/docker/integration/build (arm64.integration.build) flags=-test.v -test.timeout=120m 
15:51:14 [2019-10-22T15:51:14.588Z] ++ 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
15:51:14 [2019-10-22T15:51:14.588Z] ++ set -e
15:51:14 [2019-10-22T15:51:14.588Z] ++ '[' -n 0 ']'
15:51:14 [2019-10-22T15:51:14.588Z] ++ set -x
15:51:14 [2019-10-22T15:51:14.588Z] ++ 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
15:51:24 [2019-10-22T15:51:24.568Z] Loaded image: buildpack-deps:jessie
15:51:24 [2019-10-22T15:51:24.568Z] Loaded image: busybox:latest
15:51:24 [2019-10-22T15:51:24.568Z] Loaded image: busybox:glibc
15:51:24 [2019-10-22T15:51:24.568Z] Loaded image: debian:jessie
15:51:24 [2019-10-22T15:51:24.568Z] Loaded image: hello-world:latest
15:51:24 [2019-10-22T15:51:24.568Z] INFO: Testing against a local daemon
15:51:24 [2019-10-22T15:51:24.568Z] === RUN   TestCgroupNamespacesBuild
15:51:27 [2019-10-22T15:51:27.854Z] --- PASS: TestCgroupNamespacesBuild (4.26s)
15:51:27 [2019-10-22T15:51:27.854Z]     build_cgroupns_linux_test.go:42: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesBuild"
15:51:27 [2019-10-22T15:51:27.854Z] === RUN   TestCgroupNamespacesBuildDaemonHostMode
15:51:29 [2019-10-22T15:51:29.756Z] --- PASS: TestCgroupNamespacesBuildDaemonHostMode (1.86s)
15:51:29 [2019-10-22T15:51:29.756Z]     build_cgroupns_linux_test.go:42: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesBuildDaemonHostMode"
15:51:29 [2019-10-22T15:51:29.756Z] === RUN   TestBuildWithSession
15:51:29 [2019-10-22T15:51:29.756Z] --- SKIP: TestBuildWithSession (0.00s)
15:51:29 [2019-10-22T15:51:29.756Z]     build_session_test.go:25: TODO: BuildKit
15:51:29 [2019-10-22T15:51:29.756Z] === RUN   TestBuildSquashParent
15:51:36 [2019-10-22T15:51:36.321Z] --- PASS: TestBuildSquashParent (6.27s)
15:51:36 [2019-10-22T15:51:36.321Z] === RUN   TestBuildWithRemoveAndForceRemove
15:51:36 [2019-10-22T15:51:36.321Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
15:51:36 [2019-10-22T15:51:36.321Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
15:51:36 [2019-10-22T15:51:36.321Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_remove
15:51:36 [2019-10-22T15:51:36.321Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_remove
15:51:36 [2019-10-22T15:51:36.321Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
15:51:36 [2019-10-22T15:51:36.321Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
15:51:36 [2019-10-22T15:51:36.321Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
15:51:36 [2019-10-22T15:51:36.321Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
15:51:36 [2019-10-22T15:51:36.321Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_remove
15:51:36 [2019-10-22T15:51:36.321Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_remove
15:51:36 [2019-10-22T15:51:36.321Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
15:51:36 [2019-10-22T15:51:36.321Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
15:51:36 [2019-10-22T15:51:36.321Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
15:51:36 [2019-10-22T15:51:36.321Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
15:51:36 [2019-10-22T15:51:36.321Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
15:51:36 [2019-10-22T15:51:36.321Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_remove
15:51:38 [2019-10-22T15:51:38.860Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
15:51:38 [2019-10-22T15:51:38.860Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_remove
15:51:41 [2019-10-22T15:51:41.391Z] --- PASS: TestBuildWithRemoveAndForceRemove (0.02s)
15:51:41 [2019-10-22T15:51:41.391Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal (2.72s)
15:51:41 [2019-10-22T15:51:41.391Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_remove (2.90s)
15:51:41 [2019-10-22T15:51:41.391Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove (3.02s)
15:51:41 [2019-10-22T15:51:41.391Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal (3.07s)
15:51:41 [2019-10-22T15:51:41.391Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_remove (2.20s)
15:51:41 [2019-10-22T15:51:41.391Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove (2.51s)
15:51:41 [2019-10-22T15:51:41.391Z] === RUN   TestBuildMultiStageCopy
15:51:41 [2019-10-22T15:51:41.391Z] === RUN   TestBuildMultiStageCopy/copy_to_root
15:51:43 [2019-10-22T15:51:43.924Z] === RUN   TestBuildMultiStageCopy/copy_to_newdir
15:51:44 [2019-10-22T15:51:44.183Z] === RUN   TestBuildMultiStageCopy/copy_to_newdir_nested
15:51:44 [2019-10-22T15:51:44.442Z] === RUN   TestBuildMultiStageCopy/copy_to_existingdir
15:51:45 [2019-10-22T15:51:45.010Z] === RUN   TestBuildMultiStageCopy/copy_to_newsubdir
15:51:45 [2019-10-22T15:51:45.577Z] --- PASS: TestBuildMultiStageCopy (4.30s)
15:51:45 [2019-10-22T15:51:45.577Z]     --- PASS: TestBuildMultiStageCopy/copy_to_root (2.29s)
15:51:45 [2019-10-22T15:51:45.577Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newdir (0.47s)
15:51:45 [2019-10-22T15:51:45.577Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newdir_nested (0.48s)
15:51:45 [2019-10-22T15:51:45.577Z]     --- PASS: TestBuildMultiStageCopy/copy_to_existingdir (0.50s)
15:51:45 [2019-10-22T15:51:45.577Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newsubdir (0.55s)
15:51:45 [2019-10-22T15:51:45.577Z] === RUN   TestBuildMultiStageParentConfig
15:51:46 [2019-10-22T15:51:46.953Z] --- PASS: TestBuildMultiStageParentConfig (1.44s)
15:51:46 [2019-10-22T15:51:46.953Z] === RUN   TestBuildLabelWithTargets
15:51:49 [2019-10-22T15:51:49.486Z] --- PASS: TestBuildLabelWithTargets (2.30s)
15:51:49 [2019-10-22T15:51:49.486Z] === RUN   TestBuildWithEmptyLayers
15:51:50 [2019-10-22T15:51:50.422Z] --- PASS: TestBuildWithEmptyLayers (1.01s)
15:51:50 [2019-10-22T15:51:50.422Z] === RUN   TestBuildMultiStageOnBuild
15:51:53 [2019-10-22T15:51:53.709Z] --- PASS: TestBuildMultiStageOnBuild (2.94s)
15:51:53 [2019-10-22T15:51:53.710Z] === RUN   TestBuildUncleanTarFilenames
15:51:54 [2019-10-22T15:51:54.646Z] --- PASS: TestBuildUncleanTarFilenames (1.32s)
15:51:54 [2019-10-22T15:51:54.646Z] === RUN   TestBuildMultiStageLayerLeak
15:51:57 [2019-10-22T15:51:57.933Z] --- PASS: TestBuildMultiStageLayerLeak (2.95s)
15:51:57 [2019-10-22T15:51:57.933Z] === RUN   TestBuildWithHugeFile
15:52:44 [2019-10-22T15:52:44.682Z] --- PASS: TestBuildWithHugeFile (42.31s)
15:52:44 [2019-10-22T15:52:44.682Z] === RUN   TestBuildWithEmptyDockerfile
15:52:44 [2019-10-22T15:52:44.682Z] === RUN   TestBuildWithEmptyDockerfile/empty-dockerfile
15:52:44 [2019-10-22T15:52:44.682Z] === PAUSE TestBuildWithEmptyDockerfile/empty-dockerfile
15:52:44 [2019-10-22T15:52:44.682Z] === RUN   TestBuildWithEmptyDockerfile/empty-lines-dockerfile
15:52:44 [2019-10-22T15:52:44.682Z] === PAUSE TestBuildWithEmptyDockerfile/empty-lines-dockerfile
15:52:44 [2019-10-22T15:52:44.682Z] === RUN   TestBuildWithEmptyDockerfile/comment-only-dockerfile
15:52:44 [2019-10-22T15:52:44.682Z] === PAUSE TestBuildWithEmptyDockerfile/comment-only-dockerfile
15:52:44 [2019-10-22T15:52:44.682Z] === CONT  TestBuildWithEmptyDockerfile/empty-dockerfile
15:52:44 [2019-10-22T15:52:44.682Z] === CONT  TestBuildWithEmptyDockerfile/empty-lines-dockerfile
15:52:44 [2019-10-22T15:52:44.682Z] === CONT  TestBuildWithEmptyDockerfile/comment-only-dockerfile
15:52:44 [2019-10-22T15:52:44.682Z] --- PASS: TestBuildWithEmptyDockerfile (0.15s)
15:52:44 [2019-10-22T15:52:44.682Z]     --- PASS: TestBuildWithEmptyDockerfile/empty-dockerfile (0.28s)
15:52:44 [2019-10-22T15:52:44.682Z]     --- PASS: TestBuildWithEmptyDockerfile/empty-lines-dockerfile (0.29s)
15:52:44 [2019-10-22T15:52:44.682Z]     --- PASS: TestBuildWithEmptyDockerfile/comment-only-dockerfile (0.29s)
15:52:44 [2019-10-22T15:52:44.682Z] === RUN   TestBuildPreserveOwnership
15:52:44 [2019-10-22T15:52:44.682Z] === RUN   TestBuildPreserveOwnership/copy_from
15:52:44 [2019-10-22T15:52:44.682Z] === RUN   TestBuildPreserveOwnership/copy_from_chowned
15:52:46 [2019-10-22T15:52:46.585Z] --- PASS: TestBuildPreserveOwnership (6.08s)
15:52:46 [2019-10-22T15:52:46.585Z]     --- PASS: TestBuildPreserveOwnership/copy_from (3.92s)
15:52:46 [2019-10-22T15:52:46.585Z]     --- PASS: TestBuildPreserveOwnership/copy_from_chowned (2.14s)
15:52:46 [2019-10-22T15:52:46.585Z] === RUN   TestBuildPlatformInvalid
15:52:46 [2019-10-22T15:52:46.585Z] --- PASS: TestBuildPlatformInvalid (0.18s)
15:52:46 [2019-10-22T15:52:46.585Z] PASS
15:52:46 [2019-10-22T15:52:46.585Z] 
15:52:46 [2019-10-22T15:52:46.585Z] === Skipped
15:52:46 [2019-10-22T15:52:46.585Z] === SKIP: arm64.integration.build TestBuildWithSession (0.00s)
15:52:46 [2019-10-22T15:52:46.585Z]     build_session_test.go:25: TODO: BuildKit
15:52:46 [2019-10-22T15:52:46.585Z] 
15:52:46 [2019-10-22T15:52:46.585Z] 
15:52:46 [2019-10-22T15:52:46.585Z] DONE 32 tests, 1 skipped in 92.072s
15:52:46 [2019-10-22T15:52:46.585Z] Running /go/src/github.com/docker/docker/integration/config (arm64.integration.config) flags=-test.v -test.timeout=120m 
15:52:46 [2019-10-22T15:52:46.585Z] ++ 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
15:52:46 [2019-10-22T15:52:46.585Z] ++ set -e
15:52:46 [2019-10-22T15:52:46.585Z] ++ '[' -n 0 ']'
15:52:46 [2019-10-22T15:52:46.585Z] ++ set -x
15:52:46 [2019-10-22T15:52:46.585Z] ++ 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
15:52:47 [2019-10-22T15:52:47.151Z] INFO: Testing against a local daemon
15:52:47 [2019-10-22T15:52:47.151Z] === RUN   TestConfigList
15:52:50 [2019-10-22T15:52:50.436Z] --- PASS: TestConfigList (3.43s)
15:52:50 [2019-10-22T15:52:50.436Z]     config_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigList"
15:52:50 [2019-10-22T15:52:50.436Z] === RUN   TestConfigsCreateAndDelete
15:52:53 [2019-10-22T15:52:53.723Z] --- PASS: TestConfigsCreateAndDelete (3.13s)
15:52:53 [2019-10-22T15:52:53.723Z]     config_test.go:112: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigsCreateAndDelete"
15:52:53 [2019-10-22T15:52:53.723Z] === RUN   TestConfigsUpdate
15:52:57 [2019-10-22T15:52:57.009Z] --- PASS: TestConfigsUpdate (3.20s)
15:52:57 [2019-10-22T15:52:57.010Z]     config_test.go:140: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigsUpdate"
15:52:57 [2019-10-22T15:52:57.010Z] === RUN   TestTemplatedConfig
15:53:00 [2019-10-22T15:53:00.297Z] --- PASS: TestTemplatedConfig (3.52s)
15:53:00 [2019-10-22T15:53:00.297Z]     config_test.go:192: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestTemplatedConfig"
15:53:00 [2019-10-22T15:53:00.297Z] === RUN   TestConfigInspect
15:53:03 [2019-10-22T15:53:03.583Z] --- PASS: TestConfigInspect (3.14s)
15:53:03 [2019-10-22T15:53:03.583Z]     config_test.go:326: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigInspect"
15:53:03 [2019-10-22T15:53:03.583Z] === RUN   TestConfigCreateWithLabels
15:53:06 [2019-10-22T15:53:06.868Z] --- PASS: TestConfigCreateWithLabels (3.14s)
15:53:06 [2019-10-22T15:53:06.868Z]     config_test.go:350: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigCreateWithLabels"
15:53:06 [2019-10-22T15:53:06.868Z] === RUN   TestConfigCreateResolve
15:53:10 [2019-10-22T15:53:10.154Z] --- PASS: TestConfigCreateResolve (3.14s)
15:53:10 [2019-10-22T15:53:10.154Z]     config_test.go:377: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigCreateResolve"
15:53:10 [2019-10-22T15:53:10.154Z] === RUN   TestConfigDaemonLibtrustID
15:53:10 [2019-10-22T15:53:10.412Z] --- PASS: TestConfigDaemonLibtrustID (0.57s)
15:53:10 [2019-10-22T15:53:10.412Z]     config_test.go:427: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestConfigDaemonLibtrustID"
15:53:10 [2019-10-22T15:53:10.412Z] PASS
15:53:10 [2019-10-22T15:53:10.412Z] 
15:53:10 [2019-10-22T15:53:10.412Z] DONE 8 tests in 23.565s
15:53:10 [2019-10-22T15:53:10.412Z] Running /go/src/github.com/docker/docker/integration/container (arm64.integration.container) flags=-test.v -test.timeout=120m 
15:53:10 [2019-10-22T15:53:10.412Z] ++ 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
15:53:10 [2019-10-22T15:53:10.412Z] ++ set -e
15:53:10 [2019-10-22T15:53:10.412Z] ++ '[' -n 0 ']'
15:53:10 [2019-10-22T15:53:10.412Z] ++ set -x
15:53:10 [2019-10-22T15:53:10.412Z] ++ 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
15:53:10 [2019-10-22T15:53:10.671Z] INFO: Testing against a local daemon
15:53:10 [2019-10-22T15:53:10.671Z] === RUN   TestCheckpoint
15:53:10 [2019-10-22T15:53:10.671Z] --- SKIP: TestCheckpoint (0.00s)
15:53:10 [2019-10-22T15:53:10.671Z]     checkpoint_test.go:33: TestCheckpoint is broken; see https://github.com/moby/moby/issues/38963
15:53:10 [2019-10-22T15:53:10.671Z] === RUN   TestContainerInvalidJSON
15:53:10 [2019-10-22T15:53:10.671Z] === RUN   TestContainerInvalidJSON//containers/foobar/copy
15:53:10 [2019-10-22T15:53:10.671Z] === PAUSE TestContainerInvalidJSON//containers/foobar/copy
15:53:10 [2019-10-22T15:53:10.671Z] === RUN   TestContainerInvalidJSON//containers/foobar/exec
15:53:10 [2019-10-22T15:53:10.671Z] === PAUSE TestContainerInvalidJSON//containers/foobar/exec
15:53:10 [2019-10-22T15:53:10.671Z] === RUN   TestContainerInvalidJSON//exec/foobar/start
15:53:10 [2019-10-22T15:53:10.671Z] === PAUSE TestContainerInvalidJSON//exec/foobar/start
15:53:10 [2019-10-22T15:53:10.671Z] === CONT  TestContainerInvalidJSON//containers/foobar/copy
15:53:10 [2019-10-22T15:53:10.671Z] === CONT  TestContainerInvalidJSON//exec/foobar/start
15:53:10 [2019-10-22T15:53:10.671Z] === CONT  TestContainerInvalidJSON//containers/foobar/exec
15:53:10 [2019-10-22T15:53:10.671Z] --- PASS: TestContainerInvalidJSON (0.02s)
15:53:10 [2019-10-22T15:53:10.671Z]     --- PASS: TestContainerInvalidJSON//containers/foobar/copy (0.01s)
15:53:10 [2019-10-22T15:53:10.671Z]     --- PASS: TestContainerInvalidJSON//exec/foobar/start (0.01s)
15:53:10 [2019-10-22T15:53:10.671Z]     --- PASS: TestContainerInvalidJSON//containers/foobar/exec (0.02s)
15:53:10 [2019-10-22T15:53:10.671Z] === RUN   TestCopyFromContainerPathDoesNotExist
15:53:10 [2019-10-22T15:53:10.671Z] --- PASS: TestCopyFromContainerPathDoesNotExist (0.14s)
15:53:10 [2019-10-22T15:53:10.671Z] === RUN   TestCopyFromContainerPathIsNotDir
15:53:10 [2019-10-22T15:53:10.929Z] --- PASS: TestCopyFromContainerPathIsNotDir (0.11s)
15:53:10 [2019-10-22T15:53:10.929Z] === RUN   TestCopyToContainerPathDoesNotExist
15:53:10 [2019-10-22T15:53:10.929Z] --- PASS: TestCopyToContainerPathDoesNotExist (0.12s)
15:53:10 [2019-10-22T15:53:10.929Z] === RUN   TestCopyToContainerPathIsNotDir
15:53:11 [2019-10-22T15:53:11.187Z] --- PASS: TestCopyToContainerPathIsNotDir (0.12s)
15:53:11 [2019-10-22T15:53:11.187Z] === RUN   TestCopyFromContainer
15:53:13 [2019-10-22T15:53:13.092Z] === RUN   TestCopyFromContainer//
15:53:13 [2019-10-22T15:53:13.092Z] === RUN   TestCopyFromContainer//bar/root
15:53:13 [2019-10-22T15:53:13.350Z] === RUN   TestCopyFromContainer//bar/root/
15:53:13 [2019-10-22T15:53:13.350Z] === RUN   TestCopyFromContainer/bar/quux
15:53:13 [2019-10-22T15:53:13.609Z] === RUN   TestCopyFromContainer/bar/quux/
15:53:13 [2019-10-22T15:53:13.610Z] === RUN   TestCopyFromContainer/bar/quux/baz
15:53:13 [2019-10-22T15:53:13.610Z] === RUN   TestCopyFromContainer/bar/filesymlink
15:53:13 [2019-10-22T15:53:13.870Z] === RUN   TestCopyFromContainer/bar/dirsymlink
15:53:13 [2019-10-22T15:53:13.870Z] === RUN   TestCopyFromContainer/bar/dirsymlink/
15:53:14 [2019-10-22T15:53:14.128Z] === RUN   TestCopyFromContainer/bar/notarget
15:53:14 [2019-10-22T15:53:14.128Z] --- PASS: TestCopyFromContainer (3.07s)
15:53:14 [2019-10-22T15:53:14.128Z]     --- PASS: TestCopyFromContainer// (0.10s)
15:53:14 [2019-10-22T15:53:14.128Z]     --- PASS: TestCopyFromContainer//bar/root (0.13s)
15:53:14 [2019-10-22T15:53:14.128Z]     --- PASS: TestCopyFromContainer//bar/root/ (0.10s)
15:53:14 [2019-10-22T15:53:14.128Z]     --- PASS: TestCopyFromContainer/bar/quux (0.12s)
15:53:14 [2019-10-22T15:53:14.128Z]     --- PASS: TestCopyFromContainer/bar/quux/ (0.11s)
15:53:14 [2019-10-22T15:53:14.128Z]     --- PASS: TestCopyFromContainer/bar/quux/baz (0.11s)
15:53:14 [2019-10-22T15:53:14.128Z]     --- PASS: TestCopyFromContainer/bar/filesymlink (0.10s)
15:53:14 [2019-10-22T15:53:14.128Z]     --- PASS: TestCopyFromContainer/bar/dirsymlink (0.11s)
15:53:14 [2019-10-22T15:53:14.128Z]     --- PASS: TestCopyFromContainer/bar/dirsymlink/ (0.11s)
15:53:14 [2019-10-22T15:53:14.128Z]     --- PASS: TestCopyFromContainer/bar/notarget (0.10s)
15:53:14 [2019-10-22T15:53:14.128Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist
15:53:14 [2019-10-22T15:53:14.128Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
15:53:14 [2019-10-22T15:53:14.128Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
15:53:14 [2019-10-22T15:53:14.128Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
15:53:14 [2019-10-22T15:53:14.128Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
15:53:14 [2019-10-22T15:53:14.128Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/digest
15:53:14 [2019-10-22T15:53:14.128Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/digest
15:53:14 [2019-10-22T15:53:14.128Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
15:53:14 [2019-10-22T15:53:14.128Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
15:53:14 [2019-10-22T15:53:14.128Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/digest
15:53:14 [2019-10-22T15:53:14.128Z] --- PASS: TestCreateFailsWhenIdentifierDoesNotExist (0.02s)
15:53:14 [2019-10-22T15:53:14.128Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag (0.00s)
15:53:14 [2019-10-22T15:53:14.128Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/digest (0.00s)
15:53:14 [2019-10-22T15:53:14.128Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag (0.00s)
15:53:14 [2019-10-22T15:53:14.128Z] === RUN   TestCreateLinkToNonExistingContainer
15:53:14 [2019-10-22T15:53:14.386Z] --- PASS: TestCreateLinkToNonExistingContainer (0.06s)
15:53:14 [2019-10-22T15:53:14.386Z] === RUN   TestCreateWithInvalidEnv
15:53:14 [2019-10-22T15:53:14.386Z] === RUN   TestCreateWithInvalidEnv/0
15:53:14 [2019-10-22T15:53:14.386Z] === PAUSE TestCreateWithInvalidEnv/0
15:53:14 [2019-10-22T15:53:14.386Z] === RUN   TestCreateWithInvalidEnv/1
15:53:14 [2019-10-22T15:53:14.386Z] === PAUSE TestCreateWithInvalidEnv/1
15:53:14 [2019-10-22T15:53:14.386Z] === RUN   TestCreateWithInvalidEnv/2
15:53:14 [2019-10-22T15:53:14.386Z] === PAUSE TestCreateWithInvalidEnv/2
15:53:14 [2019-10-22T15:53:14.386Z] === CONT  TestCreateWithInvalidEnv/0
15:53:14 [2019-10-22T15:53:14.386Z] === CONT  TestCreateWithInvalidEnv/2
15:53:14 [2019-10-22T15:53:14.386Z] === CONT  TestCreateWithInvalidEnv/1
15:53:14 [2019-10-22T15:53:14.386Z] --- PASS: TestCreateWithInvalidEnv (0.02s)
15:53:14 [2019-10-22T15:53:14.386Z]     --- PASS: TestCreateWithInvalidEnv/1 (0.00s)
15:53:14 [2019-10-22T15:53:14.386Z]     --- PASS: TestCreateWithInvalidEnv/0 (0.00s)
15:53:14 [2019-10-22T15:53:14.386Z]     --- PASS: TestCreateWithInvalidEnv/2 (0.00s)
15:53:14 [2019-10-22T15:53:14.386Z] === RUN   TestCreateTmpfsMountsTarget
15:53:14 [2019-10-22T15:53:14.386Z] --- PASS: TestCreateTmpfsMountsTarget (0.04s)
15:53:14 [2019-10-22T15:53:14.386Z] === RUN   TestCreateWithCustomMaskedPaths
15:53:16 [2019-10-22T15:53:16.919Z] --- PASS: TestCreateWithCustomMaskedPaths (2.32s)
15:53:16 [2019-10-22T15:53:16.919Z] === RUN   TestCreateWithCapabilities
15:53:16 [2019-10-22T15:53:16.919Z] === RUN   TestCreateWithCapabilities/no_capabilities
15:53:16 [2019-10-22T15:53:16.919Z] === PAUSE TestCreateWithCapabilities/no_capabilities
15:53:16 [2019-10-22T15:53:16.919Z] === RUN   TestCreateWithCapabilities/empty_capabilities
15:53:16 [2019-10-22T15:53:16.919Z] === PAUSE TestCreateWithCapabilities/empty_capabilities
15:53:16 [2019-10-22T15:53:16.919Z] === RUN   TestCreateWithCapabilities/valid_capabilities
15:53:16 [2019-10-22T15:53:16.919Z] === PAUSE TestCreateWithCapabilities/valid_capabilities
15:53:16 [2019-10-22T15:53:16.919Z] === RUN   TestCreateWithCapabilities/invalid_capabilities
15:53:16 [2019-10-22T15:53:16.919Z] === PAUSE TestCreateWithCapabilities/invalid_capabilities
15:53:16 [2019-10-22T15:53:16.919Z] === RUN   TestCreateWithCapabilities/duplicate_capabilities
15:53:16 [2019-10-22T15:53:16.919Z] === PAUSE TestCreateWithCapabilities/duplicate_capabilities
15:53:16 [2019-10-22T15:53:16.919Z] === RUN   TestCreateWithCapabilities/capabilities_API_v1.39
15:53:16 [2019-10-22T15:53:16.919Z] === PAUSE TestCreateWithCapabilities/capabilities_API_v1.39
15:53:16 [2019-10-22T15:53:16.919Z] === RUN   TestCreateWithCapabilities/empty_capadd
15:53:16 [2019-10-22T15:53:16.919Z] === PAUSE TestCreateWithCapabilities/empty_capadd
15:53:16 [2019-10-22T15:53:16.919Z] === RUN   TestCreateWithCapabilities/empty_capdrop
15:53:16 [2019-10-22T15:53:16.919Z] === PAUSE TestCreateWithCapabilities/empty_capdrop
15:53:16 [2019-10-22T15:53:16.919Z] === RUN   TestCreateWithCapabilities/capadd_capdrop
15:53:16 [2019-10-22T15:53:16.919Z] === PAUSE TestCreateWithCapabilities/capadd_capdrop
15:53:16 [2019-10-22T15:53:16.919Z] === RUN   TestCreateWithCapabilities/conflict_with_capadd
15:53:16 [2019-10-22T15:53:16.919Z] === PAUSE TestCreateWithCapabilities/conflict_with_capadd
15:53:16 [2019-10-22T15:53:16.919Z] === RUN   TestCreateWithCapabilities/conflict_with_capdrop
15:53:16 [2019-10-22T15:53:16.919Z] === PAUSE TestCreateWithCapabilities/conflict_with_capdrop
15:53:16 [2019-10-22T15:53:16.919Z] === CONT  TestCreateWithCapabilities/no_capabilities
15:53:16 [2019-10-22T15:53:16.919Z] === CONT  TestCreateWithCapabilities/empty_capadd
15:53:16 [2019-10-22T15:53:16.919Z] === CONT  TestCreateWithCapabilities/conflict_with_capdrop
15:53:16 [2019-10-22T15:53:16.919Z] === CONT  TestCreateWithCapabilities/empty_capdrop
15:53:16 [2019-10-22T15:53:16.919Z] === CONT  TestCreateWithCapabilities/conflict_with_capadd
15:53:16 [2019-10-22T15:53:16.919Z] === CONT  TestCreateWithCapabilities/invalid_capabilities
15:53:16 [2019-10-22T15:53:16.919Z] === CONT  TestCreateWithCapabilities/capabilities_API_v1.39
15:53:16 [2019-10-22T15:53:16.919Z] === CONT  TestCreateWithCapabilities/duplicate_capabilities
15:53:16 [2019-10-22T15:53:16.919Z] === CONT  TestCreateWithCapabilities/capadd_capdrop
15:53:16 [2019-10-22T15:53:16.919Z] === CONT  TestCreateWithCapabilities/valid_capabilities
15:53:16 [2019-10-22T15:53:16.919Z] === CONT  TestCreateWithCapabilities/empty_capabilities
15:53:16 [2019-10-22T15:53:16.919Z] --- PASS: TestCreateWithCapabilities (0.04s)
15:53:16 [2019-10-22T15:53:16.919Z]     --- PASS: TestCreateWithCapabilities/conflict_with_capdrop (0.00s)
15:53:16 [2019-10-22T15:53:16.919Z]     --- PASS: TestCreateWithCapabilities/conflict_with_capadd (0.01s)
15:53:16 [2019-10-22T15:53:16.919Z]     --- PASS: TestCreateWithCapabilities/invalid_capabilities (0.00s)
15:53:16 [2019-10-22T15:53:16.919Z]     --- PASS: TestCreateWithCapabilities/capabilities_API_v1.39 (0.07s)
15:53:16 [2019-10-22T15:53:16.919Z]     --- PASS: TestCreateWithCapabilities/empty_capadd (0.09s)
15:53:16 [2019-10-22T15:53:16.919Z]     --- PASS: TestCreateWithCapabilities/empty_capdrop (0.09s)
15:53:16 [2019-10-22T15:53:16.919Z]     --- PASS: TestCreateWithCapabilities/no_capabilities (0.09s)
15:53:16 [2019-10-22T15:53:16.919Z]     --- PASS: TestCreateWithCapabilities/duplicate_capabilities (0.16s)
15:53:16 [2019-10-22T15:53:16.919Z]     --- PASS: TestCreateWithCapabilities/valid_capabilities (0.16s)
15:53:16 [2019-10-22T15:53:16.919Z]     --- PASS: TestCreateWithCapabilities/empty_capabilities (0.16s)
15:53:16 [2019-10-22T15:53:16.919Z]     --- PASS: TestCreateWithCapabilities/capadd_capdrop (0.16s)
15:53:16 [2019-10-22T15:53:16.919Z] === RUN   TestCreateWithCustomReadonlyPaths
15:53:19 [2019-10-22T15:53:19.451Z] --- PASS: TestCreateWithCustomReadonlyPaths (2.34s)
15:53:19 [2019-10-22T15:53:19.451Z] === RUN   TestCreateWithInvalidHealthcheckParams
15:53:19 [2019-10-22T15:53:19.451Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
15:53:19 [2019-10-22T15:53:19.451Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
15:53:19 [2019-10-22T15:53:19.451Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
15:53:19 [2019-10-22T15:53:19.451Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
15:53:19 [2019-10-22T15:53:19.451Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
15:53:19 [2019-10-22T15:53:19.451Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
15:53:19 [2019-10-22T15:53:19.451Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
15:53:19 [2019-10-22T15:53:19.451Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
15:53:19 [2019-10-22T15:53:19.451Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
15:53:19 [2019-10-22T15:53:19.451Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
15:53:19 [2019-10-22T15:53:19.451Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
15:53:19 [2019-10-22T15:53:19.451Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
15:53:19 [2019-10-22T15:53:19.451Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
15:53:19 [2019-10-22T15:53:19.451Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
15:53:19 [2019-10-22T15:53:19.451Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
15:53:19 [2019-10-22T15:53:19.451Z] --- PASS: TestCreateWithInvalidHealthcheckParams (0.03s)
15:53:19 [2019-10-22T15:53:19.451Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms (0.04s)
15:53:19 [2019-10-22T15:53:19.451Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s (0.04s)
15:53:19 [2019-10-22T15:53:19.451Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0 (0.04s)
15:53:19 [2019-10-22T15:53:19.451Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms (0.05s)
15:53:19 [2019-10-22T15:53:19.451Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms (0.02s)
15:53:19 [2019-10-22T15:53:19.451Z] === RUN   TestContainerStartOnDaemonRestart
15:53:19 [2019-10-22T15:53:19.451Z] === PAUSE TestContainerStartOnDaemonRestart
15:53:19 [2019-10-22T15:53:19.451Z] === RUN   TestDaemonRestartIpcMode
15:53:19 [2019-10-22T15:53:19.451Z] === PAUSE TestDaemonRestartIpcMode
15:53:19 [2019-10-22T15:53:19.451Z] === RUN   TestDiff
15:53:20 [2019-10-22T15:53:20.387Z] --- PASS: TestDiff (0.86s)
15:53:20 [2019-10-22T15:53:20.387Z] === RUN   TestExecWithCloseStdin
15:53:21 [2019-10-22T15:53:21.322Z] --- PASS: TestExecWithCloseStdin (1.07s)
15:53:21 [2019-10-22T15:53:21.322Z] === RUN   TestExec
15:53:22 [2019-10-22T15:53:22.258Z] --- PASS: TestExec (0.97s)
15:53:22 [2019-10-22T15:53:22.258Z] === RUN   TestExecUser
15:53:23 [2019-10-22T15:53:23.194Z] --- PASS: TestExecUser (0.98s)
15:53:23 [2019-10-22T15:53:23.194Z] === RUN   TestExportContainerAndImportImage
15:53:24 [2019-10-22T15:53:24.571Z] --- PASS: TestExportContainerAndImportImage (1.10s)
15:53:24 [2019-10-22T15:53:24.571Z] === RUN   TestExportContainerAfterDaemonRestart
15:53:26 [2019-10-22T15:53:26.474Z] --- PASS: TestExportContainerAfterDaemonRestart (1.83s)
15:53:26 [2019-10-22T15:53:26.474Z]     export_test.go:63: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestExportContainerAfterDaemonRestart"
15:53:26 [2019-10-22T15:53:26.474Z] === RUN   TestHealthCheckWorkdir
15:53:27 [2019-10-22T15:53:27.410Z] --- PASS: TestHealthCheckWorkdir (1.14s)
15:53:27 [2019-10-22T15:53:27.410Z] === RUN   TestHealthKillContainer
15:53:30 [2019-10-22T15:53:30.698Z] --- PASS: TestHealthKillContainer (2.93s)
15:53:30 [2019-10-22T15:53:30.698Z] === RUN   TestInspectCpusetInConfigPre120
15:53:31 [2019-10-22T15:53:31.266Z] --- PASS: TestInspectCpusetInConfigPre120 (0.83s)
15:53:31 [2019-10-22T15:53:31.266Z] === RUN   TestIpcModeNone
15:53:32 [2019-10-22T15:53:32.202Z] --- PASS: TestIpcModeNone (0.98s)
15:53:32 [2019-10-22T15:53:32.202Z] === RUN   TestIpcModePrivate
15:53:33 [2019-10-22T15:53:33.138Z] --- PASS: TestIpcModePrivate (0.98s)
15:53:33 [2019-10-22T15:53:33.138Z]     ipcmode_linux_test.go:90: [testIpcPrivateShareable] ipcmode: private, ipcdev: 0:100, shared: false, mustBeShared: false
15:53:33 [2019-10-22T15:53:33.138Z] === RUN   TestIpcModeShareable
15:53:34 [2019-10-22T15:53:34.076Z] --- PASS: TestIpcModeShareable (1.03s)
15:53:34 [2019-10-22T15:53:34.076Z]     ipcmode_linux_test.go:90: [testIpcPrivateShareable] ipcmode: shareable, ipcdev: 0:94, shared: true, mustBeShared: true
15:53:34 [2019-10-22T15:53:34.076Z] === RUN   TestAPIIpcModeShareableAndContainer
15:53:37 [2019-10-22T15:53:37.362Z] --- PASS: TestAPIIpcModeShareableAndContainer (2.98s)
15:53:37 [2019-10-22T15:53:37.362Z] === RUN   TestAPIIpcModeHost
15:53:37 [2019-10-22T15:53:37.929Z] --- PASS: TestAPIIpcModeHost (0.76s)
15:53:37 [2019-10-22T15:53:37.929Z] === RUN   TestDaemonIpcModeShareable
15:53:39 [2019-10-22T15:53:39.832Z] --- PASS: TestDaemonIpcModeShareable (1.94s)
15:53:39 [2019-10-22T15:53:39.832Z]     ipcmode_linux_test.go:230: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModeShareable"
15:53:39 [2019-10-22T15:53:39.832Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:105, shared: true, mustBeShared: true
15:53:39 [2019-10-22T15:53:39.832Z] === RUN   TestDaemonIpcModePrivate
15:53:41 [2019-10-22T15:53:41.737Z] --- PASS: TestDaemonIpcModePrivate (1.81s)
15:53:41 [2019-10-22T15:53:41.737Z]     ipcmode_linux_test.go:230: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModePrivate"
15:53:41 [2019-10-22T15:53:41.737Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:111, shared: false, mustBeShared: false
15:53:41 [2019-10-22T15:53:41.737Z] === RUN   TestDaemonIpcModePrivateFromConfig
15:53:43 [2019-10-22T15:53:43.640Z] --- PASS: TestDaemonIpcModePrivateFromConfig (1.87s)
15:53:43 [2019-10-22T15:53:43.640Z]     ipcmode_linux_test.go:230: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModePrivateFromConfig"
15:53:43 [2019-10-22T15:53:43.640Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:111, shared: false, mustBeShared: false
15:53:43 [2019-10-22T15:53:43.640Z] === RUN   TestDaemonIpcModeShareableFromConfig
15:53:45 [2019-10-22T15:53:45.545Z] --- PASS: TestDaemonIpcModeShareableFromConfig (1.85s)
15:53:45 [2019-10-22T15:53:45.545Z]     ipcmode_linux_test.go:230: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModeShareableFromConfig"
15:53:45 [2019-10-22T15:53:45.545Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:105, shared: true, mustBeShared: true
15:53:45 [2019-10-22T15:53:45.545Z] === RUN   TestIpcModeOlderClient
15:53:45 [2019-10-22T15:53:45.545Z] === PAUSE TestIpcModeOlderClient
15:53:45 [2019-10-22T15:53:45.545Z] === RUN   TestKillContainerInvalidSignal
15:53:46 [2019-10-22T15:53:46.112Z] --- PASS: TestKillContainerInvalidSignal (0.86s)
15:53:46 [2019-10-22T15:53:46.112Z] === RUN   TestKillContainer
15:53:46 [2019-10-22T15:53:46.112Z] === RUN   TestKillContainer/no_signal
15:53:47 [2019-10-22T15:53:47.048Z] === RUN   TestKillContainer/non_killing_signal
15:53:47 [2019-10-22T15:53:47.616Z] === RUN   TestKillContainer/killing_signal
15:53:48 [2019-10-22T15:53:48.991Z] --- PASS: TestKillContainer (2.57s)
15:53:48 [2019-10-22T15:53:48.991Z]     --- PASS: TestKillContainer/no_signal (0.83s)
15:53:48 [2019-10-22T15:53:48.991Z]     --- PASS: TestKillContainer/non_killing_signal (0.58s)
15:53:48 [2019-10-22T15:53:48.991Z]     --- PASS: TestKillContainer/killing_signal (0.79s)
15:53:48 [2019-10-22T15:53:48.991Z] === RUN   TestKillWithStopSignalAndRestartPolicies
15:53:48 [2019-10-22T15:53:48.991Z] === RUN   TestKillWithStopSignalAndRestartPolicies/same-signal-disables-restart-policy
15:53:49 [2019-10-22T15:53:49.558Z] === RUN   TestKillWithStopSignalAndRestartPolicies/different-signal-keep-restart-policy
15:53:50 [2019-10-22T15:53:50.494Z] --- PASS: TestKillWithStopSignalAndRestartPolicies (1.60s)
15:53:50 [2019-10-22T15:53:50.494Z]     --- PASS: TestKillWithStopSignalAndRestartPolicies/same-signal-disables-restart-policy (0.78s)
15:53:50 [2019-10-22T15:53:50.494Z]     --- PASS: TestKillWithStopSignalAndRestartPolicies/different-signal-keep-restart-policy (0.53s)
15:53:50 [2019-10-22T15:53:50.494Z] === RUN   TestKillStoppedContainer
15:53:50 [2019-10-22T15:53:50.494Z] --- PASS: TestKillStoppedContainer (0.12s)
15:53:50 [2019-10-22T15:53:50.494Z] === RUN   TestKillStoppedContainerAPIPre120
15:53:50 [2019-10-22T15:53:50.494Z] --- PASS: TestKillStoppedContainerAPIPre120 (0.11s)
15:53:50 [2019-10-22T15:53:50.494Z] === RUN   TestKillDifferentUserContainer
15:53:51 [2019-10-22T15:53:51.447Z] --- PASS: TestKillDifferentUserContainer (0.87s)
15:53:51 [2019-10-22T15:53:51.447Z] === RUN   TestInspectOomKilledTrue
15:53:51 [2019-10-22T15:53:51.447Z] --- SKIP: TestInspectOomKilledTrue (0.00s)
15:53:51 [2019-10-22T15:53:51.447Z]     kill_test.go:151: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
15:53:51 [2019-10-22T15:53:51.447Z] === RUN   TestInspectOomKilledFalse
15:53:51 [2019-10-22T15:53:51.447Z] --- SKIP: TestInspectOomKilledFalse (0.00s)
15:53:51 [2019-10-22T15:53:51.447Z]     kill_test.go:169: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
15:53:51 [2019-10-22T15:53:51.447Z] === RUN   TestLinksEtcHostsContentMatch
15:53:52 [2019-10-22T15:53:52.386Z] --- PASS: TestLinksEtcHostsContentMatch (0.80s)
15:53:52 [2019-10-22T15:53:52.386Z] === RUN   TestLinksContainerNames
15:53:54 [2019-10-22T15:53:54.292Z] --- PASS: TestLinksContainerNames (1.77s)
15:53:54 [2019-10-22T15:53:54.292Z] === RUN   TestLogsFollowTailEmpty
15:53:54 [2019-10-22T15:53:54.866Z] --- PASS: TestLogsFollowTailEmpty (0.88s)
15:53:54 [2019-10-22T15:53:54.866Z] === RUN   TestContainerNetworkMountsNoChown
15:53:55 [2019-10-22T15:53:55.803Z] --- PASS: TestContainerNetworkMountsNoChown (0.87s)
15:53:55 [2019-10-22T15:53:55.803Z] === RUN   TestMountDaemonRoot
15:53:55 [2019-10-22T15:53:55.803Z] === RUN   TestMountDaemonRoot/default
15:53:55 [2019-10-22T15:53:55.803Z] === PAUSE TestMountDaemonRoot/default
15:53:55 [2019-10-22T15:53:55.803Z] === RUN   TestMountDaemonRoot/private
15:53:55 [2019-10-22T15:53:55.803Z] === PAUSE TestMountDaemonRoot/private
15:53:55 [2019-10-22T15:53:55.803Z] === RUN   TestMountDaemonRoot/rprivate
15:53:55 [2019-10-22T15:53:55.803Z] === PAUSE TestMountDaemonRoot/rprivate
15:53:55 [2019-10-22T15:53:55.803Z] === RUN   TestMountDaemonRoot/slave
15:53:55 [2019-10-22T15:53:55.803Z] === PAUSE TestMountDaemonRoot/slave
15:53:55 [2019-10-22T15:53:55.803Z] === RUN   TestMountDaemonRoot/rslave
15:53:55 [2019-10-22T15:53:55.803Z] === PAUSE TestMountDaemonRoot/rslave
15:53:55 [2019-10-22T15:53:55.803Z] === RUN   TestMountDaemonRoot/shared
15:53:55 [2019-10-22T15:53:55.803Z] === PAUSE TestMountDaemonRoot/shared
15:53:55 [2019-10-22T15:53:55.803Z] === RUN   TestMountDaemonRoot/rshared
15:53:55 [2019-10-22T15:53:55.803Z] === PAUSE TestMountDaemonRoot/rshared
15:53:55 [2019-10-22T15:53:55.803Z] === CONT  TestMountDaemonRoot/default
15:53:55 [2019-10-22T15:53:55.803Z] === CONT  TestMountDaemonRoot/rslave
15:53:55 [2019-10-22T15:53:55.803Z] === RUN   TestMountDaemonRoot/default/mount_subpath
15:53:55 [2019-10-22T15:53:55.803Z] === PAUSE TestMountDaemonRoot/default/mount_subpath
15:53:55 [2019-10-22T15:53:55.803Z] === RUN   TestMountDaemonRoot/rslave/bind_root
15:53:55 [2019-10-22T15:53:55.803Z] === CONT  TestMountDaemonRoot/slave
15:53:55 [2019-10-22T15:53:55.803Z] === RUN   TestMountDaemonRoot/slave/bind_root
15:53:55 [2019-10-22T15:53:55.803Z] === RUN   TestMountDaemonRoot/default/bind_root
15:53:55 [2019-10-22T15:53:55.803Z] === PAUSE TestMountDaemonRoot/slave/bind_root
15:53:55 [2019-10-22T15:53:55.803Z] === PAUSE TestMountDaemonRoot/default/bind_root
15:53:55 [2019-10-22T15:53:55.803Z] === RUN   TestMountDaemonRoot/slave/bind_subpath
15:53:55 [2019-10-22T15:53:55.803Z] === RUN   TestMountDaemonRoot/default/bind_subpath
15:53:55 [2019-10-22T15:53:55.803Z] === CONT  TestMountDaemonRoot/rshared
15:53:55 [2019-10-22T15:53:55.803Z] === PAUSE TestMountDaemonRoot/default/bind_subpath
15:53:55 [2019-10-22T15:53:55.803Z] === PAUSE TestMountDaemonRoot/rslave/bind_root
15:53:55 [2019-10-22T15:53:55.803Z] === RUN   TestMountDaemonRoot/rshared/bind_root
15:53:55 [2019-10-22T15:53:55.803Z] === RUN   TestMountDaemonRoot/rslave/bind_subpath
15:53:55 [2019-10-22T15:53:55.803Z] === PAUSE TestMountDaemonRoot/rshared/bind_root
15:53:55 [2019-10-22T15:53:55.803Z] === PAUSE TestMountDaemonRoot/rslave/bind_subpath
15:53:55 [2019-10-22T15:53:55.803Z] === RUN   TestMountDaemonRoot/rshared/bind_subpath
15:53:55 [2019-10-22T15:53:55.803Z] === RUN   TestMountDaemonRoot/rslave/mount_root
15:53:55 [2019-10-22T15:53:55.803Z] === PAUSE TestMountDaemonRoot/rshared/bind_subpath
15:53:55 [2019-10-22T15:53:55.803Z] === PAUSE TestMountDaemonRoot/slave/bind_subpath
15:53:55 [2019-10-22T15:53:55.803Z] === RUN   TestMountDaemonRoot/default/mount_root
15:53:55 [2019-10-22T15:53:55.803Z] === RUN   TestMountDaemonRoot/slave/mount_root
15:53:55 [2019-10-22T15:53:55.803Z] === PAUSE TestMountDaemonRoot/default/mount_root
15:53:55 [2019-10-22T15:53:55.803Z] === PAUSE TestMountDaemonRoot/slave/mount_root
15:53:55 [2019-10-22T15:53:55.803Z] === PAUSE TestMountDaemonRoot/rslave/mount_root
15:53:55 [2019-10-22T15:53:55.803Z] === RUN   TestMountDaemonRoot/rshared/mount_root
15:53:55 [2019-10-22T15:53:55.803Z] === RUN   TestMountDaemonRoot/rslave/mount_subpath
15:53:55 [2019-10-22T15:53:55.803Z] === PAUSE TestMountDaemonRoot/rshared/mount_root
15:53:55 [2019-10-22T15:53:55.803Z] === PAUSE TestMountDaemonRoot/rslave/mount_subpath
15:53:55 [2019-10-22T15:53:55.803Z] === RUN   TestMountDaemonRoot/rshared/mount_subpath
15:53:55 [2019-10-22T15:53:55.803Z] === CONT  TestMountDaemonRoot/rprivate
15:53:55 [2019-10-22T15:53:55.803Z] === PAUSE TestMountDaemonRoot/rshared/mount_subpath
15:53:55 [2019-10-22T15:53:55.803Z] === CONT  TestMountDaemonRoot/private
15:53:55 [2019-10-22T15:53:55.803Z] === RUN   TestMountDaemonRoot/private/bind_root
15:53:55 [2019-10-22T15:53:55.803Z] === PAUSE TestMountDaemonRoot/private/bind_root
15:53:55 [2019-10-22T15:53:55.803Z] === RUN   TestMountDaemonRoot/private/bind_subpath
15:53:55 [2019-10-22T15:53:55.803Z] === PAUSE TestMountDaemonRoot/private/bind_subpath
15:53:55 [2019-10-22T15:53:55.803Z] === RUN   TestMountDaemonRoot/private/mount_root
15:53:55 [2019-10-22T15:53:55.803Z] === RUN   TestMountDaemonRoot/rprivate/mount_subpath
15:53:55 [2019-10-22T15:53:55.803Z] === PAUSE TestMountDaemonRoot/rprivate/mount_subpath
15:53:55 [2019-10-22T15:53:55.803Z] === RUN   TestMountDaemonRoot/rprivate/bind_root
15:53:55 [2019-10-22T15:53:55.803Z] === PAUSE TestMountDaemonRoot/rprivate/bind_root
15:53:55 [2019-10-22T15:53:55.803Z] === RUN   TestMountDaemonRoot/rprivate/bind_subpath
15:53:55 [2019-10-22T15:53:55.803Z] === PAUSE TestMountDaemonRoot/rprivate/bind_subpath
15:53:55 [2019-10-22T15:53:55.803Z] === RUN   TestMountDaemonRoot/slave/mount_subpath
15:53:55 [2019-10-22T15:53:55.803Z] === RUN   TestMountDaemonRoot/rprivate/mount_root
15:53:55 [2019-10-22T15:53:55.803Z] === PAUSE TestMountDaemonRoot/slave/mount_subpath
15:53:55 [2019-10-22T15:53:55.803Z] === PAUSE TestMountDaemonRoot/rprivate/mount_root
15:53:55 [2019-10-22T15:53:55.803Z] === CONT  TestMountDaemonRoot/default/mount_subpath
15:53:55 [2019-10-22T15:53:55.803Z] === PAUSE TestMountDaemonRoot/private/mount_root
15:53:55 [2019-10-22T15:53:55.803Z] === RUN   TestMountDaemonRoot/private/mount_subpath
15:53:55 [2019-10-22T15:53:55.803Z] === PAUSE TestMountDaemonRoot/private/mount_subpath
15:53:55 [2019-10-22T15:53:55.803Z] === CONT  TestMountDaemonRoot/shared
15:53:55 [2019-10-22T15:53:55.803Z] === RUN   TestMountDaemonRoot/shared/bind_root
15:53:55 [2019-10-22T15:53:55.803Z] === PAUSE TestMountDaemonRoot/shared/bind_root
15:53:55 [2019-10-22T15:53:55.803Z] === RUN   TestMountDaemonRoot/shared/bind_subpath
15:53:55 [2019-10-22T15:53:55.803Z] === PAUSE TestMountDaemonRoot/shared/bind_subpath
15:53:55 [2019-10-22T15:53:55.803Z] === RUN   TestMountDaemonRoot/shared/mount_root
15:53:55 [2019-10-22T15:53:55.803Z] === PAUSE TestMountDaemonRoot/shared/mount_root
15:53:55 [2019-10-22T15:53:55.803Z] === RUN   TestMountDaemonRoot/shared/mount_subpath
15:53:55 [2019-10-22T15:53:55.803Z] === PAUSE TestMountDaemonRoot/shared/mount_subpath
15:53:55 [2019-10-22T15:53:55.803Z] === CONT  TestMountDaemonRoot/default/bind_subpath
15:53:55 [2019-10-22T15:53:55.803Z] === CONT  TestMountDaemonRoot/default/mount_root
15:53:55 [2019-10-22T15:53:55.803Z] === CONT  TestMountDaemonRoot/default/bind_root
15:53:55 [2019-10-22T15:53:55.803Z] === CONT  TestMountDaemonRoot/rslave/bind_root
15:53:55 [2019-10-22T15:53:55.803Z] === CONT  TestMountDaemonRoot/rslave/mount_subpath
15:53:55 [2019-10-22T15:53:55.803Z] === CONT  TestMountDaemonRoot/rshared/bind_root
15:53:55 [2019-10-22T15:53:55.803Z] === CONT  TestMountDaemonRoot/rslave/mount_root
15:53:56 [2019-10-22T15:53:56.064Z] === CONT  TestMountDaemonRoot/rslave/bind_subpath
15:53:56 [2019-10-22T15:53:56.064Z] === CONT  TestMountDaemonRoot/rshared/mount_root
15:53:56 [2019-10-22T15:53:56.064Z] === CONT  TestMountDaemonRoot/rshared/mount_subpath
15:53:56 [2019-10-22T15:53:56.064Z] === CONT  TestMountDaemonRoot/rshared/bind_subpath
15:53:56 [2019-10-22T15:53:56.064Z] === CONT  TestMountDaemonRoot/slave/bind_root
15:53:56 [2019-10-22T15:53:56.064Z] === CONT  TestMountDaemonRoot/slave/mount_subpath
15:53:56 [2019-10-22T15:53:56.064Z] === CONT  TestMountDaemonRoot/rprivate/mount_subpath
15:53:56 [2019-10-22T15:53:56.064Z] === CONT  TestMountDaemonRoot/slave/mount_root
15:53:56 [2019-10-22T15:53:56.064Z] === CONT  TestMountDaemonRoot/slave/bind_subpath
15:53:56 [2019-10-22T15:53:56.064Z] === CONT  TestMountDaemonRoot/rprivate/mount_root
15:53:56 [2019-10-22T15:53:56.064Z] === CONT  TestMountDaemonRoot/rprivate/bind_subpath
15:53:56 [2019-10-22T15:53:56.064Z] === CONT  TestMountDaemonRoot/rprivate/bind_root
15:53:56 [2019-10-22T15:53:56.064Z] === CONT  TestMountDaemonRoot/private/bind_root
15:53:56 [2019-10-22T15:53:56.064Z] === CONT  TestMountDaemonRoot/shared/bind_root
15:53:56 [2019-10-22T15:53:56.324Z] === CONT  TestMountDaemonRoot/private/mount_subpath
15:53:56 [2019-10-22T15:53:56.324Z] === CONT  TestMountDaemonRoot/private/mount_root
15:53:56 [2019-10-22T15:53:56.324Z] === CONT  TestMountDaemonRoot/private/bind_subpath
15:53:56 [2019-10-22T15:53:56.324Z] === CONT  TestMountDaemonRoot/shared/bind_subpath
15:53:56 [2019-10-22T15:53:56.324Z] === CONT  TestMountDaemonRoot/shared/mount_subpath
15:53:56 [2019-10-22T15:53:56.324Z] === CONT  TestMountDaemonRoot/shared/mount_root
15:53:56 [2019-10-22T15:53:56.324Z] --- PASS: TestMountDaemonRoot (0.06s)
15:53:56 [2019-10-22T15:53:56.324Z]     --- PASS: TestMountDaemonRoot/default (0.00s)
15:53:56 [2019-10-22T15:53:56.324Z]         --- PASS: TestMountDaemonRoot/default/bind_subpath (0.09s)
15:53:56 [2019-10-22T15:53:56.324Z]         --- PASS: TestMountDaemonRoot/default/mount_root (0.10s)
15:53:56 [2019-10-22T15:53:56.324Z]         --- PASS: TestMountDaemonRoot/default/bind_root (0.10s)
15:53:56 [2019-10-22T15:53:56.324Z]         --- PASS: TestMountDaemonRoot/default/mount_subpath (0.11s)
15:53:56 [2019-10-22T15:53:56.324Z]     --- PASS: TestMountDaemonRoot/rslave (0.00s)
15:53:56 [2019-10-22T15:53:56.324Z]         --- PASS: TestMountDaemonRoot/rslave/mount_subpath (0.09s)
15:53:56 [2019-10-22T15:53:56.324Z]         --- PASS: TestMountDaemonRoot/rslave/bind_root (0.09s)
15:53:56 [2019-10-22T15:53:56.324Z]         --- PASS: TestMountDaemonRoot/rslave/mount_root (0.10s)
15:53:56 [2019-10-22T15:53:56.324Z]         --- PASS: TestMountDaemonRoot/rslave/bind_subpath (0.10s)
15:53:56 [2019-10-22T15:53:56.324Z]     --- PASS: TestMountDaemonRoot/rshared (0.00s)
15:53:56 [2019-10-22T15:53:56.324Z]         --- PASS: TestMountDaemonRoot/rshared/bind_root (0.10s)
15:53:56 [2019-10-22T15:53:56.324Z]         --- PASS: TestMountDaemonRoot/rshared/mount_root (0.10s)
15:53:56 [2019-10-22T15:53:56.324Z]         --- PASS: TestMountDaemonRoot/rshared/mount_subpath (0.12s)
15:53:56 [2019-10-22T15:53:56.324Z]         --- PASS: TestMountDaemonRoot/rshared/bind_subpath (0.11s)
15:53:56 [2019-10-22T15:53:56.324Z]     --- PASS: TestMountDaemonRoot/slave (0.00s)
15:53:56 [2019-10-22T15:53:56.324Z]         --- PASS: TestMountDaemonRoot/slave/bind_root (0.04s)
15:53:56 [2019-10-22T15:53:56.324Z]         --- PASS: TestMountDaemonRoot/slave/mount_subpath (0.05s)
15:53:56 [2019-10-22T15:53:56.324Z]         --- PASS: TestMountDaemonRoot/slave/mount_root (0.05s)
15:53:56 [2019-10-22T15:53:56.324Z]         --- PASS: TestMountDaemonRoot/slave/bind_subpath (0.05s)
15:53:56 [2019-10-22T15:53:56.324Z]     --- PASS: TestMountDaemonRoot/rprivate (0.00s)
15:53:56 [2019-10-22T15:53:56.324Z]         --- PASS: TestMountDaemonRoot/rprivate/mount_subpath (0.05s)
15:53:56 [2019-10-22T15:53:56.324Z]         --- PASS: TestMountDaemonRoot/rprivate/mount_root (0.05s)
15:53:56 [2019-10-22T15:53:56.324Z]         --- PASS: TestMountDaemonRoot/rprivate/bind_subpath (0.05s)
15:53:56 [2019-10-22T15:53:56.324Z]         --- PASS: TestMountDaemonRoot/rprivate/bind_root (0.08s)
15:53:56 [2019-10-22T15:53:56.324Z]     --- PASS: TestMountDaemonRoot/private (0.00s)
15:53:56 [2019-10-22T15:53:56.324Z]         --- PASS: TestMountDaemonRoot/private/bind_root (0.08s)
15:53:56 [2019-10-22T15:53:56.324Z]         --- PASS: TestMountDaemonRoot/private/mount_subpath (0.06s)
15:53:56 [2019-10-22T15:53:56.324Z]         --- PASS: TestMountDaemonRoot/private/mount_root (0.06s)
15:53:56 [2019-10-22T15:53:56.324Z]         --- PASS: TestMountDaemonRoot/private/bind_subpath (0.06s)
15:53:56 [2019-10-22T15:53:56.324Z]     --- PASS: TestMountDaemonRoot/shared (0.00s)
15:53:56 [2019-10-22T15:53:56.324Z]         --- PASS: TestMountDaemonRoot/shared/bind_root (0.07s)
15:53:56 [2019-10-22T15:53:56.324Z]         --- PASS: TestMountDaemonRoot/shared/mount_subpath (0.05s)
15:53:56 [2019-10-22T15:53:56.324Z]         --- PASS: TestMountDaemonRoot/shared/bind_subpath (0.07s)
15:53:56 [2019-10-22T15:53:56.324Z]         --- PASS: TestMountDaemonRoot/shared/mount_root (0.05s)
15:53:56 [2019-10-22T15:53:56.324Z] === RUN   TestContainerBindMountNonRecursive
15:53:58 [2019-10-22T15:53:58.858Z] --- PASS: TestContainerBindMountNonRecursive (2.12s)
15:53:58 [2019-10-22T15:53:58.858Z] === RUN   TestNetworkNat
15:53:59 [2019-10-22T15:53:59.426Z] --- PASS: TestNetworkNat (0.94s)
15:53:59 [2019-10-22T15:53:59.427Z] === RUN   TestNetworkLocalhostTCPNat
15:54:00 [2019-10-22T15:54:00.363Z] --- PASS: TestNetworkLocalhostTCPNat (0.91s)
15:54:00 [2019-10-22T15:54:00.363Z] === RUN   TestNetworkLoopbackNat
15:54:01 [2019-10-22T15:54:01.740Z] --- PASS: TestNetworkLoopbackNat (1.19s)
15:54:01 [2019-10-22T15:54:01.740Z] === RUN   TestPause
15:54:02 [2019-10-22T15:54:02.677Z] --- PASS: TestPause (0.95s)
15:54:02 [2019-10-22T15:54:02.677Z] === RUN   TestPauseFailsOnWindowsServerContainers
15:54:02 [2019-10-22T15:54:02.677Z] --- SKIP: TestPauseFailsOnWindowsServerContainers (0.00s)
15:54:02 [2019-10-22T15:54:02.677Z]     pause_test.go:54: testEnv.DaemonInfo.OSType != "windows" || testEnv.DaemonInfo.Isolation != "process"
15:54:02 [2019-10-22T15:54:02.677Z] === RUN   TestPauseStopPausedContainer
15:54:03 [2019-10-22T15:54:03.614Z] --- PASS: TestPauseStopPausedContainer (0.95s)
15:54:03 [2019-10-22T15:54:03.614Z] === RUN   TestPsFilter
15:54:03 [2019-10-22T15:54:03.614Z] --- PASS: TestPsFilter (0.28s)
15:54:03 [2019-10-22T15:54:03.614Z] === RUN   TestRemoveContainerWithRemovedVolume
15:54:04 [2019-10-22T15:54:04.551Z] --- PASS: TestRemoveContainerWithRemovedVolume (0.85s)
15:54:04 [2019-10-22T15:54:04.551Z] === RUN   TestRemoveContainerWithVolume
15:54:05 [2019-10-22T15:54:05.487Z] --- PASS: TestRemoveContainerWithVolume (0.78s)
15:54:05 [2019-10-22T15:54:05.487Z] === RUN   TestRemoveContainerRunning
15:54:06 [2019-10-22T15:54:06.423Z] --- PASS: TestRemoveContainerRunning (0.92s)
15:54:06 [2019-10-22T15:54:06.423Z] === RUN   TestRemoveContainerForceRemoveRunning
15:54:07 [2019-10-22T15:54:07.359Z] --- PASS: TestRemoveContainerForceRemoveRunning (0.96s)
15:54:07 [2019-10-22T15:54:07.359Z] === RUN   TestRemoveInvalidContainer
15:54:07 [2019-10-22T15:54:07.359Z] --- PASS: TestRemoveInvalidContainer (0.02s)
15:54:07 [2019-10-22T15:54:07.359Z] === RUN   TestRenameLinkedContainer
15:54:10 [2019-10-22T15:54:10.649Z] --- PASS: TestRenameLinkedContainer (3.36s)
15:54:10 [2019-10-22T15:54:10.649Z] === RUN   TestRenameStoppedContainer
15:54:11 [2019-10-22T15:54:11.585Z] --- PASS: TestRenameStoppedContainer (0.84s)
15:54:11 [2019-10-22T15:54:11.585Z] === RUN   TestRenameRunningContainerAndReuse
15:54:13 [2019-10-22T15:54:13.491Z] --- PASS: TestRenameRunningContainerAndReuse (1.71s)
15:54:13 [2019-10-22T15:54:13.491Z] === RUN   TestRenameInvalidName
15:54:14 [2019-10-22T15:54:14.058Z] --- PASS: TestRenameInvalidName (0.96s)
15:54:14 [2019-10-22T15:54:14.058Z] === RUN   TestRenameAnonymousContainer
15:54:18 [2019-10-22T15:54:18.247Z] --- PASS: TestRenameAnonymousContainer (3.99s)
15:54:18 [2019-10-22T15:54:18.247Z] === RUN   TestRenameContainerWithSameName
15:54:19 [2019-10-22T15:54:19.184Z] --- PASS: TestRenameContainerWithSameName (0.86s)
15:54:19 [2019-10-22T15:54:19.184Z] === RUN   TestRenameContainerWithLinkedContainer
15:54:20 [2019-10-22T15:54:20.561Z] --- PASS: TestRenameContainerWithLinkedContainer (1.70s)
15:54:20 [2019-10-22T15:54:20.561Z] === RUN   TestResize
15:54:21 [2019-10-22T15:54:21.497Z] --- PASS: TestResize (0.82s)
15:54:21 [2019-10-22T15:54:21.497Z] === RUN   TestResizeWithInvalidSize
15:54:22 [2019-10-22T15:54:22.434Z] --- PASS: TestResizeWithInvalidSize (0.88s)
15:54:22 [2019-10-22T15:54:22.434Z] === RUN   TestResizeWhenContainerNotStarted
15:54:23 [2019-10-22T15:54:23.370Z] --- PASS: TestResizeWhenContainerNotStarted (0.80s)
15:54:23 [2019-10-22T15:54:23.370Z] === RUN   TestDaemonRestartKillContainers
15:54:23 [2019-10-22T15:54:23.370Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
15:54:23 [2019-10-22T15:54:23.370Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
15:54:23 [2019-10-22T15:54:23.370Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
15:54:23 [2019-10-22T15:54:23.370Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
15:54:23 [2019-10-22T15:54:23.370Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
15:54:23 [2019-10-22T15:54:23.370Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
15:54:23 [2019-10-22T15:54:23.370Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
15:54:23 [2019-10-22T15:54:23.370Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
15:54:23 [2019-10-22T15:54:23.370Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
15:54:23 [2019-10-22T15:54:23.370Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
15:54:23 [2019-10-22T15:54:23.370Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
15:54:23 [2019-10-22T15:54:23.370Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
15:54:23 [2019-10-22T15:54:23.370Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
15:54:23 [2019-10-22T15:54:23.370Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
15:54:23 [2019-10-22T15:54:23.370Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
15:54:23 [2019-10-22T15:54:23.370Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
15:54:23 [2019-10-22T15:54:23.370Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
15:54:23 [2019-10-22T15:54:23.370Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
15:54:23 [2019-10-22T15:54:23.370Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
15:54:23 [2019-10-22T15:54:23.370Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
15:54:23 [2019-10-22T15:54:23.370Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
15:54:23 [2019-10-22T15:54:23.370Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
15:54:23 [2019-10-22T15:54:23.370Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
15:54:23 [2019-10-22T15:54:23.370Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
15:54:23 [2019-10-22T15:54:23.370Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
15:54:23 [2019-10-22T15:54:23.370Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
15:54:23 [2019-10-22T15:54:23.370Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
15:54:23 [2019-10-22T15:54:23.370Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
15:54:25 [2019-10-22T15:54:25.910Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
15:54:25 [2019-10-22T15:54:25.910Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
15:54:26 [2019-10-22T15:54:26.169Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
15:54:26 [2019-10-22T15:54:26.169Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
15:54:28 [2019-10-22T15:54:28.077Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
15:54:28 [2019-10-22T15:54:28.337Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
15:54:29 [2019-10-22T15:54:29.716Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
15:54:29 [2019-10-22T15:54:29.716Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
15:54:32 [2019-10-22T15:54:32.250Z] --- PASS: TestDaemonRestartKillContainers (0.00s)
15:54:32 [2019-10-22T15:54:32.250Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon (2.66s)
15:54:32 [2019-10-22T15:54:32.250Z]         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"
15:54:32 [2019-10-22T15:54:32.250Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon (2.86s)
15:54:32 [2019-10-22T15:54:32.250Z]         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"
15:54:32 [2019-10-22T15:54:32.250Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon (2.93s)
15:54:32 [2019-10-22T15:54:32.250Z]         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"
15:54:32 [2019-10-22T15:54:32.250Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon (2.98s)
15:54:32 [2019-10-22T15:54:32.250Z]         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"
15:54:32 [2019-10-22T15:54:32.250Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon (1.66s)
15:54:32 [2019-10-22T15:54:32.250Z]         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"
15:54:32 [2019-10-22T15:54:32.250Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon (2.66s)
15:54:32 [2019-10-22T15:54:32.250Z]         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"
15:54:32 [2019-10-22T15:54:32.250Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon (1.64s)
15:54:32 [2019-10-22T15:54:32.250Z]         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"
15:54:32 [2019-10-22T15:54:32.250Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon (3.57s)
15:54:32 [2019-10-22T15:54:32.250Z]         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"
15:54:32 [2019-10-22T15:54:32.250Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon (3.52s)
15:54:32 [2019-10-22T15:54:32.250Z]         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"
15:54:32 [2019-10-22T15:54:32.250Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon (1.57s)
15:54:32 [2019-10-22T15:54:32.250Z]         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"
15:54:32 [2019-10-22T15:54:32.250Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon (1.56s)
15:54:32 [2019-10-22T15:54:32.250Z]         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"
15:54:32 [2019-10-22T15:54:32.250Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon (2.30s)
15:54:32 [2019-10-22T15:54:32.250Z]         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"
15:54:32 [2019-10-22T15:54:32.250Z] === RUN   TestCgroupNamespacesRun
15:54:33 [2019-10-22T15:54:33.626Z] --- PASS: TestCgroupNamespacesRun (1.84s)
15:54:33 [2019-10-22T15:54:33.626Z]     run_cgroupns_linux_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRun"
15:54:33 [2019-10-22T15:54:33.626Z] === RUN   TestCgroupNamespacesRunPrivileged
15:54:35 [2019-10-22T15:54:35.532Z] --- PASS: TestCgroupNamespacesRunPrivileged (1.78s)
15:54:35 [2019-10-22T15:54:35.532Z]     run_cgroupns_linux_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunPrivileged"
15:54:35 [2019-10-22T15:54:35.532Z] === RUN   TestCgroupNamespacesRunDaemonHostMode
15:54:37 [2019-10-22T15:54:37.434Z] --- PASS: TestCgroupNamespacesRunDaemonHostMode (1.82s)
15:54:37 [2019-10-22T15:54:37.434Z]     run_cgroupns_linux_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunDaemonHostMode"
15:54:37 [2019-10-22T15:54:37.435Z] === RUN   TestCgroupNamespacesRunHostMode
15:54:39 [2019-10-22T15:54:39.338Z] --- PASS: TestCgroupNamespacesRunHostMode (1.84s)
15:54:39 [2019-10-22T15:54:39.338Z]     run_cgroupns_linux_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunHostMode"
15:54:39 [2019-10-22T15:54:39.338Z] === RUN   TestCgroupNamespacesRunPrivateMode
15:54:41 [2019-10-22T15:54:41.242Z] --- PASS: TestCgroupNamespacesRunPrivateMode (1.83s)
15:54:41 [2019-10-22T15:54:41.242Z]     run_cgroupns_linux_test.go:30: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunPrivateMode"
15:54:41 [2019-10-22T15:54:41.242Z] === RUN   TestCgroupNamespacesRunPrivilegedAndPrivate
15:54:41 [2019-10-22T15:54:41.810Z] --- PASS: TestCgroupNamespacesRunPrivilegedAndPrivate (0.91s)
15:54:41 [2019-10-22T15:54:41.810Z]     run_cgroupns_linux_test.go:48: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunPrivilegedAndPrivate"
15:54:41 [2019-10-22T15:54:41.810Z] === RUN   TestCgroupNamespacesRunInvalidMode
15:54:42 [2019-10-22T15:54:42.746Z] --- PASS: TestCgroupNamespacesRunInvalidMode (0.88s)
15:54:42 [2019-10-22T15:54:42.746Z]     run_cgroupns_linux_test.go:48: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunInvalidMode"
15:54:42 [2019-10-22T15:54:42.746Z] === RUN   TestCgroupNamespacesRunOlderClient
15:54:44 [2019-10-22T15:54:44.650Z] --- PASS: TestCgroupNamespacesRunOlderClient (1.85s)
15:54:44 [2019-10-22T15:54:44.650Z]     run_cgroupns_linux_test.go:139: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCgroupNamespacesRunOlderClient"
15:54:44 [2019-10-22T15:54:44.650Z] === RUN   TestKernelTCPMemory
15:54:45 [2019-10-22T15:54:45.586Z] --- PASS: TestKernelTCPMemory (0.98s)
15:54:45 [2019-10-22T15:54:45.586Z] === RUN   TestNISDomainname
15:54:46 [2019-10-22T15:54:46.962Z] --- PASS: TestNISDomainname (1.14s)
15:54:46 [2019-10-22T15:54:46.962Z] === RUN   TestHostnameDnsResolution
15:54:48 [2019-10-22T15:54:48.339Z] --- PASS: TestHostnameDnsResolution (1.71s)
15:54:48 [2019-10-22T15:54:48.339Z] === RUN   TestStats
15:54:50 [2019-10-22T15:54:50.870Z] --- PASS: TestStats (2.12s)
15:54:50 [2019-10-22T15:54:50.870Z] === RUN   TestStopContainerWithTimeout
15:54:50 [2019-10-22T15:54:50.870Z] === RUN   TestStopContainerWithTimeout/0
15:54:50 [2019-10-22T15:54:50.870Z] === PAUSE TestStopContainerWithTimeout/0
15:54:50 [2019-10-22T15:54:50.870Z] === RUN   TestStopContainerWithTimeout/1
15:54:50 [2019-10-22T15:54:50.870Z] === PAUSE TestStopContainerWithTimeout/1
15:54:50 [2019-10-22T15:54:50.870Z] === RUN   TestStopContainerWithTimeout/3
15:54:50 [2019-10-22T15:54:50.870Z] === PAUSE TestStopContainerWithTimeout/3
15:54:50 [2019-10-22T15:54:50.870Z] === RUN   TestStopContainerWithTimeout/-1
15:54:50 [2019-10-22T15:54:50.870Z] === PAUSE TestStopContainerWithTimeout/-1
15:54:50 [2019-10-22T15:54:50.870Z] === CONT  TestStopContainerWithTimeout/0
15:54:50 [2019-10-22T15:54:50.871Z] === CONT  TestStopContainerWithTimeout/1
15:54:50 [2019-10-22T15:54:50.871Z] === CONT  TestStopContainerWithTimeout/3
15:54:50 [2019-10-22T15:54:50.871Z] === CONT  TestStopContainerWithTimeout/-1
15:54:54 [2019-10-22T15:54:54.156Z] --- PASS: TestStopContainerWithTimeout (0.02s)
15:54:54 [2019-10-22T15:54:54.156Z]     --- PASS: TestStopContainerWithTimeout/0 (1.39s)
15:54:54 [2019-10-22T15:54:54.156Z]     --- PASS: TestStopContainerWithTimeout/1 (2.10s)
15:54:54 [2019-10-22T15:54:54.156Z]     --- PASS: TestStopContainerWithTimeout/-1 (3.12s)
15:54:54 [2019-10-22T15:54:54.156Z]     --- PASS: TestStopContainerWithTimeout/3 (3.33s)
15:54:54 [2019-10-22T15:54:54.156Z] === RUN   TestDeleteDevicemapper
15:54:54 [2019-10-22T15:54:54.156Z] --- SKIP: TestDeleteDevicemapper (0.00s)
15:54:54 [2019-10-22T15:54:54.156Z]     stop_linux_test.go:74: testEnv.DaemonInfo.Driver != "devicemapper"
15:54:54 [2019-10-22T15:54:54.156Z] === RUN   TestStopContainerWithRestartPolicyAlways
15:54:56 [2019-10-22T15:54:56.059Z] --- PASS: TestStopContainerWithRestartPolicyAlways (2.14s)
15:54:56 [2019-10-22T15:54:56.059Z] === RUN   TestUpdateMemory
15:54:56 [2019-10-22T15:54:56.059Z] --- SKIP: TestUpdateMemory (0.00s)
15:54:56 [2019-10-22T15:54:56.059Z]     update_linux_test.go:23: !testEnv.DaemonInfo.SwapLimit
15:54:56 [2019-10-22T15:54:56.059Z] === RUN   TestUpdateCPUQuota
15:54:57 [2019-10-22T15:54:57.962Z] --- PASS: TestUpdateCPUQuota (1.79s)
15:54:57 [2019-10-22T15:54:57.962Z] === RUN   TestUpdatePidsLimit
15:54:57 [2019-10-22T15:54:57.962Z] === RUN   TestUpdatePidsLimit/update_from_none
15:54:58 [2019-10-22T15:54:58.220Z] === RUN   TestUpdatePidsLimit/no_change
15:54:58 [2019-10-22T15:54:58.787Z] === RUN   TestUpdatePidsLimit/update_lower
15:54:59 [2019-10-22T15:54:59.354Z] === RUN   TestUpdatePidsLimit/update_on_old_api_ignores_value
15:54:59 [2019-10-22T15:54:59.922Z] === RUN   TestUpdatePidsLimit/unset_limit_with_zero
15:55:00 [2019-10-22T15:55:00.180Z] === RUN   TestUpdatePidsLimit/unset_limit_with_minus_one
15:55:00 [2019-10-22T15:55:00.748Z] === RUN   TestUpdatePidsLimit/unset_limit_with_minus_two
15:55:02 [2019-10-22T15:55:02.652Z] --- PASS: TestUpdatePidsLimit (4.65s)
15:55:02 [2019-10-22T15:55:02.652Z]     --- PASS: TestUpdatePidsLimit/update_from_none (0.45s)
15:55:02 [2019-10-22T15:55:02.652Z]     --- PASS: TestUpdatePidsLimit/no_change (0.48s)
15:55:02 [2019-10-22T15:55:02.652Z]     --- PASS: TestUpdatePidsLimit/update_lower (0.44s)
15:55:02 [2019-10-22T15:55:02.652Z]     --- PASS: TestUpdatePidsLimit/update_on_old_api_ignores_value (0.49s)
15:55:02 [2019-10-22T15:55:02.652Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_zero (0.46s)
15:55:02 [2019-10-22T15:55:02.652Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_minus_one (0.44s)
15:55:02 [2019-10-22T15:55:02.652Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_minus_two (0.45s)
15:55:02 [2019-10-22T15:55:02.652Z] === RUN   TestUpdateRestartPolicy
15:55:17 [2019-10-22T15:55:17.529Z] --- PASS: TestUpdateRestartPolicy (12.64s)
15:55:17 [2019-10-22T15:55:17.529Z] === RUN   TestUpdateRestartWithAutoRemove
15:55:17 [2019-10-22T15:55:17.529Z] --- PASS: TestUpdateRestartWithAutoRemove (0.87s)
15:55:17 [2019-10-22T15:55:17.529Z] === RUN   TestWaitNonBlocked
15:55:17 [2019-10-22T15:55:17.529Z] === RUN   TestWaitNonBlocked/wait-nonblocking-exit-0
15:55:17 [2019-10-22T15:55:17.529Z] === PAUSE TestWaitNonBlocked/wait-nonblocking-exit-0
15:55:17 [2019-10-22T15:55:17.529Z] === RUN   TestWaitNonBlocked/wait-nonblocking-exit-random
15:55:17 [2019-10-22T15:55:17.529Z] === PAUSE TestWaitNonBlocked/wait-nonblocking-exit-random
15:55:17 [2019-10-22T15:55:17.529Z] === CONT  TestWaitNonBlocked/wait-nonblocking-exit-0
15:55:17 [2019-10-22T15:55:17.529Z] === CONT  TestWaitNonBlocked/wait-nonblocking-exit-random
15:55:17 [2019-10-22T15:55:17.529Z] --- PASS: TestWaitNonBlocked (0.03s)
15:55:17 [2019-10-22T15:55:17.529Z]     --- PASS: TestWaitNonBlocked/wait-nonblocking-exit-random (1.03s)
15:55:17 [2019-10-22T15:55:17.529Z]     --- PASS: TestWaitNonBlocked/wait-nonblocking-exit-0 (1.09s)
15:55:17 [2019-10-22T15:55:17.529Z] === RUN   TestWaitBlocked
15:55:17 [2019-10-22T15:55:17.529Z] === RUN   TestWaitBlocked/test-wait-blocked-exit-zero
15:55:17 [2019-10-22T15:55:17.529Z] === PAUSE TestWaitBlocked/test-wait-blocked-exit-zero
15:55:17 [2019-10-22T15:55:17.529Z] === RUN   TestWaitBlocked/test-wait-blocked-exit-random
15:55:17 [2019-10-22T15:55:17.529Z] === PAUSE TestWaitBlocked/test-wait-blocked-exit-random
15:55:17 [2019-10-22T15:55:17.529Z] === CONT  TestWaitBlocked/test-wait-blocked-exit-zero
15:55:17 [2019-10-22T15:55:17.529Z] === CONT  TestWaitBlocked/test-wait-blocked-exit-random
15:55:18 [2019-10-22T15:55:18.466Z] --- PASS: TestWaitBlocked (0.03s)
15:55:18 [2019-10-22T15:55:18.466Z]     --- PASS: TestWaitBlocked/test-wait-blocked-exit-random (1.11s)
15:55:18 [2019-10-22T15:55:18.466Z]     --- PASS: TestWaitBlocked/test-wait-blocked-exit-zero (1.16s)
15:55:18 [2019-10-22T15:55:18.466Z] === CONT  TestContainerStartOnDaemonRestart
15:55:18 [2019-10-22T15:55:18.466Z] === CONT  TestIpcModeOlderClient
15:55:18 [2019-10-22T15:55:18.466Z] === CONT  TestDaemonRestartIpcMode
15:55:18 [2019-10-22T15:55:18.466Z] --- PASS: TestIpcModeOlderClient (0.19s)
15:55:21 [2019-10-22T15:55:21.759Z] --- PASS: TestContainerStartOnDaemonRestart (3.03s)
15:55:21 [2019-10-22T15:55:21.759Z]     daemon_linux_test.go:35: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestContainerStartOnDaemonRestart"
15:55:22 [2019-10-22T15:55:22.018Z] --- PASS: TestDaemonRestartIpcMode (3.77s)
15:55:22 [2019-10-22T15:55:22.018Z]     daemon_linux_test.go:89: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartIpcMode"
15:55:22 [2019-10-22T15:55:22.018Z] PASS
15:55:22 [2019-10-22T15:55:22.018Z] 
15:55:22 [2019-10-22T15:55:22.018Z] === Skipped
15:55:22 [2019-10-22T15:55:22.018Z] === SKIP: arm64.integration.container TestCheckpoint (0.00s)
15:55:22 [2019-10-22T15:55:22.018Z]     checkpoint_test.go:33: TestCheckpoint is broken; see https://github.com/moby/moby/issues/38963
15:55:22 [2019-10-22T15:55:22.018Z] 
15:55:22 [2019-10-22T15:55:22.018Z] === SKIP: arm64.integration.container TestInspectOomKilledTrue (0.00s)
15:55:22 [2019-10-22T15:55:22.018Z]     kill_test.go:151: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
15:55:22 [2019-10-22T15:55:22.018Z] 
15:55:22 [2019-10-22T15:55:22.018Z] === SKIP: arm64.integration.container TestInspectOomKilledFalse (0.00s)
15:55:22 [2019-10-22T15:55:22.018Z]     kill_test.go:169: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
15:55:22 [2019-10-22T15:55:22.018Z] 
15:55:22 [2019-10-22T15:55:22.018Z] === SKIP: arm64.integration.container TestPauseFailsOnWindowsServerContainers (0.00s)
15:55:22 [2019-10-22T15:55:22.018Z]     pause_test.go:54: testEnv.DaemonInfo.OSType != "windows" || testEnv.DaemonInfo.Isolation != "process"
15:55:22 [2019-10-22T15:55:22.018Z] 
15:55:22 [2019-10-22T15:55:22.018Z] === SKIP: arm64.integration.container TestDeleteDevicemapper (0.00s)
15:55:22 [2019-10-22T15:55:22.018Z]     stop_linux_test.go:74: testEnv.DaemonInfo.Driver != "devicemapper"
15:55:22 [2019-10-22T15:55:22.018Z] 
15:55:22 [2019-10-22T15:55:22.018Z] === SKIP: arm64.integration.container TestUpdateMemory (0.00s)
15:55:22 [2019-10-22T15:55:22.018Z]     update_linux_test.go:23: !testEnv.DaemonInfo.SwapLimit
15:55:22 [2019-10-22T15:55:22.018Z] 
15:55:22 [2019-10-22T15:55:22.018Z] 
15:55:22 [2019-10-22T15:55:22.018Z] DONE 197 tests, 6 skipped in 131.759s
15:55:22 [2019-10-22T15:55:22.018Z] Running /go/src/github.com/docker/docker/integration/image (arm64.integration.image) flags=-test.v -test.timeout=120m 
15:55:22 [2019-10-22T15:55:22.018Z] ++ 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
15:55:22 [2019-10-22T15:55:22.018Z] ++ set -e
15:55:22 [2019-10-22T15:55:22.018Z] ++ '[' -n 0 ']'
15:55:22 [2019-10-22T15:55:22.018Z] ++ set -x
15:55:22 [2019-10-22T15:55:22.018Z] ++ 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
15:55:22 [2019-10-22T15:55:22.596Z] INFO: Testing against a local daemon
15:55:22 [2019-10-22T15:55:22.596Z] === RUN   TestCommitInheritsEnv
15:55:23 [2019-10-22T15:55:23.163Z] --- PASS: TestCommitInheritsEnv (0.61s)
15:55:23 [2019-10-22T15:55:23.163Z] === RUN   TestImportExtremelyLargeImageWorks
15:55:23 [2019-10-22T15:55:23.163Z] --- SKIP: TestImportExtremelyLargeImageWorks (0.00s)
15:55:23 [2019-10-22T15:55:23.163Z]     import_test.go:21: runtime.GOARCH == "arm64": effective test will be time out
15:55:23 [2019-10-22T15:55:23.163Z] === RUN   TestImagesFilterMultiReference
15:55:23 [2019-10-22T15:55:23.163Z] --- PASS: TestImagesFilterMultiReference (0.10s)
15:55:23 [2019-10-22T15:55:23.163Z] === RUN   TestImagePullPlatformInvalid
15:55:23 [2019-10-22T15:55:23.163Z] --- PASS: TestImagePullPlatformInvalid (0.05s)
15:55:23 [2019-10-22T15:55:23.163Z] === RUN   TestRemoveImageOrphaning
15:55:23 [2019-10-22T15:55:23.731Z] --- PASS: TestRemoveImageOrphaning (0.56s)
15:55:23 [2019-10-22T15:55:23.731Z] === RUN   TestRemoveImageGarbageCollector
15:55:23 [2019-10-22T15:55:23.731Z] --- SKIP: TestRemoveImageGarbageCollector (0.00s)
15:55:23 [2019-10-22T15:55:23.731Z]     remove_unix_test.go:36: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
15:55:23 [2019-10-22T15:55:23.731Z] === RUN   TestTagUnprefixedRepoByNameOrName
15:55:23 [2019-10-22T15:55:23.731Z] --- PASS: TestTagUnprefixedRepoByNameOrName (0.05s)
15:55:23 [2019-10-22T15:55:23.731Z] === RUN   TestTagInvalidReference
15:55:23 [2019-10-22T15:55:23.731Z] --- PASS: TestTagInvalidReference (0.03s)
15:55:23 [2019-10-22T15:55:23.731Z] === RUN   TestTagValidPrefixedRepo
15:55:23 [2019-10-22T15:55:23.991Z] --- PASS: TestTagValidPrefixedRepo (0.10s)
15:55:23 [2019-10-22T15:55:23.991Z] === RUN   TestTagExistedNameWithoutForce
15:55:23 [2019-10-22T15:55:23.991Z] --- PASS: TestTagExistedNameWithoutForce (0.04s)
15:55:23 [2019-10-22T15:55:23.991Z] === RUN   TestTagOfficialNames
15:55:23 [2019-10-22T15:55:23.991Z] --- PASS: TestTagOfficialNames (0.08s)
15:55:23 [2019-10-22T15:55:23.991Z] === RUN   TestTagMatchesDigest
15:55:23 [2019-10-22T15:55:23.991Z] --- PASS: TestTagMatchesDigest (0.03s)
15:55:23 [2019-10-22T15:55:23.991Z] PASS
15:55:23 [2019-10-22T15:55:23.991Z] 
15:55:23 [2019-10-22T15:55:23.991Z] === Skipped
15:55:23 [2019-10-22T15:55:23.991Z] === SKIP: arm64.integration.image TestImportExtremelyLargeImageWorks (0.00s)
15:55:23 [2019-10-22T15:55:23.991Z]     import_test.go:21: runtime.GOARCH == "arm64": effective test will be time out
15:55:23 [2019-10-22T15:55:23.991Z] 
15:55:23 [2019-10-22T15:55:23.991Z] === SKIP: arm64.integration.image TestRemoveImageGarbageCollector (0.00s)
15:55:23 [2019-10-22T15:55:23.991Z]     remove_unix_test.go:36: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
15:55:23 [2019-10-22T15:55:23.991Z] 
15:55:23 [2019-10-22T15:55:23.991Z] 
15:55:23 [2019-10-22T15:55:23.991Z] DONE 12 tests, 2 skipped in 1.950s
15:55:23 [2019-10-22T15:55:23.991Z] Running /go/src/github.com/docker/docker/integration/network (arm64.integration.network) flags=-test.v -test.timeout=120m 
15:55:23 [2019-10-22T15:55:23.991Z] ++ 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
15:55:23 [2019-10-22T15:55:23.991Z] ++ set -e
15:55:23 [2019-10-22T15:55:23.991Z] ++ '[' -n 0 ']'
15:55:23 [2019-10-22T15:55:23.991Z] ++ set -x
15:55:23 [2019-10-22T15:55:23.991Z] ++ 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
15:55:24 [2019-10-22T15:55:24.249Z] INFO: Testing against a local daemon
15:55:24 [2019-10-22T15:55:24.250Z] === RUN   TestNetworkCreateDelete
15:55:24 [2019-10-22T15:55:24.817Z] --- PASS: TestNetworkCreateDelete (0.37s)
15:55:24 [2019-10-22T15:55:24.818Z] === RUN   TestDockerNetworkDeletePreferID
15:55:25 [2019-10-22T15:55:25.753Z] --- PASS: TestDockerNetworkDeletePreferID (1.06s)
15:55:25 [2019-10-22T15:55:25.754Z] === RUN   TestInspectNetwork
15:55:32 [2019-10-22T15:55:32.316Z] === RUN   TestInspectNetwork/full_network_id
15:55:32 [2019-10-22T15:55:32.316Z] === RUN   TestInspectNetwork/partial_network_id
15:55:32 [2019-10-22T15:55:32.316Z] === RUN   TestInspectNetwork/network_name
15:55:32 [2019-10-22T15:55:32.316Z] === RUN   TestInspectNetwork/network_name_and_swarm_scope
15:55:36 [2019-10-22T15:55:36.502Z] --- PASS: TestInspectNetwork (10.81s)
15:55:36 [2019-10-22T15:55:36.502Z]     inspect_test.go:18: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestInspectNetwork"
15:55:36 [2019-10-22T15:55:36.502Z]     --- PASS: TestInspectNetwork/full_network_id (0.00s)
15:55:36 [2019-10-22T15:55:36.502Z]     --- PASS: TestInspectNetwork/partial_network_id (0.00s)
15:55:36 [2019-10-22T15:55:36.502Z]     --- PASS: TestInspectNetwork/network_name (0.00s)
15:55:36 [2019-10-22T15:55:36.502Z]     --- PASS: TestInspectNetwork/network_name_and_swarm_scope (0.00s)
15:55:36 [2019-10-22T15:55:36.502Z] === RUN   TestRunContainerWithBridgeNone
15:55:39 [2019-10-22T15:55:39.788Z] --- PASS: TestRunContainerWithBridgeNone (2.93s)
15:55:39 [2019-10-22T15:55:39.788Z]     network_test.go:25: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestRunContainerWithBridgeNone"
15:55:39 [2019-10-22T15:55:39.788Z] === RUN   TestNetworkInvalidJSON
15:55:39 [2019-10-22T15:55:39.788Z] === RUN   TestNetworkInvalidJSON//networks/create
15:55:39 [2019-10-22T15:55:39.788Z] === PAUSE TestNetworkInvalidJSON//networks/create
15:55:39 [2019-10-22T15:55:39.788Z] === RUN   TestNetworkInvalidJSON//networks/bridge/connect
15:55:39 [2019-10-22T15:55:39.788Z] === PAUSE TestNetworkInvalidJSON//networks/bridge/connect
15:55:39 [2019-10-22T15:55:39.788Z] === RUN   TestNetworkInvalidJSON//networks/bridge/disconnect
15:55:39 [2019-10-22T15:55:39.788Z] === PAUSE TestNetworkInvalidJSON//networks/bridge/disconnect
15:55:39 [2019-10-22T15:55:39.788Z] === CONT  TestNetworkInvalidJSON//networks/create
15:55:39 [2019-10-22T15:55:39.788Z] === CONT  TestNetworkInvalidJSON//networks/bridge/disconnect
15:55:39 [2019-10-22T15:55:39.788Z] === CONT  TestNetworkInvalidJSON//networks/bridge/connect
15:55:39 [2019-10-22T15:55:39.788Z] --- PASS: TestNetworkInvalidJSON (0.04s)
15:55:39 [2019-10-22T15:55:39.788Z]     --- PASS: TestNetworkInvalidJSON//networks/bridge/connect (0.01s)
15:55:39 [2019-10-22T15:55:39.788Z]     --- PASS: TestNetworkInvalidJSON//networks/bridge/disconnect (0.01s)
15:55:39 [2019-10-22T15:55:39.788Z]     --- PASS: TestNetworkInvalidJSON//networks/create (0.01s)
15:55:39 [2019-10-22T15:55:39.788Z] === RUN   TestDaemonRestartWithLiveRestore
15:55:41 [2019-10-22T15:55:41.165Z] --- PASS: TestDaemonRestartWithLiveRestore (1.38s)
15:55:41 [2019-10-22T15:55:41.165Z]     service_test.go:32: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartWithLiveRestore"
15:55:41 [2019-10-22T15:55:41.165Z] === RUN   TestDaemonDefaultNetworkPools
15:55:42 [2019-10-22T15:55:42.101Z] --- PASS: TestDaemonDefaultNetworkPools (1.09s)
15:55:42 [2019-10-22T15:55:42.101Z]     service_test.go:57: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonDefaultNetworkPools"
15:55:42 [2019-10-22T15:55:42.101Z] === RUN   TestDaemonRestartWithExistingNetwork
15:55:44 [2019-10-22T15:55:44.005Z] --- PASS: TestDaemonRestartWithExistingNetwork (1.72s)
15:55:44 [2019-10-22T15:55:44.005Z]     service_test.go:98: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartWithExistingNetwork"
15:55:44 [2019-10-22T15:55:44.005Z] === RUN   TestDaemonRestartWithExistingNetworkWithDefaultPoolRange
15:55:45 [2019-10-22T15:55:45.963Z] --- PASS: TestDaemonRestartWithExistingNetworkWithDefaultPoolRange (2.04s)
15:55:45 [2019-10-22T15:55:45.963Z]     service_test.go:131: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartWithExistingNetworkWithDefaultPoolRange"
15:55:45 [2019-10-22T15:55:45.963Z] === RUN   TestDaemonWithBipAndDefaultNetworkPool
15:55:46 [2019-10-22T15:55:46.530Z] --- PASS: TestDaemonWithBipAndDefaultNetworkPool (0.70s)
15:55:46 [2019-10-22T15:55:46.531Z]     service_test.go:181: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonWithBipAndDefaultNetworkPool"
15:55:46 [2019-10-22T15:55:46.531Z] === RUN   TestServiceWithPredefinedNetwork
15:55:49 [2019-10-22T15:55:49.816Z] --- PASS: TestServiceWithPredefinedNetwork (3.31s)
15:55:49 [2019-10-22T15:55:49.816Z]     service_test.go:203: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithPredefinedNetwork"
15:55:49 [2019-10-22T15:55:49.816Z] === RUN   TestServiceRemoveKeepsIngressNetwork
15:55:49 [2019-10-22T15:55:49.816Z] --- SKIP: TestServiceRemoveKeepsIngressNetwork (0.00s)
15:55:49 [2019-10-22T15:55:49.816Z]     service_test.go:230: FLAKY_TEST
15:55:49 [2019-10-22T15:55:49.816Z] === RUN   TestServiceWithDataPathPortInit
15:56:11 [2019-10-22T15:56:11.743Z] --- PASS: TestServiceWithDataPathPortInit (19.68s)
15:56:11 [2019-10-22T15:56:11.743Z]     service_test.go:323: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithDataPathPortInit"
15:56:11 [2019-10-22T15:56:11.743Z]     service_test.go:355: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithDataPathPortInit"
15:56:11 [2019-10-22T15:56:11.743Z] === RUN   TestServiceWithDefaultAddressPoolInit
15:56:19 [2019-10-22T15:56:19.855Z] --- PASS: TestServiceWithDefaultAddressPoolInit (9.76s)
15:56:19 [2019-10-22T15:56:19.855Z]     service_test.go:388: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithDefaultAddressPoolInit"
15:56:19 [2019-10-22T15:56:19.855Z]     service_test.go:418: TestServiceWithDefaultAddressPoolInit: NetworkInspect: {Name:sthiraTestServiceWithDefaultAddressPoolInit ID:vfaypw0v5lum24r2q90jwsy8w Created:2019-10-22 15:56:11.042218482 +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[652bdd7c3bf84ad54abefe2705d401a5a204992163ebc7de38851d66f6d2f7a1:{Name:TestServiceTestServiceWithDefaultAddressPoolInit.1.obhpuwa8zeie7vj8trc3slgfb EndpointID:1807bf91e1c2e91384760f8a8f55d48a8140341097a5bf7d3b5d18403f026ed4 MacAddress:02:42:14:14:00:03 IPv4Address:20.20.0.3/24 IPv6Address:} lb-sthiraTestServiceWithDefaultAddressPoolInit:{Name:sthiraTestServiceWithDefaultAddressPoolInit-endpoint EndpointID:2b16b3376ceeaa9187a86ad688a92df4213a9898f33e0bb59e873c13c872815e 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:27e00a589907 IP:127.0.0.1}] Services:map[TestServiceTestServiceWithDefaultAddressPoolInit:{VIP:20.20.0.2 Ports:[] LocalLBIndex:256 Tasks:[{Name:TestServiceTestServiceWithDefaultAddressPoolInit.1.obhpuwa8zeie7vj8trc3slgfb EndpointID:1807bf91e1c2e91384760f8a8f55d48a8140341097a5bf7d3b5d18403f026ed4 EndpointIP:20.20.0.3 Info:map[Host IP:127.0.0.1]}]}]}
15:56:19 [2019-10-22T15:56:19.855Z] PASS
15:56:19 [2019-10-22T15:56:19.855Z] 
15:56:19 [2019-10-22T15:56:19.855Z] === Skipped
15:56:19 [2019-10-22T15:56:19.855Z] === SKIP: arm64.integration.network TestServiceRemoveKeepsIngressNetwork (0.00s)
15:56:19 [2019-10-22T15:56:19.855Z]     service_test.go:230: FLAKY_TEST
15:56:19 [2019-10-22T15:56:19.855Z] 
15:56:19 [2019-10-22T15:56:19.855Z] 
15:56:19 [2019-10-22T15:56:19.855Z] DONE 21 tests, 1 skipped in 55.064s
15:56:19 [2019-10-22T15:56:19.855Z] Running /go/src/github.com/docker/docker/integration/network/ipvlan (arm64.integration.network.ipvlan) flags=-test.v -test.timeout=120m 
15:56:19 [2019-10-22T15:56:19.855Z] ++ 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
15:56:19 [2019-10-22T15:56:19.855Z] ++ set -e
15:56:19 [2019-10-22T15:56:19.855Z] ++ '[' -n 0 ']'
15:56:19 [2019-10-22T15:56:19.855Z] ++ set -x
15:56:19 [2019-10-22T15:56:19.855Z] ++ 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
15:56:19 [2019-10-22T15:56:19.855Z] INFO: Testing against a local daemon
15:56:19 [2019-10-22T15:56:19.855Z] === RUN   TestDockerNetworkIpvlanPersistance
15:56:19 [2019-10-22T15:56:19.855Z] --- SKIP: TestDockerNetworkIpvlanPersistance (0.00s)
15:56:19 [2019-10-22T15:56:19.855Z]     ipvlan_test.go:26: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
15:56:19 [2019-10-22T15:56:19.855Z] === RUN   TestDockerNetworkIpvlan
15:56:19 [2019-10-22T15:56:19.855Z] --- SKIP: TestDockerNetworkIpvlan (0.00s)
15:56:19 [2019-10-22T15:56:19.855Z]     ipvlan_test.go:53: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
15:56:19 [2019-10-22T15:56:19.855Z] PASS
15:56:19 [2019-10-22T15:56:19.855Z] 
15:56:19 [2019-10-22T15:56:19.855Z] === Skipped
15:56:19 [2019-10-22T15:56:19.855Z] === SKIP: arm64.integration.network.ipvlan TestDockerNetworkIpvlanPersistance (0.00s)
15:56:19 [2019-10-22T15:56:19.855Z]     ipvlan_test.go:26: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
15:56:19 [2019-10-22T15:56:19.855Z] 
15:56:19 [2019-10-22T15:56:19.855Z] === SKIP: arm64.integration.network.ipvlan TestDockerNetworkIpvlan (0.00s)
15:56:19 [2019-10-22T15:56:19.855Z]     ipvlan_test.go:53: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
15:56:19 [2019-10-22T15:56:19.855Z] 
15:56:19 [2019-10-22T15:56:19.855Z] 
15:56:19 [2019-10-22T15:56:19.855Z] DONE 2 tests, 2 skipped in 0.225s
15:56:19 [2019-10-22T15:56:19.855Z] Running /go/src/github.com/docker/docker/integration/network/macvlan (arm64.integration.network.macvlan) flags=-test.v -test.timeout=120m 
15:56:19 [2019-10-22T15:56:19.855Z] ++ 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
15:56:19 [2019-10-22T15:56:19.855Z] ++ set -e
15:56:19 [2019-10-22T15:56:19.855Z] ++ '[' -n 0 ']'
15:56:19 [2019-10-22T15:56:19.855Z] ++ set -x
15:56:19 [2019-10-22T15:56:19.855Z] ++ 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
15:56:19 [2019-10-22T15:56:19.855Z] INFO: Testing against a local daemon
15:56:19 [2019-10-22T15:56:19.855Z] === RUN   TestDockerNetworkMacvlanPersistance
15:56:21 [2019-10-22T15:56:21.759Z] --- PASS: TestDockerNetworkMacvlanPersistance (1.85s)
15:56:21 [2019-10-22T15:56:21.759Z]     macvlan_test.go:24: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlanPersistance"
15:56:21 [2019-10-22T15:56:21.759Z] === RUN   TestDockerNetworkMacvlan
15:56:22 [2019-10-22T15:56:22.326Z] === RUN   TestDockerNetworkMacvlan/Subinterface
15:56:23 [2019-10-22T15:56:23.703Z] === RUN   TestDockerNetworkMacvlan/OverlapParent
15:56:24 [2019-10-22T15:56:24.639Z] === RUN   TestDockerNetworkMacvlan/NilParent
15:56:27 [2019-10-22T15:56:27.926Z] === RUN   TestDockerNetworkMacvlan/InternalMode
15:56:32 [2019-10-22T15:56:32.114Z] === RUN   TestDockerNetworkMacvlan/MultiSubnet
15:56:38 [2019-10-22T15:56:38.679Z] === RUN   TestDockerNetworkMacvlan/Addressing
15:56:40 [2019-10-22T15:56:40.581Z] --- PASS: TestDockerNetworkMacvlan (18.98s)
15:56:40 [2019-10-22T15:56:40.581Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
15:56:40 [2019-10-22T15:56:40.581Z]     --- PASS: TestDockerNetworkMacvlan/Subinterface (0.09s)
15:56:40 [2019-10-22T15:56:40.581Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
15:56:40 [2019-10-22T15:56:40.581Z]     --- PASS: TestDockerNetworkMacvlan/OverlapParent (0.14s)
15:56:40 [2019-10-22T15:56:40.581Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
15:56:40 [2019-10-22T15:56:40.581Z]     --- PASS: TestDockerNetworkMacvlan/NilParent (1.97s)
15:56:40 [2019-10-22T15:56:40.581Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
15:56:40 [2019-10-22T15:56:40.581Z]     --- PASS: TestDockerNetworkMacvlan/InternalMode (3.01s)
15:56:40 [2019-10-22T15:56:40.581Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
15:56:40 [2019-10-22T15:56:40.581Z]     --- PASS: TestDockerNetworkMacvlan/MultiSubnet (4.82s)
15:56:40 [2019-10-22T15:56:40.581Z]     macvlan_test.go:70: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan"
15:56:40 [2019-10-22T15:56:40.581Z]     --- PASS: TestDockerNetworkMacvlan/Addressing (1.33s)
15:56:40 [2019-10-22T15:56:40.581Z] PASS
15:56:40 [2019-10-22T15:56:40.581Z] 
15:56:40 [2019-10-22T15:56:40.581Z] DONE 8 tests in 20.980s
15:56:40 [2019-10-22T15:56:40.581Z] Running /go/src/github.com/docker/docker/integration/plugin (arm64.integration.plugin) flags=-test.v -test.timeout=120m 
15:56:40 [2019-10-22T15:56:40.581Z] ++ 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
15:56:40 [2019-10-22T15:56:40.581Z] ++ set -e
15:56:40 [2019-10-22T15:56:40.581Z] ++ '[' -n 0 ']'
15:56:40 [2019-10-22T15:56:40.581Z] ++ set -x
15:56:40 [2019-10-22T15:56:40.581Z] ++ 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
15:56:40 [2019-10-22T15:56:40.581Z] testing: warning: no tests to run
15:56:40 [2019-10-22T15:56:40.581Z] PASS
15:56:40 [2019-10-22T15:56:40.581Z] 
15:56:40 [2019-10-22T15:56:40.581Z] DONE 0 tests in 0.061s
15:56:40 [2019-10-22T15:56:40.581Z] Running /go/src/github.com/docker/docker/integration/plugin/authz (arm64.integration.plugin.authz) flags=-test.v -test.timeout=120m 
15:56:40 [2019-10-22T15:56:40.581Z] ++ 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
15:56:40 [2019-10-22T15:56:40.581Z] ++ set -e
15:56:40 [2019-10-22T15:56:40.581Z] ++ '[' -n 0 ']'
15:56:40 [2019-10-22T15:56:40.581Z] ++ set -x
15:56:40 [2019-10-22T15:56:40.581Z] ++ 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
15:56:40 [2019-10-22T15:56:40.840Z] INFO: Testing against a local daemon
15:56:40 [2019-10-22T15:56:40.840Z] === RUN   TestAuthZPluginAllowRequest
15:56:42 [2019-10-22T15:56:42.746Z] --- PASS: TestAuthZPluginAllowRequest (1.75s)
15:56:42 [2019-10-22T15:56:42.746Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginAllowRequest"
15:56:42 [2019-10-22T15:56:42.746Z] === RUN   TestAuthZPluginTLS
15:56:43 [2019-10-22T15:56:43.313Z] --- PASS: TestAuthZPluginTLS (0.62s)
15:56:43 [2019-10-22T15:56:43.313Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginTLS"
15:56:43 [2019-10-22T15:56:43.313Z] === RUN   TestAuthZPluginDenyRequest
15:56:43 [2019-10-22T15:56:43.880Z] --- PASS: TestAuthZPluginDenyRequest (0.57s)
15:56:43 [2019-10-22T15:56:43.880Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginDenyRequest"
15:56:43 [2019-10-22T15:56:43.880Z] === RUN   TestAuthZPluginAPIDenyResponse
15:56:44 [2019-10-22T15:56:44.447Z] --- PASS: TestAuthZPluginAPIDenyResponse (0.58s)
15:56:44 [2019-10-22T15:56:44.447Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginAPIDenyResponse"
15:56:44 [2019-10-22T15:56:44.447Z] === RUN   TestAuthZPluginDenyResponse
15:56:45 [2019-10-22T15:56:45.015Z] --- PASS: TestAuthZPluginDenyResponse (0.59s)
15:56:45 [2019-10-22T15:56:45.015Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginDenyResponse"
15:56:45 [2019-10-22T15:56:45.015Z] === RUN   TestAuthZPluginAllowEventStream
15:56:46 [2019-10-22T15:56:46.917Z] --- PASS: TestAuthZPluginAllowEventStream (1.69s)
15:56:46 [2019-10-22T15:56:46.917Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginAllowEventStream"
15:56:46 [2019-10-22T15:56:46.917Z] === RUN   TestAuthZPluginErrorResponse
15:56:47 [2019-10-22T15:56:47.176Z] --- PASS: TestAuthZPluginErrorResponse (0.58s)
15:56:47 [2019-10-22T15:56:47.176Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginErrorResponse"
15:56:47 [2019-10-22T15:56:47.176Z] === RUN   TestAuthZPluginErrorRequest
15:56:47 [2019-10-22T15:56:47.743Z] --- PASS: TestAuthZPluginErrorRequest (0.57s)
15:56:47 [2019-10-22T15:56:47.743Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginErrorRequest"
15:56:47 [2019-10-22T15:56:47.743Z] === RUN   TestAuthZPluginEnsureNoDuplicatePluginRegistration
15:56:48 [2019-10-22T15:56:48.311Z] --- PASS: TestAuthZPluginEnsureNoDuplicatePluginRegistration (0.59s)
15:56:48 [2019-10-22T15:56:48.311Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginEnsureNoDuplicatePluginRegistration"
15:56:48 [2019-10-22T15:56:48.311Z] === RUN   TestAuthZPluginEnsureLoadImportWorking
15:56:50 [2019-10-22T15:56:50.841Z] --- PASS: TestAuthZPluginEnsureLoadImportWorking (2.20s)
15:56:50 [2019-10-22T15:56:50.841Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginEnsureLoadImportWorking"
15:56:50 [2019-10-22T15:56:50.841Z] === RUN   TestAuthzPluginEnsureContainerCopyToFrom
15:56:52 [2019-10-22T15:56:52.742Z] --- PASS: TestAuthzPluginEnsureContainerCopyToFrom (2.23s)
15:56:52 [2019-10-22T15:56:52.742Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthzPluginEnsureContainerCopyToFrom"
15:56:52 [2019-10-22T15:56:52.742Z] === RUN   TestAuthZPluginHeader
15:56:53 [2019-10-22T15:56:53.679Z] --- PASS: TestAuthZPluginHeader (0.91s)
15:56:53 [2019-10-22T15:56:53.679Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginHeader"
15:56:53 [2019-10-22T15:56:53.679Z] === RUN   TestAuthZPluginV2AllowNonVolumeRequest
15:56:53 [2019-10-22T15:56:53.679Z] --- SKIP: TestAuthZPluginV2AllowNonVolumeRequest (0.00s)
15:56:53 [2019-10-22T15:56:53.679Z]     authz_plugin_v2_test.go:43: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
15:56:53 [2019-10-22T15:56:53.679Z] === RUN   TestAuthZPluginV2Disable
15:56:53 [2019-10-22T15:56:53.679Z] --- SKIP: TestAuthZPluginV2Disable (0.00s)
15:56:53 [2019-10-22T15:56:53.679Z]     authz_plugin_v2_test.go:65: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
15:56:53 [2019-10-22T15:56:53.679Z] === RUN   TestAuthZPluginV2RejectVolumeRequests
15:56:53 [2019-10-22T15:56:53.679Z] --- SKIP: TestAuthZPluginV2RejectVolumeRequests (0.00s)
15:56:53 [2019-10-22T15:56:53.679Z]     authz_plugin_v2_test.go:91: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
15:56:53 [2019-10-22T15:56:53.679Z] === RUN   TestAuthZPluginV2BadManifestFailsDaemonStart
15:56:53 [2019-10-22T15:56:53.679Z] --- SKIP: TestAuthZPluginV2BadManifestFailsDaemonStart (0.00s)
15:56:53 [2019-10-22T15:56:53.679Z]     authz_plugin_v2_test.go:126: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
15:56:53 [2019-10-22T15:56:53.679Z] === RUN   TestAuthZPluginV2NonexistentFailsDaemonStart
15:57:15 [2019-10-22T15:57:15.603Z] --- PASS: TestAuthZPluginV2NonexistentFailsDaemonStart (18.31s)
15:57:15 [2019-10-22T15:57:15.603Z]     main_test.go:54: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginV2NonexistentFailsDaemonStart"
15:57:15 [2019-10-22T15:57:15.603Z] PASS
15:57:15 [2019-10-22T15:57:15.603Z] 
15:57:15 [2019-10-22T15:57:15.603Z] === Skipped
15:57:15 [2019-10-22T15:57:15.603Z] === SKIP: arm64.integration.plugin.authz TestAuthZPluginV2AllowNonVolumeRequest (0.00s)
15:57:15 [2019-10-22T15:57:15.603Z]     authz_plugin_v2_test.go:43: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
15:57:15 [2019-10-22T15:57:15.603Z] 
15:57:15 [2019-10-22T15:57:15.603Z] === SKIP: arm64.integration.plugin.authz TestAuthZPluginV2Disable (0.00s)
15:57:15 [2019-10-22T15:57:15.603Z]     authz_plugin_v2_test.go:65: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
15:57:15 [2019-10-22T15:57:15.603Z] 
15:57:15 [2019-10-22T15:57:15.603Z] === SKIP: arm64.integration.plugin.authz TestAuthZPluginV2RejectVolumeRequests (0.00s)
15:57:15 [2019-10-22T15:57:15.603Z]     authz_plugin_v2_test.go:91: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
15:57:15 [2019-10-22T15:57:15.603Z] 
15:57:15 [2019-10-22T15:57:15.603Z] === SKIP: arm64.integration.plugin.authz TestAuthZPluginV2BadManifestFailsDaemonStart (0.00s)
15:57:15 [2019-10-22T15:57:15.603Z]     authz_plugin_v2_test.go:126: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
15:57:15 [2019-10-22T15:57:15.603Z] 
15:57:15 [2019-10-22T15:57:15.603Z] 
15:57:15 [2019-10-22T15:57:15.603Z] DONE 17 tests, 4 skipped in 31.436s
15:57:15 [2019-10-22T15:57:15.603Z] Running /go/src/github.com/docker/docker/integration/plugin/common (arm64.integration.plugin.common) flags=-test.v -test.timeout=120m 
15:57:15 [2019-10-22T15:57:15.603Z] ++ 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
15:57:15 [2019-10-22T15:57:15.603Z] ++ set -e
15:57:15 [2019-10-22T15:57:15.603Z] ++ '[' -n 0 ']'
15:57:15 [2019-10-22T15:57:15.603Z] ++ set -x
15:57:15 [2019-10-22T15:57:15.603Z] ++ 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
15:57:15 [2019-10-22T15:57:15.603Z] INFO: Testing against a local daemon
15:57:15 [2019-10-22T15:57:15.603Z] === RUN   TestPluginInvalidJSON
15:57:15 [2019-10-22T15:57:15.603Z] === RUN   TestPluginInvalidJSON//plugins/foobar/set
15:57:15 [2019-10-22T15:57:15.603Z] === PAUSE TestPluginInvalidJSON//plugins/foobar/set
15:57:15 [2019-10-22T15:57:15.603Z] === CONT  TestPluginInvalidJSON//plugins/foobar/set
15:57:15 [2019-10-22T15:57:15.603Z] --- PASS: TestPluginInvalidJSON (0.03s)
15:57:15 [2019-10-22T15:57:15.603Z]     --- PASS: TestPluginInvalidJSON//plugins/foobar/set (0.00s)
15:57:15 [2019-10-22T15:57:15.603Z] PASS
15:57:15 [2019-10-22T15:57:15.603Z] 
15:57:15 [2019-10-22T15:57:15.603Z] DONE 2 tests in 0.185s
15:57:15 [2019-10-22T15:57:15.603Z] Running /go/src/github.com/docker/docker/integration/plugin/graphdriver (arm64.integration.plugin.graphdriver) flags=-test.v -test.timeout=120m 
15:57:15 [2019-10-22T15:57:15.603Z] ++ 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
15:57:15 [2019-10-22T15:57:15.603Z] ++ set -e
15:57:15 [2019-10-22T15:57:15.603Z] ++ '[' -n 0 ']'
15:57:15 [2019-10-22T15:57:15.603Z] ++ set -x
15:57:15 [2019-10-22T15:57:15.603Z] ++ 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
15:57:15 [2019-10-22T15:57:15.603Z] INFO: Testing against a local daemon
15:57:15 [2019-10-22T15:57:15.603Z] === RUN   TestExternalGraphDriver
15:57:15 [2019-10-22T15:57:15.603Z] === RUN   TestExternalGraphDriver/json
15:57:15 [2019-10-22T15:57:15.603Z] === RUN   TestExternalGraphDriver/spec
15:57:18 [2019-10-22T15:57:18.136Z] === RUN   TestExternalGraphDriver/pull
15:57:20 [2019-10-22T15:57:20.039Z] --- PASS: TestExternalGraphDriver (7.57s)
15:57:20 [2019-10-22T15:57:20.039Z]     external_test.go:57: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestExternalGraphDriver"
15:57:20 [2019-10-22T15:57:20.039Z]     --- PASS: TestExternalGraphDriver/json (2.40s)
15:57:20 [2019-10-22T15:57:20.039Z]     --- PASS: TestExternalGraphDriver/spec (2.64s)
15:57:20 [2019-10-22T15:57:20.039Z]     --- PASS: TestExternalGraphDriver/pull (2.29s)
15:57:20 [2019-10-22T15:57:20.039Z] === RUN   TestGraphdriverPluginV2
15:57:20 [2019-10-22T15:57:20.039Z] --- SKIP: TestGraphdriverPluginV2 (0.05s)
15:57:20 [2019-10-22T15:57:20.039Z]     external_test.go:410: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
15:57:20 [2019-10-22T15:57:20.039Z] PASS
15:57:20 [2019-10-22T15:57:20.039Z] 
15:57:20 [2019-10-22T15:57:20.039Z] === Skipped
15:57:20 [2019-10-22T15:57:20.039Z] === SKIP: arm64.integration.plugin.graphdriver TestGraphdriverPluginV2 (0.05s)
15:57:20 [2019-10-22T15:57:20.039Z]     external_test.go:410: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
15:57:20 [2019-10-22T15:57:20.039Z] 
15:57:20 [2019-10-22T15:57:20.039Z] 
15:57:20 [2019-10-22T15:57:20.039Z] DONE 5 tests, 1 skipped in 7.794s
15:57:20 [2019-10-22T15:57:20.039Z] Running /go/src/github.com/docker/docker/integration/plugin/logging (arm64.integration.plugin.logging) flags=-test.v -test.timeout=120m 
15:57:20 [2019-10-22T15:57:20.039Z] ++ 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
15:57:20 [2019-10-22T15:57:20.039Z] ++ set -e
15:57:20 [2019-10-22T15:57:20.039Z] ++ '[' -n 0 ']'
15:57:20 [2019-10-22T15:57:20.039Z] ++ set -x
15:57:20 [2019-10-22T15:57:20.039Z] ++ 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
15:57:20 [2019-10-22T15:57:20.298Z] INFO: Testing against a local daemon
15:57:20 [2019-10-22T15:57:20.298Z] === RUN   TestContinueAfterPluginCrash
15:57:20 [2019-10-22T15:57:20.298Z] === PAUSE TestContinueAfterPluginCrash
15:57:20 [2019-10-22T15:57:20.298Z] === RUN   TestDaemonStartWithLogOpt
15:57:20 [2019-10-22T15:57:20.298Z] === PAUSE TestDaemonStartWithLogOpt
15:57:20 [2019-10-22T15:57:20.298Z] === CONT  TestContinueAfterPluginCrash
15:57:20 [2019-10-22T15:57:20.298Z] === CONT  TestDaemonStartWithLogOpt
15:57:32 [2019-10-22T15:57:32.512Z] --- PASS: TestDaemonStartWithLogOpt (10.34s)
15:57:32 [2019-10-22T15:57:32.512Z]     validation_test.go:23: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDaemonStartWithLogOpt"
15:57:35 [2019-10-22T15:57:35.796Z] --- PASS: TestContinueAfterPluginCrash (15.28s)
15:57:35 [2019-10-22T15:57:35.796Z]     logging_linux_test.go:22: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestContinueAfterPluginCrash"
15:57:35 [2019-10-22T15:57:35.796Z] PASS
15:57:35 [2019-10-22T15:57:35.796Z] 
15:57:35 [2019-10-22T15:57:35.796Z] DONE 2 tests in 15.447s
15:57:35 [2019-10-22T15:57:35.796Z] Running /go/src/github.com/docker/docker/integration/plugin/volumes (arm64.integration.plugin.volumes) flags=-test.v -test.timeout=120m 
15:57:35 [2019-10-22T15:57:35.796Z] ++ 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
15:57:35 [2019-10-22T15:57:35.796Z] ++ set -e
15:57:35 [2019-10-22T15:57:35.796Z] ++ '[' -n 0 ']'
15:57:35 [2019-10-22T15:57:35.796Z] ++ set -x
15:57:35 [2019-10-22T15:57:35.796Z] ++ 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
15:57:35 [2019-10-22T15:57:35.796Z] INFO: Testing against a local daemon
15:57:35 [2019-10-22T15:57:35.796Z] === RUN   TestPluginWithDevMounts
15:57:35 [2019-10-22T15:57:35.796Z] === PAUSE TestPluginWithDevMounts
15:57:35 [2019-10-22T15:57:35.796Z] === CONT  TestPluginWithDevMounts
15:57:38 [2019-10-22T15:57:38.334Z] --- PASS: TestPluginWithDevMounts (2.27s)
15:57:38 [2019-10-22T15:57:38.334Z]     mounts_test.go:23: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestPluginWithDevMounts"
15:57:38 [2019-10-22T15:57:38.334Z] PASS
15:57:38 [2019-10-22T15:57:38.334Z] 
15:57:38 [2019-10-22T15:57:38.334Z] DONE 1 tests in 2.605s
15:57:38 [2019-10-22T15:57:38.334Z] Running /go/src/github.com/docker/docker/integration/secret (arm64.integration.secret) flags=-test.v -test.timeout=120m 
15:57:38 [2019-10-22T15:57:38.334Z] ++ 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
15:57:38 [2019-10-22T15:57:38.334Z] ++ set -e
15:57:38 [2019-10-22T15:57:38.334Z] ++ '[' -n 0 ']'
15:57:38 [2019-10-22T15:57:38.334Z] ++ set -x
15:57:38 [2019-10-22T15:57:38.334Z] ++ 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
15:57:38 [2019-10-22T15:57:38.334Z] INFO: Testing against a local daemon
15:57:38 [2019-10-22T15:57:38.334Z] === RUN   TestSecretInspect
15:57:41 [2019-10-22T15:57:41.625Z] --- PASS: TestSecretInspect (3.19s)
15:57:41 [2019-10-22T15:57:41.625Z]     secret_test.go:25: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestSecretInspect"
15:57:41 [2019-10-22T15:57:41.625Z] === RUN   TestSecretList
15:57:44 [2019-10-22T15:57:44.912Z] --- PASS: TestSecretList (3.22s)
15:57:44 [2019-10-22T15:57:44.912Z]     secret_test.go:48: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestSecretList"
15:57:44 [2019-10-22T15:57:44.912Z] === RUN   TestSecretsCreateAndDelete
15:57:48 [2019-10-22T15:57:48.199Z] --- PASS: TestSecretsCreateAndDelete (3.20s)
15:57:48 [2019-10-22T15:57:48.199Z]     secret_test.go:125: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestSecretsCreateAndDelete"
15:57:48 [2019-10-22T15:57:48.199Z] === RUN   TestSecretsUpdate
15:57:51 [2019-10-22T15:57:51.484Z] --- PASS: TestSecretsUpdate (3.25s)
15:57:51 [2019-10-22T15:57:51.484Z]     secret_test.go:172: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestSecretsUpdate"
15:57:51 [2019-10-22T15:57:51.484Z] === RUN   TestTemplatedSecret
15:57:54 [2019-10-22T15:57:54.770Z] --- PASS: TestTemplatedSecret (3.55s)
15:57:54 [2019-10-22T15:57:54.770Z]     secret_test.go:221: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestTemplatedSecret"
15:57:54 [2019-10-22T15:57:54.770Z] === RUN   TestSecretCreateResolve
15:57:58 [2019-10-22T15:57:58.056Z] --- PASS: TestSecretCreateResolve (3.14s)
15:57:58 [2019-10-22T15:57:58.056Z]     secret_test.go:342: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestSecretCreateResolve"
15:57:58 [2019-10-22T15:57:58.056Z] PASS
15:57:58 [2019-10-22T15:57:58.056Z] 
15:57:58 [2019-10-22T15:57:58.056Z] DONE 6 tests in 19.760s
15:57:58 [2019-10-22T15:57:58.056Z] Running /go/src/github.com/docker/docker/integration/service (arm64.integration.service) flags=-test.v -test.timeout=120m 
15:57:58 [2019-10-22T15:57:58.056Z] ++ 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
15:57:58 [2019-10-22T15:57:58.056Z] ++ set -e
15:57:58 [2019-10-22T15:57:58.056Z] ++ '[' -n 0 ']'
15:57:58 [2019-10-22T15:57:58.056Z] ++ set -x
15:57:58 [2019-10-22T15:57:58.056Z] ++ 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
15:57:58 [2019-10-22T15:57:58.056Z] INFO: Testing against a local daemon
15:57:58 [2019-10-22T15:57:58.056Z] === RUN   TestServiceCreateInit
15:57:58 [2019-10-22T15:57:58.056Z] === RUN   TestServiceCreateInit/daemonInitDisabled
15:58:04 [2019-10-22T15:58:04.618Z] === RUN   TestServiceCreateInit/daemonInitEnabled
15:58:08 [2019-10-22T15:58:08.808Z] --- PASS: TestServiceCreateInit (10.63s)
15:58:08 [2019-10-22T15:58:08.808Z]     --- PASS: TestServiceCreateInit/daemonInitDisabled (5.34s)
15:58:08 [2019-10-22T15:58:08.808Z]         create_test.go:38: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceCreateInit/daemonInitDisabled"
15:58:08 [2019-10-22T15:58:08.808Z]     --- PASS: TestServiceCreateInit/daemonInitEnabled (5.25s)
15:58:08 [2019-10-22T15:58:08.808Z]         create_test.go:38: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceCreateInit/daemonInitEnabled"
15:58:08 [2019-10-22T15:58:08.808Z] === RUN   TestCreateServiceMultipleTimes
15:58:35 [2019-10-22T15:58:35.349Z] --- PASS: TestCreateServiceMultipleTimes (24.21s)
15:58:35 [2019-10-22T15:58:35.349Z]     create_test.go:80: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceMultipleTimes"
15:58:35 [2019-10-22T15:58:35.349Z] === RUN   TestCreateServiceConflict
15:58:36 [2019-10-22T15:58:36.285Z] --- PASS: TestCreateServiceConflict (3.21s)
15:58:36 [2019-10-22T15:58:36.285Z]     create_test.go:129: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceConflict"
15:58:36 [2019-10-22T15:58:36.285Z] === RUN   TestCreateServiceMaxReplicas
15:58:40 [2019-10-22T15:58:40.475Z] --- PASS: TestCreateServiceMaxReplicas (3.72s)
15:58:40 [2019-10-22T15:58:40.476Z]     create_test.go:150: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceMaxReplicas"
15:58:40 [2019-10-22T15:58:40.476Z] === RUN   TestCreateWithDuplicateNetworkNames
15:58:55 [2019-10-22T15:58:55.354Z] --- PASS: TestCreateWithDuplicateNetworkNames (15.57s)
15:58:55 [2019-10-22T15:58:55.354Z]     create_test.go:171: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateWithDuplicateNetworkNames"
15:58:55 [2019-10-22T15:58:55.354Z] === RUN   TestCreateServiceSecretFileMode
15:58:58 [2019-10-22T15:58:58.641Z] --- PASS: TestCreateServiceSecretFileMode (3.27s)
15:58:58 [2019-10-22T15:58:58.641Z]     create_test.go:224: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceSecretFileMode"
15:58:58 [2019-10-22T15:58:58.641Z] === RUN   TestCreateServiceConfigFileMode
15:59:01 [2019-10-22T15:59:01.928Z] --- PASS: TestCreateServiceConfigFileMode (3.28s)
15:59:01 [2019-10-22T15:59:01.928Z]     create_test.go:288: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceConfigFileMode"
15:59:01 [2019-10-22T15:59:01.928Z] === RUN   TestCreateServiceSysctls
15:59:07 [2019-10-22T15:59:07.201Z] --- PASS: TestCreateServiceSysctls (4.24s)
15:59:07 [2019-10-22T15:59:07.201Z]     create_test.go:378: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceSysctls"
15:59:07 [2019-10-22T15:59:07.201Z] === RUN   TestCreateServiceCapabilities
15:59:09 [2019-10-22T15:59:09.733Z] --- PASS: TestCreateServiceCapabilities (3.40s)
15:59:09 [2019-10-22T15:59:09.733Z]     create_test.go:462: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceCapabilities"
15:59:09 [2019-10-22T15:59:09.733Z] === RUN   TestInspect
15:59:13 [2019-10-22T15:59:13.921Z] --- PASS: TestInspect (3.60s)
15:59:13 [2019-10-22T15:59:13.921Z]     inspect_test.go:23: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestInspect"
15:59:13 [2019-10-22T15:59:13.921Z] === RUN   TestServiceListWithStatuses
15:59:13 [2019-10-22T15:59:13.921Z] --- SKIP: TestServiceListWithStatuses (0.00s)
15:59:13 [2019-10-22T15:59:13.921Z]     list_test.go:34: versions.LessThan(testEnv.DaemonInfo.ServerVersion, "1.41")
15:59:13 [2019-10-22T15:59:13.921Z] === RUN   TestDockerNetworkConnectAlias
15:59:22 [2019-10-22T15:59:22.035Z] --- PASS: TestDockerNetworkConnectAlias (7.43s)
15:59:22 [2019-10-22T15:59:22.035Z]     network_test.go:20: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkConnectAlias"
15:59:22 [2019-10-22T15:59:22.035Z] === RUN   TestDockerNetworkReConnect
15:59:27 [2019-10-22T15:59:27.303Z] --- PASS: TestDockerNetworkReConnect (5.97s)
15:59:27 [2019-10-22T15:59:27.303Z]     network_test.go:82: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkReConnect"
15:59:27 [2019-10-22T15:59:27.303Z] === RUN   TestServicePlugin
15:59:27 [2019-10-22T15:59:27.303Z] --- SKIP: TestServicePlugin (0.00s)
15:59:27 [2019-10-22T15:59:27.303Z]     plugin_test.go:28: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
15:59:27 [2019-10-22T15:59:27.303Z] === RUN   TestServiceUpdateLabel
15:59:29 [2019-10-22T15:59:29.833Z] --- PASS: TestServiceUpdateLabel (3.11s)
15:59:29 [2019-10-22T15:59:29.833Z]     update_test.go:21: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateLabel"
15:59:29 [2019-10-22T15:59:29.833Z] === RUN   TestServiceUpdateSecrets
15:59:47 [2019-10-22T15:59:47.915Z] --- PASS: TestServiceUpdateSecrets (15.55s)
15:59:47 [2019-10-22T15:59:47.915Z]     update_test.go:77: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateSecrets"
15:59:47 [2019-10-22T15:59:47.915Z] === RUN   TestServiceUpdateConfigs
16:00:02 [2019-10-22T16:00:02.788Z] --- PASS: TestServiceUpdateConfigs (15.70s)
16:00:02 [2019-10-22T16:00:02.788Z]     update_test.go:139: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateConfigs"
16:00:02 [2019-10-22T16:00:02.788Z] === RUN   TestServiceUpdateNetwork
16:00:17 [2019-10-22T16:00:17.664Z] --- PASS: TestServiceUpdateNetwork (15.46s)
16:00:17 [2019-10-22T16:00:17.664Z]     update_test.go:201: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateNetwork"
16:00:17 [2019-10-22T16:00:17.664Z] PASS
16:00:17 [2019-10-22T16:00:17.664Z] 
16:00:17 [2019-10-22T16:00:17.664Z] === Skipped
16:00:17 [2019-10-22T16:00:17.664Z] === SKIP: arm64.integration.service TestServiceListWithStatuses (0.00s)
16:00:17 [2019-10-22T16:00:17.664Z]     list_test.go:34: versions.LessThan(testEnv.DaemonInfo.ServerVersion, "1.41")
16:00:17 [2019-10-22T16:00:17.664Z] 
16:00:17 [2019-10-22T16:00:17.664Z] === SKIP: arm64.integration.service TestServicePlugin (0.00s)
16:00:17 [2019-10-22T16:00:17.664Z]     plugin_test.go:28: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
16:00:17 [2019-10-22T16:00:17.664Z] 
16:00:17 [2019-10-22T16:00:17.664Z] 
16:00:17 [2019-10-22T16:00:17.664Z] DONE 20 tests, 2 skipped in 138.555s
16:00:17 [2019-10-22T16:00:17.664Z] Running /go/src/github.com/docker/docker/integration/session (arm64.integration.session) flags=-test.v -test.timeout=120m 
16:00:17 [2019-10-22T16:00:17.664Z] ++ 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
16:00:17 [2019-10-22T16:00:17.664Z] ++ set -e
16:00:17 [2019-10-22T16:00:17.664Z] ++ '[' -n 0 ']'
16:00:17 [2019-10-22T16:00:17.664Z] ++ set -x
16:00:17 [2019-10-22T16:00:17.665Z] ++ 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
16:00:17 [2019-10-22T16:00:17.665Z] INFO: Testing against a local daemon
16:00:17 [2019-10-22T16:00:17.665Z] === RUN   TestSessionCreate
16:00:17 [2019-10-22T16:00:17.665Z] --- PASS: TestSessionCreate (0.05s)
16:00:17 [2019-10-22T16:00:17.665Z] === RUN   TestSessionCreateWithBadUpgrade
16:00:17 [2019-10-22T16:00:17.665Z] --- PASS: TestSessionCreateWithBadUpgrade (0.05s)
16:00:17 [2019-10-22T16:00:17.665Z] PASS
16:00:17 [2019-10-22T16:00:17.665Z] 
16:00:17 [2019-10-22T16:00:17.665Z] DONE 2 tests in 0.272s
16:00:17 [2019-10-22T16:00:17.665Z] Running /go/src/github.com/docker/docker/integration/system (arm64.integration.system) flags=-test.v -test.timeout=120m 
16:00:17 [2019-10-22T16:00:17.665Z] ++ 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
16:00:17 [2019-10-22T16:00:17.665Z] ++ set -e
16:00:17 [2019-10-22T16:00:17.665Z] ++ '[' -n 0 ']'
16:00:17 [2019-10-22T16:00:17.665Z] ++ set -x
16:00:17 [2019-10-22T16:00:17.665Z] ++ 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
16:00:17 [2019-10-22T16:00:17.665Z] INFO: Testing against a local daemon
16:00:17 [2019-10-22T16:00:17.665Z] === RUN   TestCgroupDriverSystemdMemoryLimit
16:00:17 [2019-10-22T16:00:17.665Z] --- SKIP: TestCgroupDriverSystemdMemoryLimit (0.00s)
16:00:17 [2019-10-22T16:00:17.665Z]     cgroupdriver_systemd_test.go:32: !hasSystemd()
16:00:17 [2019-10-22T16:00:17.665Z] === RUN   TestEventsExecDie
16:00:17 [2019-10-22T16:00:17.923Z] --- PASS: TestEventsExecDie (1.03s)
16:00:17 [2019-10-22T16:00:17.923Z] === RUN   TestEventsBackwardsCompatible
16:00:18 [2019-10-22T16:00:18.182Z] --- PASS: TestEventsBackwardsCompatible (0.15s)
16:00:18 [2019-10-22T16:00:18.182Z] === RUN   TestInfoBinaryCommits
16:00:18 [2019-10-22T16:00:18.182Z] --- PASS: TestInfoBinaryCommits (0.05s)
16:00:18 [2019-10-22T16:00:18.182Z] === RUN   TestInfoAPIVersioned
16:00:18 [2019-10-22T16:00:18.182Z] --- PASS: TestInfoAPIVersioned (0.02s)
16:00:18 [2019-10-22T16:00:18.182Z] === RUN   TestInfoDiscoveryBackend
16:00:18 [2019-10-22T16:00:18.749Z] --- PASS: TestInfoDiscoveryBackend (0.55s)
16:00:18 [2019-10-22T16:00:18.749Z]     info_linux_test.go:61: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestInfoDiscoveryBackend"
16:00:18 [2019-10-22T16:00:18.749Z] === RUN   TestInfoDiscoveryInvalidAdvertise
16:00:19 [2019-10-22T16:00:19.683Z] --- PASS: TestInfoDiscoveryInvalidAdvertise (1.00s)
16:00:19 [2019-10-22T16:00:19.683Z]     info_linux_test.go:74: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestInfoDiscoveryInvalidAdvertise"
16:00:19 [2019-10-22T16:00:19.683Z] === RUN   TestInfoDiscoveryAdvertiseInterfaceName
16:00:20 [2019-10-22T16:00:20.250Z] --- PASS: TestInfoDiscoveryAdvertiseInterfaceName (0.55s)
16:00:20 [2019-10-22T16:00:20.250Z]     info_linux_test.go:97: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestInfoDiscoveryAdvertiseInterfaceName"
16:00:20 [2019-10-22T16:00:20.250Z] === RUN   TestInfoAPI
16:00:20 [2019-10-22T16:00:20.250Z] --- PASS: TestInfoAPI (0.05s)
16:00:20 [2019-10-22T16:00:20.250Z] === RUN   TestInfoAPIWarnings
16:00:20 [2019-10-22T16:00:20.818Z] --- PASS: TestInfoAPIWarnings (0.55s)
16:00:20 [2019-10-22T16:00:20.818Z]     info_test.go:51: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestInfoAPIWarnings"
16:00:20 [2019-10-22T16:00:20.818Z] === RUN   TestInfoDebug
16:00:21 [2019-10-22T16:00:21.385Z] --- PASS: TestInfoDebug (0.55s)
16:00:21 [2019-10-22T16:00:21.385Z]     info_test.go:74: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestInfoDebug"
16:00:21 [2019-10-22T16:00:21.385Z] === RUN   TestInfoInsecureRegistries
16:00:21 [2019-10-22T16:00:21.952Z] --- PASS: TestInfoInsecureRegistries (0.55s)
16:00:21 [2019-10-22T16:00:21.952Z]     info_test.go:99: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestInfoInsecureRegistries"
16:00:21 [2019-10-22T16:00:21.952Z] === RUN   TestInfoRegistryMirrors
16:00:22 [2019-10-22T16:00:22.519Z] --- PASS: TestInfoRegistryMirrors (0.55s)
16:00:22 [2019-10-22T16:00:22.519Z]     info_test.go:123: Creating a new daemon at: "/go/src/github.com/docker/docker/bundles/test-integration/TestInfoRegistryMirrors"
16:00:22 [2019-10-22T16:00:22.519Z] === RUN   TestLoginFailsWithBadCredentials
16:00:23 [2019-10-22T16:00:23.085Z] --- PASS: TestLoginFailsWithBadCredentials (0.50s)
16:00:23 [2019-10-22T16:00:23.085Z] === RUN   TestPingCacheHeaders
16:00:23 [2019-10-22T16:00:23.085Z] --- PASS: TestPingCacheHeaders (0.05s)
16:00:23 [2019-10-22T16:00:23.085Z] === RUN   TestPingGet
16:00:23 [2019-10-22T16:00:23.085Z] --- PASS: TestPingGet (0.03s)
16:00:23 [2019-10-22T16:00:23.085Z] === RUN   TestPingHead
16:00:23 [2019-10-22T16:00:23.085Z] --- PASS: TestPingHead (0.05s)
16:00:23 [2019-10-22T16:00:23.085Z] === RUN   TestVersion
16:00:23 [2019-10-22T16:00:23.343Z] --- PASS: TestVersion (0.05s)
16:00:23 [2019-10-22T16:00:23.343Z] PASS
16:00:23 [2019-10-22T16:00:23.343Z] 
16:00:23 [2019-10-22T16:00:23.343Z] === Skipped
16:00:23 [2019-10-22T16:00:23.343Z] === SKIP: arm64.integration.system TestCgroupDriverSystemdMemoryLimit (0.00s)
16:00:23 [2019-10-22T16:00:23.343Z]     cgroupdriver_systemd_test.go:32: !hasSystemd()
16:00:23 [2019-10-22T16:00:23.343Z] 
16:00:23 [2019-10-22T16:00:23.343Z] 
16:00:23 [2019-10-22T16:00:23.343Z] DONE 18 tests, 1 skipped in 6.448s
16:00:23 [2019-10-22T16:00:23.343Z] Running /go/src/github.com/docker/docker/integration/volume (arm64.integration.volume) flags=-test.v -test.timeout=120m 
16:00:23 [2019-10-22T16:00:23.343Z] ++ 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
16:00:23 [2019-10-22T16:00:23.343Z] ++ set -e
16:00:23 [2019-10-22T16:00:23.343Z] ++ '[' -n 0 ']'
16:00:23 [2019-10-22T16:00:23.343Z] ++ set -x
16:00:23 [2019-10-22T16:00:23.343Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=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
16:00:23 [2019-10-22T16:00:23.343Z] INFO: Testing against a local daemon
16:00:23 [2019-10-22T16:00:23.343Z] === RUN   TestVolumesCreateAndList
16:00:23 [2019-10-22T16:00:23.602Z] --- PASS: TestVolumesCreateAndList (0.04s)
16:00:23 [2019-10-22T16:00:23.602Z] === RUN   TestVolumesRemove
16:00:23 [2019-10-22T16:00:23.602Z] --- PASS: TestVolumesRemove (0.13s)
16:00:23 [2019-10-22T16:00:23.602Z] === RUN   TestVolumesInspect
16:00:23 [2019-10-22T16:00:23.602Z] --- PASS: TestVolumesInspect (0.04s)
16:00:23 [2019-10-22T16:00:23.602Z] === RUN   TestVolumesInvalidJSON
16:00:23 [2019-10-22T16:00:23.602Z] === RUN   TestVolumesInvalidJSON//volumes/create
16:00:23 [2019-10-22T16:00:23.602Z] === PAUSE TestVolumesInvalidJSON//volumes/create
16:00:23 [2019-10-22T16:00:23.602Z] === CONT  TestVolumesInvalidJSON//volumes/create
16:00:23 [2019-10-22T16:00:23.602Z] --- PASS: TestVolumesInvalidJSON (0.03s)
16:00:23 [2019-10-22T16:00:23.602Z]     --- PASS: TestVolumesInvalidJSON//volumes/create (0.00s)
16:00:23 [2019-10-22T16:00:23.602Z] PASS
16:00:23 [2019-10-22T16:00:23.602Z] 
16:00:23 [2019-10-22T16:00:23.602Z] DONE 5 tests in 0.445s
16:00:23 [2019-10-22T16:00:23.602Z] ---> Making bundle: .integration-daemon-stop (in bundles/test-integration)
16:00:24 [2019-10-22T16:00:24.169Z] ++++ cat bundles/test-integration/docker.pid
16:00:24 [2019-10-22T16:00:24.169Z] +++ kill 12943
16:00:25 [2019-10-22T16:00:25.543Z] +++ /etc/init.d/apparmor stop
16:00:25 [2019-10-22T16:00:25.543Z] Clearing AppArmor profiles cache:.
16:00:25 [2019-10-22T16:00:25.543Z] All profile caches have been cleared, but no profiles have been unloaded.
16:00:25 [2019-10-22T16:00:25.543Z] Unloading profiles will leave already running processes permanently
16:00:25 [2019-10-22T16:00:25.543Z] unconfined, which can lead to unexpected situations.
16:00:25 [2019-10-22T16:00:25.543Z] 
16:00:25 [2019-10-22T16:00:25.544Z] To set a process to complain mode, use the command line tool
16:00:25 [2019-10-22T16:00:25.544Z] 'aa-complain'. To really tear down all profiles, run the init script
16:00:25 [2019-10-22T16:00:25.544Z] with the 'teardown' option."
16:00:25 [2019-10-22T16:00:25.544Z]