Console Output

01:32:32 [2020-01-27T01:32:32.250Z] + docker run --rm -t --privileged -v /home/jenkins/workspace/moby_PR-40007/bundles:/go/src/github.com/docker/docker/bundles --name docker-pr17 -e DOCKER_EXPERIMENTAL -e DOCKER_GITCOMMIT=6bd6b707a162b708ef3a67493892423b03fac3f5 -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:6bd6b707a162b708ef3a67493892423b03fac3f5 hack/make.sh dynbinary test-integration
01:32:32 [2020-01-27T01:32:32.614Z] 
01:32:32 [2020-01-27T01:32:32.614Z] Removing bundles/
01:32:32 [2020-01-27T01:32:32.614Z] 
01:32:32 [2020-01-27T01:32:32.614Z] ---> Making bundle: dynbinary (in bundles/dynbinary)
01:32:32 [2020-01-27T01:32:32.614Z] Building: bundles/dynbinary-daemon/dockerd-dev
01:32:32 [2020-01-27T01:32:32.614Z] GOOS="" GOARCH="" GOARM=""
01:33:21 [2020-01-27T01:33:21.345Z] Created binary: bundles/dynbinary-daemon/dockerd-dev
01:33:21 [2020-01-27T01:33:21.345Z] 
01:33:21 [2020-01-27T01:33:21.345Z] ---> Making bundle: test-integration (in bundles/test-integration)
01:33:21 [2020-01-27T01:33:21.700Z] SCRIPTDIR=/go/src/github.com/docker/docker/hack
01:33:21 [2020-01-27T01:33:21.700Z] HOSTNAME=dd5dee276192
01:33:21 [2020-01-27T01:33:21.700Z] TESTDEBUG=0
01:33:21 [2020-01-27T01:33:21.700Z] DEST=bundles/test-integration
01:33:21 [2020-01-27T01:33:21.700Z] PWD=/go/src/github.com/docker/docker
01:33:21 [2020-01-27T01:33:21.700Z] DOCKER_GITCOMMIT=6bd6b707a162b708ef3a67493892423b03fac3f5
01:33:21 [2020-01-27T01:33:21.700Z] container=docker
01:33:21 [2020-01-27T01:33:21.700Z] HOME=/root
01:33:21 [2020-01-27T01:33:21.700Z] GOLANG_VERSION=1.13.6
01:33:21 [2020-01-27T01:33:21.700Z] VALIDATE_REPO=https://github.com/moby/moby.git
01:33:21 [2020-01-27T01:33:21.700Z] VALIDATE_BRANCH=master
01:33:21 [2020-01-27T01:33:21.700Z] TERM=xterm
01:33:21 [2020-01-27T01:33:21.700Z] DOCKER_PKG=github.com/docker/docker
01:33:21 [2020-01-27T01:33:21.700Z] SHLVL=1
01:33:21 [2020-01-27T01:33:21.700Z] TIMEOUT=120m
01:33:21 [2020-01-27T01:33:21.700Z] DOCKER_BUILDTAGS=apparmor seccomp selinux journald
01:33:21 [2020-01-27T01:33:21.700Z] DOCKER_GRAPHDRIVER=overlay2
01:33:21 [2020-01-27T01:33:21.700Z] GO111MODULE=off
01:33:21 [2020-01-27T01:33:21.700Z] DOCKER_EXPERIMENTAL=1
01:33:21 [2020-01-27T01:33:21.700Z] TEST_SKIP_INTEGRATION_CLI=1
01:33:21 [2020-01-27T01:33:21.700Z] PATH=/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
01:33:21 [2020-01-27T01:33:21.700Z] MAKEDIR=/go/src/github.com/docker/docker/hack/make
01:33:21 [2020-01-27T01:33:21.700Z] GOPATH=/go
01:33:21 [2020-01-27T01:33:21.700Z] PKG_CONFIG=pkg-config
01:33:21 [2020-01-27T01:33:21.700Z] _=/usr/bin/env
01:33:21 [2020-01-27T01:33:21.700Z] Building test suite binary /go/src/github.com/docker/docker/integration/build/test.main
01:33:45 [2020-01-27T01:33:45.263Z] Building test suite binary /go/src/github.com/docker/docker/integration/config/test.main
01:33:45 [2020-01-27T01:33:45.623Z] Building test suite binary /go/src/github.com/docker/docker/integration/container/test.main
01:33:48 [2020-01-27T01:33:48.098Z] Building test suite binary /go/src/github.com/docker/docker/integration/image/test.main
01:34:04 [2020-01-27T01:34:04.400Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/test.main
01:34:04 [2020-01-27T01:34:04.400Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/ipvlan/test.main
01:34:04 [2020-01-27T01:34:04.400Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/macvlan/test.main
01:34:05 [2020-01-27T01:34:05.622Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/test.main
01:34:05 [2020-01-27T01:34:05.622Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/authz/test.main
01:34:06 [2020-01-27T01:34:06.845Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/common/test.main
01:34:07 [2020-01-27T01:34:07.605Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/graphdriver/test.main
01:34:08 [2020-01-27T01:34:08.855Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/logging/test.main
01:34:11 [2020-01-27T01:34:11.404Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/volumes/test.main
01:34:12 [2020-01-27T01:34:12.609Z] Building test suite binary /go/src/github.com/docker/docker/integration/secret/test.main
01:34:13 [2020-01-27T01:34:13.434Z] Building test suite binary /go/src/github.com/docker/docker/integration/service/test.main
01:34:15 [2020-01-27T01:34:15.213Z] Building test suite binary /go/src/github.com/docker/docker/integration/session/test.main
01:34:15 [2020-01-27T01:34:15.968Z] Building test suite binary /go/src/github.com/docker/docker/integration/system/test.main
01:34:16 [2020-01-27T01:34:16.728Z] Building test suite binary /go/src/github.com/docker/docker/integration/volume/test.main
01:34:17 [2020-01-27T01:34:17.503Z] ---> Making bundle: .integration-daemon-start (in bundles/test-integration)
01:34:17 [2020-01-27T01:34:17.503Z] Using test binary docker
01:34:17 [2020-01-27T01:34:17.503Z] # DOCKER_EXPERIMENTAL is set: starting daemon with experimental features enabled! 
01:34:17 [2020-01-27T01:34:17.503Z] +++ /etc/init.d/apparmor start
01:34:17 [2020-01-27T01:34:17.503Z] Starting: AppArmor: already loaded with profiles.: Skipped. ... (warning).
01:34:17 [2020-01-27T01:34:17.503Z] Starting dockerd
01:34:17 [2020-01-27T01:34:17.503Z] INFO: Waiting for daemon to start...
01:34:17 [2020-01-27T01:34:17.503Z] +++ 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
01:34:19 [2020-01-27T01:34:19.858Z] .
01:34:19 [2020-01-27T01:34:19.858Z] ---> Making bundle: .integration-daemon-setup (in bundles/test-integration)
01:34:19 [2020-01-27T01:34:19.858Z] ---> Making bundle: .ensure-emptyfs (in bundles/test-integration)
01:34:19 [2020-01-27T01:34:19.858Z] Error: No such image: emptyfs
01:34:19 [2020-01-27T01:34:19.858Z] ++++ tar -cC bundles/test-integration/emptyfs .
01:34:19 [2020-01-27T01:34:19.858Z] ++++ docker load
01:34:19 [2020-01-27T01:34:19.858Z] Running integration-test (iteration 1)
01:34:19 [2020-01-27T01:34:19.858Z] Running /go/src/github.com/docker/docker/integration/build (s390x.integration.build) flags=-test.v -test.timeout=120m 
01:34:19 [2020-01-27T01:34:19.858Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-build-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-build-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.build -t ./test.main -test.v -test.timeout=120m
01:34:19 [2020-01-27T01:34:19.858Z] ++ set -e
01:34:19 [2020-01-27T01:34:19.858Z] ++ '[' -n 0 ']'
01:34:19 [2020-01-27T01:34:19.858Z] ++ set -x
01:34:19 [2020-01-27T01:34:19.858Z] ++ 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=s390x 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/s390x-integration-build-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-build-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.build -t ./test.main -test.v -test.timeout=120m
01:34:27 [2020-01-27T01:34:27.403Z] Loaded image: buildpack-deps:jessie
01:34:27 [2020-01-27T01:34:27.403Z] Loaded image: busybox:latest
01:34:27 [2020-01-27T01:34:27.403Z] Loaded image: busybox:glibc
01:34:27 [2020-01-27T01:34:27.403Z] Loaded image: debian:jessie
01:34:27 [2020-01-27T01:34:27.403Z] Loaded image: hello-world:latest
01:34:27 [2020-01-27T01:34:27.403Z] INFO: Testing against a local daemon
01:34:27 [2020-01-27T01:34:27.403Z] === RUN   TestCgroupNamespacesBuild
01:34:29 [2020-01-27T01:34:29.233Z] --- PASS: TestCgroupNamespacesBuild (1.91s)
01:34:29 [2020-01-27T01:34:29.233Z] === RUN   TestCgroupNamespacesBuildDaemonHostMode
01:34:30 [2020-01-27T01:34:30.962Z] --- PASS: TestCgroupNamespacesBuildDaemonHostMode (1.64s)
01:34:30 [2020-01-27T01:34:30.962Z] === RUN   TestBuildWithSession
01:34:30 [2020-01-27T01:34:30.962Z] --- SKIP: TestBuildWithSession (0.00s)
01:34:30 [2020-01-27T01:34:30.962Z]     build_session_test.go:25: TODO: BuildKit
01:34:30 [2020-01-27T01:34:30.962Z] === RUN   TestBuildSquashParent
01:34:37 [2020-01-27T01:34:37.169Z] --- PASS: TestBuildSquashParent (5.61s)
01:34:37 [2020-01-27T01:34:37.169Z] === RUN   TestBuildWithRemoveAndForceRemove
01:34:37 [2020-01-27T01:34:37.169Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
01:34:37 [2020-01-27T01:34:37.169Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
01:34:37 [2020-01-27T01:34:37.169Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_remove
01:34:37 [2020-01-27T01:34:37.169Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_remove
01:34:37 [2020-01-27T01:34:37.169Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
01:34:37 [2020-01-27T01:34:37.169Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
01:34:37 [2020-01-27T01:34:37.169Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
01:34:37 [2020-01-27T01:34:37.169Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
01:34:37 [2020-01-27T01:34:37.169Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_remove
01:34:37 [2020-01-27T01:34:37.169Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_remove
01:34:37 [2020-01-27T01:34:37.169Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
01:34:37 [2020-01-27T01:34:37.169Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
01:34:37 [2020-01-27T01:34:37.169Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
01:34:37 [2020-01-27T01:34:37.169Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
01:34:38 [2020-01-27T01:34:38.909Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
01:34:38 [2020-01-27T01:34:38.909Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_remove
01:34:41 [2020-01-27T01:34:41.285Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
01:34:41 [2020-01-27T01:34:41.285Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_remove
01:34:43 [2020-01-27T01:34:43.649Z] --- PASS: TestBuildWithRemoveAndForceRemove (0.01s)
01:34:43 [2020-01-27T01:34:43.649Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal (2.27s)
01:34:43 [2020-01-27T01:34:43.649Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal (2.33s)
01:34:43 [2020-01-27T01:34:43.649Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_remove (2.21s)
01:34:43 [2020-01-27T01:34:43.649Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove (2.33s)
01:34:43 [2020-01-27T01:34:43.649Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove (2.26s)
01:34:43 [2020-01-27T01:34:43.649Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_remove (2.22s)
01:34:43 [2020-01-27T01:34:43.649Z] === RUN   TestBuildMultiStageCopy
01:34:43 [2020-01-27T01:34:43.649Z] === RUN   TestBuildMultiStageCopy/copy_to_root
01:34:46 [2020-01-27T01:34:46.007Z] === RUN   TestBuildMultiStageCopy/copy_to_newdir
01:34:46 [2020-01-27T01:34:46.007Z] === RUN   TestBuildMultiStageCopy/copy_to_newdir_nested
01:34:46 [2020-01-27T01:34:46.781Z] === RUN   TestBuildMultiStageCopy/copy_to_existingdir
01:34:47 [2020-01-27T01:34:47.216Z] === RUN   TestBuildMultiStageCopy/copy_to_newsubdir
01:34:47 [2020-01-27T01:34:47.596Z] --- PASS: TestBuildMultiStageCopy (4.25s)
01:34:47 [2020-01-27T01:34:47.596Z]     --- PASS: TestBuildMultiStageCopy/copy_to_root (2.29s)
01:34:47 [2020-01-27T01:34:47.596Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newdir (0.40s)
01:34:47 [2020-01-27T01:34:47.596Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newdir_nested (0.49s)
01:34:47 [2020-01-27T01:34:47.596Z]     --- PASS: TestBuildMultiStageCopy/copy_to_existingdir (0.46s)
01:34:47 [2020-01-27T01:34:47.596Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newsubdir (0.61s)
01:34:47 [2020-01-27T01:34:47.596Z] === RUN   TestBuildMultiStageParentConfig
01:34:49 [2020-01-27T01:34:49.335Z] --- PASS: TestBuildMultiStageParentConfig (1.34s)
01:34:49 [2020-01-27T01:34:49.335Z] === RUN   TestBuildLabelWithTargets
01:34:51 [2020-01-27T01:34:51.076Z] --- PASS: TestBuildLabelWithTargets (1.85s)
01:34:51 [2020-01-27T01:34:51.076Z] === RUN   TestBuildWithEmptyLayers
01:34:51 [2020-01-27T01:34:51.843Z] --- PASS: TestBuildWithEmptyLayers (0.85s)
01:34:51 [2020-01-27T01:34:51.843Z] === RUN   TestBuildMultiStageOnBuild
01:34:54 [2020-01-27T01:34:54.204Z] --- PASS: TestBuildMultiStageOnBuild (2.58s)
01:34:54 [2020-01-27T01:34:54.204Z] === RUN   TestBuildUncleanTarFilenames
01:34:55 [2020-01-27T01:34:55.413Z] --- PASS: TestBuildUncleanTarFilenames (1.09s)
01:34:55 [2020-01-27T01:34:55.413Z] === RUN   TestBuildMultiStageLayerLeak
01:34:58 [2020-01-27T01:34:58.498Z] --- PASS: TestBuildMultiStageLayerLeak (2.61s)
01:34:58 [2020-01-27T01:34:58.498Z] === RUN   TestBuildWithHugeFile
01:35:26 [2020-01-27T01:35:26.714Z] --- PASS: TestBuildWithHugeFile (25.85s)
01:35:26 [2020-01-27T01:35:26.714Z] === RUN   TestBuildWithEmptyDockerfile
01:35:26 [2020-01-27T01:35:26.714Z] === RUN   TestBuildWithEmptyDockerfile/empty-dockerfile
01:35:26 [2020-01-27T01:35:26.714Z] === PAUSE TestBuildWithEmptyDockerfile/empty-dockerfile
01:35:26 [2020-01-27T01:35:26.714Z] === RUN   TestBuildWithEmptyDockerfile/empty-lines-dockerfile
01:35:26 [2020-01-27T01:35:26.714Z] === PAUSE TestBuildWithEmptyDockerfile/empty-lines-dockerfile
01:35:26 [2020-01-27T01:35:26.714Z] === RUN   TestBuildWithEmptyDockerfile/comment-only-dockerfile
01:35:26 [2020-01-27T01:35:26.714Z] === PAUSE TestBuildWithEmptyDockerfile/comment-only-dockerfile
01:35:26 [2020-01-27T01:35:26.714Z] === CONT  TestBuildWithEmptyDockerfile/empty-dockerfile
01:35:26 [2020-01-27T01:35:26.714Z] === CONT  TestBuildWithEmptyDockerfile/comment-only-dockerfile
01:35:26 [2020-01-27T01:35:26.714Z] === CONT  TestBuildWithEmptyDockerfile/empty-lines-dockerfile
01:35:26 [2020-01-27T01:35:26.714Z] --- PASS: TestBuildWithEmptyDockerfile (0.13s)
01:35:26 [2020-01-27T01:35:26.714Z]     --- PASS: TestBuildWithEmptyDockerfile/empty-dockerfile (0.29s)
01:35:26 [2020-01-27T01:35:26.714Z]     --- PASS: TestBuildWithEmptyDockerfile/comment-only-dockerfile (0.29s)
01:35:26 [2020-01-27T01:35:26.714Z]     --- PASS: TestBuildWithEmptyDockerfile/empty-lines-dockerfile (0.09s)
01:35:26 [2020-01-27T01:35:26.714Z] === RUN   TestBuildPreserveOwnership
01:35:26 [2020-01-27T01:35:26.714Z] === RUN   TestBuildPreserveOwnership/copy_from
01:35:28 [2020-01-27T01:35:28.457Z] === RUN   TestBuildPreserveOwnership/copy_from_chowned
01:35:30 [2020-01-27T01:35:30.224Z] --- PASS: TestBuildPreserveOwnership (5.81s)
01:35:30 [2020-01-27T01:35:30.224Z]     --- PASS: TestBuildPreserveOwnership/copy_from (3.75s)
01:35:30 [2020-01-27T01:35:30.224Z]     --- PASS: TestBuildPreserveOwnership/copy_from_chowned (2.05s)
01:35:30 [2020-01-27T01:35:30.224Z] === RUN   TestBuildPlatformInvalid
01:35:30 [2020-01-27T01:35:30.224Z] --- PASS: TestBuildPlatformInvalid (0.11s)
01:35:30 [2020-01-27T01:35:30.224Z] PASS
01:35:30 [2020-01-27T01:35:30.224Z] 
01:35:30 [2020-01-27T01:35:30.224Z] === Skipped
01:35:30 [2020-01-27T01:35:30.224Z] === SKIP: s390x.integration.build TestBuildWithSession (0.00s)
01:35:30 [2020-01-27T01:35:30.224Z]     build_session_test.go:25: TODO: BuildKit
01:35:30 [2020-01-27T01:35:30.224Z] 
01:35:30 [2020-01-27T01:35:30.224Z] 
01:35:30 [2020-01-27T01:35:30.224Z] DONE 32 tests, 1 skipped in 70.452s
01:35:30 [2020-01-27T01:35:30.224Z] Running /go/src/github.com/docker/docker/integration/config (s390x.integration.config) flags=-test.v -test.timeout=120m 
01:35:30 [2020-01-27T01:35:30.224Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-config-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-config-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.config -t ./test.main -test.v -test.timeout=120m
01:35:30 [2020-01-27T01:35:30.224Z] ++ set -e
01:35:30 [2020-01-27T01:35:30.224Z] ++ '[' -n 0 ']'
01:35:30 [2020-01-27T01:35:30.224Z] ++ set -x
01:35:30 [2020-01-27T01:35:30.224Z] ++ 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=s390x 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/s390x-integration-config-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-config-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.config -t ./test.main -test.v -test.timeout=120m
01:35:30 [2020-01-27T01:35:30.572Z] INFO: Testing against a local daemon
01:35:30 [2020-01-27T01:35:30.572Z] === RUN   TestConfigList
01:35:33 [2020-01-27T01:35:33.645Z] --- PASS: TestConfigList (2.65s)
01:35:33 [2020-01-27T01:35:33.645Z] === RUN   TestConfigsCreateAndDelete
01:35:35 [2020-01-27T01:35:35.996Z] --- PASS: TestConfigsCreateAndDelete (2.77s)
01:35:35 [2020-01-27T01:35:35.996Z] === RUN   TestConfigsUpdate
01:35:39 [2020-01-27T01:35:39.065Z] --- PASS: TestConfigsUpdate (2.69s)
01:35:39 [2020-01-27T01:35:39.065Z] === RUN   TestTemplatedConfig
01:35:42 [2020-01-27T01:35:42.246Z] --- PASS: TestTemplatedConfig (3.24s)
01:35:42 [2020-01-27T01:35:42.246Z] === RUN   TestConfigInspect
01:35:45 [2020-01-27T01:35:45.328Z] --- PASS: TestConfigInspect (2.82s)
01:35:45 [2020-01-27T01:35:45.328Z] === RUN   TestConfigCreateWithLabels
01:35:47 [2020-01-27T01:35:47.711Z] --- PASS: TestConfigCreateWithLabels (2.59s)
01:35:47 [2020-01-27T01:35:47.711Z] === RUN   TestConfigCreateResolve
01:35:49 [2020-01-27T01:35:49.487Z] --- PASS: TestConfigCreateResolve (2.28s)
01:35:49 [2020-01-27T01:35:49.487Z] === RUN   TestConfigDaemonLibtrustID
01:35:50 [2020-01-27T01:35:50.238Z] --- PASS: TestConfigDaemonLibtrustID (0.53s)
01:35:50 [2020-01-27T01:35:50.238Z] PASS
01:35:50 [2020-01-27T01:35:50.238Z] 
01:35:50 [2020-01-27T01:35:50.238Z] DONE 8 tests in 19.770s
01:35:50 [2020-01-27T01:35:50.238Z] Running /go/src/github.com/docker/docker/integration/container (s390x.integration.container) flags=-test.v -test.timeout=120m 
01:35:50 [2020-01-27T01:35:50.238Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-container-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-container-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.container -t ./test.main -test.v -test.timeout=120m
01:35:50 [2020-01-27T01:35:50.238Z] ++ set -e
01:35:50 [2020-01-27T01:35:50.238Z] ++ '[' -n 0 ']'
01:35:50 [2020-01-27T01:35:50.238Z] ++ set -x
01:35:50 [2020-01-27T01:35:50.238Z] ++ 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=s390x 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/s390x-integration-container-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-container-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.container -t ./test.main -test.v -test.timeout=120m
01:35:50 [2020-01-27T01:35:50.238Z] INFO: Testing against a local daemon
01:35:50 [2020-01-27T01:35:50.238Z] === RUN   TestCheckpoint
01:35:50 [2020-01-27T01:35:50.238Z] --- SKIP: TestCheckpoint (0.00s)
01:35:50 [2020-01-27T01:35:50.238Z]     checkpoint_test.go:33: TestCheckpoint is broken; see https://github.com/moby/moby/issues/38963
01:35:50 [2020-01-27T01:35:50.238Z] === RUN   TestContainerInvalidJSON
01:35:50 [2020-01-27T01:35:50.238Z] === RUN   TestContainerInvalidJSON//containers/foobar/copy
01:35:50 [2020-01-27T01:35:50.238Z] === PAUSE TestContainerInvalidJSON//containers/foobar/copy
01:35:50 [2020-01-27T01:35:50.238Z] === RUN   TestContainerInvalidJSON//containers/foobar/exec
01:35:50 [2020-01-27T01:35:50.238Z] === PAUSE TestContainerInvalidJSON//containers/foobar/exec
01:35:50 [2020-01-27T01:35:50.238Z] === RUN   TestContainerInvalidJSON//exec/foobar/start
01:35:50 [2020-01-27T01:35:50.238Z] === PAUSE TestContainerInvalidJSON//exec/foobar/start
01:35:50 [2020-01-27T01:35:50.238Z] === CONT  TestContainerInvalidJSON//containers/foobar/copy
01:35:50 [2020-01-27T01:35:50.238Z] === CONT  TestContainerInvalidJSON//exec/foobar/start
01:35:50 [2020-01-27T01:35:50.238Z] === CONT  TestContainerInvalidJSON//containers/foobar/exec
01:35:50 [2020-01-27T01:35:50.238Z] --- PASS: TestContainerInvalidJSON (0.01s)
01:35:50 [2020-01-27T01:35:50.238Z]     --- PASS: TestContainerInvalidJSON//exec/foobar/start (0.00s)
01:35:50 [2020-01-27T01:35:50.238Z]     --- PASS: TestContainerInvalidJSON//containers/foobar/exec (0.00s)
01:35:50 [2020-01-27T01:35:50.238Z]     --- PASS: TestContainerInvalidJSON//containers/foobar/copy (0.00s)
01:35:50 [2020-01-27T01:35:50.238Z] === RUN   TestCopyFromContainerPathDoesNotExist
01:35:50 [2020-01-27T01:35:50.584Z] --- PASS: TestCopyFromContainerPathDoesNotExist (0.14s)
01:35:50 [2020-01-27T01:35:50.584Z] === RUN   TestCopyFromContainerPathIsNotDir
01:35:50 [2020-01-27T01:35:50.584Z] --- PASS: TestCopyFromContainerPathIsNotDir (0.11s)
01:35:50 [2020-01-27T01:35:50.584Z] === RUN   TestCopyToContainerPathDoesNotExist
01:35:50 [2020-01-27T01:35:50.584Z] --- PASS: TestCopyToContainerPathDoesNotExist (0.11s)
01:35:50 [2020-01-27T01:35:50.584Z] === RUN   TestCopyToContainerPathIsNotDir
01:35:50 [2020-01-27T01:35:50.931Z] --- PASS: TestCopyToContainerPathIsNotDir (0.09s)
01:35:50 [2020-01-27T01:35:50.931Z] === RUN   TestCopyFromContainer
01:35:52 [2020-01-27T01:35:52.664Z] === RUN   TestCopyFromContainer//
01:35:52 [2020-01-27T01:35:52.664Z] === RUN   TestCopyFromContainer//bar/root
01:35:52 [2020-01-27T01:35:52.664Z] === RUN   TestCopyFromContainer//bar/root/
01:35:52 [2020-01-27T01:35:52.664Z] === RUN   TestCopyFromContainer/bar/quux
01:35:53 [2020-01-27T01:35:53.012Z] === RUN   TestCopyFromContainer/bar/quux/
01:35:53 [2020-01-27T01:35:53.012Z] === RUN   TestCopyFromContainer/bar/quux/baz
01:35:53 [2020-01-27T01:35:53.012Z] === RUN   TestCopyFromContainer/bar/filesymlink
01:35:53 [2020-01-27T01:35:53.012Z] === RUN   TestCopyFromContainer/bar/dirsymlink
01:35:53 [2020-01-27T01:35:53.371Z] === RUN   TestCopyFromContainer/bar/dirsymlink/
01:35:53 [2020-01-27T01:35:53.371Z] === RUN   TestCopyFromContainer/bar/notarget
01:35:53 [2020-01-27T01:35:53.371Z] --- PASS: TestCopyFromContainer (2.57s)
01:35:53 [2020-01-27T01:35:53.371Z]     --- PASS: TestCopyFromContainer// (0.05s)
01:35:53 [2020-01-27T01:35:53.371Z]     --- PASS: TestCopyFromContainer//bar/root (0.10s)
01:35:53 [2020-01-27T01:35:53.371Z]     --- PASS: TestCopyFromContainer//bar/root/ (0.05s)
01:35:53 [2020-01-27T01:35:53.371Z]     --- PASS: TestCopyFromContainer/bar/quux (0.11s)
01:35:53 [2020-01-27T01:35:53.372Z]     --- PASS: TestCopyFromContainer/bar/quux/ (0.06s)
01:35:53 [2020-01-27T01:35:53.372Z]     --- PASS: TestCopyFromContainer/bar/quux/baz (0.06s)
01:35:53 [2020-01-27T01:35:53.372Z]     --- PASS: TestCopyFromContainer/bar/filesymlink (0.07s)
01:35:53 [2020-01-27T01:35:53.372Z]     --- PASS: TestCopyFromContainer/bar/dirsymlink (0.08s)
01:35:53 [2020-01-27T01:35:53.372Z]     --- PASS: TestCopyFromContainer/bar/dirsymlink/ (0.08s)
01:35:53 [2020-01-27T01:35:53.372Z]     --- PASS: TestCopyFromContainer/bar/notarget (0.06s)
01:35:53 [2020-01-27T01:35:53.372Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist
01:35:53 [2020-01-27T01:35:53.372Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
01:35:53 [2020-01-27T01:35:53.372Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
01:35:53 [2020-01-27T01:35:53.372Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
01:35:53 [2020-01-27T01:35:53.372Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
01:35:53 [2020-01-27T01:35:53.372Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/digest
01:35:53 [2020-01-27T01:35:53.372Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/digest
01:35:53 [2020-01-27T01:35:53.372Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
01:35:53 [2020-01-27T01:35:53.372Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/digest
01:35:53 [2020-01-27T01:35:53.372Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
01:35:53 [2020-01-27T01:35:53.372Z] --- PASS: TestCreateFailsWhenIdentifierDoesNotExist (0.01s)
01:35:53 [2020-01-27T01:35:53.372Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/digest (0.00s)
01:35:53 [2020-01-27T01:35:53.372Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag (0.00s)
01:35:53 [2020-01-27T01:35:53.372Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag (0.00s)
01:35:53 [2020-01-27T01:35:53.372Z] === RUN   TestCreateLinkToNonExistingContainer
01:35:53 [2020-01-27T01:35:53.372Z] --- PASS: TestCreateLinkToNonExistingContainer (0.07s)
01:35:53 [2020-01-27T01:35:53.372Z] === RUN   TestCreateWithInvalidEnv
01:35:53 [2020-01-27T01:35:53.372Z] === RUN   TestCreateWithInvalidEnv/0
01:35:53 [2020-01-27T01:35:53.372Z] === PAUSE TestCreateWithInvalidEnv/0
01:35:53 [2020-01-27T01:35:53.372Z] === RUN   TestCreateWithInvalidEnv/1
01:35:53 [2020-01-27T01:35:53.372Z] === PAUSE TestCreateWithInvalidEnv/1
01:35:53 [2020-01-27T01:35:53.372Z] === RUN   TestCreateWithInvalidEnv/2
01:35:53 [2020-01-27T01:35:53.372Z] === PAUSE TestCreateWithInvalidEnv/2
01:35:53 [2020-01-27T01:35:53.372Z] === CONT  TestCreateWithInvalidEnv/0
01:35:53 [2020-01-27T01:35:53.372Z] === CONT  TestCreateWithInvalidEnv/2
01:35:53 [2020-01-27T01:35:53.372Z] === CONT  TestCreateWithInvalidEnv/1
01:35:53 [2020-01-27T01:35:53.372Z] --- PASS: TestCreateWithInvalidEnv (0.01s)
01:35:53 [2020-01-27T01:35:53.372Z]     --- PASS: TestCreateWithInvalidEnv/2 (0.00s)
01:35:53 [2020-01-27T01:35:53.372Z]     --- PASS: TestCreateWithInvalidEnv/1 (0.00s)
01:35:53 [2020-01-27T01:35:53.372Z]     --- PASS: TestCreateWithInvalidEnv/0 (0.00s)
01:35:53 [2020-01-27T01:35:53.372Z] === RUN   TestCreateTmpfsMountsTarget
01:35:53 [2020-01-27T01:35:53.372Z] --- PASS: TestCreateTmpfsMountsTarget (0.02s)
01:35:53 [2020-01-27T01:35:53.372Z] === RUN   TestCreateWithCustomMaskedPaths
01:35:55 [2020-01-27T01:35:55.739Z] --- PASS: TestCreateWithCustomMaskedPaths (2.34s)
01:35:55 [2020-01-27T01:35:55.739Z] === RUN   TestCreateWithCapabilities
01:35:55 [2020-01-27T01:35:55.739Z] === RUN   TestCreateWithCapabilities/no_capabilities
01:35:55 [2020-01-27T01:35:55.739Z] === PAUSE TestCreateWithCapabilities/no_capabilities
01:35:55 [2020-01-27T01:35:55.739Z] === RUN   TestCreateWithCapabilities/empty_capabilities
01:35:55 [2020-01-27T01:35:55.739Z] === PAUSE TestCreateWithCapabilities/empty_capabilities
01:35:55 [2020-01-27T01:35:55.739Z] === RUN   TestCreateWithCapabilities/valid_capabilities
01:35:55 [2020-01-27T01:35:55.739Z] === PAUSE TestCreateWithCapabilities/valid_capabilities
01:35:55 [2020-01-27T01:35:55.739Z] === RUN   TestCreateWithCapabilities/invalid_capabilities
01:35:55 [2020-01-27T01:35:55.739Z] === PAUSE TestCreateWithCapabilities/invalid_capabilities
01:35:55 [2020-01-27T01:35:55.739Z] === RUN   TestCreateWithCapabilities/duplicate_capabilities
01:35:55 [2020-01-27T01:35:55.739Z] === PAUSE TestCreateWithCapabilities/duplicate_capabilities
01:35:55 [2020-01-27T01:35:55.739Z] === RUN   TestCreateWithCapabilities/capabilities_API_v1.39
01:35:55 [2020-01-27T01:35:55.739Z] === PAUSE TestCreateWithCapabilities/capabilities_API_v1.39
01:35:55 [2020-01-27T01:35:55.739Z] === RUN   TestCreateWithCapabilities/empty_capadd
01:35:55 [2020-01-27T01:35:55.739Z] === PAUSE TestCreateWithCapabilities/empty_capadd
01:35:55 [2020-01-27T01:35:55.739Z] === RUN   TestCreateWithCapabilities/empty_capdrop
01:35:55 [2020-01-27T01:35:55.739Z] === PAUSE TestCreateWithCapabilities/empty_capdrop
01:35:55 [2020-01-27T01:35:55.739Z] === RUN   TestCreateWithCapabilities/capadd_capdrop
01:35:55 [2020-01-27T01:35:55.739Z] === PAUSE TestCreateWithCapabilities/capadd_capdrop
01:35:55 [2020-01-27T01:35:55.739Z] === RUN   TestCreateWithCapabilities/conflict_with_capadd
01:35:55 [2020-01-27T01:35:55.739Z] === PAUSE TestCreateWithCapabilities/conflict_with_capadd
01:35:55 [2020-01-27T01:35:55.739Z] === RUN   TestCreateWithCapabilities/conflict_with_capdrop
01:35:55 [2020-01-27T01:35:55.739Z] === PAUSE TestCreateWithCapabilities/conflict_with_capdrop
01:35:55 [2020-01-27T01:35:55.739Z] === CONT  TestCreateWithCapabilities/no_capabilities
01:35:55 [2020-01-27T01:35:55.739Z] === CONT  TestCreateWithCapabilities/conflict_with_capdrop
01:35:55 [2020-01-27T01:35:55.739Z] === CONT  TestCreateWithCapabilities/conflict_with_capadd
01:35:55 [2020-01-27T01:35:55.739Z] === CONT  TestCreateWithCapabilities/capadd_capdrop
01:35:55 [2020-01-27T01:35:55.739Z] === CONT  TestCreateWithCapabilities/empty_capdrop
01:35:55 [2020-01-27T01:35:55.739Z] === CONT  TestCreateWithCapabilities/empty_capadd
01:35:56 [2020-01-27T01:35:56.089Z] === CONT  TestCreateWithCapabilities/capabilities_API_v1.39
01:35:56 [2020-01-27T01:35:56.090Z] === CONT  TestCreateWithCapabilities/duplicate_capabilities
01:35:56 [2020-01-27T01:35:56.090Z] === CONT  TestCreateWithCapabilities/invalid_capabilities
01:35:56 [2020-01-27T01:35:56.090Z] === CONT  TestCreateWithCapabilities/valid_capabilities
01:35:56 [2020-01-27T01:35:56.090Z] === CONT  TestCreateWithCapabilities/empty_capabilities
01:35:56 [2020-01-27T01:35:56.090Z] --- PASS: TestCreateWithCapabilities (0.01s)
01:35:56 [2020-01-27T01:35:56.090Z]     --- PASS: TestCreateWithCapabilities/conflict_with_capdrop (0.00s)
01:35:56 [2020-01-27T01:35:56.090Z]     --- PASS: TestCreateWithCapabilities/conflict_with_capadd (0.00s)
01:35:56 [2020-01-27T01:35:56.090Z]     --- PASS: TestCreateWithCapabilities/no_capabilities (0.06s)
01:35:56 [2020-01-27T01:35:56.090Z]     --- PASS: TestCreateWithCapabilities/capadd_capdrop (0.06s)
01:35:56 [2020-01-27T01:35:56.090Z]     --- PASS: TestCreateWithCapabilities/empty_capdrop (0.08s)
01:35:56 [2020-01-27T01:35:56.090Z]     --- PASS: TestCreateWithCapabilities/empty_capadd (0.08s)
01:35:56 [2020-01-27T01:35:56.090Z]     --- PASS: TestCreateWithCapabilities/duplicate_capabilities (0.07s)
01:35:56 [2020-01-27T01:35:56.090Z]     --- PASS: TestCreateWithCapabilities/capabilities_API_v1.39 (0.07s)
01:35:56 [2020-01-27T01:35:56.090Z]     --- PASS: TestCreateWithCapabilities/invalid_capabilities (0.00s)
01:35:56 [2020-01-27T01:35:56.090Z]     --- PASS: TestCreateWithCapabilities/valid_capabilities (0.07s)
01:35:56 [2020-01-27T01:35:56.090Z]     --- PASS: TestCreateWithCapabilities/empty_capabilities (0.07s)
01:35:56 [2020-01-27T01:35:56.090Z] === RUN   TestCreateWithCustomReadonlyPaths
01:35:58 [2020-01-27T01:35:58.620Z] --- PASS: TestCreateWithCustomReadonlyPaths (2.46s)
01:35:58 [2020-01-27T01:35:58.620Z] === RUN   TestCreateWithInvalidHealthcheckParams
01:35:58 [2020-01-27T01:35:58.620Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
01:35:58 [2020-01-27T01:35:58.620Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
01:35:58 [2020-01-27T01:35:58.620Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
01:35:58 [2020-01-27T01:35:58.620Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
01:35:58 [2020-01-27T01:35:58.620Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
01:35:58 [2020-01-27T01:35:58.620Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
01:35:58 [2020-01-27T01:35:58.620Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
01:35:58 [2020-01-27T01:35:58.620Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
01:35:58 [2020-01-27T01:35:58.620Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
01:35:58 [2020-01-27T01:35:58.620Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
01:35:58 [2020-01-27T01:35:58.620Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
01:35:58 [2020-01-27T01:35:58.620Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
01:35:58 [2020-01-27T01:35:58.620Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
01:35:58 [2020-01-27T01:35:58.620Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
01:35:58 [2020-01-27T01:35:58.620Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
01:35:58 [2020-01-27T01:35:58.620Z] --- PASS: TestCreateWithInvalidHealthcheckParams (0.01s)
01:35:58 [2020-01-27T01:35:58.620Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms (0.01s)
01:35:58 [2020-01-27T01:35:58.620Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s (0.01s)
01:35:58 [2020-01-27T01:35:58.620Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0 (0.00s)
01:35:58 [2020-01-27T01:35:58.620Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms (0.01s)
01:35:58 [2020-01-27T01:35:58.620Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms (0.00s)
01:35:58 [2020-01-27T01:35:58.620Z] === RUN   TestContainerStartOnDaemonRestart
01:35:58 [2020-01-27T01:35:58.620Z] === PAUSE TestContainerStartOnDaemonRestart
01:35:58 [2020-01-27T01:35:58.620Z] === RUN   TestDaemonRestartIpcMode
01:35:58 [2020-01-27T01:35:58.620Z] === PAUSE TestDaemonRestartIpcMode
01:35:58 [2020-01-27T01:35:58.620Z] === RUN   TestDaemonHostGatewayIP
01:35:58 [2020-01-27T01:35:58.620Z] === PAUSE TestDaemonHostGatewayIP
01:35:58 [2020-01-27T01:35:58.620Z] === RUN   TestDiff
01:35:59 [2020-01-27T01:35:59.382Z] --- PASS: TestDiff (0.78s)
01:35:59 [2020-01-27T01:35:59.382Z] === RUN   TestExecWithCloseStdin
01:36:00 [2020-01-27T01:36:00.129Z] --- PASS: TestExecWithCloseStdin (0.88s)
01:36:00 [2020-01-27T01:36:00.129Z] === RUN   TestExec
01:36:01 [2020-01-27T01:36:01.327Z] --- PASS: TestExec (0.93s)
01:36:01 [2020-01-27T01:36:01.327Z] === RUN   TestExecUser
01:36:02 [2020-01-27T01:36:02.074Z] --- PASS: TestExecUser (0.91s)
01:36:02 [2020-01-27T01:36:02.074Z] === RUN   TestExportContainerAndImportImage
01:36:03 [2020-01-27T01:36:03.294Z] --- PASS: TestExportContainerAndImportImage (1.14s)
01:36:03 [2020-01-27T01:36:03.294Z] === RUN   TestExportContainerAfterDaemonRestart
01:36:04 [2020-01-27T01:36:04.525Z] --- PASS: TestExportContainerAfterDaemonRestart (1.46s)
01:36:04 [2020-01-27T01:36:04.525Z] === RUN   TestHealthCheckWorkdir
01:36:05 [2020-01-27T01:36:05.737Z] --- PASS: TestHealthCheckWorkdir (1.04s)
01:36:05 [2020-01-27T01:36:05.737Z] === RUN   TestHealthKillContainer
01:36:08 [2020-01-27T01:36:08.790Z] --- PASS: TestHealthKillContainer (3.03s)
01:36:08 [2020-01-27T01:36:08.790Z] === RUN   TestInspectCpusetInConfigPre120
01:36:09 [2020-01-27T01:36:09.562Z] --- PASS: TestInspectCpusetInConfigPre120 (0.83s)
01:36:09 [2020-01-27T01:36:09.562Z] === RUN   TestIpcModeNone
01:36:10 [2020-01-27T01:36:10.761Z] --- PASS: TestIpcModeNone (0.97s)
01:36:10 [2020-01-27T01:36:10.761Z] === RUN   TestIpcModePrivate
01:36:11 [2020-01-27T01:36:11.513Z] --- PASS: TestIpcModePrivate (0.97s)
01:36:11 [2020-01-27T01:36:11.513Z]     ipcmode_linux_test.go:90: [testIpcPrivateShareable] ipcmode: private, ipcdev: 0:64, shared: false, mustBeShared: false
01:36:11 [2020-01-27T01:36:11.513Z] === RUN   TestIpcModeShareable
01:36:12 [2020-01-27T01:36:12.777Z] --- PASS: TestIpcModeShareable (0.94s)
01:36:12 [2020-01-27T01:36:12.777Z]     ipcmode_linux_test.go:90: [testIpcPrivateShareable] ipcmode: shareable, ipcdev: 0:58, shared: true, mustBeShared: true
01:36:12 [2020-01-27T01:36:12.777Z] === RUN   TestAPIIpcModeShareableAndContainer
01:36:15 [2020-01-27T01:36:15.161Z] --- PASS: TestAPIIpcModeShareableAndContainer (2.77s)
01:36:15 [2020-01-27T01:36:15.161Z] === RUN   TestAPIIpcModeHost
01:36:15 [2020-01-27T01:36:15.905Z] --- PASS: TestAPIIpcModeHost (0.67s)
01:36:15 [2020-01-27T01:36:15.905Z] === RUN   TestDaemonIpcModeShareable
01:36:17 [2020-01-27T01:36:17.669Z] --- PASS: TestDaemonIpcModeShareable (1.67s)
01:36:17 [2020-01-27T01:36:17.669Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:66, shared: true, mustBeShared: true
01:36:17 [2020-01-27T01:36:17.669Z] === RUN   TestDaemonIpcModePrivate
01:36:19 [2020-01-27T01:36:19.454Z] --- PASS: TestDaemonIpcModePrivate (1.60s)
01:36:19 [2020-01-27T01:36:19.454Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:72, shared: false, mustBeShared: false
01:36:19 [2020-01-27T01:36:19.454Z] === RUN   TestDaemonIpcModePrivateFromConfig
01:36:20 [2020-01-27T01:36:20.690Z] --- PASS: TestDaemonIpcModePrivateFromConfig (1.62s)
01:36:20 [2020-01-27T01:36:20.690Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:72, shared: false, mustBeShared: false
01:36:20 [2020-01-27T01:36:20.690Z] === RUN   TestDaemonIpcModeShareableFromConfig
01:36:22 [2020-01-27T01:36:22.431Z] --- PASS: TestDaemonIpcModeShareableFromConfig (1.71s)
01:36:22 [2020-01-27T01:36:22.431Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:66, shared: true, mustBeShared: true
01:36:22 [2020-01-27T01:36:22.431Z] === RUN   TestIpcModeOlderClient
01:36:22 [2020-01-27T01:36:22.431Z] === PAUSE TestIpcModeOlderClient
01:36:22 [2020-01-27T01:36:22.431Z] === RUN   TestKillContainerInvalidSignal
01:36:23 [2020-01-27T01:36:23.644Z] --- PASS: TestKillContainerInvalidSignal (0.86s)
01:36:23 [2020-01-27T01:36:23.644Z] === RUN   TestKillContainer
01:36:23 [2020-01-27T01:36:23.644Z] === RUN   TestKillContainer/no_signal
01:36:24 [2020-01-27T01:36:24.394Z] === RUN   TestKillContainer/non_killing_signal
01:36:24 [2020-01-27T01:36:24.745Z] === RUN   TestKillContainer/killing_signal
01:36:25 [2020-01-27T01:36:25.958Z] --- PASS: TestKillContainer (2.59s)
01:36:25 [2020-01-27T01:36:25.958Z]     --- PASS: TestKillContainer/no_signal (0.89s)
01:36:25 [2020-01-27T01:36:25.958Z]     --- PASS: TestKillContainer/non_killing_signal (0.57s)
01:36:25 [2020-01-27T01:36:25.958Z]     --- PASS: TestKillContainer/killing_signal (0.73s)
01:36:25 [2020-01-27T01:36:25.958Z] === RUN   TestKillWithStopSignalAndRestartPolicies
01:36:25 [2020-01-27T01:36:25.958Z] === RUN   TestKillWithStopSignalAndRestartPolicies/same-signal-disables-restart-policy
01:36:26 [2020-01-27T01:36:26.704Z] === RUN   TestKillWithStopSignalAndRestartPolicies/different-signal-keep-restart-policy
01:36:27 [2020-01-27T01:36:27.463Z] --- PASS: TestKillWithStopSignalAndRestartPolicies (1.64s)
01:36:27 [2020-01-27T01:36:27.463Z]     --- PASS: TestKillWithStopSignalAndRestartPolicies/same-signal-disables-restart-policy (0.79s)
01:36:27 [2020-01-27T01:36:27.463Z]     --- PASS: TestKillWithStopSignalAndRestartPolicies/different-signal-keep-restart-policy (0.52s)
01:36:27 [2020-01-27T01:36:27.463Z] === RUN   TestKillStoppedContainer
01:36:27 [2020-01-27T01:36:27.841Z] --- PASS: TestKillStoppedContainer (0.07s)
01:36:27 [2020-01-27T01:36:27.841Z] === RUN   TestKillStoppedContainerAPIPre120
01:36:27 [2020-01-27T01:36:27.841Z] --- PASS: TestKillStoppedContainerAPIPre120 (0.10s)
01:36:27 [2020-01-27T01:36:27.841Z] === RUN   TestKillDifferentUserContainer
01:36:28 [2020-01-27T01:36:28.618Z] --- PASS: TestKillDifferentUserContainer (0.78s)
01:36:28 [2020-01-27T01:36:28.618Z] === RUN   TestInspectOomKilledTrue
01:36:28 [2020-01-27T01:36:28.618Z] --- SKIP: TestInspectOomKilledTrue (0.01s)
01:36:28 [2020-01-27T01:36:28.618Z]     kill_test.go:151: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
01:36:28 [2020-01-27T01:36:28.618Z] === RUN   TestInspectOomKilledFalse
01:36:28 [2020-01-27T01:36:28.618Z] --- SKIP: TestInspectOomKilledFalse (0.00s)
01:36:28 [2020-01-27T01:36:28.618Z]     kill_test.go:169: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
01:36:28 [2020-01-27T01:36:28.618Z] === RUN   TestLinksEtcHostsContentMatch
01:36:29 [2020-01-27T01:36:29.361Z] --- PASS: TestLinksEtcHostsContentMatch (0.63s)
01:36:29 [2020-01-27T01:36:29.361Z] === RUN   TestLinksContainerNames
01:36:30 [2020-01-27T01:36:30.568Z] --- PASS: TestLinksContainerNames (1.42s)
01:36:30 [2020-01-27T01:36:30.568Z] === RUN   TestLogsFollowTailEmpty
01:36:31 [2020-01-27T01:36:31.319Z] --- PASS: TestLogsFollowTailEmpty (0.74s)
01:36:31 [2020-01-27T01:36:31.319Z] === RUN   TestContainerNetworkMountsNoChown
01:36:32 [2020-01-27T01:36:32.526Z] --- PASS: TestContainerNetworkMountsNoChown (0.94s)
01:36:32 [2020-01-27T01:36:32.526Z] === RUN   TestMountDaemonRoot
01:36:32 [2020-01-27T01:36:32.526Z] === RUN   TestMountDaemonRoot/default
01:36:32 [2020-01-27T01:36:32.526Z] === PAUSE TestMountDaemonRoot/default
01:36:32 [2020-01-27T01:36:32.526Z] === RUN   TestMountDaemonRoot/private
01:36:32 [2020-01-27T01:36:32.526Z] === PAUSE TestMountDaemonRoot/private
01:36:32 [2020-01-27T01:36:32.526Z] === RUN   TestMountDaemonRoot/rprivate
01:36:32 [2020-01-27T01:36:32.526Z] === PAUSE TestMountDaemonRoot/rprivate
01:36:32 [2020-01-27T01:36:32.526Z] === RUN   TestMountDaemonRoot/slave
01:36:32 [2020-01-27T01:36:32.526Z] === PAUSE TestMountDaemonRoot/slave
01:36:32 [2020-01-27T01:36:32.526Z] === RUN   TestMountDaemonRoot/rslave
01:36:32 [2020-01-27T01:36:32.526Z] === PAUSE TestMountDaemonRoot/rslave
01:36:32 [2020-01-27T01:36:32.526Z] === RUN   TestMountDaemonRoot/shared
01:36:32 [2020-01-27T01:36:32.526Z] === PAUSE TestMountDaemonRoot/shared
01:36:32 [2020-01-27T01:36:32.526Z] === RUN   TestMountDaemonRoot/rshared
01:36:32 [2020-01-27T01:36:32.526Z] === PAUSE TestMountDaemonRoot/rshared
01:36:32 [2020-01-27T01:36:32.526Z] === CONT  TestMountDaemonRoot/default
01:36:32 [2020-01-27T01:36:32.526Z] === RUN   TestMountDaemonRoot/default/bind_root
01:36:32 [2020-01-27T01:36:32.526Z] === PAUSE TestMountDaemonRoot/default/bind_root
01:36:32 [2020-01-27T01:36:32.526Z] === RUN   TestMountDaemonRoot/default/bind_subpath
01:36:32 [2020-01-27T01:36:32.526Z] === PAUSE TestMountDaemonRoot/default/bind_subpath
01:36:32 [2020-01-27T01:36:32.526Z] === RUN   TestMountDaemonRoot/default/mount_root
01:36:32 [2020-01-27T01:36:32.526Z] === PAUSE TestMountDaemonRoot/default/mount_root
01:36:32 [2020-01-27T01:36:32.526Z] === RUN   TestMountDaemonRoot/default/mount_subpath
01:36:32 [2020-01-27T01:36:32.526Z] === PAUSE TestMountDaemonRoot/default/mount_subpath
01:36:32 [2020-01-27T01:36:32.526Z] === CONT  TestMountDaemonRoot/default/bind_root
01:36:32 [2020-01-27T01:36:32.526Z] === CONT  TestMountDaemonRoot/rshared
01:36:32 [2020-01-27T01:36:32.526Z] === RUN   TestMountDaemonRoot/rshared/mount_subpath
01:36:32 [2020-01-27T01:36:32.526Z] === PAUSE TestMountDaemonRoot/rshared/mount_subpath
01:36:32 [2020-01-27T01:36:32.526Z] === RUN   TestMountDaemonRoot/rshared/bind_root
01:36:32 [2020-01-27T01:36:32.526Z] === PAUSE TestMountDaemonRoot/rshared/bind_root
01:36:32 [2020-01-27T01:36:32.526Z] === RUN   TestMountDaemonRoot/rshared/bind_subpath
01:36:32 [2020-01-27T01:36:32.526Z] === PAUSE TestMountDaemonRoot/rshared/bind_subpath
01:36:32 [2020-01-27T01:36:32.526Z] === RUN   TestMountDaemonRoot/rshared/mount_root
01:36:32 [2020-01-27T01:36:32.526Z] === PAUSE TestMountDaemonRoot/rshared/mount_root
01:36:32 [2020-01-27T01:36:32.526Z] === CONT  TestMountDaemonRoot/rshared/mount_subpath
01:36:32 [2020-01-27T01:36:32.526Z] === CONT  TestMountDaemonRoot/default/mount_subpath
01:36:32 [2020-01-27T01:36:32.526Z] === CONT  TestMountDaemonRoot/shared
01:36:32 [2020-01-27T01:36:32.526Z] === RUN   TestMountDaemonRoot/shared/mount_subpath
01:36:32 [2020-01-27T01:36:32.526Z] === PAUSE TestMountDaemonRoot/shared/mount_subpath
01:36:32 [2020-01-27T01:36:32.526Z] === RUN   TestMountDaemonRoot/shared/bind_root
01:36:32 [2020-01-27T01:36:32.526Z] === PAUSE TestMountDaemonRoot/shared/bind_root
01:36:32 [2020-01-27T01:36:32.526Z] === RUN   TestMountDaemonRoot/shared/bind_subpath
01:36:32 [2020-01-27T01:36:32.526Z] === PAUSE TestMountDaemonRoot/shared/bind_subpath
01:36:32 [2020-01-27T01:36:32.526Z] === RUN   TestMountDaemonRoot/shared/mount_root
01:36:32 [2020-01-27T01:36:32.526Z] === PAUSE TestMountDaemonRoot/shared/mount_root
01:36:32 [2020-01-27T01:36:32.526Z] === CONT  TestMountDaemonRoot/rslave
01:36:32 [2020-01-27T01:36:32.526Z] === RUN   TestMountDaemonRoot/rslave/bind_root
01:36:32 [2020-01-27T01:36:32.526Z] === PAUSE TestMountDaemonRoot/rslave/bind_root
01:36:32 [2020-01-27T01:36:32.526Z] === RUN   TestMountDaemonRoot/rslave/bind_subpath
01:36:32 [2020-01-27T01:36:32.526Z] === PAUSE TestMountDaemonRoot/rslave/bind_subpath
01:36:32 [2020-01-27T01:36:32.526Z] === RUN   TestMountDaemonRoot/rslave/mount_root
01:36:32 [2020-01-27T01:36:32.526Z] === PAUSE TestMountDaemonRoot/rslave/mount_root
01:36:32 [2020-01-27T01:36:32.526Z] === RUN   TestMountDaemonRoot/rslave/mount_subpath
01:36:32 [2020-01-27T01:36:32.526Z] === PAUSE TestMountDaemonRoot/rslave/mount_subpath
01:36:32 [2020-01-27T01:36:32.526Z] === CONT  TestMountDaemonRoot/slave
01:36:32 [2020-01-27T01:36:32.526Z] === RUN   TestMountDaemonRoot/slave/bind_root
01:36:32 [2020-01-27T01:36:32.526Z] === PAUSE TestMountDaemonRoot/slave/bind_root
01:36:32 [2020-01-27T01:36:32.526Z] === RUN   TestMountDaemonRoot/slave/bind_subpath
01:36:32 [2020-01-27T01:36:32.526Z] === PAUSE TestMountDaemonRoot/slave/bind_subpath
01:36:32 [2020-01-27T01:36:32.526Z] === RUN   TestMountDaemonRoot/slave/mount_root
01:36:32 [2020-01-27T01:36:32.526Z] === PAUSE TestMountDaemonRoot/slave/mount_root
01:36:32 [2020-01-27T01:36:32.526Z] === RUN   TestMountDaemonRoot/slave/mount_subpath
01:36:32 [2020-01-27T01:36:32.526Z] === PAUSE TestMountDaemonRoot/slave/mount_subpath
01:36:32 [2020-01-27T01:36:32.526Z] === CONT  TestMountDaemonRoot/rprivate
01:36:32 [2020-01-27T01:36:32.526Z] === RUN   TestMountDaemonRoot/rprivate/mount_subpath
01:36:32 [2020-01-27T01:36:32.526Z] === PAUSE TestMountDaemonRoot/rprivate/mount_subpath
01:36:32 [2020-01-27T01:36:32.526Z] === RUN   TestMountDaemonRoot/rprivate/bind_root
01:36:32 [2020-01-27T01:36:32.526Z] === PAUSE TestMountDaemonRoot/rprivate/bind_root
01:36:32 [2020-01-27T01:36:32.526Z] === RUN   TestMountDaemonRoot/rprivate/bind_subpath
01:36:32 [2020-01-27T01:36:32.526Z] === PAUSE TestMountDaemonRoot/rprivate/bind_subpath
01:36:32 [2020-01-27T01:36:32.526Z] === RUN   TestMountDaemonRoot/rprivate/mount_root
01:36:32 [2020-01-27T01:36:32.526Z] === PAUSE TestMountDaemonRoot/rprivate/mount_root
01:36:32 [2020-01-27T01:36:32.526Z] === CONT  TestMountDaemonRoot/private
01:36:32 [2020-01-27T01:36:32.526Z] === RUN   TestMountDaemonRoot/private/bind_root
01:36:32 [2020-01-27T01:36:32.526Z] === PAUSE TestMountDaemonRoot/private/bind_root
01:36:32 [2020-01-27T01:36:32.526Z] === RUN   TestMountDaemonRoot/private/bind_subpath
01:36:32 [2020-01-27T01:36:32.526Z] === PAUSE TestMountDaemonRoot/private/bind_subpath
01:36:32 [2020-01-27T01:36:32.526Z] === RUN   TestMountDaemonRoot/private/mount_root
01:36:32 [2020-01-27T01:36:32.526Z] === PAUSE TestMountDaemonRoot/private/mount_root
01:36:32 [2020-01-27T01:36:32.526Z] === RUN   TestMountDaemonRoot/private/mount_subpath
01:36:32 [2020-01-27T01:36:32.526Z] === PAUSE TestMountDaemonRoot/private/mount_subpath
01:36:32 [2020-01-27T01:36:32.526Z] === CONT  TestMountDaemonRoot/rshared/mount_root
01:36:32 [2020-01-27T01:36:32.526Z] === CONT  TestMountDaemonRoot/default/mount_root
01:36:32 [2020-01-27T01:36:32.526Z] === CONT  TestMountDaemonRoot/default/bind_subpath
01:36:32 [2020-01-27T01:36:32.526Z] === CONT  TestMountDaemonRoot/rshared/bind_subpath
01:36:32 [2020-01-27T01:36:32.526Z] === CONT  TestMountDaemonRoot/rshared/bind_root
01:36:32 [2020-01-27T01:36:32.526Z] === CONT  TestMountDaemonRoot/shared/mount_subpath
01:36:32 [2020-01-27T01:36:32.526Z] === CONT  TestMountDaemonRoot/rslave/bind_root
01:36:32 [2020-01-27T01:36:32.526Z] === CONT  TestMountDaemonRoot/shared/mount_root
01:36:32 [2020-01-27T01:36:32.526Z] === CONT  TestMountDaemonRoot/shared/bind_subpath
01:36:32 [2020-01-27T01:36:32.526Z] === CONT  TestMountDaemonRoot/shared/bind_root
01:36:32 [2020-01-27T01:36:32.526Z] === CONT  TestMountDaemonRoot/rslave/mount_root
01:36:32 [2020-01-27T01:36:32.526Z] === CONT  TestMountDaemonRoot/rslave/mount_subpath
01:36:32 [2020-01-27T01:36:32.877Z] === CONT  TestMountDaemonRoot/rslave/bind_subpath
01:36:32 [2020-01-27T01:36:32.877Z] === CONT  TestMountDaemonRoot/slave/bind_root
01:36:32 [2020-01-27T01:36:32.877Z] === CONT  TestMountDaemonRoot/rprivate/mount_subpath
01:36:32 [2020-01-27T01:36:32.877Z] === CONT  TestMountDaemonRoot/slave/mount_subpath
01:36:32 [2020-01-27T01:36:32.877Z] === CONT  TestMountDaemonRoot/slave/mount_root
01:36:32 [2020-01-27T01:36:32.877Z] === CONT  TestMountDaemonRoot/slave/bind_subpath
01:36:32 [2020-01-27T01:36:32.877Z] === CONT  TestMountDaemonRoot/private/bind_root
01:36:32 [2020-01-27T01:36:32.877Z] === CONT  TestMountDaemonRoot/rprivate/mount_root
01:36:32 [2020-01-27T01:36:32.877Z] === CONT  TestMountDaemonRoot/rprivate/bind_subpath
01:36:32 [2020-01-27T01:36:32.877Z] === CONT  TestMountDaemonRoot/rprivate/bind_root
01:36:32 [2020-01-27T01:36:32.877Z] === CONT  TestMountDaemonRoot/private/mount_subpath
01:36:32 [2020-01-27T01:36:32.877Z] === CONT  TestMountDaemonRoot/private/mount_root
01:36:32 [2020-01-27T01:36:32.877Z] === CONT  TestMountDaemonRoot/private/bind_subpath
01:36:32 [2020-01-27T01:36:32.877Z] --- PASS: TestMountDaemonRoot (0.01s)
01:36:32 [2020-01-27T01:36:32.877Z]     --- PASS: TestMountDaemonRoot/default (0.00s)
01:36:32 [2020-01-27T01:36:32.877Z]         --- PASS: TestMountDaemonRoot/default/bind_root (0.07s)
01:36:32 [2020-01-27T01:36:32.877Z]         --- PASS: TestMountDaemonRoot/default/mount_subpath (0.07s)
01:36:32 [2020-01-27T01:36:32.877Z]         --- PASS: TestMountDaemonRoot/default/mount_root (0.07s)
01:36:32 [2020-01-27T01:36:32.877Z]         --- PASS: TestMountDaemonRoot/default/bind_subpath (0.07s)
01:36:32 [2020-01-27T01:36:32.877Z]     --- PASS: TestMountDaemonRoot/rshared (0.00s)
01:36:32 [2020-01-27T01:36:32.877Z]         --- PASS: TestMountDaemonRoot/rshared/mount_subpath (0.07s)
01:36:32 [2020-01-27T01:36:32.877Z]         --- PASS: TestMountDaemonRoot/rshared/mount_root (0.07s)
01:36:32 [2020-01-27T01:36:32.877Z]         --- PASS: TestMountDaemonRoot/rshared/bind_root (0.06s)
01:36:32 [2020-01-27T01:36:32.877Z]         --- PASS: TestMountDaemonRoot/rshared/bind_subpath (0.09s)
01:36:32 [2020-01-27T01:36:32.877Z]     --- PASS: TestMountDaemonRoot/shared (0.00s)
01:36:32 [2020-01-27T01:36:32.877Z]         --- PASS: TestMountDaemonRoot/shared/mount_subpath (0.02s)
01:36:32 [2020-01-27T01:36:32.877Z]         --- PASS: TestMountDaemonRoot/shared/mount_root (0.03s)
01:36:32 [2020-01-27T01:36:32.877Z]         --- PASS: TestMountDaemonRoot/shared/bind_subpath (0.05s)
01:36:32 [2020-01-27T01:36:32.877Z]         --- PASS: TestMountDaemonRoot/shared/bind_root (0.02s)
01:36:32 [2020-01-27T01:36:32.877Z]     --- PASS: TestMountDaemonRoot/rslave (0.00s)
01:36:32 [2020-01-27T01:36:32.877Z]         --- PASS: TestMountDaemonRoot/rslave/bind_root (0.07s)
01:36:32 [2020-01-27T01:36:32.877Z]         --- PASS: TestMountDaemonRoot/rslave/mount_subpath (0.05s)
01:36:32 [2020-01-27T01:36:32.877Z]         --- PASS: TestMountDaemonRoot/rslave/mount_root (0.07s)
01:36:32 [2020-01-27T01:36:32.877Z]         --- PASS: TestMountDaemonRoot/rslave/bind_subpath (0.07s)
01:36:32 [2020-01-27T01:36:32.877Z]     --- PASS: TestMountDaemonRoot/slave (0.00s)
01:36:32 [2020-01-27T01:36:32.877Z]         --- PASS: TestMountDaemonRoot/slave/bind_root (0.05s)
01:36:32 [2020-01-27T01:36:32.877Z]         --- PASS: TestMountDaemonRoot/slave/mount_subpath (0.04s)
01:36:32 [2020-01-27T01:36:32.877Z]         --- PASS: TestMountDaemonRoot/slave/mount_root (0.03s)
01:36:32 [2020-01-27T01:36:32.877Z]         --- PASS: TestMountDaemonRoot/slave/bind_subpath (0.02s)
01:36:32 [2020-01-27T01:36:32.877Z]     --- PASS: TestMountDaemonRoot/rprivate (0.00s)
01:36:32 [2020-01-27T01:36:32.877Z]         --- PASS: TestMountDaemonRoot/rprivate/mount_subpath (0.03s)
01:36:32 [2020-01-27T01:36:32.877Z]         --- PASS: TestMountDaemonRoot/rprivate/mount_root (0.04s)
01:36:32 [2020-01-27T01:36:32.877Z]         --- PASS: TestMountDaemonRoot/rprivate/bind_subpath (0.04s)
01:36:32 [2020-01-27T01:36:32.877Z]         --- PASS: TestMountDaemonRoot/rprivate/bind_root (0.03s)
01:36:32 [2020-01-27T01:36:32.877Z]     --- PASS: TestMountDaemonRoot/private (0.00s)
01:36:32 [2020-01-27T01:36:32.877Z]         --- PASS: TestMountDaemonRoot/private/bind_root (0.03s)
01:36:32 [2020-01-27T01:36:32.877Z]         --- PASS: TestMountDaemonRoot/private/mount_subpath (0.03s)
01:36:32 [2020-01-27T01:36:32.877Z]         --- PASS: TestMountDaemonRoot/private/mount_root (0.03s)
01:36:32 [2020-01-27T01:36:32.877Z]         --- PASS: TestMountDaemonRoot/private/bind_subpath (0.05s)
01:36:32 [2020-01-27T01:36:32.877Z] === RUN   TestContainerBindMountNonRecursive
01:36:34 [2020-01-27T01:36:34.631Z] --- PASS: TestContainerBindMountNonRecursive (1.70s)
01:36:34 [2020-01-27T01:36:34.631Z] === RUN   TestNetworkNat
01:36:35 [2020-01-27T01:36:35.372Z] --- PASS: TestNetworkNat (0.82s)
01:36:35 [2020-01-27T01:36:35.372Z] === RUN   TestNetworkLocalhostTCPNat
01:36:36 [2020-01-27T01:36:36.566Z] --- PASS: TestNetworkLocalhostTCPNat (0.81s)
01:36:36 [2020-01-27T01:36:36.566Z] === RUN   TestNetworkLoopbackNat
01:36:37 [2020-01-27T01:36:37.767Z] --- PASS: TestNetworkLoopbackNat (1.14s)
01:36:37 [2020-01-27T01:36:37.767Z] === RUN   TestPause
01:36:38 [2020-01-27T01:36:38.507Z] --- PASS: TestPause (0.92s)
01:36:38 [2020-01-27T01:36:38.507Z] === RUN   TestPauseFailsOnWindowsServerContainers
01:36:38 [2020-01-27T01:36:38.507Z] --- SKIP: TestPauseFailsOnWindowsServerContainers (0.00s)
01:36:38 [2020-01-27T01:36:38.507Z]     pause_test.go:54: testEnv.DaemonInfo.OSType != "windows" || testEnv.DaemonInfo.Isolation != "process"
01:36:38 [2020-01-27T01:36:38.507Z] === RUN   TestPauseStopPausedContainer
01:36:39 [2020-01-27T01:36:39.254Z] --- PASS: TestPauseStopPausedContainer (0.86s)
01:36:39 [2020-01-27T01:36:39.254Z] === RUN   TestPsFilter
01:36:39 [2020-01-27T01:36:39.602Z] --- PASS: TestPsFilter (0.23s)
01:36:39 [2020-01-27T01:36:39.602Z] === RUN   TestRemoveContainerWithRemovedVolume
01:36:40 [2020-01-27T01:36:40.347Z] --- PASS: TestRemoveContainerWithRemovedVolume (0.68s)
01:36:40 [2020-01-27T01:36:40.347Z] === RUN   TestRemoveContainerWithVolume
01:36:41 [2020-01-27T01:36:41.097Z] --- PASS: TestRemoveContainerWithVolume (0.88s)
01:36:41 [2020-01-27T01:36:41.097Z] === RUN   TestRemoveContainerRunning
01:36:41 [2020-01-27T01:36:41.948Z] --- PASS: TestRemoveContainerRunning (0.80s)
01:36:41 [2020-01-27T01:36:41.948Z] === RUN   TestRemoveContainerForceRemoveRunning
01:36:42 [2020-01-27T01:36:42.729Z] --- PASS: TestRemoveContainerForceRemoveRunning (0.99s)
01:36:42 [2020-01-27T01:36:42.729Z] === RUN   TestRemoveInvalidContainer
01:36:42 [2020-01-27T01:36:42.729Z] --- PASS: TestRemoveInvalidContainer (0.01s)
01:36:42 [2020-01-27T01:36:42.729Z] === RUN   TestRenameLinkedContainer
01:36:46 [2020-01-27T01:36:46.632Z] --- PASS: TestRenameLinkedContainer (3.17s)
01:36:46 [2020-01-27T01:36:46.632Z] === RUN   TestRenameStoppedContainer
01:36:46 [2020-01-27T01:36:46.994Z] --- PASS: TestRenameStoppedContainer (0.81s)
01:36:46 [2020-01-27T01:36:46.994Z] === RUN   TestRenameRunningContainerAndReuse
01:36:48 [2020-01-27T01:36:48.720Z] --- PASS: TestRenameRunningContainerAndReuse (1.63s)
01:36:48 [2020-01-27T01:36:48.720Z] === RUN   TestRenameInvalidName
01:36:49 [2020-01-27T01:36:49.457Z] --- PASS: TestRenameInvalidName (0.83s)
01:36:49 [2020-01-27T01:36:49.457Z] === RUN   TestRenameAnonymousContainer
01:36:52 [2020-01-27T01:36:52.599Z] --- PASS: TestRenameAnonymousContainer (2.87s)
01:36:52 [2020-01-27T01:36:52.599Z] === RUN   TestRenameContainerWithSameName
01:36:52 [2020-01-27T01:36:52.944Z] --- PASS: TestRenameContainerWithSameName (0.75s)
01:36:52 [2020-01-27T01:36:52.944Z] === RUN   TestRenameContainerWithLinkedContainer
01:36:54 [2020-01-27T01:36:54.680Z] --- PASS: TestRenameContainerWithLinkedContainer (1.55s)
01:36:54 [2020-01-27T01:36:54.680Z] === RUN   TestResize
01:36:55 [2020-01-27T01:36:55.419Z] --- PASS: TestResize (0.85s)
01:36:55 [2020-01-27T01:36:55.419Z] === RUN   TestResizeWithInvalidSize
01:36:56 [2020-01-27T01:36:56.174Z] --- PASS: TestResizeWithInvalidSize (0.90s)
01:36:56 [2020-01-27T01:36:56.174Z] === RUN   TestResizeWhenContainerNotStarted
01:36:56 [2020-01-27T01:36:56.942Z] --- PASS: TestResizeWhenContainerNotStarted (0.82s)
01:36:56 [2020-01-27T01:36:56.942Z] === RUN   TestDaemonRestartKillContainers
01:36:56 [2020-01-27T01:36:56.942Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
01:36:56 [2020-01-27T01:36:56.942Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
01:36:56 [2020-01-27T01:36:56.942Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
01:36:56 [2020-01-27T01:36:56.942Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
01:36:56 [2020-01-27T01:36:56.942Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
01:36:56 [2020-01-27T01:36:56.942Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
01:36:56 [2020-01-27T01:36:56.942Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
01:36:56 [2020-01-27T01:36:56.942Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
01:36:56 [2020-01-27T01:36:56.942Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
01:36:56 [2020-01-27T01:36:56.942Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
01:36:56 [2020-01-27T01:36:56.942Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
01:36:56 [2020-01-27T01:36:56.942Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
01:36:56 [2020-01-27T01:36:56.942Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
01:36:56 [2020-01-27T01:36:56.942Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
01:36:56 [2020-01-27T01:36:56.942Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
01:36:56 [2020-01-27T01:36:56.942Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
01:36:56 [2020-01-27T01:36:56.942Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
01:36:56 [2020-01-27T01:36:56.942Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
01:36:56 [2020-01-27T01:36:56.942Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
01:36:56 [2020-01-27T01:36:56.942Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
01:36:56 [2020-01-27T01:36:56.942Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
01:36:56 [2020-01-27T01:36:56.942Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
01:36:56 [2020-01-27T01:36:56.942Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
01:36:56 [2020-01-27T01:36:56.942Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
01:36:56 [2020-01-27T01:36:56.942Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
01:36:56 [2020-01-27T01:36:56.942Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
01:36:58 [2020-01-27T01:36:58.850Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
01:36:59 [2020-01-27T01:36:59.197Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
01:37:00 [2020-01-27T01:37:00.404Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
01:37:00 [2020-01-27T01:37:00.754Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
01:37:01 [2020-01-27T01:37:01.995Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
01:37:02 [2020-01-27T01:37:02.345Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
01:37:04 [2020-01-27T01:37:04.081Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
01:37:04 [2020-01-27T01:37:04.440Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
01:37:06 [2020-01-27T01:37:06.398Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
01:37:06 [2020-01-27T01:37:06.752Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
01:37:09 [2020-01-27T01:37:09.113Z] --- PASS: TestDaemonRestartKillContainers (0.00s)
01:37:09 [2020-01-27T01:37:09.113Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon (1.90s)
01:37:09 [2020-01-27T01:37:09.113Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon (2.33s)
01:37:09 [2020-01-27T01:37:09.113Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon (1.38s)
01:37:09 [2020-01-27T01:37:09.113Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon (1.40s)
01:37:09 [2020-01-27T01:37:09.113Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon (1.42s)
01:37:09 [2020-01-27T01:37:09.113Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon (1.43s)
01:37:09 [2020-01-27T01:37:09.113Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon (2.13s)
01:37:09 [2020-01-27T01:37:09.113Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon (2.12s)
01:37:09 [2020-01-27T01:37:09.113Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon (1.87s)
01:37:09 [2020-01-27T01:37:09.113Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon (2.82s)
01:37:09 [2020-01-27T01:37:09.113Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon (2.17s)
01:37:09 [2020-01-27T01:37:09.113Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon (2.21s)
01:37:09 [2020-01-27T01:37:09.113Z] === RUN   TestCgroupNamespacesRun
01:37:10 [2020-01-27T01:37:10.838Z] --- PASS: TestCgroupNamespacesRun (1.65s)
01:37:10 [2020-01-27T01:37:10.838Z] === RUN   TestCgroupNamespacesRunPrivileged
01:37:12 [2020-01-27T01:37:12.049Z] --- PASS: TestCgroupNamespacesRunPrivileged (1.51s)
01:37:12 [2020-01-27T01:37:12.049Z] === RUN   TestCgroupNamespacesRunDaemonHostMode
01:37:13 [2020-01-27T01:37:13.848Z] --- PASS: TestCgroupNamespacesRunDaemonHostMode (1.68s)
01:37:13 [2020-01-27T01:37:13.848Z] === RUN   TestCgroupNamespacesRunHostMode
01:37:15 [2020-01-27T01:37:15.252Z] --- PASS: TestCgroupNamespacesRunHostMode (1.68s)
01:37:15 [2020-01-27T01:37:15.252Z] === RUN   TestCgroupNamespacesRunPrivateMode
01:37:16 [2020-01-27T01:37:16.984Z] --- PASS: TestCgroupNamespacesRunPrivateMode (1.61s)
01:37:16 [2020-01-27T01:37:16.984Z] === RUN   TestCgroupNamespacesRunPrivilegedAndPrivate
01:37:17 [2020-01-27T01:37:17.744Z] --- PASS: TestCgroupNamespacesRunPrivilegedAndPrivate (0.75s)
01:37:17 [2020-01-27T01:37:17.744Z] === RUN   TestCgroupNamespacesRunInvalidMode
01:37:18 [2020-01-27T01:37:18.507Z] --- PASS: TestCgroupNamespacesRunInvalidMode (0.81s)
01:37:18 [2020-01-27T01:37:18.507Z] === RUN   TestCgroupNamespacesRunOlderClient
01:37:20 [2020-01-27T01:37:20.267Z] --- PASS: TestCgroupNamespacesRunOlderClient (1.68s)
01:37:20 [2020-01-27T01:37:20.267Z] === RUN   TestKernelTCPMemory
01:37:21 [2020-01-27T01:37:21.483Z] --- PASS: TestKernelTCPMemory (0.97s)
01:37:21 [2020-01-27T01:37:21.483Z] === RUN   TestNISDomainname
01:37:22 [2020-01-27T01:37:22.347Z] --- PASS: TestNISDomainname (1.18s)
01:37:22 [2020-01-27T01:37:22.347Z] === RUN   TestHostnameDnsResolution
01:37:23 [2020-01-27T01:37:23.626Z] --- PASS: TestHostnameDnsResolution (1.14s)
01:37:23 [2020-01-27T01:37:23.626Z] === RUN   TestStats
01:37:26 [2020-01-27T01:37:26.673Z] --- PASS: TestStats (2.64s)
01:37:26 [2020-01-27T01:37:26.673Z] === RUN   TestStopContainerWithTimeout
01:37:26 [2020-01-27T01:37:26.673Z] === RUN   TestStopContainerWithTimeout/0
01:37:26 [2020-01-27T01:37:26.673Z] === PAUSE TestStopContainerWithTimeout/0
01:37:26 [2020-01-27T01:37:26.673Z] === RUN   TestStopContainerWithTimeout/1
01:37:26 [2020-01-27T01:37:26.673Z] === PAUSE TestStopContainerWithTimeout/1
01:37:26 [2020-01-27T01:37:26.673Z] === RUN   TestStopContainerWithTimeout/3
01:37:26 [2020-01-27T01:37:26.673Z] === PAUSE TestStopContainerWithTimeout/3
01:37:26 [2020-01-27T01:37:26.673Z] === RUN   TestStopContainerWithTimeout/-1
01:37:26 [2020-01-27T01:37:26.673Z] === PAUSE TestStopContainerWithTimeout/-1
01:37:26 [2020-01-27T01:37:26.673Z] === CONT  TestStopContainerWithTimeout/0
01:37:26 [2020-01-27T01:37:26.673Z] === CONT  TestStopContainerWithTimeout/3
01:37:27 [2020-01-27T01:37:27.420Z] === CONT  TestStopContainerWithTimeout/-1
01:37:29 [2020-01-27T01:37:29.144Z] === CONT  TestStopContainerWithTimeout/1
01:37:30 [2020-01-27T01:37:30.945Z] --- PASS: TestStopContainerWithTimeout (0.01s)
01:37:30 [2020-01-27T01:37:30.945Z]     --- PASS: TestStopContainerWithTimeout/0 (1.12s)
01:37:30 [2020-01-27T01:37:30.945Z]     --- PASS: TestStopContainerWithTimeout/3 (2.98s)
01:37:30 [2020-01-27T01:37:30.945Z]     --- PASS: TestStopContainerWithTimeout/-1 (2.87s)
01:37:30 [2020-01-27T01:37:30.945Z]     --- PASS: TestStopContainerWithTimeout/1 (1.84s)
01:37:30 [2020-01-27T01:37:30.945Z] === RUN   TestDeleteDevicemapper
01:37:30 [2020-01-27T01:37:30.945Z] --- SKIP: TestDeleteDevicemapper (0.00s)
01:37:30 [2020-01-27T01:37:30.945Z]     stop_linux_test.go:74: testEnv.DaemonInfo.Driver != "devicemapper"
01:37:30 [2020-01-27T01:37:30.945Z] === RUN   TestStopContainerWithRestartPolicyAlways
01:37:34 [2020-01-27T01:37:34.886Z] --- PASS: TestStopContainerWithRestartPolicyAlways (3.54s)
01:37:34 [2020-01-27T01:37:34.886Z] === RUN   TestUpdateMemory
01:37:34 [2020-01-27T01:37:34.886Z] --- SKIP: TestUpdateMemory (0.00s)
01:37:34 [2020-01-27T01:37:34.886Z]     update_linux_test.go:23: !testEnv.DaemonInfo.SwapLimit
01:37:34 [2020-01-27T01:37:34.886Z] === RUN   TestUpdateCPUQuota
01:37:35 [2020-01-27T01:37:35.635Z] --- PASS: TestUpdateCPUQuota (1.07s)
01:37:35 [2020-01-27T01:37:35.635Z] === RUN   TestUpdatePidsLimit
01:37:35 [2020-01-27T01:37:35.635Z] === RUN   TestUpdatePidsLimit/update_from_none
01:37:35 [2020-01-27T01:37:35.993Z] === RUN   TestUpdatePidsLimit/no_change
01:37:36 [2020-01-27T01:37:36.343Z] === RUN   TestUpdatePidsLimit/update_lower
01:37:36 [2020-01-27T01:37:36.701Z] === RUN   TestUpdatePidsLimit/update_on_old_api_ignores_value
01:37:37 [2020-01-27T01:37:37.057Z] === RUN   TestUpdatePidsLimit/unset_limit_with_zero
01:37:37 [2020-01-27T01:37:37.406Z] === RUN   TestUpdatePidsLimit/unset_limit_with_minus_one
01:37:37 [2020-01-27T01:37:37.758Z] === RUN   TestUpdatePidsLimit/unset_limit_with_minus_two
01:37:39 [2020-01-27T01:37:39.167Z] --- PASS: TestUpdatePidsLimit (3.57s)
01:37:39 [2020-01-27T01:37:39.167Z]     --- PASS: TestUpdatePidsLimit/update_from_none (0.37s)
01:37:39 [2020-01-27T01:37:39.167Z]     --- PASS: TestUpdatePidsLimit/no_change (0.41s)
01:37:39 [2020-01-27T01:37:39.167Z]     --- PASS: TestUpdatePidsLimit/update_lower (0.37s)
01:37:39 [2020-01-27T01:37:39.167Z]     --- PASS: TestUpdatePidsLimit/update_on_old_api_ignores_value (0.36s)
01:37:39 [2020-01-27T01:37:39.167Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_zero (0.37s)
01:37:39 [2020-01-27T01:37:39.167Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_minus_one (0.36s)
01:37:39 [2020-01-27T01:37:39.167Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_minus_two (0.35s)
01:37:39 [2020-01-27T01:37:39.167Z] === RUN   TestUpdateRestartPolicy
01:37:52 [2020-01-27T01:37:52.495Z] --- PASS: TestUpdateRestartPolicy (12.48s)
01:37:52 [2020-01-27T01:37:52.495Z] === RUN   TestUpdateRestartWithAutoRemove
01:37:52 [2020-01-27T01:37:52.495Z] --- PASS: TestUpdateRestartWithAutoRemove (0.83s)
01:37:52 [2020-01-27T01:37:52.495Z] === RUN   TestWaitNonBlocked
01:37:52 [2020-01-27T01:37:52.495Z] === RUN   TestWaitNonBlocked/wait-nonblocking-exit-0
01:37:52 [2020-01-27T01:37:52.495Z] === PAUSE TestWaitNonBlocked/wait-nonblocking-exit-0
01:37:52 [2020-01-27T01:37:52.495Z] === RUN   TestWaitNonBlocked/wait-nonblocking-exit-random
01:37:52 [2020-01-27T01:37:52.495Z] === PAUSE TestWaitNonBlocked/wait-nonblocking-exit-random
01:37:52 [2020-01-27T01:37:52.495Z] === CONT  TestWaitNonBlocked/wait-nonblocking-exit-0
01:37:52 [2020-01-27T01:37:52.495Z] === CONT  TestWaitNonBlocked/wait-nonblocking-exit-random
01:37:53 [2020-01-27T01:37:53.697Z] --- PASS: TestWaitNonBlocked (0.01s)
01:37:53 [2020-01-27T01:37:53.698Z]     --- PASS: TestWaitNonBlocked/wait-nonblocking-exit-random (0.95s)
01:37:53 [2020-01-27T01:37:53.698Z]     --- PASS: TestWaitNonBlocked/wait-nonblocking-exit-0 (1.04s)
01:37:53 [2020-01-27T01:37:53.698Z] === RUN   TestWaitBlocked
01:37:53 [2020-01-27T01:37:53.698Z] === RUN   TestWaitBlocked/test-wait-blocked-exit-zero
01:37:53 [2020-01-27T01:37:53.698Z] === PAUSE TestWaitBlocked/test-wait-blocked-exit-zero
01:37:53 [2020-01-27T01:37:53.698Z] === RUN   TestWaitBlocked/test-wait-blocked-exit-random
01:37:53 [2020-01-27T01:37:53.698Z] === PAUSE TestWaitBlocked/test-wait-blocked-exit-random
01:37:53 [2020-01-27T01:37:53.698Z] === CONT  TestWaitBlocked/test-wait-blocked-exit-zero
01:37:53 [2020-01-27T01:37:53.698Z] === CONT  TestWaitBlocked/test-wait-blocked-exit-random
01:37:54 [2020-01-27T01:37:54.989Z] --- PASS: TestWaitBlocked (0.01s)
01:37:54 [2020-01-27T01:37:54.989Z]     --- PASS: TestWaitBlocked/test-wait-blocked-exit-zero (1.31s)
01:37:54 [2020-01-27T01:37:54.989Z]     --- PASS: TestWaitBlocked/test-wait-blocked-exit-random (1.38s)
01:37:54 [2020-01-27T01:37:54.989Z] === CONT  TestContainerStartOnDaemonRestart
01:37:54 [2020-01-27T01:37:54.989Z] === CONT  TestIpcModeOlderClient
01:37:54 [2020-01-27T01:37:54.989Z] --- PASS: TestIpcModeOlderClient (0.14s)
01:37:54 [2020-01-27T01:37:54.989Z] === CONT  TestDaemonHostGatewayIP
01:37:58 [2020-01-27T01:37:58.102Z] --- PASS: TestContainerStartOnDaemonRestart (2.89s)
01:37:58 [2020-01-27T01:37:58.102Z] === CONT  TestDaemonRestartIpcMode
01:37:58 [2020-01-27T01:37:58.449Z] --- PASS: TestDaemonHostGatewayIP (3.27s)
01:38:01 [2020-01-27T01:38:01.528Z] --- PASS: TestDaemonRestartIpcMode (3.19s)
01:38:01 [2020-01-27T01:38:01.528Z] PASS
01:38:01 [2020-01-27T01:38:01.528Z] 
01:38:01 [2020-01-27T01:38:01.528Z] === Skipped
01:38:01 [2020-01-27T01:38:01.528Z] === SKIP: s390x.integration.container TestCheckpoint (0.00s)
01:38:01 [2020-01-27T01:38:01.528Z]     checkpoint_test.go:33: TestCheckpoint is broken; see https://github.com/moby/moby/issues/38963
01:38:01 [2020-01-27T01:38:01.528Z] 
01:38:01 [2020-01-27T01:38:01.528Z] === SKIP: s390x.integration.container TestInspectOomKilledTrue (0.01s)
01:38:01 [2020-01-27T01:38:01.528Z]     kill_test.go:151: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
01:38:01 [2020-01-27T01:38:01.528Z] 
01:38:01 [2020-01-27T01:38:01.528Z] === SKIP: s390x.integration.container TestInspectOomKilledFalse (0.00s)
01:38:01 [2020-01-27T01:38:01.528Z]     kill_test.go:169: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
01:38:01 [2020-01-27T01:38:01.528Z] 
01:38:01 [2020-01-27T01:38:01.528Z] === SKIP: s390x.integration.container TestPauseFailsOnWindowsServerContainers (0.00s)
01:38:01 [2020-01-27T01:38:01.528Z]     pause_test.go:54: testEnv.DaemonInfo.OSType != "windows" || testEnv.DaemonInfo.Isolation != "process"
01:38:01 [2020-01-27T01:38:01.528Z] 
01:38:01 [2020-01-27T01:38:01.528Z] === SKIP: s390x.integration.container TestDeleteDevicemapper (0.00s)
01:38:01 [2020-01-27T01:38:01.528Z]     stop_linux_test.go:74: testEnv.DaemonInfo.Driver != "devicemapper"
01:38:01 [2020-01-27T01:38:01.528Z] 
01:38:01 [2020-01-27T01:38:01.528Z] === SKIP: s390x.integration.container TestUpdateMemory (0.00s)
01:38:01 [2020-01-27T01:38:01.528Z]     update_linux_test.go:23: !testEnv.DaemonInfo.SwapLimit
01:38:01 [2020-01-27T01:38:01.528Z] 
01:38:01 [2020-01-27T01:38:01.528Z] 
01:38:01 [2020-01-27T01:38:01.528Z] DONE 198 tests, 6 skipped in 130.855s
01:38:01 [2020-01-27T01:38:01.528Z] Running /go/src/github.com/docker/docker/integration/image (s390x.integration.image) flags=-test.v -test.timeout=120m 
01:38:01 [2020-01-27T01:38:01.528Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-image-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-image-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.image -t ./test.main -test.v -test.timeout=120m
01:38:01 [2020-01-27T01:38:01.528Z] ++ set -e
01:38:01 [2020-01-27T01:38:01.528Z] ++ '[' -n 0 ']'
01:38:01 [2020-01-27T01:38:01.528Z] ++ set -x
01:38:01 [2020-01-27T01:38:01.528Z] ++ 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=s390x 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/s390x-integration-image-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-image-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.image -t ./test.main -test.v -test.timeout=120m
01:38:01 [2020-01-27T01:38:01.528Z] INFO: Testing against a local daemon
01:38:01 [2020-01-27T01:38:01.528Z] === RUN   TestCommitInheritsEnv
01:38:01 [2020-01-27T01:38:01.875Z] --- PASS: TestCommitInheritsEnv (0.47s)
01:38:01 [2020-01-27T01:38:01.875Z] === RUN   TestImportExtremelyLargeImageWorks
01:38:01 [2020-01-27T01:38:01.875Z] === PAUSE TestImportExtremelyLargeImageWorks
01:38:01 [2020-01-27T01:38:01.875Z] === RUN   TestImagesFilterMultiReference
01:38:01 [2020-01-27T01:38:01.875Z] --- PASS: TestImagesFilterMultiReference (0.03s)
01:38:01 [2020-01-27T01:38:01.875Z] === RUN   TestImagePullPlatformInvalid
01:38:01 [2020-01-27T01:38:01.875Z] --- PASS: TestImagePullPlatformInvalid (0.01s)
01:38:01 [2020-01-27T01:38:01.875Z] === RUN   TestRemoveImageOrphaning
01:38:02 [2020-01-27T01:38:02.261Z] --- PASS: TestRemoveImageOrphaning (0.47s)
01:38:02 [2020-01-27T01:38:02.261Z] === RUN   TestRemoveImageGarbageCollector
01:38:02 [2020-01-27T01:38:02.261Z] --- SKIP: TestRemoveImageGarbageCollector (0.00s)
01:38:02 [2020-01-27T01:38:02.261Z]     remove_unix_test.go:36: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
01:38:02 [2020-01-27T01:38:02.261Z] === RUN   TestTagUnprefixedRepoByNameOrName
01:38:02 [2020-01-27T01:38:02.261Z] --- PASS: TestTagUnprefixedRepoByNameOrName (0.02s)
01:38:02 [2020-01-27T01:38:02.261Z] === RUN   TestTagInvalidReference
01:38:02 [2020-01-27T01:38:02.261Z] --- PASS: TestTagInvalidReference (0.01s)
01:38:02 [2020-01-27T01:38:02.261Z] === RUN   TestTagValidPrefixedRepo
01:38:02 [2020-01-27T01:38:02.261Z] --- PASS: TestTagValidPrefixedRepo (0.05s)
01:38:02 [2020-01-27T01:38:02.261Z] === RUN   TestTagExistedNameWithoutForce
01:38:02 [2020-01-27T01:38:02.261Z] --- PASS: TestTagExistedNameWithoutForce (0.02s)
01:38:02 [2020-01-27T01:38:02.261Z] === RUN   TestTagOfficialNames
01:38:02 [2020-01-27T01:38:02.672Z] --- PASS: TestTagOfficialNames (0.05s)
01:38:02 [2020-01-27T01:38:02.672Z] === RUN   TestTagMatchesDigest
01:38:02 [2020-01-27T01:38:02.672Z] --- PASS: TestTagMatchesDigest (0.01s)
01:38:02 [2020-01-27T01:38:02.672Z] === CONT  TestImportExtremelyLargeImageWorks
01:39:26 [2020-01-27T01:39:26.443Z] --- PASS: TestImportExtremelyLargeImageWorks (79.34s)
01:39:26 [2020-01-27T01:39:26.443Z] PASS
01:39:26 [2020-01-27T01:39:26.443Z] 
01:39:26 [2020-01-27T01:39:26.443Z] === Skipped
01:39:26 [2020-01-27T01:39:26.443Z] === SKIP: s390x.integration.image TestRemoveImageGarbageCollector (0.00s)
01:39:26 [2020-01-27T01:39:26.443Z]     remove_unix_test.go:36: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
01:39:26 [2020-01-27T01:39:26.443Z] 
01:39:26 [2020-01-27T01:39:26.443Z] 
01:39:26 [2020-01-27T01:39:26.443Z] DONE 12 tests, 1 skipped in 80.741s
01:39:26 [2020-01-27T01:39:26.443Z] Running /go/src/github.com/docker/docker/integration/network (s390x.integration.network) flags=-test.v -test.timeout=120m 
01:39:26 [2020-01-27T01:39:26.443Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-network-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-network-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.network -t ./test.main -test.v -test.timeout=120m
01:39:26 [2020-01-27T01:39:26.443Z] ++ set -e
01:39:26 [2020-01-27T01:39:26.443Z] ++ '[' -n 0 ']'
01:39:26 [2020-01-27T01:39:26.443Z] ++ set -x
01:39:26 [2020-01-27T01:39:26.443Z] ++ 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=s390x 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/s390x-integration-network-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-network-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.network -t ./test.main -test.v -test.timeout=120m
01:39:26 [2020-01-27T01:39:26.443Z] INFO: Testing against a local daemon
01:39:26 [2020-01-27T01:39:26.443Z] === RUN   TestNetworkCreateDelete
01:39:26 [2020-01-27T01:39:26.443Z] --- PASS: TestNetworkCreateDelete (0.12s)
01:39:26 [2020-01-27T01:39:26.443Z] === RUN   TestDockerNetworkDeletePreferID
01:39:26 [2020-01-27T01:39:26.443Z] --- PASS: TestDockerNetworkDeletePreferID (0.33s)
01:39:26 [2020-01-27T01:39:26.443Z] === RUN   TestInspectNetwork
01:39:26 [2020-01-27T01:39:26.443Z] === RUN   TestInspectNetwork/full_network_id
01:39:26 [2020-01-27T01:39:26.443Z] === RUN   TestInspectNetwork/partial_network_id
01:39:26 [2020-01-27T01:39:26.443Z] === RUN   TestInspectNetwork/network_name
01:39:26 [2020-01-27T01:39:26.443Z] === RUN   TestInspectNetwork/network_name_and_swarm_scope
01:39:30 [2020-01-27T01:39:30.325Z] --- PASS: TestInspectNetwork (7.85s)
01:39:30 [2020-01-27T01:39:30.325Z]     --- PASS: TestInspectNetwork/full_network_id (0.01s)
01:39:30 [2020-01-27T01:39:30.325Z]     --- PASS: TestInspectNetwork/partial_network_id (0.00s)
01:39:30 [2020-01-27T01:39:30.325Z]     --- PASS: TestInspectNetwork/network_name (0.00s)
01:39:30 [2020-01-27T01:39:30.325Z]     --- PASS: TestInspectNetwork/network_name_and_swarm_scope (0.00s)
01:39:30 [2020-01-27T01:39:30.325Z] === RUN   TestRunContainerWithBridgeNone
01:39:32 [2020-01-27T01:39:32.668Z] --- PASS: TestRunContainerWithBridgeNone (2.44s)
01:39:32 [2020-01-27T01:39:32.668Z] === RUN   TestNetworkInvalidJSON
01:39:32 [2020-01-27T01:39:32.668Z] === RUN   TestNetworkInvalidJSON//networks/create
01:39:32 [2020-01-27T01:39:32.668Z] === PAUSE TestNetworkInvalidJSON//networks/create
01:39:32 [2020-01-27T01:39:32.668Z] === RUN   TestNetworkInvalidJSON//networks/bridge/connect
01:39:32 [2020-01-27T01:39:32.668Z] === PAUSE TestNetworkInvalidJSON//networks/bridge/connect
01:39:32 [2020-01-27T01:39:32.668Z] === RUN   TestNetworkInvalidJSON//networks/bridge/disconnect
01:39:32 [2020-01-27T01:39:32.668Z] === PAUSE TestNetworkInvalidJSON//networks/bridge/disconnect
01:39:32 [2020-01-27T01:39:32.668Z] === CONT  TestNetworkInvalidJSON//networks/create
01:39:32 [2020-01-27T01:39:32.668Z] === CONT  TestNetworkInvalidJSON//networks/bridge/disconnect
01:39:32 [2020-01-27T01:39:32.668Z] === CONT  TestNetworkInvalidJSON//networks/bridge/connect
01:39:32 [2020-01-27T01:39:32.668Z] --- PASS: TestNetworkInvalidJSON (0.04s)
01:39:32 [2020-01-27T01:39:32.668Z]     --- PASS: TestNetworkInvalidJSON//networks/bridge/disconnect (0.00s)
01:39:32 [2020-01-27T01:39:32.668Z]     --- PASS: TestNetworkInvalidJSON//networks/bridge/connect (0.00s)
01:39:32 [2020-01-27T01:39:32.668Z]     --- PASS: TestNetworkInvalidJSON//networks/create (0.00s)
01:39:32 [2020-01-27T01:39:32.668Z] === RUN   TestDaemonRestartWithLiveRestore
01:39:33 [2020-01-27T01:39:33.919Z] --- PASS: TestDaemonRestartWithLiveRestore (1.03s)
01:39:33 [2020-01-27T01:39:33.919Z] === RUN   TestDaemonDefaultNetworkPools
01:39:34 [2020-01-27T01:39:34.667Z] --- PASS: TestDaemonDefaultNetworkPools (0.72s)
01:39:34 [2020-01-27T01:39:34.667Z] === RUN   TestDaemonRestartWithExistingNetwork
01:39:35 [2020-01-27T01:39:35.869Z] --- PASS: TestDaemonRestartWithExistingNetwork (1.13s)
01:39:35 [2020-01-27T01:39:35.869Z] === RUN   TestDaemonRestartWithExistingNetworkWithDefaultPoolRange
01:39:37 [2020-01-27T01:39:37.070Z] --- PASS: TestDaemonRestartWithExistingNetworkWithDefaultPoolRange (1.17s)
01:39:37 [2020-01-27T01:39:37.070Z] === RUN   TestDaemonWithBipAndDefaultNetworkPool
01:39:37 [2020-01-27T01:39:37.416Z] --- PASS: TestDaemonWithBipAndDefaultNetworkPool (0.60s)
01:39:37 [2020-01-27T01:39:37.416Z] === RUN   TestServiceWithPredefinedNetwork
01:39:40 [2020-01-27T01:39:40.487Z] --- PASS: TestServiceWithPredefinedNetwork (2.72s)
01:39:40 [2020-01-27T01:39:40.487Z] === RUN   TestServiceRemoveKeepsIngressNetwork
01:39:40 [2020-01-27T01:39:40.487Z] --- SKIP: TestServiceRemoveKeepsIngressNetwork (0.00s)
01:39:40 [2020-01-27T01:39:40.487Z]     service_test.go:230: FLAKY_TEST
01:39:40 [2020-01-27T01:39:40.487Z] === RUN   TestServiceWithDataPathPortInit
01:39:56 [2020-01-27T01:39:56.693Z] --- PASS: TestServiceWithDataPathPortInit (16.01s)
01:39:56 [2020-01-27T01:39:56.693Z] === RUN   TestServiceWithDefaultAddressPoolInit
01:40:05 [2020-01-27T01:40:05.838Z] --- PASS: TestServiceWithDefaultAddressPoolInit (8.31s)
01:40:05 [2020-01-27T01:40:05.838Z]     service_test.go:418: TestServiceWithDefaultAddressPoolInit: NetworkInspect: {Name:sthiraTestServiceWithDefaultAddressPoolInit ID:bui1852l5m0778w4inxns806f Created:2020-01-27 01:39:57.481431849 +0000 UTC Scope:swarm Driver:overlay EnableIPv6:false IPAM:{Driver:default Options:map[] Config:[{Subnet:20.20.1.0/24 IPRange: Gateway:20.20.1.1 AuxAddress:map[]}]} Internal:false Attachable:false Ingress:false ConfigFrom:{Network:} ConfigOnly:false Containers:map[41f76bfdf110457319da52d80ba0ad3ab0714ed7ab0139c332ef860ad77eed3f:{Name:TestServiceTestServiceWithDefaultAddressPoolInit.1.5b90juofio3o30oyfnf5a818c EndpointID:ae8b64889d87aff84bc05fde452fd40b33251777b56abe116ebd3bd07cb0bbcc MacAddress:02:42:14:14:01:03 IPv4Address:20.20.1.3/24 IPv6Address:} lb-sthiraTestServiceWithDefaultAddressPoolInit:{Name:sthiraTestServiceWithDefaultAddressPoolInit-endpoint EndpointID:58c4f21fd579a55b7c7ead4082c8a7c84c62a5ad79171658d7063fd84d8387aa MacAddress:02:42:14:14:01:04 IPv4Address:20.20.1.4/24 IPv6Address:}] Options:map[com.docker.network.driver.overlay.vxlanid_list:4097] Labels:map[] Peers:[{Name:b220f94b3d76 IP:127.0.0.1}] Services:map[TestServiceTestServiceWithDefaultAddressPoolInit:{VIP:20.20.1.2 Ports:[] LocalLBIndex:256 Tasks:[{Name:TestServiceTestServiceWithDefaultAddressPoolInit.1.5b90juofio3o30oyfnf5a818c EndpointID:ae8b64889d87aff84bc05fde452fd40b33251777b56abe116ebd3bd07cb0bbcc EndpointIP:20.20.1.3 Info:map[Host IP:127.0.0.1]}]}]}
01:40:05 [2020-01-27T01:40:05.838Z] PASS
01:40:05 [2020-01-27T01:40:05.838Z] 
01:40:05 [2020-01-27T01:40:05.838Z] === Skipped
01:40:05 [2020-01-27T01:40:05.838Z] === SKIP: s390x.integration.network TestServiceRemoveKeepsIngressNetwork (0.00s)
01:40:05 [2020-01-27T01:40:05.838Z]     service_test.go:230: FLAKY_TEST
01:40:05 [2020-01-27T01:40:05.838Z] 
01:40:05 [2020-01-27T01:40:05.838Z] 
01:40:05 [2020-01-27T01:40:05.838Z] DONE 21 tests, 1 skipped in 42.678s
01:40:05 [2020-01-27T01:40:05.838Z] Running /go/src/github.com/docker/docker/integration/network/ipvlan (s390x.integration.network.ipvlan) flags=-test.v -test.timeout=120m 
01:40:05 [2020-01-27T01:40:05.838Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-network-ipvlan-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-network-ipvlan-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.network.ipvlan -t ./test.main -test.v -test.timeout=120m
01:40:05 [2020-01-27T01:40:05.838Z] ++ set -e
01:40:05 [2020-01-27T01:40:05.838Z] ++ '[' -n 0 ']'
01:40:05 [2020-01-27T01:40:05.838Z] ++ set -x
01:40:05 [2020-01-27T01:40:05.838Z] ++ 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=s390x 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/s390x-integration-network-ipvlan-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-network-ipvlan-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.network.ipvlan -t ./test.main -test.v -test.timeout=120m
01:40:05 [2020-01-27T01:40:05.838Z] INFO: Testing against a local daemon
01:40:05 [2020-01-27T01:40:05.838Z] === RUN   TestDockerNetworkIpvlanPersistance
01:40:05 [2020-01-27T01:40:05.838Z] --- SKIP: TestDockerNetworkIpvlanPersistance (0.01s)
01:40:05 [2020-01-27T01:40:05.838Z]     ipvlan_test.go:26: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
01:40:05 [2020-01-27T01:40:05.838Z] === RUN   TestDockerNetworkIpvlan
01:40:05 [2020-01-27T01:40:05.838Z] --- SKIP: TestDockerNetworkIpvlan (0.00s)
01:40:05 [2020-01-27T01:40:05.838Z]     ipvlan_test.go:53: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
01:40:05 [2020-01-27T01:40:05.838Z] PASS
01:40:05 [2020-01-27T01:40:05.838Z] 
01:40:05 [2020-01-27T01:40:05.838Z] === Skipped
01:40:05 [2020-01-27T01:40:05.838Z] === SKIP: s390x.integration.network.ipvlan TestDockerNetworkIpvlanPersistance (0.01s)
01:40:05 [2020-01-27T01:40:05.838Z]     ipvlan_test.go:26: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
01:40:05 [2020-01-27T01:40:05.838Z] 
01:40:05 [2020-01-27T01:40:05.838Z] === SKIP: s390x.integration.network.ipvlan TestDockerNetworkIpvlan (0.00s)
01:40:05 [2020-01-27T01:40:05.838Z]     ipvlan_test.go:53: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
01:40:05 [2020-01-27T01:40:05.838Z] 
01:40:05 [2020-01-27T01:40:05.838Z] 
01:40:05 [2020-01-27T01:40:05.838Z] DONE 2 tests, 2 skipped in 0.169s
01:40:05 [2020-01-27T01:40:05.838Z] Running /go/src/github.com/docker/docker/integration/network/macvlan (s390x.integration.network.macvlan) flags=-test.v -test.timeout=120m 
01:40:05 [2020-01-27T01:40:05.838Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-network-macvlan-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-network-macvlan-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.network.macvlan -t ./test.main -test.v -test.timeout=120m
01:40:05 [2020-01-27T01:40:05.838Z] ++ set -e
01:40:05 [2020-01-27T01:40:05.838Z] ++ '[' -n 0 ']'
01:40:05 [2020-01-27T01:40:05.838Z] ++ set -x
01:40:05 [2020-01-27T01:40:05.838Z] ++ 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=s390x 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/s390x-integration-network-macvlan-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-network-macvlan-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.network.macvlan -t ./test.main -test.v -test.timeout=120m
01:40:05 [2020-01-27T01:40:05.838Z] INFO: Testing against a local daemon
01:40:05 [2020-01-27T01:40:05.838Z] === RUN   TestDockerNetworkMacvlanPersistance
01:40:06 [2020-01-27T01:40:06.183Z] --- PASS: TestDockerNetworkMacvlanPersistance (1.32s)
01:40:06 [2020-01-27T01:40:06.183Z] === RUN   TestDockerNetworkMacvlan
01:40:06 [2020-01-27T01:40:06.953Z] === RUN   TestDockerNetworkMacvlan/Subinterface
01:40:07 [2020-01-27T01:40:07.723Z] === RUN   TestDockerNetworkMacvlan/OverlapParent
01:40:08 [2020-01-27T01:40:08.464Z] === RUN   TestDockerNetworkMacvlan/NilParent
01:40:10 [2020-01-27T01:40:10.806Z] === RUN   TestDockerNetworkMacvlan/InternalMode
01:40:14 [2020-01-27T01:40:14.780Z] === RUN   TestDockerNetworkMacvlan/MultiSubnet
01:40:18 [2020-01-27T01:40:18.735Z] === RUN   TestDockerNetworkMacvlan/Addressing
01:40:19 [2020-01-27T01:40:19.976Z] --- PASS: TestDockerNetworkMacvlan (13.68s)
01:40:19 [2020-01-27T01:40:19.976Z]     --- PASS: TestDockerNetworkMacvlan/Subinterface (0.05s)
01:40:19 [2020-01-27T01:40:19.976Z]     --- PASS: TestDockerNetworkMacvlan/OverlapParent (0.08s)
01:40:19 [2020-01-27T01:40:19.976Z]     --- PASS: TestDockerNetworkMacvlan/NilParent (1.14s)
01:40:19 [2020-01-27T01:40:19.976Z]     --- PASS: TestDockerNetworkMacvlan/InternalMode (2.18s)
01:40:19 [2020-01-27T01:40:19.976Z]     --- PASS: TestDockerNetworkMacvlan/MultiSubnet (2.64s)
01:40:19 [2020-01-27T01:40:19.976Z]     --- PASS: TestDockerNetworkMacvlan/Addressing (0.78s)
01:40:19 [2020-01-27T01:40:19.976Z] PASS
01:40:19 [2020-01-27T01:40:19.976Z] 
01:40:19 [2020-01-27T01:40:19.976Z] DONE 8 tests in 15.125s
01:40:19 [2020-01-27T01:40:19.976Z] Running /go/src/github.com/docker/docker/integration/plugin (s390x.integration.plugin) flags=-test.v -test.timeout=120m 
01:40:19 [2020-01-27T01:40:19.976Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.plugin -t ./test.main -test.v -test.timeout=120m
01:40:19 [2020-01-27T01:40:19.976Z] ++ set -e
01:40:19 [2020-01-27T01:40:19.976Z] ++ '[' -n 0 ']'
01:40:19 [2020-01-27T01:40:19.976Z] ++ set -x
01:40:19 [2020-01-27T01:40:19.976Z] ++ 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=s390x 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/s390x-integration-plugin-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.plugin -t ./test.main -test.v -test.timeout=120m
01:40:19 [2020-01-27T01:40:19.976Z] testing: warning: no tests to run
01:40:19 [2020-01-27T01:40:19.976Z] PASS
01:40:19 [2020-01-27T01:40:19.976Z] 
01:40:19 [2020-01-27T01:40:19.976Z] DONE 0 tests in 0.063s
01:40:19 [2020-01-27T01:40:19.976Z] Running /go/src/github.com/docker/docker/integration/plugin/authz (s390x.integration.plugin.authz) flags=-test.v -test.timeout=120m 
01:40:19 [2020-01-27T01:40:19.976Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-authz-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-authz-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.plugin.authz -t ./test.main -test.v -test.timeout=120m
01:40:19 [2020-01-27T01:40:19.976Z] ++ set -e
01:40:19 [2020-01-27T01:40:19.976Z] ++ '[' -n 0 ']'
01:40:19 [2020-01-27T01:40:19.976Z] ++ set -x
01:40:19 [2020-01-27T01:40:19.976Z] ++ 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=s390x 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/s390x-integration-plugin-authz-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-authz-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.plugin.authz -t ./test.main -test.v -test.timeout=120m
01:40:19 [2020-01-27T01:40:19.976Z] INFO: Testing against a local daemon
01:40:19 [2020-01-27T01:40:19.976Z] === RUN   TestAuthZPluginAllowRequest
01:40:21 [2020-01-27T01:40:21.774Z] --- PASS: TestAuthZPluginAllowRequest (1.66s)
01:40:21 [2020-01-27T01:40:21.774Z] === RUN   TestAuthZPluginTLS
01:40:22 [2020-01-27T01:40:22.126Z] --- PASS: TestAuthZPluginTLS (0.56s)
01:40:22 [2020-01-27T01:40:22.126Z] === RUN   TestAuthZPluginDenyRequest
01:40:22 [2020-01-27T01:40:22.868Z] --- PASS: TestAuthZPluginDenyRequest (0.53s)
01:40:22 [2020-01-27T01:40:22.868Z] === RUN   TestAuthZPluginAPIDenyResponse
01:40:23 [2020-01-27T01:40:23.219Z] --- PASS: TestAuthZPluginAPIDenyResponse (0.53s)
01:40:23 [2020-01-27T01:40:23.219Z] === RUN   TestAuthZPluginDenyResponse
01:40:23 [2020-01-27T01:40:23.957Z] --- PASS: TestAuthZPluginDenyResponse (0.53s)
01:40:23 [2020-01-27T01:40:23.957Z] === RUN   TestAuthZPluginAllowEventStream
01:40:25 [2020-01-27T01:40:25.681Z] --- PASS: TestAuthZPluginAllowEventStream (1.59s)
01:40:25 [2020-01-27T01:40:25.681Z] === RUN   TestAuthZPluginErrorResponse
01:40:26 [2020-01-27T01:40:26.032Z] --- PASS: TestAuthZPluginErrorResponse (0.54s)
01:40:26 [2020-01-27T01:40:26.032Z] === RUN   TestAuthZPluginErrorRequest
01:40:26 [2020-01-27T01:40:26.384Z] --- PASS: TestAuthZPluginErrorRequest (0.52s)
01:40:26 [2020-01-27T01:40:26.384Z] === RUN   TestAuthZPluginEnsureNoDuplicatePluginRegistration
01:40:27 [2020-01-27T01:40:27.127Z] --- PASS: TestAuthZPluginEnsureNoDuplicatePluginRegistration (0.53s)
01:40:27 [2020-01-27T01:40:27.127Z] === RUN   TestAuthZPluginEnsureLoadImportWorking
01:40:28 [2020-01-27T01:40:28.987Z] --- PASS: TestAuthZPluginEnsureLoadImportWorking (2.03s)
01:40:28 [2020-01-27T01:40:28.987Z] === RUN   TestAuthzPluginEnsureContainerCopyToFrom
01:40:31 [2020-01-27T01:40:31.363Z] --- PASS: TestAuthzPluginEnsureContainerCopyToFrom (1.97s)
01:40:31 [2020-01-27T01:40:31.363Z] === RUN   TestAuthZPluginHeader
01:40:31 [2020-01-27T01:40:31.730Z] --- PASS: TestAuthZPluginHeader (0.85s)
01:40:31 [2020-01-27T01:40:31.730Z] === RUN   TestAuthZPluginV2AllowNonVolumeRequest
01:40:31 [2020-01-27T01:40:31.730Z] --- SKIP: TestAuthZPluginV2AllowNonVolumeRequest (0.00s)
01:40:31 [2020-01-27T01:40:31.730Z]     authz_plugin_v2_test.go:43: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
01:40:31 [2020-01-27T01:40:31.730Z] === RUN   TestAuthZPluginV2Disable
01:40:31 [2020-01-27T01:40:31.730Z] --- SKIP: TestAuthZPluginV2Disable (0.00s)
01:40:31 [2020-01-27T01:40:31.730Z]     authz_plugin_v2_test.go:65: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
01:40:31 [2020-01-27T01:40:31.730Z] === RUN   TestAuthZPluginV2RejectVolumeRequests
01:40:31 [2020-01-27T01:40:31.730Z] --- SKIP: TestAuthZPluginV2RejectVolumeRequests (0.00s)
01:40:31 [2020-01-27T01:40:31.730Z]     authz_plugin_v2_test.go:91: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
01:40:31 [2020-01-27T01:40:31.730Z] === RUN   TestAuthZPluginV2BadManifestFailsDaemonStart
01:40:31 [2020-01-27T01:40:31.730Z] --- SKIP: TestAuthZPluginV2BadManifestFailsDaemonStart (0.00s)
01:40:31 [2020-01-27T01:40:31.730Z]     authz_plugin_v2_test.go:126: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
01:40:31 [2020-01-27T01:40:31.730Z] === RUN   TestAuthZPluginV2NonexistentFailsDaemonStart
01:40:51 [2020-01-27T01:40:51.183Z] --- PASS: TestAuthZPluginV2NonexistentFailsDaemonStart (16.78s)
01:40:51 [2020-01-27T01:40:51.183Z] PASS
01:40:51 [2020-01-27T01:40:51.183Z] 
01:40:51 [2020-01-27T01:40:51.183Z] === Skipped
01:40:51 [2020-01-27T01:40:51.183Z] === SKIP: s390x.integration.plugin.authz TestAuthZPluginV2AllowNonVolumeRequest (0.00s)
01:40:51 [2020-01-27T01:40:51.183Z]     authz_plugin_v2_test.go:43: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
01:40:51 [2020-01-27T01:40:51.183Z] 
01:40:51 [2020-01-27T01:40:51.183Z] === SKIP: s390x.integration.plugin.authz TestAuthZPluginV2Disable (0.00s)
01:40:51 [2020-01-27T01:40:51.183Z]     authz_plugin_v2_test.go:65: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
01:40:51 [2020-01-27T01:40:51.183Z] 
01:40:51 [2020-01-27T01:40:51.183Z] === SKIP: s390x.integration.plugin.authz TestAuthZPluginV2RejectVolumeRequests (0.00s)
01:40:51 [2020-01-27T01:40:51.183Z]     authz_plugin_v2_test.go:91: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
01:40:51 [2020-01-27T01:40:51.183Z] 
01:40:51 [2020-01-27T01:40:51.183Z] === SKIP: s390x.integration.plugin.authz TestAuthZPluginV2BadManifestFailsDaemonStart (0.00s)
01:40:51 [2020-01-27T01:40:51.183Z]     authz_plugin_v2_test.go:126: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
01:40:51 [2020-01-27T01:40:51.183Z] 
01:40:51 [2020-01-27T01:40:51.183Z] 
01:40:51 [2020-01-27T01:40:51.183Z] DONE 17 tests, 4 skipped in 28.760s
01:40:51 [2020-01-27T01:40:51.183Z] Running /go/src/github.com/docker/docker/integration/plugin/common (s390x.integration.plugin.common) flags=-test.v -test.timeout=120m 
01:40:51 [2020-01-27T01:40:51.183Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-common-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-common-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.plugin.common -t ./test.main -test.v -test.timeout=120m
01:40:51 [2020-01-27T01:40:51.183Z] ++ set -e
01:40:51 [2020-01-27T01:40:51.183Z] ++ '[' -n 0 ']'
01:40:51 [2020-01-27T01:40:51.183Z] ++ set -x
01:40:51 [2020-01-27T01:40:51.183Z] ++ 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=s390x 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/s390x-integration-plugin-common-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-common-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.plugin.common -t ./test.main -test.v -test.timeout=120m
01:40:51 [2020-01-27T01:40:51.183Z] INFO: Testing against a local daemon
01:40:51 [2020-01-27T01:40:51.183Z] === RUN   TestPluginInvalidJSON
01:40:51 [2020-01-27T01:40:51.183Z] === RUN   TestPluginInvalidJSON//plugins/foobar/set
01:40:51 [2020-01-27T01:40:51.183Z] === PAUSE TestPluginInvalidJSON//plugins/foobar/set
01:40:51 [2020-01-27T01:40:51.183Z] === CONT  TestPluginInvalidJSON//plugins/foobar/set
01:40:51 [2020-01-27T01:40:51.183Z] --- PASS: TestPluginInvalidJSON (0.01s)
01:40:51 [2020-01-27T01:40:51.183Z]     --- PASS: TestPluginInvalidJSON//plugins/foobar/set (0.00s)
01:40:51 [2020-01-27T01:40:51.183Z] PASS
01:40:51 [2020-01-27T01:40:51.183Z] 
01:40:51 [2020-01-27T01:40:51.183Z] DONE 2 tests in 0.148s
01:40:51 [2020-01-27T01:40:51.183Z] Running /go/src/github.com/docker/docker/integration/plugin/graphdriver (s390x.integration.plugin.graphdriver) flags=-test.v -test.timeout=120m 
01:40:51 [2020-01-27T01:40:51.183Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-graphdriver-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-graphdriver-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.plugin.graphdriver -t ./test.main -test.v -test.timeout=120m
01:40:51 [2020-01-27T01:40:51.183Z] ++ set -e
01:40:51 [2020-01-27T01:40:51.183Z] ++ '[' -n 0 ']'
01:40:51 [2020-01-27T01:40:51.183Z] ++ set -x
01:40:51 [2020-01-27T01:40:51.183Z] ++ 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=s390x 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/s390x-integration-plugin-graphdriver-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-graphdriver-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.plugin.graphdriver -t ./test.main -test.v -test.timeout=120m
01:40:51 [2020-01-27T01:40:51.183Z] INFO: Testing against a local daemon
01:40:51 [2020-01-27T01:40:51.183Z] === RUN   TestExternalGraphDriver
01:40:51 [2020-01-27T01:40:51.183Z] === RUN   TestExternalGraphDriver/json
01:40:51 [2020-01-27T01:40:51.183Z] === RUN   TestExternalGraphDriver/spec
01:40:53 [2020-01-27T01:40:53.545Z] === RUN   TestExternalGraphDriver/pull
01:40:55 [2020-01-27T01:40:55.307Z] --- PASS: TestExternalGraphDriver (6.14s)
01:40:55 [2020-01-27T01:40:55.307Z]     --- PASS: TestExternalGraphDriver/json (1.96s)
01:40:55 [2020-01-27T01:40:55.307Z]     --- PASS: TestExternalGraphDriver/spec (2.04s)
01:40:55 [2020-01-27T01:40:55.307Z]     --- PASS: TestExternalGraphDriver/pull (2.02s)
01:40:55 [2020-01-27T01:40:55.307Z] === RUN   TestGraphdriverPluginV2
01:40:55 [2020-01-27T01:40:55.307Z] --- SKIP: TestGraphdriverPluginV2 (0.06s)
01:40:55 [2020-01-27T01:40:55.307Z]     external_test.go:410: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
01:40:55 [2020-01-27T01:40:55.307Z] PASS
01:40:55 [2020-01-27T01:40:55.307Z] 
01:40:55 [2020-01-27T01:40:55.307Z] === Skipped
01:40:55 [2020-01-27T01:40:55.307Z] === SKIP: s390x.integration.plugin.graphdriver TestGraphdriverPluginV2 (0.06s)
01:40:55 [2020-01-27T01:40:55.307Z]     external_test.go:410: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
01:40:55 [2020-01-27T01:40:55.307Z] 
01:40:55 [2020-01-27T01:40:55.307Z] 
01:40:55 [2020-01-27T01:40:55.307Z] DONE 5 tests, 1 skipped in 6.362s
01:40:55 [2020-01-27T01:40:55.307Z] Running /go/src/github.com/docker/docker/integration/plugin/logging (s390x.integration.plugin.logging) flags=-test.v -test.timeout=120m 
01:40:55 [2020-01-27T01:40:55.307Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-logging-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-logging-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.plugin.logging -t ./test.main -test.v -test.timeout=120m
01:40:55 [2020-01-27T01:40:55.307Z] ++ set -e
01:40:55 [2020-01-27T01:40:55.307Z] ++ '[' -n 0 ']'
01:40:55 [2020-01-27T01:40:55.307Z] ++ set -x
01:40:55 [2020-01-27T01:40:55.307Z] ++ 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=s390x 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/s390x-integration-plugin-logging-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-logging-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.plugin.logging -t ./test.main -test.v -test.timeout=120m
01:40:55 [2020-01-27T01:40:55.307Z] INFO: Testing against a local daemon
01:40:55 [2020-01-27T01:40:55.307Z] === RUN   TestContinueAfterPluginCrash
01:40:55 [2020-01-27T01:40:55.307Z] === PAUSE TestContinueAfterPluginCrash
01:40:55 [2020-01-27T01:40:55.307Z] === RUN   TestDaemonStartWithLogOpt
01:40:55 [2020-01-27T01:40:55.307Z] === PAUSE TestDaemonStartWithLogOpt
01:40:55 [2020-01-27T01:40:55.307Z] === CONT  TestContinueAfterPluginCrash
01:40:55 [2020-01-27T01:40:55.307Z] === CONT  TestDaemonStartWithLogOpt
01:41:04 [2020-01-27T01:41:04.633Z] --- PASS: TestDaemonStartWithLogOpt (9.25s)
01:41:09 [2020-01-27T01:41:09.505Z] --- PASS: TestContinueAfterPluginCrash (14.13s)
01:41:09 [2020-01-27T01:41:09.505Z] PASS
01:41:09 [2020-01-27T01:41:09.505Z] 
01:41:09 [2020-01-27T01:41:09.505Z] DONE 2 tests in 14.233s
01:41:09 [2020-01-27T01:41:09.505Z] Running /go/src/github.com/docker/docker/integration/plugin/volumes (s390x.integration.plugin.volumes) flags=-test.v -test.timeout=120m 
01:41:09 [2020-01-27T01:41:09.505Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-volumes-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-volumes-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.plugin.volumes -t ./test.main -test.v -test.timeout=120m
01:41:09 [2020-01-27T01:41:09.505Z] ++ set -e
01:41:09 [2020-01-27T01:41:09.505Z] ++ '[' -n 0 ']'
01:41:09 [2020-01-27T01:41:09.505Z] ++ set -x
01:41:09 [2020-01-27T01:41:09.505Z] ++ 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=s390x 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/s390x-integration-plugin-volumes-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-volumes-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.plugin.volumes -t ./test.main -test.v -test.timeout=120m
01:41:09 [2020-01-27T01:41:09.856Z] INFO: Testing against a local daemon
01:41:09 [2020-01-27T01:41:09.856Z] === RUN   TestPluginWithDevMounts
01:41:09 [2020-01-27T01:41:09.856Z] === PAUSE TestPluginWithDevMounts
01:41:09 [2020-01-27T01:41:09.856Z] === CONT  TestPluginWithDevMounts
01:41:11 [2020-01-27T01:41:11.602Z] --- PASS: TestPluginWithDevMounts (1.89s)
01:41:11 [2020-01-27T01:41:11.602Z] PASS
01:41:11 [2020-01-27T01:41:11.602Z] 
01:41:11 [2020-01-27T01:41:11.602Z] DONE 1 tests in 2.203s
01:41:11 [2020-01-27T01:41:11.602Z] Running /go/src/github.com/docker/docker/integration/secret (s390x.integration.secret) flags=-test.v -test.timeout=120m 
01:41:11 [2020-01-27T01:41:11.602Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-secret-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-secret-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.secret -t ./test.main -test.v -test.timeout=120m
01:41:11 [2020-01-27T01:41:11.602Z] ++ set -e
01:41:11 [2020-01-27T01:41:11.602Z] ++ '[' -n 0 ']'
01:41:11 [2020-01-27T01:41:11.602Z] ++ set -x
01:41:11 [2020-01-27T01:41:11.602Z] ++ 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=s390x 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/s390x-integration-secret-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-secret-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.secret -t ./test.main -test.v -test.timeout=120m
01:41:11 [2020-01-27T01:41:11.990Z] INFO: Testing against a local daemon
01:41:11 [2020-01-27T01:41:11.990Z] === RUN   TestSecretInspect
01:41:15 [2020-01-27T01:41:15.149Z] --- PASS: TestSecretInspect (2.79s)
01:41:15 [2020-01-27T01:41:15.149Z] === RUN   TestSecretList
01:41:17 [2020-01-27T01:41:17.508Z] --- PASS: TestSecretList (2.71s)
01:41:17 [2020-01-27T01:41:17.508Z] === RUN   TestSecretsCreateAndDelete
01:41:20 [2020-01-27T01:41:20.602Z] --- PASS: TestSecretsCreateAndDelete (2.77s)
01:41:20 [2020-01-27T01:41:20.602Z] === RUN   TestSecretsUpdate
01:41:23 [2020-01-27T01:41:23.048Z] --- PASS: TestSecretsUpdate (2.77s)
01:41:23 [2020-01-27T01:41:23.048Z] === RUN   TestTemplatedSecret
01:41:26 [2020-01-27T01:41:26.118Z] --- PASS: TestTemplatedSecret (3.18s)
01:41:26 [2020-01-27T01:41:26.118Z] === RUN   TestSecretCreateResolve
01:41:29 [2020-01-27T01:41:29.201Z] --- PASS: TestSecretCreateResolve (2.71s)
01:41:29 [2020-01-27T01:41:29.201Z] PASS
01:41:29 [2020-01-27T01:41:29.201Z] 
01:41:29 [2020-01-27T01:41:29.201Z] DONE 6 tests in 17.211s
01:41:29 [2020-01-27T01:41:29.201Z] Running /go/src/github.com/docker/docker/integration/service (s390x.integration.service) flags=-test.v -test.timeout=120m 
01:41:29 [2020-01-27T01:41:29.201Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-service-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-service-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.service -t ./test.main -test.v -test.timeout=120m
01:41:29 [2020-01-27T01:41:29.201Z] ++ set -e
01:41:29 [2020-01-27T01:41:29.201Z] ++ '[' -n 0 ']'
01:41:29 [2020-01-27T01:41:29.201Z] ++ set -x
01:41:29 [2020-01-27T01:41:29.201Z] ++ 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=s390x 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/s390x-integration-service-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-service-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.service -t ./test.main -test.v -test.timeout=120m
01:41:29 [2020-01-27T01:41:29.201Z] INFO: Testing against a local daemon
01:41:29 [2020-01-27T01:41:29.201Z] === RUN   TestServiceCreateInit
01:41:29 [2020-01-27T01:41:29.201Z] === RUN   TestServiceCreateInit/daemonInitDisabled
01:41:34 [2020-01-27T01:41:34.253Z] === RUN   TestServiceCreateInit/daemonInitEnabled
01:41:39 [2020-01-27T01:41:39.154Z] --- PASS: TestServiceCreateInit (9.59s)
01:41:39 [2020-01-27T01:41:39.154Z]     --- PASS: TestServiceCreateInit/daemonInitDisabled (4.87s)
01:41:39 [2020-01-27T01:41:39.154Z]     --- PASS: TestServiceCreateInit/daemonInitEnabled (4.70s)
01:41:39 [2020-01-27T01:41:39.154Z] === RUN   TestCreateServiceMultipleTimes
01:41:55 [2020-01-27T01:41:55.298Z] --- PASS: TestCreateServiceMultipleTimes (16.51s)
01:41:55 [2020-01-27T01:41:55.298Z] === RUN   TestCreateServiceConflict
01:41:58 [2020-01-27T01:41:58.381Z] --- PASS: TestCreateServiceConflict (2.66s)
01:41:58 [2020-01-27T01:41:58.381Z] === RUN   TestCreateServiceMaxReplicas
01:42:02 [2020-01-27T01:42:02.326Z] --- PASS: TestCreateServiceMaxReplicas (3.82s)
01:42:02 [2020-01-27T01:42:02.326Z] === RUN   TestCreateWithDuplicateNetworkNames
01:42:15 [2020-01-27T01:42:15.673Z] --- PASS: TestCreateWithDuplicateNetworkNames (13.93s)
01:42:15 [2020-01-27T01:42:15.673Z] === RUN   TestCreateServiceSecretFileMode
01:42:18 [2020-01-27T01:42:18.858Z] --- PASS: TestCreateServiceSecretFileMode (2.69s)
01:42:18 [2020-01-27T01:42:18.858Z] === RUN   TestCreateServiceConfigFileMode
01:42:21 [2020-01-27T01:42:21.932Z] --- PASS: TestCreateServiceConfigFileMode (3.13s)
01:42:21 [2020-01-27T01:42:21.932Z] === RUN   TestCreateServiceSysctls
01:42:25 [2020-01-27T01:42:25.853Z] --- PASS: TestCreateServiceSysctls (3.90s)
01:42:25 [2020-01-27T01:42:25.853Z] === RUN   TestCreateServiceCapabilities
01:42:29 [2020-01-27T01:42:29.074Z] --- PASS: TestCreateServiceCapabilities (3.26s)
01:42:29 [2020-01-27T01:42:29.074Z] === RUN   TestInspect
01:42:32 [2020-01-27T01:42:32.170Z] --- PASS: TestInspect (2.87s)
01:42:32 [2020-01-27T01:42:32.170Z] === RUN   TestCreateJob
01:42:35 [2020-01-27T01:42:35.245Z] --- PASS: TestCreateJob (3.75s)
01:42:35 [2020-01-27T01:42:35.245Z] === RUN   TestReplicatedJob
01:42:42 [2020-01-27T01:42:42.772Z] --- PASS: TestReplicatedJob (7.00s)
01:42:42 [2020-01-27T01:42:42.772Z] === RUN   TestUpdateReplicatedJob
01:42:46 [2020-01-27T01:42:46.701Z] --- PASS: TestUpdateReplicatedJob (3.67s)
01:42:46 [2020-01-27T01:42:46.701Z] === RUN   TestServiceListWithStatuses
01:42:46 [2020-01-27T01:42:46.701Z] --- SKIP: TestServiceListWithStatuses (0.02s)
01:42:46 [2020-01-27T01:42:46.701Z]     list_test.go:34: versions.LessThan(testEnv.DaemonInfo.ServerVersion, "1.41")
01:42:46 [2020-01-27T01:42:46.701Z] === RUN   TestDockerNetworkConnectAlias
01:42:51 [2020-01-27T01:42:51.723Z] --- PASS: TestDockerNetworkConnectAlias (5.58s)
01:42:51 [2020-01-27T01:42:51.723Z] === RUN   TestDockerNetworkReConnect
01:42:56 [2020-01-27T01:42:56.617Z] --- PASS: TestDockerNetworkReConnect (4.58s)
01:42:56 [2020-01-27T01:42:56.617Z] === RUN   TestServicePlugin
01:42:56 [2020-01-27T01:42:56.617Z] --- SKIP: TestServicePlugin (0.00s)
01:42:56 [2020-01-27T01:42:56.617Z]     plugin_test.go:28: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
01:42:56 [2020-01-27T01:42:56.617Z] === RUN   TestServiceUpdateLabel
01:42:58 [2020-01-27T01:42:58.962Z] --- PASS: TestServiceUpdateLabel (2.72s)
01:42:58 [2020-01-27T01:42:58.962Z] === RUN   TestServiceUpdateSecrets
01:43:15 [2020-01-27T01:43:15.189Z] --- PASS: TestServiceUpdateSecrets (15.38s)
01:43:15 [2020-01-27T01:43:15.189Z] === RUN   TestServiceUpdateConfigs
01:43:31 [2020-01-27T01:43:31.603Z] --- PASS: TestServiceUpdateConfigs (15.32s)
01:43:31 [2020-01-27T01:43:31.603Z] === RUN   TestServiceUpdateNetwork
01:43:44 [2020-01-27T01:43:44.954Z] --- PASS: TestServiceUpdateNetwork (13.72s)
01:43:44 [2020-01-27T01:43:44.954Z] PASS
01:43:44 [2020-01-27T01:43:44.954Z] 
01:43:44 [2020-01-27T01:43:44.954Z] === Skipped
01:43:44 [2020-01-27T01:43:44.954Z] === SKIP: s390x.integration.service TestServiceListWithStatuses (0.02s)
01:43:44 [2020-01-27T01:43:44.954Z]     list_test.go:34: versions.LessThan(testEnv.DaemonInfo.ServerVersion, "1.41")
01:43:44 [2020-01-27T01:43:44.954Z] 
01:43:44 [2020-01-27T01:43:44.954Z] === SKIP: s390x.integration.service TestServicePlugin (0.00s)
01:43:44 [2020-01-27T01:43:44.954Z]     plugin_test.go:28: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
01:43:44 [2020-01-27T01:43:44.954Z] 
01:43:44 [2020-01-27T01:43:44.954Z] 
01:43:44 [2020-01-27T01:43:44.954Z] DONE 23 tests, 2 skipped in 134.473s
01:43:44 [2020-01-27T01:43:44.954Z] Running /go/src/github.com/docker/docker/integration/session (s390x.integration.session) flags=-test.v -test.timeout=120m 
01:43:44 [2020-01-27T01:43:44.954Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-session-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-session-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.session -t ./test.main -test.v -test.timeout=120m
01:43:44 [2020-01-27T01:43:44.954Z] ++ set -e
01:43:44 [2020-01-27T01:43:44.954Z] ++ '[' -n 0 ']'
01:43:44 [2020-01-27T01:43:44.954Z] ++ set -x
01:43:44 [2020-01-27T01:43:44.954Z] ++ 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=s390x 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/s390x-integration-session-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-session-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.session -t ./test.main -test.v -test.timeout=120m
01:43:44 [2020-01-27T01:43:44.954Z] INFO: Testing against a local daemon
01:43:44 [2020-01-27T01:43:44.954Z] === RUN   TestSessionCreate
01:43:44 [2020-01-27T01:43:44.954Z] --- PASS: TestSessionCreate (0.02s)
01:43:44 [2020-01-27T01:43:44.954Z] === RUN   TestSessionCreateWithBadUpgrade
01:43:44 [2020-01-27T01:43:44.954Z] --- PASS: TestSessionCreateWithBadUpgrade (0.01s)
01:43:44 [2020-01-27T01:43:44.954Z] PASS
01:43:44 [2020-01-27T01:43:44.954Z] 
01:43:44 [2020-01-27T01:43:44.954Z] DONE 2 tests in 0.228s
01:43:44 [2020-01-27T01:43:44.954Z] Running /go/src/github.com/docker/docker/integration/system (s390x.integration.system) flags=-test.v -test.timeout=120m 
01:43:44 [2020-01-27T01:43:44.954Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-system-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-system-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.system -t ./test.main -test.v -test.timeout=120m
01:43:44 [2020-01-27T01:43:44.954Z] ++ set -e
01:43:44 [2020-01-27T01:43:44.954Z] ++ '[' -n 0 ']'
01:43:44 [2020-01-27T01:43:44.954Z] ++ set -x
01:43:44 [2020-01-27T01:43:44.954Z] ++ 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=s390x 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/s390x-integration-system-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-system-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.system -t ./test.main -test.v -test.timeout=120m
01:43:44 [2020-01-27T01:43:44.954Z] INFO: Testing against a local daemon
01:43:44 [2020-01-27T01:43:44.954Z] === RUN   TestCgroupDriverSystemdMemoryLimit
01:43:44 [2020-01-27T01:43:44.954Z] --- SKIP: TestCgroupDriverSystemdMemoryLimit (0.00s)
01:43:44 [2020-01-27T01:43:44.954Z]     cgroupdriver_systemd_test.go:32: !hasSystemd()
01:43:44 [2020-01-27T01:43:44.954Z] === RUN   TestEventsExecDie
01:43:44 [2020-01-27T01:43:44.954Z] --- PASS: TestEventsExecDie (0.89s)
01:43:44 [2020-01-27T01:43:44.954Z] === RUN   TestEventsBackwardsCompatible
01:43:44 [2020-01-27T01:43:44.954Z] --- PASS: TestEventsBackwardsCompatible (0.09s)
01:43:44 [2020-01-27T01:43:44.954Z] === RUN   TestInfoBinaryCommits
01:43:44 [2020-01-27T01:43:44.954Z] --- PASS: TestInfoBinaryCommits (0.02s)
01:43:44 [2020-01-27T01:43:44.954Z] === RUN   TestInfoAPIVersioned
01:43:44 [2020-01-27T01:43:44.954Z] --- PASS: TestInfoAPIVersioned (0.01s)
01:43:44 [2020-01-27T01:43:44.954Z] === RUN   TestInfoDiscoveryBackend
01:43:45 [2020-01-27T01:43:45.298Z] --- PASS: TestInfoDiscoveryBackend (0.53s)
01:43:45 [2020-01-27T01:43:45.298Z] === RUN   TestInfoDiscoveryInvalidAdvertise
01:43:46 [2020-01-27T01:43:46.498Z] --- PASS: TestInfoDiscoveryInvalidAdvertise (1.00s)
01:43:46 [2020-01-27T01:43:46.498Z] === RUN   TestInfoDiscoveryAdvertiseInterfaceName
01:43:46 [2020-01-27T01:43:46.843Z] --- PASS: TestInfoDiscoveryAdvertiseInterfaceName (0.52s)
01:43:46 [2020-01-27T01:43:46.843Z] === RUN   TestInfoAPI
01:43:46 [2020-01-27T01:43:46.843Z] --- PASS: TestInfoAPI (0.02s)
01:43:46 [2020-01-27T01:43:46.843Z] === RUN   TestInfoAPIWarnings
01:43:47 [2020-01-27T01:43:47.194Z] --- PASS: TestInfoAPIWarnings (0.52s)
01:43:47 [2020-01-27T01:43:47.194Z] === RUN   TestInfoDebug
01:43:47 [2020-01-27T01:43:47.934Z] --- PASS: TestInfoDebug (0.52s)
01:43:47 [2020-01-27T01:43:47.934Z] === RUN   TestInfoInsecureRegistries
01:43:48 [2020-01-27T01:43:48.281Z] --- PASS: TestInfoInsecureRegistries (0.52s)
01:43:48 [2020-01-27T01:43:48.281Z] === RUN   TestInfoRegistryMirrors
01:43:49 [2020-01-27T01:43:49.026Z] --- PASS: TestInfoRegistryMirrors (0.52s)
01:43:49 [2020-01-27T01:43:49.026Z] === RUN   TestLoginFailsWithBadCredentials
01:43:49 [2020-01-27T01:43:49.026Z] --- PASS: TestLoginFailsWithBadCredentials (0.30s)
01:43:49 [2020-01-27T01:43:49.026Z] === RUN   TestPingCacheHeaders
01:43:49 [2020-01-27T01:43:49.026Z] --- PASS: TestPingCacheHeaders (0.02s)
01:43:49 [2020-01-27T01:43:49.026Z] === RUN   TestPingGet
01:43:49 [2020-01-27T01:43:49.026Z] --- PASS: TestPingGet (0.01s)
01:43:49 [2020-01-27T01:43:49.026Z] === RUN   TestPingHead
01:43:49 [2020-01-27T01:43:49.380Z] --- PASS: TestPingHead (0.02s)
01:43:49 [2020-01-27T01:43:49.380Z] === RUN   TestVersion
01:43:49 [2020-01-27T01:43:49.380Z] --- PASS: TestVersion (0.02s)
01:43:49 [2020-01-27T01:43:49.380Z] PASS
01:43:49 [2020-01-27T01:43:49.380Z] 
01:43:49 [2020-01-27T01:43:49.380Z] === Skipped
01:43:49 [2020-01-27T01:43:49.380Z] === SKIP: s390x.integration.system TestCgroupDriverSystemdMemoryLimit (0.00s)
01:43:49 [2020-01-27T01:43:49.380Z]     cgroupdriver_systemd_test.go:32: !hasSystemd()
01:43:49 [2020-01-27T01:43:49.380Z] 
01:43:49 [2020-01-27T01:43:49.380Z] 
01:43:49 [2020-01-27T01:43:49.380Z] DONE 18 tests, 1 skipped in 5.627s
01:43:49 [2020-01-27T01:43:49.380Z] Running /go/src/github.com/docker/docker/integration/volume (s390x.integration.volume) flags=-test.v -test.timeout=120m 
01:43:49 [2020-01-27T01:43:49.380Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-volume-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-volume-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.volume -t ./test.main -test.v -test.timeout=120m
01:43:49 [2020-01-27T01:43:49.380Z] ++ set -e
01:43:49 [2020-01-27T01:43:49.380Z] ++ '[' -n 0 ']'
01:43:49 [2020-01-27T01:43:49.380Z] ++ set -x
01:43:49 [2020-01-27T01:43:49.380Z] ++ 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=s390x 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/s390x-integration-volume-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-volume-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.volume -t ./test.main -test.v -test.timeout=120m
01:43:49 [2020-01-27T01:43:49.380Z] INFO: Testing against a local daemon
01:43:49 [2020-01-27T01:43:49.380Z] === RUN   TestVolumesCreateAndList
01:43:49 [2020-01-27T01:43:49.380Z] --- PASS: TestVolumesCreateAndList (0.03s)
01:43:49 [2020-01-27T01:43:49.380Z] === RUN   TestVolumesRemove
01:43:49 [2020-01-27T01:43:49.380Z] --- PASS: TestVolumesRemove (0.12s)
01:43:49 [2020-01-27T01:43:49.380Z] === RUN   TestVolumesInspect
01:43:49 [2020-01-27T01:43:49.380Z] --- PASS: TestVolumesInspect (0.01s)
01:43:49 [2020-01-27T01:43:49.380Z] === RUN   TestVolumesInvalidJSON
01:43:49 [2020-01-27T01:43:49.380Z] === RUN   TestVolumesInvalidJSON//volumes/create
01:43:49 [2020-01-27T01:43:49.380Z] === PAUSE TestVolumesInvalidJSON//volumes/create
01:43:49 [2020-01-27T01:43:49.380Z] === CONT  TestVolumesInvalidJSON//volumes/create
01:43:49 [2020-01-27T01:43:49.380Z] --- PASS: TestVolumesInvalidJSON (0.01s)
01:43:49 [2020-01-27T01:43:49.380Z]     --- PASS: TestVolumesInvalidJSON//volumes/create (0.00s)
01:43:49 [2020-01-27T01:43:49.380Z] PASS
01:43:49 [2020-01-27T01:43:49.380Z] 
01:43:49 [2020-01-27T01:43:49.380Z] DONE 5 tests in 0.274s
01:43:49 [2020-01-27T01:43:49.380Z] ---> Making bundle: .integration-daemon-stop (in bundles/test-integration)
01:43:49 [2020-01-27T01:43:49.733Z] ++++ cat bundles/test-integration/docker.pid
01:43:49 [2020-01-27T01:43:49.733Z] +++ kill 11579
01:43:51 [2020-01-27T01:43:51.024Z] +++ /etc/init.d/apparmor stop
01:43:51 [2020-01-27T01:43:51.024Z] Leaving: AppArmorNo profiles have been unloaded.
01:43:51 [2020-01-27T01:43:51.024Z] 
01:43:51 [2020-01-27T01:43:51.024Z] Unloading profiles will leave already running processes permanently
01:43:51 [2020-01-27T01:43:51.024Z] unconfined, which can lead to unexpected situations.
01:43:51 [2020-01-27T01:43:51.024Z] 
01:43:51 [2020-01-27T01:43:51.024Z] To set a process to complain mode, use the command line tool
01:43:51 [2020-01-27T01:43:51.024Z] 'aa-complain'. To really tear down all profiles, run 'aa-teardown'."
01:43:51 [2020-01-27T01:43:51.024Z] +++ true
01:43:51 [2020-01-27T01:43:51.024Z]