Console Output
22:19:03 [2019-11-06T22:19:03.973Z] + docker run --rm -t --privileged -v /home/jenkins/workspace/moby_PR-40177/bundles:/go/src/github.com/docker/docker/bundles --name docker-pr8 -e DOCKER_EXPERIMENTAL -e DOCKER_GITCOMMIT=4891080458d785f7c69c2d2c6055e2e448da3421 -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:4891080458d785f7c69c2d2c6055e2e448da3421 hack/make.sh dynbinary test-integration
22:19:04 [2019-11-06T22:19:04.355Z]
22:19:04 [2019-11-06T22:19:04.355Z] Removing bundles/
22:19:04 [2019-11-06T22:19:04.355Z]
22:19:04 [2019-11-06T22:19:04.355Z] ---> Making bundle: dynbinary (in bundles/dynbinary)
22:19:04 [2019-11-06T22:19:04.355Z] Building: bundles/dynbinary-daemon/dockerd-dev
22:19:04 [2019-11-06T22:19:04.355Z] GOOS="" GOARCH="" GOARM=""
22:20:03 [2019-11-06T22:20:03.261Z] Created binary: bundles/dynbinary-daemon/dockerd-dev
22:20:03 [2019-11-06T22:20:03.656Z]
22:20:03 [2019-11-06T22:20:03.656Z] ---> Making bundle: test-integration (in bundles/test-integration)
22:20:04 [2019-11-06T22:20:04.069Z] PKG_CONFIG=pkg-config
22:20:04 [2019-11-06T22:20:04.069Z] GOLANG_VERSION=1.13.3
22:20:04 [2019-11-06T22:20:04.069Z] HOSTNAME=204d6b82e045
22:20:04 [2019-11-06T22:20:04.069Z] DOCKER_EXPERIMENTAL=1
22:20:04 [2019-11-06T22:20:04.069Z] container=docker
22:20:04 [2019-11-06T22:20:04.069Z] TEST_SKIP_INTEGRATION_CLI=1
22:20:04 [2019-11-06T22:20:04.069Z] GO111MODULE=off
22:20:04 [2019-11-06T22:20:04.069Z] GOPATH=/go
22:20:04 [2019-11-06T22:20:04.069Z] PWD=/go/src/github.com/docker/docker
22:20:04 [2019-11-06T22:20:04.069Z] HOME=/root
22:20:04 [2019-11-06T22:20:04.069Z] VALIDATE_REPO=https://github.com/moby/moby.git
22:20:04 [2019-11-06T22:20:04.069Z] SCRIPTDIR=/go/src/github.com/docker/docker/hack
22:20:04 [2019-11-06T22:20:04.069Z] MAKEDIR=/go/src/github.com/docker/docker/hack/make
22:20:04 [2019-11-06T22:20:04.069Z] DOCKER_GITCOMMIT=4891080458d785f7c69c2d2c6055e2e448da3421
22:20:04 [2019-11-06T22:20:04.069Z] DOCKER_BUILDTAGS=apparmor seccomp selinux journald
22:20:04 [2019-11-06T22:20:04.069Z] DOCKER_GRAPHDRIVER=overlay2
22:20:04 [2019-11-06T22:20:04.069Z] TERM=xterm
22:20:04 [2019-11-06T22:20:04.069Z] VALIDATE_BRANCH=master
22:20:04 [2019-11-06T22:20:04.069Z] DEST=bundles/test-integration
22:20:04 [2019-11-06T22:20:04.069Z] SHLVL=1
22:20:04 [2019-11-06T22:20:04.069Z] TIMEOUT=120m
22:20:04 [2019-11-06T22:20:04.069Z] PATH=/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
22:20:04 [2019-11-06T22:20:04.069Z] DOCKER_PKG=github.com/docker/docker
22:20:04 [2019-11-06T22:20:04.069Z] TESTDEBUG=0
22:20:04 [2019-11-06T22:20:04.069Z] _=/usr/bin/env
22:20:04 [2019-11-06T22:20:04.069Z] Building test suite binary /go/src/github.com/docker/docker/integration/build/test.main
22:20:38 [2019-11-06T22:20:38.588Z] Building test suite binary /go/src/github.com/docker/docker/integration/config/test.main
22:20:38 [2019-11-06T22:20:38.588Z] Building test suite binary /go/src/github.com/docker/docker/integration/container/test.main
22:20:38 [2019-11-06T22:20:38.588Z] Building test suite binary /go/src/github.com/docker/docker/integration/image/test.main
22:20:58 [2019-11-06T22:20:58.602Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/test.main
22:20:58 [2019-11-06T22:20:58.602Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/ipvlan/test.main
22:20:59 [2019-11-06T22:20:59.916Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/macvlan/test.main
22:21:00 [2019-11-06T22:21:00.716Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/test.main
22:21:01 [2019-11-06T22:21:01.093Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/authz/test.main
22:21:02 [2019-11-06T22:21:02.937Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/common/test.main
22:21:04 [2019-11-06T22:21:04.263Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/graphdriver/test.main
22:21:05 [2019-11-06T22:21:05.554Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/logging/test.main
22:21:08 [2019-11-06T22:21:08.074Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/volumes/test.main
22:21:09 [2019-11-06T22:21:09.937Z] Building test suite binary /go/src/github.com/docker/docker/integration/secret/test.main
22:21:10 [2019-11-06T22:21:10.757Z] Building test suite binary /go/src/github.com/docker/docker/integration/service/test.main
22:21:12 [2019-11-06T22:21:12.613Z] Building test suite binary /go/src/github.com/docker/docker/integration/session/test.main
22:21:13 [2019-11-06T22:21:13.889Z] Building test suite binary /go/src/github.com/docker/docker/integration/system/test.main
22:21:15 [2019-11-06T22:21:15.038Z] Building test suite binary /go/src/github.com/docker/docker/integration/volume/test.main
22:21:17 [2019-11-06T22:21:17.051Z] ---> Making bundle: .integration-daemon-start (in bundles/test-integration)
22:21:17 [2019-11-06T22:21:17.051Z] Using test binary docker
22:21:17 [2019-11-06T22:21:17.051Z] # DOCKER_EXPERIMENTAL is set: starting daemon with experimental features enabled!
22:21:17 [2019-11-06T22:21:17.051Z] +++ /etc/init.d/apparmor start
22:21:17 [2019-11-06T22:21:17.051Z] /etc/init.d/apparmor: 130: /etc/init.d/apparmor: systemd-detect-virt: not found
22:21:17 [2019-11-06T22:21:17.051Z] Starting AppArmor profiles:Warning from stdin (line 1): /sbin/apparmor_parser: cannot use or update cache, disable, or force-complain via stdin
22:21:17 [2019-11-06T22:21:17.051Z] Warning failed to create cache: (null)
22:21:17 [2019-11-06T22:21:17.051Z] .
22:21:17 [2019-11-06T22:21:17.051Z] INFO: Waiting for daemon to start...
22:21:17 [2019-11-06T22:21:17.051Z] Starting dockerd
22:21:17 [2019-11-06T22:21:17.051Z] +++ 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
22:21:19 [2019-11-06T22:21:19.487Z] .
22:21:19 [2019-11-06T22:21:19.487Z] ---> Making bundle: .integration-daemon-setup (in bundles/test-integration)
22:21:19 [2019-11-06T22:21:19.487Z] ---> Making bundle: .ensure-emptyfs (in bundles/test-integration)
22:21:19 [2019-11-06T22:21:19.487Z] Error: No such image: emptyfs
22:21:19 [2019-11-06T22:21:19.487Z] ++++ tar -cC bundles/test-integration/emptyfs .
22:21:19 [2019-11-06T22:21:19.487Z] ++++ docker load
22:21:19 [2019-11-06T22:21:19.487Z] Running integration-test (iteration 1)
22:21:19 [2019-11-06T22:21:19.487Z] Running /go/src/github.com/docker/docker/integration/build (s390x.integration.build) flags=-test.v -test.timeout=120m
22:21:19 [2019-11-06T22:21:19.487Z] ++ 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
22:21:19 [2019-11-06T22:21:19.487Z] ++ set -e
22:21:19 [2019-11-06T22:21:19.487Z] ++ '[' -n 0 ']'
22:21:19 [2019-11-06T22:21:19.487Z] ++ set -x
22:21:19 [2019-11-06T22:21:19.487Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=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
22:21:28 [2019-11-06T22:21:28.926Z] Loaded image: buildpack-deps:jessie
22:21:29 [2019-11-06T22:21:29.311Z] Loaded image: busybox:latest
22:21:29 [2019-11-06T22:21:29.311Z] Loaded image: busybox:glibc
22:21:29 [2019-11-06T22:21:29.311Z] Loaded image: debian:jessie
22:21:29 [2019-11-06T22:21:29.675Z] Loaded image: hello-world:latest
22:21:29 [2019-11-06T22:21:29.675Z] INFO: Testing against a local daemon
22:21:29 [2019-11-06T22:21:29.675Z] === RUN TestCgroupNamespacesBuild
22:21:31 [2019-11-06T22:21:31.485Z] --- PASS: TestCgroupNamespacesBuild (1.65s)
22:21:31 [2019-11-06T22:21:31.485Z] === RUN TestCgroupNamespacesBuildDaemonHostMode
22:21:32 [2019-11-06T22:21:32.769Z] --- PASS: TestCgroupNamespacesBuildDaemonHostMode (1.70s)
22:21:32 [2019-11-06T22:21:32.769Z] === RUN TestBuildWithSession
22:21:32 [2019-11-06T22:21:32.769Z] --- SKIP: TestBuildWithSession (0.00s)
22:21:32 [2019-11-06T22:21:32.769Z] build_session_test.go:25: TODO: BuildKit
22:21:32 [2019-11-06T22:21:32.769Z] === RUN TestBuildSquashParent
22:21:40 [2019-11-06T22:21:40.443Z] --- PASS: TestBuildSquashParent (6.79s)
22:21:40 [2019-11-06T22:21:40.443Z] === RUN TestBuildWithRemoveAndForceRemove
22:21:40 [2019-11-06T22:21:40.443Z] === RUN TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
22:21:40 [2019-11-06T22:21:40.443Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
22:21:40 [2019-11-06T22:21:40.443Z] === RUN TestBuildWithRemoveAndForceRemove/successful_build_with_remove
22:21:40 [2019-11-06T22:21:40.443Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_remove
22:21:40 [2019-11-06T22:21:40.443Z] === RUN TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
22:21:40 [2019-11-06T22:21:40.443Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
22:21:40 [2019-11-06T22:21:40.443Z] === RUN TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
22:21:40 [2019-11-06T22:21:40.443Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
22:21:40 [2019-11-06T22:21:40.443Z] === RUN TestBuildWithRemoveAndForceRemove/failed_build_with_remove
22:21:40 [2019-11-06T22:21:40.443Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_remove
22:21:40 [2019-11-06T22:21:40.443Z] === RUN TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
22:21:40 [2019-11-06T22:21:40.443Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
22:21:40 [2019-11-06T22:21:40.443Z] === CONT TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
22:21:40 [2019-11-06T22:21:40.443Z] === CONT TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
22:21:42 [2019-11-06T22:21:42.293Z] === CONT TestBuildWithRemoveAndForceRemove/failed_build_with_remove
22:21:42 [2019-11-06T22:21:42.293Z] === CONT TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
22:21:44 [2019-11-06T22:21:44.780Z] === CONT TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
22:21:44 [2019-11-06T22:21:44.780Z] === CONT TestBuildWithRemoveAndForceRemove/successful_build_with_remove
22:21:47 [2019-11-06T22:21:47.476Z] --- PASS: TestBuildWithRemoveAndForceRemove (0.03s)
22:21:47 [2019-11-06T22:21:47.477Z] --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove (2.45s)
22:21:47 [2019-11-06T22:21:47.477Z] --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal (2.68s)
22:21:47 [2019-11-06T22:21:47.477Z] --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_remove (2.62s)
22:21:47 [2019-11-06T22:21:47.477Z] --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal (2.47s)
22:21:47 [2019-11-06T22:21:47.477Z] --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove (2.43s)
22:21:47 [2019-11-06T22:21:47.477Z] --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_remove (2.35s)
22:21:47 [2019-11-06T22:21:47.477Z] === RUN TestBuildMultiStageCopy
22:21:47 [2019-11-06T22:21:47.477Z] === RUN TestBuildMultiStageCopy/copy_to_root
22:21:50 [2019-11-06T22:21:50.050Z] === RUN TestBuildMultiStageCopy/copy_to_newdir
22:21:50 [2019-11-06T22:21:50.416Z] === RUN TestBuildMultiStageCopy/copy_to_newdir_nested
22:21:51 [2019-11-06T22:21:51.387Z] === RUN TestBuildMultiStageCopy/copy_to_existingdir
22:21:51 [2019-11-06T22:21:51.780Z] === RUN TestBuildMultiStageCopy/copy_to_newsubdir
22:21:52 [2019-11-06T22:21:52.152Z] --- PASS: TestBuildMultiStageCopy (4.98s)
22:21:52 [2019-11-06T22:21:52.152Z] --- PASS: TestBuildMultiStageCopy/copy_to_root (2.71s)
22:21:52 [2019-11-06T22:21:52.152Z] --- PASS: TestBuildMultiStageCopy/copy_to_newdir (0.48s)
22:21:52 [2019-11-06T22:21:52.152Z] --- PASS: TestBuildMultiStageCopy/copy_to_newdir_nested (0.51s)
22:21:52 [2019-11-06T22:21:52.152Z] --- PASS: TestBuildMultiStageCopy/copy_to_existingdir (0.62s)
22:21:52 [2019-11-06T22:21:52.152Z] --- PASS: TestBuildMultiStageCopy/copy_to_newsubdir (0.66s)
22:21:52 [2019-11-06T22:21:52.152Z] === RUN TestBuildMultiStageParentConfig
22:21:53 [2019-11-06T22:21:53.987Z] --- PASS: TestBuildMultiStageParentConfig (1.44s)
22:21:53 [2019-11-06T22:21:53.987Z] === RUN TestBuildLabelWithTargets
22:21:55 [2019-11-06T22:21:55.809Z] --- PASS: TestBuildLabelWithTargets (2.08s)
22:21:55 [2019-11-06T22:21:55.809Z] === RUN TestBuildWithEmptyLayers
22:21:56 [2019-11-06T22:21:56.612Z] --- PASS: TestBuildWithEmptyLayers (0.86s)
22:21:56 [2019-11-06T22:21:56.612Z] === RUN TestBuildMultiStageOnBuild
22:21:59 [2019-11-06T22:21:59.814Z] --- PASS: TestBuildMultiStageOnBuild (3.25s)
22:21:59 [2019-11-06T22:21:59.814Z] === RUN TestBuildUncleanTarFilenames
22:22:01 [2019-11-06T22:22:01.112Z] --- PASS: TestBuildUncleanTarFilenames (1.25s)
22:22:01 [2019-11-06T22:22:01.112Z] === RUN TestBuildMultiStageLayerLeak
22:22:04 [2019-11-06T22:22:04.451Z] --- PASS: TestBuildMultiStageLayerLeak (2.94s)
22:22:04 [2019-11-06T22:22:04.451Z] === RUN TestBuildWithHugeFile
22:22:38 [2019-11-06T22:22:38.743Z] --- PASS: TestBuildWithHugeFile (30.33s)
22:22:38 [2019-11-06T22:22:38.743Z] === RUN TestBuildWithEmptyDockerfile
22:22:38 [2019-11-06T22:22:38.743Z] === RUN TestBuildWithEmptyDockerfile/empty-dockerfile
22:22:38 [2019-11-06T22:22:38.743Z] === PAUSE TestBuildWithEmptyDockerfile/empty-dockerfile
22:22:38 [2019-11-06T22:22:38.743Z] === RUN TestBuildWithEmptyDockerfile/empty-lines-dockerfile
22:22:38 [2019-11-06T22:22:38.743Z] === PAUSE TestBuildWithEmptyDockerfile/empty-lines-dockerfile
22:22:38 [2019-11-06T22:22:38.743Z] === RUN TestBuildWithEmptyDockerfile/comment-only-dockerfile
22:22:38 [2019-11-06T22:22:38.743Z] === PAUSE TestBuildWithEmptyDockerfile/comment-only-dockerfile
22:22:38 [2019-11-06T22:22:38.743Z] === CONT TestBuildWithEmptyDockerfile/empty-dockerfile
22:22:38 [2019-11-06T22:22:38.743Z] === CONT TestBuildWithEmptyDockerfile/comment-only-dockerfile
22:22:38 [2019-11-06T22:22:38.743Z] === CONT TestBuildWithEmptyDockerfile/empty-lines-dockerfile
22:22:38 [2019-11-06T22:22:38.743Z] --- PASS: TestBuildWithEmptyDockerfile (0.10s)
22:22:38 [2019-11-06T22:22:38.743Z] --- PASS: TestBuildWithEmptyDockerfile/empty-dockerfile (0.14s)
22:22:38 [2019-11-06T22:22:38.743Z] --- PASS: TestBuildWithEmptyDockerfile/comment-only-dockerfile (0.14s)
22:22:38 [2019-11-06T22:22:38.743Z] --- PASS: TestBuildWithEmptyDockerfile/empty-lines-dockerfile (0.10s)
22:22:38 [2019-11-06T22:22:38.743Z] === RUN TestBuildPreserveOwnership
22:22:38 [2019-11-06T22:22:38.743Z] === RUN TestBuildPreserveOwnership/copy_from
22:22:38 [2019-11-06T22:22:38.743Z] === RUN TestBuildPreserveOwnership/copy_from_chowned
22:22:41 [2019-11-06T22:22:41.693Z] --- PASS: TestBuildPreserveOwnership (6.51s)
22:22:41 [2019-11-06T22:22:41.693Z] --- PASS: TestBuildPreserveOwnership/copy_from (4.02s)
22:22:41 [2019-11-06T22:22:41.693Z] --- PASS: TestBuildPreserveOwnership/copy_from_chowned (2.48s)
22:22:41 [2019-11-06T22:22:41.693Z] === RUN TestBuildPlatformInvalid
22:22:41 [2019-11-06T22:22:41.693Z] --- PASS: TestBuildPlatformInvalid (0.14s)
22:22:41 [2019-11-06T22:22:41.693Z] PASS
22:22:41 [2019-11-06T22:22:41.693Z]
22:22:41 [2019-11-06T22:22:41.693Z] === Skipped
22:22:41 [2019-11-06T22:22:41.693Z] === SKIP: s390x.integration.build TestBuildWithSession (0.00s)
22:22:41 [2019-11-06T22:22:41.693Z] build_session_test.go:25: TODO: BuildKit
22:22:41 [2019-11-06T22:22:41.693Z]
22:22:41 [2019-11-06T22:22:41.693Z]
22:22:41 [2019-11-06T22:22:41.693Z] DONE 32 tests, 1 skipped in 82.036s
22:22:41 [2019-11-06T22:22:41.693Z] Running /go/src/github.com/docker/docker/integration/config (s390x.integration.config) flags=-test.v -test.timeout=120m
22:22:41 [2019-11-06T22:22:41.693Z] ++ 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
22:22:41 [2019-11-06T22:22:41.693Z] ++ set -e
22:22:41 [2019-11-06T22:22:41.693Z] ++ '[' -n 0 ']'
22:22:41 [2019-11-06T22:22:41.693Z] ++ set -x
22:22:41 [2019-11-06T22:22:41.693Z] ++ 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
22:22:41 [2019-11-06T22:22:41.693Z] INFO: Testing against a local daemon
22:22:41 [2019-11-06T22:22:41.693Z] === RUN TestConfigList
22:22:44 [2019-11-06T22:22:44.924Z] --- PASS: TestConfigList (2.97s)
22:22:44 [2019-11-06T22:22:44.924Z] === RUN TestConfigsCreateAndDelete
22:22:47 [2019-11-06T22:22:47.431Z] --- PASS: TestConfigsCreateAndDelete (2.99s)
22:22:47 [2019-11-06T22:22:47.431Z] === RUN TestConfigsUpdate
22:22:50 [2019-11-06T22:22:50.645Z] --- PASS: TestConfigsUpdate (2.78s)
22:22:50 [2019-11-06T22:22:50.645Z] === RUN TestTemplatedConfig
22:22:53 [2019-11-06T22:22:53.859Z] --- PASS: TestTemplatedConfig (3.12s)
22:22:53 [2019-11-06T22:22:53.859Z] === RUN TestConfigInspect
22:22:56 [2019-11-06T22:22:56.322Z] --- PASS: TestConfigInspect (2.89s)
22:22:56 [2019-11-06T22:22:56.322Z] === RUN TestConfigCreateWithLabels
22:22:59 [2019-11-06T22:22:59.524Z] --- PASS: TestConfigCreateWithLabels (2.96s)
22:22:59 [2019-11-06T22:22:59.524Z] === RUN TestConfigCreateResolve
22:23:01 [2019-11-06T22:23:01.998Z] --- PASS: TestConfigCreateResolve (2.51s)
22:23:01 [2019-11-06T22:23:01.998Z] === RUN TestConfigDaemonLibtrustID
22:23:02 [2019-11-06T22:23:02.370Z] --- PASS: TestConfigDaemonLibtrustID (0.55s)
22:23:02 [2019-11-06T22:23:02.370Z] PASS
22:23:02 [2019-11-06T22:23:02.370Z]
22:23:02 [2019-11-06T22:23:02.370Z] DONE 8 tests in 20.863s
22:23:02 [2019-11-06T22:23:02.370Z] Running /go/src/github.com/docker/docker/integration/container (s390x.integration.container) flags=-test.v -test.timeout=120m
22:23:02 [2019-11-06T22:23:02.370Z] ++ 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
22:23:02 [2019-11-06T22:23:02.370Z] ++ set -e
22:23:02 [2019-11-06T22:23:02.370Z] ++ '[' -n 0 ']'
22:23:02 [2019-11-06T22:23:02.370Z] ++ set -x
22:23:02 [2019-11-06T22:23:02.370Z] ++ 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
22:23:02 [2019-11-06T22:23:02.370Z] INFO: Testing against a local daemon
22:23:02 [2019-11-06T22:23:02.370Z] === RUN TestCheckpoint
22:23:02 [2019-11-06T22:23:02.370Z] --- SKIP: TestCheckpoint (0.00s)
22:23:02 [2019-11-06T22:23:02.370Z] checkpoint_test.go:33: TestCheckpoint is broken; see https://github.com/moby/moby/issues/38963
22:23:02 [2019-11-06T22:23:02.370Z] === RUN TestContainerInvalidJSON
22:23:02 [2019-11-06T22:23:02.370Z] === RUN TestContainerInvalidJSON//containers/foobar/copy
22:23:02 [2019-11-06T22:23:02.370Z] === PAUSE TestContainerInvalidJSON//containers/foobar/copy
22:23:02 [2019-11-06T22:23:02.370Z] === RUN TestContainerInvalidJSON//containers/foobar/exec
22:23:02 [2019-11-06T22:23:02.370Z] === PAUSE TestContainerInvalidJSON//containers/foobar/exec
22:23:02 [2019-11-06T22:23:02.370Z] === RUN TestContainerInvalidJSON//exec/foobar/start
22:23:02 [2019-11-06T22:23:02.370Z] === PAUSE TestContainerInvalidJSON//exec/foobar/start
22:23:02 [2019-11-06T22:23:02.370Z] === CONT TestContainerInvalidJSON//containers/foobar/copy
22:23:02 [2019-11-06T22:23:02.370Z] === CONT TestContainerInvalidJSON//exec/foobar/start
22:23:02 [2019-11-06T22:23:02.370Z] === CONT TestContainerInvalidJSON//containers/foobar/exec
22:23:02 [2019-11-06T22:23:02.370Z] --- PASS: TestContainerInvalidJSON (0.01s)
22:23:02 [2019-11-06T22:23:02.370Z] --- PASS: TestContainerInvalidJSON//exec/foobar/start (0.00s)
22:23:02 [2019-11-06T22:23:02.370Z] --- PASS: TestContainerInvalidJSON//containers/foobar/copy (0.00s)
22:23:02 [2019-11-06T22:23:02.370Z] --- PASS: TestContainerInvalidJSON//containers/foobar/exec (0.00s)
22:23:02 [2019-11-06T22:23:02.370Z] === RUN TestCopyFromContainerPathDoesNotExist
22:23:02 [2019-11-06T22:23:02.742Z] --- PASS: TestCopyFromContainerPathDoesNotExist (0.12s)
22:23:02 [2019-11-06T22:23:02.742Z] === RUN TestCopyFromContainerPathIsNotDir
22:23:02 [2019-11-06T22:23:02.742Z] --- PASS: TestCopyFromContainerPathIsNotDir (0.11s)
22:23:02 [2019-11-06T22:23:02.742Z] === RUN TestCopyToContainerPathDoesNotExist
22:23:02 [2019-11-06T22:23:02.742Z] --- PASS: TestCopyToContainerPathDoesNotExist (0.12s)
22:23:02 [2019-11-06T22:23:02.742Z] === RUN TestCopyToContainerPathIsNotDir
22:23:02 [2019-11-06T22:23:02.742Z] --- PASS: TestCopyToContainerPathIsNotDir (0.09s)
22:23:02 [2019-11-06T22:23:02.742Z] === RUN TestCopyFromContainer
22:23:05 [2019-11-06T22:23:05.297Z] === RUN TestCopyFromContainer//
22:23:05 [2019-11-06T22:23:05.297Z] === RUN TestCopyFromContainer//bar/root
22:23:05 [2019-11-06T22:23:05.297Z] === RUN TestCopyFromContainer//bar/root/
22:23:05 [2019-11-06T22:23:05.297Z] === RUN TestCopyFromContainer/bar/quux
22:23:05 [2019-11-06T22:23:05.297Z] === RUN TestCopyFromContainer/bar/quux/
22:23:05 [2019-11-06T22:23:05.297Z] === RUN TestCopyFromContainer/bar/quux/baz
22:23:05 [2019-11-06T22:23:05.297Z] === RUN TestCopyFromContainer/bar/filesymlink
22:23:05 [2019-11-06T22:23:05.297Z] === RUN TestCopyFromContainer/bar/dirsymlink
22:23:05 [2019-11-06T22:23:05.690Z] === RUN TestCopyFromContainer/bar/dirsymlink/
22:23:05 [2019-11-06T22:23:05.690Z] === RUN TestCopyFromContainer/bar/notarget
22:23:05 [2019-11-06T22:23:05.690Z] --- PASS: TestCopyFromContainer (2.82s)
22:23:05 [2019-11-06T22:23:05.690Z] --- PASS: TestCopyFromContainer// (0.06s)
22:23:05 [2019-11-06T22:23:05.690Z] --- PASS: TestCopyFromContainer//bar/root (0.09s)
22:23:05 [2019-11-06T22:23:05.690Z] --- PASS: TestCopyFromContainer//bar/root/ (0.06s)
22:23:05 [2019-11-06T22:23:05.690Z] --- PASS: TestCopyFromContainer/bar/quux (0.12s)
22:23:05 [2019-11-06T22:23:05.690Z] --- PASS: TestCopyFromContainer/bar/quux/ (0.08s)
22:23:05 [2019-11-06T22:23:05.690Z] --- PASS: TestCopyFromContainer/bar/quux/baz (0.08s)
22:23:05 [2019-11-06T22:23:05.690Z] --- PASS: TestCopyFromContainer/bar/filesymlink (0.08s)
22:23:05 [2019-11-06T22:23:05.690Z] --- PASS: TestCopyFromContainer/bar/dirsymlink (0.11s)
22:23:05 [2019-11-06T22:23:05.690Z] --- PASS: TestCopyFromContainer/bar/dirsymlink/ (0.09s)
22:23:05 [2019-11-06T22:23:05.690Z] --- PASS: TestCopyFromContainer/bar/notarget (0.08s)
22:23:05 [2019-11-06T22:23:05.690Z] === RUN TestCreateFailsWhenIdentifierDoesNotExist
22:23:05 [2019-11-06T22:23:05.690Z] === RUN TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
22:23:05 [2019-11-06T22:23:05.690Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
22:23:05 [2019-11-06T22:23:05.690Z] === RUN TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
22:23:05 [2019-11-06T22:23:05.690Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
22:23:05 [2019-11-06T22:23:05.690Z] === RUN TestCreateFailsWhenIdentifierDoesNotExist/digest
22:23:05 [2019-11-06T22:23:05.690Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/digest
22:23:05 [2019-11-06T22:23:05.690Z] === CONT TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
22:23:05 [2019-11-06T22:23:05.690Z] === CONT TestCreateFailsWhenIdentifierDoesNotExist/digest
22:23:05 [2019-11-06T22:23:05.690Z] === CONT TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
22:23:05 [2019-11-06T22:23:05.690Z] --- PASS: TestCreateFailsWhenIdentifierDoesNotExist (0.01s)
22:23:05 [2019-11-06T22:23:05.690Z] --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/digest (0.00s)
22:23:05 [2019-11-06T22:23:05.690Z] --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag (0.00s)
22:23:05 [2019-11-06T22:23:05.690Z] --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag (0.01s)
22:23:05 [2019-11-06T22:23:05.690Z] === RUN TestCreateLinkToNonExistingContainer
22:23:05 [2019-11-06T22:23:05.690Z] --- PASS: TestCreateLinkToNonExistingContainer (0.05s)
22:23:05 [2019-11-06T22:23:05.690Z] === RUN TestCreateWithInvalidEnv
22:23:05 [2019-11-06T22:23:05.690Z] === RUN TestCreateWithInvalidEnv/0
22:23:05 [2019-11-06T22:23:05.691Z] === PAUSE TestCreateWithInvalidEnv/0
22:23:05 [2019-11-06T22:23:05.691Z] === RUN TestCreateWithInvalidEnv/1
22:23:05 [2019-11-06T22:23:05.691Z] === PAUSE TestCreateWithInvalidEnv/1
22:23:05 [2019-11-06T22:23:05.691Z] === RUN TestCreateWithInvalidEnv/2
22:23:05 [2019-11-06T22:23:05.691Z] === PAUSE TestCreateWithInvalidEnv/2
22:23:05 [2019-11-06T22:23:05.691Z] === CONT TestCreateWithInvalidEnv/0
22:23:05 [2019-11-06T22:23:05.691Z] === CONT TestCreateWithInvalidEnv/2
22:23:05 [2019-11-06T22:23:05.691Z] === CONT TestCreateWithInvalidEnv/1
22:23:05 [2019-11-06T22:23:05.691Z] --- PASS: TestCreateWithInvalidEnv (0.01s)
22:23:05 [2019-11-06T22:23:05.691Z] --- PASS: TestCreateWithInvalidEnv/2 (0.00s)
22:23:05 [2019-11-06T22:23:05.691Z] --- PASS: TestCreateWithInvalidEnv/1 (0.00s)
22:23:05 [2019-11-06T22:23:05.691Z] --- PASS: TestCreateWithInvalidEnv/0 (0.00s)
22:23:05 [2019-11-06T22:23:05.691Z] === RUN TestCreateTmpfsMountsTarget
22:23:05 [2019-11-06T22:23:05.691Z] --- PASS: TestCreateTmpfsMountsTarget (0.03s)
22:23:05 [2019-11-06T22:23:05.691Z] === RUN TestCreateWithCustomMaskedPaths
22:23:08 [2019-11-06T22:23:08.277Z] --- PASS: TestCreateWithCustomMaskedPaths (2.52s)
22:23:08 [2019-11-06T22:23:08.277Z] === RUN TestCreateWithCapabilities
22:23:08 [2019-11-06T22:23:08.277Z] === RUN TestCreateWithCapabilities/no_capabilities
22:23:08 [2019-11-06T22:23:08.277Z] === PAUSE TestCreateWithCapabilities/no_capabilities
22:23:08 [2019-11-06T22:23:08.277Z] === RUN TestCreateWithCapabilities/empty_capabilities
22:23:08 [2019-11-06T22:23:08.277Z] === PAUSE TestCreateWithCapabilities/empty_capabilities
22:23:08 [2019-11-06T22:23:08.277Z] === RUN TestCreateWithCapabilities/valid_capabilities
22:23:08 [2019-11-06T22:23:08.277Z] === PAUSE TestCreateWithCapabilities/valid_capabilities
22:23:08 [2019-11-06T22:23:08.277Z] === RUN TestCreateWithCapabilities/invalid_capabilities
22:23:08 [2019-11-06T22:23:08.277Z] === PAUSE TestCreateWithCapabilities/invalid_capabilities
22:23:08 [2019-11-06T22:23:08.277Z] === RUN TestCreateWithCapabilities/duplicate_capabilities
22:23:08 [2019-11-06T22:23:08.277Z] === PAUSE TestCreateWithCapabilities/duplicate_capabilities
22:23:08 [2019-11-06T22:23:08.277Z] === RUN TestCreateWithCapabilities/capabilities_API_v1.39
22:23:08 [2019-11-06T22:23:08.277Z] === PAUSE TestCreateWithCapabilities/capabilities_API_v1.39
22:23:08 [2019-11-06T22:23:08.277Z] === RUN TestCreateWithCapabilities/empty_capadd
22:23:08 [2019-11-06T22:23:08.277Z] === PAUSE TestCreateWithCapabilities/empty_capadd
22:23:08 [2019-11-06T22:23:08.277Z] === RUN TestCreateWithCapabilities/empty_capdrop
22:23:08 [2019-11-06T22:23:08.277Z] === PAUSE TestCreateWithCapabilities/empty_capdrop
22:23:08 [2019-11-06T22:23:08.277Z] === RUN TestCreateWithCapabilities/capadd_capdrop
22:23:08 [2019-11-06T22:23:08.277Z] === PAUSE TestCreateWithCapabilities/capadd_capdrop
22:23:08 [2019-11-06T22:23:08.277Z] === RUN TestCreateWithCapabilities/conflict_with_capadd
22:23:08 [2019-11-06T22:23:08.277Z] === PAUSE TestCreateWithCapabilities/conflict_with_capadd
22:23:08 [2019-11-06T22:23:08.277Z] === RUN TestCreateWithCapabilities/conflict_with_capdrop
22:23:08 [2019-11-06T22:23:08.277Z] === PAUSE TestCreateWithCapabilities/conflict_with_capdrop
22:23:08 [2019-11-06T22:23:08.277Z] === CONT TestCreateWithCapabilities/no_capabilities
22:23:08 [2019-11-06T22:23:08.277Z] === CONT TestCreateWithCapabilities/conflict_with_capdrop
22:23:08 [2019-11-06T22:23:08.277Z] === CONT TestCreateWithCapabilities/conflict_with_capadd
22:23:08 [2019-11-06T22:23:08.277Z] === CONT TestCreateWithCapabilities/capadd_capdrop
22:23:08 [2019-11-06T22:23:08.277Z] === CONT TestCreateWithCapabilities/empty_capdrop
22:23:08 [2019-11-06T22:23:08.277Z] === CONT TestCreateWithCapabilities/empty_capadd
22:23:08 [2019-11-06T22:23:08.760Z] === CONT TestCreateWithCapabilities/capabilities_API_v1.39
22:23:08 [2019-11-06T22:23:08.760Z] === CONT TestCreateWithCapabilities/duplicate_capabilities
22:23:08 [2019-11-06T22:23:08.760Z] === CONT TestCreateWithCapabilities/invalid_capabilities
22:23:08 [2019-11-06T22:23:08.760Z] === CONT TestCreateWithCapabilities/valid_capabilities
22:23:08 [2019-11-06T22:23:08.760Z] === CONT TestCreateWithCapabilities/empty_capabilities
22:23:08 [2019-11-06T22:23:08.760Z] --- PASS: TestCreateWithCapabilities (0.02s)
22:23:08 [2019-11-06T22:23:08.760Z] --- PASS: TestCreateWithCapabilities/conflict_with_capdrop (0.00s)
22:23:08 [2019-11-06T22:23:08.760Z] --- PASS: TestCreateWithCapabilities/conflict_with_capadd (0.00s)
22:23:08 [2019-11-06T22:23:08.760Z] --- PASS: TestCreateWithCapabilities/no_capabilities (0.06s)
22:23:08 [2019-11-06T22:23:08.760Z] --- PASS: TestCreateWithCapabilities/capadd_capdrop (0.06s)
22:23:08 [2019-11-06T22:23:08.760Z] --- PASS: TestCreateWithCapabilities/empty_capdrop (0.08s)
22:23:08 [2019-11-06T22:23:08.760Z] --- PASS: TestCreateWithCapabilities/empty_capadd (0.08s)
22:23:08 [2019-11-06T22:23:08.760Z] --- PASS: TestCreateWithCapabilities/capabilities_API_v1.39 (0.06s)
22:23:08 [2019-11-06T22:23:08.760Z] --- PASS: TestCreateWithCapabilities/invalid_capabilities (0.00s)
22:23:08 [2019-11-06T22:23:08.760Z] --- PASS: TestCreateWithCapabilities/duplicate_capabilities (0.06s)
22:23:08 [2019-11-06T22:23:08.760Z] --- PASS: TestCreateWithCapabilities/valid_capabilities (0.06s)
22:23:08 [2019-11-06T22:23:08.760Z] --- PASS: TestCreateWithCapabilities/empty_capabilities (0.06s)
22:23:08 [2019-11-06T22:23:08.760Z] === RUN TestCreateWithCustomReadonlyPaths
22:23:11 [2019-11-06T22:23:11.365Z] --- PASS: TestCreateWithCustomReadonlyPaths (2.76s)
22:23:11 [2019-11-06T22:23:11.365Z] === RUN TestCreateWithInvalidHealthcheckParams
22:23:11 [2019-11-06T22:23:11.365Z] === RUN TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
22:23:11 [2019-11-06T22:23:11.365Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
22:23:11 [2019-11-06T22:23:11.365Z] === RUN TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
22:23:11 [2019-11-06T22:23:11.365Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
22:23:11 [2019-11-06T22:23:11.365Z] === RUN TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
22:23:11 [2019-11-06T22:23:11.365Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
22:23:11 [2019-11-06T22:23:11.365Z] === RUN TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
22:23:11 [2019-11-06T22:23:11.365Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
22:23:11 [2019-11-06T22:23:11.365Z] === RUN TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
22:23:11 [2019-11-06T22:23:11.365Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
22:23:11 [2019-11-06T22:23:11.365Z] === CONT TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
22:23:11 [2019-11-06T22:23:11.365Z] === CONT TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
22:23:11 [2019-11-06T22:23:11.365Z] === CONT TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
22:23:11 [2019-11-06T22:23:11.365Z] === CONT TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
22:23:11 [2019-11-06T22:23:11.365Z] === CONT TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
22:23:11 [2019-11-06T22:23:11.365Z] --- PASS: TestCreateWithInvalidHealthcheckParams (0.01s)
22:23:11 [2019-11-06T22:23:11.365Z] --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms (0.01s)
22:23:11 [2019-11-06T22:23:11.365Z] --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s (0.01s)
22:23:11 [2019-11-06T22:23:11.365Z] --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0 (0.01s)
22:23:11 [2019-11-06T22:23:11.365Z] --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms (0.02s)
22:23:11 [2019-11-06T22:23:11.365Z] --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms (0.02s)
22:23:11 [2019-11-06T22:23:11.365Z] === RUN TestContainerStartOnDaemonRestart
22:23:11 [2019-11-06T22:23:11.365Z] === PAUSE TestContainerStartOnDaemonRestart
22:23:11 [2019-11-06T22:23:11.365Z] === RUN TestDaemonRestartIpcMode
22:23:11 [2019-11-06T22:23:11.365Z] === PAUSE TestDaemonRestartIpcMode
22:23:11 [2019-11-06T22:23:11.365Z] === RUN TestDiff
22:23:12 [2019-11-06T22:23:12.189Z] --- PASS: TestDiff (0.79s)
22:23:12 [2019-11-06T22:23:12.189Z] === RUN TestExecWithCloseStdin
22:23:13 [2019-11-06T22:23:13.469Z] --- PASS: TestExecWithCloseStdin (1.08s)
22:23:13 [2019-11-06T22:23:13.469Z] === RUN TestExec
22:23:14 [2019-11-06T22:23:14.743Z] --- PASS: TestExec (1.16s)
22:23:14 [2019-11-06T22:23:14.743Z] === RUN TestExecUser
22:23:15 [2019-11-06T22:23:15.580Z] --- PASS: TestExecUser (1.09s)
22:23:15 [2019-11-06T22:23:15.580Z] === RUN TestExportContainerAndImportImage
22:23:16 [2019-11-06T22:23:16.927Z] --- PASS: TestExportContainerAndImportImage (1.38s)
22:23:16 [2019-11-06T22:23:16.927Z] === RUN TestExportContainerAfterDaemonRestart
22:23:18 [2019-11-06T22:23:18.795Z] --- PASS: TestExportContainerAfterDaemonRestart (1.59s)
22:23:18 [2019-11-06T22:23:18.795Z] === RUN TestHealthCheckWorkdir
22:23:20 [2019-11-06T22:23:20.081Z] --- PASS: TestHealthCheckWorkdir (1.29s)
22:23:20 [2019-11-06T22:23:20.081Z] === RUN TestHealthKillContainer
22:23:23 [2019-11-06T22:23:23.274Z] --- PASS: TestHealthKillContainer (3.09s)
22:23:23 [2019-11-06T22:23:23.274Z] === RUN TestInspectCpusetInConfigPre120
22:23:23 [2019-11-06T22:23:23.651Z] --- PASS: TestInspectCpusetInConfigPre120 (0.90s)
22:23:23 [2019-11-06T22:23:23.651Z] === RUN TestIpcModeNone
22:23:24 [2019-11-06T22:23:24.966Z] --- PASS: TestIpcModeNone (1.09s)
22:23:24 [2019-11-06T22:23:24.966Z] === RUN TestIpcModePrivate
22:23:26 [2019-11-06T22:23:26.246Z] --- PASS: TestIpcModePrivate (1.06s)
22:23:26 [2019-11-06T22:23:26.246Z] ipcmode_linux_test.go:90: [testIpcPrivateShareable] ipcmode: private, ipcdev: 0:64, shared: false, mustBeShared: false
22:23:26 [2019-11-06T22:23:26.246Z] === RUN TestIpcModeShareable
22:23:27 [2019-11-06T22:23:27.033Z] --- PASS: TestIpcModeShareable (1.19s)
22:23:27 [2019-11-06T22:23:27.033Z] ipcmode_linux_test.go:90: [testIpcPrivateShareable] ipcmode: shareable, ipcdev: 0:58, shared: true, mustBeShared: true
22:23:27 [2019-11-06T22:23:27.033Z] === RUN TestAPIIpcModeShareableAndContainer
22:23:30 [2019-11-06T22:23:30.232Z] --- PASS: TestAPIIpcModeShareableAndContainer (3.11s)
22:23:30 [2019-11-06T22:23:30.232Z] === RUN TestAPIIpcModeHost
22:23:31 [2019-11-06T22:23:31.040Z] --- PASS: TestAPIIpcModeHost (0.87s)
22:23:31 [2019-11-06T22:23:31.040Z] === RUN TestDaemonIpcModeShareable
22:23:32 [2019-11-06T22:23:32.901Z] --- PASS: TestDaemonIpcModeShareable (1.91s)
22:23:32 [2019-11-06T22:23:32.901Z] ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:66, shared: true, mustBeShared: true
22:23:32 [2019-11-06T22:23:32.901Z] === RUN TestDaemonIpcModePrivate
22:23:35 [2019-11-06T22:23:35.154Z] --- PASS: TestDaemonIpcModePrivate (1.96s)
22:23:35 [2019-11-06T22:23:35.154Z] ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:72, shared: false, mustBeShared: false
22:23:35 [2019-11-06T22:23:35.154Z] === RUN TestDaemonIpcModePrivateFromConfig
22:23:37 [2019-11-06T22:23:37.080Z] --- PASS: TestDaemonIpcModePrivateFromConfig (1.97s)
22:23:37 [2019-11-06T22:23:37.081Z] ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:72, shared: false, mustBeShared: false
22:23:37 [2019-11-06T22:23:37.081Z] === RUN TestDaemonIpcModeShareableFromConfig
22:23:38 [2019-11-06T22:23:38.931Z] --- PASS: TestDaemonIpcModeShareableFromConfig (1.92s)
22:23:38 [2019-11-06T22:23:38.931Z] ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:66, shared: true, mustBeShared: true
22:23:38 [2019-11-06T22:23:38.931Z] === RUN TestIpcModeOlderClient
22:23:38 [2019-11-06T22:23:38.931Z] === PAUSE TestIpcModeOlderClient
22:23:38 [2019-11-06T22:23:38.931Z] === RUN TestKillContainerInvalidSignal
22:23:39 [2019-11-06T22:23:39.721Z] --- PASS: TestKillContainerInvalidSignal (0.92s)
22:23:39 [2019-11-06T22:23:39.722Z] === RUN TestKillContainer
22:23:39 [2019-11-06T22:23:39.722Z] === RUN TestKillContainer/no_signal
22:23:40 [2019-11-06T22:23:40.513Z] === RUN TestKillContainer/non_killing_signal
22:23:41 [2019-11-06T22:23:41.335Z] === RUN TestKillContainer/killing_signal
22:23:42 [2019-11-06T22:23:42.679Z] --- PASS: TestKillContainer (2.74s)
22:23:42 [2019-11-06T22:23:42.679Z] --- PASS: TestKillContainer/no_signal (0.86s)
22:23:42 [2019-11-06T22:23:42.679Z] --- PASS: TestKillContainer/non_killing_signal (0.65s)
22:23:42 [2019-11-06T22:23:42.679Z] --- PASS: TestKillContainer/killing_signal (0.86s)
22:23:42 [2019-11-06T22:23:42.679Z] === RUN TestKillWithStopSignalAndRestartPolicies
22:23:42 [2019-11-06T22:23:42.679Z] === RUN TestKillWithStopSignalAndRestartPolicies/same-signal-disables-restart-policy
22:23:43 [2019-11-06T22:23:43.658Z] === RUN TestKillWithStopSignalAndRestartPolicies/different-signal-keep-restart-policy
22:23:44 [2019-11-06T22:23:44.451Z] --- PASS: TestKillWithStopSignalAndRestartPolicies (2.01s)
22:23:44 [2019-11-06T22:23:44.451Z] --- PASS: TestKillWithStopSignalAndRestartPolicies/same-signal-disables-restart-policy (0.97s)
22:23:44 [2019-11-06T22:23:44.451Z] --- PASS: TestKillWithStopSignalAndRestartPolicies/different-signal-keep-restart-policy (0.67s)
22:23:44 [2019-11-06T22:23:44.451Z] === RUN TestKillStoppedContainer
22:23:44 [2019-11-06T22:23:44.827Z] --- PASS: TestKillStoppedContainer (0.10s)
22:23:44 [2019-11-06T22:23:44.827Z] === RUN TestKillStoppedContainerAPIPre120
22:23:44 [2019-11-06T22:23:44.827Z] --- PASS: TestKillStoppedContainerAPIPre120 (0.10s)
22:23:44 [2019-11-06T22:23:44.827Z] === RUN TestKillDifferentUserContainer
22:23:45 [2019-11-06T22:23:45.645Z] --- PASS: TestKillDifferentUserContainer (0.89s)
22:23:45 [2019-11-06T22:23:45.645Z] === RUN TestInspectOomKilledTrue
22:23:45 [2019-11-06T22:23:45.645Z] --- SKIP: TestInspectOomKilledTrue (0.00s)
22:23:45 [2019-11-06T22:23:45.645Z] kill_test.go:151: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
22:23:45 [2019-11-06T22:23:45.645Z] === RUN TestInspectOomKilledFalse
22:23:45 [2019-11-06T22:23:45.645Z] --- SKIP: TestInspectOomKilledFalse (0.00s)
22:23:45 [2019-11-06T22:23:45.645Z] kill_test.go:169: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
22:23:45 [2019-11-06T22:23:45.645Z] === RUN TestLinksEtcHostsContentMatch
22:23:46 [2019-11-06T22:23:46.433Z] --- PASS: TestLinksEtcHostsContentMatch (0.78s)
22:23:46 [2019-11-06T22:23:46.433Z] === RUN TestLinksContainerNames
22:23:48 [2019-11-06T22:23:48.256Z] --- PASS: TestLinksContainerNames (1.73s)
22:23:48 [2019-11-06T22:23:48.256Z] === RUN TestLogsFollowTailEmpty
22:23:49 [2019-11-06T22:23:49.053Z] --- PASS: TestLogsFollowTailEmpty (0.96s)
22:23:49 [2019-11-06T22:23:49.053Z] === RUN TestContainerNetworkMountsNoChown
22:23:49 [2019-11-06T22:23:49.863Z] --- PASS: TestContainerNetworkMountsNoChown (0.89s)
22:23:49 [2019-11-06T22:23:49.863Z] === RUN TestMountDaemonRoot
22:23:50 [2019-11-06T22:23:50.266Z] === RUN TestMountDaemonRoot/default
22:23:50 [2019-11-06T22:23:50.266Z] === PAUSE TestMountDaemonRoot/default
22:23:50 [2019-11-06T22:23:50.266Z] === RUN TestMountDaemonRoot/private
22:23:50 [2019-11-06T22:23:50.266Z] === PAUSE TestMountDaemonRoot/private
22:23:50 [2019-11-06T22:23:50.266Z] === RUN TestMountDaemonRoot/rprivate
22:23:50 [2019-11-06T22:23:50.266Z] === PAUSE TestMountDaemonRoot/rprivate
22:23:50 [2019-11-06T22:23:50.266Z] === RUN TestMountDaemonRoot/slave
22:23:50 [2019-11-06T22:23:50.266Z] === PAUSE TestMountDaemonRoot/slave
22:23:50 [2019-11-06T22:23:50.266Z] === RUN TestMountDaemonRoot/rslave
22:23:50 [2019-11-06T22:23:50.266Z] === PAUSE TestMountDaemonRoot/rslave
22:23:50 [2019-11-06T22:23:50.266Z] === RUN TestMountDaemonRoot/shared
22:23:50 [2019-11-06T22:23:50.266Z] === PAUSE TestMountDaemonRoot/shared
22:23:50 [2019-11-06T22:23:50.266Z] === RUN TestMountDaemonRoot/rshared
22:23:50 [2019-11-06T22:23:50.266Z] === PAUSE TestMountDaemonRoot/rshared
22:23:50 [2019-11-06T22:23:50.266Z] === CONT TestMountDaemonRoot/default
22:23:50 [2019-11-06T22:23:50.266Z] === RUN TestMountDaemonRoot/default/bind_root
22:23:50 [2019-11-06T22:23:50.266Z] === CONT TestMountDaemonRoot/rslave
22:23:50 [2019-11-06T22:23:50.266Z] === RUN TestMountDaemonRoot/rslave/bind_root
22:23:50 [2019-11-06T22:23:50.266Z] === PAUSE TestMountDaemonRoot/rslave/bind_root
22:23:50 [2019-11-06T22:23:50.266Z] === RUN TestMountDaemonRoot/rslave/bind_subpath
22:23:50 [2019-11-06T22:23:50.266Z] === PAUSE TestMountDaemonRoot/rslave/bind_subpath
22:23:50 [2019-11-06T22:23:50.266Z] === RUN TestMountDaemonRoot/rslave/mount_root
22:23:50 [2019-11-06T22:23:50.266Z] === PAUSE TestMountDaemonRoot/rslave/mount_root
22:23:50 [2019-11-06T22:23:50.266Z] === RUN TestMountDaemonRoot/rslave/mount_subpath
22:23:50 [2019-11-06T22:23:50.266Z] === PAUSE TestMountDaemonRoot/rslave/mount_subpath
22:23:50 [2019-11-06T22:23:50.266Z] === CONT TestMountDaemonRoot/rshared
22:23:50 [2019-11-06T22:23:50.266Z] === RUN TestMountDaemonRoot/rshared/bind_root
22:23:50 [2019-11-06T22:23:50.266Z] === PAUSE TestMountDaemonRoot/rshared/bind_root
22:23:50 [2019-11-06T22:23:50.266Z] === RUN TestMountDaemonRoot/rshared/bind_subpath
22:23:50 [2019-11-06T22:23:50.266Z] === PAUSE TestMountDaemonRoot/rshared/bind_subpath
22:23:50 [2019-11-06T22:23:50.266Z] === RUN TestMountDaemonRoot/rshared/mount_root
22:23:50 [2019-11-06T22:23:50.266Z] === PAUSE TestMountDaemonRoot/rshared/mount_root
22:23:50 [2019-11-06T22:23:50.266Z] === RUN TestMountDaemonRoot/rshared/mount_subpath
22:23:50 [2019-11-06T22:23:50.266Z] === PAUSE TestMountDaemonRoot/rshared/mount_subpath
22:23:50 [2019-11-06T22:23:50.266Z] === CONT TestMountDaemonRoot/shared
22:23:50 [2019-11-06T22:23:50.266Z] === RUN TestMountDaemonRoot/shared/mount_root
22:23:50 [2019-11-06T22:23:50.266Z] === PAUSE TestMountDaemonRoot/shared/mount_root
22:23:50 [2019-11-06T22:23:50.266Z] === RUN TestMountDaemonRoot/shared/mount_subpath
22:23:50 [2019-11-06T22:23:50.266Z] === PAUSE TestMountDaemonRoot/shared/mount_subpath
22:23:50 [2019-11-06T22:23:50.266Z] === RUN TestMountDaemonRoot/shared/bind_root
22:23:50 [2019-11-06T22:23:50.266Z] === PAUSE TestMountDaemonRoot/shared/bind_root
22:23:50 [2019-11-06T22:23:50.266Z] === RUN TestMountDaemonRoot/shared/bind_subpath
22:23:50 [2019-11-06T22:23:50.266Z] === PAUSE TestMountDaemonRoot/shared/bind_subpath
22:23:50 [2019-11-06T22:23:50.266Z] === CONT TestMountDaemonRoot/rprivate
22:23:50 [2019-11-06T22:23:50.266Z] === RUN TestMountDaemonRoot/rprivate/mount_root
22:23:50 [2019-11-06T22:23:50.266Z] === PAUSE TestMountDaemonRoot/rprivate/mount_root
22:23:50 [2019-11-06T22:23:50.266Z] === RUN TestMountDaemonRoot/rprivate/mount_subpath
22:23:50 [2019-11-06T22:23:50.266Z] === PAUSE TestMountDaemonRoot/rprivate/mount_subpath
22:23:50 [2019-11-06T22:23:50.266Z] === RUN TestMountDaemonRoot/rprivate/bind_root
22:23:50 [2019-11-06T22:23:50.266Z] === PAUSE TestMountDaemonRoot/rprivate/bind_root
22:23:50 [2019-11-06T22:23:50.266Z] === RUN TestMountDaemonRoot/rprivate/bind_subpath
22:23:50 [2019-11-06T22:23:50.266Z] === PAUSE TestMountDaemonRoot/rprivate/bind_subpath
22:23:50 [2019-11-06T22:23:50.266Z] === CONT TestMountDaemonRoot/slave
22:23:50 [2019-11-06T22:23:50.266Z] === RUN TestMountDaemonRoot/slave/bind_root
22:23:50 [2019-11-06T22:23:50.266Z] === PAUSE TestMountDaemonRoot/slave/bind_root
22:23:50 [2019-11-06T22:23:50.266Z] === RUN TestMountDaemonRoot/slave/bind_subpath
22:23:50 [2019-11-06T22:23:50.266Z] === PAUSE TestMountDaemonRoot/slave/bind_subpath
22:23:50 [2019-11-06T22:23:50.266Z] === RUN TestMountDaemonRoot/slave/mount_root
22:23:50 [2019-11-06T22:23:50.266Z] === PAUSE TestMountDaemonRoot/slave/mount_root
22:23:50 [2019-11-06T22:23:50.266Z] === RUN TestMountDaemonRoot/slave/mount_subpath
22:23:50 [2019-11-06T22:23:50.266Z] === PAUSE TestMountDaemonRoot/slave/mount_subpath
22:23:50 [2019-11-06T22:23:50.266Z] === CONT TestMountDaemonRoot/private
22:23:50 [2019-11-06T22:23:50.266Z] === RUN TestMountDaemonRoot/private/bind_root
22:23:50 [2019-11-06T22:23:50.266Z] === PAUSE TestMountDaemonRoot/private/bind_root
22:23:50 [2019-11-06T22:23:50.266Z] === RUN TestMountDaemonRoot/private/bind_subpath
22:23:50 [2019-11-06T22:23:50.266Z] === PAUSE TestMountDaemonRoot/private/bind_subpath
22:23:50 [2019-11-06T22:23:50.266Z] === RUN TestMountDaemonRoot/private/mount_root
22:23:50 [2019-11-06T22:23:50.266Z] === PAUSE TestMountDaemonRoot/private/mount_root
22:23:50 [2019-11-06T22:23:50.266Z] === RUN TestMountDaemonRoot/private/mount_subpath
22:23:50 [2019-11-06T22:23:50.266Z] === PAUSE TestMountDaemonRoot/private/mount_subpath
22:23:50 [2019-11-06T22:23:50.266Z] === CONT TestMountDaemonRoot/rslave/bind_root
22:23:50 [2019-11-06T22:23:50.266Z] === PAUSE TestMountDaemonRoot/default/bind_root
22:23:50 [2019-11-06T22:23:50.266Z] === RUN TestMountDaemonRoot/default/bind_subpath
22:23:50 [2019-11-06T22:23:50.266Z] === PAUSE TestMountDaemonRoot/default/bind_subpath
22:23:50 [2019-11-06T22:23:50.266Z] === RUN TestMountDaemonRoot/default/mount_root
22:23:50 [2019-11-06T22:23:50.267Z] === PAUSE TestMountDaemonRoot/default/mount_root
22:23:50 [2019-11-06T22:23:50.267Z] === RUN TestMountDaemonRoot/default/mount_subpath
22:23:50 [2019-11-06T22:23:50.267Z] === PAUSE TestMountDaemonRoot/default/mount_subpath
22:23:50 [2019-11-06T22:23:50.267Z] === CONT TestMountDaemonRoot/rshared/bind_root
22:23:50 [2019-11-06T22:23:50.267Z] === CONT TestMountDaemonRoot/rslave/mount_subpath
22:23:50 [2019-11-06T22:23:50.267Z] === CONT TestMountDaemonRoot/rslave/mount_root
22:23:50 [2019-11-06T22:23:50.267Z] === CONT TestMountDaemonRoot/rslave/bind_subpath
22:23:50 [2019-11-06T22:23:50.267Z] === CONT TestMountDaemonRoot/shared/mount_root
22:23:50 [2019-11-06T22:23:50.267Z] === CONT TestMountDaemonRoot/rshared/mount_subpath
22:23:50 [2019-11-06T22:23:50.267Z] === CONT TestMountDaemonRoot/rshared/mount_root
22:23:50 [2019-11-06T22:23:50.267Z] === CONT TestMountDaemonRoot/rshared/bind_subpath
22:23:50 [2019-11-06T22:23:50.267Z] === CONT TestMountDaemonRoot/rprivate/mount_root
22:23:50 [2019-11-06T22:23:50.267Z] === CONT TestMountDaemonRoot/shared/bind_subpath
22:23:50 [2019-11-06T22:23:50.761Z] === CONT TestMountDaemonRoot/shared/bind_root
22:23:50 [2019-11-06T22:23:50.761Z] === CONT TestMountDaemonRoot/shared/mount_subpath
22:23:50 [2019-11-06T22:23:50.761Z] === CONT TestMountDaemonRoot/slave/bind_root
22:23:50 [2019-11-06T22:23:50.761Z] === CONT TestMountDaemonRoot/rprivate/bind_subpath
22:23:50 [2019-11-06T22:23:50.761Z] === CONT TestMountDaemonRoot/rprivate/bind_root
22:23:50 [2019-11-06T22:23:50.762Z] === CONT TestMountDaemonRoot/rprivate/mount_subpath
22:23:50 [2019-11-06T22:23:50.762Z] === CONT TestMountDaemonRoot/private/bind_root
22:23:50 [2019-11-06T22:23:50.762Z] === CONT TestMountDaemonRoot/slave/mount_subpath
22:23:50 [2019-11-06T22:23:50.762Z] === CONT TestMountDaemonRoot/slave/mount_root
22:23:50 [2019-11-06T22:23:50.762Z] === CONT TestMountDaemonRoot/slave/bind_subpath
22:23:50 [2019-11-06T22:23:50.762Z] === CONT TestMountDaemonRoot/private/mount_subpath
22:23:50 [2019-11-06T22:23:50.762Z] === CONT TestMountDaemonRoot/private/mount_root
22:23:50 [2019-11-06T22:23:50.762Z] === CONT TestMountDaemonRoot/private/bind_subpath
22:23:50 [2019-11-06T22:23:50.762Z] === CONT TestMountDaemonRoot/default/bind_root
22:23:50 [2019-11-06T22:23:50.762Z] === CONT TestMountDaemonRoot/default/mount_root
22:23:50 [2019-11-06T22:23:50.762Z] === CONT TestMountDaemonRoot/default/mount_subpath
22:23:50 [2019-11-06T22:23:50.762Z] === CONT TestMountDaemonRoot/default/bind_subpath
22:23:50 [2019-11-06T22:23:50.762Z] --- PASS: TestMountDaemonRoot (0.04s)
22:23:50 [2019-11-06T22:23:50.762Z] --- PASS: TestMountDaemonRoot/rslave (0.00s)
22:23:50 [2019-11-06T22:23:50.762Z] --- PASS: TestMountDaemonRoot/rslave/bind_root (0.10s)
22:23:50 [2019-11-06T22:23:50.762Z] --- PASS: TestMountDaemonRoot/rslave/mount_subpath (0.06s)
22:23:50 [2019-11-06T22:23:50.762Z] --- PASS: TestMountDaemonRoot/rslave/mount_root (0.09s)
22:23:50 [2019-11-06T22:23:50.762Z] --- PASS: TestMountDaemonRoot/rslave/bind_subpath (0.08s)
22:23:50 [2019-11-06T22:23:50.762Z] --- PASS: TestMountDaemonRoot/rshared (0.00s)
22:23:50 [2019-11-06T22:23:50.762Z] --- PASS: TestMountDaemonRoot/rshared/bind_root (0.10s)
22:23:50 [2019-11-06T22:23:50.762Z] --- PASS: TestMountDaemonRoot/rshared/mount_subpath (0.11s)
22:23:50 [2019-11-06T22:23:50.762Z] --- PASS: TestMountDaemonRoot/rshared/mount_root (0.08s)
22:23:50 [2019-11-06T22:23:50.762Z] --- PASS: TestMountDaemonRoot/rshared/bind_subpath (0.08s)
22:23:50 [2019-11-06T22:23:50.762Z] --- PASS: TestMountDaemonRoot/shared (0.00s)
22:23:50 [2019-11-06T22:23:50.762Z] --- PASS: TestMountDaemonRoot/shared/mount_root (0.03s)
22:23:50 [2019-11-06T22:23:50.762Z] --- PASS: TestMountDaemonRoot/shared/bind_subpath (0.02s)
22:23:50 [2019-11-06T22:23:50.762Z] --- PASS: TestMountDaemonRoot/shared/bind_root (0.02s)
22:23:50 [2019-11-06T22:23:50.762Z] --- PASS: TestMountDaemonRoot/shared/mount_subpath (0.04s)
22:23:50 [2019-11-06T22:23:50.762Z] --- PASS: TestMountDaemonRoot/rprivate (0.00s)
22:23:50 [2019-11-06T22:23:50.762Z] --- PASS: TestMountDaemonRoot/rprivate/mount_root (0.04s)
22:23:50 [2019-11-06T22:23:50.762Z] --- PASS: TestMountDaemonRoot/rprivate/bind_subpath (0.04s)
22:23:50 [2019-11-06T22:23:50.762Z] --- PASS: TestMountDaemonRoot/rprivate/bind_root (0.04s)
22:23:50 [2019-11-06T22:23:50.762Z] --- PASS: TestMountDaemonRoot/rprivate/mount_subpath (0.02s)
22:23:50 [2019-11-06T22:23:50.762Z] --- PASS: TestMountDaemonRoot/slave (0.00s)
22:23:50 [2019-11-06T22:23:50.762Z] --- PASS: TestMountDaemonRoot/slave/bind_root (0.04s)
22:23:50 [2019-11-06T22:23:50.762Z] --- PASS: TestMountDaemonRoot/slave/mount_subpath (0.03s)
22:23:50 [2019-11-06T22:23:50.762Z] --- PASS: TestMountDaemonRoot/slave/bind_subpath (0.04s)
22:23:50 [2019-11-06T22:23:50.762Z] --- PASS: TestMountDaemonRoot/slave/mount_root (0.05s)
22:23:50 [2019-11-06T22:23:50.762Z] --- PASS: TestMountDaemonRoot/private (0.00s)
22:23:50 [2019-11-06T22:23:50.762Z] --- PASS: TestMountDaemonRoot/private/bind_root (0.04s)
22:23:50 [2019-11-06T22:23:50.762Z] --- PASS: TestMountDaemonRoot/private/mount_subpath (0.05s)
22:23:50 [2019-11-06T22:23:50.762Z] --- PASS: TestMountDaemonRoot/private/mount_root (0.05s)
22:23:50 [2019-11-06T22:23:50.762Z] --- PASS: TestMountDaemonRoot/private/bind_subpath (0.05s)
22:23:50 [2019-11-06T22:23:50.762Z] --- PASS: TestMountDaemonRoot/default (0.00s)
22:23:50 [2019-11-06T22:23:50.762Z] --- PASS: TestMountDaemonRoot/default/bind_root (0.09s)
22:23:50 [2019-11-06T22:23:50.762Z] --- PASS: TestMountDaemonRoot/default/mount_root (0.08s)
22:23:50 [2019-11-06T22:23:50.762Z] --- PASS: TestMountDaemonRoot/default/mount_subpath (0.07s)
22:23:50 [2019-11-06T22:23:50.762Z] --- PASS: TestMountDaemonRoot/default/bind_subpath (0.10s)
22:23:50 [2019-11-06T22:23:50.762Z] === RUN TestContainerBindMountNonRecursive
22:23:53 [2019-11-06T22:23:53.221Z] --- PASS: TestContainerBindMountNonRecursive (1.97s)
22:23:53 [2019-11-06T22:23:53.222Z] === RUN TestNetworkNat
22:23:53 [2019-11-06T22:23:53.589Z] --- PASS: TestNetworkNat (0.84s)
22:23:53 [2019-11-06T22:23:53.589Z] === RUN TestNetworkLocalhostTCPNat
22:23:54 [2019-11-06T22:23:54.391Z] --- PASS: TestNetworkLocalhostTCPNat (0.85s)
22:23:54 [2019-11-06T22:23:54.392Z] === RUN TestNetworkLoopbackNat
22:23:55 [2019-11-06T22:23:55.670Z] --- PASS: TestNetworkLoopbackNat (1.20s)
22:23:55 [2019-11-06T22:23:55.670Z] === RUN TestPause
22:23:56 [2019-11-06T22:23:56.965Z] --- PASS: TestPause (0.90s)
22:23:56 [2019-11-06T22:23:56.965Z] === RUN TestPauseFailsOnWindowsServerContainers
22:23:56 [2019-11-06T22:23:56.965Z] --- SKIP: TestPauseFailsOnWindowsServerContainers (0.00s)
22:23:56 [2019-11-06T22:23:56.965Z] pause_test.go:54: testEnv.DaemonInfo.OSType != "windows" || testEnv.DaemonInfo.Isolation != "process"
22:23:56 [2019-11-06T22:23:56.965Z] === RUN TestPauseStopPausedContainer
22:23:57 [2019-11-06T22:23:57.859Z] --- PASS: TestPauseStopPausedContainer (0.90s)
22:23:57 [2019-11-06T22:23:57.859Z] === RUN TestPsFilter
22:23:57 [2019-11-06T22:23:57.859Z] --- PASS: TestPsFilter (0.27s)
22:23:57 [2019-11-06T22:23:57.859Z] === RUN TestRemoveContainerWithRemovedVolume
22:23:58 [2019-11-06T22:23:58.858Z] --- PASS: TestRemoveContainerWithRemovedVolume (1.03s)
22:23:58 [2019-11-06T22:23:58.858Z] === RUN TestRemoveContainerWithVolume
22:23:59 [2019-11-06T22:23:59.759Z] --- PASS: TestRemoveContainerWithVolume (1.02s)
22:23:59 [2019-11-06T22:23:59.759Z] === RUN TestRemoveContainerRunning
22:24:01 [2019-11-06T22:24:01.054Z] --- PASS: TestRemoveContainerRunning (1.01s)
22:24:01 [2019-11-06T22:24:01.054Z] === RUN TestRemoveContainerForceRemoveRunning
22:24:01 [2019-11-06T22:24:01.870Z] --- PASS: TestRemoveContainerForceRemoveRunning (1.00s)
22:24:01 [2019-11-06T22:24:01.870Z] === RUN TestRemoveInvalidContainer
22:24:01 [2019-11-06T22:24:01.870Z] --- PASS: TestRemoveInvalidContainer (0.01s)
22:24:01 [2019-11-06T22:24:01.870Z] === RUN TestRenameLinkedContainer
22:24:05 [2019-11-06T22:24:05.968Z] --- PASS: TestRenameLinkedContainer (3.55s)
22:24:05 [2019-11-06T22:24:05.968Z] === RUN TestRenameStoppedContainer
22:24:06 [2019-11-06T22:24:06.343Z] --- PASS: TestRenameStoppedContainer (0.95s)
22:24:06 [2019-11-06T22:24:06.343Z] === RUN TestRenameRunningContainerAndReuse
22:24:08 [2019-11-06T22:24:08.157Z] --- PASS: TestRenameRunningContainerAndReuse (1.91s)
22:24:08 [2019-11-06T22:24:08.157Z] === RUN TestRenameInvalidName
22:24:09 [2019-11-06T22:24:09.562Z] --- PASS: TestRenameInvalidName (1.02s)
22:24:09 [2019-11-06T22:24:09.562Z] === RUN TestRenameAnonymousContainer
22:24:12 [2019-11-06T22:24:12.835Z] --- PASS: TestRenameAnonymousContainer (3.09s)
22:24:12 [2019-11-06T22:24:12.835Z] === RUN TestRenameContainerWithSameName
22:24:13 [2019-11-06T22:24:13.210Z] --- PASS: TestRenameContainerWithSameName (0.84s)
22:24:13 [2019-11-06T22:24:13.210Z] === RUN TestRenameContainerWithLinkedContainer
22:24:15 [2019-11-06T22:24:15.039Z] --- PASS: TestRenameContainerWithLinkedContainer (1.69s)
22:24:15 [2019-11-06T22:24:15.039Z] === RUN TestResize
22:24:15 [2019-11-06T22:24:15.825Z] --- PASS: TestResize (0.98s)
22:24:15 [2019-11-06T22:24:15.825Z] === RUN TestResizeWithInvalidSize
22:24:17 [2019-11-06T22:24:17.098Z] --- PASS: TestResizeWithInvalidSize (1.03s)
22:24:17 [2019-11-06T22:24:17.099Z] === RUN TestResizeWhenContainerNotStarted
22:24:17 [2019-11-06T22:24:17.914Z] --- PASS: TestResizeWhenContainerNotStarted (0.96s)
22:24:17 [2019-11-06T22:24:17.914Z] === RUN TestDaemonRestartKillContainers
22:24:17 [2019-11-06T22:24:17.914Z] === RUN TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
22:24:17 [2019-11-06T22:24:17.914Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
22:24:17 [2019-11-06T22:24:17.914Z] === RUN TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
22:24:17 [2019-11-06T22:24:17.914Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
22:24:17 [2019-11-06T22:24:17.914Z] === RUN TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
22:24:17 [2019-11-06T22:24:17.914Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
22:24:17 [2019-11-06T22:24:17.914Z] === RUN TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
22:24:17 [2019-11-06T22:24:17.914Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
22:24:17 [2019-11-06T22:24:17.914Z] === RUN TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
22:24:17 [2019-11-06T22:24:17.914Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
22:24:17 [2019-11-06T22:24:17.914Z] === RUN TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
22:24:17 [2019-11-06T22:24:17.914Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
22:24:17 [2019-11-06T22:24:17.914Z] === RUN TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
22:24:17 [2019-11-06T22:24:17.914Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
22:24:17 [2019-11-06T22:24:17.914Z] === RUN TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
22:24:17 [2019-11-06T22:24:17.914Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
22:24:17 [2019-11-06T22:24:17.914Z] === RUN TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
22:24:17 [2019-11-06T22:24:17.914Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
22:24:17 [2019-11-06T22:24:17.914Z] === RUN TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
22:24:17 [2019-11-06T22:24:17.914Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
22:24:17 [2019-11-06T22:24:17.914Z] === RUN TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
22:24:17 [2019-11-06T22:24:17.914Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
22:24:17 [2019-11-06T22:24:17.914Z] === RUN TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
22:24:17 [2019-11-06T22:24:17.914Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
22:24:17 [2019-11-06T22:24:17.914Z] === CONT TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
22:24:17 [2019-11-06T22:24:17.914Z] === CONT TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
22:24:19 [2019-11-06T22:24:19.921Z] === CONT TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
22:24:20 [2019-11-06T22:24:20.746Z] === CONT TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
22:24:21 [2019-11-06T22:24:21.561Z] === CONT TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
22:24:21 [2019-11-06T22:24:21.945Z] === CONT TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
22:24:23 [2019-11-06T22:24:23.229Z] === CONT TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
22:24:23 [2019-11-06T22:24:23.620Z] === CONT TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
22:24:25 [2019-11-06T22:24:25.763Z] === CONT TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
22:24:26 [2019-11-06T22:24:26.346Z] === CONT TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
22:24:28 [2019-11-06T22:24:28.858Z] === CONT TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
22:24:29 [2019-11-06T22:24:29.243Z] === CONT TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
22:24:31 [2019-11-06T22:24:31.728Z] --- PASS: TestDaemonRestartKillContainers (0.00s)
22:24:31 [2019-11-06T22:24:31.728Z] --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon (2.15s)
22:24:31 [2019-11-06T22:24:31.728Z] --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon (2.59s)
22:24:31 [2019-11-06T22:24:31.728Z] --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon (1.49s)
22:24:31 [2019-11-06T22:24:31.728Z] --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon (1.51s)
22:24:31 [2019-11-06T22:24:31.728Z] --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon (1.55s)
22:24:31 [2019-11-06T22:24:31.728Z] --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon (1.44s)
22:24:31 [2019-11-06T22:24:31.728Z] --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon (2.45s)
22:24:31 [2019-11-06T22:24:31.728Z] --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon (2.62s)
22:24:31 [2019-11-06T22:24:31.728Z] --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon (3.07s)
22:24:31 [2019-11-06T22:24:31.728Z] --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon (3.05s)
22:24:31 [2019-11-06T22:24:31.728Z] --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon (2.49s)
22:24:31 [2019-11-06T22:24:31.728Z] --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon (2.47s)
22:24:31 [2019-11-06T22:24:31.728Z] === RUN TestCgroupNamespacesRun
22:24:33 [2019-11-06T22:24:33.553Z] --- PASS: TestCgroupNamespacesRun (1.79s)
22:24:33 [2019-11-06T22:24:33.553Z] === RUN TestCgroupNamespacesRunPrivileged
22:24:35 [2019-11-06T22:24:35.386Z] --- PASS: TestCgroupNamespacesRunPrivileged (1.81s)
22:24:35 [2019-11-06T22:24:35.386Z] === RUN TestCgroupNamespacesRunDaemonHostMode
22:24:37 [2019-11-06T22:24:37.563Z] --- PASS: TestCgroupNamespacesRunDaemonHostMode (1.86s)
22:24:37 [2019-11-06T22:24:37.563Z] === RUN TestCgroupNamespacesRunHostMode
22:24:38 [2019-11-06T22:24:38.848Z] --- PASS: TestCgroupNamespacesRunHostMode (1.87s)
22:24:38 [2019-11-06T22:24:38.848Z] === RUN TestCgroupNamespacesRunPrivateMode
22:24:40 [2019-11-06T22:24:40.684Z] --- PASS: TestCgroupNamespacesRunPrivateMode (1.77s)
22:24:40 [2019-11-06T22:24:40.684Z] === RUN TestCgroupNamespacesRunPrivilegedAndPrivate
22:24:41 [2019-11-06T22:24:41.493Z] --- PASS: TestCgroupNamespacesRunPrivilegedAndPrivate (0.83s)
22:24:41 [2019-11-06T22:24:41.493Z] === RUN TestCgroupNamespacesRunInvalidMode
22:24:42 [2019-11-06T22:24:42.296Z] --- PASS: TestCgroupNamespacesRunInvalidMode (0.81s)
22:24:42 [2019-11-06T22:24:42.296Z] === RUN TestCgroupNamespacesRunOlderClient
22:24:44 [2019-11-06T22:24:44.171Z] --- PASS: TestCgroupNamespacesRunOlderClient (1.83s)
22:24:44 [2019-11-06T22:24:44.171Z] === RUN TestKernelTCPMemory
22:24:45 [2019-11-06T22:24:45.632Z] --- PASS: TestKernelTCPMemory (1.15s)
22:24:45 [2019-11-06T22:24:45.632Z] === RUN TestNISDomainname
22:24:46 [2019-11-06T22:24:46.909Z] --- PASS: TestNISDomainname (1.41s)
22:24:46 [2019-11-06T22:24:46.909Z] === RUN TestHostnameDnsResolution
22:24:47 [2019-11-06T22:24:47.785Z] --- PASS: TestHostnameDnsResolution (1.19s)
22:24:47 [2019-11-06T22:24:47.785Z] === RUN TestStats
22:24:51 [2019-11-06T22:24:51.199Z] --- PASS: TestStats (2.79s)
22:24:51 [2019-11-06T22:24:51.199Z] === RUN TestStopContainerWithTimeout
22:24:51 [2019-11-06T22:24:51.199Z] === RUN TestStopContainerWithTimeout/0
22:24:51 [2019-11-06T22:24:51.199Z] === PAUSE TestStopContainerWithTimeout/0
22:24:51 [2019-11-06T22:24:51.199Z] === RUN TestStopContainerWithTimeout/1
22:24:51 [2019-11-06T22:24:51.199Z] === PAUSE TestStopContainerWithTimeout/1
22:24:51 [2019-11-06T22:24:51.199Z] === RUN TestStopContainerWithTimeout/3
22:24:51 [2019-11-06T22:24:51.199Z] === PAUSE TestStopContainerWithTimeout/3
22:24:51 [2019-11-06T22:24:51.199Z] === RUN TestStopContainerWithTimeout/-1
22:24:51 [2019-11-06T22:24:51.199Z] === PAUSE TestStopContainerWithTimeout/-1
22:24:51 [2019-11-06T22:24:51.199Z] === CONT TestStopContainerWithTimeout/0
22:24:51 [2019-11-06T22:24:51.199Z] === CONT TestStopContainerWithTimeout/-1
22:24:52 [2019-11-06T22:24:52.033Z] === CONT TestStopContainerWithTimeout/3
22:24:53 [2019-11-06T22:24:53.843Z] === CONT TestStopContainerWithTimeout/1
22:24:55 [2019-11-06T22:24:55.653Z] --- PASS: TestStopContainerWithTimeout (0.02s)
22:24:55 [2019-11-06T22:24:55.653Z] --- PASS: TestStopContainerWithTimeout/0 (1.09s)
22:24:55 [2019-11-06T22:24:55.653Z] --- PASS: TestStopContainerWithTimeout/-1 (3.03s)
22:24:55 [2019-11-06T22:24:55.653Z] --- PASS: TestStopContainerWithTimeout/3 (2.93s)
22:24:55 [2019-11-06T22:24:55.653Z] --- PASS: TestStopContainerWithTimeout/1 (1.94s)
22:24:55 [2019-11-06T22:24:55.653Z] === RUN TestDeleteDevicemapper
22:24:55 [2019-11-06T22:24:55.653Z] --- SKIP: TestDeleteDevicemapper (0.00s)
22:24:55 [2019-11-06T22:24:55.653Z] stop_linux_test.go:74: testEnv.DaemonInfo.Driver != "devicemapper"
22:24:55 [2019-11-06T22:24:55.653Z] === RUN TestStopContainerWithRestartPolicyAlways
22:24:59 [2019-11-06T22:24:59.747Z] --- PASS: TestStopContainerWithRestartPolicyAlways (3.54s)
22:24:59 [2019-11-06T22:24:59.747Z] === RUN TestUpdateMemory
22:24:59 [2019-11-06T22:24:59.747Z] --- SKIP: TestUpdateMemory (0.00s)
22:24:59 [2019-11-06T22:24:59.747Z] update_linux_test.go:23: !testEnv.DaemonInfo.SwapLimit
22:24:59 [2019-11-06T22:24:59.747Z] === RUN TestUpdateCPUQuota
22:25:00 [2019-11-06T22:25:00.774Z] --- PASS: TestUpdateCPUQuota (1.66s)
22:25:00 [2019-11-06T22:25:00.774Z] === RUN TestUpdatePidsLimit
22:25:00 [2019-11-06T22:25:00.774Z] === RUN TestUpdatePidsLimit/update_from_none
22:25:01 [2019-11-06T22:25:01.153Z] === RUN TestUpdatePidsLimit/no_change
22:25:01 [2019-11-06T22:25:01.965Z] === RUN TestUpdatePidsLimit/update_lower
22:25:02 [2019-11-06T22:25:02.345Z] === RUN TestUpdatePidsLimit/update_on_old_api_ignores_value
22:25:02 [2019-11-06T22:25:02.784Z] === RUN TestUpdatePidsLimit/unset_limit_with_zero
22:25:03 [2019-11-06T22:25:03.245Z] === RUN TestUpdatePidsLimit/unset_limit_with_minus_one
22:25:03 [2019-11-06T22:25:03.693Z] === RUN TestUpdatePidsLimit/unset_limit_with_minus_two
22:25:05 [2019-11-06T22:25:05.065Z] --- PASS: TestUpdatePidsLimit (4.22s)
22:25:05 [2019-11-06T22:25:05.065Z] --- PASS: TestUpdatePidsLimit/update_from_none (0.43s)
22:25:05 [2019-11-06T22:25:05.065Z] --- PASS: TestUpdatePidsLimit/no_change (0.42s)
22:25:05 [2019-11-06T22:25:05.065Z] --- PASS: TestUpdatePidsLimit/update_lower (0.45s)
22:25:05 [2019-11-06T22:25:05.065Z] --- PASS: TestUpdatePidsLimit/update_on_old_api_ignores_value (0.41s)
22:25:05 [2019-11-06T22:25:05.065Z] --- PASS: TestUpdatePidsLimit/unset_limit_with_zero (0.50s)
22:25:05 [2019-11-06T22:25:05.065Z] --- PASS: TestUpdatePidsLimit/unset_limit_with_minus_one (0.42s)
22:25:05 [2019-11-06T22:25:05.065Z] --- PASS: TestUpdatePidsLimit/unset_limit_with_minus_two (0.37s)
22:25:05 [2019-11-06T22:25:05.065Z] === RUN TestUpdateRestartPolicy
22:25:18 [2019-11-06T22:25:18.675Z] --- PASS: TestUpdateRestartPolicy (13.02s)
22:25:18 [2019-11-06T22:25:18.675Z] === RUN TestUpdateRestartWithAutoRemove
22:25:19 [2019-11-06T22:25:19.046Z] --- PASS: TestUpdateRestartWithAutoRemove (0.96s)
22:25:19 [2019-11-06T22:25:19.046Z] === RUN TestWaitNonBlocked
22:25:19 [2019-11-06T22:25:19.046Z] === RUN TestWaitNonBlocked/wait-nonblocking-exit-0
22:25:19 [2019-11-06T22:25:19.046Z] === PAUSE TestWaitNonBlocked/wait-nonblocking-exit-0
22:25:19 [2019-11-06T22:25:19.046Z] === RUN TestWaitNonBlocked/wait-nonblocking-exit-random
22:25:19 [2019-11-06T22:25:19.046Z] === PAUSE TestWaitNonBlocked/wait-nonblocking-exit-random
22:25:19 [2019-11-06T22:25:19.046Z] === CONT TestWaitNonBlocked/wait-nonblocking-exit-0
22:25:19 [2019-11-06T22:25:19.046Z] === CONT TestWaitNonBlocked/wait-nonblocking-exit-random
22:25:20 [2019-11-06T22:25:20.602Z] --- PASS: TestWaitNonBlocked (0.01s)
22:25:20 [2019-11-06T22:25:20.602Z] --- PASS: TestWaitNonBlocked/wait-nonblocking-exit-random (1.16s)
22:25:20 [2019-11-06T22:25:20.602Z] --- PASS: TestWaitNonBlocked/wait-nonblocking-exit-0 (1.17s)
22:25:20 [2019-11-06T22:25:20.602Z] === RUN TestWaitBlocked
22:25:20 [2019-11-06T22:25:20.602Z] === RUN TestWaitBlocked/test-wait-blocked-exit-zero
22:25:20 [2019-11-06T22:25:20.602Z] === PAUSE TestWaitBlocked/test-wait-blocked-exit-zero
22:25:20 [2019-11-06T22:25:20.602Z] === RUN TestWaitBlocked/test-wait-blocked-exit-random
22:25:20 [2019-11-06T22:25:20.602Z] === PAUSE TestWaitBlocked/test-wait-blocked-exit-random
22:25:20 [2019-11-06T22:25:20.602Z] === CONT TestWaitBlocked/test-wait-blocked-exit-zero
22:25:20 [2019-11-06T22:25:20.602Z] === CONT TestWaitBlocked/test-wait-blocked-exit-random
22:25:21 [2019-11-06T22:25:21.541Z] --- PASS: TestWaitBlocked (0.02s)
22:25:21 [2019-11-06T22:25:21.541Z] --- PASS: TestWaitBlocked/test-wait-blocked-exit-zero (1.35s)
22:25:21 [2019-11-06T22:25:21.541Z] --- PASS: TestWaitBlocked/test-wait-blocked-exit-random (1.43s)
22:25:21 [2019-11-06T22:25:21.541Z] === CONT TestContainerStartOnDaemonRestart
22:25:21 [2019-11-06T22:25:21.541Z] === CONT TestIpcModeOlderClient
22:25:21 [2019-11-06T22:25:21.925Z] --- PASS: TestIpcModeOlderClient (0.18s)
22:25:21 [2019-11-06T22:25:21.925Z] === CONT TestDaemonRestartIpcMode
22:25:25 [2019-11-06T22:25:25.173Z] --- PASS: TestContainerStartOnDaemonRestart (3.35s)
22:25:25 [2019-11-06T22:25:25.982Z] --- PASS: TestDaemonRestartIpcMode (3.87s)
22:25:25 [2019-11-06T22:25:25.982Z] PASS
22:25:25 [2019-11-06T22:25:25.983Z]
22:25:25 [2019-11-06T22:25:25.983Z] === Skipped
22:25:25 [2019-11-06T22:25:25.983Z] === SKIP: s390x.integration.container TestCheckpoint (0.00s)
22:25:25 [2019-11-06T22:25:25.983Z] checkpoint_test.go:33: TestCheckpoint is broken; see https://github.com/moby/moby/issues/38963
22:25:25 [2019-11-06T22:25:25.983Z]
22:25:25 [2019-11-06T22:25:25.983Z] === SKIP: s390x.integration.container TestInspectOomKilledTrue (0.00s)
22:25:25 [2019-11-06T22:25:25.983Z] kill_test.go:151: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
22:25:25 [2019-11-06T22:25:25.983Z]
22:25:25 [2019-11-06T22:25:25.983Z] === SKIP: s390x.integration.container TestInspectOomKilledFalse (0.00s)
22:25:25 [2019-11-06T22:25:25.983Z] kill_test.go:169: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
22:25:25 [2019-11-06T22:25:25.983Z]
22:25:25 [2019-11-06T22:25:25.983Z] === SKIP: s390x.integration.container TestPauseFailsOnWindowsServerContainers (0.00s)
22:25:25 [2019-11-06T22:25:25.983Z] pause_test.go:54: testEnv.DaemonInfo.OSType != "windows" || testEnv.DaemonInfo.Isolation != "process"
22:25:25 [2019-11-06T22:25:25.983Z]
22:25:25 [2019-11-06T22:25:25.983Z] === SKIP: s390x.integration.container TestDeleteDevicemapper (0.00s)
22:25:25 [2019-11-06T22:25:25.983Z] stop_linux_test.go:74: testEnv.DaemonInfo.Driver != "devicemapper"
22:25:25 [2019-11-06T22:25:25.983Z]
22:25:25 [2019-11-06T22:25:25.983Z] === SKIP: s390x.integration.container TestUpdateMemory (0.00s)
22:25:25 [2019-11-06T22:25:25.983Z] update_linux_test.go:23: !testEnv.DaemonInfo.SwapLimit
22:25:25 [2019-11-06T22:25:25.983Z]
22:25:25 [2019-11-06T22:25:25.983Z]
22:25:25 [2019-11-06T22:25:25.983Z] DONE 197 tests, 6 skipped in 143.388s
22:25:25 [2019-11-06T22:25:25.983Z] Running /go/src/github.com/docker/docker/integration/image (s390x.integration.image) flags=-test.v -test.timeout=120m
22:25:25 [2019-11-06T22:25:25.983Z] ++ 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
22:25:25 [2019-11-06T22:25:25.983Z] ++ set -e
22:25:25 [2019-11-06T22:25:25.983Z] ++ '[' -n 0 ']'
22:25:25 [2019-11-06T22:25:25.983Z] ++ set -x
22:25:25 [2019-11-06T22:25:25.983Z] ++ 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
22:25:25 [2019-11-06T22:25:25.983Z] INFO: Testing against a local daemon
22:25:25 [2019-11-06T22:25:25.983Z] === RUN TestCommitInheritsEnv
22:25:26 [2019-11-06T22:25:26.353Z] --- PASS: TestCommitInheritsEnv (0.51s)
22:25:26 [2019-11-06T22:25:26.353Z] === RUN TestImportExtremelyLargeImageWorks
22:25:26 [2019-11-06T22:25:26.353Z] === PAUSE TestImportExtremelyLargeImageWorks
22:25:26 [2019-11-06T22:25:26.353Z] === RUN TestImagesFilterMultiReference
22:25:26 [2019-11-06T22:25:26.728Z] --- PASS: TestImagesFilterMultiReference (0.07s)
22:25:26 [2019-11-06T22:25:26.728Z] === RUN TestImagePullPlatformInvalid
22:25:26 [2019-11-06T22:25:26.728Z] --- PASS: TestImagePullPlatformInvalid (0.02s)
22:25:26 [2019-11-06T22:25:26.728Z] === RUN TestRemoveImageOrphaning
22:25:27 [2019-11-06T22:25:27.122Z] --- PASS: TestRemoveImageOrphaning (0.57s)
22:25:27 [2019-11-06T22:25:27.122Z] === RUN TestRemoveImageGarbageCollector
22:25:27 [2019-11-06T22:25:27.122Z] --- SKIP: TestRemoveImageGarbageCollector (0.00s)
22:25:27 [2019-11-06T22:25:27.122Z] remove_unix_test.go:36: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:25:27 [2019-11-06T22:25:27.122Z] === RUN TestTagUnprefixedRepoByNameOrName
22:25:27 [2019-11-06T22:25:27.122Z] --- PASS: TestTagUnprefixedRepoByNameOrName (0.02s)
22:25:27 [2019-11-06T22:25:27.122Z] === RUN TestTagInvalidReference
22:25:27 [2019-11-06T22:25:27.122Z] --- PASS: TestTagInvalidReference (0.01s)
22:25:27 [2019-11-06T22:25:27.122Z] === RUN TestTagValidPrefixedRepo
22:25:27 [2019-11-06T22:25:27.122Z] --- PASS: TestTagValidPrefixedRepo (0.05s)
22:25:27 [2019-11-06T22:25:27.122Z] === RUN TestTagExistedNameWithoutForce
22:25:27 [2019-11-06T22:25:27.122Z] --- PASS: TestTagExistedNameWithoutForce (0.05s)
22:25:27 [2019-11-06T22:25:27.122Z] === RUN TestTagOfficialNames
22:25:27 [2019-11-06T22:25:27.508Z] --- PASS: TestTagOfficialNames (0.05s)
22:25:27 [2019-11-06T22:25:27.508Z] === RUN TestTagMatchesDigest
22:25:27 [2019-11-06T22:25:27.508Z] --- PASS: TestTagMatchesDigest (0.01s)
22:25:27 [2019-11-06T22:25:27.508Z] === CONT TestImportExtremelyLargeImageWorks
22:27:37 [2019-11-06T22:27:37.253Z] --- PASS: TestImportExtremelyLargeImageWorks (118.22s)
22:27:37 [2019-11-06T22:27:37.253Z] PASS
22:27:37 [2019-11-06T22:27:37.253Z]
22:27:37 [2019-11-06T22:27:37.253Z] === Skipped
22:27:37 [2019-11-06T22:27:37.253Z] === SKIP: s390x.integration.image TestRemoveImageGarbageCollector (0.00s)
22:27:37 [2019-11-06T22:27:37.253Z] remove_unix_test.go:36: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:27:37 [2019-11-06T22:27:37.253Z]
22:27:37 [2019-11-06T22:27:37.253Z]
22:27:37 [2019-11-06T22:27:37.253Z] DONE 12 tests, 1 skipped in 119.812s
22:27:37 [2019-11-06T22:27:37.253Z] Running /go/src/github.com/docker/docker/integration/network (s390x.integration.network) flags=-test.v -test.timeout=120m
22:27:37 [2019-11-06T22:27:37.253Z] ++ 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
22:27:37 [2019-11-06T22:27:37.253Z] ++ set -e
22:27:37 [2019-11-06T22:27:37.253Z] ++ '[' -n 0 ']'
22:27:37 [2019-11-06T22:27:37.253Z] ++ set -x
22:27:37 [2019-11-06T22:27:37.253Z] ++ 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
22:27:37 [2019-11-06T22:27:37.253Z] INFO: Testing against a local daemon
22:27:37 [2019-11-06T22:27:37.253Z] === RUN TestNetworkCreateDelete
22:27:37 [2019-11-06T22:27:37.253Z] --- PASS: TestNetworkCreateDelete (0.11s)
22:27:37 [2019-11-06T22:27:37.253Z] === RUN TestDockerNetworkDeletePreferID
22:27:37 [2019-11-06T22:27:37.253Z] --- PASS: TestDockerNetworkDeletePreferID (0.36s)
22:27:37 [2019-11-06T22:27:37.253Z] === RUN TestInspectNetwork
22:27:37 [2019-11-06T22:27:37.253Z] === RUN TestInspectNetwork/full_network_id
22:27:37 [2019-11-06T22:27:37.253Z] === RUN TestInspectNetwork/partial_network_id
22:27:37 [2019-11-06T22:27:37.253Z] === RUN TestInspectNetwork/network_name
22:27:37 [2019-11-06T22:27:37.253Z] === RUN TestInspectNetwork/network_name_and_swarm_scope
22:27:37 [2019-11-06T22:27:37.253Z] --- PASS: TestInspectNetwork (8.68s)
22:27:37 [2019-11-06T22:27:37.253Z] --- PASS: TestInspectNetwork/full_network_id (0.00s)
22:27:37 [2019-11-06T22:27:37.253Z] --- PASS: TestInspectNetwork/partial_network_id (0.00s)
22:27:37 [2019-11-06T22:27:37.253Z] --- PASS: TestInspectNetwork/network_name (0.00s)
22:27:37 [2019-11-06T22:27:37.253Z] --- PASS: TestInspectNetwork/network_name_and_swarm_scope (0.00s)
22:27:37 [2019-11-06T22:27:37.253Z] === RUN TestRunContainerWithBridgeNone
22:27:37 [2019-11-06T22:27:37.703Z] --- PASS: TestRunContainerWithBridgeNone (2.67s)
22:27:37 [2019-11-06T22:27:37.703Z] === RUN TestNetworkInvalidJSON
22:27:37 [2019-11-06T22:27:37.703Z] === RUN TestNetworkInvalidJSON//networks/create
22:27:37 [2019-11-06T22:27:37.703Z] === PAUSE TestNetworkInvalidJSON//networks/create
22:27:37 [2019-11-06T22:27:37.703Z] === RUN TestNetworkInvalidJSON//networks/bridge/connect
22:27:37 [2019-11-06T22:27:37.703Z] === PAUSE TestNetworkInvalidJSON//networks/bridge/connect
22:27:37 [2019-11-06T22:27:37.703Z] === RUN TestNetworkInvalidJSON//networks/bridge/disconnect
22:27:37 [2019-11-06T22:27:37.703Z] === PAUSE TestNetworkInvalidJSON//networks/bridge/disconnect
22:27:37 [2019-11-06T22:27:37.703Z] === CONT TestNetworkInvalidJSON//networks/create
22:27:37 [2019-11-06T22:27:37.703Z] === CONT TestNetworkInvalidJSON//networks/bridge/disconnect
22:27:37 [2019-11-06T22:27:37.703Z] === CONT TestNetworkInvalidJSON//networks/bridge/connect
22:27:37 [2019-11-06T22:27:37.703Z] --- PASS: TestNetworkInvalidJSON (0.03s)
22:27:37 [2019-11-06T22:27:37.703Z] --- PASS: TestNetworkInvalidJSON//networks/create (0.00s)
22:27:37 [2019-11-06T22:27:37.703Z] --- PASS: TestNetworkInvalidJSON//networks/bridge/connect (0.00s)
22:27:37 [2019-11-06T22:27:37.703Z] --- PASS: TestNetworkInvalidJSON//networks/bridge/disconnect (0.00s)
22:27:37 [2019-11-06T22:27:37.703Z] === RUN TestDaemonRestartWithLiveRestore
22:27:38 [2019-11-06T22:27:38.539Z] --- PASS: TestDaemonRestartWithLiveRestore (1.05s)
22:27:38 [2019-11-06T22:27:38.539Z] === RUN TestDaemonDefaultNetworkPools
22:27:42 [2019-11-06T22:27:42.871Z] --- PASS: TestDaemonDefaultNetworkPools (0.74s)
22:27:42 [2019-11-06T22:27:42.871Z] === RUN TestDaemonRestartWithExistingNetwork
22:27:42 [2019-11-06T22:27:42.871Z] --- PASS: TestDaemonRestartWithExistingNetwork (1.15s)
22:27:42 [2019-11-06T22:27:42.871Z] === RUN TestDaemonRestartWithExistingNetworkWithDefaultPoolRange
22:27:42 [2019-11-06T22:27:42.871Z] --- PASS: TestDaemonRestartWithExistingNetworkWithDefaultPoolRange (1.23s)
22:27:42 [2019-11-06T22:27:42.871Z] === RUN TestDaemonWithBipAndDefaultNetworkPool
22:27:42 [2019-11-06T22:27:42.871Z] --- PASS: TestDaemonWithBipAndDefaultNetworkPool (0.62s)
22:27:42 [2019-11-06T22:27:42.871Z] === RUN TestServiceWithPredefinedNetwork
22:27:45 [2019-11-06T22:27:45.334Z] --- PASS: TestServiceWithPredefinedNetwork (3.04s)
22:27:45 [2019-11-06T22:27:45.334Z] === RUN TestServiceRemoveKeepsIngressNetwork
22:27:45 [2019-11-06T22:27:45.334Z] --- SKIP: TestServiceRemoveKeepsIngressNetwork (0.00s)
22:27:45 [2019-11-06T22:27:45.334Z] service_test.go:230: FLAKY_TEST
22:27:45 [2019-11-06T22:27:45.334Z] === RUN TestServiceWithDataPathPortInit
22:28:05 [2019-11-06T22:28:05.076Z] --- PASS: TestServiceWithDataPathPortInit (17.07s)
22:28:05 [2019-11-06T22:28:05.076Z] === RUN TestServiceWithDefaultAddressPoolInit
22:28:11 [2019-11-06T22:28:11.563Z] --- PASS: TestServiceWithDefaultAddressPoolInit (8.64s)
22:28:11 [2019-11-06T22:28:11.563Z] service_test.go:418: TestServiceWithDefaultAddressPoolInit: NetworkInspect: {Name:sthiraTestServiceWithDefaultAddressPoolInit ID:im7djj39kgw2n9iczq62jbgvt Created:2019-11-06 22:28:03.961786102 +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[f561ae7db5f9bfd54c53cc9ab17f079e61c8bc86552efe003167a681142a0ce0:{Name:TestServiceTestServiceWithDefaultAddressPoolInit.1.wnp3yxxfak0vlmp194tmvy321 EndpointID:da34026a4de71c75e908a88b74e028304ecdae9fcdfaaa1d19ea81534989ee96 MacAddress:02:42:14:14:00:03 IPv4Address:20.20.0.3/24 IPv6Address:} lb-sthiraTestServiceWithDefaultAddressPoolInit:{Name:sthiraTestServiceWithDefaultAddressPoolInit-endpoint EndpointID:f0315a5c520a3ee0900ca3551bd227bca0149ad459673184860fb71afdffd40e 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:b11e0ed7042b IP:127.0.0.1}] Services:map[TestServiceTestServiceWithDefaultAddressPoolInit:{VIP:20.20.0.2 Ports:[] LocalLBIndex:256 Tasks:[{Name:TestServiceTestServiceWithDefaultAddressPoolInit.1.wnp3yxxfak0vlmp194tmvy321 EndpointID:da34026a4de71c75e908a88b74e028304ecdae9fcdfaaa1d19ea81534989ee96 EndpointIP:20.20.0.3 Info:map[Host IP:127.0.0.1]}]}]}
22:28:11 [2019-11-06T22:28:11.563Z] PASS
22:28:11 [2019-11-06T22:28:11.563Z]
22:28:11 [2019-11-06T22:28:11.563Z] === Skipped
22:28:11 [2019-11-06T22:28:11.563Z] === SKIP: s390x.integration.network TestServiceRemoveKeepsIngressNetwork (0.00s)
22:28:11 [2019-11-06T22:28:11.563Z] service_test.go:230: FLAKY_TEST
22:28:11 [2019-11-06T22:28:11.563Z]
22:28:11 [2019-11-06T22:28:11.563Z]
22:28:11 [2019-11-06T22:28:11.563Z] DONE 21 tests, 1 skipped in 45.585s
22:28:11 [2019-11-06T22:28:11.563Z] Running /go/src/github.com/docker/docker/integration/network/ipvlan (s390x.integration.network.ipvlan) flags=-test.v -test.timeout=120m
22:28:11 [2019-11-06T22:28:11.563Z] ++ 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
22:28:11 [2019-11-06T22:28:11.563Z] ++ set -e
22:28:11 [2019-11-06T22:28:11.563Z] ++ '[' -n 0 ']'
22:28:11 [2019-11-06T22:28:11.563Z] ++ set -x
22:28:11 [2019-11-06T22:28:11.563Z] ++ 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
22:28:11 [2019-11-06T22:28:11.563Z] INFO: Testing against a local daemon
22:28:11 [2019-11-06T22:28:11.563Z] === RUN TestDockerNetworkIpvlanPersistance
22:28:11 [2019-11-06T22:28:11.563Z] --- SKIP: TestDockerNetworkIpvlanPersistance (0.00s)
22:28:11 [2019-11-06T22:28:11.563Z] ipvlan_test.go:26: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
22:28:11 [2019-11-06T22:28:11.563Z] === RUN TestDockerNetworkIpvlan
22:28:11 [2019-11-06T22:28:11.563Z] --- SKIP: TestDockerNetworkIpvlan (0.00s)
22:28:11 [2019-11-06T22:28:11.563Z] ipvlan_test.go:53: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
22:28:11 [2019-11-06T22:28:11.563Z] PASS
22:28:11 [2019-11-06T22:28:11.563Z]
22:28:11 [2019-11-06T22:28:11.563Z] === Skipped
22:28:11 [2019-11-06T22:28:11.563Z] === SKIP: s390x.integration.network.ipvlan TestDockerNetworkIpvlanPersistance (0.00s)
22:28:11 [2019-11-06T22:28:11.563Z] ipvlan_test.go:26: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
22:28:11 [2019-11-06T22:28:11.563Z]
22:28:11 [2019-11-06T22:28:11.563Z] === SKIP: s390x.integration.network.ipvlan TestDockerNetworkIpvlan (0.00s)
22:28:11 [2019-11-06T22:28:11.563Z] ipvlan_test.go:53: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
22:28:11 [2019-11-06T22:28:11.563Z]
22:28:11 [2019-11-06T22:28:11.563Z]
22:28:11 [2019-11-06T22:28:11.563Z] DONE 2 tests, 2 skipped in 0.121s
22:28:11 [2019-11-06T22:28:11.563Z] Running /go/src/github.com/docker/docker/integration/network/macvlan (s390x.integration.network.macvlan) flags=-test.v -test.timeout=120m
22:28:11 [2019-11-06T22:28:11.563Z] ++ 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
22:28:11 [2019-11-06T22:28:11.563Z] ++ set -e
22:28:11 [2019-11-06T22:28:11.563Z] ++ '[' -n 0 ']'
22:28:11 [2019-11-06T22:28:11.563Z] ++ set -x
22:28:11 [2019-11-06T22:28:11.563Z] ++ 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
22:28:11 [2019-11-06T22:28:11.563Z] INFO: Testing against a local daemon
22:28:11 [2019-11-06T22:28:11.563Z] === RUN TestDockerNetworkMacvlanPersistance
22:28:13 [2019-11-06T22:28:13.093Z] --- PASS: TestDockerNetworkMacvlanPersistance (1.41s)
22:28:13 [2019-11-06T22:28:13.094Z] === RUN TestDockerNetworkMacvlan
22:28:13 [2019-11-06T22:28:13.529Z] === RUN TestDockerNetworkMacvlan/Subinterface
22:28:14 [2019-11-06T22:28:14.382Z] === RUN TestDockerNetworkMacvlan/OverlapParent
22:28:15 [2019-11-06T22:28:15.735Z] === RUN TestDockerNetworkMacvlan/NilParent
22:28:18 [2019-11-06T22:28:18.182Z] === RUN TestDockerNetworkMacvlan/InternalMode
22:28:22 [2019-11-06T22:28:22.237Z] === RUN TestDockerNetworkMacvlan/MultiSubnet
22:28:27 [2019-11-06T22:28:27.678Z] === RUN TestDockerNetworkMacvlan/Addressing
22:28:28 [2019-11-06T22:28:28.491Z] --- PASS: TestDockerNetworkMacvlan (15.68s)
22:28:28 [2019-11-06T22:28:28.491Z] --- PASS: TestDockerNetworkMacvlan/Subinterface (0.06s)
22:28:28 [2019-11-06T22:28:28.491Z] --- PASS: TestDockerNetworkMacvlan/OverlapParent (0.12s)
22:28:28 [2019-11-06T22:28:28.491Z] --- PASS: TestDockerNetworkMacvlan/NilParent (1.25s)
22:28:28 [2019-11-06T22:28:28.491Z] --- PASS: TestDockerNetworkMacvlan/InternalMode (2.32s)
22:28:28 [2019-11-06T22:28:28.491Z] --- PASS: TestDockerNetworkMacvlan/MultiSubnet (3.40s)
22:28:28 [2019-11-06T22:28:28.491Z] --- PASS: TestDockerNetworkMacvlan/Addressing (0.98s)
22:28:28 [2019-11-06T22:28:28.491Z] PASS
22:28:28 [2019-11-06T22:28:28.491Z]
22:28:28 [2019-11-06T22:28:28.491Z] DONE 8 tests in 17.198s
22:28:28 [2019-11-06T22:28:28.491Z] Running /go/src/github.com/docker/docker/integration/plugin (s390x.integration.plugin) flags=-test.v -test.timeout=120m
22:28:28 [2019-11-06T22:28:28.491Z] ++ 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
22:28:28 [2019-11-06T22:28:28.491Z] ++ set -e
22:28:28 [2019-11-06T22:28:28.491Z] ++ '[' -n 0 ']'
22:28:28 [2019-11-06T22:28:28.491Z] ++ set -x
22:28:28 [2019-11-06T22:28:28.491Z] ++ 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
22:28:28 [2019-11-06T22:28:28.491Z] testing: warning: no tests to run
22:28:28 [2019-11-06T22:28:28.491Z] PASS
22:28:28 [2019-11-06T22:28:28.491Z]
22:28:28 [2019-11-06T22:28:28.491Z] DONE 0 tests in 0.056s
22:28:28 [2019-11-06T22:28:28.491Z] Running /go/src/github.com/docker/docker/integration/plugin/authz (s390x.integration.plugin.authz) flags=-test.v -test.timeout=120m
22:28:28 [2019-11-06T22:28:28.491Z] ++ 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
22:28:28 [2019-11-06T22:28:28.491Z] ++ set -e
22:28:28 [2019-11-06T22:28:28.491Z] ++ '[' -n 0 ']'
22:28:28 [2019-11-06T22:28:28.491Z] ++ set -x
22:28:28 [2019-11-06T22:28:28.491Z] ++ 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
22:28:28 [2019-11-06T22:28:28.865Z] INFO: Testing against a local daemon
22:28:28 [2019-11-06T22:28:28.865Z] === RUN TestAuthZPluginAllowRequest
22:28:30 [2019-11-06T22:28:30.685Z] --- PASS: TestAuthZPluginAllowRequest (1.75s)
22:28:30 [2019-11-06T22:28:30.685Z] === RUN TestAuthZPluginTLS
22:28:31 [2019-11-06T22:28:31.060Z] --- PASS: TestAuthZPluginTLS (0.57s)
22:28:31 [2019-11-06T22:28:31.060Z] === RUN TestAuthZPluginDenyRequest
22:28:31 [2019-11-06T22:28:31.862Z] --- PASS: TestAuthZPluginDenyRequest (0.55s)
22:28:31 [2019-11-06T22:28:31.862Z] === RUN TestAuthZPluginAPIDenyResponse
22:28:32 [2019-11-06T22:28:32.238Z] --- PASS: TestAuthZPluginAPIDenyResponse (0.54s)
22:28:32 [2019-11-06T22:28:32.238Z] === RUN TestAuthZPluginDenyResponse
22:28:32 [2019-11-06T22:28:32.613Z] --- PASS: TestAuthZPluginDenyResponse (0.54s)
22:28:32 [2019-11-06T22:28:32.613Z] === RUN TestAuthZPluginAllowEventStream
22:28:34 [2019-11-06T22:28:34.461Z] --- PASS: TestAuthZPluginAllowEventStream (1.85s)
22:28:34 [2019-11-06T22:28:34.461Z] === RUN TestAuthZPluginErrorResponse
22:28:35 [2019-11-06T22:28:35.238Z] --- PASS: TestAuthZPluginErrorResponse (0.56s)
22:28:35 [2019-11-06T22:28:35.238Z] === RUN TestAuthZPluginErrorRequest
22:28:35 [2019-11-06T22:28:35.622Z] --- PASS: TestAuthZPluginErrorRequest (0.54s)
22:28:35 [2019-11-06T22:28:35.622Z] === RUN TestAuthZPluginEnsureNoDuplicatePluginRegistration
22:28:36 [2019-11-06T22:28:36.409Z] --- PASS: TestAuthZPluginEnsureNoDuplicatePluginRegistration (0.55s)
22:28:36 [2019-11-06T22:28:36.410Z] === RUN TestAuthZPluginEnsureLoadImportWorking
22:28:38 [2019-11-06T22:28:38.242Z] --- PASS: TestAuthZPluginEnsureLoadImportWorking (2.16s)
22:28:38 [2019-11-06T22:28:38.242Z] === RUN TestAuthzPluginEnsureContainerCopyToFrom
22:28:40 [2019-11-06T22:28:40.890Z] --- PASS: TestAuthzPluginEnsureContainerCopyToFrom (2.34s)
22:28:40 [2019-11-06T22:28:40.890Z] === RUN TestAuthZPluginHeader
22:28:41 [2019-11-06T22:28:41.801Z] --- PASS: TestAuthZPluginHeader (0.94s)
22:28:41 [2019-11-06T22:28:41.801Z] === RUN TestAuthZPluginV2AllowNonVolumeRequest
22:28:41 [2019-11-06T22:28:41.801Z] --- SKIP: TestAuthZPluginV2AllowNonVolumeRequest (0.00s)
22:28:41 [2019-11-06T22:28:41.801Z] authz_plugin_v2_test.go:43: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:28:41 [2019-11-06T22:28:41.801Z] === RUN TestAuthZPluginV2Disable
22:28:41 [2019-11-06T22:28:41.801Z] --- SKIP: TestAuthZPluginV2Disable (0.00s)
22:28:41 [2019-11-06T22:28:41.801Z] authz_plugin_v2_test.go:65: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:28:41 [2019-11-06T22:28:41.801Z] === RUN TestAuthZPluginV2RejectVolumeRequests
22:28:41 [2019-11-06T22:28:41.801Z] --- SKIP: TestAuthZPluginV2RejectVolumeRequests (0.00s)
22:28:41 [2019-11-06T22:28:41.801Z] authz_plugin_v2_test.go:91: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:28:41 [2019-11-06T22:28:41.801Z] === RUN TestAuthZPluginV2BadManifestFailsDaemonStart
22:28:41 [2019-11-06T22:28:41.801Z] --- SKIP: TestAuthZPluginV2BadManifestFailsDaemonStart (0.00s)
22:28:41 [2019-11-06T22:28:41.801Z] authz_plugin_v2_test.go:126: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:28:41 [2019-11-06T22:28:41.801Z] === RUN TestAuthZPluginV2NonexistentFailsDaemonStart
22:29:01 [2019-11-06T22:29:01.455Z] --- PASS: TestAuthZPluginV2NonexistentFailsDaemonStart (16.83s)
22:29:01 [2019-11-06T22:29:01.455Z] PASS
22:29:01 [2019-11-06T22:29:01.455Z]
22:29:01 [2019-11-06T22:29:01.455Z] === Skipped
22:29:01 [2019-11-06T22:29:01.455Z] === SKIP: s390x.integration.plugin.authz TestAuthZPluginV2AllowNonVolumeRequest (0.00s)
22:29:01 [2019-11-06T22:29:01.455Z] authz_plugin_v2_test.go:43: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:29:01 [2019-11-06T22:29:01.455Z]
22:29:01 [2019-11-06T22:29:01.455Z] === SKIP: s390x.integration.plugin.authz TestAuthZPluginV2Disable (0.00s)
22:29:01 [2019-11-06T22:29:01.455Z] authz_plugin_v2_test.go:65: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:29:01 [2019-11-06T22:29:01.455Z]
22:29:01 [2019-11-06T22:29:01.455Z] === SKIP: s390x.integration.plugin.authz TestAuthZPluginV2RejectVolumeRequests (0.00s)
22:29:01 [2019-11-06T22:29:01.455Z] authz_plugin_v2_test.go:91: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:29:01 [2019-11-06T22:29:01.455Z]
22:29:01 [2019-11-06T22:29:01.455Z] === SKIP: s390x.integration.plugin.authz TestAuthZPluginV2BadManifestFailsDaemonStart (0.00s)
22:29:01 [2019-11-06T22:29:01.455Z] authz_plugin_v2_test.go:126: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:29:01 [2019-11-06T22:29:01.455Z]
22:29:01 [2019-11-06T22:29:01.455Z]
22:29:01 [2019-11-06T22:29:01.455Z] DONE 17 tests, 4 skipped in 29.892s
22:29:01 [2019-11-06T22:29:01.455Z] Running /go/src/github.com/docker/docker/integration/plugin/common (s390x.integration.plugin.common) flags=-test.v -test.timeout=120m
22:29:01 [2019-11-06T22:29:01.455Z] ++ 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
22:29:01 [2019-11-06T22:29:01.455Z] ++ set -e
22:29:01 [2019-11-06T22:29:01.455Z] ++ '[' -n 0 ']'
22:29:01 [2019-11-06T22:29:01.455Z] ++ set -x
22:29:01 [2019-11-06T22:29:01.455Z] ++ 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
22:29:01 [2019-11-06T22:29:01.455Z] INFO: Testing against a local daemon
22:29:01 [2019-11-06T22:29:01.455Z] === RUN TestPluginInvalidJSON
22:29:01 [2019-11-06T22:29:01.455Z] === RUN TestPluginInvalidJSON//plugins/foobar/set
22:29:01 [2019-11-06T22:29:01.455Z] === PAUSE TestPluginInvalidJSON//plugins/foobar/set
22:29:01 [2019-11-06T22:29:01.455Z] === CONT TestPluginInvalidJSON//plugins/foobar/set
22:29:01 [2019-11-06T22:29:01.455Z] --- PASS: TestPluginInvalidJSON (0.02s)
22:29:01 [2019-11-06T22:29:01.455Z] --- PASS: TestPluginInvalidJSON//plugins/foobar/set (0.00s)
22:29:01 [2019-11-06T22:29:01.455Z] PASS
22:29:01 [2019-11-06T22:29:01.455Z]
22:29:01 [2019-11-06T22:29:01.455Z] DONE 2 tests in 0.142s
22:29:01 [2019-11-06T22:29:01.455Z] Running /go/src/github.com/docker/docker/integration/plugin/graphdriver (s390x.integration.plugin.graphdriver) flags=-test.v -test.timeout=120m
22:29:01 [2019-11-06T22:29:01.455Z] ++ 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
22:29:01 [2019-11-06T22:29:01.455Z] ++ set -e
22:29:01 [2019-11-06T22:29:01.455Z] ++ '[' -n 0 ']'
22:29:01 [2019-11-06T22:29:01.455Z] ++ set -x
22:29:01 [2019-11-06T22:29:01.456Z] ++ 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
22:29:01 [2019-11-06T22:29:01.456Z] INFO: Testing against a local daemon
22:29:01 [2019-11-06T22:29:01.456Z] === RUN TestExternalGraphDriver
22:29:01 [2019-11-06T22:29:01.456Z] === RUN TestExternalGraphDriver/json
22:29:01 [2019-11-06T22:29:01.456Z] === RUN TestExternalGraphDriver/spec
22:29:03 [2019-11-06T22:29:03.297Z] === RUN TestExternalGraphDriver/pull
22:29:05 [2019-11-06T22:29:05.333Z] --- PASS: TestExternalGraphDriver (6.57s)
22:29:05 [2019-11-06T22:29:05.333Z] --- PASS: TestExternalGraphDriver/json (2.15s)
22:29:05 [2019-11-06T22:29:05.333Z] --- PASS: TestExternalGraphDriver/spec (2.17s)
22:29:05 [2019-11-06T22:29:05.333Z] --- PASS: TestExternalGraphDriver/pull (2.08s)
22:29:05 [2019-11-06T22:29:05.333Z] === RUN TestGraphdriverPluginV2
22:29:05 [2019-11-06T22:29:05.333Z] --- SKIP: TestGraphdriverPluginV2 (0.05s)
22:29:05 [2019-11-06T22:29:05.333Z] external_test.go:410: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:29:05 [2019-11-06T22:29:05.333Z] PASS
22:29:05 [2019-11-06T22:29:05.333Z]
22:29:05 [2019-11-06T22:29:05.333Z] === Skipped
22:29:05 [2019-11-06T22:29:05.333Z] === SKIP: s390x.integration.plugin.graphdriver TestGraphdriverPluginV2 (0.05s)
22:29:05 [2019-11-06T22:29:05.333Z] external_test.go:410: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:29:05 [2019-11-06T22:29:05.333Z]
22:29:05 [2019-11-06T22:29:05.333Z]
22:29:05 [2019-11-06T22:29:05.333Z] DONE 5 tests, 1 skipped in 6.741s
22:29:05 [2019-11-06T22:29:05.333Z] Running /go/src/github.com/docker/docker/integration/plugin/logging (s390x.integration.plugin.logging) flags=-test.v -test.timeout=120m
22:29:05 [2019-11-06T22:29:05.333Z] ++ 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
22:29:05 [2019-11-06T22:29:05.333Z] ++ set -e
22:29:05 [2019-11-06T22:29:05.333Z] ++ '[' -n 0 ']'
22:29:05 [2019-11-06T22:29:05.333Z] ++ set -x
22:29:05 [2019-11-06T22:29:05.333Z] ++ 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
22:29:05 [2019-11-06T22:29:05.709Z] INFO: Testing against a local daemon
22:29:05 [2019-11-06T22:29:05.709Z] === RUN TestContinueAfterPluginCrash
22:29:05 [2019-11-06T22:29:05.709Z] === PAUSE TestContinueAfterPluginCrash
22:29:05 [2019-11-06T22:29:05.709Z] === RUN TestDaemonStartWithLogOpt
22:29:05 [2019-11-06T22:29:05.709Z] === PAUSE TestDaemonStartWithLogOpt
22:29:05 [2019-11-06T22:29:05.709Z] === CONT TestContinueAfterPluginCrash
22:29:05 [2019-11-06T22:29:05.709Z] === CONT TestDaemonStartWithLogOpt
22:29:17 [2019-11-06T22:29:17.268Z] --- PASS: TestDaemonStartWithLogOpt (9.99s)
22:29:21 [2019-11-06T22:29:21.285Z] --- PASS: TestContinueAfterPluginCrash (15.27s)
22:29:21 [2019-11-06T22:29:21.285Z] PASS
22:29:21 [2019-11-06T22:29:21.285Z]
22:29:21 [2019-11-06T22:29:21.285Z] DONE 2 tests in 15.454s
22:29:21 [2019-11-06T22:29:21.285Z] Running /go/src/github.com/docker/docker/integration/plugin/volumes (s390x.integration.plugin.volumes) flags=-test.v -test.timeout=120m
22:29:21 [2019-11-06T22:29:21.285Z] ++ 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
22:29:21 [2019-11-06T22:29:21.285Z] ++ set -e
22:29:21 [2019-11-06T22:29:21.285Z] ++ '[' -n 0 ']'
22:29:21 [2019-11-06T22:29:21.285Z] ++ set -x
22:29:21 [2019-11-06T22:29:21.285Z] ++ 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
22:29:21 [2019-11-06T22:29:21.285Z] INFO: Testing against a local daemon
22:29:21 [2019-11-06T22:29:21.285Z] === RUN TestPluginWithDevMounts
22:29:21 [2019-11-06T22:29:21.285Z] === PAUSE TestPluginWithDevMounts
22:29:21 [2019-11-06T22:29:21.285Z] === CONT TestPluginWithDevMounts
22:29:23 [2019-11-06T22:29:23.110Z] --- PASS: TestPluginWithDevMounts (2.02s)
22:29:23 [2019-11-06T22:29:23.110Z] PASS
22:29:23 [2019-11-06T22:29:23.110Z]
22:29:23 [2019-11-06T22:29:23.110Z] DONE 1 tests in 2.155s
22:29:23 [2019-11-06T22:29:23.110Z] Running /go/src/github.com/docker/docker/integration/secret (s390x.integration.secret) flags=-test.v -test.timeout=120m
22:29:23 [2019-11-06T22:29:23.110Z] ++ 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
22:29:23 [2019-11-06T22:29:23.110Z] ++ set -e
22:29:23 [2019-11-06T22:29:23.110Z] ++ '[' -n 0 ']'
22:29:23 [2019-11-06T22:29:23.110Z] ++ set -x
22:29:23 [2019-11-06T22:29:23.110Z] ++ 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
22:29:23 [2019-11-06T22:29:23.110Z] INFO: Testing against a local daemon
22:29:23 [2019-11-06T22:29:23.110Z] === RUN TestSecretInspect
22:29:26 [2019-11-06T22:29:26.291Z] --- PASS: TestSecretInspect (2.92s)
22:29:26 [2019-11-06T22:29:26.291Z] === RUN TestSecretList
22:29:29 [2019-11-06T22:29:29.274Z] --- PASS: TestSecretList (3.07s)
22:29:29 [2019-11-06T22:29:29.274Z] === RUN TestSecretsCreateAndDelete
22:29:32 [2019-11-06T22:29:32.477Z] --- PASS: TestSecretsCreateAndDelete (2.92s)
22:29:32 [2019-11-06T22:29:32.477Z] === RUN TestSecretsUpdate
22:29:34 [2019-11-06T22:29:34.931Z] --- PASS: TestSecretsUpdate (2.96s)
22:29:34 [2019-11-06T22:29:34.931Z] === RUN TestTemplatedSecret
22:29:39 [2019-11-06T22:29:39.015Z] --- PASS: TestTemplatedSecret (3.54s)
22:29:39 [2019-11-06T22:29:39.015Z] === RUN TestSecretCreateResolve
22:29:41 [2019-11-06T22:29:41.739Z] --- PASS: TestSecretCreateResolve (2.69s)
22:29:41 [2019-11-06T22:29:41.739Z] PASS
22:29:41 [2019-11-06T22:29:41.739Z]
22:29:41 [2019-11-06T22:29:41.739Z] DONE 6 tests in 18.252s
22:29:41 [2019-11-06T22:29:41.739Z] Running /go/src/github.com/docker/docker/integration/service (s390x.integration.service) flags=-test.v -test.timeout=120m
22:29:41 [2019-11-06T22:29:41.739Z] ++ 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
22:29:41 [2019-11-06T22:29:41.739Z] ++ set -e
22:29:41 [2019-11-06T22:29:41.739Z] ++ '[' -n 0 ']'
22:29:41 [2019-11-06T22:29:41.739Z] ++ set -x
22:29:41 [2019-11-06T22:29:41.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-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
22:29:41 [2019-11-06T22:29:41.740Z] INFO: Testing against a local daemon
22:29:41 [2019-11-06T22:29:41.740Z] === RUN TestServiceCreateInit
22:29:41 [2019-11-06T22:29:41.740Z] === RUN TestServiceCreateInit/daemonInitDisabled
22:29:46 [2019-11-06T22:29:46.826Z] === RUN TestServiceCreateInit/daemonInitEnabled
22:29:51 [2019-11-06T22:29:51.914Z] --- PASS: TestServiceCreateInit (10.45s)
22:29:51 [2019-11-06T22:29:51.914Z] --- PASS: TestServiceCreateInit/daemonInitDisabled (5.29s)
22:29:51 [2019-11-06T22:29:51.914Z] --- PASS: TestServiceCreateInit/daemonInitEnabled (5.14s)
22:29:51 [2019-11-06T22:29:51.914Z] === RUN TestCreateServiceMultipleTimes
22:30:11 [2019-11-06T22:30:11.956Z] --- PASS: TestCreateServiceMultipleTimes (18.37s)
22:30:11 [2019-11-06T22:30:11.956Z] === RUN TestCreateServiceConflict
22:30:13 [2019-11-06T22:30:13.219Z] --- PASS: TestCreateServiceConflict (2.84s)
22:30:13 [2019-11-06T22:30:13.219Z] === RUN TestCreateServiceMaxReplicas
22:30:17 [2019-11-06T22:30:17.313Z] --- PASS: TestCreateServiceMaxReplicas (3.71s)
22:30:17 [2019-11-06T22:30:17.313Z] === RUN TestCreateWithDuplicateNetworkNames
22:30:30 [2019-11-06T22:30:30.906Z] --- PASS: TestCreateWithDuplicateNetworkNames (14.07s)
22:30:30 [2019-11-06T22:30:30.906Z] === RUN TestCreateServiceSecretFileMode
22:30:34 [2019-11-06T22:30:34.341Z] --- PASS: TestCreateServiceSecretFileMode (3.34s)
22:30:34 [2019-11-06T22:30:34.341Z] === RUN TestCreateServiceConfigFileMode
22:30:37 [2019-11-06T22:30:37.560Z] --- PASS: TestCreateServiceConfigFileMode (3.32s)
22:30:37 [2019-11-06T22:30:37.560Z] === RUN TestCreateServiceSysctls
22:30:42 [2019-11-06T22:30:42.651Z] --- PASS: TestCreateServiceSysctls (4.31s)
22:30:42 [2019-11-06T22:30:42.651Z] === RUN TestCreateServiceCapabilities
22:30:45 [2019-11-06T22:30:45.091Z] --- PASS: TestCreateServiceCapabilities (3.24s)
22:30:45 [2019-11-06T22:30:45.091Z] === RUN TestInspect
22:30:49 [2019-11-06T22:30:49.180Z] --- PASS: TestInspect (3.57s)
22:30:49 [2019-11-06T22:30:49.180Z] === RUN TestServiceListWithStatuses
22:30:49 [2019-11-06T22:30:49.180Z] --- SKIP: TestServiceListWithStatuses (0.00s)
22:30:49 [2019-11-06T22:30:49.180Z] list_test.go:34: versions.LessThan(testEnv.DaemonInfo.ServerVersion, "1.41")
22:30:49 [2019-11-06T22:30:49.180Z] === RUN TestDockerNetworkConnectAlias
22:30:55 [2019-11-06T22:30:55.678Z] --- PASS: TestDockerNetworkConnectAlias (6.19s)
22:30:55 [2019-11-06T22:30:55.678Z] === RUN TestDockerNetworkReConnect
22:30:59 [2019-11-06T22:30:59.734Z] --- PASS: TestDockerNetworkReConnect (4.92s)
22:30:59 [2019-11-06T22:30:59.734Z] === RUN TestServicePlugin
22:30:59 [2019-11-06T22:30:59.734Z] --- SKIP: TestServicePlugin (0.00s)
22:30:59 [2019-11-06T22:30:59.734Z] plugin_test.go:28: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:30:59 [2019-11-06T22:30:59.734Z] === RUN TestServiceUpdateLabel
22:31:02 [2019-11-06T22:31:02.260Z] --- PASS: TestServiceUpdateLabel (2.47s)
22:31:02 [2019-11-06T22:31:02.260Z] === RUN TestServiceUpdateSecrets
22:31:18 [2019-11-06T22:31:18.809Z] --- PASS: TestServiceUpdateSecrets (15.77s)
22:31:18 [2019-11-06T22:31:18.809Z] === RUN TestServiceUpdateConfigs
22:31:35 [2019-11-06T22:31:35.159Z] --- PASS: TestServiceUpdateConfigs (15.52s)
22:31:35 [2019-11-06T22:31:35.159Z] === RUN TestServiceUpdateNetwork
22:31:48 [2019-11-06T22:31:48.831Z] --- PASS: TestServiceUpdateNetwork (14.49s)
22:31:48 [2019-11-06T22:31:48.831Z] PASS
22:31:48 [2019-11-06T22:31:48.831Z]
22:31:48 [2019-11-06T22:31:48.831Z] === Skipped
22:31:48 [2019-11-06T22:31:48.831Z] === SKIP: s390x.integration.service TestServiceListWithStatuses (0.00s)
22:31:48 [2019-11-06T22:31:48.831Z] list_test.go:34: versions.LessThan(testEnv.DaemonInfo.ServerVersion, "1.41")
22:31:48 [2019-11-06T22:31:48.831Z]
22:31:48 [2019-11-06T22:31:48.831Z] === SKIP: s390x.integration.service TestServicePlugin (0.00s)
22:31:48 [2019-11-06T22:31:48.831Z] plugin_test.go:28: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
22:31:48 [2019-11-06T22:31:48.831Z]
22:31:48 [2019-11-06T22:31:48.831Z]
22:31:48 [2019-11-06T22:31:48.831Z] DONE 20 tests, 2 skipped in 126.768s
22:31:48 [2019-11-06T22:31:48.831Z] Running /go/src/github.com/docker/docker/integration/session (s390x.integration.session) flags=-test.v -test.timeout=120m
22:31:48 [2019-11-06T22:31:48.831Z] ++ 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
22:31:48 [2019-11-06T22:31:48.831Z] ++ set -e
22:31:48 [2019-11-06T22:31:48.831Z] ++ '[' -n 0 ']'
22:31:48 [2019-11-06T22:31:48.831Z] ++ set -x
22:31:48 [2019-11-06T22:31:48.831Z] ++ 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
22:31:48 [2019-11-06T22:31:48.832Z] INFO: Testing against a local daemon
22:31:48 [2019-11-06T22:31:48.832Z] === RUN TestSessionCreate
22:31:48 [2019-11-06T22:31:48.832Z] --- PASS: TestSessionCreate (0.03s)
22:31:48 [2019-11-06T22:31:48.832Z] === RUN TestSessionCreateWithBadUpgrade
22:31:48 [2019-11-06T22:31:48.832Z] --- PASS: TestSessionCreateWithBadUpgrade (0.03s)
22:31:48 [2019-11-06T22:31:48.832Z] PASS
22:31:48 [2019-11-06T22:31:48.832Z]
22:31:48 [2019-11-06T22:31:48.832Z] DONE 2 tests in 0.261s
22:31:48 [2019-11-06T22:31:48.832Z] Running /go/src/github.com/docker/docker/integration/system (s390x.integration.system) flags=-test.v -test.timeout=120m
22:31:48 [2019-11-06T22:31:48.832Z] ++ 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
22:31:48 [2019-11-06T22:31:48.832Z] ++ set -e
22:31:48 [2019-11-06T22:31:48.832Z] ++ '[' -n 0 ']'
22:31:48 [2019-11-06T22:31:48.832Z] ++ set -x
22:31:48 [2019-11-06T22:31:48.832Z] ++ 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
22:31:48 [2019-11-06T22:31:48.832Z] INFO: Testing against a local daemon
22:31:48 [2019-11-06T22:31:48.832Z] === RUN TestCgroupDriverSystemdMemoryLimit
22:31:48 [2019-11-06T22:31:48.832Z] --- SKIP: TestCgroupDriverSystemdMemoryLimit (0.00s)
22:31:48 [2019-11-06T22:31:48.832Z] cgroupdriver_systemd_test.go:32: !hasSystemd()
22:31:48 [2019-11-06T22:31:48.832Z] === RUN TestEventsExecDie
22:31:49 [2019-11-06T22:31:49.628Z] --- PASS: TestEventsExecDie (0.98s)
22:31:49 [2019-11-06T22:31:49.628Z] === RUN TestEventsBackwardsCompatible
22:31:49 [2019-11-06T22:31:49.628Z] --- PASS: TestEventsBackwardsCompatible (0.11s)
22:31:49 [2019-11-06T22:31:49.628Z] === RUN TestInfoBinaryCommits
22:31:49 [2019-11-06T22:31:49.628Z] --- PASS: TestInfoBinaryCommits (0.02s)
22:31:49 [2019-11-06T22:31:49.628Z] === RUN TestInfoAPIVersioned
22:31:49 [2019-11-06T22:31:49.628Z] --- PASS: TestInfoAPIVersioned (0.01s)
22:31:49 [2019-11-06T22:31:49.628Z] === RUN TestInfoDiscoveryBackend
22:31:50 [2019-11-06T22:31:50.022Z] --- PASS: TestInfoDiscoveryBackend (0.54s)
22:31:50 [2019-11-06T22:31:50.022Z] === RUN TestInfoDiscoveryInvalidAdvertise
22:31:51 [2019-11-06T22:31:51.268Z] --- PASS: TestInfoDiscoveryInvalidAdvertise (1.00s)
22:31:51 [2019-11-06T22:31:51.269Z] === RUN TestInfoDiscoveryAdvertiseInterfaceName
22:31:51 [2019-11-06T22:31:51.635Z] --- PASS: TestInfoDiscoveryAdvertiseInterfaceName (0.53s)
22:31:51 [2019-11-06T22:31:51.635Z] === RUN TestInfoAPI
22:31:51 [2019-11-06T22:31:51.635Z] --- PASS: TestInfoAPI (0.02s)
22:31:51 [2019-11-06T22:31:51.635Z] === RUN TestInfoAPIWarnings
22:31:52 [2019-11-06T22:31:52.428Z] --- PASS: TestInfoAPIWarnings (0.54s)
22:31:52 [2019-11-06T22:31:52.428Z] === RUN TestInfoDebug
22:31:52 [2019-11-06T22:31:52.792Z] --- PASS: TestInfoDebug (0.53s)
22:31:52 [2019-11-06T22:31:52.792Z] === RUN TestInfoInsecureRegistries
22:31:53 [2019-11-06T22:31:53.172Z] --- PASS: TestInfoInsecureRegistries (0.54s)
22:31:53 [2019-11-06T22:31:53.172Z] === RUN TestInfoRegistryMirrors
22:31:54 [2019-11-06T22:31:54.067Z] --- PASS: TestInfoRegistryMirrors (0.53s)
22:31:54 [2019-11-06T22:31:54.067Z] === RUN TestLoginFailsWithBadCredentials
22:31:54 [2019-11-06T22:31:54.067Z] --- PASS: TestLoginFailsWithBadCredentials (0.36s)
22:31:54 [2019-11-06T22:31:54.067Z] === RUN TestPingCacheHeaders
22:31:54 [2019-11-06T22:31:54.067Z] --- PASS: TestPingCacheHeaders (0.02s)
22:31:54 [2019-11-06T22:31:54.067Z] === RUN TestPingGet
22:31:54 [2019-11-06T22:31:54.470Z] --- PASS: TestPingGet (0.06s)
22:31:54 [2019-11-06T22:31:54.470Z] === RUN TestPingHead
22:31:54 [2019-11-06T22:31:54.470Z] --- PASS: TestPingHead (0.03s)
22:31:54 [2019-11-06T22:31:54.470Z] === RUN TestVersion
22:31:54 [2019-11-06T22:31:54.470Z] --- PASS: TestVersion (0.02s)
22:31:54 [2019-11-06T22:31:54.470Z] PASS
22:31:54 [2019-11-06T22:31:54.470Z]
22:31:54 [2019-11-06T22:31:54.470Z] === Skipped
22:31:54 [2019-11-06T22:31:54.470Z] === SKIP: s390x.integration.system TestCgroupDriverSystemdMemoryLimit (0.00s)
22:31:54 [2019-11-06T22:31:54.470Z] cgroupdriver_systemd_test.go:32: !hasSystemd()
22:31:54 [2019-11-06T22:31:54.470Z]
22:31:54 [2019-11-06T22:31:54.470Z]
22:31:54 [2019-11-06T22:31:54.470Z] DONE 18 tests, 1 skipped in 5.952s
22:31:54 [2019-11-06T22:31:54.470Z] Running /go/src/github.com/docker/docker/integration/volume (s390x.integration.volume) flags=-test.v -test.timeout=120m
22:31:54 [2019-11-06T22:31:54.470Z] ++ 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
22:31:54 [2019-11-06T22:31:54.470Z] ++ set -e
22:31:54 [2019-11-06T22:31:54.470Z] ++ '[' -n 0 ']'
22:31:54 [2019-11-06T22:31:54.470Z] ++ set -x
22:31:54 [2019-11-06T22:31:54.470Z] ++ 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
22:31:54 [2019-11-06T22:31:54.470Z] INFO: Testing against a local daemon
22:31:54 [2019-11-06T22:31:54.470Z] === RUN TestVolumesCreateAndList
22:31:54 [2019-11-06T22:31:54.470Z] --- PASS: TestVolumesCreateAndList (0.02s)
22:31:54 [2019-11-06T22:31:54.470Z] === RUN TestVolumesRemove
22:31:54 [2019-11-06T22:31:54.470Z] --- PASS: TestVolumesRemove (0.13s)
22:31:54 [2019-11-06T22:31:54.470Z] === RUN TestVolumesInspect
22:31:54 [2019-11-06T22:31:54.470Z] --- PASS: TestVolumesInspect (0.02s)
22:31:54 [2019-11-06T22:31:54.470Z] === RUN TestVolumesInvalidJSON
22:31:54 [2019-11-06T22:31:54.470Z] === RUN TestVolumesInvalidJSON//volumes/create
22:31:54 [2019-11-06T22:31:54.470Z] === PAUSE TestVolumesInvalidJSON//volumes/create
22:31:54 [2019-11-06T22:31:54.470Z] === CONT TestVolumesInvalidJSON//volumes/create
22:31:54 [2019-11-06T22:31:54.470Z] --- PASS: TestVolumesInvalidJSON (0.02s)
22:31:54 [2019-11-06T22:31:54.470Z] --- PASS: TestVolumesInvalidJSON//volumes/create (0.00s)
22:31:54 [2019-11-06T22:31:54.470Z] PASS
22:31:54 [2019-11-06T22:31:54.470Z]
22:31:54 [2019-11-06T22:31:54.470Z] DONE 5 tests in 0.295s
22:31:54 [2019-11-06T22:31:54.837Z] ---> Making bundle: .integration-daemon-stop (in bundles/test-integration)
22:31:54 [2019-11-06T22:31:54.837Z] ++++ cat bundles/test-integration/docker.pid
22:31:54 [2019-11-06T22:31:54.837Z] +++ kill 11508
22:31:56 [2019-11-06T22:31:56.635Z] +++ /etc/init.d/apparmor stop
22:31:56 [2019-11-06T22:31:56.635Z] Clearing AppArmor profiles cache:.
22:31:56 [2019-11-06T22:31:56.635Z] All profile caches have been cleared, but no profiles have been unloaded.
22:31:56 [2019-11-06T22:31:56.635Z] Unloading profiles will leave already running processes permanently
22:31:56 [2019-11-06T22:31:56.635Z] unconfined, which can lead to unexpected situations.
22:31:56 [2019-11-06T22:31:56.635Z]
22:31:56 [2019-11-06T22:31:56.635Z] To set a process to complain mode, use the command line tool
22:31:56 [2019-11-06T22:31:56.635Z] 'aa-complain'. To really tear down all profiles, run the init script
22:31:56 [2019-11-06T22:31:56.635Z] with the 'teardown' option."
22:31:56 [2019-11-06T22:31:56.635Z]