Skip to content

Console Output

09:31:13 [2019-12-13T09:31:13.263Z] + docker run --rm -t --privileged -v /home/jenkins/workspace/moby_PR-40259/bundles:/go/src/github.com/docker/docker/bundles --name docker-pr3 -e DOCKER_EXPERIMENTAL -e DOCKER_GITCOMMIT=87a16ff1b70ecc70744fc1c583a6c1fcb52256b3 -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:87a16ff1b70ecc70744fc1c583a6c1fcb52256b3 hack/make.sh dynbinary test-integration
09:31:13 [2019-12-13T09:31:13.643Z] 
09:31:13 [2019-12-13T09:31:13.643Z] Removing bundles/
09:31:14 [2019-12-13T09:31:14.029Z] 
09:31:14 [2019-12-13T09:31:14.029Z] ---> Making bundle: dynbinary (in bundles/dynbinary)
09:31:14 [2019-12-13T09:31:14.029Z] Building: bundles/dynbinary-daemon/dockerd-dev
09:31:14 [2019-12-13T09:31:14.029Z] GOOS="" GOARCH="" GOARM=""
09:32:38 [2019-12-13T09:32:38.885Z] Created binary: bundles/dynbinary-daemon/dockerd-dev
09:32:38 [2019-12-13T09:32:38.885Z] 
09:32:38 [2019-12-13T09:32:38.885Z] ---> Making bundle: test-integration (in bundles/test-integration)
09:32:38 [2019-12-13T09:32:38.885Z] PKG_CONFIG=pkg-config
09:32:38 [2019-12-13T09:32:38.885Z] GOLANG_VERSION=1.13.4
09:32:38 [2019-12-13T09:32:38.885Z] HOSTNAME=d47becbfa12e
09:32:38 [2019-12-13T09:32:38.885Z] DOCKER_EXPERIMENTAL=1
09:32:38 [2019-12-13T09:32:38.885Z] container=docker
09:32:38 [2019-12-13T09:32:38.885Z] TEST_SKIP_INTEGRATION_CLI=1
09:32:38 [2019-12-13T09:32:38.885Z] GO111MODULE=off
09:32:38 [2019-12-13T09:32:38.885Z] GOPATH=/go
09:32:38 [2019-12-13T09:32:38.885Z] PWD=/go/src/github.com/docker/docker
09:32:38 [2019-12-13T09:32:38.885Z] HOME=/root
09:32:38 [2019-12-13T09:32:38.885Z] VALIDATE_REPO=https://github.com/moby/moby.git
09:32:38 [2019-12-13T09:32:38.885Z] SCRIPTDIR=/go/src/github.com/docker/docker/hack
09:32:38 [2019-12-13T09:32:38.885Z] MAKEDIR=/go/src/github.com/docker/docker/hack/make
09:32:38 [2019-12-13T09:32:38.885Z] DOCKER_GITCOMMIT=87a16ff1b70ecc70744fc1c583a6c1fcb52256b3
09:32:38 [2019-12-13T09:32:38.885Z] DOCKER_BUILDTAGS=apparmor seccomp selinux journald
09:32:38 [2019-12-13T09:32:38.885Z] DOCKER_GRAPHDRIVER=overlay2
09:32:38 [2019-12-13T09:32:38.885Z] TERM=xterm
09:32:38 [2019-12-13T09:32:38.885Z] VALIDATE_BRANCH=master
09:32:38 [2019-12-13T09:32:38.885Z] DEST=bundles/test-integration
09:32:38 [2019-12-13T09:32:38.885Z] SHLVL=1
09:32:38 [2019-12-13T09:32:38.885Z] TIMEOUT=120m
09:32:38 [2019-12-13T09:32:38.885Z] PATH=/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
09:32:38 [2019-12-13T09:32:38.885Z] DOCKER_PKG=github.com/docker/docker
09:32:38 [2019-12-13T09:32:38.885Z] TESTDEBUG=0
09:32:38 [2019-12-13T09:32:38.885Z] _=/usr/bin/env
09:32:38 [2019-12-13T09:32:38.885Z] Building test suite binary /go/src/github.com/docker/docker/integration/build/test.main
09:33:03 [2019-12-13T09:33:03.179Z] Building test suite binary /go/src/github.com/docker/docker/integration/config/test.main
09:33:03 [2019-12-13T09:33:03.179Z] Building test suite binary /go/src/github.com/docker/docker/integration/container/test.main
09:33:07 [2019-12-13T09:33:07.327Z] Building test suite binary /go/src/github.com/docker/docker/integration/image/test.main
09:33:31 [2019-12-13T09:33:31.477Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/test.main
09:33:32 [2019-12-13T09:33:32.315Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/ipvlan/test.main
09:33:34 [2019-12-13T09:33:34.188Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/macvlan/test.main
09:33:36 [2019-12-13T09:33:36.115Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/test.main
09:33:36 [2019-12-13T09:33:36.558Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/authz/test.main
09:33:39 [2019-12-13T09:33:39.966Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/common/test.main
09:33:41 [2019-12-13T09:33:41.943Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/graphdriver/test.main
09:33:45 [2019-12-13T09:33:45.182Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/logging/test.main
09:33:48 [2019-12-13T09:33:48.593Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/volumes/test.main
09:33:51 [2019-12-13T09:33:51.876Z] Building test suite binary /go/src/github.com/docker/docker/integration/secret/test.main
09:33:53 [2019-12-13T09:33:53.906Z] Building test suite binary /go/src/github.com/docker/docker/integration/service/test.main
09:33:57 [2019-12-13T09:33:57.343Z] Building test suite binary /go/src/github.com/docker/docker/integration/session/test.main
09:33:59 [2019-12-13T09:33:59.348Z] Building test suite binary /go/src/github.com/docker/docker/integration/system/test.main
09:34:01 [2019-12-13T09:34:01.230Z] Building test suite binary /go/src/github.com/docker/docker/integration/volume/test.main
09:34:03 [2019-12-13T09:34:03.115Z] ---> Making bundle: .integration-daemon-start (in bundles/test-integration)
09:34:03 [2019-12-13T09:34:03.115Z] Using test binary docker
09:34:03 [2019-12-13T09:34:03.678Z] # DOCKER_EXPERIMENTAL is set: starting daemon with experimental features enabled! 
09:34:03 [2019-12-13T09:34:03.678Z] +++ /etc/init.d/apparmor start
09:34:03 [2019-12-13T09:34:03.678Z] /etc/init.d/apparmor: 130: /etc/init.d/apparmor: systemd-detect-virt: not found
09:34:03 [2019-12-13T09:34:03.678Z] Starting AppArmor profiles:Warning from stdin (line 1): /sbin/apparmor_parser: cannot use or update cache, disable, or force-complain via stdin
09:34:03 [2019-12-13T09:34:03.678Z] Warning failed to create cache: (null)
09:34:03 [2019-12-13T09:34:03.678Z] .
09:34:03 [2019-12-13T09:34:03.678Z] INFO: Waiting for daemon to start...
09:34:03 [2019-12-13T09:34:03.678Z] Starting dockerd
09:34:03 [2019-12-13T09:34:03.678Z] +++ 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
09:34:05 [2019-12-13T09:34:05.516Z] .
09:34:05 [2019-12-13T09:34:05.516Z] ---> Making bundle: .integration-daemon-setup (in bundles/test-integration)
09:34:05 [2019-12-13T09:34:05.516Z] ---> Making bundle: .ensure-emptyfs (in bundles/test-integration)
09:34:05 [2019-12-13T09:34:05.516Z] Error: No such image: emptyfs
09:34:05 [2019-12-13T09:34:05.516Z] ++++ tar -cC bundles/test-integration/emptyfs .
09:34:05 [2019-12-13T09:34:05.516Z] ++++ docker load
09:34:05 [2019-12-13T09:34:05.903Z] Running integration-test (iteration 1)
09:34:05 [2019-12-13T09:34:05.903Z] Running /go/src/github.com/docker/docker/integration/build (s390x.integration.build) flags=-test.v -test.timeout=120m 
09:34:05 [2019-12-13T09:34:05.903Z] ++ 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
09:34:05 [2019-12-13T09:34:05.903Z] ++ set -e
09:34:05 [2019-12-13T09:34:05.903Z] ++ '[' -n 0 ']'
09:34:05 [2019-12-13T09:34:05.903Z] ++ set -x
09:34:05 [2019-12-13T09:34:05.904Z] ++ 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
09:34:17 [2019-12-13T09:34:17.444Z] Loaded image: buildpack-deps:jessie
09:34:17 [2019-12-13T09:34:17.444Z] Loaded image: busybox:latest
09:34:17 [2019-12-13T09:34:17.444Z] Loaded image: busybox:glibc
09:34:17 [2019-12-13T09:34:17.444Z] Loaded image: debian:jessie
09:34:17 [2019-12-13T09:34:17.444Z] Loaded image: hello-world:latest
09:34:17 [2019-12-13T09:34:17.444Z] INFO: Testing against a local daemon
09:34:17 [2019-12-13T09:34:17.444Z] === RUN   TestCgroupNamespacesBuild
09:34:18 [2019-12-13T09:34:18.739Z] --- PASS: TestCgroupNamespacesBuild (1.90s)
09:34:18 [2019-12-13T09:34:18.739Z] === RUN   TestCgroupNamespacesBuildDaemonHostMode
09:34:20 [2019-12-13T09:34:20.682Z] --- PASS: TestCgroupNamespacesBuildDaemonHostMode (1.85s)
09:34:20 [2019-12-13T09:34:20.682Z] === RUN   TestBuildWithSession
09:34:20 [2019-12-13T09:34:20.682Z] --- SKIP: TestBuildWithSession (0.00s)
09:34:20 [2019-12-13T09:34:20.682Z]     build_session_test.go:25: TODO: BuildKit
09:34:20 [2019-12-13T09:34:20.682Z] === RUN   TestBuildSquashParent
09:34:27 [2019-12-13T09:34:27.168Z] --- PASS: TestBuildSquashParent (6.46s)
09:34:27 [2019-12-13T09:34:27.168Z] === RUN   TestBuildWithRemoveAndForceRemove
09:34:27 [2019-12-13T09:34:27.168Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
09:34:27 [2019-12-13T09:34:27.168Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
09:34:27 [2019-12-13T09:34:27.168Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_remove
09:34:27 [2019-12-13T09:34:27.168Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_remove
09:34:27 [2019-12-13T09:34:27.168Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
09:34:27 [2019-12-13T09:34:27.168Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
09:34:27 [2019-12-13T09:34:27.168Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
09:34:27 [2019-12-13T09:34:27.168Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
09:34:27 [2019-12-13T09:34:27.168Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_remove
09:34:27 [2019-12-13T09:34:27.168Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_remove
09:34:27 [2019-12-13T09:34:27.168Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
09:34:27 [2019-12-13T09:34:27.168Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
09:34:27 [2019-12-13T09:34:27.168Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
09:34:27 [2019-12-13T09:34:27.168Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
09:34:29 [2019-12-13T09:34:29.690Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_remove
09:34:30 [2019-12-13T09:34:30.076Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
09:34:32 [2019-12-13T09:34:32.706Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
09:34:33 [2019-12-13T09:34:33.093Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_remove
09:34:35 [2019-12-13T09:34:35.632Z] --- PASS: TestBuildWithRemoveAndForceRemove (0.01s)
09:34:35 [2019-12-13T09:34:35.632Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove (2.77s)
09:34:35 [2019-12-13T09:34:35.632Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal (2.92s)
09:34:35 [2019-12-13T09:34:35.632Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_remove (3.12s)
09:34:35 [2019-12-13T09:34:35.632Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal (3.06s)
09:34:35 [2019-12-13T09:34:35.632Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_remove (2.72s)
09:34:35 [2019-12-13T09:34:35.632Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove (2.92s)
09:34:35 [2019-12-13T09:34:35.632Z] === RUN   TestBuildMultiStageCopy
09:34:35 [2019-12-13T09:34:35.632Z] === RUN   TestBuildMultiStageCopy/copy_to_root
09:34:38 [2019-12-13T09:34:38.251Z] === RUN   TestBuildMultiStageCopy/copy_to_newdir
09:34:39 [2019-12-13T09:34:39.074Z] === RUN   TestBuildMultiStageCopy/copy_to_newdir_nested
09:34:39 [2019-12-13T09:34:39.462Z] === RUN   TestBuildMultiStageCopy/copy_to_existingdir
09:34:39 [2019-12-13T09:34:39.852Z] === RUN   TestBuildMultiStageCopy/copy_to_newsubdir
09:34:40 [2019-12-13T09:34:40.658Z] --- PASS: TestBuildMultiStageCopy (4.91s)
09:34:40 [2019-12-13T09:34:40.658Z]     --- PASS: TestBuildMultiStageCopy/copy_to_root (2.64s)
09:34:40 [2019-12-13T09:34:40.658Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newdir (0.52s)
09:34:40 [2019-12-13T09:34:40.658Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newdir_nested (0.52s)
09:34:40 [2019-12-13T09:34:40.658Z]     --- PASS: TestBuildMultiStageCopy/copy_to_existingdir (0.54s)
09:34:40 [2019-12-13T09:34:40.658Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newsubdir (0.69s)
09:34:40 [2019-12-13T09:34:40.658Z] === RUN   TestBuildMultiStageParentConfig
09:34:42 [2019-12-13T09:34:42.674Z] --- PASS: TestBuildMultiStageParentConfig (1.61s)
09:34:42 [2019-12-13T09:34:42.674Z] === RUN   TestBuildLabelWithTargets
09:34:44 [2019-12-13T09:34:44.526Z] --- PASS: TestBuildLabelWithTargets (2.36s)
09:34:44 [2019-12-13T09:34:44.526Z] === RUN   TestBuildWithEmptyLayers
09:34:45 [2019-12-13T09:34:45.845Z] --- PASS: TestBuildWithEmptyLayers (1.04s)
09:34:45 [2019-12-13T09:34:45.845Z] === RUN   TestBuildMultiStageOnBuild
09:34:49 [2019-12-13T09:34:49.157Z] --- PASS: TestBuildMultiStageOnBuild (3.39s)
09:34:49 [2019-12-13T09:34:49.157Z] === RUN   TestBuildUncleanTarFilenames
09:34:50 [2019-12-13T09:34:50.481Z] --- PASS: TestBuildUncleanTarFilenames (1.38s)
09:34:50 [2019-12-13T09:34:50.481Z] === RUN   TestBuildMultiStageLayerLeak
09:34:53 [2019-12-13T09:34:53.803Z] --- PASS: TestBuildMultiStageLayerLeak (3.02s)
09:34:53 [2019-12-13T09:34:53.803Z] === RUN   TestBuildWithHugeFile
09:35:28 [2019-12-13T09:35:28.260Z] --- PASS: TestBuildWithHugeFile (33.20s)
09:35:28 [2019-12-13T09:35:28.260Z] === RUN   TestBuildWithEmptyDockerfile
09:35:28 [2019-12-13T09:35:28.260Z] === RUN   TestBuildWithEmptyDockerfile/empty-dockerfile
09:35:28 [2019-12-13T09:35:28.260Z] === PAUSE TestBuildWithEmptyDockerfile/empty-dockerfile
09:35:28 [2019-12-13T09:35:28.260Z] === RUN   TestBuildWithEmptyDockerfile/empty-lines-dockerfile
09:35:28 [2019-12-13T09:35:28.260Z] === PAUSE TestBuildWithEmptyDockerfile/empty-lines-dockerfile
09:35:28 [2019-12-13T09:35:28.260Z] === RUN   TestBuildWithEmptyDockerfile/comment-only-dockerfile
09:35:28 [2019-12-13T09:35:28.260Z] === PAUSE TestBuildWithEmptyDockerfile/comment-only-dockerfile
09:35:28 [2019-12-13T09:35:28.260Z] === CONT  TestBuildWithEmptyDockerfile/empty-dockerfile
09:35:28 [2019-12-13T09:35:28.260Z] === CONT  TestBuildWithEmptyDockerfile/comment-only-dockerfile
09:35:28 [2019-12-13T09:35:28.260Z] === CONT  TestBuildWithEmptyDockerfile/empty-lines-dockerfile
09:35:28 [2019-12-13T09:35:28.260Z] --- PASS: TestBuildWithEmptyDockerfile (0.13s)
09:35:28 [2019-12-13T09:35:28.260Z]     --- PASS: TestBuildWithEmptyDockerfile/empty-dockerfile (0.21s)
09:35:28 [2019-12-13T09:35:28.260Z]     --- PASS: TestBuildWithEmptyDockerfile/comment-only-dockerfile (0.24s)
09:35:28 [2019-12-13T09:35:28.260Z]     --- PASS: TestBuildWithEmptyDockerfile/empty-lines-dockerfile (0.13s)
09:35:28 [2019-12-13T09:35:28.260Z] === RUN   TestBuildPreserveOwnership
09:35:28 [2019-12-13T09:35:28.260Z] === RUN   TestBuildPreserveOwnership/copy_from
09:35:31 [2019-12-13T09:35:31.581Z] === RUN   TestBuildPreserveOwnership/copy_from_chowned
09:35:33 [2019-12-13T09:35:33.447Z] --- PASS: TestBuildPreserveOwnership (6.44s)
09:35:33 [2019-12-13T09:35:33.447Z]     --- PASS: TestBuildPreserveOwnership/copy_from (4.21s)
09:35:33 [2019-12-13T09:35:33.447Z]     --- PASS: TestBuildPreserveOwnership/copy_from_chowned (2.22s)
09:35:33 [2019-12-13T09:35:33.447Z] === RUN   TestBuildPlatformInvalid
09:35:33 [2019-12-13T09:35:33.858Z] --- PASS: TestBuildPlatformInvalid (0.16s)
09:35:33 [2019-12-13T09:35:33.858Z] PASS
09:35:33 [2019-12-13T09:35:33.858Z] 
09:35:33 [2019-12-13T09:35:33.858Z] === Skipped
09:35:33 [2019-12-13T09:35:33.858Z] === SKIP: s390x.integration.build TestBuildWithSession (0.00s)
09:35:33 [2019-12-13T09:35:33.858Z]     build_session_test.go:25: TODO: BuildKit
09:35:33 [2019-12-13T09:35:33.858Z] 
09:35:33 [2019-12-13T09:35:33.858Z] 
09:35:33 [2019-12-13T09:35:33.858Z] DONE 32 tests, 1 skipped in 87.990s
09:35:33 [2019-12-13T09:35:33.858Z] Running /go/src/github.com/docker/docker/integration/config (s390x.integration.config) flags=-test.v -test.timeout=120m 
09:35:33 [2019-12-13T09:35:33.858Z] ++ 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
09:35:33 [2019-12-13T09:35:33.858Z] ++ set -e
09:35:33 [2019-12-13T09:35:33.858Z] ++ '[' -n 0 ']'
09:35:33 [2019-12-13T09:35:33.858Z] ++ set -x
09:35:33 [2019-12-13T09:35:33.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-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
09:35:34 [2019-12-13T09:35:34.337Z] INFO: Testing against a local daemon
09:35:34 [2019-12-13T09:35:34.337Z] === RUN   TestConfigList
09:35:37 [2019-12-13T09:35:37.655Z] --- PASS: TestConfigList (3.07s)
09:35:37 [2019-12-13T09:35:37.655Z] === RUN   TestConfigsCreateAndDelete
09:35:40 [2019-12-13T09:35:40.238Z] --- PASS: TestConfigsCreateAndDelete (3.05s)
09:35:40 [2019-12-13T09:35:40.238Z] === RUN   TestConfigsUpdate
09:35:43 [2019-12-13T09:35:43.453Z] --- PASS: TestConfigsUpdate (2.99s)
09:35:43 [2019-12-13T09:35:43.453Z] === RUN   TestTemplatedConfig
09:35:47 [2019-12-13T09:35:47.739Z] --- PASS: TestTemplatedConfig (4.27s)
09:35:47 [2019-12-13T09:35:47.739Z] === RUN   TestConfigInspect
09:35:50 [2019-12-13T09:35:50.230Z] --- PASS: TestConfigInspect (2.57s)
09:35:50 [2019-12-13T09:35:50.230Z] === RUN   TestConfigCreateWithLabels
09:35:52 [2019-12-13T09:35:52.889Z] --- PASS: TestConfigCreateWithLabels (2.93s)
09:35:52 [2019-12-13T09:35:52.889Z] === RUN   TestConfigCreateResolve
09:35:56 [2019-12-13T09:35:56.149Z] --- PASS: TestConfigCreateResolve (2.99s)
09:35:56 [2019-12-13T09:35:56.149Z] === RUN   TestConfigDaemonLibtrustID
09:35:56 [2019-12-13T09:35:56.608Z] --- PASS: TestConfigDaemonLibtrustID (0.54s)
09:35:56 [2019-12-13T09:35:56.608Z] PASS
09:35:56 [2019-12-13T09:35:56.608Z] 
09:35:56 [2019-12-13T09:35:56.608Z] DONE 8 tests in 22.506s
09:35:56 [2019-12-13T09:35:56.608Z] Running /go/src/github.com/docker/docker/integration/container (s390x.integration.container) flags=-test.v -test.timeout=120m 
09:35:56 [2019-12-13T09:35:56.608Z] ++ 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
09:35:56 [2019-12-13T09:35:56.608Z] ++ set -e
09:35:56 [2019-12-13T09:35:56.608Z] ++ '[' -n 0 ']'
09:35:56 [2019-12-13T09:35:56.608Z] ++ set -x
09:35:56 [2019-12-13T09:35:56.608Z] ++ 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
09:35:56 [2019-12-13T09:35:56.608Z] INFO: Testing against a local daemon
09:35:56 [2019-12-13T09:35:56.608Z] === RUN   TestCheckpoint
09:35:56 [2019-12-13T09:35:56.608Z] --- SKIP: TestCheckpoint (0.00s)
09:35:56 [2019-12-13T09:35:56.608Z]     checkpoint_test.go:33: TestCheckpoint is broken; see https://github.com/moby/moby/issues/38963
09:35:56 [2019-12-13T09:35:56.608Z] === RUN   TestContainerInvalidJSON
09:35:56 [2019-12-13T09:35:56.608Z] === RUN   TestContainerInvalidJSON//containers/foobar/copy
09:35:56 [2019-12-13T09:35:56.608Z] === PAUSE TestContainerInvalidJSON//containers/foobar/copy
09:35:56 [2019-12-13T09:35:56.608Z] === RUN   TestContainerInvalidJSON//containers/foobar/exec
09:35:56 [2019-12-13T09:35:56.608Z] === PAUSE TestContainerInvalidJSON//containers/foobar/exec
09:35:56 [2019-12-13T09:35:56.608Z] === RUN   TestContainerInvalidJSON//exec/foobar/start
09:35:56 [2019-12-13T09:35:56.608Z] === PAUSE TestContainerInvalidJSON//exec/foobar/start
09:35:56 [2019-12-13T09:35:56.608Z] === CONT  TestContainerInvalidJSON//containers/foobar/copy
09:35:56 [2019-12-13T09:35:56.608Z] === CONT  TestContainerInvalidJSON//exec/foobar/start
09:35:56 [2019-12-13T09:35:56.608Z] === CONT  TestContainerInvalidJSON//containers/foobar/exec
09:35:56 [2019-12-13T09:35:56.608Z] --- PASS: TestContainerInvalidJSON (0.01s)
09:35:56 [2019-12-13T09:35:56.608Z]     --- PASS: TestContainerInvalidJSON//exec/foobar/start (0.00s)
09:35:56 [2019-12-13T09:35:56.608Z]     --- PASS: TestContainerInvalidJSON//containers/foobar/copy (0.00s)
09:35:56 [2019-12-13T09:35:56.608Z]     --- PASS: TestContainerInvalidJSON//containers/foobar/exec (0.00s)
09:35:56 [2019-12-13T09:35:56.608Z] === RUN   TestCopyFromContainerPathDoesNotExist
09:35:56 [2019-12-13T09:35:56.608Z] --- PASS: TestCopyFromContainerPathDoesNotExist (0.15s)
09:35:56 [2019-12-13T09:35:56.608Z] === RUN   TestCopyFromContainerPathIsNotDir
09:35:57 [2019-12-13T09:35:57.067Z] --- PASS: TestCopyFromContainerPathIsNotDir (0.11s)
09:35:57 [2019-12-13T09:35:57.067Z] === RUN   TestCopyToContainerPathDoesNotExist
09:35:57 [2019-12-13T09:35:57.067Z] --- PASS: TestCopyToContainerPathDoesNotExist (0.13s)
09:35:57 [2019-12-13T09:35:57.067Z] === RUN   TestCopyToContainerPathIsNotDir
09:35:57 [2019-12-13T09:35:57.067Z] --- PASS: TestCopyToContainerPathIsNotDir (0.13s)
09:35:57 [2019-12-13T09:35:57.067Z] === RUN   TestCopyFromContainer
09:35:59 [2019-12-13T09:35:59.553Z] === RUN   TestCopyFromContainer//
09:35:59 [2019-12-13T09:35:59.553Z] === RUN   TestCopyFromContainer//bar/root
09:35:59 [2019-12-13T09:35:59.553Z] === RUN   TestCopyFromContainer//bar/root/
09:35:59 [2019-12-13T09:35:59.553Z] === RUN   TestCopyFromContainer/bar/quux
09:35:59 [2019-12-13T09:35:59.964Z] === RUN   TestCopyFromContainer/bar/quux/
09:35:59 [2019-12-13T09:35:59.964Z] === RUN   TestCopyFromContainer/bar/quux/baz
09:35:59 [2019-12-13T09:35:59.964Z] === RUN   TestCopyFromContainer/bar/filesymlink
09:35:59 [2019-12-13T09:35:59.964Z] === RUN   TestCopyFromContainer/bar/dirsymlink
09:36:00 [2019-12-13T09:36:00.352Z] === RUN   TestCopyFromContainer/bar/dirsymlink/
09:36:00 [2019-12-13T09:36:00.352Z] === RUN   TestCopyFromContainer/bar/notarget
09:36:00 [2019-12-13T09:36:00.352Z] --- PASS: TestCopyFromContainer (3.29s)
09:36:00 [2019-12-13T09:36:00.352Z]     --- PASS: TestCopyFromContainer// (0.07s)
09:36:00 [2019-12-13T09:36:00.352Z]     --- PASS: TestCopyFromContainer//bar/root (0.10s)
09:36:00 [2019-12-13T09:36:00.352Z]     --- PASS: TestCopyFromContainer//bar/root/ (0.06s)
09:36:00 [2019-12-13T09:36:00.352Z]     --- PASS: TestCopyFromContainer/bar/quux (0.13s)
09:36:00 [2019-12-13T09:36:00.352Z]     --- PASS: TestCopyFromContainer/bar/quux/ (0.10s)
09:36:00 [2019-12-13T09:36:00.352Z]     --- PASS: TestCopyFromContainer/bar/quux/baz (0.08s)
09:36:00 [2019-12-13T09:36:00.352Z]     --- PASS: TestCopyFromContainer/bar/filesymlink (0.14s)
09:36:00 [2019-12-13T09:36:00.352Z]     --- PASS: TestCopyFromContainer/bar/dirsymlink (0.12s)
09:36:00 [2019-12-13T09:36:00.352Z]     --- PASS: TestCopyFromContainer/bar/dirsymlink/ (0.11s)
09:36:00 [2019-12-13T09:36:00.352Z]     --- PASS: TestCopyFromContainer/bar/notarget (0.08s)
09:36:00 [2019-12-13T09:36:00.352Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist
09:36:00 [2019-12-13T09:36:00.352Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
09:36:00 [2019-12-13T09:36:00.352Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
09:36:00 [2019-12-13T09:36:00.352Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
09:36:00 [2019-12-13T09:36:00.352Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
09:36:00 [2019-12-13T09:36:00.352Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/digest
09:36:00 [2019-12-13T09:36:00.352Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/digest
09:36:00 [2019-12-13T09:36:00.352Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
09:36:00 [2019-12-13T09:36:00.352Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/digest
09:36:00 [2019-12-13T09:36:00.352Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
09:36:00 [2019-12-13T09:36:00.352Z] --- PASS: TestCreateFailsWhenIdentifierDoesNotExist (0.01s)
09:36:00 [2019-12-13T09:36:00.352Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/digest (0.00s)
09:36:00 [2019-12-13T09:36:00.352Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag (0.00s)
09:36:00 [2019-12-13T09:36:00.352Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag (0.00s)
09:36:00 [2019-12-13T09:36:00.352Z] === RUN   TestCreateLinkToNonExistingContainer
09:36:00 [2019-12-13T09:36:00.352Z] --- PASS: TestCreateLinkToNonExistingContainer (0.07s)
09:36:00 [2019-12-13T09:36:00.352Z] === RUN   TestCreateWithInvalidEnv
09:36:00 [2019-12-13T09:36:00.352Z] === RUN   TestCreateWithInvalidEnv/0
09:36:00 [2019-12-13T09:36:00.352Z] === PAUSE TestCreateWithInvalidEnv/0
09:36:00 [2019-12-13T09:36:00.352Z] === RUN   TestCreateWithInvalidEnv/1
09:36:00 [2019-12-13T09:36:00.352Z] === PAUSE TestCreateWithInvalidEnv/1
09:36:00 [2019-12-13T09:36:00.352Z] === RUN   TestCreateWithInvalidEnv/2
09:36:00 [2019-12-13T09:36:00.352Z] === PAUSE TestCreateWithInvalidEnv/2
09:36:00 [2019-12-13T09:36:00.352Z] === CONT  TestCreateWithInvalidEnv/0
09:36:00 [2019-12-13T09:36:00.352Z] === CONT  TestCreateWithInvalidEnv/2
09:36:00 [2019-12-13T09:36:00.352Z] === CONT  TestCreateWithInvalidEnv/1
09:36:00 [2019-12-13T09:36:00.352Z] --- PASS: TestCreateWithInvalidEnv (0.03s)
09:36:00 [2019-12-13T09:36:00.352Z]     --- PASS: TestCreateWithInvalidEnv/0 (0.00s)
09:36:00 [2019-12-13T09:36:00.352Z]     --- PASS: TestCreateWithInvalidEnv/2 (0.01s)
09:36:00 [2019-12-13T09:36:00.352Z]     --- PASS: TestCreateWithInvalidEnv/1 (0.00s)
09:36:00 [2019-12-13T09:36:00.352Z] === RUN   TestCreateTmpfsMountsTarget
09:36:00 [2019-12-13T09:36:00.794Z] --- PASS: TestCreateTmpfsMountsTarget (0.03s)
09:36:00 [2019-12-13T09:36:00.794Z] === RUN   TestCreateWithCustomMaskedPaths
09:36:03 [2019-12-13T09:36:03.362Z] --- PASS: TestCreateWithCustomMaskedPaths (2.75s)
09:36:03 [2019-12-13T09:36:03.362Z] === RUN   TestCreateWithCapabilities
09:36:03 [2019-12-13T09:36:03.362Z] === RUN   TestCreateWithCapabilities/no_capabilities
09:36:03 [2019-12-13T09:36:03.362Z] === PAUSE TestCreateWithCapabilities/no_capabilities
09:36:03 [2019-12-13T09:36:03.362Z] === RUN   TestCreateWithCapabilities/empty_capabilities
09:36:03 [2019-12-13T09:36:03.362Z] === PAUSE TestCreateWithCapabilities/empty_capabilities
09:36:03 [2019-12-13T09:36:03.362Z] === RUN   TestCreateWithCapabilities/valid_capabilities
09:36:03 [2019-12-13T09:36:03.362Z] === PAUSE TestCreateWithCapabilities/valid_capabilities
09:36:03 [2019-12-13T09:36:03.362Z] === RUN   TestCreateWithCapabilities/invalid_capabilities
09:36:03 [2019-12-13T09:36:03.362Z] === PAUSE TestCreateWithCapabilities/invalid_capabilities
09:36:03 [2019-12-13T09:36:03.362Z] === RUN   TestCreateWithCapabilities/duplicate_capabilities
09:36:03 [2019-12-13T09:36:03.362Z] === PAUSE TestCreateWithCapabilities/duplicate_capabilities
09:36:03 [2019-12-13T09:36:03.362Z] === RUN   TestCreateWithCapabilities/capabilities_API_v1.39
09:36:03 [2019-12-13T09:36:03.362Z] === PAUSE TestCreateWithCapabilities/capabilities_API_v1.39
09:36:03 [2019-12-13T09:36:03.362Z] === RUN   TestCreateWithCapabilities/empty_capadd
09:36:03 [2019-12-13T09:36:03.362Z] === PAUSE TestCreateWithCapabilities/empty_capadd
09:36:03 [2019-12-13T09:36:03.362Z] === RUN   TestCreateWithCapabilities/empty_capdrop
09:36:03 [2019-12-13T09:36:03.362Z] === PAUSE TestCreateWithCapabilities/empty_capdrop
09:36:03 [2019-12-13T09:36:03.362Z] === RUN   TestCreateWithCapabilities/capadd_capdrop
09:36:03 [2019-12-13T09:36:03.362Z] === PAUSE TestCreateWithCapabilities/capadd_capdrop
09:36:03 [2019-12-13T09:36:03.362Z] === RUN   TestCreateWithCapabilities/conflict_with_capadd
09:36:03 [2019-12-13T09:36:03.362Z] === PAUSE TestCreateWithCapabilities/conflict_with_capadd
09:36:03 [2019-12-13T09:36:03.362Z] === RUN   TestCreateWithCapabilities/conflict_with_capdrop
09:36:03 [2019-12-13T09:36:03.362Z] === PAUSE TestCreateWithCapabilities/conflict_with_capdrop
09:36:03 [2019-12-13T09:36:03.362Z] === CONT  TestCreateWithCapabilities/no_capabilities
09:36:03 [2019-12-13T09:36:03.362Z] === CONT  TestCreateWithCapabilities/empty_capadd
09:36:03 [2019-12-13T09:36:03.362Z] === CONT  TestCreateWithCapabilities/conflict_with_capdrop
09:36:03 [2019-12-13T09:36:03.362Z] === CONT  TestCreateWithCapabilities/conflict_with_capadd
09:36:03 [2019-12-13T09:36:03.362Z] === CONT  TestCreateWithCapabilities/capadd_capdrop
09:36:03 [2019-12-13T09:36:03.362Z] === CONT  TestCreateWithCapabilities/empty_capdrop
09:36:03 [2019-12-13T09:36:03.362Z] === CONT  TestCreateWithCapabilities/invalid_capabilities
09:36:03 [2019-12-13T09:36:03.362Z] === CONT  TestCreateWithCapabilities/capabilities_API_v1.39
09:36:03 [2019-12-13T09:36:03.362Z] === CONT  TestCreateWithCapabilities/duplicate_capabilities
09:36:03 [2019-12-13T09:36:03.741Z] === CONT  TestCreateWithCapabilities/valid_capabilities
09:36:03 [2019-12-13T09:36:03.741Z] === CONT  TestCreateWithCapabilities/empty_capabilities
09:36:03 [2019-12-13T09:36:03.741Z] --- PASS: TestCreateWithCapabilities (0.01s)
09:36:03 [2019-12-13T09:36:03.741Z]     --- PASS: TestCreateWithCapabilities/empty_capadd (0.08s)
09:36:03 [2019-12-13T09:36:03.741Z]     --- PASS: TestCreateWithCapabilities/no_capabilities (0.08s)
09:36:03 [2019-12-13T09:36:03.741Z]     --- PASS: TestCreateWithCapabilities/conflict_with_capdrop (0.00s)
09:36:03 [2019-12-13T09:36:03.741Z]     --- PASS: TestCreateWithCapabilities/conflict_with_capadd (0.00s)
09:36:03 [2019-12-13T09:36:03.741Z]     --- PASS: TestCreateWithCapabilities/capadd_capdrop (0.08s)
09:36:03 [2019-12-13T09:36:03.741Z]     --- PASS: TestCreateWithCapabilities/empty_capdrop (0.08s)
09:36:03 [2019-12-13T09:36:03.741Z]     --- PASS: TestCreateWithCapabilities/invalid_capabilities (0.00s)
09:36:03 [2019-12-13T09:36:03.741Z]     --- PASS: TestCreateWithCapabilities/capabilities_API_v1.39 (0.09s)
09:36:03 [2019-12-13T09:36:03.741Z]     --- PASS: TestCreateWithCapabilities/duplicate_capabilities (0.09s)
09:36:03 [2019-12-13T09:36:03.741Z]     --- PASS: TestCreateWithCapabilities/empty_capabilities (0.06s)
09:36:03 [2019-12-13T09:36:03.741Z]     --- PASS: TestCreateWithCapabilities/valid_capabilities (0.06s)
09:36:03 [2019-12-13T09:36:03.741Z] === RUN   TestCreateWithCustomReadonlyPaths
09:36:07 [2019-12-13T09:36:07.023Z] --- PASS: TestCreateWithCustomReadonlyPaths (2.81s)
09:36:07 [2019-12-13T09:36:07.023Z] === RUN   TestCreateWithInvalidHealthcheckParams
09:36:07 [2019-12-13T09:36:07.023Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
09:36:07 [2019-12-13T09:36:07.023Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
09:36:07 [2019-12-13T09:36:07.023Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
09:36:07 [2019-12-13T09:36:07.023Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
09:36:07 [2019-12-13T09:36:07.023Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
09:36:07 [2019-12-13T09:36:07.023Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
09:36:07 [2019-12-13T09:36:07.023Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
09:36:07 [2019-12-13T09:36:07.023Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
09:36:07 [2019-12-13T09:36:07.023Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
09:36:07 [2019-12-13T09:36:07.023Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
09:36:07 [2019-12-13T09:36:07.023Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
09:36:07 [2019-12-13T09:36:07.023Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
09:36:07 [2019-12-13T09:36:07.023Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
09:36:07 [2019-12-13T09:36:07.023Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
09:36:07 [2019-12-13T09:36:07.023Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
09:36:07 [2019-12-13T09:36:07.023Z] --- PASS: TestCreateWithInvalidHealthcheckParams (0.02s)
09:36:07 [2019-12-13T09:36:07.023Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms (0.01s)
09:36:07 [2019-12-13T09:36:07.023Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s (0.01s)
09:36:07 [2019-12-13T09:36:07.023Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0 (0.01s)
09:36:07 [2019-12-13T09:36:07.023Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms (0.01s)
09:36:07 [2019-12-13T09:36:07.023Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms (0.01s)
09:36:07 [2019-12-13T09:36:07.023Z] === RUN   TestContainerStartOnDaemonRestart
09:36:07 [2019-12-13T09:36:07.023Z] === PAUSE TestContainerStartOnDaemonRestart
09:36:07 [2019-12-13T09:36:07.023Z] === RUN   TestDaemonRestartIpcMode
09:36:07 [2019-12-13T09:36:07.023Z] === PAUSE TestDaemonRestartIpcMode
09:36:07 [2019-12-13T09:36:07.023Z] === RUN   TestDiff
09:36:07 [2019-12-13T09:36:07.023Z] --- PASS: TestDiff (0.66s)
09:36:07 [2019-12-13T09:36:07.023Z] === RUN   TestExecWithCloseStdin
09:36:08 [2019-12-13T09:36:08.282Z] --- PASS: TestExecWithCloseStdin (1.03s)
09:36:08 [2019-12-13T09:36:08.282Z] === RUN   TestExec
09:36:09 [2019-12-13T09:36:09.110Z] --- PASS: TestExec (1.09s)
09:36:09 [2019-12-13T09:36:09.110Z] === RUN   TestExecUser
09:36:10 [2019-12-13T09:36:10.410Z] --- PASS: TestExecUser (1.05s)
09:36:10 [2019-12-13T09:36:10.410Z] === RUN   TestExportContainerAndImportImage
09:36:11 [2019-12-13T09:36:11.856Z] --- PASS: TestExportContainerAndImportImage (1.31s)
09:36:11 [2019-12-13T09:36:11.856Z] === RUN   TestExportContainerAfterDaemonRestart
09:36:13 [2019-12-13T09:36:13.141Z] --- PASS: TestExportContainerAfterDaemonRestart (1.57s)
09:36:13 [2019-12-13T09:36:13.141Z] === RUN   TestHealthCheckWorkdir
09:36:14 [2019-12-13T09:36:14.447Z] --- PASS: TestHealthCheckWorkdir (1.17s)
09:36:14 [2019-12-13T09:36:14.447Z] === RUN   TestHealthKillContainer
09:36:17 [2019-12-13T09:36:17.735Z] --- PASS: TestHealthKillContainer (3.06s)
09:36:17 [2019-12-13T09:36:17.735Z] === RUN   TestInspectCpusetInConfigPre120
09:36:18 [2019-12-13T09:36:18.565Z] --- PASS: TestInspectCpusetInConfigPre120 (0.92s)
09:36:18 [2019-12-13T09:36:18.565Z] === RUN   TestIpcModeNone
09:36:19 [2019-12-13T09:36:19.354Z] --- PASS: TestIpcModeNone (1.01s)
09:36:19 [2019-12-13T09:36:19.354Z] === RUN   TestIpcModePrivate
09:36:20 [2019-12-13T09:36:20.654Z] --- PASS: TestIpcModePrivate (1.07s)
09:36:20 [2019-12-13T09:36:20.654Z]     ipcmode_linux_test.go:90: [testIpcPrivateShareable] ipcmode: private, ipcdev: 0:64, shared: false, mustBeShared: false
09:36:20 [2019-12-13T09:36:20.654Z] === RUN   TestIpcModeShareable
09:36:21 [2019-12-13T09:36:21.679Z] --- PASS: TestIpcModeShareable (1.17s)
09:36:21 [2019-12-13T09:36:21.679Z]     ipcmode_linux_test.go:90: [testIpcPrivateShareable] ipcmode: shareable, ipcdev: 0:58, shared: true, mustBeShared: true
09:36:21 [2019-12-13T09:36:21.679Z] === RUN   TestAPIIpcModeShareableAndContainer
09:36:24 [2019-12-13T09:36:24.922Z] --- PASS: TestAPIIpcModeShareableAndContainer (3.02s)
09:36:24 [2019-12-13T09:36:24.922Z] === RUN   TestAPIIpcModeHost
09:36:25 [2019-12-13T09:36:25.712Z] --- PASS: TestAPIIpcModeHost (0.91s)
09:36:25 [2019-12-13T09:36:25.712Z] === RUN   TestDaemonIpcModeShareable
09:36:27 [2019-12-13T09:36:27.629Z] --- PASS: TestDaemonIpcModeShareable (1.92s)
09:36:27 [2019-12-13T09:36:27.629Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:66, shared: true, mustBeShared: true
09:36:27 [2019-12-13T09:36:27.629Z] === RUN   TestDaemonIpcModePrivate
09:36:29 [2019-12-13T09:36:29.508Z] --- PASS: TestDaemonIpcModePrivate (1.93s)
09:36:29 [2019-12-13T09:36:29.508Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:72, shared: false, mustBeShared: false
09:36:29 [2019-12-13T09:36:29.508Z] === RUN   TestDaemonIpcModePrivateFromConfig
09:36:31 [2019-12-13T09:36:31.426Z] --- PASS: TestDaemonIpcModePrivateFromConfig (1.91s)
09:36:31 [2019-12-13T09:36:31.426Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:72, shared: false, mustBeShared: false
09:36:31 [2019-12-13T09:36:31.426Z] === RUN   TestDaemonIpcModeShareableFromConfig
09:36:33 [2019-12-13T09:36:33.325Z] --- PASS: TestDaemonIpcModeShareableFromConfig (1.97s)
09:36:33 [2019-12-13T09:36:33.325Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:66, shared: true, mustBeShared: true
09:36:33 [2019-12-13T09:36:33.325Z] === RUN   TestIpcModeOlderClient
09:36:33 [2019-12-13T09:36:33.325Z] === PAUSE TestIpcModeOlderClient
09:36:33 [2019-12-13T09:36:33.325Z] === RUN   TestKillContainerInvalidSignal
09:36:34 [2019-12-13T09:36:34.130Z] --- PASS: TestKillContainerInvalidSignal (0.89s)
09:36:34 [2019-12-13T09:36:34.130Z] === RUN   TestKillContainer
09:36:34 [2019-12-13T09:36:34.130Z] === RUN   TestKillContainer/no_signal
09:36:35 [2019-12-13T09:36:35.393Z] === RUN   TestKillContainer/non_killing_signal
09:36:36 [2019-12-13T09:36:36.277Z] === RUN   TestKillContainer/killing_signal
09:36:38 [2019-12-13T09:36:38.147Z] --- PASS: TestKillContainer (3.90s)
09:36:38 [2019-12-13T09:36:38.147Z]     --- PASS: TestKillContainer/no_signal (1.31s)
09:36:38 [2019-12-13T09:36:38.147Z]     --- PASS: TestKillContainer/non_killing_signal (0.65s)
09:36:38 [2019-12-13T09:36:38.147Z]     --- PASS: TestKillContainer/killing_signal (1.56s)
09:36:38 [2019-12-13T09:36:38.147Z] === RUN   TestKillWithStopSignalAndRestartPolicies
09:36:38 [2019-12-13T09:36:38.147Z] === RUN   TestKillWithStopSignalAndRestartPolicies/same-signal-disables-restart-policy
09:36:38 [2019-12-13T09:36:38.952Z] === RUN   TestKillWithStopSignalAndRestartPolicies/different-signal-keep-restart-policy
09:36:39 [2019-12-13T09:36:39.770Z] --- PASS: TestKillWithStopSignalAndRestartPolicies (1.82s)
09:36:39 [2019-12-13T09:36:39.770Z]     --- PASS: TestKillWithStopSignalAndRestartPolicies/same-signal-disables-restart-policy (0.86s)
09:36:39 [2019-12-13T09:36:39.770Z]     --- PASS: TestKillWithStopSignalAndRestartPolicies/different-signal-keep-restart-policy (0.62s)
09:36:39 [2019-12-13T09:36:39.770Z] === RUN   TestKillStoppedContainer
09:36:40 [2019-12-13T09:36:40.158Z] --- PASS: TestKillStoppedContainer (0.10s)
09:36:40 [2019-12-13T09:36:40.158Z] === RUN   TestKillStoppedContainerAPIPre120
09:36:40 [2019-12-13T09:36:40.158Z] --- PASS: TestKillStoppedContainerAPIPre120 (0.11s)
09:36:40 [2019-12-13T09:36:40.158Z] === RUN   TestKillDifferentUserContainer
09:36:41 [2019-12-13T09:36:41.033Z] --- PASS: TestKillDifferentUserContainer (0.97s)
09:36:41 [2019-12-13T09:36:41.033Z] === RUN   TestInspectOomKilledTrue
09:36:41 [2019-12-13T09:36:41.033Z] --- SKIP: TestInspectOomKilledTrue (0.01s)
09:36:41 [2019-12-13T09:36:41.033Z]     kill_test.go:151: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
09:36:41 [2019-12-13T09:36:41.033Z] === RUN   TestInspectOomKilledFalse
09:36:41 [2019-12-13T09:36:41.033Z] --- SKIP: TestInspectOomKilledFalse (0.00s)
09:36:41 [2019-12-13T09:36:41.033Z]     kill_test.go:169: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
09:36:41 [2019-12-13T09:36:41.033Z] === RUN   TestLinksEtcHostsContentMatch
09:36:41 [2019-12-13T09:36:41.825Z] --- PASS: TestLinksEtcHostsContentMatch (0.72s)
09:36:41 [2019-12-13T09:36:41.825Z] === RUN   TestLinksContainerNames
09:36:43 [2019-12-13T09:36:43.711Z] --- PASS: TestLinksContainerNames (1.80s)
09:36:43 [2019-12-13T09:36:43.711Z] === RUN   TestLogsFollowTailEmpty
09:36:44 [2019-12-13T09:36:44.530Z] --- PASS: TestLogsFollowTailEmpty (1.01s)
09:36:44 [2019-12-13T09:36:44.530Z] === RUN   TestContainerNetworkMountsNoChown
09:36:45 [2019-12-13T09:36:45.945Z] --- PASS: TestContainerNetworkMountsNoChown (1.03s)
09:36:45 [2019-12-13T09:36:45.945Z] === RUN   TestMountDaemonRoot
09:36:45 [2019-12-13T09:36:45.945Z] === RUN   TestMountDaemonRoot/default
09:36:45 [2019-12-13T09:36:45.945Z] === PAUSE TestMountDaemonRoot/default
09:36:45 [2019-12-13T09:36:45.945Z] === RUN   TestMountDaemonRoot/private
09:36:45 [2019-12-13T09:36:45.945Z] === PAUSE TestMountDaemonRoot/private
09:36:45 [2019-12-13T09:36:45.945Z] === RUN   TestMountDaemonRoot/rprivate
09:36:45 [2019-12-13T09:36:45.945Z] === PAUSE TestMountDaemonRoot/rprivate
09:36:45 [2019-12-13T09:36:45.945Z] === RUN   TestMountDaemonRoot/slave
09:36:45 [2019-12-13T09:36:45.945Z] === PAUSE TestMountDaemonRoot/slave
09:36:45 [2019-12-13T09:36:45.945Z] === RUN   TestMountDaemonRoot/rslave
09:36:45 [2019-12-13T09:36:45.945Z] === PAUSE TestMountDaemonRoot/rslave
09:36:45 [2019-12-13T09:36:45.945Z] === RUN   TestMountDaemonRoot/shared
09:36:45 [2019-12-13T09:36:45.945Z] === PAUSE TestMountDaemonRoot/shared
09:36:45 [2019-12-13T09:36:45.945Z] === RUN   TestMountDaemonRoot/rshared
09:36:45 [2019-12-13T09:36:45.945Z] === PAUSE TestMountDaemonRoot/rshared
09:36:45 [2019-12-13T09:36:45.945Z] === CONT  TestMountDaemonRoot/default
09:36:45 [2019-12-13T09:36:45.945Z] === RUN   TestMountDaemonRoot/default/bind_subpath
09:36:45 [2019-12-13T09:36:45.945Z] === PAUSE TestMountDaemonRoot/default/bind_subpath
09:36:45 [2019-12-13T09:36:45.945Z] === RUN   TestMountDaemonRoot/default/mount_root
09:36:45 [2019-12-13T09:36:45.945Z] === PAUSE TestMountDaemonRoot/default/mount_root
09:36:45 [2019-12-13T09:36:45.945Z] === RUN   TestMountDaemonRoot/default/mount_subpath
09:36:45 [2019-12-13T09:36:45.945Z] === PAUSE TestMountDaemonRoot/default/mount_subpath
09:36:45 [2019-12-13T09:36:45.945Z] === RUN   TestMountDaemonRoot/default/bind_root
09:36:45 [2019-12-13T09:36:45.945Z] === PAUSE TestMountDaemonRoot/default/bind_root
09:36:45 [2019-12-13T09:36:45.945Z] === CONT  TestMountDaemonRoot/default/bind_subpath
09:36:45 [2019-12-13T09:36:45.945Z] === CONT  TestMountDaemonRoot/rprivate
09:36:45 [2019-12-13T09:36:45.945Z] === RUN   TestMountDaemonRoot/rprivate/bind_root
09:36:45 [2019-12-13T09:36:45.945Z] === PAUSE TestMountDaemonRoot/rprivate/bind_root
09:36:45 [2019-12-13T09:36:45.945Z] === RUN   TestMountDaemonRoot/rprivate/bind_subpath
09:36:45 [2019-12-13T09:36:45.945Z] === PAUSE TestMountDaemonRoot/rprivate/bind_subpath
09:36:45 [2019-12-13T09:36:45.945Z] === RUN   TestMountDaemonRoot/rprivate/mount_root
09:36:45 [2019-12-13T09:36:45.945Z] === PAUSE TestMountDaemonRoot/rprivate/mount_root
09:36:45 [2019-12-13T09:36:45.945Z] === RUN   TestMountDaemonRoot/rprivate/mount_subpath
09:36:45 [2019-12-13T09:36:45.945Z] === PAUSE TestMountDaemonRoot/rprivate/mount_subpath
09:36:45 [2019-12-13T09:36:45.945Z] === CONT  TestMountDaemonRoot/rprivate/bind_root
09:36:45 [2019-12-13T09:36:45.945Z] === CONT  TestMountDaemonRoot/rshared
09:36:45 [2019-12-13T09:36:45.945Z] === RUN   TestMountDaemonRoot/rshared/mount_subpath
09:36:45 [2019-12-13T09:36:45.945Z] === PAUSE TestMountDaemonRoot/rshared/mount_subpath
09:36:45 [2019-12-13T09:36:45.945Z] === RUN   TestMountDaemonRoot/rshared/bind_root
09:36:45 [2019-12-13T09:36:45.945Z] === PAUSE TestMountDaemonRoot/rshared/bind_root
09:36:45 [2019-12-13T09:36:45.945Z] === RUN   TestMountDaemonRoot/rshared/bind_subpath
09:36:45 [2019-12-13T09:36:45.945Z] === PAUSE TestMountDaemonRoot/rshared/bind_subpath
09:36:45 [2019-12-13T09:36:45.945Z] === RUN   TestMountDaemonRoot/rshared/mount_root
09:36:45 [2019-12-13T09:36:45.945Z] === PAUSE TestMountDaemonRoot/rshared/mount_root
09:36:45 [2019-12-13T09:36:45.945Z] === CONT  TestMountDaemonRoot/shared
09:36:45 [2019-12-13T09:36:45.945Z] === RUN   TestMountDaemonRoot/shared/bind_root
09:36:45 [2019-12-13T09:36:45.945Z] === PAUSE TestMountDaemonRoot/shared/bind_root
09:36:45 [2019-12-13T09:36:45.945Z] === RUN   TestMountDaemonRoot/shared/bind_subpath
09:36:45 [2019-12-13T09:36:45.945Z] === PAUSE TestMountDaemonRoot/shared/bind_subpath
09:36:45 [2019-12-13T09:36:45.945Z] === RUN   TestMountDaemonRoot/shared/mount_root
09:36:45 [2019-12-13T09:36:45.945Z] === PAUSE TestMountDaemonRoot/shared/mount_root
09:36:45 [2019-12-13T09:36:45.945Z] === RUN   TestMountDaemonRoot/shared/mount_subpath
09:36:45 [2019-12-13T09:36:45.945Z] === PAUSE TestMountDaemonRoot/shared/mount_subpath
09:36:45 [2019-12-13T09:36:45.945Z] === CONT  TestMountDaemonRoot/rslave
09:36:45 [2019-12-13T09:36:45.945Z] === RUN   TestMountDaemonRoot/rslave/bind_root
09:36:45 [2019-12-13T09:36:45.945Z] === PAUSE TestMountDaemonRoot/rslave/bind_root
09:36:45 [2019-12-13T09:36:45.945Z] === RUN   TestMountDaemonRoot/rslave/bind_subpath
09:36:45 [2019-12-13T09:36:45.945Z] === PAUSE TestMountDaemonRoot/rslave/bind_subpath
09:36:45 [2019-12-13T09:36:45.945Z] === RUN   TestMountDaemonRoot/rslave/mount_root
09:36:45 [2019-12-13T09:36:45.945Z] === PAUSE TestMountDaemonRoot/rslave/mount_root
09:36:45 [2019-12-13T09:36:45.945Z] === RUN   TestMountDaemonRoot/rslave/mount_subpath
09:36:45 [2019-12-13T09:36:45.945Z] === PAUSE TestMountDaemonRoot/rslave/mount_subpath
09:36:45 [2019-12-13T09:36:45.945Z] === CONT  TestMountDaemonRoot/slave
09:36:45 [2019-12-13T09:36:45.945Z] === RUN   TestMountDaemonRoot/slave/bind_root
09:36:45 [2019-12-13T09:36:45.945Z] === PAUSE TestMountDaemonRoot/slave/bind_root
09:36:45 [2019-12-13T09:36:45.945Z] === RUN   TestMountDaemonRoot/slave/bind_subpath
09:36:45 [2019-12-13T09:36:45.945Z] === PAUSE TestMountDaemonRoot/slave/bind_subpath
09:36:45 [2019-12-13T09:36:45.945Z] === RUN   TestMountDaemonRoot/slave/mount_root
09:36:45 [2019-12-13T09:36:45.945Z] === PAUSE TestMountDaemonRoot/slave/mount_root
09:36:45 [2019-12-13T09:36:45.945Z] === RUN   TestMountDaemonRoot/slave/mount_subpath
09:36:45 [2019-12-13T09:36:45.945Z] === PAUSE TestMountDaemonRoot/slave/mount_subpath
09:36:45 [2019-12-13T09:36:45.945Z] === CONT  TestMountDaemonRoot/rprivate/mount_subpath
09:36:45 [2019-12-13T09:36:45.945Z] === CONT  TestMountDaemonRoot/rprivate/mount_root
09:36:45 [2019-12-13T09:36:45.945Z] === CONT  TestMountDaemonRoot/rprivate/bind_subpath
09:36:45 [2019-12-13T09:36:45.945Z] === CONT  TestMountDaemonRoot/default/bind_root
09:36:45 [2019-12-13T09:36:45.945Z] === CONT  TestMountDaemonRoot/private
09:36:45 [2019-12-13T09:36:45.945Z] === RUN   TestMountDaemonRoot/private/bind_root
09:36:45 [2019-12-13T09:36:45.945Z] === PAUSE TestMountDaemonRoot/private/bind_root
09:36:45 [2019-12-13T09:36:45.945Z] === RUN   TestMountDaemonRoot/private/bind_subpath
09:36:45 [2019-12-13T09:36:45.945Z] === PAUSE TestMountDaemonRoot/private/bind_subpath
09:36:45 [2019-12-13T09:36:45.945Z] === RUN   TestMountDaemonRoot/private/mount_root
09:36:45 [2019-12-13T09:36:45.945Z] === PAUSE TestMountDaemonRoot/private/mount_root
09:36:45 [2019-12-13T09:36:45.945Z] === RUN   TestMountDaemonRoot/private/mount_subpath
09:36:45 [2019-12-13T09:36:45.945Z] === PAUSE TestMountDaemonRoot/private/mount_subpath
09:36:45 [2019-12-13T09:36:45.945Z] === CONT  TestMountDaemonRoot/default/mount_subpath
09:36:45 [2019-12-13T09:36:45.945Z] === CONT  TestMountDaemonRoot/default/mount_root
09:36:45 [2019-12-13T09:36:45.945Z] === CONT  TestMountDaemonRoot/rshared/mount_subpath
09:36:45 [2019-12-13T09:36:45.945Z] === CONT  TestMountDaemonRoot/shared/bind_root
09:36:45 [2019-12-13T09:36:45.945Z] === CONT  TestMountDaemonRoot/rshared/mount_root
09:36:45 [2019-12-13T09:36:45.945Z] === CONT  TestMountDaemonRoot/rshared/bind_subpath
09:36:45 [2019-12-13T09:36:45.945Z] === CONT  TestMountDaemonRoot/rshared/bind_root
09:36:45 [2019-12-13T09:36:45.945Z] === CONT  TestMountDaemonRoot/rslave/bind_root
09:36:46 [2019-12-13T09:36:46.325Z] === CONT  TestMountDaemonRoot/shared/mount_subpath
09:36:46 [2019-12-13T09:36:46.325Z] === CONT  TestMountDaemonRoot/shared/mount_root
09:36:46 [2019-12-13T09:36:46.325Z] === CONT  TestMountDaemonRoot/shared/bind_subpath
09:36:46 [2019-12-13T09:36:46.325Z] === CONT  TestMountDaemonRoot/slave/bind_root
09:36:46 [2019-12-13T09:36:46.325Z] === CONT  TestMountDaemonRoot/rslave/mount_subpath
09:36:46 [2019-12-13T09:36:46.325Z] === CONT  TestMountDaemonRoot/rslave/mount_root
09:36:46 [2019-12-13T09:36:46.325Z] === CONT  TestMountDaemonRoot/rslave/bind_subpath
09:36:46 [2019-12-13T09:36:46.325Z] === CONT  TestMountDaemonRoot/slave/mount_subpath
09:36:46 [2019-12-13T09:36:46.325Z] === CONT  TestMountDaemonRoot/slave/mount_root
09:36:46 [2019-12-13T09:36:46.325Z] === CONT  TestMountDaemonRoot/slave/bind_subpath
09:36:46 [2019-12-13T09:36:46.325Z] === CONT  TestMountDaemonRoot/private/bind_root
09:36:46 [2019-12-13T09:36:46.325Z] === CONT  TestMountDaemonRoot/private/mount_subpath
09:36:46 [2019-12-13T09:36:46.325Z] === CONT  TestMountDaemonRoot/private/mount_root
09:36:46 [2019-12-13T09:36:46.325Z] === CONT  TestMountDaemonRoot/private/bind_subpath
09:36:46 [2019-12-13T09:36:46.709Z] --- PASS: TestMountDaemonRoot (0.02s)
09:36:46 [2019-12-13T09:36:46.709Z]     --- PASS: TestMountDaemonRoot/rprivate (0.00s)
09:36:46 [2019-12-13T09:36:46.709Z]         --- PASS: TestMountDaemonRoot/rprivate/bind_root (0.05s)
09:36:46 [2019-12-13T09:36:46.709Z]         --- PASS: TestMountDaemonRoot/rprivate/mount_subpath (0.07s)
09:36:46 [2019-12-13T09:36:46.709Z]         --- PASS: TestMountDaemonRoot/rprivate/mount_root (0.03s)
09:36:46 [2019-12-13T09:36:46.709Z]         --- PASS: TestMountDaemonRoot/rprivate/bind_subpath (0.04s)
09:36:46 [2019-12-13T09:36:46.709Z]     --- PASS: TestMountDaemonRoot/default (0.00s)
09:36:46 [2019-12-13T09:36:46.709Z]         --- PASS: TestMountDaemonRoot/default/bind_subpath (0.13s)
09:36:46 [2019-12-13T09:36:46.709Z]         --- PASS: TestMountDaemonRoot/default/bind_root (0.09s)
09:36:46 [2019-12-13T09:36:46.709Z]         --- PASS: TestMountDaemonRoot/default/mount_subpath (0.08s)
09:36:46 [2019-12-13T09:36:46.709Z]         --- PASS: TestMountDaemonRoot/default/mount_root (0.09s)
09:36:46 [2019-12-13T09:36:46.709Z]     --- PASS: TestMountDaemonRoot/rshared (0.00s)
09:36:46 [2019-12-13T09:36:46.709Z]         --- PASS: TestMountDaemonRoot/rshared/mount_subpath (0.08s)
09:36:46 [2019-12-13T09:36:46.709Z]         --- PASS: TestMountDaemonRoot/rshared/mount_root (0.09s)
09:36:46 [2019-12-13T09:36:46.709Z]         --- PASS: TestMountDaemonRoot/rshared/bind_subpath (0.08s)
09:36:46 [2019-12-13T09:36:46.709Z]         --- PASS: TestMountDaemonRoot/rshared/bind_root (0.10s)
09:36:46 [2019-12-13T09:36:46.709Z]     --- PASS: TestMountDaemonRoot/shared (0.00s)
09:36:46 [2019-12-13T09:36:46.709Z]         --- PASS: TestMountDaemonRoot/shared/bind_root (0.06s)
09:36:46 [2019-12-13T09:36:46.709Z]         --- PASS: TestMountDaemonRoot/shared/mount_subpath (0.04s)
09:36:46 [2019-12-13T09:36:46.709Z]         --- PASS: TestMountDaemonRoot/shared/bind_subpath (0.04s)
09:36:46 [2019-12-13T09:36:46.709Z]         --- PASS: TestMountDaemonRoot/shared/mount_root (0.04s)
09:36:46 [2019-12-13T09:36:46.709Z]     --- PASS: TestMountDaemonRoot/rslave (0.00s)
09:36:46 [2019-12-13T09:36:46.709Z]         --- PASS: TestMountDaemonRoot/rslave/bind_root (0.09s)
09:36:46 [2019-12-13T09:36:46.709Z]         --- PASS: TestMountDaemonRoot/rslave/mount_subpath (0.08s)
09:36:46 [2019-12-13T09:36:46.709Z]         --- PASS: TestMountDaemonRoot/rslave/mount_root (0.08s)
09:36:46 [2019-12-13T09:36:46.709Z]         --- PASS: TestMountDaemonRoot/rslave/bind_subpath (0.09s)
09:36:46 [2019-12-13T09:36:46.709Z]     --- PASS: TestMountDaemonRoot/slave (0.00s)
09:36:46 [2019-12-13T09:36:46.709Z]         --- PASS: TestMountDaemonRoot/slave/bind_root (0.04s)
09:36:46 [2019-12-13T09:36:46.709Z]         --- PASS: TestMountDaemonRoot/slave/mount_subpath (0.04s)
09:36:46 [2019-12-13T09:36:46.709Z]         --- PASS: TestMountDaemonRoot/slave/mount_root (0.05s)
09:36:46 [2019-12-13T09:36:46.709Z]         --- PASS: TestMountDaemonRoot/slave/bind_subpath (0.04s)
09:36:46 [2019-12-13T09:36:46.709Z]     --- PASS: TestMountDaemonRoot/private (0.00s)
09:36:46 [2019-12-13T09:36:46.709Z]         --- PASS: TestMountDaemonRoot/private/bind_root (0.05s)
09:36:46 [2019-12-13T09:36:46.709Z]         --- PASS: TestMountDaemonRoot/private/mount_subpath (0.05s)
09:36:46 [2019-12-13T09:36:46.709Z]         --- PASS: TestMountDaemonRoot/private/mount_root (0.04s)
09:36:46 [2019-12-13T09:36:46.709Z]         --- PASS: TestMountDaemonRoot/private/bind_subpath (0.04s)
09:36:46 [2019-12-13T09:36:46.709Z] === RUN   TestContainerBindMountNonRecursive
09:36:49 [2019-12-13T09:36:49.238Z] --- PASS: TestContainerBindMountNonRecursive (2.58s)
09:36:49 [2019-12-13T09:36:49.238Z] === RUN   TestNetworkNat
09:36:50 [2019-12-13T09:36:50.112Z] --- PASS: TestNetworkNat (1.05s)
09:36:50 [2019-12-13T09:36:50.112Z] === RUN   TestNetworkLocalhostTCPNat
09:36:51 [2019-12-13T09:36:51.534Z] --- PASS: TestNetworkLocalhostTCPNat (0.98s)
09:36:51 [2019-12-13T09:36:51.534Z] === RUN   TestNetworkLoopbackNat
09:36:52 [2019-12-13T09:36:52.329Z] --- PASS: TestNetworkLoopbackNat (1.31s)
09:36:52 [2019-12-13T09:36:52.329Z] === RUN   TestPause
09:36:53 [2019-12-13T09:36:53.647Z] --- PASS: TestPause (1.26s)
09:36:53 [2019-12-13T09:36:53.647Z] === RUN   TestPauseFailsOnWindowsServerContainers
09:36:53 [2019-12-13T09:36:53.647Z] --- SKIP: TestPauseFailsOnWindowsServerContainers (0.00s)
09:36:53 [2019-12-13T09:36:53.647Z]     pause_test.go:54: testEnv.DaemonInfo.OSType != "windows" || testEnv.DaemonInfo.Isolation != "process"
09:36:53 [2019-12-13T09:36:53.647Z] === RUN   TestPauseStopPausedContainer
09:36:54 [2019-12-13T09:36:54.534Z] --- PASS: TestPauseStopPausedContainer (0.94s)
09:36:54 [2019-12-13T09:36:54.534Z] === RUN   TestPsFilter
09:36:54 [2019-12-13T09:36:54.912Z] --- PASS: TestPsFilter (0.26s)
09:36:54 [2019-12-13T09:36:54.912Z] === RUN   TestRemoveContainerWithRemovedVolume
09:36:55 [2019-12-13T09:36:55.713Z] --- PASS: TestRemoveContainerWithRemovedVolume (0.81s)
09:36:55 [2019-12-13T09:36:55.713Z] === RUN   TestRemoveContainerWithVolume
09:36:56 [2019-12-13T09:36:56.523Z] --- PASS: TestRemoveContainerWithVolume (0.96s)
09:36:56 [2019-12-13T09:36:56.523Z] === RUN   TestRemoveContainerRunning
09:36:57 [2019-12-13T09:36:57.828Z] --- PASS: TestRemoveContainerRunning (0.88s)
09:36:57 [2019-12-13T09:36:57.829Z] === RUN   TestRemoveContainerForceRemoveRunning
09:36:58 [2019-12-13T09:36:58.713Z] --- PASS: TestRemoveContainerForceRemoveRunning (0.92s)
09:36:58 [2019-12-13T09:36:58.713Z] === RUN   TestRemoveInvalidContainer
09:36:58 [2019-12-13T09:36:58.713Z] --- PASS: TestRemoveInvalidContainer (0.01s)
09:36:58 [2019-12-13T09:36:58.713Z] === RUN   TestRenameLinkedContainer
09:37:01 [2019-12-13T09:37:01.983Z] --- PASS: TestRenameLinkedContainer (3.64s)
09:37:01 [2019-12-13T09:37:01.983Z] === RUN   TestRenameStoppedContainer
09:37:03 [2019-12-13T09:37:03.400Z] --- PASS: TestRenameStoppedContainer (1.05s)
09:37:03 [2019-12-13T09:37:03.400Z] === RUN   TestRenameRunningContainerAndReuse
09:37:05 [2019-12-13T09:37:05.394Z] --- PASS: TestRenameRunningContainerAndReuse (1.90s)
09:37:05 [2019-12-13T09:37:05.394Z] === RUN   TestRenameInvalidName
09:37:06 [2019-12-13T09:37:06.203Z] --- PASS: TestRenameInvalidName (0.99s)
09:37:06 [2019-12-13T09:37:06.203Z] === RUN   TestRenameAnonymousContainer
09:37:09 [2019-12-13T09:37:09.513Z] --- PASS: TestRenameAnonymousContainer (3.34s)
09:37:09 [2019-12-13T09:37:09.513Z] === RUN   TestRenameContainerWithSameName
09:37:10 [2019-12-13T09:37:10.334Z] --- PASS: TestRenameContainerWithSameName (0.89s)
09:37:10 [2019-12-13T09:37:10.334Z] === RUN   TestRenameContainerWithLinkedContainer
09:37:12 [2019-12-13T09:37:12.161Z] --- PASS: TestRenameContainerWithLinkedContainer (1.81s)
09:37:12 [2019-12-13T09:37:12.161Z] === RUN   TestResize
09:37:12 [2019-12-13T09:37:12.970Z] --- PASS: TestResize (0.90s)
09:37:12 [2019-12-13T09:37:12.970Z] === RUN   TestResizeWithInvalidSize
09:37:13 [2019-12-13T09:37:13.990Z] --- PASS: TestResizeWithInvalidSize (1.01s)
09:37:13 [2019-12-13T09:37:13.990Z] === RUN   TestResizeWhenContainerNotStarted
09:37:14 [2019-12-13T09:37:14.843Z] --- PASS: TestResizeWhenContainerNotStarted (0.97s)
09:37:14 [2019-12-13T09:37:14.843Z] === RUN   TestDaemonRestartKillContainers
09:37:14 [2019-12-13T09:37:14.843Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
09:37:14 [2019-12-13T09:37:14.843Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
09:37:14 [2019-12-13T09:37:14.843Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
09:37:14 [2019-12-13T09:37:14.843Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
09:37:14 [2019-12-13T09:37:14.843Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
09:37:14 [2019-12-13T09:37:14.843Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
09:37:14 [2019-12-13T09:37:14.843Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
09:37:14 [2019-12-13T09:37:14.843Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
09:37:14 [2019-12-13T09:37:14.843Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
09:37:14 [2019-12-13T09:37:14.843Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
09:37:14 [2019-12-13T09:37:14.843Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
09:37:14 [2019-12-13T09:37:14.843Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
09:37:14 [2019-12-13T09:37:14.843Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
09:37:14 [2019-12-13T09:37:14.843Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
09:37:14 [2019-12-13T09:37:14.843Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
09:37:14 [2019-12-13T09:37:14.843Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
09:37:14 [2019-12-13T09:37:14.843Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
09:37:14 [2019-12-13T09:37:14.843Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
09:37:14 [2019-12-13T09:37:14.843Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
09:37:14 [2019-12-13T09:37:14.843Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
09:37:14 [2019-12-13T09:37:14.843Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
09:37:14 [2019-12-13T09:37:14.843Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
09:37:14 [2019-12-13T09:37:14.843Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
09:37:14 [2019-12-13T09:37:14.843Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
09:37:14 [2019-12-13T09:37:14.843Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
09:37:14 [2019-12-13T09:37:14.843Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
09:37:18 [2019-12-13T09:37:18.039Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
09:37:18 [2019-12-13T09:37:18.039Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
09:37:19 [2019-12-13T09:37:19.475Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
09:37:19 [2019-12-13T09:37:19.475Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
09:37:20 [2019-12-13T09:37:20.892Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
09:37:20 [2019-12-13T09:37:20.892Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
09:37:23 [2019-12-13T09:37:23.423Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
09:37:23 [2019-12-13T09:37:23.423Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
09:37:26 [2019-12-13T09:37:26.937Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
09:37:26 [2019-12-13T09:37:26.937Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
09:37:30 [2019-12-13T09:37:30.191Z] --- PASS: TestDaemonRestartKillContainers (0.00s)
09:37:30 [2019-12-13T09:37:30.191Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon (2.60s)
09:37:30 [2019-12-13T09:37:30.191Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon (2.92s)
09:37:30 [2019-12-13T09:37:30.191Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon (1.55s)
09:37:30 [2019-12-13T09:37:30.191Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon (1.48s)
09:37:30 [2019-12-13T09:37:30.191Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon (1.62s)
09:37:30 [2019-12-13T09:37:30.191Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon (1.51s)
09:37:30 [2019-12-13T09:37:30.191Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon (2.39s)
09:37:30 [2019-12-13T09:37:30.191Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon (2.58s)
09:37:30 [2019-12-13T09:37:30.191Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon (3.55s)
09:37:30 [2019-12-13T09:37:30.191Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon (3.24s)
09:37:30 [2019-12-13T09:37:30.191Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon (2.24s)
09:37:30 [2019-12-13T09:37:30.191Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon (3.15s)
09:37:30 [2019-12-13T09:37:30.191Z] === RUN   TestCgroupNamespacesRun
09:37:31 [2019-12-13T09:37:31.616Z] --- PASS: TestCgroupNamespacesRun (1.93s)
09:37:31 [2019-12-13T09:37:31.616Z] === RUN   TestCgroupNamespacesRunPrivileged
09:37:33 [2019-12-13T09:37:33.456Z] --- PASS: TestCgroupNamespacesRunPrivileged (1.73s)
09:37:33 [2019-12-13T09:37:33.456Z] === RUN   TestCgroupNamespacesRunDaemonHostMode
09:37:35 [2019-12-13T09:37:35.400Z] --- PASS: TestCgroupNamespacesRunDaemonHostMode (1.81s)
09:37:35 [2019-12-13T09:37:35.400Z] === RUN   TestCgroupNamespacesRunHostMode
09:37:37 [2019-12-13T09:37:37.325Z] --- PASS: TestCgroupNamespacesRunHostMode (1.92s)
09:37:37 [2019-12-13T09:37:37.325Z] === RUN   TestCgroupNamespacesRunPrivateMode
09:37:39 [2019-12-13T09:37:39.146Z] --- PASS: TestCgroupNamespacesRunPrivateMode (1.89s)
09:37:39 [2019-12-13T09:37:39.146Z] === RUN   TestCgroupNamespacesRunPrivilegedAndPrivate
09:37:39 [2019-12-13T09:37:39.984Z] --- PASS: TestCgroupNamespacesRunPrivilegedAndPrivate (0.86s)
09:37:39 [2019-12-13T09:37:39.984Z] === RUN   TestCgroupNamespacesRunInvalidMode
09:37:40 [2019-12-13T09:37:40.866Z] --- PASS: TestCgroupNamespacesRunInvalidMode (0.94s)
09:37:40 [2019-12-13T09:37:40.866Z] === RUN   TestCgroupNamespacesRunOlderClient
09:37:42 [2019-12-13T09:37:42.753Z] --- PASS: TestCgroupNamespacesRunOlderClient (1.87s)
09:37:42 [2019-12-13T09:37:42.753Z] === RUN   TestKernelTCPMemory
09:37:44 [2019-12-13T09:37:44.017Z] --- PASS: TestKernelTCPMemory (1.02s)
09:37:44 [2019-12-13T09:37:44.017Z] === RUN   TestNISDomainname
09:37:44 [2019-12-13T09:37:44.955Z] --- PASS: TestNISDomainname (1.23s)
09:37:44 [2019-12-13T09:37:44.955Z] === RUN   TestHostnameDnsResolution
09:37:46 [2019-12-13T09:37:46.263Z] --- PASS: TestHostnameDnsResolution (1.29s)
09:37:46 [2019-12-13T09:37:46.263Z] === RUN   TestStats
09:37:49 [2019-12-13T09:37:49.449Z] --- PASS: TestStats (2.82s)
09:37:49 [2019-12-13T09:37:49.449Z] === RUN   TestStopContainerWithTimeout
09:37:49 [2019-12-13T09:37:49.449Z] === RUN   TestStopContainerWithTimeout/0
09:37:49 [2019-12-13T09:37:49.449Z] === PAUSE TestStopContainerWithTimeout/0
09:37:49 [2019-12-13T09:37:49.449Z] === RUN   TestStopContainerWithTimeout/1
09:37:49 [2019-12-13T09:37:49.449Z] === PAUSE TestStopContainerWithTimeout/1
09:37:49 [2019-12-13T09:37:49.449Z] === RUN   TestStopContainerWithTimeout/3
09:37:49 [2019-12-13T09:37:49.449Z] === PAUSE TestStopContainerWithTimeout/3
09:37:49 [2019-12-13T09:37:49.449Z] === RUN   TestStopContainerWithTimeout/-1
09:37:49 [2019-12-13T09:37:49.449Z] === PAUSE TestStopContainerWithTimeout/-1
09:37:49 [2019-12-13T09:37:49.449Z] === CONT  TestStopContainerWithTimeout/0
09:37:49 [2019-12-13T09:37:49.449Z] === CONT  TestStopContainerWithTimeout/-1
09:37:50 [2019-12-13T09:37:50.301Z] === CONT  TestStopContainerWithTimeout/3
09:37:52 [2019-12-13T09:37:52.143Z] === CONT  TestStopContainerWithTimeout/1
09:37:54 [2019-12-13T09:37:54.092Z] --- PASS: TestStopContainerWithTimeout (0.01s)
09:37:54 [2019-12-13T09:37:54.092Z]     --- PASS: TestStopContainerWithTimeout/0 (1.02s)
09:37:54 [2019-12-13T09:37:54.092Z]     --- PASS: TestStopContainerWithTimeout/-1 (2.94s)
09:37:54 [2019-12-13T09:37:54.092Z]     --- PASS: TestStopContainerWithTimeout/3 (2.99s)
09:37:54 [2019-12-13T09:37:54.092Z]     --- PASS: TestStopContainerWithTimeout/1 (1.88s)
09:37:54 [2019-12-13T09:37:54.092Z] === RUN   TestDeleteDevicemapper
09:37:54 [2019-12-13T09:37:54.092Z] --- SKIP: TestDeleteDevicemapper (0.00s)
09:37:54 [2019-12-13T09:37:54.092Z]     stop_linux_test.go:74: testEnv.DaemonInfo.Driver != "devicemapper"
09:37:54 [2019-12-13T09:37:54.092Z] === RUN   TestStopContainerWithRestartPolicyAlways
09:37:58 [2019-12-13T09:37:58.275Z] --- PASS: TestStopContainerWithRestartPolicyAlways (3.61s)
09:37:58 [2019-12-13T09:37:58.275Z] === RUN   TestUpdateMemory
09:37:58 [2019-12-13T09:37:58.275Z] --- SKIP: TestUpdateMemory (0.00s)
09:37:58 [2019-12-13T09:37:58.275Z]     update_linux_test.go:23: !testEnv.DaemonInfo.SwapLimit
09:37:58 [2019-12-13T09:37:58.275Z] === RUN   TestUpdateCPUQuota
09:37:59 [2019-12-13T09:37:59.076Z] --- PASS: TestUpdateCPUQuota (1.62s)
09:37:59 [2019-12-13T09:37:59.076Z] === RUN   TestUpdatePidsLimit
09:37:59 [2019-12-13T09:37:59.076Z] === RUN   TestUpdatePidsLimit/update_from_none
09:37:59 [2019-12-13T09:37:59.906Z] === RUN   TestUpdatePidsLimit/no_change
09:38:00 [2019-12-13T09:38:00.394Z] === RUN   TestUpdatePidsLimit/update_lower
09:38:00 [2019-12-13T09:38:00.834Z] === RUN   TestUpdatePidsLimit/update_on_old_api_ignores_value
09:38:01 [2019-12-13T09:38:01.229Z] === RUN   TestUpdatePidsLimit/unset_limit_with_zero
09:38:01 [2019-12-13T09:38:01.599Z] === RUN   TestUpdatePidsLimit/unset_limit_with_minus_one
09:38:01 [2019-12-13T09:38:01.969Z] === RUN   TestUpdatePidsLimit/unset_limit_with_minus_two
09:38:03 [2019-12-13T09:38:03.811Z] --- PASS: TestUpdatePidsLimit (4.43s)
09:38:03 [2019-12-13T09:38:03.811Z]     --- PASS: TestUpdatePidsLimit/update_from_none (0.47s)
09:38:03 [2019-12-13T09:38:03.811Z]     --- PASS: TestUpdatePidsLimit/no_change (0.40s)
09:38:03 [2019-12-13T09:38:03.811Z]     --- PASS: TestUpdatePidsLimit/update_lower (0.46s)
09:38:03 [2019-12-13T09:38:03.811Z]     --- PASS: TestUpdatePidsLimit/update_on_old_api_ignores_value (0.49s)
09:38:03 [2019-12-13T09:38:03.811Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_zero (0.49s)
09:38:03 [2019-12-13T09:38:03.811Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_minus_one (0.48s)
09:38:03 [2019-12-13T09:38:03.811Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_minus_two (0.42s)
09:38:03 [2019-12-13T09:38:03.811Z] === RUN   TestUpdateRestartPolicy
09:38:17 [2019-12-13T09:38:17.637Z] --- PASS: TestUpdateRestartPolicy (13.67s)
09:38:17 [2019-12-13T09:38:17.637Z] === RUN   TestUpdateRestartWithAutoRemove
09:38:18 [2019-12-13T09:38:18.421Z] --- PASS: TestUpdateRestartWithAutoRemove (0.95s)
09:38:18 [2019-12-13T09:38:18.421Z] === RUN   TestWaitNonBlocked
09:38:18 [2019-12-13T09:38:18.421Z] === RUN   TestWaitNonBlocked/wait-nonblocking-exit-0
09:38:18 [2019-12-13T09:38:18.421Z] === PAUSE TestWaitNonBlocked/wait-nonblocking-exit-0
09:38:18 [2019-12-13T09:38:18.421Z] === RUN   TestWaitNonBlocked/wait-nonblocking-exit-random
09:38:18 [2019-12-13T09:38:18.421Z] === PAUSE TestWaitNonBlocked/wait-nonblocking-exit-random
09:38:18 [2019-12-13T09:38:18.421Z] === CONT  TestWaitNonBlocked/wait-nonblocking-exit-0
09:38:18 [2019-12-13T09:38:18.421Z] === CONT  TestWaitNonBlocked/wait-nonblocking-exit-random
09:38:19 [2019-12-13T09:38:19.269Z] --- PASS: TestWaitNonBlocked (0.01s)
09:38:19 [2019-12-13T09:38:19.269Z]     --- PASS: TestWaitNonBlocked/wait-nonblocking-exit-0 (1.09s)
09:38:19 [2019-12-13T09:38:19.269Z]     --- PASS: TestWaitNonBlocked/wait-nonblocking-exit-random (1.14s)
09:38:19 [2019-12-13T09:38:19.269Z] === RUN   TestWaitBlocked
09:38:19 [2019-12-13T09:38:19.269Z] === RUN   TestWaitBlocked/test-wait-blocked-exit-zero
09:38:19 [2019-12-13T09:38:19.269Z] === PAUSE TestWaitBlocked/test-wait-blocked-exit-zero
09:38:19 [2019-12-13T09:38:19.269Z] === RUN   TestWaitBlocked/test-wait-blocked-exit-random
09:38:19 [2019-12-13T09:38:19.269Z] === PAUSE TestWaitBlocked/test-wait-blocked-exit-random
09:38:19 [2019-12-13T09:38:19.642Z] === CONT  TestWaitBlocked/test-wait-blocked-exit-zero
09:38:19 [2019-12-13T09:38:19.642Z] === CONT  TestWaitBlocked/test-wait-blocked-exit-random
09:38:21 [2019-12-13T09:38:21.531Z] --- PASS: TestWaitBlocked (0.03s)
09:38:21 [2019-12-13T09:38:21.531Z]     --- PASS: TestWaitBlocked/test-wait-blocked-exit-random (1.66s)
09:38:21 [2019-12-13T09:38:21.531Z]     --- PASS: TestWaitBlocked/test-wait-blocked-exit-zero (1.79s)
09:38:21 [2019-12-13T09:38:21.531Z] === CONT  TestContainerStartOnDaemonRestart
09:38:21 [2019-12-13T09:38:21.531Z] === CONT  TestIpcModeOlderClient
09:38:22 [2019-12-13T09:38:22.031Z] --- PASS: TestIpcModeOlderClient (0.48s)
09:38:22 [2019-12-13T09:38:22.031Z] === CONT  TestDaemonRestartIpcMode
09:38:25 [2019-12-13T09:38:25.355Z] --- PASS: TestContainerStartOnDaemonRestart (3.91s)
09:38:26 [2019-12-13T09:38:26.625Z] --- PASS: TestDaemonRestartIpcMode (4.99s)
09:38:26 [2019-12-13T09:38:26.625Z] PASS
09:38:26 [2019-12-13T09:38:26.625Z] 
09:38:26 [2019-12-13T09:38:26.625Z] === Skipped
09:38:26 [2019-12-13T09:38:26.625Z] === SKIP: s390x.integration.container TestCheckpoint (0.00s)
09:38:26 [2019-12-13T09:38:26.625Z]     checkpoint_test.go:33: TestCheckpoint is broken; see https://github.com/moby/moby/issues/38963
09:38:26 [2019-12-13T09:38:26.625Z] 
09:38:26 [2019-12-13T09:38:26.625Z] === SKIP: s390x.integration.container TestInspectOomKilledTrue (0.01s)
09:38:26 [2019-12-13T09:38:26.625Z]     kill_test.go:151: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
09:38:26 [2019-12-13T09:38:26.625Z] 
09:38:26 [2019-12-13T09:38:26.625Z] === SKIP: s390x.integration.container TestInspectOomKilledFalse (0.00s)
09:38:26 [2019-12-13T09:38:26.625Z]     kill_test.go:169: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
09:38:26 [2019-12-13T09:38:26.625Z] 
09:38:26 [2019-12-13T09:38:26.625Z] === SKIP: s390x.integration.container TestPauseFailsOnWindowsServerContainers (0.00s)
09:38:26 [2019-12-13T09:38:26.625Z]     pause_test.go:54: testEnv.DaemonInfo.OSType != "windows" || testEnv.DaemonInfo.Isolation != "process"
09:38:26 [2019-12-13T09:38:26.625Z] 
09:38:26 [2019-12-13T09:38:26.625Z] === SKIP: s390x.integration.container TestDeleteDevicemapper (0.00s)
09:38:26 [2019-12-13T09:38:26.625Z]     stop_linux_test.go:74: testEnv.DaemonInfo.Driver != "devicemapper"
09:38:26 [2019-12-13T09:38:26.625Z] 
09:38:26 [2019-12-13T09:38:26.625Z] === SKIP: s390x.integration.container TestUpdateMemory (0.00s)
09:38:26 [2019-12-13T09:38:26.625Z]     update_linux_test.go:23: !testEnv.DaemonInfo.SwapLimit
09:38:26 [2019-12-13T09:38:26.625Z] 
09:38:26 [2019-12-13T09:38:26.625Z] 
09:38:26 [2019-12-13T09:38:26.625Z] DONE 197 tests, 6 skipped in 150.235s
09:38:26 [2019-12-13T09:38:26.625Z] Running /go/src/github.com/docker/docker/integration/image (s390x.integration.image) flags=-test.v -test.timeout=120m 
09:38:26 [2019-12-13T09:38:26.625Z] ++ 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
09:38:26 [2019-12-13T09:38:26.625Z] ++ set -e
09:38:26 [2019-12-13T09:38:26.625Z] ++ '[' -n 0 ']'
09:38:26 [2019-12-13T09:38:26.625Z] ++ set -x
09:38:26 [2019-12-13T09:38:26.625Z] ++ 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
09:38:27 [2019-12-13T09:38:27.030Z] INFO: Testing against a local daemon
09:38:27 [2019-12-13T09:38:27.030Z] === RUN   TestCommitInheritsEnv
09:38:27 [2019-12-13T09:38:27.524Z] --- PASS: TestCommitInheritsEnv (0.62s)
09:38:27 [2019-12-13T09:38:27.524Z] === RUN   TestImportExtremelyLargeImageWorks
09:38:27 [2019-12-13T09:38:27.524Z] === PAUSE TestImportExtremelyLargeImageWorks
09:38:27 [2019-12-13T09:38:27.524Z] === RUN   TestImagesFilterMultiReference
09:38:27 [2019-12-13T09:38:27.938Z] --- PASS: TestImagesFilterMultiReference (0.09s)
09:38:27 [2019-12-13T09:38:27.938Z] === RUN   TestImagePullPlatformInvalid
09:38:27 [2019-12-13T09:38:27.938Z] --- PASS: TestImagePullPlatformInvalid (0.03s)
09:38:27 [2019-12-13T09:38:27.938Z] === RUN   TestRemoveImageOrphaning
09:38:28 [2019-12-13T09:38:28.330Z] --- PASS: TestRemoveImageOrphaning (0.56s)
09:38:28 [2019-12-13T09:38:28.330Z] === RUN   TestRemoveImageGarbageCollector
09:38:28 [2019-12-13T09:38:28.330Z] --- SKIP: TestRemoveImageGarbageCollector (0.00s)
09:38:28 [2019-12-13T09:38:28.330Z]     remove_unix_test.go:36: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
09:38:28 [2019-12-13T09:38:28.330Z] === RUN   TestTagUnprefixedRepoByNameOrName
09:38:28 [2019-12-13T09:38:28.330Z] --- PASS: TestTagUnprefixedRepoByNameOrName (0.02s)
09:38:28 [2019-12-13T09:38:28.330Z] === RUN   TestTagInvalidReference
09:38:28 [2019-12-13T09:38:28.330Z] --- PASS: TestTagInvalidReference (0.02s)
09:38:28 [2019-12-13T09:38:28.330Z] === RUN   TestTagValidPrefixedRepo
09:38:28 [2019-12-13T09:38:28.330Z] --- PASS: TestTagValidPrefixedRepo (0.04s)
09:38:28 [2019-12-13T09:38:28.330Z] === RUN   TestTagExistedNameWithoutForce
09:38:28 [2019-12-13T09:38:28.330Z] --- PASS: TestTagExistedNameWithoutForce (0.02s)
09:38:28 [2019-12-13T09:38:28.330Z] === RUN   TestTagOfficialNames
09:38:28 [2019-12-13T09:38:28.330Z] --- PASS: TestTagOfficialNames (0.04s)
09:38:28 [2019-12-13T09:38:28.330Z] === RUN   TestTagMatchesDigest
09:38:28 [2019-12-13T09:38:28.330Z] --- PASS: TestTagMatchesDigest (0.01s)
09:38:28 [2019-12-13T09:38:28.330Z] === CONT  TestImportExtremelyLargeImageWorks
09:40:38 [2019-12-13T09:40:38.222Z] --- PASS: TestImportExtremelyLargeImageWorks (120.14s)
09:40:38 [2019-12-13T09:40:38.222Z] PASS
09:40:38 [2019-12-13T09:40:38.222Z] 
09:40:38 [2019-12-13T09:40:38.222Z] === Skipped
09:40:38 [2019-12-13T09:40:38.222Z] === SKIP: s390x.integration.image TestRemoveImageGarbageCollector (0.00s)
09:40:38 [2019-12-13T09:40:38.222Z]     remove_unix_test.go:36: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
09:40:38 [2019-12-13T09:40:38.222Z] 
09:40:38 [2019-12-13T09:40:38.222Z] 
09:40:38 [2019-12-13T09:40:38.222Z] DONE 12 tests, 1 skipped in 121.789s
09:40:38 [2019-12-13T09:40:38.222Z] Running /go/src/github.com/docker/docker/integration/network (s390x.integration.network) flags=-test.v -test.timeout=120m 
09:40:38 [2019-12-13T09:40:38.222Z] ++ 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
09:40:38 [2019-12-13T09:40:38.222Z] ++ set -e
09:40:38 [2019-12-13T09:40:38.222Z] ++ '[' -n 0 ']'
09:40:38 [2019-12-13T09:40:38.222Z] ++ set -x
09:40:38 [2019-12-13T09:40:38.222Z] ++ 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
09:40:38 [2019-12-13T09:40:38.222Z] INFO: Testing against a local daemon
09:40:38 [2019-12-13T09:40:38.222Z] === RUN   TestNetworkCreateDelete
09:40:38 [2019-12-13T09:40:38.222Z] --- PASS: TestNetworkCreateDelete (0.17s)
09:40:38 [2019-12-13T09:40:38.222Z] === RUN   TestDockerNetworkDeletePreferID
09:40:38 [2019-12-13T09:40:38.222Z] --- PASS: TestDockerNetworkDeletePreferID (0.40s)
09:40:38 [2019-12-13T09:40:38.222Z] === RUN   TestInspectNetwork
09:40:38 [2019-12-13T09:40:38.222Z] === RUN   TestInspectNetwork/full_network_id
09:40:38 [2019-12-13T09:40:38.222Z] === RUN   TestInspectNetwork/partial_network_id
09:40:38 [2019-12-13T09:40:38.222Z] === RUN   TestInspectNetwork/network_name
09:40:38 [2019-12-13T09:40:38.222Z] === RUN   TestInspectNetwork/network_name_and_swarm_scope
09:40:38 [2019-12-13T09:40:38.597Z] --- PASS: TestInspectNetwork (9.24s)
09:40:38 [2019-12-13T09:40:38.597Z]     --- PASS: TestInspectNetwork/full_network_id (0.00s)
09:40:38 [2019-12-13T09:40:38.597Z]     --- PASS: TestInspectNetwork/partial_network_id (0.00s)
09:40:38 [2019-12-13T09:40:38.597Z]     --- PASS: TestInspectNetwork/network_name (0.00s)
09:40:38 [2019-12-13T09:40:38.597Z]     --- PASS: TestInspectNetwork/network_name_and_swarm_scope (0.00s)
09:40:38 [2019-12-13T09:40:38.597Z] === RUN   TestRunContainerWithBridgeNone
09:40:41 [2019-12-13T09:40:41.178Z] --- PASS: TestRunContainerWithBridgeNone (2.71s)
09:40:41 [2019-12-13T09:40:41.178Z] === RUN   TestNetworkInvalidJSON
09:40:41 [2019-12-13T09:40:41.178Z] === RUN   TestNetworkInvalidJSON//networks/create
09:40:41 [2019-12-13T09:40:41.178Z] === PAUSE TestNetworkInvalidJSON//networks/create
09:40:41 [2019-12-13T09:40:41.178Z] === RUN   TestNetworkInvalidJSON//networks/bridge/connect
09:40:41 [2019-12-13T09:40:41.178Z] === PAUSE TestNetworkInvalidJSON//networks/bridge/connect
09:40:41 [2019-12-13T09:40:41.178Z] === RUN   TestNetworkInvalidJSON//networks/bridge/disconnect
09:40:41 [2019-12-13T09:40:41.178Z] === PAUSE TestNetworkInvalidJSON//networks/bridge/disconnect
09:40:41 [2019-12-13T09:40:41.178Z] === CONT  TestNetworkInvalidJSON//networks/create
09:40:41 [2019-12-13T09:40:41.178Z] === CONT  TestNetworkInvalidJSON//networks/bridge/disconnect
09:40:41 [2019-12-13T09:40:41.178Z] === CONT  TestNetworkInvalidJSON//networks/bridge/connect
09:40:41 [2019-12-13T09:40:41.178Z] --- PASS: TestNetworkInvalidJSON (0.01s)
09:40:41 [2019-12-13T09:40:41.178Z]     --- PASS: TestNetworkInvalidJSON//networks/bridge/disconnect (0.00s)
09:40:41 [2019-12-13T09:40:41.179Z]     --- PASS: TestNetworkInvalidJSON//networks/create (0.00s)
09:40:41 [2019-12-13T09:40:41.179Z]     --- PASS: TestNetworkInvalidJSON//networks/bridge/connect (0.00s)
09:40:41 [2019-12-13T09:40:41.179Z] === RUN   TestDaemonRestartWithLiveRestore
09:40:42 [2019-12-13T09:40:42.456Z] --- PASS: TestDaemonRestartWithLiveRestore (1.06s)
09:40:42 [2019-12-13T09:40:42.456Z] === RUN   TestDaemonDefaultNetworkPools
09:40:43 [2019-12-13T09:40:43.244Z] --- PASS: TestDaemonDefaultNetworkPools (0.76s)
09:40:43 [2019-12-13T09:40:43.244Z] === RUN   TestDaemonRestartWithExistingNetwork
09:40:44 [2019-12-13T09:40:44.095Z] --- PASS: TestDaemonRestartWithExistingNetwork (1.16s)
09:40:44 [2019-12-13T09:40:44.095Z] === RUN   TestDaemonRestartWithExistingNetworkWithDefaultPoolRange
09:40:45 [2019-12-13T09:40:45.587Z] --- PASS: TestDaemonRestartWithExistingNetworkWithDefaultPoolRange (1.24s)
09:40:45 [2019-12-13T09:40:45.587Z] === RUN   TestDaemonWithBipAndDefaultNetworkPool
09:40:45 [2019-12-13T09:40:45.970Z] --- PASS: TestDaemonWithBipAndDefaultNetworkPool (0.60s)
09:40:45 [2019-12-13T09:40:45.970Z] === RUN   TestServiceWithPredefinedNetwork
09:40:49 [2019-12-13T09:40:49.266Z] --- PASS: TestServiceWithPredefinedNetwork (3.10s)
09:40:49 [2019-12-13T09:40:49.266Z] === RUN   TestServiceRemoveKeepsIngressNetwork
09:40:49 [2019-12-13T09:40:49.266Z] --- SKIP: TestServiceRemoveKeepsIngressNetwork (0.00s)
09:40:49 [2019-12-13T09:40:49.266Z]     service_test.go:230: FLAKY_TEST
09:40:49 [2019-12-13T09:40:49.266Z] === RUN   TestServiceWithDataPathPortInit
09:41:09 [2019-12-13T09:41:09.125Z] --- PASS: TestServiceWithDataPathPortInit (17.32s)
09:41:09 [2019-12-13T09:41:09.126Z] === RUN   TestServiceWithDefaultAddressPoolInit
09:41:15 [2019-12-13T09:41:15.443Z] --- PASS: TestServiceWithDefaultAddressPoolInit (9.06s)
09:41:15 [2019-12-13T09:41:15.443Z]     service_test.go:418: TestServiceWithDefaultAddressPoolInit: NetworkInspect: {Name:sthiraTestServiceWithDefaultAddressPoolInit ID:l6nr1p0i09j2avr74spr09af8 Created:2019-12-13 09:41:07.420831523 +0000 UTC Scope:swarm Driver:overlay EnableIPv6:false IPAM:{Driver:default Options:map[] Config:[{Subnet:20.20.0.0/24 IPRange: Gateway:20.20.0.1 AuxAddress:map[]}]} Internal:false Attachable:false Ingress:false ConfigFrom:{Network:} ConfigOnly:false Containers:map[58721073c9ce0ac0f33ed27e175d647e980827225564e12ff0964dc8429fe7ea:{Name:TestServiceTestServiceWithDefaultAddressPoolInit.1.6lj2sdn3m0fi8vzlys63ibtek EndpointID:3f9b32219e8a8806f4d23169108b75fa57e294c56ae4e07807919e5ae52174d0 MacAddress:02:42:14:14:00:03 IPv4Address:20.20.0.3/24 IPv6Address:} lb-sthiraTestServiceWithDefaultAddressPoolInit:{Name:sthiraTestServiceWithDefaultAddressPoolInit-endpoint EndpointID:b5f9fe8f112892de56e9f2f06b30e0232185bbc38bf60604f276500b4d237c38 MacAddress:02:42:14:14:00:04 IPv4Address:20.20.0.4/24 IPv6Address:}] Options:map[com.docker.network.driver.overlay.vxlanid_list:4097] Labels:map[] Peers:[{Name:242d0b626d5e IP:127.0.0.1}] Services:map[TestServiceTestServiceWithDefaultAddressPoolInit:{VIP:20.20.0.2 Ports:[] LocalLBIndex:256 Tasks:[{Name:TestServiceTestServiceWithDefaultAddressPoolInit.1.6lj2sdn3m0fi8vzlys63ibtek EndpointID:3f9b32219e8a8806f4d23169108b75fa57e294c56ae4e07807919e5ae52174d0 EndpointIP:20.20.0.3 Info:map[Host IP:127.0.0.1]}]}]}
09:41:15 [2019-12-13T09:41:15.443Z] PASS
09:41:15 [2019-12-13T09:41:15.443Z] 
09:41:15 [2019-12-13T09:41:15.443Z] === Skipped
09:41:15 [2019-12-13T09:41:15.443Z] === SKIP: s390x.integration.network TestServiceRemoveKeepsIngressNetwork (0.00s)
09:41:15 [2019-12-13T09:41:15.443Z]     service_test.go:230: FLAKY_TEST
09:41:15 [2019-12-13T09:41:15.443Z] 
09:41:15 [2019-12-13T09:41:15.443Z] 
09:41:15 [2019-12-13T09:41:15.443Z] DONE 21 tests, 1 skipped in 46.932s
09:41:15 [2019-12-13T09:41:15.443Z] Running /go/src/github.com/docker/docker/integration/network/ipvlan (s390x.integration.network.ipvlan) flags=-test.v -test.timeout=120m 
09:41:15 [2019-12-13T09:41:15.443Z] ++ 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
09:41:15 [2019-12-13T09:41:15.443Z] ++ set -e
09:41:15 [2019-12-13T09:41:15.443Z] ++ '[' -n 0 ']'
09:41:15 [2019-12-13T09:41:15.443Z] ++ set -x
09:41:15 [2019-12-13T09:41:15.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-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
09:41:15 [2019-12-13T09:41:15.836Z] INFO: Testing against a local daemon
09:41:15 [2019-12-13T09:41:15.836Z] === RUN   TestDockerNetworkIpvlanPersistance
09:41:15 [2019-12-13T09:41:15.836Z] --- SKIP: TestDockerNetworkIpvlanPersistance (0.00s)
09:41:15 [2019-12-13T09:41:15.836Z]     ipvlan_test.go:26: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
09:41:15 [2019-12-13T09:41:15.836Z] === RUN   TestDockerNetworkIpvlan
09:41:15 [2019-12-13T09:41:15.836Z] --- SKIP: TestDockerNetworkIpvlan (0.00s)
09:41:15 [2019-12-13T09:41:15.836Z]     ipvlan_test.go:53: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
09:41:15 [2019-12-13T09:41:15.836Z] PASS
09:41:15 [2019-12-13T09:41:15.836Z] 
09:41:15 [2019-12-13T09:41:15.836Z] === Skipped
09:41:15 [2019-12-13T09:41:15.836Z] === SKIP: s390x.integration.network.ipvlan TestDockerNetworkIpvlanPersistance (0.00s)
09:41:15 [2019-12-13T09:41:15.837Z]     ipvlan_test.go:26: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
09:41:15 [2019-12-13T09:41:15.837Z] 
09:41:15 [2019-12-13T09:41:15.837Z] === SKIP: s390x.integration.network.ipvlan TestDockerNetworkIpvlan (0.00s)
09:41:15 [2019-12-13T09:41:15.837Z]     ipvlan_test.go:53: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
09:41:15 [2019-12-13T09:41:15.837Z] 
09:41:15 [2019-12-13T09:41:15.837Z] 
09:41:15 [2019-12-13T09:41:15.837Z] DONE 2 tests, 2 skipped in 0.121s
09:41:15 [2019-12-13T09:41:15.837Z] Running /go/src/github.com/docker/docker/integration/network/macvlan (s390x.integration.network.macvlan) flags=-test.v -test.timeout=120m 
09:41:15 [2019-12-13T09:41:15.837Z] ++ 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
09:41:15 [2019-12-13T09:41:15.837Z] ++ set -e
09:41:15 [2019-12-13T09:41:15.837Z] ++ '[' -n 0 ']'
09:41:15 [2019-12-13T09:41:15.837Z] ++ set -x
09:41:15 [2019-12-13T09:41:15.837Z] ++ 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
09:41:15 [2019-12-13T09:41:15.837Z] INFO: Testing against a local daemon
09:41:15 [2019-12-13T09:41:15.837Z] === RUN   TestDockerNetworkMacvlanPersistance
09:41:17 [2019-12-13T09:41:17.150Z] --- PASS: TestDockerNetworkMacvlanPersistance (1.47s)
09:41:17 [2019-12-13T09:41:17.150Z] === RUN   TestDockerNetworkMacvlan
09:41:17 [2019-12-13T09:41:17.949Z] === RUN   TestDockerNetworkMacvlan/Subinterface
09:41:19 [2019-12-13T09:41:19.373Z] === RUN   TestDockerNetworkMacvlan/OverlapParent
09:41:20 [2019-12-13T09:41:20.211Z] === RUN   TestDockerNetworkMacvlan/NilParent
09:41:22 [2019-12-13T09:41:22.679Z] === RUN   TestDockerNetworkMacvlan/InternalMode
09:41:26 [2019-12-13T09:41:26.920Z] === RUN   TestDockerNetworkMacvlan/MultiSubnet
09:41:32 [2019-12-13T09:41:32.160Z] === RUN   TestDockerNetworkMacvlan/Addressing
09:41:32 [2019-12-13T09:41:32.961Z] --- PASS: TestDockerNetworkMacvlan (15.64s)
09:41:32 [2019-12-13T09:41:32.961Z]     --- PASS: TestDockerNetworkMacvlan/Subinterface (0.09s)
09:41:32 [2019-12-13T09:41:32.961Z]     --- PASS: TestDockerNetworkMacvlan/OverlapParent (0.11s)
09:41:32 [2019-12-13T09:41:32.961Z]     --- PASS: TestDockerNetworkMacvlan/NilParent (1.34s)
09:41:32 [2019-12-13T09:41:32.961Z]     --- PASS: TestDockerNetworkMacvlan/InternalMode (2.36s)
09:41:32 [2019-12-13T09:41:32.961Z]     --- PASS: TestDockerNetworkMacvlan/MultiSubnet (3.21s)
09:41:32 [2019-12-13T09:41:32.961Z]     --- PASS: TestDockerNetworkMacvlan/Addressing (0.91s)
09:41:32 [2019-12-13T09:41:32.961Z] PASS
09:41:32 [2019-12-13T09:41:32.961Z] 
09:41:32 [2019-12-13T09:41:32.961Z] DONE 8 tests in 17.197s
09:41:32 [2019-12-13T09:41:32.961Z] Running /go/src/github.com/docker/docker/integration/plugin (s390x.integration.plugin) flags=-test.v -test.timeout=120m 
09:41:32 [2019-12-13T09:41:32.961Z] ++ 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
09:41:32 [2019-12-13T09:41:32.961Z] ++ set -e
09:41:32 [2019-12-13T09:41:32.961Z] ++ '[' -n 0 ']'
09:41:32 [2019-12-13T09:41:32.961Z] ++ set -x
09:41:32 [2019-12-13T09:41:32.961Z] ++ 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
09:41:32 [2019-12-13T09:41:32.961Z] testing: warning: no tests to run
09:41:32 [2019-12-13T09:41:32.961Z] PASS
09:41:32 [2019-12-13T09:41:32.961Z] 
09:41:32 [2019-12-13T09:41:32.961Z] DONE 0 tests in 0.021s
09:41:32 [2019-12-13T09:41:32.961Z] Running /go/src/github.com/docker/docker/integration/plugin/authz (s390x.integration.plugin.authz) flags=-test.v -test.timeout=120m 
09:41:32 [2019-12-13T09:41:32.961Z] ++ 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
09:41:32 [2019-12-13T09:41:32.961Z] ++ set -e
09:41:32 [2019-12-13T09:41:32.961Z] ++ '[' -n 0 ']'
09:41:32 [2019-12-13T09:41:32.961Z] ++ set -x
09:41:32 [2019-12-13T09:41:32.961Z] ++ 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
09:41:32 [2019-12-13T09:41:32.961Z] INFO: Testing against a local daemon
09:41:32 [2019-12-13T09:41:32.961Z] === RUN   TestAuthZPluginAllowRequest
09:41:34 [2019-12-13T09:41:34.794Z] --- PASS: TestAuthZPluginAllowRequest (1.74s)
09:41:34 [2019-12-13T09:41:34.794Z] === RUN   TestAuthZPluginTLS
09:41:35 [2019-12-13T09:41:35.169Z] --- PASS: TestAuthZPluginTLS (0.55s)
09:41:35 [2019-12-13T09:41:35.169Z] === RUN   TestAuthZPluginDenyRequest
09:41:35 [2019-12-13T09:41:35.993Z] --- PASS: TestAuthZPluginDenyRequest (0.55s)
09:41:35 [2019-12-13T09:41:35.993Z] === RUN   TestAuthZPluginAPIDenyResponse
09:41:36 [2019-12-13T09:41:36.393Z] --- PASS: TestAuthZPluginAPIDenyResponse (0.55s)
09:41:36 [2019-12-13T09:41:36.393Z] === RUN   TestAuthZPluginDenyResponse
09:41:37 [2019-12-13T09:41:37.220Z] --- PASS: TestAuthZPluginDenyResponse (0.57s)
09:41:37 [2019-12-13T09:41:37.220Z] === RUN   TestAuthZPluginAllowEventStream
09:41:39 [2019-12-13T09:41:39.046Z] --- PASS: TestAuthZPluginAllowEventStream (1.78s)
09:41:39 [2019-12-13T09:41:39.046Z] === RUN   TestAuthZPluginErrorResponse
09:41:39 [2019-12-13T09:41:39.415Z] --- PASS: TestAuthZPluginErrorResponse (0.55s)
09:41:39 [2019-12-13T09:41:39.415Z] === RUN   TestAuthZPluginErrorRequest
09:41:39 [2019-12-13T09:41:39.794Z] --- PASS: TestAuthZPluginErrorRequest (0.54s)
09:41:39 [2019-12-13T09:41:39.794Z] === RUN   TestAuthZPluginEnsureNoDuplicatePluginRegistration
09:41:40 [2019-12-13T09:41:40.757Z] --- PASS: TestAuthZPluginEnsureNoDuplicatePluginRegistration (0.54s)
09:41:40 [2019-12-13T09:41:40.757Z] === RUN   TestAuthZPluginEnsureLoadImportWorking
09:41:42 [2019-12-13T09:41:42.631Z] --- PASS: TestAuthZPluginEnsureLoadImportWorking (2.12s)
09:41:42 [2019-12-13T09:41:42.631Z] === RUN   TestAuthzPluginEnsureContainerCopyToFrom
09:41:45 [2019-12-13T09:41:45.104Z] --- PASS: TestAuthzPluginEnsureContainerCopyToFrom (2.33s)
09:41:45 [2019-12-13T09:41:45.104Z] === RUN   TestAuthZPluginHeader
09:41:46 [2019-12-13T09:41:46.013Z] --- PASS: TestAuthZPluginHeader (0.93s)
09:41:46 [2019-12-13T09:41:46.013Z] === RUN   TestAuthZPluginV2AllowNonVolumeRequest
09:41:46 [2019-12-13T09:41:46.013Z] --- SKIP: TestAuthZPluginV2AllowNonVolumeRequest (0.00s)
09:41:46 [2019-12-13T09:41:46.013Z]     authz_plugin_v2_test.go:43: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
09:41:46 [2019-12-13T09:41:46.013Z] === RUN   TestAuthZPluginV2Disable
09:41:46 [2019-12-13T09:41:46.013Z] --- SKIP: TestAuthZPluginV2Disable (0.00s)
09:41:46 [2019-12-13T09:41:46.013Z]     authz_plugin_v2_test.go:65: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
09:41:46 [2019-12-13T09:41:46.013Z] === RUN   TestAuthZPluginV2RejectVolumeRequests
09:41:46 [2019-12-13T09:41:46.013Z] --- SKIP: TestAuthZPluginV2RejectVolumeRequests (0.00s)
09:41:46 [2019-12-13T09:41:46.013Z]     authz_plugin_v2_test.go:91: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
09:41:46 [2019-12-13T09:41:46.013Z] === RUN   TestAuthZPluginV2BadManifestFailsDaemonStart
09:41:46 [2019-12-13T09:41:46.013Z] --- SKIP: TestAuthZPluginV2BadManifestFailsDaemonStart (0.00s)
09:41:46 [2019-12-13T09:41:46.013Z]     authz_plugin_v2_test.go:126: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
09:41:46 [2019-12-13T09:41:46.013Z] === RUN   TestAuthZPluginV2NonexistentFailsDaemonStart
09:42:05 [2019-12-13T09:42:05.765Z] --- PASS: TestAuthZPluginV2NonexistentFailsDaemonStart (16.91s)
09:42:05 [2019-12-13T09:42:05.765Z] PASS
09:42:05 [2019-12-13T09:42:05.765Z] 
09:42:05 [2019-12-13T09:42:05.765Z] === Skipped
09:42:05 [2019-12-13T09:42:05.765Z] === SKIP: s390x.integration.plugin.authz TestAuthZPluginV2AllowNonVolumeRequest (0.00s)
09:42:05 [2019-12-13T09:42:05.765Z]     authz_plugin_v2_test.go:43: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
09:42:05 [2019-12-13T09:42:05.765Z] 
09:42:05 [2019-12-13T09:42:05.765Z] === SKIP: s390x.integration.plugin.authz TestAuthZPluginV2Disable (0.00s)
09:42:05 [2019-12-13T09:42:05.765Z]     authz_plugin_v2_test.go:65: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
09:42:05 [2019-12-13T09:42:05.765Z] 
09:42:05 [2019-12-13T09:42:05.765Z] === SKIP: s390x.integration.plugin.authz TestAuthZPluginV2RejectVolumeRequests (0.00s)
09:42:05 [2019-12-13T09:42:05.765Z]     authz_plugin_v2_test.go:91: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
09:42:05 [2019-12-13T09:42:05.765Z] 
09:42:05 [2019-12-13T09:42:05.765Z] === SKIP: s390x.integration.plugin.authz TestAuthZPluginV2BadManifestFailsDaemonStart (0.00s)
09:42:05 [2019-12-13T09:42:05.765Z]     authz_plugin_v2_test.go:126: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
09:42:05 [2019-12-13T09:42:05.765Z] 
09:42:05 [2019-12-13T09:42:05.765Z] 
09:42:05 [2019-12-13T09:42:05.765Z] DONE 17 tests, 4 skipped in 29.781s
09:42:05 [2019-12-13T09:42:05.765Z] Running /go/src/github.com/docker/docker/integration/plugin/common (s390x.integration.plugin.common) flags=-test.v -test.timeout=120m 
09:42:05 [2019-12-13T09:42:05.765Z] ++ 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
09:42:05 [2019-12-13T09:42:05.765Z] ++ set -e
09:42:05 [2019-12-13T09:42:05.765Z] ++ '[' -n 0 ']'
09:42:05 [2019-12-13T09:42:05.765Z] ++ set -x
09:42:05 [2019-12-13T09:42:05.765Z] ++ 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
09:42:05 [2019-12-13T09:42:05.765Z] INFO: Testing against a local daemon
09:42:05 [2019-12-13T09:42:05.765Z] === RUN   TestPluginInvalidJSON
09:42:05 [2019-12-13T09:42:05.765Z] === RUN   TestPluginInvalidJSON//plugins/foobar/set
09:42:05 [2019-12-13T09:42:05.765Z] === PAUSE TestPluginInvalidJSON//plugins/foobar/set
09:42:05 [2019-12-13T09:42:05.765Z] === CONT  TestPluginInvalidJSON//plugins/foobar/set
09:42:05 [2019-12-13T09:42:05.765Z] --- PASS: TestPluginInvalidJSON (0.02s)
09:42:05 [2019-12-13T09:42:05.765Z]     --- PASS: TestPluginInvalidJSON//plugins/foobar/set (0.00s)
09:42:05 [2019-12-13T09:42:05.765Z] PASS
09:42:05 [2019-12-13T09:42:05.765Z] 
09:42:05 [2019-12-13T09:42:05.765Z] DONE 2 tests in 0.112s
09:42:05 [2019-12-13T09:42:05.765Z] Running /go/src/github.com/docker/docker/integration/plugin/graphdriver (s390x.integration.plugin.graphdriver) flags=-test.v -test.timeout=120m 
09:42:05 [2019-12-13T09:42:05.765Z] ++ 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
09:42:05 [2019-12-13T09:42:05.765Z] ++ set -e
09:42:05 [2019-12-13T09:42:05.765Z] ++ '[' -n 0 ']'
09:42:05 [2019-12-13T09:42:05.765Z] ++ set -x
09:42:05 [2019-12-13T09:42:05.765Z] ++ 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
09:42:05 [2019-12-13T09:42:05.765Z] INFO: Testing against a local daemon
09:42:05 [2019-12-13T09:42:05.765Z] === RUN   TestExternalGraphDriver
09:42:05 [2019-12-13T09:42:05.765Z] === RUN   TestExternalGraphDriver/json
09:42:05 [2019-12-13T09:42:05.765Z] === RUN   TestExternalGraphDriver/spec
09:42:07 [2019-12-13T09:42:07.604Z] === RUN   TestExternalGraphDriver/pull
09:42:09 [2019-12-13T09:42:09.542Z] --- PASS: TestExternalGraphDriver (6.66s)
09:42:09 [2019-12-13T09:42:09.542Z]     --- PASS: TestExternalGraphDriver/json (2.12s)
09:42:09 [2019-12-13T09:42:09.542Z]     --- PASS: TestExternalGraphDriver/spec (2.16s)
09:42:09 [2019-12-13T09:42:09.542Z]     --- PASS: TestExternalGraphDriver/pull (2.23s)
09:42:09 [2019-12-13T09:42:09.542Z] === RUN   TestGraphdriverPluginV2
09:42:09 [2019-12-13T09:42:09.542Z] --- SKIP: TestGraphdriverPluginV2 (0.08s)
09:42:09 [2019-12-13T09:42:09.542Z]     external_test.go:410: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
09:42:09 [2019-12-13T09:42:09.542Z] PASS
09:42:09 [2019-12-13T09:42:09.915Z] 
09:42:09 [2019-12-13T09:42:09.915Z] === Skipped
09:42:09 [2019-12-13T09:42:09.915Z] === SKIP: s390x.integration.plugin.graphdriver TestGraphdriverPluginV2 (0.08s)
09:42:09 [2019-12-13T09:42:09.915Z]     external_test.go:410: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
09:42:09 [2019-12-13T09:42:09.915Z] 
09:42:09 [2019-12-13T09:42:09.915Z] 
09:42:09 [2019-12-13T09:42:09.915Z] DONE 5 tests, 1 skipped in 6.847s
09:42:09 [2019-12-13T09:42:09.915Z] Running /go/src/github.com/docker/docker/integration/plugin/logging (s390x.integration.plugin.logging) flags=-test.v -test.timeout=120m 
09:42:09 [2019-12-13T09:42:09.915Z] ++ 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
09:42:09 [2019-12-13T09:42:09.915Z] ++ set -e
09:42:09 [2019-12-13T09:42:09.915Z] ++ '[' -n 0 ']'
09:42:09 [2019-12-13T09:42:09.915Z] ++ set -x
09:42:09 [2019-12-13T09:42:09.915Z] ++ 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
09:42:09 [2019-12-13T09:42:09.915Z] INFO: Testing against a local daemon
09:42:09 [2019-12-13T09:42:09.915Z] === RUN   TestContinueAfterPluginCrash
09:42:09 [2019-12-13T09:42:09.915Z] === PAUSE TestContinueAfterPluginCrash
09:42:09 [2019-12-13T09:42:09.915Z] === RUN   TestDaemonStartWithLogOpt
09:42:09 [2019-12-13T09:42:09.915Z] === PAUSE TestDaemonStartWithLogOpt
09:42:09 [2019-12-13T09:42:09.915Z] === CONT  TestContinueAfterPluginCrash
09:42:09 [2019-12-13T09:42:09.915Z] === CONT  TestDaemonStartWithLogOpt
09:42:21 [2019-12-13T09:42:21.511Z] --- PASS: TestDaemonStartWithLogOpt (11.54s)
09:42:26 [2019-12-13T09:42:26.632Z] --- PASS: TestContinueAfterPluginCrash (16.43s)
09:42:26 [2019-12-13T09:42:26.632Z] PASS
09:42:26 [2019-12-13T09:42:26.632Z] 
09:42:26 [2019-12-13T09:42:26.632Z] DONE 2 tests in 16.533s
09:42:26 [2019-12-13T09:42:26.632Z] Running /go/src/github.com/docker/docker/integration/plugin/volumes (s390x.integration.plugin.volumes) flags=-test.v -test.timeout=120m 
09:42:26 [2019-12-13T09:42:26.632Z] ++ 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
09:42:26 [2019-12-13T09:42:26.632Z] ++ set -e
09:42:26 [2019-12-13T09:42:26.632Z] ++ '[' -n 0 ']'
09:42:26 [2019-12-13T09:42:26.632Z] ++ set -x
09:42:26 [2019-12-13T09:42:26.632Z] ++ 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
09:42:26 [2019-12-13T09:42:26.632Z] INFO: Testing against a local daemon
09:42:26 [2019-12-13T09:42:26.632Z] === RUN   TestPluginWithDevMounts
09:42:26 [2019-12-13T09:42:26.632Z] === PAUSE TestPluginWithDevMounts
09:42:26 [2019-12-13T09:42:26.632Z] === CONT  TestPluginWithDevMounts
09:42:28 [2019-12-13T09:42:28.463Z] --- PASS: TestPluginWithDevMounts (2.01s)
09:42:28 [2019-12-13T09:42:28.463Z] PASS
09:42:28 [2019-12-13T09:42:28.463Z] 
09:42:28 [2019-12-13T09:42:28.463Z] DONE 1 tests in 2.111s
09:42:28 [2019-12-13T09:42:28.463Z] Running /go/src/github.com/docker/docker/integration/secret (s390x.integration.secret) flags=-test.v -test.timeout=120m 
09:42:28 [2019-12-13T09:42:28.464Z] ++ 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
09:42:28 [2019-12-13T09:42:28.464Z] ++ set -e
09:42:28 [2019-12-13T09:42:28.464Z] ++ '[' -n 0 ']'
09:42:28 [2019-12-13T09:42:28.464Z] ++ set -x
09:42:28 [2019-12-13T09:42:28.464Z] ++ 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
09:42:28 [2019-12-13T09:42:28.464Z] INFO: Testing against a local daemon
09:42:28 [2019-12-13T09:42:28.464Z] === RUN   TestSecretInspect
09:42:31 [2019-12-13T09:42:31.879Z] --- PASS: TestSecretInspect (2.88s)
09:42:31 [2019-12-13T09:42:31.879Z] === RUN   TestSecretList
09:42:34 [2019-12-13T09:42:34.369Z] --- PASS: TestSecretList (3.07s)
09:42:34 [2019-12-13T09:42:34.369Z] === RUN   TestSecretsCreateAndDelete
09:42:37 [2019-12-13T09:42:37.749Z] --- PASS: TestSecretsCreateAndDelete (3.28s)
09:42:37 [2019-12-13T09:42:37.749Z] === RUN   TestSecretsUpdate
09:42:41 [2019-12-13T09:42:41.061Z] --- PASS: TestSecretsUpdate (3.06s)
09:42:41 [2019-12-13T09:42:41.061Z] === RUN   TestTemplatedSecret
09:42:44 [2019-12-13T09:42:44.361Z] --- PASS: TestTemplatedSecret (3.20s)
09:42:44 [2019-12-13T09:42:44.361Z] === RUN   TestSecretCreateResolve
09:42:46 [2019-12-13T09:42:46.867Z] --- PASS: TestSecretCreateResolve (3.04s)
09:42:46 [2019-12-13T09:42:46.867Z] PASS
09:42:47 [2019-12-13T09:42:47.247Z] 
09:42:47 [2019-12-13T09:42:47.247Z] DONE 6 tests in 18.623s
09:42:47 [2019-12-13T09:42:47.247Z] Running /go/src/github.com/docker/docker/integration/service (s390x.integration.service) flags=-test.v -test.timeout=120m 
09:42:47 [2019-12-13T09:42:47.247Z] ++ 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
09:42:47 [2019-12-13T09:42:47.247Z] ++ set -e
09:42:47 [2019-12-13T09:42:47.247Z] ++ '[' -n 0 ']'
09:42:47 [2019-12-13T09:42:47.247Z] ++ set -x
09:42:47 [2019-12-13T09:42:47.247Z] ++ 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
09:42:47 [2019-12-13T09:42:47.247Z] INFO: Testing against a local daemon
09:42:47 [2019-12-13T09:42:47.247Z] === RUN   TestServiceCreateInit
09:42:47 [2019-12-13T09:42:47.247Z] === RUN   TestServiceCreateInit/daemonInitDisabled
09:42:52 [2019-12-13T09:42:52.510Z] === RUN   TestServiceCreateInit/daemonInitEnabled
09:42:57 [2019-12-13T09:42:57.786Z] --- PASS: TestServiceCreateInit (10.53s)
09:42:57 [2019-12-13T09:42:57.786Z]     --- PASS: TestServiceCreateInit/daemonInitDisabled (5.26s)
09:42:57 [2019-12-13T09:42:57.786Z]     --- PASS: TestServiceCreateInit/daemonInitEnabled (5.26s)
09:42:57 [2019-12-13T09:42:57.786Z] === RUN   TestCreateServiceMultipleTimes
09:43:17 [2019-12-13T09:43:17.580Z] --- PASS: TestCreateServiceMultipleTimes (19.18s)
09:43:17 [2019-12-13T09:43:17.580Z] === RUN   TestCreateServiceConflict
09:43:20 [2019-12-13T09:43:20.153Z] --- PASS: TestCreateServiceConflict (3.42s)
09:43:20 [2019-12-13T09:43:20.153Z] === RUN   TestCreateServiceMaxReplicas
09:43:25 [2019-12-13T09:43:25.267Z] --- PASS: TestCreateServiceMaxReplicas (4.32s)
09:43:25 [2019-12-13T09:43:25.267Z] === RUN   TestCreateWithDuplicateNetworkNames
09:43:41 [2019-12-13T09:43:41.741Z] --- PASS: TestCreateWithDuplicateNetworkNames (14.58s)
09:43:41 [2019-12-13T09:43:41.741Z] === RUN   TestCreateServiceSecretFileMode
09:43:43 [2019-12-13T09:43:43.033Z] --- PASS: TestCreateServiceSecretFileMode (3.65s)
09:43:43 [2019-12-13T09:43:43.033Z] === RUN   TestCreateServiceConfigFileMode
09:43:46 [2019-12-13T09:43:46.309Z] --- PASS: TestCreateServiceConfigFileMode (3.50s)
09:43:46 [2019-12-13T09:43:46.309Z] === RUN   TestCreateServiceSysctls
09:43:51 [2019-12-13T09:43:51.434Z] --- PASS: TestCreateServiceSysctls (4.28s)
09:43:51 [2019-12-13T09:43:51.434Z] === RUN   TestCreateServiceCapabilities
09:43:53 [2019-12-13T09:43:53.982Z] --- PASS: TestCreateServiceCapabilities (3.15s)
09:43:53 [2019-12-13T09:43:53.982Z] === RUN   TestInspect
09:43:57 [2019-12-13T09:43:57.376Z] --- PASS: TestInspect (3.50s)
09:43:57 [2019-12-13T09:43:57.376Z] === RUN   TestServiceListWithStatuses
09:43:57 [2019-12-13T09:43:57.376Z] --- SKIP: TestServiceListWithStatuses (0.01s)
09:43:57 [2019-12-13T09:43:57.376Z]     list_test.go:34: versions.LessThan(testEnv.DaemonInfo.ServerVersion, "1.41")
09:43:57 [2019-12-13T09:43:57.376Z] === RUN   TestDockerNetworkConnectAlias
09:44:05 [2019-12-13T09:44:05.068Z] --- PASS: TestDockerNetworkConnectAlias (7.07s)
09:44:05 [2019-12-13T09:44:05.068Z] === RUN   TestDockerNetworkReConnect
09:44:09 [2019-12-13T09:44:09.417Z] --- PASS: TestDockerNetworkReConnect (4.94s)
09:44:09 [2019-12-13T09:44:09.417Z] === RUN   TestServicePlugin
09:44:09 [2019-12-13T09:44:09.417Z] --- SKIP: TestServicePlugin (0.00s)
09:44:09 [2019-12-13T09:44:09.417Z]     plugin_test.go:28: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
09:44:09 [2019-12-13T09:44:09.417Z] === RUN   TestServiceUpdateLabel
09:44:12 [2019-12-13T09:44:12.822Z] --- PASS: TestServiceUpdateLabel (3.20s)
09:44:12 [2019-12-13T09:44:12.822Z] === RUN   TestServiceUpdateSecrets
09:44:29 [2019-12-13T09:44:29.225Z] --- PASS: TestServiceUpdateSecrets (15.60s)
09:44:29 [2019-12-13T09:44:29.225Z] === RUN   TestServiceUpdateConfigs
09:44:45 [2019-12-13T09:44:45.755Z] --- PASS: TestServiceUpdateConfigs (15.86s)
09:44:45 [2019-12-13T09:44:45.755Z] === RUN   TestServiceUpdateNetwork
09:44:59 [2019-12-13T09:44:59.584Z] --- PASS: TestServiceUpdateNetwork (14.62s)
09:44:59 [2019-12-13T09:44:59.584Z] PASS
09:44:59 [2019-12-13T09:44:59.584Z] 
09:44:59 [2019-12-13T09:44:59.584Z] === Skipped
09:44:59 [2019-12-13T09:44:59.584Z] === SKIP: s390x.integration.service TestServiceListWithStatuses (0.01s)
09:44:59 [2019-12-13T09:44:59.584Z]     list_test.go:34: versions.LessThan(testEnv.DaemonInfo.ServerVersion, "1.41")
09:44:59 [2019-12-13T09:44:59.584Z] 
09:44:59 [2019-12-13T09:44:59.584Z] === SKIP: s390x.integration.service TestServicePlugin (0.00s)
09:44:59 [2019-12-13T09:44:59.584Z]     plugin_test.go:28: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
09:44:59 [2019-12-13T09:44:59.585Z] 
09:44:59 [2019-12-13T09:44:59.585Z] 
09:44:59 [2019-12-13T09:44:59.585Z] DONE 20 tests, 2 skipped in 131.557s
09:44:59 [2019-12-13T09:44:59.585Z] Running /go/src/github.com/docker/docker/integration/session (s390x.integration.session) flags=-test.v -test.timeout=120m 
09:44:59 [2019-12-13T09:44:59.585Z] ++ 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
09:44:59 [2019-12-13T09:44:59.585Z] ++ set -e
09:44:59 [2019-12-13T09:44:59.585Z] ++ '[' -n 0 ']'
09:44:59 [2019-12-13T09:44:59.585Z] ++ set -x
09:44:59 [2019-12-13T09:44:59.585Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=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
09:44:59 [2019-12-13T09:44:59.585Z] INFO: Testing against a local daemon
09:44:59 [2019-12-13T09:44:59.585Z] === RUN   TestSessionCreate
09:44:59 [2019-12-13T09:44:59.585Z] --- PASS: TestSessionCreate (0.03s)
09:44:59 [2019-12-13T09:44:59.585Z] === RUN   TestSessionCreateWithBadUpgrade
09:44:59 [2019-12-13T09:44:59.585Z] --- PASS: TestSessionCreateWithBadUpgrade (0.03s)
09:44:59 [2019-12-13T09:44:59.585Z] PASS
09:44:59 [2019-12-13T09:44:59.585Z] 
09:44:59 [2019-12-13T09:44:59.585Z] DONE 2 tests in 0.146s
09:44:59 [2019-12-13T09:44:59.585Z] Running /go/src/github.com/docker/docker/integration/system (s390x.integration.system) flags=-test.v -test.timeout=120m 
09:44:59 [2019-12-13T09:44:59.585Z] ++ 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
09:44:59 [2019-12-13T09:44:59.585Z] ++ set -e
09:44:59 [2019-12-13T09:44:59.585Z] ++ '[' -n 0 ']'
09:44:59 [2019-12-13T09:44:59.585Z] ++ set -x
09:44:59 [2019-12-13T09:44:59.585Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=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
09:44:59 [2019-12-13T09:44:59.585Z] INFO: Testing against a local daemon
09:44:59 [2019-12-13T09:44:59.585Z] === RUN   TestCgroupDriverSystemdMemoryLimit
09:44:59 [2019-12-13T09:44:59.585Z] --- SKIP: TestCgroupDriverSystemdMemoryLimit (0.00s)
09:44:59 [2019-12-13T09:44:59.585Z]     cgroupdriver_systemd_test.go:32: !hasSystemd()
09:44:59 [2019-12-13T09:44:59.585Z] === RUN   TestEventsExecDie
09:44:59 [2019-12-13T09:44:59.968Z] --- PASS: TestEventsExecDie (1.02s)
09:44:59 [2019-12-13T09:44:59.968Z] === RUN   TestEventsBackwardsCompatible
09:44:59 [2019-12-13T09:44:59.968Z] --- PASS: TestEventsBackwardsCompatible (0.13s)
09:44:59 [2019-12-13T09:44:59.968Z] === RUN   TestInfoBinaryCommits
09:44:59 [2019-12-13T09:44:59.968Z] --- PASS: TestInfoBinaryCommits (0.02s)
09:44:59 [2019-12-13T09:44:59.968Z] === RUN   TestInfoAPIVersioned
09:44:59 [2019-12-13T09:44:59.968Z] --- PASS: TestInfoAPIVersioned (0.01s)
09:44:59 [2019-12-13T09:44:59.968Z] === RUN   TestInfoDiscoveryBackend
09:45:00 [2019-12-13T09:45:00.742Z] --- PASS: TestInfoDiscoveryBackend (0.53s)
09:45:00 [2019-12-13T09:45:00.742Z] === RUN   TestInfoDiscoveryInvalidAdvertise
09:45:01 [2019-12-13T09:45:01.533Z] --- PASS: TestInfoDiscoveryInvalidAdvertise (1.00s)
09:45:01 [2019-12-13T09:45:01.533Z] === RUN   TestInfoDiscoveryAdvertiseInterfaceName
09:45:02 [2019-12-13T09:45:02.333Z] --- PASS: TestInfoDiscoveryAdvertiseInterfaceName (0.54s)
09:45:02 [2019-12-13T09:45:02.333Z] === RUN   TestInfoAPI
09:45:02 [2019-12-13T09:45:02.333Z] --- PASS: TestInfoAPI (0.02s)
09:45:02 [2019-12-13T09:45:02.333Z] === RUN   TestInfoAPIWarnings
09:45:02 [2019-12-13T09:45:02.707Z] --- PASS: TestInfoAPIWarnings (0.53s)
09:45:02 [2019-12-13T09:45:02.707Z] === RUN   TestInfoDebug
09:45:03 [2019-12-13T09:45:03.081Z] --- PASS: TestInfoDebug (0.54s)
09:45:03 [2019-12-13T09:45:03.082Z] === RUN   TestInfoInsecureRegistries
09:45:03 [2019-12-13T09:45:03.964Z] --- PASS: TestInfoInsecureRegistries (0.54s)
09:45:03 [2019-12-13T09:45:03.964Z] === RUN   TestInfoRegistryMirrors
09:45:04 [2019-12-13T09:45:04.351Z] --- PASS: TestInfoRegistryMirrors (0.53s)
09:45:04 [2019-12-13T09:45:04.351Z] === RUN   TestLoginFailsWithBadCredentials
09:45:04 [2019-12-13T09:45:04.740Z] --- PASS: TestLoginFailsWithBadCredentials (0.37s)
09:45:04 [2019-12-13T09:45:04.740Z] === RUN   TestPingCacheHeaders
09:45:04 [2019-12-13T09:45:04.740Z] --- PASS: TestPingCacheHeaders (0.03s)
09:45:04 [2019-12-13T09:45:04.740Z] === RUN   TestPingGet
09:45:04 [2019-12-13T09:45:04.740Z] --- PASS: TestPingGet (0.01s)
09:45:04 [2019-12-13T09:45:04.740Z] === RUN   TestPingHead
09:45:04 [2019-12-13T09:45:04.740Z] --- PASS: TestPingHead (0.02s)
09:45:04 [2019-12-13T09:45:04.740Z] === RUN   TestVersion
09:45:04 [2019-12-13T09:45:04.740Z] --- PASS: TestVersion (0.02s)
09:45:04 [2019-12-13T09:45:04.740Z] PASS
09:45:04 [2019-12-13T09:45:04.740Z] 
09:45:04 [2019-12-13T09:45:04.740Z] === Skipped
09:45:04 [2019-12-13T09:45:04.740Z] === SKIP: s390x.integration.system TestCgroupDriverSystemdMemoryLimit (0.00s)
09:45:04 [2019-12-13T09:45:04.740Z]     cgroupdriver_systemd_test.go:32: !hasSystemd()
09:45:04 [2019-12-13T09:45:04.740Z] 
09:45:04 [2019-12-13T09:45:04.740Z] 
09:45:04 [2019-12-13T09:45:04.740Z] DONE 18 tests, 1 skipped in 5.944s
09:45:04 [2019-12-13T09:45:04.740Z] Running /go/src/github.com/docker/docker/integration/volume (s390x.integration.volume) flags=-test.v -test.timeout=120m 
09:45:04 [2019-12-13T09:45:04.740Z] ++ 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
09:45:04 [2019-12-13T09:45:04.740Z] ++ set -e
09:45:04 [2019-12-13T09:45:04.740Z] ++ '[' -n 0 ']'
09:45:04 [2019-12-13T09:45:04.740Z] ++ set -x
09:45:04 [2019-12-13T09:45:04.740Z] ++ 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
09:45:04 [2019-12-13T09:45:04.740Z] INFO: Testing against a local daemon
09:45:04 [2019-12-13T09:45:04.740Z] === RUN   TestVolumesCreateAndList
09:45:04 [2019-12-13T09:45:04.740Z] --- PASS: TestVolumesCreateAndList (0.05s)
09:45:04 [2019-12-13T09:45:04.740Z] === RUN   TestVolumesRemove
09:45:05 [2019-12-13T09:45:05.116Z] --- PASS: TestVolumesRemove (0.11s)
09:45:05 [2019-12-13T09:45:05.116Z] === RUN   TestVolumesInspect
09:45:05 [2019-12-13T09:45:05.116Z] --- PASS: TestVolumesInspect (0.02s)
09:45:05 [2019-12-13T09:45:05.116Z] === RUN   TestVolumesInvalidJSON
09:45:05 [2019-12-13T09:45:05.116Z] === RUN   TestVolumesInvalidJSON//volumes/create
09:45:05 [2019-12-13T09:45:05.116Z] === PAUSE TestVolumesInvalidJSON//volumes/create
09:45:05 [2019-12-13T09:45:05.116Z] === CONT  TestVolumesInvalidJSON//volumes/create
09:45:05 [2019-12-13T09:45:05.116Z] --- PASS: TestVolumesInvalidJSON (0.01s)
09:45:05 [2019-12-13T09:45:05.116Z]     --- PASS: TestVolumesInvalidJSON//volumes/create (0.00s)
09:45:05 [2019-12-13T09:45:05.116Z] PASS
09:45:05 [2019-12-13T09:45:05.116Z] 
09:45:05 [2019-12-13T09:45:05.116Z] DONE 5 tests in 0.279s
09:45:05 [2019-12-13T09:45:05.116Z] ---> Making bundle: .integration-daemon-stop (in bundles/test-integration)
09:45:05 [2019-12-13T09:45:05.116Z] ++++ cat bundles/test-integration/docker.pid
09:45:05 [2019-12-13T09:45:05.116Z] +++ kill 11525
09:45:06 [2019-12-13T09:45:06.931Z] +++ /etc/init.d/apparmor stop
09:45:06 [2019-12-13T09:45:06.931Z] Clearing AppArmor profiles cache:.
09:45:06 [2019-12-13T09:45:06.931Z] All profile caches have been cleared, but no profiles have been unloaded.
09:45:06 [2019-12-13T09:45:06.931Z] Unloading profiles will leave already running processes permanently
09:45:06 [2019-12-13T09:45:06.931Z] unconfined, which can lead to unexpected situations.
09:45:06 [2019-12-13T09:45:06.931Z] 
09:45:06 [2019-12-13T09:45:06.931Z] To set a process to complain mode, use the command line tool
09:45:06 [2019-12-13T09:45:06.931Z] 'aa-complain'. To really tear down all profiles, run the init script
09:45:06 [2019-12-13T09:45:06.931Z] with the 'teardown' option."
09:45:06 [2019-12-13T09:45:06.931Z]