Console Output

01:24:24 [2020-02-11T01:24:24.544Z] + docker run --rm -t --privileged -v /home/jenkins/workspace/moby_PR-39086/bundles:/go/src/github.com/docker/docker/bundles --name docker-pr7 -e DOCKER_EXPERIMENTAL -e DOCKER_GITCOMMIT=008fc679742b1f6dc386b728887573987ac09feb -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:008fc679742b1f6dc386b728887573987ac09feb hack/make.sh dynbinary test-integration
01:24:24 [2020-02-11T01:24:24.910Z] 
01:24:24 [2020-02-11T01:24:24.910Z] Removing bundles/
01:24:24 [2020-02-11T01:24:24.910Z] 
01:24:24 [2020-02-11T01:24:24.910Z] ---> Making bundle: dynbinary (in bundles/dynbinary)
01:24:24 [2020-02-11T01:24:24.910Z] Building: bundles/dynbinary-daemon/dockerd-dev
01:24:24 [2020-02-11T01:24:24.910Z] GOOS="" GOARCH="" GOARM=""
01:25:23 [2020-02-11T01:25:23.284Z] Created binary: bundles/dynbinary-daemon/dockerd-dev
01:25:23 [2020-02-11T01:25:23.284Z] 
01:25:23 [2020-02-11T01:25:23.284Z] ---> Making bundle: test-integration (in bundles/test-integration)
01:25:23 [2020-02-11T01:25:23.284Z] SCRIPTDIR=/go/src/github.com/docker/docker/hack
01:25:23 [2020-02-11T01:25:23.284Z] HOSTNAME=ec497cc43a73
01:25:23 [2020-02-11T01:25:23.284Z] TESTDEBUG=0
01:25:23 [2020-02-11T01:25:23.284Z] DEST=bundles/test-integration
01:25:23 [2020-02-11T01:25:23.284Z] PWD=/go/src/github.com/docker/docker
01:25:23 [2020-02-11T01:25:23.284Z] DOCKER_GITCOMMIT=008fc679742b1f6dc386b728887573987ac09feb
01:25:23 [2020-02-11T01:25:23.284Z] container=docker
01:25:23 [2020-02-11T01:25:23.284Z] HOME=/root
01:25:23 [2020-02-11T01:25:23.284Z] GOLANG_VERSION=1.13.7
01:25:23 [2020-02-11T01:25:23.284Z] VALIDATE_REPO=https://github.com/moby/moby.git
01:25:23 [2020-02-11T01:25:23.284Z] VALIDATE_BRANCH=master
01:25:23 [2020-02-11T01:25:23.284Z] TERM=xterm
01:25:23 [2020-02-11T01:25:23.284Z] DOCKER_PKG=github.com/docker/docker
01:25:23 [2020-02-11T01:25:23.284Z] SHLVL=1
01:25:23 [2020-02-11T01:25:23.284Z] TIMEOUT=120m
01:25:23 [2020-02-11T01:25:23.284Z] DOCKER_BUILDTAGS=apparmor seccomp selinux journald
01:25:23 [2020-02-11T01:25:23.284Z] DOCKER_GRAPHDRIVER=overlay2
01:25:23 [2020-02-11T01:25:23.284Z] GO111MODULE=off
01:25:23 [2020-02-11T01:25:23.284Z] DOCKER_EXPERIMENTAL=1
01:25:23 [2020-02-11T01:25:23.284Z] TEST_SKIP_INTEGRATION_CLI=1
01:25:23 [2020-02-11T01:25:23.284Z] PATH=/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
01:25:23 [2020-02-11T01:25:23.284Z] MAKEDIR=/go/src/github.com/docker/docker/hack/make
01:25:23 [2020-02-11T01:25:23.284Z] GOPATH=/go
01:25:23 [2020-02-11T01:25:23.284Z] PKG_CONFIG=pkg-config
01:25:23 [2020-02-11T01:25:23.284Z] _=/usr/bin/env
01:25:23 [2020-02-11T01:25:23.284Z] Building test suite binary /go/src/github.com/docker/docker/integration/build/test.main
01:25:39 [2020-02-11T01:25:39.591Z] Building test suite binary /go/src/github.com/docker/docker/integration/config/test.main
01:25:39 [2020-02-11T01:25:39.951Z] Building test suite binary /go/src/github.com/docker/docker/integration/container/test.main
01:25:41 [2020-02-11T01:25:41.726Z] Building test suite binary /go/src/github.com/docker/docker/integration/image/test.main
01:25:58 [2020-02-11T01:25:58.001Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/test.main
01:25:58 [2020-02-11T01:25:58.001Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/ipvlan/test.main
01:25:59 [2020-02-11T01:25:59.226Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/macvlan/test.main
01:26:00 [2020-02-11T01:26:00.213Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/test.main
01:26:00 [2020-02-11T01:26:00.624Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/authz/test.main
01:26:02 [2020-02-11T01:26:02.508Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/common/test.main
01:26:03 [2020-02-11T01:26:03.284Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/graphdriver/test.main
01:26:04 [2020-02-11T01:26:04.589Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/logging/test.main
01:26:06 [2020-02-11T01:26:06.430Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/volumes/test.main
01:26:08 [2020-02-11T01:26:08.180Z] Building test suite binary /go/src/github.com/docker/docker/integration/secret/test.main
01:26:08 [2020-02-11T01:26:08.928Z] Building test suite binary /go/src/github.com/docker/docker/integration/service/test.main
01:26:10 [2020-02-11T01:26:10.698Z] Building test suite binary /go/src/github.com/docker/docker/integration/session/test.main
01:26:11 [2020-02-11T01:26:11.443Z] Building test suite binary /go/src/github.com/docker/docker/integration/system/test.main
01:26:12 [2020-02-11T01:26:12.192Z] Building test suite binary /go/src/github.com/docker/docker/integration/volume/test.main
01:26:13 [2020-02-11T01:26:13.419Z] ---> Making bundle: .integration-daemon-start (in bundles/test-integration)
01:26:13 [2020-02-11T01:26:13.419Z] Using test binary docker
01:26:13 [2020-02-11T01:26:13.419Z] # DOCKER_EXPERIMENTAL is set: starting daemon with experimental features enabled! 
01:26:13 [2020-02-11T01:26:13.419Z] +++ /etc/init.d/apparmor start
01:26:13 [2020-02-11T01:26:13.419Z] Starting: AppArmor: already loaded with profiles.: Skipped. ... (warning).
01:26:13 [2020-02-11T01:26:13.419Z] Starting dockerd
01:26:13 [2020-02-11T01:26:13.419Z] INFO: Waiting for daemon to start...
01:26:13 [2020-02-11T01:26:13.419Z] +++ exec dockerd --debug --host unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock --storage-driver overlay2 --pidfile bundles/test-integration/docker.pid --userland-proxy=true --experimental
01:26:15 [2020-02-11T01:26:15.141Z] .
01:26:15 [2020-02-11T01:26:15.141Z] ---> Making bundle: .integration-daemon-setup (in bundles/test-integration)
01:26:15 [2020-02-11T01:26:15.141Z] ---> Making bundle: .ensure-emptyfs (in bundles/test-integration)
01:26:15 [2020-02-11T01:26:15.141Z] Error: No such image: emptyfs
01:26:15 [2020-02-11T01:26:15.494Z] ++++ tar -cC bundles/test-integration/emptyfs .
01:26:15 [2020-02-11T01:26:15.494Z] ++++ docker load
01:26:15 [2020-02-11T01:26:15.494Z] Running integration-test (iteration 1)
01:26:15 [2020-02-11T01:26:15.494Z] Running /go/src/github.com/docker/docker/integration/build (s390x.integration.build) flags=-test.v -test.timeout=120m 
01:26:15 [2020-02-11T01:26:15.494Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-build-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-build-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.build -t ./test.main -test.v -test.timeout=120m
01:26:15 [2020-02-11T01:26:15.494Z] ++ set -e
01:26:15 [2020-02-11T01:26:15.494Z] ++ '[' -n 0 ']'
01:26:15 [2020-02-11T01:26:15.494Z] ++ set -x
01:26:15 [2020-02-11T01:26:15.494Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=s390x DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-build-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-build-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.build -t ./test.main -test.v -test.timeout=120m
01:26:23 [2020-02-11T01:26:23.003Z] Loaded image: buildpack-deps:jessie
01:26:23 [2020-02-11T01:26:23.004Z] Loaded image: busybox:latest
01:26:23 [2020-02-11T01:26:23.004Z] Loaded image: busybox:glibc
01:26:23 [2020-02-11T01:26:23.004Z] Loaded image: debian:jessie
01:26:23 [2020-02-11T01:26:23.362Z] Loaded image: hello-world:latest
01:26:23 [2020-02-11T01:26:23.363Z] INFO: Testing against a local daemon
01:26:23 [2020-02-11T01:26:23.363Z] === RUN   TestCgroupNamespacesBuild
01:26:25 [2020-02-11T01:26:25.093Z] --- PASS: TestCgroupNamespacesBuild (1.67s)
01:26:25 [2020-02-11T01:26:25.093Z] === RUN   TestCgroupNamespacesBuildDaemonHostMode
01:26:26 [2020-02-11T01:26:26.853Z] --- PASS: TestCgroupNamespacesBuildDaemonHostMode (1.66s)
01:26:26 [2020-02-11T01:26:26.853Z] === RUN   TestBuildWithSession
01:26:26 [2020-02-11T01:26:26.853Z] --- SKIP: TestBuildWithSession (0.00s)
01:26:26 [2020-02-11T01:26:26.853Z]     build_session_test.go:25: TODO: BuildKit
01:26:26 [2020-02-11T01:26:26.853Z] === RUN   TestBuildSquashParent
01:26:33 [2020-02-11T01:26:33.137Z] --- PASS: TestBuildSquashParent (6.00s)
01:26:33 [2020-02-11T01:26:33.137Z] === RUN   TestBuildWithRemoveAndForceRemove
01:26:33 [2020-02-11T01:26:33.137Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
01:26:33 [2020-02-11T01:26:33.137Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
01:26:33 [2020-02-11T01:26:33.137Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_remove
01:26:33 [2020-02-11T01:26:33.137Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_remove
01:26:33 [2020-02-11T01:26:33.137Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
01:26:33 [2020-02-11T01:26:33.137Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
01:26:33 [2020-02-11T01:26:33.137Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
01:26:33 [2020-02-11T01:26:33.137Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
01:26:33 [2020-02-11T01:26:33.137Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_remove
01:26:33 [2020-02-11T01:26:33.137Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_remove
01:26:33 [2020-02-11T01:26:33.137Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
01:26:33 [2020-02-11T01:26:33.137Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
01:26:33 [2020-02-11T01:26:33.137Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
01:26:33 [2020-02-11T01:26:33.137Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
01:26:35 [2020-02-11T01:26:35.523Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_remove
01:26:35 [2020-02-11T01:26:35.523Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
01:26:37 [2020-02-11T01:26:37.883Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
01:26:37 [2020-02-11T01:26:37.883Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_remove
01:26:40 [2020-02-11T01:26:40.399Z] --- PASS: TestBuildWithRemoveAndForceRemove (0.01s)
01:26:40 [2020-02-11T01:26:40.399Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal (2.68s)
01:26:40 [2020-02-11T01:26:40.399Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove (2.76s)
01:26:40 [2020-02-11T01:26:40.399Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_remove (2.25s)
01:26:40 [2020-02-11T01:26:40.399Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal (2.22s)
01:26:40 [2020-02-11T01:26:40.399Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove (2.66s)
01:26:40 [2020-02-11T01:26:40.399Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_remove (2.69s)
01:26:40 [2020-02-11T01:26:40.399Z] === RUN   TestBuildMultiStageCopy
01:26:40 [2020-02-11T01:26:40.399Z] === RUN   TestBuildMultiStageCopy/copy_to_root
01:26:42 [2020-02-11T01:26:42.765Z] === RUN   TestBuildMultiStageCopy/copy_to_newdir
01:26:43 [2020-02-11T01:26:43.111Z] === RUN   TestBuildMultiStageCopy/copy_to_newdir_nested
01:26:43 [2020-02-11T01:26:43.852Z] === RUN   TestBuildMultiStageCopy/copy_to_existingdir
01:26:44 [2020-02-11T01:26:44.202Z] === RUN   TestBuildMultiStageCopy/copy_to_newsubdir
01:26:44 [2020-02-11T01:26:44.955Z] --- PASS: TestBuildMultiStageCopy (4.46s)
01:26:44 [2020-02-11T01:26:44.955Z]     --- PASS: TestBuildMultiStageCopy/copy_to_root (2.46s)
01:26:44 [2020-02-11T01:26:44.955Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newdir (0.46s)
01:26:44 [2020-02-11T01:26:44.955Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newdir_nested (0.47s)
01:26:44 [2020-02-11T01:26:44.955Z]     --- PASS: TestBuildMultiStageCopy/copy_to_existingdir (0.53s)
01:26:44 [2020-02-11T01:26:44.955Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newsubdir (0.54s)
01:26:44 [2020-02-11T01:26:44.955Z] === RUN   TestBuildMultiStageParentConfig
01:26:46 [2020-02-11T01:26:46.172Z] --- PASS: TestBuildMultiStageParentConfig (1.28s)
01:26:46 [2020-02-11T01:26:46.172Z] === RUN   TestBuildLabelWithTargets
01:26:48 [2020-02-11T01:26:48.517Z] --- PASS: TestBuildLabelWithTargets (2.12s)
01:26:48 [2020-02-11T01:26:48.517Z] === RUN   TestBuildWithEmptyLayers
01:26:48 [2020-02-11T01:26:48.874Z] --- PASS: TestBuildWithEmptyLayers (0.84s)
01:26:48 [2020-02-11T01:26:48.874Z] === RUN   TestBuildMultiStageOnBuild
01:26:51 [2020-02-11T01:26:51.993Z] --- PASS: TestBuildMultiStageOnBuild (2.50s)
01:26:51 [2020-02-11T01:26:51.993Z] === RUN   TestBuildUncleanTarFilenames
01:26:52 [2020-02-11T01:26:52.741Z] --- PASS: TestBuildUncleanTarFilenames (1.27s)
01:26:52 [2020-02-11T01:26:52.741Z] === RUN   TestBuildMultiStageLayerLeak
01:26:55 [2020-02-11T01:26:55.848Z] --- PASS: TestBuildMultiStageLayerLeak (2.59s)
01:26:55 [2020-02-11T01:26:55.848Z] === RUN   TestBuildWithHugeFile
01:27:24 [2020-02-11T01:27:24.530Z] --- PASS: TestBuildWithHugeFile (27.11s)
01:27:24 [2020-02-11T01:27:24.530Z] === RUN   TestBuildWithEmptyDockerfile
01:27:24 [2020-02-11T01:27:24.530Z] === RUN   TestBuildWithEmptyDockerfile/empty-dockerfile
01:27:24 [2020-02-11T01:27:24.530Z] === PAUSE TestBuildWithEmptyDockerfile/empty-dockerfile
01:27:24 [2020-02-11T01:27:24.530Z] === RUN   TestBuildWithEmptyDockerfile/empty-lines-dockerfile
01:27:24 [2020-02-11T01:27:24.530Z] === PAUSE TestBuildWithEmptyDockerfile/empty-lines-dockerfile
01:27:24 [2020-02-11T01:27:24.530Z] === RUN   TestBuildWithEmptyDockerfile/comment-only-dockerfile
01:27:24 [2020-02-11T01:27:24.530Z] === PAUSE TestBuildWithEmptyDockerfile/comment-only-dockerfile
01:27:24 [2020-02-11T01:27:24.530Z] === CONT  TestBuildWithEmptyDockerfile/empty-dockerfile
01:27:24 [2020-02-11T01:27:24.530Z] === CONT  TestBuildWithEmptyDockerfile/comment-only-dockerfile
01:27:24 [2020-02-11T01:27:24.530Z] === CONT  TestBuildWithEmptyDockerfile/empty-lines-dockerfile
01:27:24 [2020-02-11T01:27:24.530Z] --- PASS: TestBuildWithEmptyDockerfile (0.10s)
01:27:24 [2020-02-11T01:27:24.530Z]     --- PASS: TestBuildWithEmptyDockerfile/comment-only-dockerfile (0.28s)
01:27:24 [2020-02-11T01:27:24.530Z]     --- PASS: TestBuildWithEmptyDockerfile/empty-dockerfile (0.29s)
01:27:24 [2020-02-11T01:27:24.530Z]     --- PASS: TestBuildWithEmptyDockerfile/empty-lines-dockerfile (0.11s)
01:27:24 [2020-02-11T01:27:24.530Z] === RUN   TestBuildPreserveOwnership
01:27:24 [2020-02-11T01:27:24.530Z] === RUN   TestBuildPreserveOwnership/copy_from
01:27:26 [2020-02-11T01:27:26.900Z] === RUN   TestBuildPreserveOwnership/copy_from_chowned
01:27:28 [2020-02-11T01:27:28.629Z] --- PASS: TestBuildPreserveOwnership (5.66s)
01:27:28 [2020-02-11T01:27:28.629Z]     --- PASS: TestBuildPreserveOwnership/copy_from (3.74s)
01:27:28 [2020-02-11T01:27:28.629Z]     --- PASS: TestBuildPreserveOwnership/copy_from_chowned (1.92s)
01:27:28 [2020-02-11T01:27:28.629Z] === RUN   TestBuildPlatformInvalid
01:27:28 [2020-02-11T01:27:28.629Z] --- PASS: TestBuildPlatformInvalid (0.11s)
01:27:28 [2020-02-11T01:27:28.629Z] PASS
01:27:28 [2020-02-11T01:27:28.630Z] 
01:27:28 [2020-02-11T01:27:28.630Z] === Skipped
01:27:28 [2020-02-11T01:27:28.630Z] === SKIP: s390x.integration.build TestBuildWithSession (0.00s)
01:27:28 [2020-02-11T01:27:28.630Z]     build_session_test.go:25: TODO: BuildKit
01:27:28 [2020-02-11T01:27:28.630Z] 
01:27:28 [2020-02-11T01:27:28.630Z] 
01:27:28 [2020-02-11T01:27:28.630Z] DONE 32 tests, 1 skipped in 73.188s
01:27:29 [2020-02-11T01:27:29.011Z] Running /go/src/github.com/docker/docker/integration/config (s390x.integration.config) flags=-test.v -test.timeout=120m 
01:27:29 [2020-02-11T01:27:29.011Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-config-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-config-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.config -t ./test.main -test.v -test.timeout=120m
01:27:29 [2020-02-11T01:27:29.011Z] ++ set -e
01:27:29 [2020-02-11T01:27:29.011Z] ++ '[' -n 0 ']'
01:27:29 [2020-02-11T01:27:29.011Z] ++ set -x
01:27:29 [2020-02-11T01:27:29.011Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=s390x DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-config-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-config-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.config -t ./test.main -test.v -test.timeout=120m
01:27:29 [2020-02-11T01:27:29.011Z] INFO: Testing against a local daemon
01:27:29 [2020-02-11T01:27:29.011Z] === RUN   TestConfigList
01:27:32 [2020-02-11T01:27:32.214Z] --- PASS: TestConfigList (2.87s)
01:27:32 [2020-02-11T01:27:32.214Z] === RUN   TestConfigsCreateAndDelete
01:27:34 [2020-02-11T01:27:34.580Z] --- PASS: TestConfigsCreateAndDelete (2.63s)
01:27:34 [2020-02-11T01:27:34.581Z] === RUN   TestConfigsUpdate
01:27:37 [2020-02-11T01:27:37.673Z] --- PASS: TestConfigsUpdate (2.73s)
01:27:37 [2020-02-11T01:27:37.673Z] === RUN   TestTemplatedConfig
01:27:40 [2020-02-11T01:27:40.746Z] --- PASS: TestTemplatedConfig (2.96s)
01:27:40 [2020-02-11T01:27:40.746Z] === RUN   TestConfigInspect
01:27:43 [2020-02-11T01:27:43.102Z] --- PASS: TestConfigInspect (2.38s)
01:27:43 [2020-02-11T01:27:43.102Z] === RUN   TestConfigCreateWithLabels
01:27:45 [2020-02-11T01:27:45.442Z] --- PASS: TestConfigCreateWithLabels (2.75s)
01:27:45 [2020-02-11T01:27:45.443Z] === RUN   TestConfigCreateResolve
01:27:48 [2020-02-11T01:27:48.534Z] --- PASS: TestConfigCreateResolve (2.80s)
01:27:48 [2020-02-11T01:27:48.534Z] === RUN   TestConfigDaemonLibtrustID
01:27:48 [2020-02-11T01:27:48.896Z] --- PASS: TestConfigDaemonLibtrustID (0.54s)
01:27:48 [2020-02-11T01:27:48.896Z] PASS
01:27:48 [2020-02-11T01:27:48.896Z] 
01:27:48 [2020-02-11T01:27:48.896Z] DONE 8 tests in 19.785s
01:27:48 [2020-02-11T01:27:48.896Z] Running /go/src/github.com/docker/docker/integration/container (s390x.integration.container) flags=-test.v -test.timeout=120m 
01:27:48 [2020-02-11T01:27:48.896Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-container-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-container-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.container -t ./test.main -test.v -test.timeout=120m
01:27:48 [2020-02-11T01:27:48.896Z] ++ set -e
01:27:48 [2020-02-11T01:27:48.896Z] ++ '[' -n 0 ']'
01:27:48 [2020-02-11T01:27:48.896Z] ++ set -x
01:27:48 [2020-02-11T01:27:48.896Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=s390x DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-container-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-container-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.container -t ./test.main -test.v -test.timeout=120m
01:27:48 [2020-02-11T01:27:48.896Z] INFO: Testing against a local daemon
01:27:48 [2020-02-11T01:27:48.896Z] === RUN   TestCheckpoint
01:27:48 [2020-02-11T01:27:48.896Z] --- SKIP: TestCheckpoint (0.00s)
01:27:48 [2020-02-11T01:27:48.896Z]     checkpoint_test.go:33: TestCheckpoint is broken; see https://github.com/moby/moby/issues/38963
01:27:48 [2020-02-11T01:27:48.896Z] === RUN   TestContainerInvalidJSON
01:27:48 [2020-02-11T01:27:48.896Z] === RUN   TestContainerInvalidJSON//containers/foobar/copy
01:27:48 [2020-02-11T01:27:48.896Z] === PAUSE TestContainerInvalidJSON//containers/foobar/copy
01:27:48 [2020-02-11T01:27:48.896Z] === RUN   TestContainerInvalidJSON//containers/foobar/exec
01:27:48 [2020-02-11T01:27:48.896Z] === PAUSE TestContainerInvalidJSON//containers/foobar/exec
01:27:48 [2020-02-11T01:27:48.896Z] === RUN   TestContainerInvalidJSON//exec/foobar/start
01:27:48 [2020-02-11T01:27:48.896Z] === PAUSE TestContainerInvalidJSON//exec/foobar/start
01:27:48 [2020-02-11T01:27:48.896Z] === CONT  TestContainerInvalidJSON//containers/foobar/copy
01:27:48 [2020-02-11T01:27:48.896Z] === CONT  TestContainerInvalidJSON//exec/foobar/start
01:27:48 [2020-02-11T01:27:48.896Z] === CONT  TestContainerInvalidJSON//containers/foobar/exec
01:27:48 [2020-02-11T01:27:48.896Z] --- PASS: TestContainerInvalidJSON (0.01s)
01:27:48 [2020-02-11T01:27:48.896Z]     --- PASS: TestContainerInvalidJSON//containers/foobar/copy (0.00s)
01:27:48 [2020-02-11T01:27:48.896Z]     --- PASS: TestContainerInvalidJSON//exec/foobar/start (0.00s)
01:27:48 [2020-02-11T01:27:48.896Z]     --- PASS: TestContainerInvalidJSON//containers/foobar/exec (0.00s)
01:27:48 [2020-02-11T01:27:48.896Z] === RUN   TestCopyFromContainerPathDoesNotExist
01:27:48 [2020-02-11T01:27:48.896Z] --- PASS: TestCopyFromContainerPathDoesNotExist (0.11s)
01:27:48 [2020-02-11T01:27:48.896Z] === RUN   TestCopyFromContainerPathIsNotDir
01:27:49 [2020-02-11T01:27:49.244Z] --- PASS: TestCopyFromContainerPathIsNotDir (0.10s)
01:27:49 [2020-02-11T01:27:49.244Z] === RUN   TestCopyToContainerPathDoesNotExist
01:27:49 [2020-02-11T01:27:49.244Z] --- PASS: TestCopyToContainerPathDoesNotExist (0.11s)
01:27:49 [2020-02-11T01:27:49.244Z] === RUN   TestCopyToContainerPathIsNotDir
01:27:49 [2020-02-11T01:27:49.244Z] --- PASS: TestCopyToContainerPathIsNotDir (0.12s)
01:27:49 [2020-02-11T01:27:49.244Z] === RUN   TestCopyFromContainer
01:27:51 [2020-02-11T01:27:51.367Z] === RUN   TestCopyFromContainer//
01:27:51 [2020-02-11T01:27:51.367Z] === RUN   TestCopyFromContainer//bar/root
01:27:51 [2020-02-11T01:27:51.367Z] === RUN   TestCopyFromContainer//bar/root/
01:27:51 [2020-02-11T01:27:51.367Z] === RUN   TestCopyFromContainer/bar/quux
01:27:51 [2020-02-11T01:27:51.756Z] === RUN   TestCopyFromContainer/bar/quux/
01:27:51 [2020-02-11T01:27:51.756Z] === RUN   TestCopyFromContainer/bar/quux/baz
01:27:51 [2020-02-11T01:27:51.756Z] === RUN   TestCopyFromContainer/bar/filesymlink
01:27:51 [2020-02-11T01:27:51.756Z] === RUN   TestCopyFromContainer/bar/dirsymlink
01:27:51 [2020-02-11T01:27:51.756Z] === RUN   TestCopyFromContainer/bar/dirsymlink/
01:27:52 [2020-02-11T01:27:52.123Z] === RUN   TestCopyFromContainer/bar/notarget
01:27:52 [2020-02-11T01:27:52.123Z] --- PASS: TestCopyFromContainer (2.79s)
01:27:52 [2020-02-11T01:27:52.123Z]     --- PASS: TestCopyFromContainer// (0.07s)
01:27:52 [2020-02-11T01:27:52.123Z]     --- PASS: TestCopyFromContainer//bar/root (0.09s)
01:27:52 [2020-02-11T01:27:52.123Z]     --- PASS: TestCopyFromContainer//bar/root/ (0.07s)
01:27:52 [2020-02-11T01:27:52.123Z]     --- PASS: TestCopyFromContainer/bar/quux (0.11s)
01:27:52 [2020-02-11T01:27:52.123Z]     --- PASS: TestCopyFromContainer/bar/quux/ (0.08s)
01:27:52 [2020-02-11T01:27:52.123Z]     --- PASS: TestCopyFromContainer/bar/quux/baz (0.06s)
01:27:52 [2020-02-11T01:27:52.123Z]     --- PASS: TestCopyFromContainer/bar/filesymlink (0.09s)
01:27:52 [2020-02-11T01:27:52.123Z]     --- PASS: TestCopyFromContainer/bar/dirsymlink (0.09s)
01:27:52 [2020-02-11T01:27:52.123Z]     --- PASS: TestCopyFromContainer/bar/dirsymlink/ (0.11s)
01:27:52 [2020-02-11T01:27:52.123Z]     --- PASS: TestCopyFromContainer/bar/notarget (0.09s)
01:27:52 [2020-02-11T01:27:52.123Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist
01:27:52 [2020-02-11T01:27:52.123Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
01:27:52 [2020-02-11T01:27:52.123Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
01:27:52 [2020-02-11T01:27:52.123Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
01:27:52 [2020-02-11T01:27:52.123Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
01:27:52 [2020-02-11T01:27:52.123Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/digest
01:27:52 [2020-02-11T01:27:52.123Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/digest
01:27:52 [2020-02-11T01:27:52.123Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
01:27:52 [2020-02-11T01:27:52.123Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/digest
01:27:52 [2020-02-11T01:27:52.123Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
01:27:52 [2020-02-11T01:27:52.123Z] --- PASS: TestCreateFailsWhenIdentifierDoesNotExist (0.01s)
01:27:52 [2020-02-11T01:27:52.123Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag (0.00s)
01:27:52 [2020-02-11T01:27:52.123Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/digest (0.00s)
01:27:52 [2020-02-11T01:27:52.123Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag (0.00s)
01:27:52 [2020-02-11T01:27:52.123Z] === RUN   TestCreateLinkToNonExistingContainer
01:27:52 [2020-02-11T01:27:52.123Z] --- PASS: TestCreateLinkToNonExistingContainer (0.03s)
01:27:52 [2020-02-11T01:27:52.123Z] === RUN   TestCreateWithInvalidEnv
01:27:52 [2020-02-11T01:27:52.123Z] === RUN   TestCreateWithInvalidEnv/0
01:27:52 [2020-02-11T01:27:52.123Z] === PAUSE TestCreateWithInvalidEnv/0
01:27:52 [2020-02-11T01:27:52.123Z] === RUN   TestCreateWithInvalidEnv/1
01:27:52 [2020-02-11T01:27:52.123Z] === PAUSE TestCreateWithInvalidEnv/1
01:27:52 [2020-02-11T01:27:52.123Z] === RUN   TestCreateWithInvalidEnv/2
01:27:52 [2020-02-11T01:27:52.123Z] === PAUSE TestCreateWithInvalidEnv/2
01:27:52 [2020-02-11T01:27:52.123Z] === CONT  TestCreateWithInvalidEnv/0
01:27:52 [2020-02-11T01:27:52.123Z] === CONT  TestCreateWithInvalidEnv/2
01:27:52 [2020-02-11T01:27:52.123Z] === CONT  TestCreateWithInvalidEnv/1
01:27:52 [2020-02-11T01:27:52.123Z] --- PASS: TestCreateWithInvalidEnv (0.02s)
01:27:52 [2020-02-11T01:27:52.123Z]     --- PASS: TestCreateWithInvalidEnv/0 (0.00s)
01:27:52 [2020-02-11T01:27:52.123Z]     --- PASS: TestCreateWithInvalidEnv/2 (0.00s)
01:27:52 [2020-02-11T01:27:52.123Z]     --- PASS: TestCreateWithInvalidEnv/1 (0.00s)
01:27:52 [2020-02-11T01:27:52.123Z] === RUN   TestCreateTmpfsMountsTarget
01:27:52 [2020-02-11T01:27:52.123Z] --- PASS: TestCreateTmpfsMountsTarget (0.03s)
01:27:52 [2020-02-11T01:27:52.123Z] === RUN   TestCreateWithCustomMaskedPaths
01:27:54 [2020-02-11T01:27:54.631Z] --- PASS: TestCreateWithCustomMaskedPaths (2.42s)
01:27:54 [2020-02-11T01:27:54.631Z] === RUN   TestCreateWithCapabilities
01:27:54 [2020-02-11T01:27:54.631Z] === RUN   TestCreateWithCapabilities/no_capabilities
01:27:54 [2020-02-11T01:27:54.631Z] === PAUSE TestCreateWithCapabilities/no_capabilities
01:27:54 [2020-02-11T01:27:54.631Z] === RUN   TestCreateWithCapabilities/empty_capabilities
01:27:54 [2020-02-11T01:27:54.631Z] === PAUSE TestCreateWithCapabilities/empty_capabilities
01:27:54 [2020-02-11T01:27:54.631Z] === RUN   TestCreateWithCapabilities/valid_capabilities
01:27:54 [2020-02-11T01:27:54.631Z] === PAUSE TestCreateWithCapabilities/valid_capabilities
01:27:54 [2020-02-11T01:27:54.631Z] === RUN   TestCreateWithCapabilities/invalid_capabilities
01:27:54 [2020-02-11T01:27:54.631Z] === PAUSE TestCreateWithCapabilities/invalid_capabilities
01:27:54 [2020-02-11T01:27:54.631Z] === RUN   TestCreateWithCapabilities/duplicate_capabilities
01:27:54 [2020-02-11T01:27:54.631Z] === PAUSE TestCreateWithCapabilities/duplicate_capabilities
01:27:54 [2020-02-11T01:27:54.631Z] === RUN   TestCreateWithCapabilities/capabilities_API_v1.39
01:27:54 [2020-02-11T01:27:54.631Z] === PAUSE TestCreateWithCapabilities/capabilities_API_v1.39
01:27:54 [2020-02-11T01:27:54.631Z] === RUN   TestCreateWithCapabilities/empty_capadd
01:27:54 [2020-02-11T01:27:54.631Z] === PAUSE TestCreateWithCapabilities/empty_capadd
01:27:54 [2020-02-11T01:27:54.631Z] === RUN   TestCreateWithCapabilities/empty_capdrop
01:27:54 [2020-02-11T01:27:54.631Z] === PAUSE TestCreateWithCapabilities/empty_capdrop
01:27:54 [2020-02-11T01:27:54.631Z] === RUN   TestCreateWithCapabilities/capadd_capdrop
01:27:54 [2020-02-11T01:27:54.631Z] === PAUSE TestCreateWithCapabilities/capadd_capdrop
01:27:54 [2020-02-11T01:27:54.631Z] === RUN   TestCreateWithCapabilities/conflict_with_capadd
01:27:54 [2020-02-11T01:27:54.631Z] === PAUSE TestCreateWithCapabilities/conflict_with_capadd
01:27:54 [2020-02-11T01:27:54.631Z] === RUN   TestCreateWithCapabilities/conflict_with_capdrop
01:27:54 [2020-02-11T01:27:54.631Z] === PAUSE TestCreateWithCapabilities/conflict_with_capdrop
01:27:54 [2020-02-11T01:27:54.631Z] === CONT  TestCreateWithCapabilities/no_capabilities
01:27:54 [2020-02-11T01:27:54.631Z] === CONT  TestCreateWithCapabilities/conflict_with_capdrop
01:27:54 [2020-02-11T01:27:54.631Z] === CONT  TestCreateWithCapabilities/conflict_with_capadd
01:27:54 [2020-02-11T01:27:54.631Z] === CONT  TestCreateWithCapabilities/capadd_capdrop
01:27:54 [2020-02-11T01:27:54.631Z] === CONT  TestCreateWithCapabilities/empty_capdrop
01:27:54 [2020-02-11T01:27:54.631Z] === CONT  TestCreateWithCapabilities/empty_capadd
01:27:54 [2020-02-11T01:27:54.631Z] === CONT  TestCreateWithCapabilities/capabilities_API_v1.39
01:27:54 [2020-02-11T01:27:54.631Z] === CONT  TestCreateWithCapabilities/duplicate_capabilities
01:27:54 [2020-02-11T01:27:54.984Z] === CONT  TestCreateWithCapabilities/invalid_capabilities
01:27:54 [2020-02-11T01:27:54.984Z] === CONT  TestCreateWithCapabilities/valid_capabilities
01:27:54 [2020-02-11T01:27:54.984Z] === CONT  TestCreateWithCapabilities/empty_capabilities
01:27:54 [2020-02-11T01:27:54.984Z] --- PASS: TestCreateWithCapabilities (0.01s)
01:27:54 [2020-02-11T01:27:54.984Z]     --- PASS: TestCreateWithCapabilities/conflict_with_capdrop (0.00s)
01:27:54 [2020-02-11T01:27:54.984Z]     --- PASS: TestCreateWithCapabilities/conflict_with_capadd (0.00s)
01:27:54 [2020-02-11T01:27:54.984Z]     --- PASS: TestCreateWithCapabilities/no_capabilities (0.07s)
01:27:54 [2020-02-11T01:27:54.984Z]     --- PASS: TestCreateWithCapabilities/capadd_capdrop (0.09s)
01:27:54 [2020-02-11T01:27:54.984Z]     --- PASS: TestCreateWithCapabilities/empty_capdrop (0.06s)
01:27:54 [2020-02-11T01:27:54.984Z]     --- PASS: TestCreateWithCapabilities/empty_capadd (0.07s)
01:27:54 [2020-02-11T01:27:54.984Z]     --- PASS: TestCreateWithCapabilities/capabilities_API_v1.39 (0.08s)
01:27:54 [2020-02-11T01:27:54.984Z]     --- PASS: TestCreateWithCapabilities/invalid_capabilities (0.00s)
01:27:54 [2020-02-11T01:27:54.984Z]     --- PASS: TestCreateWithCapabilities/duplicate_capabilities (0.08s)
01:27:54 [2020-02-11T01:27:54.984Z]     --- PASS: TestCreateWithCapabilities/valid_capabilities (0.08s)
01:27:54 [2020-02-11T01:27:54.984Z]     --- PASS: TestCreateWithCapabilities/empty_capabilities (0.05s)
01:27:54 [2020-02-11T01:27:54.984Z] === RUN   TestCreateWithCustomReadonlyPaths
01:27:57 [2020-02-11T01:27:57.344Z] --- PASS: TestCreateWithCustomReadonlyPaths (2.56s)
01:27:57 [2020-02-11T01:27:57.344Z] === RUN   TestCreateWithInvalidHealthcheckParams
01:27:57 [2020-02-11T01:27:57.344Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
01:27:57 [2020-02-11T01:27:57.344Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
01:27:57 [2020-02-11T01:27:57.344Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
01:27:57 [2020-02-11T01:27:57.344Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
01:27:57 [2020-02-11T01:27:57.344Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
01:27:57 [2020-02-11T01:27:57.344Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
01:27:57 [2020-02-11T01:27:57.344Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
01:27:57 [2020-02-11T01:27:57.344Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
01:27:57 [2020-02-11T01:27:57.344Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
01:27:57 [2020-02-11T01:27:57.344Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
01:27:57 [2020-02-11T01:27:57.344Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
01:27:57 [2020-02-11T01:27:57.344Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
01:27:57 [2020-02-11T01:27:57.344Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
01:27:57 [2020-02-11T01:27:57.344Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
01:27:57 [2020-02-11T01:27:57.344Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
01:27:57 [2020-02-11T01:27:57.344Z] --- PASS: TestCreateWithInvalidHealthcheckParams (0.02s)
01:27:57 [2020-02-11T01:27:57.344Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms (0.01s)
01:27:57 [2020-02-11T01:27:57.344Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s (0.01s)
01:27:57 [2020-02-11T01:27:57.344Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0 (0.00s)
01:27:57 [2020-02-11T01:27:57.344Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms (0.01s)
01:27:57 [2020-02-11T01:27:57.344Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms (0.01s)
01:27:57 [2020-02-11T01:27:57.344Z] === RUN   TestCreateTmpfsOverrideAnonymousVolume
01:27:58 [2020-02-11T01:27:58.543Z] --- PASS: TestCreateTmpfsOverrideAnonymousVolume (0.79s)
01:27:58 [2020-02-11T01:27:58.543Z] === RUN   TestContainerStartOnDaemonRestart
01:27:58 [2020-02-11T01:27:58.543Z] === PAUSE TestContainerStartOnDaemonRestart
01:27:58 [2020-02-11T01:27:58.543Z] === RUN   TestDaemonRestartIpcMode
01:27:58 [2020-02-11T01:27:58.543Z] === PAUSE TestDaemonRestartIpcMode
01:27:58 [2020-02-11T01:27:58.543Z] === RUN   TestDaemonHostGatewayIP
01:27:58 [2020-02-11T01:27:58.543Z] === PAUSE TestDaemonHostGatewayIP
01:27:58 [2020-02-11T01:27:58.543Z] === RUN   TestDiff
01:27:59 [2020-02-11T01:27:59.297Z] --- PASS: TestDiff (0.85s)
01:27:59 [2020-02-11T01:27:59.297Z] === RUN   TestExecWithCloseStdin
01:28:00 [2020-02-11T01:28:00.159Z] --- PASS: TestExecWithCloseStdin (0.97s)
01:28:00 [2020-02-11T01:28:00.159Z] === RUN   TestExec
01:28:01 [2020-02-11T01:28:01.414Z] --- PASS: TestExec (1.05s)
01:28:01 [2020-02-11T01:28:01.414Z] === RUN   TestExecUser
01:28:02 [2020-02-11T01:28:02.156Z] --- PASS: TestExecUser (1.02s)
01:28:02 [2020-02-11T01:28:02.157Z] === RUN   TestExportContainerAndImportImage
01:28:03 [2020-02-11T01:28:03.357Z] --- PASS: TestExportContainerAndImportImage (1.18s)
01:28:03 [2020-02-11T01:28:03.357Z] === RUN   TestExportContainerAfterDaemonRestart
01:28:05 [2020-02-11T01:28:05.117Z] --- PASS: TestExportContainerAfterDaemonRestart (1.46s)
01:28:05 [2020-02-11T01:28:05.117Z] === RUN   TestHealthCheckWorkdir
01:28:05 [2020-02-11T01:28:05.880Z] --- PASS: TestHealthCheckWorkdir (1.12s)
01:28:05 [2020-02-11T01:28:05.880Z] === RUN   TestHealthKillContainer
01:28:08 [2020-02-11T01:28:08.930Z] --- PASS: TestHealthKillContainer (3.09s)
01:28:08 [2020-02-11T01:28:08.930Z] === RUN   TestInspectCpusetInConfigPre120
01:28:10 [2020-02-11T01:28:10.142Z] --- PASS: TestInspectCpusetInConfigPre120 (1.06s)
01:28:10 [2020-02-11T01:28:10.142Z] === RUN   TestIpcModeNone
01:28:11 [2020-02-11T01:28:11.348Z] --- PASS: TestIpcModeNone (1.00s)
01:28:11 [2020-02-11T01:28:11.348Z] === RUN   TestIpcModePrivate
01:28:12 [2020-02-11T01:28:12.086Z] --- PASS: TestIpcModePrivate (0.94s)
01:28:12 [2020-02-11T01:28:12.086Z]     ipcmode_linux_test.go:90: [testIpcPrivateShareable] ipcmode: private, ipcdev: 0:64, shared: false, mustBeShared: false
01:28:12 [2020-02-11T01:28:12.086Z] === RUN   TestIpcModeShareable
01:28:13 [2020-02-11T01:28:13.280Z] --- PASS: TestIpcModeShareable (1.11s)
01:28:13 [2020-02-11T01:28:13.280Z]     ipcmode_linux_test.go:90: [testIpcPrivateShareable] ipcmode: shareable, ipcdev: 0:58, shared: true, mustBeShared: true
01:28:13 [2020-02-11T01:28:13.280Z] === RUN   TestAPIIpcModeShareableAndContainer
01:28:16 [2020-02-11T01:28:16.380Z] --- PASS: TestAPIIpcModeShareableAndContainer (2.89s)
01:28:16 [2020-02-11T01:28:16.380Z] === RUN   TestAPIIpcModeHost
01:28:16 [2020-02-11T01:28:16.726Z] --- PASS: TestAPIIpcModeHost (0.76s)
01:28:16 [2020-02-11T01:28:16.727Z] === RUN   TestDaemonIpcModeShareable
01:28:18 [2020-02-11T01:28:18.872Z] --- PASS: TestDaemonIpcModeShareable (1.77s)
01:28:18 [2020-02-11T01:28:18.872Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:66, shared: true, mustBeShared: true
01:28:18 [2020-02-11T01:28:18.872Z] === RUN   TestDaemonIpcModePrivate
01:28:20 [2020-02-11T01:28:20.201Z] --- PASS: TestDaemonIpcModePrivate (1.72s)
01:28:20 [2020-02-11T01:28:20.201Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:72, shared: false, mustBeShared: false
01:28:20 [2020-02-11T01:28:20.201Z] === RUN   TestDaemonIpcModePrivateFromConfig
01:28:22 [2020-02-11T01:28:22.585Z] --- PASS: TestDaemonIpcModePrivateFromConfig (1.84s)
01:28:22 [2020-02-11T01:28:22.585Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:72, shared: false, mustBeShared: false
01:28:22 [2020-02-11T01:28:22.585Z] === RUN   TestDaemonIpcModeShareableFromConfig
01:28:23 [2020-02-11T01:28:23.801Z] --- PASS: TestDaemonIpcModeShareableFromConfig (1.67s)
01:28:23 [2020-02-11T01:28:23.801Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:66, shared: true, mustBeShared: true
01:28:23 [2020-02-11T01:28:23.801Z] === RUN   TestIpcModeOlderClient
01:28:23 [2020-02-11T01:28:23.801Z] === PAUSE TestIpcModeOlderClient
01:28:23 [2020-02-11T01:28:23.801Z] === RUN   TestKillContainerInvalidSignal
01:28:24 [2020-02-11T01:28:24.545Z] --- PASS: TestKillContainerInvalidSignal (0.87s)
01:28:24 [2020-02-11T01:28:24.545Z] === RUN   TestKillContainer
01:28:24 [2020-02-11T01:28:24.545Z] === RUN   TestKillContainer/no_signal
01:28:25 [2020-02-11T01:28:25.743Z] === RUN   TestKillContainer/non_killing_signal
01:28:26 [2020-02-11T01:28:26.095Z] === RUN   TestKillContainer/killing_signal
01:28:27 [2020-02-11T01:28:27.303Z] --- PASS: TestKillContainer (2.56s)
01:28:27 [2020-02-11T01:28:27.303Z]     --- PASS: TestKillContainer/no_signal (0.86s)
01:28:27 [2020-02-11T01:28:27.303Z]     --- PASS: TestKillContainer/non_killing_signal (0.56s)
01:28:27 [2020-02-11T01:28:27.303Z]     --- PASS: TestKillContainer/killing_signal (0.75s)
01:28:27 [2020-02-11T01:28:27.303Z] === RUN   TestKillWithStopSignalAndRestartPolicies
01:28:27 [2020-02-11T01:28:27.303Z] === RUN   TestKillWithStopSignalAndRestartPolicies/same-signal-disables-restart-policy
01:28:28 [2020-02-11T01:28:28.141Z] === RUN   TestKillWithStopSignalAndRestartPolicies/different-signal-keep-restart-policy
01:28:28 [2020-02-11T01:28:28.925Z] --- PASS: TestKillWithStopSignalAndRestartPolicies (1.74s)
01:28:28 [2020-02-11T01:28:28.925Z]     --- PASS: TestKillWithStopSignalAndRestartPolicies/same-signal-disables-restart-policy (0.85s)
01:28:28 [2020-02-11T01:28:28.925Z]     --- PASS: TestKillWithStopSignalAndRestartPolicies/different-signal-keep-restart-policy (0.55s)
01:28:28 [2020-02-11T01:28:28.925Z] === RUN   TestKillStoppedContainer
01:28:28 [2020-02-11T01:28:28.925Z] --- PASS: TestKillStoppedContainer (0.11s)
01:28:28 [2020-02-11T01:28:28.925Z] === RUN   TestKillStoppedContainerAPIPre120
01:28:29 [2020-02-11T01:28:29.274Z] --- PASS: TestKillStoppedContainerAPIPre120 (0.05s)
01:28:29 [2020-02-11T01:28:29.274Z] === RUN   TestKillDifferentUserContainer
01:28:30 [2020-02-11T01:28:30.012Z] --- PASS: TestKillDifferentUserContainer (0.85s)
01:28:30 [2020-02-11T01:28:30.012Z] === RUN   TestInspectOomKilledTrue
01:28:30 [2020-02-11T01:28:30.012Z] --- SKIP: TestInspectOomKilledTrue (0.13s)
01:28:30 [2020-02-11T01:28:30.012Z]     kill_test.go:151: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
01:28:30 [2020-02-11T01:28:30.012Z] === RUN   TestInspectOomKilledFalse
01:28:30 [2020-02-11T01:28:30.012Z] --- SKIP: TestInspectOomKilledFalse (0.00s)
01:28:30 [2020-02-11T01:28:30.012Z]     kill_test.go:169: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
01:28:30 [2020-02-11T01:28:30.012Z] === RUN   TestLinksEtcHostsContentMatch
01:28:30 [2020-02-11T01:28:30.759Z] --- PASS: TestLinksEtcHostsContentMatch (0.60s)
01:28:30 [2020-02-11T01:28:30.759Z] === RUN   TestLinksContainerNames
01:28:31 [2020-02-11T01:28:31.971Z] --- PASS: TestLinksContainerNames (1.42s)
01:28:31 [2020-02-11T01:28:31.971Z] === RUN   TestLogsFollowTailEmpty
01:28:33 [2020-02-11T01:28:33.171Z] --- PASS: TestLogsFollowTailEmpty (0.85s)
01:28:33 [2020-02-11T01:28:33.171Z] === RUN   TestContainerNetworkMountsNoChown
01:28:33 [2020-02-11T01:28:33.922Z] --- PASS: TestContainerNetworkMountsNoChown (0.86s)
01:28:33 [2020-02-11T01:28:33.922Z] === RUN   TestMountDaemonRoot
01:28:33 [2020-02-11T01:28:33.922Z] === RUN   TestMountDaemonRoot/default
01:28:33 [2020-02-11T01:28:33.922Z] === PAUSE TestMountDaemonRoot/default
01:28:33 [2020-02-11T01:28:33.922Z] === RUN   TestMountDaemonRoot/private
01:28:33 [2020-02-11T01:28:33.922Z] === PAUSE TestMountDaemonRoot/private
01:28:33 [2020-02-11T01:28:33.922Z] === RUN   TestMountDaemonRoot/rprivate
01:28:33 [2020-02-11T01:28:33.922Z] === PAUSE TestMountDaemonRoot/rprivate
01:28:33 [2020-02-11T01:28:33.922Z] === RUN   TestMountDaemonRoot/slave
01:28:33 [2020-02-11T01:28:33.922Z] === PAUSE TestMountDaemonRoot/slave
01:28:33 [2020-02-11T01:28:33.922Z] === RUN   TestMountDaemonRoot/rslave
01:28:33 [2020-02-11T01:28:33.922Z] === PAUSE TestMountDaemonRoot/rslave
01:28:33 [2020-02-11T01:28:33.922Z] === RUN   TestMountDaemonRoot/shared
01:28:33 [2020-02-11T01:28:33.922Z] === PAUSE TestMountDaemonRoot/shared
01:28:33 [2020-02-11T01:28:33.922Z] === RUN   TestMountDaemonRoot/rshared
01:28:33 [2020-02-11T01:28:33.922Z] === PAUSE TestMountDaemonRoot/rshared
01:28:33 [2020-02-11T01:28:33.922Z] === CONT  TestMountDaemonRoot/default
01:28:33 [2020-02-11T01:28:33.922Z] === RUN   TestMountDaemonRoot/default/bind_root
01:28:33 [2020-02-11T01:28:33.922Z] === PAUSE TestMountDaemonRoot/default/bind_root
01:28:33 [2020-02-11T01:28:33.922Z] === RUN   TestMountDaemonRoot/default/bind_subpath
01:28:33 [2020-02-11T01:28:33.922Z] === PAUSE TestMountDaemonRoot/default/bind_subpath
01:28:33 [2020-02-11T01:28:33.922Z] === RUN   TestMountDaemonRoot/default/mount_root
01:28:33 [2020-02-11T01:28:33.922Z] === PAUSE TestMountDaemonRoot/default/mount_root
01:28:33 [2020-02-11T01:28:33.922Z] === RUN   TestMountDaemonRoot/default/mount_subpath
01:28:33 [2020-02-11T01:28:33.922Z] === PAUSE TestMountDaemonRoot/default/mount_subpath
01:28:33 [2020-02-11T01:28:33.922Z] === CONT  TestMountDaemonRoot/default/bind_root
01:28:33 [2020-02-11T01:28:33.922Z] === CONT  TestMountDaemonRoot/rshared
01:28:33 [2020-02-11T01:28:33.922Z] === RUN   TestMountDaemonRoot/rshared/bind_root
01:28:33 [2020-02-11T01:28:33.922Z] === PAUSE TestMountDaemonRoot/rshared/bind_root
01:28:33 [2020-02-11T01:28:33.922Z] === RUN   TestMountDaemonRoot/rshared/bind_subpath
01:28:33 [2020-02-11T01:28:33.922Z] === PAUSE TestMountDaemonRoot/rshared/bind_subpath
01:28:33 [2020-02-11T01:28:33.922Z] === RUN   TestMountDaemonRoot/rshared/mount_root
01:28:33 [2020-02-11T01:28:33.922Z] === PAUSE TestMountDaemonRoot/rshared/mount_root
01:28:33 [2020-02-11T01:28:33.922Z] === RUN   TestMountDaemonRoot/rshared/mount_subpath
01:28:33 [2020-02-11T01:28:33.922Z] === PAUSE TestMountDaemonRoot/rshared/mount_subpath
01:28:33 [2020-02-11T01:28:33.922Z] === CONT  TestMountDaemonRoot/rprivate
01:28:33 [2020-02-11T01:28:33.922Z] === RUN   TestMountDaemonRoot/rprivate/bind_root
01:28:33 [2020-02-11T01:28:33.922Z] === PAUSE TestMountDaemonRoot/rprivate/bind_root
01:28:33 [2020-02-11T01:28:33.922Z] === RUN   TestMountDaemonRoot/rprivate/bind_subpath
01:28:33 [2020-02-11T01:28:33.922Z] === PAUSE TestMountDaemonRoot/rprivate/bind_subpath
01:28:33 [2020-02-11T01:28:33.922Z] === RUN   TestMountDaemonRoot/rprivate/mount_root
01:28:33 [2020-02-11T01:28:33.922Z] === PAUSE TestMountDaemonRoot/rprivate/mount_root
01:28:33 [2020-02-11T01:28:33.922Z] === RUN   TestMountDaemonRoot/rprivate/mount_subpath
01:28:33 [2020-02-11T01:28:33.922Z] === PAUSE TestMountDaemonRoot/rprivate/mount_subpath
01:28:33 [2020-02-11T01:28:33.922Z] === CONT  TestMountDaemonRoot/shared
01:28:33 [2020-02-11T01:28:33.922Z] === RUN   TestMountDaemonRoot/shared/mount_root
01:28:33 [2020-02-11T01:28:33.922Z] === PAUSE TestMountDaemonRoot/shared/mount_root
01:28:33 [2020-02-11T01:28:33.922Z] === RUN   TestMountDaemonRoot/shared/mount_subpath
01:28:33 [2020-02-11T01:28:33.922Z] === PAUSE TestMountDaemonRoot/shared/mount_subpath
01:28:33 [2020-02-11T01:28:33.922Z] === RUN   TestMountDaemonRoot/shared/bind_root
01:28:33 [2020-02-11T01:28:33.922Z] === PAUSE TestMountDaemonRoot/shared/bind_root
01:28:33 [2020-02-11T01:28:33.922Z] === RUN   TestMountDaemonRoot/shared/bind_subpath
01:28:33 [2020-02-11T01:28:33.922Z] === PAUSE TestMountDaemonRoot/shared/bind_subpath
01:28:33 [2020-02-11T01:28:33.922Z] === CONT  TestMountDaemonRoot/rslave
01:28:33 [2020-02-11T01:28:33.922Z] === RUN   TestMountDaemonRoot/rslave/bind_root
01:28:33 [2020-02-11T01:28:33.922Z] === PAUSE TestMountDaemonRoot/rslave/bind_root
01:28:33 [2020-02-11T01:28:33.922Z] === RUN   TestMountDaemonRoot/rslave/bind_subpath
01:28:33 [2020-02-11T01:28:33.922Z] === PAUSE TestMountDaemonRoot/rslave/bind_subpath
01:28:33 [2020-02-11T01:28:33.922Z] === RUN   TestMountDaemonRoot/rslave/mount_root
01:28:33 [2020-02-11T01:28:33.922Z] === PAUSE TestMountDaemonRoot/rslave/mount_root
01:28:33 [2020-02-11T01:28:33.922Z] === RUN   TestMountDaemonRoot/rslave/mount_subpath
01:28:33 [2020-02-11T01:28:33.922Z] === PAUSE TestMountDaemonRoot/rslave/mount_subpath
01:28:33 [2020-02-11T01:28:33.922Z] === CONT  TestMountDaemonRoot/slave
01:28:33 [2020-02-11T01:28:33.922Z] === RUN   TestMountDaemonRoot/slave/mount_root
01:28:33 [2020-02-11T01:28:33.922Z] === PAUSE TestMountDaemonRoot/slave/mount_root
01:28:33 [2020-02-11T01:28:33.922Z] === RUN   TestMountDaemonRoot/slave/mount_subpath
01:28:33 [2020-02-11T01:28:33.922Z] === PAUSE TestMountDaemonRoot/slave/mount_subpath
01:28:33 [2020-02-11T01:28:33.922Z] === RUN   TestMountDaemonRoot/slave/bind_root
01:28:33 [2020-02-11T01:28:33.922Z] === PAUSE TestMountDaemonRoot/slave/bind_root
01:28:33 [2020-02-11T01:28:33.922Z] === RUN   TestMountDaemonRoot/slave/bind_subpath
01:28:33 [2020-02-11T01:28:33.922Z] === PAUSE TestMountDaemonRoot/slave/bind_subpath
01:28:33 [2020-02-11T01:28:33.922Z] === CONT  TestMountDaemonRoot/default/mount_subpath
01:28:33 [2020-02-11T01:28:33.922Z] === CONT  TestMountDaemonRoot/private
01:28:33 [2020-02-11T01:28:33.922Z] === RUN   TestMountDaemonRoot/private/bind_root
01:28:33 [2020-02-11T01:28:33.922Z] === PAUSE TestMountDaemonRoot/private/bind_root
01:28:33 [2020-02-11T01:28:33.922Z] === RUN   TestMountDaemonRoot/private/bind_subpath
01:28:33 [2020-02-11T01:28:33.922Z] === PAUSE TestMountDaemonRoot/private/bind_subpath
01:28:33 [2020-02-11T01:28:33.922Z] === RUN   TestMountDaemonRoot/private/mount_root
01:28:33 [2020-02-11T01:28:33.922Z] === PAUSE TestMountDaemonRoot/private/mount_root
01:28:33 [2020-02-11T01:28:33.922Z] === RUN   TestMountDaemonRoot/private/mount_subpath
01:28:33 [2020-02-11T01:28:33.922Z] === PAUSE TestMountDaemonRoot/private/mount_subpath
01:28:33 [2020-02-11T01:28:33.922Z] === CONT  TestMountDaemonRoot/default/mount_root
01:28:33 [2020-02-11T01:28:33.922Z] === CONT  TestMountDaemonRoot/default/bind_subpath
01:28:33 [2020-02-11T01:28:33.922Z] === CONT  TestMountDaemonRoot/rshared/bind_root
01:28:33 [2020-02-11T01:28:33.922Z] === CONT  TestMountDaemonRoot/rshared/mount_root
01:28:33 [2020-02-11T01:28:33.922Z] === CONT  TestMountDaemonRoot/rshared/mount_subpath
01:28:34 [2020-02-11T01:28:34.271Z] === CONT  TestMountDaemonRoot/rshared/bind_subpath
01:28:34 [2020-02-11T01:28:34.271Z] === CONT  TestMountDaemonRoot/rprivate/bind_root
01:28:34 [2020-02-11T01:28:34.271Z] === CONT  TestMountDaemonRoot/rprivate/mount_root
01:28:34 [2020-02-11T01:28:34.271Z] === CONT  TestMountDaemonRoot/rprivate/mount_subpath
01:28:34 [2020-02-11T01:28:34.271Z] === CONT  TestMountDaemonRoot/rprivate/bind_subpath
01:28:34 [2020-02-11T01:28:34.271Z] === CONT  TestMountDaemonRoot/shared/mount_root
01:28:34 [2020-02-11T01:28:34.271Z] === CONT  TestMountDaemonRoot/shared/bind_root
01:28:34 [2020-02-11T01:28:34.271Z] === CONT  TestMountDaemonRoot/shared/bind_subpath
01:28:34 [2020-02-11T01:28:34.271Z] === CONT  TestMountDaemonRoot/shared/mount_subpath
01:28:34 [2020-02-11T01:28:34.271Z] === CONT  TestMountDaemonRoot/rslave/bind_root
01:28:34 [2020-02-11T01:28:34.271Z] === CONT  TestMountDaemonRoot/rslave/mount_root
01:28:34 [2020-02-11T01:28:34.271Z] === CONT  TestMountDaemonRoot/rslave/mount_subpath
01:28:34 [2020-02-11T01:28:34.271Z] === CONT  TestMountDaemonRoot/rslave/bind_subpath
01:28:34 [2020-02-11T01:28:34.629Z] === CONT  TestMountDaemonRoot/slave/mount_root
01:28:34 [2020-02-11T01:28:34.629Z] === CONT  TestMountDaemonRoot/slave/bind_root
01:28:34 [2020-02-11T01:28:34.629Z] === CONT  TestMountDaemonRoot/slave/bind_subpath
01:28:34 [2020-02-11T01:28:34.629Z] === CONT  TestMountDaemonRoot/slave/mount_subpath
01:28:34 [2020-02-11T01:28:34.629Z] === CONT  TestMountDaemonRoot/private/bind_root
01:28:34 [2020-02-11T01:28:34.629Z] === CONT  TestMountDaemonRoot/private/mount_subpath
01:28:34 [2020-02-11T01:28:34.629Z] === CONT  TestMountDaemonRoot/private/mount_root
01:28:34 [2020-02-11T01:28:34.629Z] === CONT  TestMountDaemonRoot/private/bind_subpath
01:28:34 [2020-02-11T01:28:34.629Z] --- PASS: TestMountDaemonRoot (0.02s)
01:28:34 [2020-02-11T01:28:34.629Z]     --- PASS: TestMountDaemonRoot/default (0.00s)
01:28:34 [2020-02-11T01:28:34.629Z]         --- PASS: TestMountDaemonRoot/default/mount_subpath (0.08s)
01:28:34 [2020-02-11T01:28:34.629Z]         --- PASS: TestMountDaemonRoot/default/bind_root (0.08s)
01:28:34 [2020-02-11T01:28:34.629Z]         --- PASS: TestMountDaemonRoot/default/mount_root (0.08s)
01:28:34 [2020-02-11T01:28:34.629Z]         --- PASS: TestMountDaemonRoot/default/bind_subpath (0.08s)
01:28:34 [2020-02-11T01:28:34.629Z]     --- PASS: TestMountDaemonRoot/rshared (0.00s)
01:28:34 [2020-02-11T01:28:34.629Z]         --- PASS: TestMountDaemonRoot/rshared/bind_root (0.07s)
01:28:34 [2020-02-11T01:28:34.629Z]         --- PASS: TestMountDaemonRoot/rshared/mount_root (0.08s)
01:28:34 [2020-02-11T01:28:34.629Z]         --- PASS: TestMountDaemonRoot/rshared/mount_subpath (0.09s)
01:28:34 [2020-02-11T01:28:34.629Z]         --- PASS: TestMountDaemonRoot/rshared/bind_subpath (0.08s)
01:28:34 [2020-02-11T01:28:34.629Z]     --- PASS: TestMountDaemonRoot/rprivate (0.00s)
01:28:34 [2020-02-11T01:28:34.629Z]         --- PASS: TestMountDaemonRoot/rprivate/bind_root (0.03s)
01:28:34 [2020-02-11T01:28:34.629Z]         --- PASS: TestMountDaemonRoot/rprivate/mount_root (0.06s)
01:28:34 [2020-02-11T01:28:34.629Z]         --- PASS: TestMountDaemonRoot/rprivate/mount_subpath (0.04s)
01:28:34 [2020-02-11T01:28:34.629Z]         --- PASS: TestMountDaemonRoot/rprivate/bind_subpath (0.04s)
01:28:34 [2020-02-11T01:28:34.629Z]     --- PASS: TestMountDaemonRoot/shared (0.00s)
01:28:34 [2020-02-11T01:28:34.629Z]         --- PASS: TestMountDaemonRoot/shared/mount_root (0.04s)
01:28:34 [2020-02-11T01:28:34.629Z]         --- PASS: TestMountDaemonRoot/shared/bind_subpath (0.03s)
01:28:34 [2020-02-11T01:28:34.629Z]         --- PASS: TestMountDaemonRoot/shared/bind_root (0.03s)
01:28:34 [2020-02-11T01:28:34.629Z]         --- PASS: TestMountDaemonRoot/shared/mount_subpath (0.03s)
01:28:34 [2020-02-11T01:28:34.629Z]     --- PASS: TestMountDaemonRoot/rslave (0.00s)
01:28:34 [2020-02-11T01:28:34.629Z]         --- PASS: TestMountDaemonRoot/rslave/bind_root (0.07s)
01:28:34 [2020-02-11T01:28:34.629Z]         --- PASS: TestMountDaemonRoot/rslave/mount_root (0.08s)
01:28:34 [2020-02-11T01:28:34.629Z]         --- PASS: TestMountDaemonRoot/rslave/mount_subpath (0.09s)
01:28:34 [2020-02-11T01:28:34.629Z]         --- PASS: TestMountDaemonRoot/rslave/bind_subpath (0.10s)
01:28:34 [2020-02-11T01:28:34.629Z]     --- PASS: TestMountDaemonRoot/slave (0.00s)
01:28:34 [2020-02-11T01:28:34.629Z]         --- PASS: TestMountDaemonRoot/slave/mount_root (0.05s)
01:28:34 [2020-02-11T01:28:34.629Z]         --- PASS: TestMountDaemonRoot/slave/bind_root (0.02s)
01:28:34 [2020-02-11T01:28:34.629Z]         --- PASS: TestMountDaemonRoot/slave/bind_subpath (0.05s)
01:28:34 [2020-02-11T01:28:34.629Z]         --- PASS: TestMountDaemonRoot/slave/mount_subpath (0.04s)
01:28:34 [2020-02-11T01:28:34.629Z]     --- PASS: TestMountDaemonRoot/private (0.00s)
01:28:34 [2020-02-11T01:28:34.629Z]         --- PASS: TestMountDaemonRoot/private/mount_subpath (0.03s)
01:28:34 [2020-02-11T01:28:34.629Z]         --- PASS: TestMountDaemonRoot/private/bind_root (0.04s)
01:28:34 [2020-02-11T01:28:34.629Z]         --- PASS: TestMountDaemonRoot/private/bind_subpath (0.03s)
01:28:34 [2020-02-11T01:28:34.629Z]         --- PASS: TestMountDaemonRoot/private/mount_root (0.03s)
01:28:34 [2020-02-11T01:28:34.629Z] === RUN   TestContainerBindMountNonRecursive
01:28:36 [2020-02-11T01:28:36.368Z] --- PASS: TestContainerBindMountNonRecursive (1.85s)
01:28:36 [2020-02-11T01:28:36.368Z] === RUN   TestNetworkNat
01:28:37 [2020-02-11T01:28:37.572Z] --- PASS: TestNetworkNat (0.80s)
01:28:37 [2020-02-11T01:28:37.572Z] === RUN   TestNetworkLocalhostTCPNat
01:28:38 [2020-02-11T01:28:38.318Z] --- PASS: TestNetworkLocalhostTCPNat (0.91s)
01:28:38 [2020-02-11T01:28:38.318Z] === RUN   TestNetworkLoopbackNat
01:28:39 [2020-02-11T01:28:39.541Z] --- PASS: TestNetworkLoopbackNat (1.17s)
01:28:39 [2020-02-11T01:28:39.541Z] === RUN   TestPause
01:28:40 [2020-02-11T01:28:40.290Z] --- PASS: TestPause (0.90s)
01:28:40 [2020-02-11T01:28:40.290Z] === RUN   TestPauseFailsOnWindowsServerContainers
01:28:40 [2020-02-11T01:28:40.290Z] --- SKIP: TestPauseFailsOnWindowsServerContainers (0.00s)
01:28:40 [2020-02-11T01:28:40.290Z]     pause_test.go:54: testEnv.DaemonInfo.OSType != "windows" || testEnv.DaemonInfo.Isolation != "process"
01:28:40 [2020-02-11T01:28:40.290Z] === RUN   TestPauseStopPausedContainer
01:28:41 [2020-02-11T01:28:41.032Z] --- PASS: TestPauseStopPausedContainer (0.78s)
01:28:41 [2020-02-11T01:28:41.032Z] === RUN   TestPsFilter
01:28:41 [2020-02-11T01:28:41.388Z] --- PASS: TestPsFilter (0.29s)
01:28:41 [2020-02-11T01:28:41.388Z] === RUN   TestRemoveContainerWithRemovedVolume
01:28:42 [2020-02-11T01:28:42.145Z] --- PASS: TestRemoveContainerWithRemovedVolume (0.77s)
01:28:42 [2020-02-11T01:28:42.145Z] === RUN   TestRemoveContainerWithVolume
01:28:43 [2020-02-11T01:28:43.052Z] --- PASS: TestRemoveContainerWithVolume (0.86s)
01:28:43 [2020-02-11T01:28:43.052Z] === RUN   TestRemoveContainerRunning
01:28:43 [2020-02-11T01:28:43.875Z] --- PASS: TestRemoveContainerRunning (0.91s)
01:28:43 [2020-02-11T01:28:43.875Z] === RUN   TestRemoveContainerForceRemoveRunning
01:28:44 [2020-02-11T01:28:44.702Z] --- PASS: TestRemoveContainerForceRemoveRunning (0.80s)
01:28:44 [2020-02-11T01:28:44.702Z] === RUN   TestRemoveInvalidContainer
01:28:44 [2020-02-11T01:28:44.702Z] --- PASS: TestRemoveInvalidContainer (0.01s)
01:28:44 [2020-02-11T01:28:44.702Z] === RUN   TestRenameLinkedContainer
01:28:47 [2020-02-11T01:28:47.791Z] --- PASS: TestRenameLinkedContainer (3.15s)
01:28:47 [2020-02-11T01:28:47.791Z] === RUN   TestRenameStoppedContainer
01:28:48 [2020-02-11T01:28:48.544Z] --- PASS: TestRenameStoppedContainer (0.78s)
01:28:48 [2020-02-11T01:28:48.544Z] === RUN   TestRenameRunningContainerAndReuse
01:28:50 [2020-02-11T01:28:50.271Z] --- PASS: TestRenameRunningContainerAndReuse (1.65s)
01:28:50 [2020-02-11T01:28:50.271Z] === RUN   TestRenameInvalidName
01:28:51 [2020-02-11T01:28:51.026Z] --- PASS: TestRenameInvalidName (0.89s)
01:28:51 [2020-02-11T01:28:51.026Z] === RUN   TestRenameAnonymousContainer
01:28:54 [2020-02-11T01:28:54.180Z] --- PASS: TestRenameAnonymousContainer (2.86s)
01:28:54 [2020-02-11T01:28:54.180Z] === RUN   TestRenameContainerWithSameName
01:28:54 [2020-02-11T01:28:54.968Z] --- PASS: TestRenameContainerWithSameName (0.90s)
01:28:54 [2020-02-11T01:28:54.968Z] === RUN   TestRenameContainerWithLinkedContainer
01:28:56 [2020-02-11T01:28:56.700Z] --- PASS: TestRenameContainerWithLinkedContainer (1.75s)
01:28:56 [2020-02-11T01:28:56.700Z] === RUN   TestResize
01:28:57 [2020-02-11T01:28:57.445Z] --- PASS: TestResize (0.84s)
01:28:57 [2020-02-11T01:28:57.445Z] === RUN   TestResizeWithInvalidSize
01:28:58 [2020-02-11T01:28:58.651Z] --- PASS: TestResizeWithInvalidSize (0.89s)
01:28:58 [2020-02-11T01:28:58.651Z] === RUN   TestResizeWhenContainerNotStarted
01:28:59 [2020-02-11T01:28:59.422Z] --- PASS: TestResizeWhenContainerNotStarted (0.89s)
01:28:59 [2020-02-11T01:28:59.422Z] === RUN   TestDaemonRestartKillContainers
01:28:59 [2020-02-11T01:28:59.422Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
01:28:59 [2020-02-11T01:28:59.422Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
01:28:59 [2020-02-11T01:28:59.422Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
01:28:59 [2020-02-11T01:28:59.422Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
01:28:59 [2020-02-11T01:28:59.422Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
01:28:59 [2020-02-11T01:28:59.422Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
01:28:59 [2020-02-11T01:28:59.422Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
01:28:59 [2020-02-11T01:28:59.422Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
01:28:59 [2020-02-11T01:28:59.422Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
01:28:59 [2020-02-11T01:28:59.422Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
01:28:59 [2020-02-11T01:28:59.422Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
01:28:59 [2020-02-11T01:28:59.422Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
01:28:59 [2020-02-11T01:28:59.422Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
01:28:59 [2020-02-11T01:28:59.422Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
01:28:59 [2020-02-11T01:28:59.422Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
01:28:59 [2020-02-11T01:28:59.422Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
01:28:59 [2020-02-11T01:28:59.422Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
01:28:59 [2020-02-11T01:28:59.422Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
01:28:59 [2020-02-11T01:28:59.422Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
01:28:59 [2020-02-11T01:28:59.422Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
01:28:59 [2020-02-11T01:28:59.422Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
01:28:59 [2020-02-11T01:28:59.422Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
01:28:59 [2020-02-11T01:28:59.422Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
01:28:59 [2020-02-11T01:28:59.422Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
01:28:59 [2020-02-11T01:28:59.422Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
01:28:59 [2020-02-11T01:28:59.422Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
01:29:01 [2020-02-11T01:29:01.201Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
01:29:01 [2020-02-11T01:29:01.565Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
01:29:02 [2020-02-11T01:29:02.795Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
01:29:03 [2020-02-11T01:29:03.153Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
01:29:04 [2020-02-11T01:29:04.367Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
01:29:04 [2020-02-11T01:29:04.367Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
01:29:06 [2020-02-11T01:29:06.736Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
01:29:06 [2020-02-11T01:29:06.736Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
01:29:09 [2020-02-11T01:29:09.119Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
01:29:09 [2020-02-11T01:29:09.478Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
01:29:12 [2020-02-11T01:29:12.137Z] --- PASS: TestDaemonRestartKillContainers (0.00s)
01:29:12 [2020-02-11T01:29:12.138Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon (1.99s)
01:29:12 [2020-02-11T01:29:12.138Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon (2.35s)
01:29:12 [2020-02-11T01:29:12.138Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon (1.49s)
01:29:12 [2020-02-11T01:29:12.138Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon (1.46s)
01:29:12 [2020-02-11T01:29:12.138Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon (1.41s)
01:29:12 [2020-02-11T01:29:12.138Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon (1.43s)
01:29:12 [2020-02-11T01:29:12.138Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon (2.11s)
01:29:12 [2020-02-11T01:29:12.138Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon (2.16s)
01:29:12 [2020-02-11T01:29:12.138Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon (2.76s)
01:29:12 [2020-02-11T01:29:12.138Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon (2.74s)
01:29:12 [2020-02-11T01:29:12.138Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon (2.55s)
01:29:12 [2020-02-11T01:29:12.138Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon (2.42s)
01:29:12 [2020-02-11T01:29:12.138Z] === RUN   TestCgroupNamespacesRun
01:29:13 [2020-02-11T01:29:13.878Z] --- PASS: TestCgroupNamespacesRun (1.70s)
01:29:13 [2020-02-11T01:29:13.878Z] === RUN   TestCgroupNamespacesRunPrivileged
01:29:15 [2020-02-11T01:29:15.085Z] --- PASS: TestCgroupNamespacesRunPrivileged (1.61s)
01:29:15 [2020-02-11T01:29:15.085Z] === RUN   TestCgroupNamespacesRunDaemonHostMode
01:29:16 [2020-02-11T01:29:16.836Z] --- PASS: TestCgroupNamespacesRunDaemonHostMode (1.65s)
01:29:16 [2020-02-11T01:29:16.836Z] === RUN   TestCgroupNamespacesRunHostMode
01:29:18 [2020-02-11T01:29:18.581Z] --- PASS: TestCgroupNamespacesRunHostMode (1.67s)
01:29:18 [2020-02-11T01:29:18.581Z] === RUN   TestCgroupNamespacesRunPrivateMode
01:29:20 [2020-02-11T01:29:20.326Z] --- PASS: TestCgroupNamespacesRunPrivateMode (1.65s)
01:29:20 [2020-02-11T01:29:20.326Z] === RUN   TestCgroupNamespacesRunPrivilegedAndPrivate
01:29:21 [2020-02-11T01:29:21.083Z] --- PASS: TestCgroupNamespacesRunPrivilegedAndPrivate (0.85s)
01:29:21 [2020-02-11T01:29:21.083Z] === RUN   TestCgroupNamespacesRunInvalidMode
01:29:21 [2020-02-11T01:29:21.896Z] --- PASS: TestCgroupNamespacesRunInvalidMode (0.88s)
01:29:21 [2020-02-11T01:29:21.896Z] === RUN   TestCgroupNamespacesRunOlderClient
01:29:23 [2020-02-11T01:29:23.826Z] --- PASS: TestCgroupNamespacesRunOlderClient (2.04s)
01:29:23 [2020-02-11T01:29:23.826Z] === RUN   TestKernelTCPMemory
01:29:25 [2020-02-11T01:29:25.040Z] --- PASS: TestKernelTCPMemory (0.93s)
01:29:25 [2020-02-11T01:29:25.040Z] === RUN   TestNISDomainname
01:29:25 [2020-02-11T01:29:25.814Z] --- PASS: TestNISDomainname (1.06s)
01:29:25 [2020-02-11T01:29:25.814Z] === RUN   TestHostnameDnsResolution
01:29:27 [2020-02-11T01:29:27.025Z] --- PASS: TestHostnameDnsResolution (1.07s)
01:29:27 [2020-02-11T01:29:27.025Z] === RUN   TestStats
01:29:28 [2020-02-11T01:29:28.764Z] --- PASS: TestStats (1.87s)
01:29:28 [2020-02-11T01:29:28.764Z] === RUN   TestStopContainerWithTimeout
01:29:28 [2020-02-11T01:29:28.764Z] === RUN   TestStopContainerWithTimeout/0
01:29:28 [2020-02-11T01:29:28.764Z] === PAUSE TestStopContainerWithTimeout/0
01:29:28 [2020-02-11T01:29:28.764Z] === RUN   TestStopContainerWithTimeout/1
01:29:28 [2020-02-11T01:29:28.764Z] === PAUSE TestStopContainerWithTimeout/1
01:29:28 [2020-02-11T01:29:28.764Z] === RUN   TestStopContainerWithTimeout/3
01:29:28 [2020-02-11T01:29:28.764Z] === PAUSE TestStopContainerWithTimeout/3
01:29:28 [2020-02-11T01:29:28.764Z] === RUN   TestStopContainerWithTimeout/-1
01:29:28 [2020-02-11T01:29:28.764Z] === PAUSE TestStopContainerWithTimeout/-1
01:29:28 [2020-02-11T01:29:28.764Z] === CONT  TestStopContainerWithTimeout/0
01:29:28 [2020-02-11T01:29:28.764Z] === CONT  TestStopContainerWithTimeout/-1
01:29:29 [2020-02-11T01:29:29.977Z] === CONT  TestStopContainerWithTimeout/3
01:29:31 [2020-02-11T01:29:31.719Z] === CONT  TestStopContainerWithTimeout/1
01:29:34 [2020-02-11T01:29:34.078Z] --- PASS: TestStopContainerWithTimeout (0.01s)
01:29:34 [2020-02-11T01:29:34.078Z]     --- PASS: TestStopContainerWithTimeout/0 (0.99s)
01:29:34 [2020-02-11T01:29:34.078Z]     --- PASS: TestStopContainerWithTimeout/-1 (2.95s)
01:29:34 [2020-02-11T01:29:34.078Z]     --- PASS: TestStopContainerWithTimeout/3 (2.90s)
01:29:34 [2020-02-11T01:29:34.078Z]     --- PASS: TestStopContainerWithTimeout/1 (1.85s)
01:29:34 [2020-02-11T01:29:34.078Z] === RUN   TestDeleteDevicemapper
01:29:34 [2020-02-11T01:29:34.078Z] --- SKIP: TestDeleteDevicemapper (0.01s)
01:29:34 [2020-02-11T01:29:34.078Z]     stop_linux_test.go:74: testEnv.DaemonInfo.Driver != "devicemapper"
01:29:34 [2020-02-11T01:29:34.078Z] === RUN   TestStopContainerWithRestartPolicyAlways
01:29:37 [2020-02-11T01:29:37.193Z] --- PASS: TestStopContainerWithRestartPolicyAlways (3.38s)
01:29:37 [2020-02-11T01:29:37.193Z] === RUN   TestUpdateMemory
01:29:37 [2020-02-11T01:29:37.193Z] --- SKIP: TestUpdateMemory (0.00s)
01:29:37 [2020-02-11T01:29:37.193Z]     update_linux_test.go:23: !testEnv.DaemonInfo.SwapLimit
01:29:37 [2020-02-11T01:29:37.193Z] === RUN   TestUpdateCPUQuota
01:29:38 [2020-02-11T01:29:38.646Z] --- PASS: TestUpdateCPUQuota (1.40s)
01:29:38 [2020-02-11T01:29:38.646Z] === RUN   TestUpdatePidsLimit
01:29:38 [2020-02-11T01:29:38.646Z] === RUN   TestUpdatePidsLimit/update_from_none
01:29:38 [2020-02-11T01:29:38.646Z] === RUN   TestUpdatePidsLimit/no_change
01:29:39 [2020-02-11T01:29:39.142Z] === RUN   TestUpdatePidsLimit/update_lower
01:29:39 [2020-02-11T01:29:39.689Z] === RUN   TestUpdatePidsLimit/update_on_old_api_ignores_value
01:29:40 [2020-02-11T01:29:40.041Z] === RUN   TestUpdatePidsLimit/unset_limit_with_zero
01:29:40 [2020-02-11T01:29:40.396Z] === RUN   TestUpdatePidsLimit/unset_limit_with_minus_one
01:29:40 [2020-02-11T01:29:40.749Z] === RUN   TestUpdatePidsLimit/unset_limit_with_minus_two
01:29:42 [2020-02-11T01:29:42.494Z] --- PASS: TestUpdatePidsLimit (3.80s)
01:29:42 [2020-02-11T01:29:42.494Z]     --- PASS: TestUpdatePidsLimit/update_from_none (0.35s)
01:29:42 [2020-02-11T01:29:42.494Z]     --- PASS: TestUpdatePidsLimit/no_change (0.41s)
01:29:42 [2020-02-11T01:29:42.494Z]     --- PASS: TestUpdatePidsLimit/update_lower (0.40s)
01:29:42 [2020-02-11T01:29:42.494Z]     --- PASS: TestUpdatePidsLimit/update_on_old_api_ignores_value (0.41s)
01:29:42 [2020-02-11T01:29:42.494Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_zero (0.47s)
01:29:42 [2020-02-11T01:29:42.494Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_minus_one (0.36s)
01:29:42 [2020-02-11T01:29:42.494Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_minus_two (0.37s)
01:29:42 [2020-02-11T01:29:42.494Z] === RUN   TestUpdateRestartPolicy
01:29:55 [2020-02-11T01:29:55.885Z] --- PASS: TestUpdateRestartPolicy (12.60s)
01:29:55 [2020-02-11T01:29:55.885Z] === RUN   TestUpdateRestartWithAutoRemove
01:29:55 [2020-02-11T01:29:55.885Z] --- PASS: TestUpdateRestartWithAutoRemove (0.90s)
01:29:55 [2020-02-11T01:29:55.885Z] === RUN   TestWaitNonBlocked
01:29:55 [2020-02-11T01:29:55.885Z] === RUN   TestWaitNonBlocked/wait-nonblocking-exit-0
01:29:55 [2020-02-11T01:29:55.885Z] === PAUSE TestWaitNonBlocked/wait-nonblocking-exit-0
01:29:55 [2020-02-11T01:29:55.885Z] === RUN   TestWaitNonBlocked/wait-nonblocking-exit-random
01:29:55 [2020-02-11T01:29:55.885Z] === PAUSE TestWaitNonBlocked/wait-nonblocking-exit-random
01:29:55 [2020-02-11T01:29:55.885Z] === CONT  TestWaitNonBlocked/wait-nonblocking-exit-0
01:29:55 [2020-02-11T01:29:55.885Z] === CONT  TestWaitNonBlocked/wait-nonblocking-exit-random
01:29:56 [2020-02-11T01:29:56.639Z] --- PASS: TestWaitNonBlocked (0.02s)
01:29:56 [2020-02-11T01:29:56.639Z]     --- PASS: TestWaitNonBlocked/wait-nonblocking-exit-random (1.01s)
01:29:56 [2020-02-11T01:29:56.639Z]     --- PASS: TestWaitNonBlocked/wait-nonblocking-exit-0 (1.06s)
01:29:56 [2020-02-11T01:29:56.639Z] === RUN   TestWaitBlocked
01:29:56 [2020-02-11T01:29:56.993Z] === RUN   TestWaitBlocked/test-wait-blocked-exit-zero
01:29:56 [2020-02-11T01:29:56.993Z] === PAUSE TestWaitBlocked/test-wait-blocked-exit-zero
01:29:56 [2020-02-11T01:29:56.993Z] === RUN   TestWaitBlocked/test-wait-blocked-exit-random
01:29:56 [2020-02-11T01:29:56.993Z] === PAUSE TestWaitBlocked/test-wait-blocked-exit-random
01:29:56 [2020-02-11T01:29:56.993Z] === CONT  TestWaitBlocked/test-wait-blocked-exit-zero
01:29:56 [2020-02-11T01:29:56.993Z] === CONT  TestWaitBlocked/test-wait-blocked-exit-random
01:29:57 [2020-02-11T01:29:57.834Z] --- PASS: TestWaitBlocked (0.02s)
01:29:57 [2020-02-11T01:29:57.834Z]     --- PASS: TestWaitBlocked/test-wait-blocked-exit-zero (1.03s)
01:29:57 [2020-02-11T01:29:57.834Z]     --- PASS: TestWaitBlocked/test-wait-blocked-exit-random (1.08s)
01:29:57 [2020-02-11T01:29:57.834Z] === CONT  TestContainerStartOnDaemonRestart
01:29:57 [2020-02-11T01:29:57.834Z] === CONT  TestIpcModeOlderClient
01:29:58 [2020-02-11T01:29:58.226Z] --- PASS: TestIpcModeOlderClient (0.15s)
01:29:58 [2020-02-11T01:29:58.226Z] === CONT  TestDaemonHostGatewayIP
01:30:00 [2020-02-11T01:30:00.674Z] --- PASS: TestContainerStartOnDaemonRestart (2.84s)
01:30:00 [2020-02-11T01:30:00.674Z] === CONT  TestDaemonRestartIpcMode
01:30:01 [2020-02-11T01:30:01.455Z] --- PASS: TestDaemonHostGatewayIP (3.36s)
01:30:04 [2020-02-11T01:30:04.585Z] --- PASS: TestDaemonRestartIpcMode (3.28s)
01:30:04 [2020-02-11T01:30:04.585Z] PASS
01:30:04 [2020-02-11T01:30:04.585Z] 
01:30:04 [2020-02-11T01:30:04.585Z] === Skipped
01:30:04 [2020-02-11T01:30:04.585Z] === SKIP: s390x.integration.container TestCheckpoint (0.00s)
01:30:04 [2020-02-11T01:30:04.585Z]     checkpoint_test.go:33: TestCheckpoint is broken; see https://github.com/moby/moby/issues/38963
01:30:04 [2020-02-11T01:30:04.585Z] 
01:30:04 [2020-02-11T01:30:04.585Z] === SKIP: s390x.integration.container TestInspectOomKilledTrue (0.13s)
01:30:04 [2020-02-11T01:30:04.585Z]     kill_test.go:151: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
01:30:04 [2020-02-11T01:30:04.585Z] 
01:30:04 [2020-02-11T01:30:04.585Z] === SKIP: s390x.integration.container TestInspectOomKilledFalse (0.00s)
01:30:04 [2020-02-11T01:30:04.585Z]     kill_test.go:169: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
01:30:04 [2020-02-11T01:30:04.585Z] 
01:30:04 [2020-02-11T01:30:04.585Z] === SKIP: s390x.integration.container TestPauseFailsOnWindowsServerContainers (0.00s)
01:30:04 [2020-02-11T01:30:04.585Z]     pause_test.go:54: testEnv.DaemonInfo.OSType != "windows" || testEnv.DaemonInfo.Isolation != "process"
01:30:04 [2020-02-11T01:30:04.585Z] 
01:30:04 [2020-02-11T01:30:04.585Z] === SKIP: s390x.integration.container TestDeleteDevicemapper (0.01s)
01:30:04 [2020-02-11T01:30:04.585Z]     stop_linux_test.go:74: testEnv.DaemonInfo.Driver != "devicemapper"
01:30:04 [2020-02-11T01:30:04.585Z] 
01:30:04 [2020-02-11T01:30:04.585Z] === SKIP: s390x.integration.container TestUpdateMemory (0.00s)
01:30:04 [2020-02-11T01:30:04.585Z]     update_linux_test.go:23: !testEnv.DaemonInfo.SwapLimit
01:30:04 [2020-02-11T01:30:04.585Z] 
01:30:04 [2020-02-11T01:30:04.585Z] 
01:30:04 [2020-02-11T01:30:04.585Z] DONE 199 tests, 6 skipped in 135.239s
01:30:04 [2020-02-11T01:30:04.585Z] Running /go/src/github.com/docker/docker/integration/image (s390x.integration.image) flags=-test.v -test.timeout=120m 
01:30:04 [2020-02-11T01:30:04.585Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-image-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-image-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.image -t ./test.main -test.v -test.timeout=120m
01:30:04 [2020-02-11T01:30:04.585Z] ++ set -e
01:30:04 [2020-02-11T01:30:04.585Z] ++ '[' -n 0 ']'
01:30:04 [2020-02-11T01:30:04.585Z] ++ set -x
01:30:04 [2020-02-11T01:30:04.585Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=s390x DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-image-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-image-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.image -t ./test.main -test.v -test.timeout=120m
01:30:04 [2020-02-11T01:30:04.585Z] INFO: Testing against a local daemon
01:30:04 [2020-02-11T01:30:04.586Z] === RUN   TestCommitInheritsEnv
01:30:04 [2020-02-11T01:30:04.586Z] --- PASS: TestCommitInheritsEnv (0.48s)
01:30:04 [2020-02-11T01:30:04.586Z] === RUN   TestImportExtremelyLargeImageWorks
01:30:04 [2020-02-11T01:30:04.586Z] === PAUSE TestImportExtremelyLargeImageWorks
01:30:04 [2020-02-11T01:30:04.586Z] === RUN   TestImagesFilterMultiReference
01:30:04 [2020-02-11T01:30:04.586Z] --- PASS: TestImagesFilterMultiReference (0.04s)
01:30:04 [2020-02-11T01:30:04.586Z] === RUN   TestImagePullPlatformInvalid
01:30:04 [2020-02-11T01:30:04.586Z] --- PASS: TestImagePullPlatformInvalid (0.02s)
01:30:04 [2020-02-11T01:30:04.586Z] === RUN   TestRemoveImageOrphaning
01:30:05 [2020-02-11T01:30:05.352Z] --- PASS: TestRemoveImageOrphaning (0.44s)
01:30:05 [2020-02-11T01:30:05.352Z] === RUN   TestRemoveImageGarbageCollector
01:30:05 [2020-02-11T01:30:05.352Z] --- SKIP: TestRemoveImageGarbageCollector (0.01s)
01:30:05 [2020-02-11T01:30:05.352Z]     remove_unix_test.go:36: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
01:30:05 [2020-02-11T01:30:05.352Z] === RUN   TestTagUnprefixedRepoByNameOrName
01:30:05 [2020-02-11T01:30:05.352Z] --- PASS: TestTagUnprefixedRepoByNameOrName (0.03s)
01:30:05 [2020-02-11T01:30:05.352Z] === RUN   TestTagInvalidReference
01:30:05 [2020-02-11T01:30:05.352Z] --- PASS: TestTagInvalidReference (0.01s)
01:30:05 [2020-02-11T01:30:05.352Z] === RUN   TestTagValidPrefixedRepo
01:30:05 [2020-02-11T01:30:05.352Z] --- PASS: TestTagValidPrefixedRepo (0.03s)
01:30:05 [2020-02-11T01:30:05.352Z] === RUN   TestTagExistedNameWithoutForce
01:30:05 [2020-02-11T01:30:05.352Z] --- PASS: TestTagExistedNameWithoutForce (0.01s)
01:30:05 [2020-02-11T01:30:05.352Z] === RUN   TestTagOfficialNames
01:30:05 [2020-02-11T01:30:05.352Z] --- PASS: TestTagOfficialNames (0.04s)
01:30:05 [2020-02-11T01:30:05.352Z] === RUN   TestTagMatchesDigest
01:30:05 [2020-02-11T01:30:05.352Z] --- PASS: TestTagMatchesDigest (0.02s)
01:30:05 [2020-02-11T01:30:05.352Z] === CONT  TestImportExtremelyLargeImageWorks
01:31:29 [2020-02-11T01:31:29.157Z] --- PASS: TestImportExtremelyLargeImageWorks (80.01s)
01:31:29 [2020-02-11T01:31:29.158Z] PASS
01:31:29 [2020-02-11T01:31:29.158Z] 
01:31:29 [2020-02-11T01:31:29.158Z] === Skipped
01:31:29 [2020-02-11T01:31:29.158Z] === SKIP: s390x.integration.image TestRemoveImageGarbageCollector (0.01s)
01:31:29 [2020-02-11T01:31:29.158Z]     remove_unix_test.go:36: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
01:31:29 [2020-02-11T01:31:29.158Z] 
01:31:29 [2020-02-11T01:31:29.158Z] 
01:31:29 [2020-02-11T01:31:29.158Z] DONE 12 tests, 1 skipped in 81.258s
01:31:29 [2020-02-11T01:31:29.158Z] Running /go/src/github.com/docker/docker/integration/network (s390x.integration.network) flags=-test.v -test.timeout=120m 
01:31:29 [2020-02-11T01:31:29.158Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-network-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-network-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.network -t ./test.main -test.v -test.timeout=120m
01:31:29 [2020-02-11T01:31:29.158Z] ++ set -e
01:31:29 [2020-02-11T01:31:29.158Z] ++ '[' -n 0 ']'
01:31:29 [2020-02-11T01:31:29.158Z] ++ set -x
01:31:29 [2020-02-11T01:31:29.158Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=s390x DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-network-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-network-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.network -t ./test.main -test.v -test.timeout=120m
01:31:29 [2020-02-11T01:31:29.158Z] INFO: Testing against a local daemon
01:31:29 [2020-02-11T01:31:29.158Z] === RUN   TestNetworkCreateDelete
01:31:29 [2020-02-11T01:31:29.158Z] --- PASS: TestNetworkCreateDelete (0.14s)
01:31:29 [2020-02-11T01:31:29.158Z] === RUN   TestDockerNetworkDeletePreferID
01:31:29 [2020-02-11T01:31:29.158Z] --- PASS: TestDockerNetworkDeletePreferID (0.29s)
01:31:29 [2020-02-11T01:31:29.158Z] === RUN   TestInspectNetwork
01:31:29 [2020-02-11T01:31:29.158Z] === RUN   TestInspectNetwork/full_network_id
01:31:29 [2020-02-11T01:31:29.158Z] === RUN   TestInspectNetwork/partial_network_id
01:31:29 [2020-02-11T01:31:29.158Z] === RUN   TestInspectNetwork/network_name
01:31:29 [2020-02-11T01:31:29.158Z] === RUN   TestInspectNetwork/network_name_and_swarm_scope
01:31:35 [2020-02-11T01:31:35.197Z] --- PASS: TestInspectNetwork (8.55s)
01:31:35 [2020-02-11T01:31:35.197Z]     --- PASS: TestInspectNetwork/full_network_id (0.00s)
01:31:35 [2020-02-11T01:31:35.197Z]     --- PASS: TestInspectNetwork/partial_network_id (0.00s)
01:31:35 [2020-02-11T01:31:35.197Z]     --- PASS: TestInspectNetwork/network_name (0.00s)
01:31:35 [2020-02-11T01:31:35.197Z]     --- PASS: TestInspectNetwork/network_name_and_swarm_scope (0.00s)
01:31:35 [2020-02-11T01:31:35.197Z] === RUN   TestRunContainerWithBridgeNone
01:31:36 [2020-02-11T01:31:36.936Z] --- PASS: TestRunContainerWithBridgeNone (2.31s)
01:31:36 [2020-02-11T01:31:36.936Z] === RUN   TestNetworkInvalidJSON
01:31:36 [2020-02-11T01:31:36.936Z] === RUN   TestNetworkInvalidJSON//networks/create
01:31:36 [2020-02-11T01:31:36.936Z] === PAUSE TestNetworkInvalidJSON//networks/create
01:31:36 [2020-02-11T01:31:36.936Z] === RUN   TestNetworkInvalidJSON//networks/bridge/connect
01:31:36 [2020-02-11T01:31:36.936Z] === PAUSE TestNetworkInvalidJSON//networks/bridge/connect
01:31:36 [2020-02-11T01:31:36.936Z] === RUN   TestNetworkInvalidJSON//networks/bridge/disconnect
01:31:36 [2020-02-11T01:31:36.936Z] === PAUSE TestNetworkInvalidJSON//networks/bridge/disconnect
01:31:36 [2020-02-11T01:31:36.936Z] === CONT  TestNetworkInvalidJSON//networks/create
01:31:36 [2020-02-11T01:31:36.936Z] === CONT  TestNetworkInvalidJSON//networks/bridge/disconnect
01:31:36 [2020-02-11T01:31:36.936Z] === CONT  TestNetworkInvalidJSON//networks/bridge/connect
01:31:36 [2020-02-11T01:31:36.936Z] --- PASS: TestNetworkInvalidJSON (0.01s)
01:31:36 [2020-02-11T01:31:36.936Z]     --- PASS: TestNetworkInvalidJSON//networks/create (0.00s)
01:31:36 [2020-02-11T01:31:36.936Z]     --- PASS: TestNetworkInvalidJSON//networks/bridge/disconnect (0.00s)
01:31:36 [2020-02-11T01:31:36.936Z]     --- PASS: TestNetworkInvalidJSON//networks/bridge/connect (0.00s)
01:31:36 [2020-02-11T01:31:36.936Z] === RUN   TestDaemonRestartWithLiveRestore
01:31:37 [2020-02-11T01:31:37.672Z] --- PASS: TestDaemonRestartWithLiveRestore (1.03s)
01:31:37 [2020-02-11T01:31:37.672Z] === RUN   TestDaemonDefaultNetworkPools
01:31:38 [2020-02-11T01:31:38.411Z] --- PASS: TestDaemonDefaultNetworkPools (0.75s)
01:31:38 [2020-02-11T01:31:38.411Z] === RUN   TestDaemonRestartWithExistingNetwork
01:31:39 [2020-02-11T01:31:39.611Z] --- PASS: TestDaemonRestartWithExistingNetwork (1.12s)
01:31:39 [2020-02-11T01:31:39.611Z] === RUN   TestDaemonRestartWithExistingNetworkWithDefaultPoolRange
01:31:41 [2020-02-11T01:31:41.006Z] --- PASS: TestDaemonRestartWithExistingNetworkWithDefaultPoolRange (1.20s)
01:31:41 [2020-02-11T01:31:41.006Z] === RUN   TestDaemonWithBipAndDefaultNetworkPool
01:31:41 [2020-02-11T01:31:41.396Z] --- PASS: TestDaemonWithBipAndDefaultNetworkPool (0.58s)
01:31:41 [2020-02-11T01:31:41.396Z] === RUN   TestServiceWithPredefinedNetwork
01:31:44 [2020-02-11T01:31:44.519Z] --- PASS: TestServiceWithPredefinedNetwork (2.81s)
01:31:44 [2020-02-11T01:31:44.519Z] === RUN   TestServiceRemoveKeepsIngressNetwork
01:31:44 [2020-02-11T01:31:44.519Z] --- SKIP: TestServiceRemoveKeepsIngressNetwork (0.00s)
01:31:44 [2020-02-11T01:31:44.519Z]     service_test.go:230: FLAKY_TEST
01:31:44 [2020-02-11T01:31:44.519Z] === RUN   TestServiceWithDataPathPortInit
01:32:00 [2020-02-11T01:32:00.797Z] --- PASS: TestServiceWithDataPathPortInit (16.59s)
01:32:00 [2020-02-11T01:32:00.797Z] === RUN   TestServiceWithDefaultAddressPoolInit
01:32:09 [2020-02-11T01:32:09.937Z] --- PASS: TestServiceWithDefaultAddressPoolInit (8.08s)
01:32:09 [2020-02-11T01:32:09.937Z]     service_test.go:418: TestServiceWithDefaultAddressPoolInit: NetworkInspect: {Name:sthiraTestServiceWithDefaultAddressPoolInit ID:yuaoflzqx6lv52khkdjwalwve Created:2020-02-11 01:32:02.113314915 +0000 UTC Scope:swarm Driver:overlay EnableIPv6:false IPAM:{Driver:default Options:map[] Config:[{Subnet:20.20.1.0/24 IPRange: Gateway:20.20.1.1 AuxAddress:map[]}]} Internal:false Attachable:false Ingress:false ConfigFrom:{Network:} ConfigOnly:false Containers:map[2d5602baa5c18e520c7c6f03be83e5dac448ceee6173693ceba2a34fc943a0fc:{Name:TestServiceTestServiceWithDefaultAddressPoolInit.1.5z9ublh3odyiuasrzdqcpa9yc EndpointID:10e9eafb6b9dfa65df8f847219339e11ace6078fd632d8160a45ab1e4e008166 MacAddress:02:42:14:14:01:03 IPv4Address:20.20.1.3/24 IPv6Address:} lb-sthiraTestServiceWithDefaultAddressPoolInit:{Name:sthiraTestServiceWithDefaultAddressPoolInit-endpoint EndpointID:138786dfe373b66aa3f1badfb3f8849b16cb5acccd25685168e39a77d169cb67 MacAddress:02:42:14:14:01:04 IPv4Address:20.20.1.4/24 IPv6Address:}] Options:map[com.docker.network.driver.overlay.vxlanid_list:4097] Labels:map[] Peers:[{Name:3e4f383edbaa IP:127.0.0.1}] Services:map[TestServiceTestServiceWithDefaultAddressPoolInit:{VIP:20.20.1.2 Ports:[] LocalLBIndex:256 Tasks:[{Name:TestServiceTestServiceWithDefaultAddressPoolInit.1.5z9ublh3odyiuasrzdqcpa9yc EndpointID:10e9eafb6b9dfa65df8f847219339e11ace6078fd632d8160a45ab1e4e008166 EndpointIP:20.20.1.3 Info:map[Host IP:127.0.0.1]}]}]}
01:32:09 [2020-02-11T01:32:09.937Z] PASS
01:32:09 [2020-02-11T01:32:09.937Z] 
01:32:09 [2020-02-11T01:32:09.937Z] === Skipped
01:32:09 [2020-02-11T01:32:09.937Z] === SKIP: s390x.integration.network TestServiceRemoveKeepsIngressNetwork (0.00s)
01:32:09 [2020-02-11T01:32:09.937Z]     service_test.go:230: FLAKY_TEST
01:32:09 [2020-02-11T01:32:09.937Z] 
01:32:09 [2020-02-11T01:32:09.937Z] 
01:32:09 [2020-02-11T01:32:09.937Z] DONE 21 tests, 1 skipped in 43.540s
01:32:09 [2020-02-11T01:32:09.937Z] Running /go/src/github.com/docker/docker/integration/network/ipvlan (s390x.integration.network.ipvlan) flags=-test.v -test.timeout=120m 
01:32:09 [2020-02-11T01:32:09.937Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-network-ipvlan-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-network-ipvlan-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.network.ipvlan -t ./test.main -test.v -test.timeout=120m
01:32:09 [2020-02-11T01:32:09.937Z] ++ set -e
01:32:09 [2020-02-11T01:32:09.937Z] ++ '[' -n 0 ']'
01:32:09 [2020-02-11T01:32:09.937Z] ++ set -x
01:32:09 [2020-02-11T01:32:09.937Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=s390x DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-network-ipvlan-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-network-ipvlan-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.network.ipvlan -t ./test.main -test.v -test.timeout=120m
01:32:09 [2020-02-11T01:32:09.937Z] INFO: Testing against a local daemon
01:32:09 [2020-02-11T01:32:09.937Z] === RUN   TestDockerNetworkIpvlanPersistance
01:32:09 [2020-02-11T01:32:09.937Z] --- SKIP: TestDockerNetworkIpvlanPersistance (0.01s)
01:32:09 [2020-02-11T01:32:09.937Z]     ipvlan_test.go:26: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
01:32:09 [2020-02-11T01:32:09.937Z] === RUN   TestDockerNetworkIpvlan
01:32:09 [2020-02-11T01:32:09.937Z] --- SKIP: TestDockerNetworkIpvlan (0.00s)
01:32:09 [2020-02-11T01:32:09.937Z]     ipvlan_test.go:53: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
01:32:09 [2020-02-11T01:32:09.937Z] PASS
01:32:09 [2020-02-11T01:32:09.937Z] 
01:32:09 [2020-02-11T01:32:09.937Z] === Skipped
01:32:09 [2020-02-11T01:32:09.937Z] === SKIP: s390x.integration.network.ipvlan TestDockerNetworkIpvlanPersistance (0.01s)
01:32:09 [2020-02-11T01:32:09.937Z]     ipvlan_test.go:26: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
01:32:09 [2020-02-11T01:32:09.937Z] 
01:32:09 [2020-02-11T01:32:09.937Z] === SKIP: s390x.integration.network.ipvlan TestDockerNetworkIpvlan (0.00s)
01:32:09 [2020-02-11T01:32:09.937Z]     ipvlan_test.go:53: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
01:32:09 [2020-02-11T01:32:09.937Z] 
01:32:09 [2020-02-11T01:32:09.937Z] 
01:32:09 [2020-02-11T01:32:09.937Z] DONE 2 tests, 2 skipped in 0.084s
01:32:09 [2020-02-11T01:32:09.937Z] Running /go/src/github.com/docker/docker/integration/network/macvlan (s390x.integration.network.macvlan) flags=-test.v -test.timeout=120m 
01:32:09 [2020-02-11T01:32:09.937Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-network-macvlan-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-network-macvlan-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.network.macvlan -t ./test.main -test.v -test.timeout=120m
01:32:09 [2020-02-11T01:32:09.937Z] ++ set -e
01:32:09 [2020-02-11T01:32:09.937Z] ++ '[' -n 0 ']'
01:32:09 [2020-02-11T01:32:09.937Z] ++ set -x
01:32:09 [2020-02-11T01:32:09.937Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=s390x DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-network-macvlan-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-network-macvlan-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.network.macvlan -t ./test.main -test.v -test.timeout=120m
01:32:09 [2020-02-11T01:32:09.937Z] INFO: Testing against a local daemon
01:32:09 [2020-02-11T01:32:09.937Z] === RUN   TestDockerNetworkMacvlanPersistance
01:32:10 [2020-02-11T01:32:10.282Z] --- PASS: TestDockerNetworkMacvlanPersistance (1.37s)
01:32:10 [2020-02-11T01:32:10.282Z] === RUN   TestDockerNetworkMacvlan
01:32:11 [2020-02-11T01:32:11.201Z] === RUN   TestDockerNetworkMacvlan/Subinterface
01:32:12 [2020-02-11T01:32:12.095Z] === RUN   TestDockerNetworkMacvlan/OverlapParent
01:32:12 [2020-02-11T01:32:12.860Z] === RUN   TestDockerNetworkMacvlan/NilParent
01:32:15 [2020-02-11T01:32:15.221Z] === RUN   TestDockerNetworkMacvlan/InternalMode
01:32:19 [2020-02-11T01:32:19.145Z] === RUN   TestDockerNetworkMacvlan/MultiSubnet
01:32:23 [2020-02-11T01:32:23.078Z] === RUN   TestDockerNetworkMacvlan/Addressing
01:32:24 [2020-02-11T01:32:24.304Z] --- PASS: TestDockerNetworkMacvlan (13.83s)
01:32:24 [2020-02-11T01:32:24.304Z]     --- PASS: TestDockerNetworkMacvlan/Subinterface (0.06s)
01:32:24 [2020-02-11T01:32:24.304Z]     --- PASS: TestDockerNetworkMacvlan/OverlapParent (0.07s)
01:32:24 [2020-02-11T01:32:24.304Z]     --- PASS: TestDockerNetworkMacvlan/NilParent (1.09s)
01:32:24 [2020-02-11T01:32:24.304Z]     --- PASS: TestDockerNetworkMacvlan/InternalMode (2.08s)
01:32:24 [2020-02-11T01:32:24.304Z]     --- PASS: TestDockerNetworkMacvlan/MultiSubnet (2.73s)
01:32:24 [2020-02-11T01:32:24.304Z]     --- PASS: TestDockerNetworkMacvlan/Addressing (0.80s)
01:32:24 [2020-02-11T01:32:24.304Z] PASS
01:32:24 [2020-02-11T01:32:24.304Z] 
01:32:24 [2020-02-11T01:32:24.304Z] DONE 8 tests in 15.275s
01:32:24 [2020-02-11T01:32:24.304Z] Running /go/src/github.com/docker/docker/integration/plugin (s390x.integration.plugin) flags=-test.v -test.timeout=120m 
01:32:24 [2020-02-11T01:32:24.304Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.plugin -t ./test.main -test.v -test.timeout=120m
01:32:24 [2020-02-11T01:32:24.304Z] ++ set -e
01:32:24 [2020-02-11T01:32:24.304Z] ++ '[' -n 0 ']'
01:32:24 [2020-02-11T01:32:24.304Z] ++ set -x
01:32:24 [2020-02-11T01:32:24.304Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=s390x DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.plugin -t ./test.main -test.v -test.timeout=120m
01:32:24 [2020-02-11T01:32:24.304Z] testing: warning: no tests to run
01:32:24 [2020-02-11T01:32:24.304Z] PASS
01:32:24 [2020-02-11T01:32:24.304Z] 
01:32:24 [2020-02-11T01:32:24.304Z] DONE 0 tests in 0.015s
01:32:24 [2020-02-11T01:32:24.304Z] Running /go/src/github.com/docker/docker/integration/plugin/authz (s390x.integration.plugin.authz) flags=-test.v -test.timeout=120m 
01:32:24 [2020-02-11T01:32:24.304Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-authz-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-authz-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.plugin.authz -t ./test.main -test.v -test.timeout=120m
01:32:24 [2020-02-11T01:32:24.304Z] ++ set -e
01:32:24 [2020-02-11T01:32:24.304Z] ++ '[' -n 0 ']'
01:32:24 [2020-02-11T01:32:24.304Z] ++ set -x
01:32:24 [2020-02-11T01:32:24.304Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=s390x DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-authz-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-authz-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.plugin.authz -t ./test.main -test.v -test.timeout=120m
01:32:24 [2020-02-11T01:32:24.304Z] INFO: Testing against a local daemon
01:32:24 [2020-02-11T01:32:24.304Z] === RUN   TestAuthZPluginAllowRequest
01:32:26 [2020-02-11T01:32:26.223Z] --- PASS: TestAuthZPluginAllowRequest (1.69s)
01:32:26 [2020-02-11T01:32:26.223Z] === RUN   TestAuthZPluginTLS
01:32:26 [2020-02-11T01:32:26.572Z] --- PASS: TestAuthZPluginTLS (0.54s)
01:32:26 [2020-02-11T01:32:26.573Z] === RUN   TestAuthZPluginDenyRequest
01:32:27 [2020-02-11T01:32:27.323Z] --- PASS: TestAuthZPluginDenyRequest (0.53s)
01:32:27 [2020-02-11T01:32:27.323Z] === RUN   TestAuthZPluginAPIDenyResponse
01:32:27 [2020-02-11T01:32:27.672Z] --- PASS: TestAuthZPluginAPIDenyResponse (0.53s)
01:32:27 [2020-02-11T01:32:27.672Z] === RUN   TestAuthZPluginDenyResponse
01:32:28 [2020-02-11T01:32:28.431Z] --- PASS: TestAuthZPluginDenyResponse (0.55s)
01:32:28 [2020-02-11T01:32:28.431Z] === RUN   TestAuthZPluginAllowEventStream
01:32:29 [2020-02-11T01:32:29.644Z] --- PASS: TestAuthZPluginAllowEventStream (1.59s)
01:32:29 [2020-02-11T01:32:29.644Z] === RUN   TestAuthZPluginErrorResponse
01:32:30 [2020-02-11T01:32:30.407Z] --- PASS: TestAuthZPluginErrorResponse (0.54s)
01:32:30 [2020-02-11T01:32:30.407Z] === RUN   TestAuthZPluginErrorRequest
01:32:30 [2020-02-11T01:32:30.760Z] --- PASS: TestAuthZPluginErrorRequest (0.54s)
01:32:30 [2020-02-11T01:32:30.760Z] === RUN   TestAuthZPluginEnsureNoDuplicatePluginRegistration
01:32:31 [2020-02-11T01:32:31.499Z] --- PASS: TestAuthZPluginEnsureNoDuplicatePluginRegistration (0.54s)
01:32:31 [2020-02-11T01:32:31.499Z] === RUN   TestAuthZPluginEnsureLoadImportWorking
01:32:33 [2020-02-11T01:32:33.258Z] --- PASS: TestAuthZPluginEnsureLoadImportWorking (1.93s)
01:32:33 [2020-02-11T01:32:33.258Z] === RUN   TestAuthzPluginEnsureContainerCopyToFrom
01:32:35 [2020-02-11T01:32:35.624Z] --- PASS: TestAuthzPluginEnsureContainerCopyToFrom (2.05s)
01:32:35 [2020-02-11T01:32:35.624Z] === RUN   TestAuthZPluginHeader
01:32:36 [2020-02-11T01:32:36.401Z] --- PASS: TestAuthZPluginHeader (0.86s)
01:32:36 [2020-02-11T01:32:36.401Z] === RUN   TestAuthZPluginV2AllowNonVolumeRequest
01:32:36 [2020-02-11T01:32:36.401Z] --- SKIP: TestAuthZPluginV2AllowNonVolumeRequest (0.00s)
01:32:36 [2020-02-11T01:32:36.401Z]     authz_plugin_v2_test.go:43: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
01:32:36 [2020-02-11T01:32:36.401Z] === RUN   TestAuthZPluginV2Disable
01:32:36 [2020-02-11T01:32:36.401Z] --- SKIP: TestAuthZPluginV2Disable (0.00s)
01:32:36 [2020-02-11T01:32:36.401Z]     authz_plugin_v2_test.go:65: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
01:32:36 [2020-02-11T01:32:36.401Z] === RUN   TestAuthZPluginV2RejectVolumeRequests
01:32:36 [2020-02-11T01:32:36.401Z] --- SKIP: TestAuthZPluginV2RejectVolumeRequests (0.00s)
01:32:36 [2020-02-11T01:32:36.401Z]     authz_plugin_v2_test.go:91: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
01:32:36 [2020-02-11T01:32:36.401Z] === RUN   TestAuthZPluginV2BadManifestFailsDaemonStart
01:32:36 [2020-02-11T01:32:36.401Z] --- SKIP: TestAuthZPluginV2BadManifestFailsDaemonStart (0.00s)
01:32:36 [2020-02-11T01:32:36.401Z]     authz_plugin_v2_test.go:126: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
01:32:36 [2020-02-11T01:32:36.401Z] === RUN   TestAuthZPluginV2NonexistentFailsDaemonStart
01:32:55 [2020-02-11T01:32:55.969Z] --- PASS: TestAuthZPluginV2NonexistentFailsDaemonStart (16.77s)
01:32:55 [2020-02-11T01:32:55.969Z] PASS
01:32:55 [2020-02-11T01:32:55.969Z] 
01:32:55 [2020-02-11T01:32:55.969Z] === Skipped
01:32:55 [2020-02-11T01:32:55.969Z] === SKIP: s390x.integration.plugin.authz TestAuthZPluginV2AllowNonVolumeRequest (0.00s)
01:32:55 [2020-02-11T01:32:55.969Z]     authz_plugin_v2_test.go:43: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
01:32:55 [2020-02-11T01:32:55.969Z] 
01:32:55 [2020-02-11T01:32:55.969Z] === SKIP: s390x.integration.plugin.authz TestAuthZPluginV2Disable (0.00s)
01:32:55 [2020-02-11T01:32:55.969Z]     authz_plugin_v2_test.go:65: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
01:32:55 [2020-02-11T01:32:55.969Z] 
01:32:55 [2020-02-11T01:32:55.969Z] === SKIP: s390x.integration.plugin.authz TestAuthZPluginV2RejectVolumeRequests (0.00s)
01:32:55 [2020-02-11T01:32:55.969Z]     authz_plugin_v2_test.go:91: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
01:32:55 [2020-02-11T01:32:55.969Z] 
01:32:55 [2020-02-11T01:32:55.969Z] === SKIP: s390x.integration.plugin.authz TestAuthZPluginV2BadManifestFailsDaemonStart (0.00s)
01:32:55 [2020-02-11T01:32:55.969Z]     authz_plugin_v2_test.go:126: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
01:32:55 [2020-02-11T01:32:55.969Z] 
01:32:55 [2020-02-11T01:32:55.969Z] 
01:32:55 [2020-02-11T01:32:55.969Z] DONE 17 tests, 4 skipped in 28.744s
01:32:55 [2020-02-11T01:32:55.969Z] Running /go/src/github.com/docker/docker/integration/plugin/common (s390x.integration.plugin.common) flags=-test.v -test.timeout=120m 
01:32:55 [2020-02-11T01:32:55.969Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-common-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-common-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.plugin.common -t ./test.main -test.v -test.timeout=120m
01:32:55 [2020-02-11T01:32:55.969Z] ++ set -e
01:32:55 [2020-02-11T01:32:55.969Z] ++ '[' -n 0 ']'
01:32:55 [2020-02-11T01:32:55.969Z] ++ set -x
01:32:55 [2020-02-11T01:32:55.969Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=s390x DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-common-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-common-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.plugin.common -t ./test.main -test.v -test.timeout=120m
01:32:55 [2020-02-11T01:32:55.969Z] INFO: Testing against a local daemon
01:32:55 [2020-02-11T01:32:55.969Z] === RUN   TestPluginInvalidJSON
01:32:55 [2020-02-11T01:32:55.969Z] === RUN   TestPluginInvalidJSON//plugins/foobar/set
01:32:55 [2020-02-11T01:32:55.969Z] === PAUSE TestPluginInvalidJSON//plugins/foobar/set
01:32:55 [2020-02-11T01:32:55.969Z] === CONT  TestPluginInvalidJSON//plugins/foobar/set
01:32:55 [2020-02-11T01:32:55.969Z] --- PASS: TestPluginInvalidJSON (0.02s)
01:32:55 [2020-02-11T01:32:55.969Z]     --- PASS: TestPluginInvalidJSON//plugins/foobar/set (0.00s)
01:32:55 [2020-02-11T01:32:55.969Z] PASS
01:32:55 [2020-02-11T01:32:55.969Z] 
01:32:55 [2020-02-11T01:32:55.969Z] DONE 2 tests in 0.093s
01:32:55 [2020-02-11T01:32:55.969Z] Running /go/src/github.com/docker/docker/integration/plugin/graphdriver (s390x.integration.plugin.graphdriver) flags=-test.v -test.timeout=120m 
01:32:55 [2020-02-11T01:32:55.969Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-graphdriver-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-graphdriver-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.plugin.graphdriver -t ./test.main -test.v -test.timeout=120m
01:32:55 [2020-02-11T01:32:55.969Z] ++ set -e
01:32:55 [2020-02-11T01:32:55.969Z] ++ '[' -n 0 ']'
01:32:55 [2020-02-11T01:32:55.969Z] ++ set -x
01:32:55 [2020-02-11T01:32:55.969Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=s390x DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-graphdriver-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-graphdriver-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.plugin.graphdriver -t ./test.main -test.v -test.timeout=120m
01:32:55 [2020-02-11T01:32:55.969Z] INFO: Testing against a local daemon
01:32:55 [2020-02-11T01:32:55.969Z] === RUN   TestExternalGraphDriver
01:32:55 [2020-02-11T01:32:55.969Z] === RUN   TestExternalGraphDriver/json
01:32:55 [2020-02-11T01:32:55.969Z] === RUN   TestExternalGraphDriver/spec
01:32:57 [2020-02-11T01:32:57.728Z] === RUN   TestExternalGraphDriver/pull
01:32:59 [2020-02-11T01:32:59.518Z] --- PASS: TestExternalGraphDriver (6.10s)
01:32:59 [2020-02-11T01:32:59.518Z]     --- PASS: TestExternalGraphDriver/json (1.96s)
01:32:59 [2020-02-11T01:32:59.518Z]     --- PASS: TestExternalGraphDriver/spec (2.09s)
01:32:59 [2020-02-11T01:32:59.518Z]     --- PASS: TestExternalGraphDriver/pull (1.95s)
01:32:59 [2020-02-11T01:32:59.518Z] === RUN   TestGraphdriverPluginV2
01:32:59 [2020-02-11T01:32:59.518Z] --- SKIP: TestGraphdriverPluginV2 (0.06s)
01:32:59 [2020-02-11T01:32:59.518Z]     external_test.go:410: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
01:32:59 [2020-02-11T01:32:59.518Z] PASS
01:32:59 [2020-02-11T01:32:59.518Z] 
01:32:59 [2020-02-11T01:32:59.518Z] === Skipped
01:32:59 [2020-02-11T01:32:59.518Z] === SKIP: s390x.integration.plugin.graphdriver TestGraphdriverPluginV2 (0.06s)
01:32:59 [2020-02-11T01:32:59.518Z]     external_test.go:410: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
01:32:59 [2020-02-11T01:32:59.518Z] 
01:32:59 [2020-02-11T01:32:59.518Z] 
01:32:59 [2020-02-11T01:32:59.518Z] DONE 5 tests, 1 skipped in 6.240s
01:32:59 [2020-02-11T01:32:59.518Z] Running /go/src/github.com/docker/docker/integration/plugin/logging (s390x.integration.plugin.logging) flags=-test.v -test.timeout=120m 
01:32:59 [2020-02-11T01:32:59.518Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-logging-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-logging-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.plugin.logging -t ./test.main -test.v -test.timeout=120m
01:32:59 [2020-02-11T01:32:59.518Z] ++ set -e
01:32:59 [2020-02-11T01:32:59.518Z] ++ '[' -n 0 ']'
01:32:59 [2020-02-11T01:32:59.518Z] ++ set -x
01:32:59 [2020-02-11T01:32:59.518Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=s390x DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-logging-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-logging-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.plugin.logging -t ./test.main -test.v -test.timeout=120m
01:32:59 [2020-02-11T01:32:59.518Z] INFO: Testing against a local daemon
01:32:59 [2020-02-11T01:32:59.518Z] === RUN   TestContinueAfterPluginCrash
01:32:59 [2020-02-11T01:32:59.518Z] === PAUSE TestContinueAfterPluginCrash
01:32:59 [2020-02-11T01:32:59.518Z] === RUN   TestDaemonStartWithLogOpt
01:32:59 [2020-02-11T01:32:59.518Z] === PAUSE TestDaemonStartWithLogOpt
01:32:59 [2020-02-11T01:32:59.518Z] === CONT  TestContinueAfterPluginCrash
01:32:59 [2020-02-11T01:32:59.518Z] === CONT  TestDaemonStartWithLogOpt
01:33:08 [2020-02-11T01:33:08.745Z] --- PASS: TestDaemonStartWithLogOpt (8.94s)
01:33:13 [2020-02-11T01:33:13.663Z] --- PASS: TestContinueAfterPluginCrash (13.74s)
01:33:13 [2020-02-11T01:33:13.663Z] PASS
01:33:13 [2020-02-11T01:33:13.663Z] 
01:33:13 [2020-02-11T01:33:13.663Z] DONE 2 tests in 13.820s
01:33:13 [2020-02-11T01:33:13.663Z] Running /go/src/github.com/docker/docker/integration/plugin/volumes (s390x.integration.plugin.volumes) flags=-test.v -test.timeout=120m 
01:33:13 [2020-02-11T01:33:13.663Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-volumes-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-volumes-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.plugin.volumes -t ./test.main -test.v -test.timeout=120m
01:33:13 [2020-02-11T01:33:13.663Z] ++ set -e
01:33:13 [2020-02-11T01:33:13.663Z] ++ '[' -n 0 ']'
01:33:13 [2020-02-11T01:33:13.663Z] ++ set -x
01:33:13 [2020-02-11T01:33:13.663Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=s390x DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-volumes-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-plugin-volumes-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.plugin.volumes -t ./test.main -test.v -test.timeout=120m
01:33:13 [2020-02-11T01:33:13.663Z] INFO: Testing against a local daemon
01:33:13 [2020-02-11T01:33:13.663Z] === RUN   TestPluginWithDevMounts
01:33:13 [2020-02-11T01:33:13.663Z] === PAUSE TestPluginWithDevMounts
01:33:13 [2020-02-11T01:33:13.663Z] === CONT  TestPluginWithDevMounts
01:33:15 [2020-02-11T01:33:15.415Z] --- PASS: TestPluginWithDevMounts (1.83s)
01:33:15 [2020-02-11T01:33:15.415Z] PASS
01:33:15 [2020-02-11T01:33:15.415Z] 
01:33:15 [2020-02-11T01:33:15.415Z] DONE 1 tests in 1.912s
01:33:15 [2020-02-11T01:33:15.415Z] Running /go/src/github.com/docker/docker/integration/secret (s390x.integration.secret) flags=-test.v -test.timeout=120m 
01:33:15 [2020-02-11T01:33:15.415Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-secret-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-secret-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.secret -t ./test.main -test.v -test.timeout=120m
01:33:15 [2020-02-11T01:33:15.415Z] ++ set -e
01:33:15 [2020-02-11T01:33:15.415Z] ++ '[' -n 0 ']'
01:33:15 [2020-02-11T01:33:15.415Z] ++ set -x
01:33:15 [2020-02-11T01:33:15.415Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=s390x DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-secret-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-secret-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.secret -t ./test.main -test.v -test.timeout=120m
01:33:15 [2020-02-11T01:33:15.415Z] INFO: Testing against a local daemon
01:33:15 [2020-02-11T01:33:15.415Z] === RUN   TestSecretInspect
01:33:18 [2020-02-11T01:33:18.493Z] --- PASS: TestSecretInspect (2.74s)
01:33:18 [2020-02-11T01:33:18.493Z] === RUN   TestSecretList
01:33:20 [2020-02-11T01:33:20.230Z] --- PASS: TestSecretList (2.30s)
01:33:20 [2020-02-11T01:33:20.230Z] === RUN   TestSecretsCreateAndDelete
01:33:23 [2020-02-11T01:33:23.310Z] --- PASS: TestSecretsCreateAndDelete (2.77s)
01:33:23 [2020-02-11T01:33:23.310Z] === RUN   TestSecretsUpdate
01:33:25 [2020-02-11T01:33:25.656Z] --- PASS: TestSecretsUpdate (2.32s)
01:33:25 [2020-02-11T01:33:25.656Z] === RUN   TestTemplatedSecret
01:33:28 [2020-02-11T01:33:28.875Z] --- PASS: TestTemplatedSecret (3.36s)
01:33:28 [2020-02-11T01:33:28.875Z] === RUN   TestSecretCreateResolve
01:33:31 [2020-02-11T01:33:31.942Z] --- PASS: TestSecretCreateResolve (2.80s)
01:33:31 [2020-02-11T01:33:31.942Z] PASS
01:33:31 [2020-02-11T01:33:31.942Z] 
01:33:31 [2020-02-11T01:33:31.942Z] DONE 6 tests in 16.351s
01:33:31 [2020-02-11T01:33:31.942Z] Running /go/src/github.com/docker/docker/integration/service (s390x.integration.service) flags=-test.v -test.timeout=120m 
01:33:31 [2020-02-11T01:33:31.942Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-service-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-service-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.service -t ./test.main -test.v -test.timeout=120m
01:33:31 [2020-02-11T01:33:31.942Z] ++ set -e
01:33:31 [2020-02-11T01:33:31.942Z] ++ '[' -n 0 ']'
01:33:31 [2020-02-11T01:33:31.942Z] ++ set -x
01:33:31 [2020-02-11T01:33:31.942Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=s390x DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-service-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-service-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.service -t ./test.main -test.v -test.timeout=120m
01:33:31 [2020-02-11T01:33:31.942Z] INFO: Testing against a local daemon
01:33:31 [2020-02-11T01:33:31.942Z] === RUN   TestServiceCreateInit
01:33:31 [2020-02-11T01:33:31.942Z] === RUN   TestServiceCreateInit/daemonInitDisabled
01:33:36 [2020-02-11T01:33:36.857Z] === RUN   TestServiceCreateInit/daemonInitEnabled
01:33:41 [2020-02-11T01:33:41.790Z] --- PASS: TestServiceCreateInit (9.43s)
01:33:41 [2020-02-11T01:33:41.790Z]     --- PASS: TestServiceCreateInit/daemonInitDisabled (4.50s)
01:33:41 [2020-02-11T01:33:41.790Z]     --- PASS: TestServiceCreateInit/daemonInitEnabled (4.90s)
01:33:41 [2020-02-11T01:33:41.790Z] === RUN   TestCreateServiceMultipleTimes
01:33:58 [2020-02-11T01:33:58.054Z] --- PASS: TestCreateServiceMultipleTimes (16.91s)
01:33:58 [2020-02-11T01:33:58.054Z] === RUN   TestCreateServiceConflict
01:34:00 [2020-02-11T01:34:00.451Z] --- PASS: TestCreateServiceConflict (2.34s)
01:34:00 [2020-02-11T01:34:00.451Z] === RUN   TestCreateServiceMaxReplicas
01:34:04 [2020-02-11T01:34:04.383Z] --- PASS: TestCreateServiceMaxReplicas (3.54s)
01:34:04 [2020-02-11T01:34:04.383Z] === RUN   TestCreateWithDuplicateNetworkNames
01:34:17 [2020-02-11T01:34:17.767Z] --- PASS: TestCreateWithDuplicateNetworkNames (13.98s)
01:34:17 [2020-02-11T01:34:17.767Z] === RUN   TestCreateServiceSecretFileMode
01:34:21 [2020-02-11T01:34:21.682Z] --- PASS: TestCreateServiceSecretFileMode (3.48s)
01:34:21 [2020-02-11T01:34:21.682Z] === RUN   TestCreateServiceConfigFileMode
01:34:25 [2020-02-11T01:34:25.600Z] --- PASS: TestCreateServiceConfigFileMode (3.55s)
01:34:25 [2020-02-11T01:34:25.600Z] === RUN   TestCreateServiceSysctls
01:34:29 [2020-02-11T01:34:29.520Z] --- PASS: TestCreateServiceSysctls (4.01s)
01:34:29 [2020-02-11T01:34:29.520Z] === RUN   TestCreateServiceCapabilities
01:34:32 [2020-02-11T01:34:32.593Z] --- PASS: TestCreateServiceCapabilities (3.39s)
01:34:32 [2020-02-11T01:34:32.593Z] === RUN   TestInspect
01:34:35 [2020-02-11T01:34:35.906Z] --- PASS: TestInspect (3.11s)
01:34:35 [2020-02-11T01:34:35.906Z] === RUN   TestCreateJob
01:34:39 [2020-02-11T01:34:39.831Z] --- PASS: TestCreateJob (4.33s)
01:34:39 [2020-02-11T01:34:39.831Z] === RUN   TestReplicatedJob
01:34:47 [2020-02-11T01:34:47.321Z] --- PASS: TestReplicatedJob (7.23s)
01:34:47 [2020-02-11T01:34:47.321Z] === RUN   TestUpdateReplicatedJob
01:34:51 [2020-02-11T01:34:51.241Z] --- PASS: TestUpdateReplicatedJob (4.17s)
01:34:51 [2020-02-11T01:34:51.241Z] === RUN   TestServiceListWithStatuses
01:34:51 [2020-02-11T01:34:51.241Z] --- SKIP: TestServiceListWithStatuses (0.01s)
01:34:51 [2020-02-11T01:34:51.241Z]     list_test.go:34: versions.LessThan(testEnv.DaemonInfo.ServerVersion, "1.41")
01:34:51 [2020-02-11T01:34:51.241Z] === RUN   TestDockerNetworkConnectAlias
01:34:57 [2020-02-11T01:34:57.531Z] --- PASS: TestDockerNetworkConnectAlias (5.51s)
01:34:57 [2020-02-11T01:34:57.531Z] === RUN   TestDockerNetworkReConnect
01:35:01 [2020-02-11T01:35:01.436Z] --- PASS: TestDockerNetworkReConnect (4.87s)
01:35:01 [2020-02-11T01:35:01.436Z] === RUN   TestServicePlugin
01:35:01 [2020-02-11T01:35:01.436Z] --- SKIP: TestServicePlugin (0.01s)
01:35:01 [2020-02-11T01:35:01.436Z]     plugin_test.go:28: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
01:35:01 [2020-02-11T01:35:01.436Z] === RUN   TestServiceUpdateLabel
01:35:04 [2020-02-11T01:35:04.543Z] --- PASS: TestServiceUpdateLabel (2.73s)
01:35:04 [2020-02-11T01:35:04.544Z] === RUN   TestServiceUpdateSecrets
01:35:20 [2020-02-11T01:35:20.738Z] --- PASS: TestServiceUpdateSecrets (15.65s)
01:35:20 [2020-02-11T01:35:20.738Z] === RUN   TestServiceUpdateConfigs
01:35:36 [2020-02-11T01:35:36.971Z] --- PASS: TestServiceUpdateConfigs (15.48s)
01:35:36 [2020-02-11T01:35:36.971Z] === RUN   TestServiceUpdateNetwork
01:35:50 [2020-02-11T01:35:50.386Z] --- PASS: TestServiceUpdateNetwork (14.07s)
01:35:50 [2020-02-11T01:35:50.386Z] PASS
01:35:50 [2020-02-11T01:35:50.386Z] 
01:35:50 [2020-02-11T01:35:50.386Z] === Skipped
01:35:50 [2020-02-11T01:35:50.386Z] === SKIP: s390x.integration.service TestServiceListWithStatuses (0.01s)
01:35:50 [2020-02-11T01:35:50.386Z]     list_test.go:34: versions.LessThan(testEnv.DaemonInfo.ServerVersion, "1.41")
01:35:50 [2020-02-11T01:35:50.386Z] 
01:35:50 [2020-02-11T01:35:50.386Z] === SKIP: s390x.integration.service TestServicePlugin (0.01s)
01:35:50 [2020-02-11T01:35:50.386Z]     plugin_test.go:28: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
01:35:50 [2020-02-11T01:35:50.386Z] 
01:35:50 [2020-02-11T01:35:50.386Z] 
01:35:50 [2020-02-11T01:35:50.386Z] DONE 23 tests, 2 skipped in 138.000s
01:35:50 [2020-02-11T01:35:50.386Z] Running /go/src/github.com/docker/docker/integration/session (s390x.integration.session) flags=-test.v -test.timeout=120m 
01:35:50 [2020-02-11T01:35:50.386Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-session-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-session-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.session -t ./test.main -test.v -test.timeout=120m
01:35:50 [2020-02-11T01:35:50.386Z] ++ set -e
01:35:50 [2020-02-11T01:35:50.386Z] ++ '[' -n 0 ']'
01:35:50 [2020-02-11T01:35:50.386Z] ++ set -x
01:35:50 [2020-02-11T01:35:50.386Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=s390x DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-session-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-session-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.session -t ./test.main -test.v -test.timeout=120m
01:35:50 [2020-02-11T01:35:50.386Z] INFO: Testing against a local daemon
01:35:50 [2020-02-11T01:35:50.386Z] === RUN   TestSessionCreate
01:35:50 [2020-02-11T01:35:50.386Z] --- PASS: TestSessionCreate (0.02s)
01:35:50 [2020-02-11T01:35:50.386Z] === RUN   TestSessionCreateWithBadUpgrade
01:35:50 [2020-02-11T01:35:50.386Z] --- PASS: TestSessionCreateWithBadUpgrade (0.02s)
01:35:50 [2020-02-11T01:35:50.386Z] PASS
01:35:50 [2020-02-11T01:35:50.386Z] 
01:35:50 [2020-02-11T01:35:50.386Z] DONE 2 tests in 0.180s
01:35:50 [2020-02-11T01:35:50.386Z] Running /go/src/github.com/docker/docker/integration/system (s390x.integration.system) flags=-test.v -test.timeout=120m 
01:35:50 [2020-02-11T01:35:50.386Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-system-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-system-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.system -t ./test.main -test.v -test.timeout=120m
01:35:50 [2020-02-11T01:35:50.386Z] ++ set -e
01:35:50 [2020-02-11T01:35:50.386Z] ++ '[' -n 0 ']'
01:35:50 [2020-02-11T01:35:50.386Z] ++ set -x
01:35:50 [2020-02-11T01:35:50.386Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=s390x DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-system-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-system-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.system -t ./test.main -test.v -test.timeout=120m
01:35:50 [2020-02-11T01:35:50.386Z] INFO: Testing against a local daemon
01:35:50 [2020-02-11T01:35:50.386Z] === RUN   TestCgroupDriverSystemdMemoryLimit
01:35:50 [2020-02-11T01:35:50.386Z] --- SKIP: TestCgroupDriverSystemdMemoryLimit (0.00s)
01:35:50 [2020-02-11T01:35:50.386Z]     cgroupdriver_systemd_test.go:32: !hasSystemd()
01:35:50 [2020-02-11T01:35:50.386Z] === RUN   TestEventsExecDie
01:35:50 [2020-02-11T01:35:50.739Z] --- PASS: TestEventsExecDie (0.86s)
01:35:50 [2020-02-11T01:35:50.739Z] === RUN   TestEventsBackwardsCompatible
01:35:50 [2020-02-11T01:35:50.739Z] --- PASS: TestEventsBackwardsCompatible (0.10s)
01:35:50 [2020-02-11T01:35:50.739Z] === RUN   TestInfoBinaryCommits
01:35:50 [2020-02-11T01:35:50.739Z] --- PASS: TestInfoBinaryCommits (0.01s)
01:35:50 [2020-02-11T01:35:50.739Z] === RUN   TestInfoAPIVersioned
01:35:50 [2020-02-11T01:35:50.739Z] --- PASS: TestInfoAPIVersioned (0.00s)
01:35:50 [2020-02-11T01:35:50.739Z] === RUN   TestInfoDiscoveryBackend
01:35:51 [2020-02-11T01:35:51.484Z] --- PASS: TestInfoDiscoveryBackend (0.53s)
01:35:51 [2020-02-11T01:35:51.484Z] === RUN   TestInfoDiscoveryInvalidAdvertise
01:35:52 [2020-02-11T01:35:52.230Z] --- PASS: TestInfoDiscoveryInvalidAdvertise (1.00s)
01:35:52 [2020-02-11T01:35:52.230Z] === RUN   TestInfoDiscoveryAdvertiseInterfaceName
01:35:53 [2020-02-11T01:35:53.083Z] --- PASS: TestInfoDiscoveryAdvertiseInterfaceName (0.52s)
01:35:53 [2020-02-11T01:35:53.083Z] === RUN   TestInfoAPI
01:35:53 [2020-02-11T01:35:53.083Z] --- PASS: TestInfoAPI (0.02s)
01:35:53 [2020-02-11T01:35:53.083Z] === RUN   TestInfoAPIWarnings
01:35:53 [2020-02-11T01:35:53.500Z] --- PASS: TestInfoAPIWarnings (0.52s)
01:35:53 [2020-02-11T01:35:53.500Z] === RUN   TestInfoDebug
01:35:53 [2020-02-11T01:35:53.882Z] --- PASS: TestInfoDebug (0.52s)
01:35:53 [2020-02-11T01:35:53.882Z] === RUN   TestInfoInsecureRegistries
01:35:54 [2020-02-11T01:35:54.287Z] --- PASS: TestInfoInsecureRegistries (0.54s)
01:35:54 [2020-02-11T01:35:54.287Z] === RUN   TestInfoRegistryMirrors
01:35:55 [2020-02-11T01:35:55.052Z] --- PASS: TestInfoRegistryMirrors (0.53s)
01:35:55 [2020-02-11T01:35:55.052Z] === RUN   TestLoginFailsWithBadCredentials
01:35:55 [2020-02-11T01:35:55.403Z] --- PASS: TestLoginFailsWithBadCredentials (0.32s)
01:35:55 [2020-02-11T01:35:55.403Z] === RUN   TestPingCacheHeaders
01:35:55 [2020-02-11T01:35:55.403Z] --- PASS: TestPingCacheHeaders (0.02s)
01:35:55 [2020-02-11T01:35:55.403Z] === RUN   TestPingGet
01:35:55 [2020-02-11T01:35:55.403Z] --- PASS: TestPingGet (0.01s)
01:35:55 [2020-02-11T01:35:55.403Z] === RUN   TestPingHead
01:35:55 [2020-02-11T01:35:55.403Z] --- PASS: TestPingHead (0.01s)
01:35:55 [2020-02-11T01:35:55.403Z] === RUN   TestVersion
01:35:55 [2020-02-11T01:35:55.403Z] --- PASS: TestVersion (0.01s)
01:35:55 [2020-02-11T01:35:55.403Z] PASS
01:35:55 [2020-02-11T01:35:55.403Z] 
01:35:55 [2020-02-11T01:35:55.403Z] === Skipped
01:35:55 [2020-02-11T01:35:55.403Z] === SKIP: s390x.integration.system TestCgroupDriverSystemdMemoryLimit (0.00s)
01:35:55 [2020-02-11T01:35:55.403Z]     cgroupdriver_systemd_test.go:32: !hasSystemd()
01:35:55 [2020-02-11T01:35:55.403Z] 
01:35:55 [2020-02-11T01:35:55.403Z] 
01:35:55 [2020-02-11T01:35:55.403Z] DONE 18 tests, 1 skipped in 5.626s
01:35:55 [2020-02-11T01:35:55.403Z] Running /go/src/github.com/docker/docker/integration/volume (s390x.integration.volume) flags=-test.v -test.timeout=120m 
01:35:55 [2020-02-11T01:35:55.403Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-volume-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-volume-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.volume -t ./test.main -test.v -test.timeout=120m
01:35:55 [2020-02-11T01:35:55.403Z] ++ set -e
01:35:55 [2020-02-11T01:35:55.403Z] ++ '[' -n 0 ']'
01:35:55 [2020-02-11T01:35:55.403Z] ++ set -x
01:35:55 [2020-02-11T01:35:55.403Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=s390x DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-volume-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-volume-junit-report.xml --raw-command -- go tool test2json -p s390x.integration.volume -t ./test.main -test.v -test.timeout=120m
01:35:55 [2020-02-11T01:35:55.403Z] INFO: Testing against a local daemon
01:35:55 [2020-02-11T01:35:55.403Z] === RUN   TestVolumesCreateAndList
01:35:55 [2020-02-11T01:35:55.403Z] --- PASS: TestVolumesCreateAndList (0.02s)
01:35:55 [2020-02-11T01:35:55.403Z] === RUN   TestVolumesRemove
01:35:55 [2020-02-11T01:35:55.761Z] --- PASS: TestVolumesRemove (0.11s)
01:35:55 [2020-02-11T01:35:55.761Z] === RUN   TestVolumesInspect
01:35:55 [2020-02-11T01:35:55.761Z] --- PASS: TestVolumesInspect (0.01s)
01:35:55 [2020-02-11T01:35:55.761Z] === RUN   TestVolumesInvalidJSON
01:35:55 [2020-02-11T01:35:55.761Z] === RUN   TestVolumesInvalidJSON//volumes/create
01:35:55 [2020-02-11T01:35:55.762Z] === PAUSE TestVolumesInvalidJSON//volumes/create
01:35:55 [2020-02-11T01:35:55.762Z] === CONT  TestVolumesInvalidJSON//volumes/create
01:35:55 [2020-02-11T01:35:55.762Z] --- PASS: TestVolumesInvalidJSON (0.01s)
01:35:55 [2020-02-11T01:35:55.762Z]     --- PASS: TestVolumesInvalidJSON//volumes/create (0.00s)
01:35:55 [2020-02-11T01:35:55.762Z] PASS
01:35:55 [2020-02-11T01:35:55.762Z] 
01:35:55 [2020-02-11T01:35:55.762Z] DONE 5 tests in 0.250s
01:35:55 [2020-02-11T01:35:55.762Z] ---> Making bundle: .integration-daemon-stop (in bundles/test-integration)
01:35:55 [2020-02-11T01:35:55.762Z] ++++ cat bundles/test-integration/docker.pid
01:35:55 [2020-02-11T01:35:55.762Z] +++ kill 11618
01:35:56 [2020-02-11T01:35:56.959Z] +++ /etc/init.d/apparmor stop
01:35:56 [2020-02-11T01:35:56.959Z] Leaving: AppArmorNo profiles have been unloaded.
01:35:56 [2020-02-11T01:35:56.959Z] 
01:35:56 [2020-02-11T01:35:56.959Z] Unloading profiles will leave already running processes permanently
01:35:56 [2020-02-11T01:35:56.959Z] unconfined, which can lead to unexpected situations.
01:35:56 [2020-02-11T01:35:56.959Z] 
01:35:56 [2020-02-11T01:35:56.959Z] To set a process to complain mode, use the command line tool
01:35:56 [2020-02-11T01:35:56.959Z] 'aa-complain'. To really tear down all profiles, run 'aa-teardown'."
01:35:56 [2020-02-11T01:35:56.959Z] +++ true
01:35:56 [2020-02-11T01:35:56.959Z]