Console Output

21:38:43 [2019-10-21T21:38:43.126Z] + docker run --rm -t --privileged -v /home/jenkins/workspace/engine_PR-400/bundles:/go/src/github.com/docker/docker/bundles --name docker-pr7 -e DOCKER_EXPERIMENTAL -e DOCKER_GITCOMMIT=9605322965bfa28c3d3c46f7d424c81271279635 -e DOCKER_GRAPHDRIVER -e TESTDEBUG -e TEST_SKIP_INTEGRATION_CLI -e TIMEOUT -e VALIDATE_REPO=https://github.com/docker/engine.git -e VALIDATE_BRANCH=18.09 docker:9605322965bfa28c3d3c46f7d424c81271279635 hack/make.sh dynbinary test-integration
21:38:43 [2019-10-21T21:38:43.515Z] 
21:38:43 [2019-10-21T21:38:43.515Z] Removing bundles/
21:38:43 [2019-10-21T21:38:43.515Z] 
21:38:43 [2019-10-21T21:38:43.515Z] ---> Making bundle: dynbinary (in bundles/dynbinary)
21:38:43 [2019-10-21T21:38:43.515Z] Building: bundles/dynbinary-daemon/dockerd-dev
21:38:43 [2019-10-21T21:38:43.515Z] GOOS="" GOARCH="" GOARM=""
21:39:54 [2019-10-21T21:39:54.204Z] Created binary: bundles/dynbinary-daemon/dockerd-dev
21:39:54 [2019-10-21T21:39:54.204Z] 
21:39:54 [2019-10-21T21:39:54.204Z] ---> Making bundle: test-integration (in bundles/test-integration)
21:39:54 [2019-10-21T21:39:54.204Z] PKG_CONFIG=pkg-config
21:39:54 [2019-10-21T21:39:54.204Z] GOLANG_VERSION=1.12.10
21:39:54 [2019-10-21T21:39:54.204Z] HOSTNAME=324a2c5fee68
21:39:54 [2019-10-21T21:39:54.204Z] DOCKER_EXPERIMENTAL=1
21:39:54 [2019-10-21T21:39:54.204Z] container=docker
21:39:54 [2019-10-21T21:39:54.204Z] TEST_SKIP_INTEGRATION_CLI=1
21:39:54 [2019-10-21T21:39:54.204Z] GOMETALINTER_OPTS=--deadline=2m
21:39:54 [2019-10-21T21:39:54.204Z] GOPATH=/go
21:39:54 [2019-10-21T21:39:54.204Z] PWD=/go/src/github.com/docker/docker
21:39:54 [2019-10-21T21:39:54.204Z] HOME=/root
21:39:54 [2019-10-21T21:39:54.204Z] VALIDATE_REPO=https://github.com/docker/engine.git
21:39:54 [2019-10-21T21:39:54.204Z] SCRIPTDIR=/go/src/github.com/docker/docker/hack
21:39:54 [2019-10-21T21:39:54.204Z] MAKEDIR=/go/src/github.com/docker/docker/hack/make
21:39:54 [2019-10-21T21:39:54.204Z] DOCKER_GITCOMMIT=9605322965bfa28c3d3c46f7d424c81271279635
21:39:54 [2019-10-21T21:39:54.204Z] DOCKER_BUILDTAGS=apparmor seccomp selinux journald
21:39:54 [2019-10-21T21:39:54.204Z] DOCKER_GRAPHDRIVER=overlay2
21:39:54 [2019-10-21T21:39:54.204Z] TERM=xterm
21:39:54 [2019-10-21T21:39:54.204Z] VALIDATE_BRANCH=18.09
21:39:54 [2019-10-21T21:39:54.204Z] DEST=bundles/test-integration
21:39:54 [2019-10-21T21:39:54.204Z] SHLVL=1
21:39:54 [2019-10-21T21:39:54.204Z] TIMEOUT=120m
21:39:54 [2019-10-21T21:39:54.204Z] PATH=/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
21:39:54 [2019-10-21T21:39:54.204Z] DOCKER_PKG=github.com/docker/docker
21:39:54 [2019-10-21T21:39:54.204Z] TESTDEBUG=0
21:39:54 [2019-10-21T21:39:54.204Z] _=/usr/bin/env
21:39:54 [2019-10-21T21:39:54.204Z] Building test suite binary /go/src/github.com/docker/docker/integration/build/test.main
21:40:18 [2019-10-21T21:40:18.553Z] Building test suite binary /go/src/github.com/docker/docker/integration/config/test.main
21:40:18 [2019-10-21T21:40:18.553Z] Building test suite binary /go/src/github.com/docker/docker/integration/container/test.main
21:40:21 [2019-10-21T21:40:21.502Z] Building test suite binary /go/src/github.com/docker/docker/integration/image/test.main
21:40:22 [2019-10-21T21:40:22.914Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/test.main
21:40:24 [2019-10-21T21:40:24.321Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/ipvlan/test.main
21:40:25 [2019-10-21T21:40:25.772Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/macvlan/test.main
21:40:27 [2019-10-21T21:40:27.696Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/test.main
21:40:27 [2019-10-21T21:40:27.696Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/authz/test.main
21:40:30 [2019-10-21T21:40:30.264Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/common/test.main
21:40:31 [2019-10-21T21:40:31.079Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/graphdriver/test.main
21:40:34 [2019-10-21T21:40:34.618Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/logging/test.main
21:40:44 [2019-10-21T21:40:44.465Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/volumes/test.main
21:40:45 [2019-10-21T21:40:45.842Z] Building test suite binary /go/src/github.com/docker/docker/integration/secret/test.main
21:40:47 [2019-10-21T21:40:47.197Z] Building test suite binary /go/src/github.com/docker/docker/integration/service/test.main
21:40:49 [2019-10-21T21:40:49.822Z] Building test suite binary /go/src/github.com/docker/docker/integration/session/test.main
21:40:51 [2019-10-21T21:40:51.414Z] Building test suite binary /go/src/github.com/docker/docker/integration/system/test.main
21:40:52 [2019-10-21T21:40:52.804Z] Building test suite binary /go/src/github.com/docker/docker/integration/volume/test.main
21:40:54 [2019-10-21T21:40:54.857Z] ---> Making bundle: .integration-daemon-start (in bundles/test-integration)
21:40:54 [2019-10-21T21:40:54.857Z] Using test binary docker
21:40:54 [2019-10-21T21:40:54.857Z] # DOCKER_EXPERIMENTAL is set: starting daemon with experimental features enabled! 
21:40:54 [2019-10-21T21:40:54.857Z] +++ /etc/init.d/apparmor start
21:40:54 [2019-10-21T21:40:54.857Z] /etc/init.d/apparmor: 130: /etc/init.d/apparmor: systemd-detect-virt: not found
21:40:54 [2019-10-21T21:40:54.857Z] Starting AppArmor profiles:Warning from stdin (line 1): /sbin/apparmor_parser: cannot use or update cache, disable, or force-complain via stdin
21:40:54 [2019-10-21T21:40:54.857Z] Warning failed to create cache: (null)
21:40:54 [2019-10-21T21:40:54.857Z] .
21:40:54 [2019-10-21T21:40:54.857Z] INFO: Waiting for daemon to start...
21:40:54 [2019-10-21T21:40:54.857Z] Starting dockerd
21:40:54 [2019-10-21T21:40:54.857Z] +++ 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
21:40:56 [2019-10-21T21:40:56.720Z] .
21:40:56 [2019-10-21T21:40:56.720Z] ---> Making bundle: .integration-daemon-setup (in bundles/test-integration)
21:40:56 [2019-10-21T21:40:56.720Z] ---> Making bundle: .ensure-emptyfs (in bundles/test-integration)
21:40:56 [2019-10-21T21:40:56.720Z] Error: No such image: emptyfs
21:40:56 [2019-10-21T21:40:56.720Z] ++++ tar -cC bundles/test-integration/emptyfs .
21:40:56 [2019-10-21T21:40:56.720Z] ++++ docker load
21:40:57 [2019-10-21T21:40:57.126Z] Running integration-test (iteration 1)
21:40:57 [2019-10-21T21:40:57.126Z] Running /go/src/github.com/docker/docker/integration/build (s390x.integration.build) flags=-test.v -test.timeout=120m  
21:40:57 [2019-10-21T21:40:57.126Z] ++ 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
21:40:57 [2019-10-21T21:40:57.126Z] ++ set -e
21:40:57 [2019-10-21T21:40:57.126Z] ++ '[' -n 0 ']'
21:40:57 [2019-10-21T21:40:57.126Z] ++ set -x
21:40:57 [2019-10-21T21:40:57.126Z] ++ 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
21:41:08 [2019-10-21T21:41:08.978Z] Loaded image: buildpack-deps:jessie
21:41:08 [2019-10-21T21:41:08.978Z] Loaded image: busybox:latest
21:41:08 [2019-10-21T21:41:08.978Z] Loaded image: busybox:glibc
21:41:08 [2019-10-21T21:41:08.978Z] Loaded image: debian:jessie
21:41:09 [2019-10-21T21:41:09.406Z] Loaded image: hello-world:latest
21:41:09 [2019-10-21T21:41:09.807Z] INFO: Testing against a local daemon
21:41:09 [2019-10-21T21:41:09.807Z] === RUN   TestBuildWithSession
21:41:15 [2019-10-21T21:41:15.106Z] --- PASS: TestBuildWithSession (5.43s)
21:41:15 [2019-10-21T21:41:15.106Z]     build_session_test.go:26: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestBuildWithSession
21:41:15 [2019-10-21T21:41:15.106Z]     daemon.go:302: [d02ee23dd8ddb] waiting for daemon to start
21:41:15 [2019-10-21T21:41:15.106Z]     daemon.go:334: [d02ee23dd8ddb] daemon started
21:41:15 [2019-10-21T21:41:15.106Z]     daemon.go:286: [d02ee23dd8ddb] exiting daemon
21:41:15 [2019-10-21T21:41:15.106Z] === RUN   TestBuildSquashParent
21:41:24 [2019-10-21T21:41:24.808Z] --- PASS: TestBuildSquashParent (9.01s)
21:41:24 [2019-10-21T21:41:24.808Z]     build_squash_test.go:25: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestBuildSquashParent
21:41:24 [2019-10-21T21:41:24.808Z]     daemon.go:302: [d8cdcc2c4be68] waiting for daemon to start
21:41:24 [2019-10-21T21:41:24.808Z]     daemon.go:334: [d8cdcc2c4be68] daemon started
21:41:24 [2019-10-21T21:41:24.808Z]     daemon.go:286: [d8cdcc2c4be68] exiting daemon
21:41:24 [2019-10-21T21:41:24.808Z] === RUN   TestBuildWithRemoveAndForceRemove
21:41:24 [2019-10-21T21:41:24.808Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
21:41:24 [2019-10-21T21:41:24.808Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
21:41:24 [2019-10-21T21:41:24.808Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_remove
21:41:24 [2019-10-21T21:41:24.808Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_remove
21:41:24 [2019-10-21T21:41:24.808Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
21:41:24 [2019-10-21T21:41:24.808Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
21:41:24 [2019-10-21T21:41:24.808Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
21:41:24 [2019-10-21T21:41:24.808Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
21:41:24 [2019-10-21T21:41:24.808Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_remove
21:41:24 [2019-10-21T21:41:24.808Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_remove
21:41:24 [2019-10-21T21:41:24.808Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
21:41:24 [2019-10-21T21:41:24.808Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
21:41:24 [2019-10-21T21:41:24.808Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
21:41:24 [2019-10-21T21:41:24.808Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
21:41:26 [2019-10-21T21:41:26.747Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_remove
21:41:27 [2019-10-21T21:41:27.146Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
21:41:29 [2019-10-21T21:41:29.827Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
21:41:29 [2019-10-21T21:41:29.827Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_remove
21:41:33 [2019-10-21T21:41:33.238Z] --- PASS: TestBuildWithRemoveAndForceRemove (0.01s)
21:41:33 [2019-10-21T21:41:33.238Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal (2.65s)
21:41:33 [2019-10-21T21:41:33.238Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove (2.72s)
21:41:33 [2019-10-21T21:41:33.238Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal (2.80s)
21:41:33 [2019-10-21T21:41:33.238Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_remove (2.89s)
21:41:33 [2019-10-21T21:41:33.238Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_remove (2.96s)
21:41:33 [2019-10-21T21:41:33.238Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove (3.08s)
21:41:33 [2019-10-21T21:41:33.238Z] === RUN   TestBuildMultiStageParentConfig
21:42:07 [2019-10-21T21:42:07.625Z] --- PASS: TestBuildMultiStageParentConfig (31.68s)
21:42:07 [2019-10-21T21:42:07.625Z]     build_test.go:175: [{-1 1571694094 sha256:21695edf82662a0a40523123d09254d28f21a9636045659ac38d6f86002fe595 map[] sha256:224e97842ed58506b42ab4d4f704ce5b531f473720a7021a4f1fd7dac3de8698 [] [build1:latest] -1 4459757 4459757} {-1 1571694093 sha256:96d6873e58e00a41acced6dba401daf69971dd5524774d900d53fd1808bf1619 map[] sha256:2836c66df603ffea6bd2e5ed84b545ae585fcede43b7235e724662c3d47608ab [<none>@<none>] [<none>:<none>] -1 4459757 4459757} {-1 1571694091 sha256:3827491e6cfb6cc600ca6929ef44a79ff096e21f1b40db15a6f62e391327fd79 map[] sha256:36e9590454976dc0eb44c15bc80fe4fbd52aaa91df37ec76cd3ed245e1a12829 [<none>@<none>] [<none>:<none>] -1 4459757 4459757} {-1 1571694091 sha256:fcf92f593830f02cd2cb06f655fb6c55c0e6fdf04ffedf61c5dcaf1470f24e4c map[] sha256:36e9590454976dc0eb44c15bc80fe4fbd52aaa91df37ec76cd3ed245e1a12829 [<none>@<none>] [<none>:<none>] -1 4459757 4459757} {-1 1571694088 sha256:9ff84c423edfa46a6eeca3193188cbd49d05248a61324d4563b6b855a8a85f09 map[] sha256:36e9590454976dc0eb44c15bc80fe4fbd52aaa91df37ec76cd3ed245e1a12829 [<none>@<none>] [<none>:<none>] -1 4459757 4459757} {-1 1571694088 sha256:b6d1fa43f0b77364d12abf1c67fc4d3b370955e002fe5f0ae882e1edf6d08c40 map[] sha256:36e9590454976dc0eb44c15bc80fe4fbd52aaa91df37ec76cd3ed245e1a12829 [<none>@<none>] [<none>:<none>] -1 4459757 4459757} {-1 1571694085 sha256:046813888a4bc1fe18a40fc1e746dc04516971a00a932ad55c4c2e08594b19ec map[] sha256:36e9590454976dc0eb44c15bc80fe4fbd52aaa91df37ec76cd3ed245e1a12829 [<none>@<none>] [<none>:<none>] -1 4459757 4459757} {-1 1571694085 sha256:23517a083e889d86e6417a10e5caf2ba0ade009a0e092150650d03bc94a3e888 map[] sha256:36e9590454976dc0eb44c15bc80fe4fbd52aaa91df37ec76cd3ed245e1a12829 [<none>@<none>] [<none>:<none>] -1 4459757 4459757} {-1 1516785504 sha256:1e1e09d79a9fd4fa5faae6a9f150ecfe3e403a3efdfb78666c67227e656988b2 map[]  [] [busybox:glibc] -1 4476205 4476205} {-1 1511271291 sha256:3ab301db05ea4e52e26aadb6daabc1222e58c0be7cfa2b8945443d801b6b9585 map[]  [] [hello-world:frozen] -1 1976 1976} {-1 1509640958 sha256:9b0236353396efce03211408c208e6f90f31e7636682fa01f5eb4e38bbf571d6 map[]  [] [buildpack-deps:jessie] -1 595286123 595286123} {-1 1509610708 sha256:36e9590454976dc0eb44c15bc80fe4fbd52aaa91df37ec76cd3ed245e1a12829 map[]  [] [busybox:latest] -1 4459757 4459757} {-1 1507585344 sha256:de6513af1fcb9db380e4954f276ea347858dcb7bff0299953aa25c4abd54bc0b map[]  [] [debian:jessie] -1 129107182 129107182} {-1 1371157430 sha256:11f64303f0f7ffdc71f001788132bca5346831939a956e3e975c93267d89a16d map[]  [] [emptyfs:latest] -1 0 0}]
21:42:07 [2019-10-21T21:42:07.625Z] === RUN   TestBuildLabelWithTargets
21:42:07 [2019-10-21T21:42:07.625Z] --- PASS: TestBuildLabelWithTargets (2.33s)
21:42:07 [2019-10-21T21:42:07.625Z] === RUN   TestBuildWithEmptyLayers
21:42:08 [2019-10-21T21:42:08.359Z] --- PASS: TestBuildWithEmptyLayers (1.14s)
21:42:08 [2019-10-21T21:42:08.359Z] === RUN   TestBuildMultiStageOnBuild
21:42:11 [2019-10-21T21:42:11.838Z] --- PASS: TestBuildMultiStageOnBuild (3.47s)
21:42:11 [2019-10-21T21:42:11.838Z] === RUN   TestBuildUncleanTarFilenames
21:42:12 [2019-10-21T21:42:12.709Z] --- PASS: TestBuildUncleanTarFilenames (1.45s)
21:42:12 [2019-10-21T21:42:12.709Z] === RUN   TestBuildMultiStageLayerLeak
21:42:16 [2019-10-21T21:42:16.390Z] --- PASS: TestBuildMultiStageLayerLeak (3.57s)
21:42:16 [2019-10-21T21:42:16.391Z] === RUN   TestBuildWithHugeFile
21:42:58 [2019-10-21T21:42:58.018Z] --- PASS: TestBuildWithHugeFile (35.54s)
21:42:58 [2019-10-21T21:42:58.018Z] === RUN   TestBuildWithEmptyDockerfile
21:42:58 [2019-10-21T21:42:58.018Z] === RUN   TestBuildWithEmptyDockerfile/empty-dockerfile
21:42:58 [2019-10-21T21:42:58.018Z] === PAUSE TestBuildWithEmptyDockerfile/empty-dockerfile
21:42:58 [2019-10-21T21:42:58.018Z] === RUN   TestBuildWithEmptyDockerfile/empty-lines-dockerfile
21:42:58 [2019-10-21T21:42:58.018Z] === PAUSE TestBuildWithEmptyDockerfile/empty-lines-dockerfile
21:42:58 [2019-10-21T21:42:58.018Z] === RUN   TestBuildWithEmptyDockerfile/comment-only-dockerfile
21:42:58 [2019-10-21T21:42:58.018Z] === PAUSE TestBuildWithEmptyDockerfile/comment-only-dockerfile
21:42:58 [2019-10-21T21:42:58.018Z] === CONT  TestBuildWithEmptyDockerfile/empty-dockerfile
21:42:58 [2019-10-21T21:42:58.018Z] === CONT  TestBuildWithEmptyDockerfile/comment-only-dockerfile
21:42:58 [2019-10-21T21:42:58.018Z] === CONT  TestBuildWithEmptyDockerfile/empty-lines-dockerfile
21:42:58 [2019-10-21T21:42:58.018Z] --- PASS: TestBuildWithEmptyDockerfile (0.01s)
21:42:58 [2019-10-21T21:42:58.018Z]     --- PASS: TestBuildWithEmptyDockerfile/empty-dockerfile (0.19s)
21:42:58 [2019-10-21T21:42:58.018Z]     --- PASS: TestBuildWithEmptyDockerfile/comment-only-dockerfile (0.20s)
21:42:58 [2019-10-21T21:42:58.018Z]     --- PASS: TestBuildWithEmptyDockerfile/empty-lines-dockerfile (0.12s)
21:42:58 [2019-10-21T21:42:58.018Z] PASS
21:42:58 [2019-10-21T21:42:58.018Z] 
21:42:58 [2019-10-21T21:42:58.018Z] DONE 20 tests in 115.195s
21:42:58 [2019-10-21T21:42:58.018Z] Running /go/src/github.com/docker/docker/integration/config (s390x.integration.config) flags=-test.v -test.timeout=120m  
21:42:58 [2019-10-21T21:42:58.018Z] ++ 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
21:42:58 [2019-10-21T21:42:58.018Z] ++ set -e
21:42:58 [2019-10-21T21:42:58.018Z] ++ '[' -n 0 ']'
21:42:58 [2019-10-21T21:42:58.018Z] ++ set -x
21:42:58 [2019-10-21T21:42:58.018Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=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
21:42:58 [2019-10-21T21:42:58.018Z] INFO: Testing against a local daemon
21:42:58 [2019-10-21T21:42:58.018Z] === RUN   TestConfigList
21:42:58 [2019-10-21T21:42:58.018Z] --- PASS: TestConfigList (3.21s)
21:42:58 [2019-10-21T21:42:58.018Z]     config_test.go:26: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestConfigList
21:42:58 [2019-10-21T21:42:58.018Z]     daemon.go:302: [dbbcad8ddd091] waiting for daemon to start
21:42:58 [2019-10-21T21:42:58.018Z]     daemon.go:334: [dbbcad8ddd091] daemon started
21:42:58 [2019-10-21T21:42:58.018Z]     daemon.go:286: [dbbcad8ddd091] exiting daemon
21:42:58 [2019-10-21T21:42:58.018Z] === RUN   TestConfigsCreateAndDelete
21:42:59 [2019-10-21T21:42:59.370Z] --- PASS: TestConfigsCreateAndDelete (3.18s)
21:42:59 [2019-10-21T21:42:59.370Z]     config_test.go:108: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestConfigsCreateAndDelete
21:42:59 [2019-10-21T21:42:59.370Z]     daemon.go:302: [deaefe06d382b] waiting for daemon to start
21:42:59 [2019-10-21T21:42:59.370Z]     daemon.go:334: [deaefe06d382b] daemon started
21:42:59 [2019-10-21T21:42:59.370Z]     daemon.go:286: [deaefe06d382b] exiting daemon
21:42:59 [2019-10-21T21:42:59.370Z] === RUN   TestConfigsUpdate
21:43:02 [2019-10-21T21:43:02.059Z] --- PASS: TestConfigsUpdate (2.85s)
21:43:02 [2019-10-21T21:43:02.059Z]     config_test.go:136: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestConfigsUpdate
21:43:02 [2019-10-21T21:43:02.059Z]     daemon.go:302: [d78493d61a586] waiting for daemon to start
21:43:02 [2019-10-21T21:43:02.059Z]     daemon.go:334: [d78493d61a586] daemon started
21:43:02 [2019-10-21T21:43:02.059Z]     daemon.go:286: [d78493d61a586] exiting daemon
21:43:02 [2019-10-21T21:43:02.059Z] === RUN   TestTemplatedConfig
21:43:05 [2019-10-21T21:43:05.405Z] --- PASS: TestTemplatedConfig (3.44s)
21:43:05 [2019-10-21T21:43:05.405Z]     config_test.go:188: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestTemplatedConfig
21:43:05 [2019-10-21T21:43:05.405Z]     daemon.go:302: [d63fcdf8a7fc2] waiting for daemon to start
21:43:05 [2019-10-21T21:43:05.405Z]     daemon.go:334: [d63fcdf8a7fc2] daemon started
21:43:05 [2019-10-21T21:43:05.405Z]     daemon.go:286: [d63fcdf8a7fc2] exiting daemon
21:43:05 [2019-10-21T21:43:05.405Z] === RUN   TestConfigInspect
21:43:09 [2019-10-21T21:43:09.118Z] --- PASS: TestConfigInspect (3.39s)
21:43:09 [2019-10-21T21:43:09.118Z]     config_test.go:330: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestConfigInspect
21:43:09 [2019-10-21T21:43:09.118Z]     daemon.go:302: [d123dd5ed7767] waiting for daemon to start
21:43:09 [2019-10-21T21:43:09.118Z]     daemon.go:334: [d123dd5ed7767] daemon started
21:43:09 [2019-10-21T21:43:09.118Z]     daemon.go:286: [d123dd5ed7767] exiting daemon
21:43:09 [2019-10-21T21:43:09.118Z] === RUN   TestConfigCreateWithLabels
21:43:11 [2019-10-21T21:43:11.734Z] --- PASS: TestConfigCreateWithLabels (2.91s)
21:43:11 [2019-10-21T21:43:11.734Z]     config_test.go:354: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestConfigCreateWithLabels
21:43:11 [2019-10-21T21:43:11.734Z]     daemon.go:302: [def742026f4d7] waiting for daemon to start
21:43:11 [2019-10-21T21:43:11.734Z]     daemon.go:334: [def742026f4d7] daemon started
21:43:11 [2019-10-21T21:43:11.734Z]     daemon.go:286: [def742026f4d7] exiting daemon
21:43:11 [2019-10-21T21:43:11.734Z] === RUN   TestConfigCreateResolve
21:43:15 [2019-10-21T21:43:15.128Z] --- PASS: TestConfigCreateResolve (3.28s)
21:43:15 [2019-10-21T21:43:15.128Z]     config_test.go:381: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestConfigCreateResolve
21:43:15 [2019-10-21T21:43:15.128Z]     daemon.go:302: [d2be6ed249508] waiting for daemon to start
21:43:15 [2019-10-21T21:43:15.128Z]     daemon.go:334: [d2be6ed249508] daemon started
21:43:15 [2019-10-21T21:43:15.128Z]     daemon.go:286: [d2be6ed249508] exiting daemon
21:43:15 [2019-10-21T21:43:15.128Z] PASS
21:43:15 [2019-10-21T21:43:15.128Z] 
21:43:15 [2019-10-21T21:43:15.128Z] DONE 7 tests in 22.531s
21:43:15 [2019-10-21T21:43:15.128Z] Running /go/src/github.com/docker/docker/integration/container (s390x.integration.container) flags=-test.v -test.timeout=120m  
21:43:15 [2019-10-21T21:43:15.128Z] ++ 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
21:43:15 [2019-10-21T21:43:15.128Z] ++ set -e
21:43:15 [2019-10-21T21:43:15.128Z] ++ '[' -n 0 ']'
21:43:15 [2019-10-21T21:43:15.128Z] ++ set -x
21:43:15 [2019-10-21T21:43:15.128Z] ++ 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
21:43:15 [2019-10-21T21:43:15.128Z] INFO: Testing against a local daemon
21:43:15 [2019-10-21T21:43:15.128Z] === RUN   TestContainerInvalidJSON
21:43:15 [2019-10-21T21:43:15.128Z] === RUN   TestContainerInvalidJSON//containers/foobar/copy
21:43:15 [2019-10-21T21:43:15.128Z] === PAUSE TestContainerInvalidJSON//containers/foobar/copy
21:43:15 [2019-10-21T21:43:15.128Z] === RUN   TestContainerInvalidJSON//containers/foobar/exec
21:43:15 [2019-10-21T21:43:15.128Z] === PAUSE TestContainerInvalidJSON//containers/foobar/exec
21:43:15 [2019-10-21T21:43:15.128Z] === RUN   TestContainerInvalidJSON//exec/foobar/start
21:43:15 [2019-10-21T21:43:15.128Z] === PAUSE TestContainerInvalidJSON//exec/foobar/start
21:43:15 [2019-10-21T21:43:15.128Z] === CONT  TestContainerInvalidJSON//containers/foobar/copy
21:43:15 [2019-10-21T21:43:15.128Z] === CONT  TestContainerInvalidJSON//exec/foobar/start
21:43:15 [2019-10-21T21:43:15.128Z] === CONT  TestContainerInvalidJSON//containers/foobar/exec
21:43:15 [2019-10-21T21:43:15.128Z] --- PASS: TestContainerInvalidJSON (0.03s)
21:43:15 [2019-10-21T21:43:15.128Z]     --- PASS: TestContainerInvalidJSON//containers/foobar/copy (0.00s)
21:43:15 [2019-10-21T21:43:15.128Z]     --- PASS: TestContainerInvalidJSON//exec/foobar/start (0.00s)
21:43:15 [2019-10-21T21:43:15.128Z]     --- PASS: TestContainerInvalidJSON//containers/foobar/exec (0.00s)
21:43:15 [2019-10-21T21:43:15.128Z] === RUN   TestCopyFromContainerPathDoesNotExist
21:43:15 [2019-10-21T21:43:15.515Z] --- PASS: TestCopyFromContainerPathDoesNotExist (0.15s)
21:43:15 [2019-10-21T21:43:15.515Z] === RUN   TestCopyFromContainerPathIsNotDir
21:43:15 [2019-10-21T21:43:15.515Z] --- PASS: TestCopyFromContainerPathIsNotDir (0.13s)
21:43:15 [2019-10-21T21:43:15.515Z] === RUN   TestCopyToContainerPathDoesNotExist
21:43:15 [2019-10-21T21:43:15.515Z] --- PASS: TestCopyToContainerPathDoesNotExist (0.14s)
21:43:15 [2019-10-21T21:43:15.515Z] === RUN   TestCopyToContainerPathIsNotDir
21:43:15 [2019-10-21T21:43:15.904Z] --- PASS: TestCopyToContainerPathIsNotDir (0.11s)
21:43:15 [2019-10-21T21:43:15.904Z] === RUN   TestCopyFromContainer
21:43:17 [2019-10-21T21:43:17.764Z] === RUN   TestCopyFromContainer//
21:43:17 [2019-10-21T21:43:17.764Z] === RUN   TestCopyFromContainer//bar/root
21:43:18 [2019-10-21T21:43:18.159Z] === RUN   TestCopyFromContainer//bar/root/
21:43:18 [2019-10-21T21:43:18.160Z] === RUN   TestCopyFromContainer/bar/quux
21:43:18 [2019-10-21T21:43:18.160Z] === RUN   TestCopyFromContainer/bar/quux/
21:43:18 [2019-10-21T21:43:18.552Z] === RUN   TestCopyFromContainer/bar/quux/baz
21:43:18 [2019-10-21T21:43:18.552Z] === RUN   TestCopyFromContainer/bar/filesymlink
21:43:18 [2019-10-21T21:43:18.552Z] === RUN   TestCopyFromContainer/bar/dirsymlink
21:43:18 [2019-10-21T21:43:18.552Z] === RUN   TestCopyFromContainer/bar/dirsymlink/
21:43:18 [2019-10-21T21:43:18.961Z] === RUN   TestCopyFromContainer/bar/notarget
21:43:18 [2019-10-21T21:43:18.961Z] --- PASS: TestCopyFromContainer (3.20s)
21:43:18 [2019-10-21T21:43:18.961Z]     --- PASS: TestCopyFromContainer// (0.10s)
21:43:18 [2019-10-21T21:43:18.961Z]     --- PASS: TestCopyFromContainer//bar/root (0.13s)
21:43:18 [2019-10-21T21:43:18.961Z]     --- PASS: TestCopyFromContainer//bar/root/ (0.07s)
21:43:18 [2019-10-21T21:43:18.961Z]     --- PASS: TestCopyFromContainer/bar/quux (0.09s)
21:43:18 [2019-10-21T21:43:18.961Z]     --- PASS: TestCopyFromContainer/bar/quux/ (0.14s)
21:43:18 [2019-10-21T21:43:18.961Z]     --- PASS: TestCopyFromContainer/bar/quux/baz (0.09s)
21:43:18 [2019-10-21T21:43:18.961Z]     --- PASS: TestCopyFromContainer/bar/filesymlink (0.08s)
21:43:18 [2019-10-21T21:43:18.961Z]     --- PASS: TestCopyFromContainer/bar/dirsymlink (0.10s)
21:43:18 [2019-10-21T21:43:18.961Z]     --- PASS: TestCopyFromContainer/bar/dirsymlink/ (0.13s)
21:43:18 [2019-10-21T21:43:18.961Z]     --- PASS: TestCopyFromContainer/bar/notarget (0.12s)
21:43:18 [2019-10-21T21:43:18.961Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist
21:43:18 [2019-10-21T21:43:18.961Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
21:43:18 [2019-10-21T21:43:18.961Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
21:43:18 [2019-10-21T21:43:18.961Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
21:43:18 [2019-10-21T21:43:18.961Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
21:43:18 [2019-10-21T21:43:18.961Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/digest
21:43:18 [2019-10-21T21:43:18.961Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/digest
21:43:18 [2019-10-21T21:43:18.961Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
21:43:18 [2019-10-21T21:43:18.961Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/digest
21:43:18 [2019-10-21T21:43:18.961Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
21:43:18 [2019-10-21T21:43:18.961Z] --- PASS: TestCreateFailsWhenIdentifierDoesNotExist (0.01s)
21:43:18 [2019-10-21T21:43:18.961Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/digest (0.00s)
21:43:18 [2019-10-21T21:43:18.961Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag (0.00s)
21:43:18 [2019-10-21T21:43:18.961Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag (0.00s)
21:43:18 [2019-10-21T21:43:18.961Z] === RUN   TestCreateWithInvalidEnv
21:43:18 [2019-10-21T21:43:18.961Z] === RUN   TestCreateWithInvalidEnv/0
21:43:18 [2019-10-21T21:43:18.961Z] === PAUSE TestCreateWithInvalidEnv/0
21:43:18 [2019-10-21T21:43:18.961Z] === RUN   TestCreateWithInvalidEnv/1
21:43:18 [2019-10-21T21:43:18.961Z] === PAUSE TestCreateWithInvalidEnv/1
21:43:18 [2019-10-21T21:43:18.961Z] === RUN   TestCreateWithInvalidEnv/2
21:43:18 [2019-10-21T21:43:18.961Z] === PAUSE TestCreateWithInvalidEnv/2
21:43:18 [2019-10-21T21:43:18.961Z] === CONT  TestCreateWithInvalidEnv/0
21:43:18 [2019-10-21T21:43:18.961Z] === CONT  TestCreateWithInvalidEnv/2
21:43:18 [2019-10-21T21:43:18.961Z] === CONT  TestCreateWithInvalidEnv/1
21:43:18 [2019-10-21T21:43:18.961Z] --- PASS: TestCreateWithInvalidEnv (0.02s)
21:43:18 [2019-10-21T21:43:18.961Z]     --- PASS: TestCreateWithInvalidEnv/2 (0.00s)
21:43:18 [2019-10-21T21:43:18.961Z]     --- PASS: TestCreateWithInvalidEnv/0 (0.00s)
21:43:18 [2019-10-21T21:43:18.961Z]     --- PASS: TestCreateWithInvalidEnv/1 (0.01s)
21:43:18 [2019-10-21T21:43:18.961Z] === RUN   TestCreateTmpfsMountsTarget
21:43:18 [2019-10-21T21:43:18.961Z] --- PASS: TestCreateTmpfsMountsTarget (0.02s)
21:43:18 [2019-10-21T21:43:18.961Z] === RUN   TestCreateWithCustomMaskedPaths
21:43:22 [2019-10-21T21:43:22.431Z] --- PASS: TestCreateWithCustomMaskedPaths (2.99s)
21:43:22 [2019-10-21T21:43:22.431Z] === RUN   TestCreateWithCustomReadonlyPaths
21:43:25 [2019-10-21T21:43:25.003Z] --- PASS: TestCreateWithCustomReadonlyPaths (2.81s)
21:43:25 [2019-10-21T21:43:25.003Z] === RUN   TestContainerStartOnDaemonRestart
21:43:25 [2019-10-21T21:43:25.003Z] === PAUSE TestContainerStartOnDaemonRestart
21:43:25 [2019-10-21T21:43:25.003Z] === RUN   TestDaemonRestartIpcMode
21:43:25 [2019-10-21T21:43:25.003Z] === PAUSE TestDaemonRestartIpcMode
21:43:25 [2019-10-21T21:43:25.003Z] === RUN   TestDiff
21:43:25 [2019-10-21T21:43:25.835Z] --- PASS: TestDiff (1.01s)
21:43:25 [2019-10-21T21:43:25.835Z] === RUN   TestExecWithCloseStdin
21:43:27 [2019-10-21T21:43:27.234Z] --- PASS: TestExecWithCloseStdin (1.11s)
21:43:27 [2019-10-21T21:43:27.234Z] === RUN   TestExec
21:43:28 [2019-10-21T21:43:28.265Z] --- PASS: TestExec (1.35s)
21:43:28 [2019-10-21T21:43:28.265Z] === RUN   TestExecUser
21:43:29 [2019-10-21T21:43:29.644Z] --- PASS: TestExecUser (1.09s)
21:43:29 [2019-10-21T21:43:29.644Z] === RUN   TestExportContainerAndImportImage
21:43:31 [2019-10-21T21:43:31.011Z] --- PASS: TestExportContainerAndImportImage (1.36s)
21:43:31 [2019-10-21T21:43:31.011Z] === RUN   TestExportContainerAfterDaemonRestart
21:43:32 [2019-10-21T21:43:32.453Z] --- PASS: TestExportContainerAfterDaemonRestart (1.66s)
21:43:32 [2019-10-21T21:43:32.453Z]     export_test.go:63: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestExportContainerAfterDaemonRestart
21:43:32 [2019-10-21T21:43:32.453Z]     daemon.go:302: [deb6871752958] waiting for daemon to start
21:43:32 [2019-10-21T21:43:32.453Z]     daemon.go:334: [deb6871752958] daemon started
21:43:32 [2019-10-21T21:43:32.453Z]     daemon.go:286: [deb6871752958] exiting daemon
21:43:32 [2019-10-21T21:43:32.453Z]     daemon.go:302: [deb6871752958] waiting for daemon to start
21:43:32 [2019-10-21T21:43:32.453Z]     daemon.go:334: [deb6871752958] daemon started
21:43:32 [2019-10-21T21:43:32.453Z]     daemon.go:286: [deb6871752958] exiting daemon
21:43:32 [2019-10-21T21:43:32.453Z] === RUN   TestHealthCheckWorkdir
21:43:33 [2019-10-21T21:43:33.950Z] --- PASS: TestHealthCheckWorkdir (1.40s)
21:43:33 [2019-10-21T21:43:33.950Z] === RUN   TestHealthKillContainer
21:43:37 [2019-10-21T21:43:37.306Z] --- PASS: TestHealthKillContainer (3.22s)
21:43:37 [2019-10-21T21:43:37.306Z] === RUN   TestInspectCpusetInConfigPre120
21:43:38 [2019-10-21T21:43:38.180Z] --- PASS: TestInspectCpusetInConfigPre120 (1.02s)
21:43:38 [2019-10-21T21:43:38.180Z] === RUN   TestIpcModeNone
21:43:39 [2019-10-21T21:43:39.170Z] --- PASS: TestIpcModeNone (1.21s)
21:43:39 [2019-10-21T21:43:39.170Z] === RUN   TestIpcModePrivate
21:43:40 [2019-10-21T21:43:40.647Z] --- PASS: TestIpcModePrivate (1.24s)
21:43:40 [2019-10-21T21:43:40.647Z]     ipcmode_linux_test.go:87: [testIpcPrivateShareable] ipcmode: private, ipcdev: 0:56, shared: false, mustBeShared: false
21:43:40 [2019-10-21T21:43:40.647Z] === RUN   TestIpcModeShareable
21:43:41 [2019-10-21T21:43:41.962Z] --- PASS: TestIpcModeShareable (1.28s)
21:43:41 [2019-10-21T21:43:41.962Z]     ipcmode_linux_test.go:87: [testIpcPrivateShareable] ipcmode: shareable, ipcdev: 0:50, shared: true, mustBeShared: true
21:43:41 [2019-10-21T21:43:41.962Z] === RUN   TestAPIIpcModeShareableAndContainer
21:43:45 [2019-10-21T21:43:45.434Z] --- PASS: TestAPIIpcModeShareableAndContainer (3.42s)
21:43:45 [2019-10-21T21:43:45.434Z] === RUN   TestAPIIpcModeHost
21:43:46 [2019-10-21T21:43:46.394Z] --- PASS: TestAPIIpcModeHost (1.04s)
21:43:46 [2019-10-21T21:43:46.394Z] === RUN   TestDaemonIpcModeShareable
21:43:48 [2019-10-21T21:43:48.395Z] --- PASS: TestDaemonIpcModeShareable (2.05s)
21:43:48 [2019-10-21T21:43:48.395Z]     ipcmode_linux_test.go:227: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModeShareable
21:43:48 [2019-10-21T21:43:48.395Z]     daemon.go:302: [d0af33e583680] waiting for daemon to start
21:43:48 [2019-10-21T21:43:48.395Z]     daemon.go:334: [d0af33e583680] daemon started
21:43:48 [2019-10-21T21:43:48.395Z]     ipcmode_linux_test.go:255: [testDaemonIpcPrivateShareable] ipcdev: 0:58, shared: true, mustBeShared: true
21:43:48 [2019-10-21T21:43:48.395Z]     daemon.go:286: [d0af33e583680] exiting daemon
21:43:48 [2019-10-21T21:43:48.395Z] === RUN   TestDaemonIpcModePrivate
21:43:50 [2019-10-21T21:43:50.468Z] --- PASS: TestDaemonIpcModePrivate (2.05s)
21:43:50 [2019-10-21T21:43:50.468Z]     ipcmode_linux_test.go:227: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModePrivate
21:43:50 [2019-10-21T21:43:50.468Z]     daemon.go:302: [d6f11728d2c5d] waiting for daemon to start
21:43:50 [2019-10-21T21:43:50.468Z]     daemon.go:334: [d6f11728d2c5d] daemon started
21:43:50 [2019-10-21T21:43:50.468Z]     ipcmode_linux_test.go:255: [testDaemonIpcPrivateShareable] ipcdev: 0:64, shared: false, mustBeShared: false
21:43:50 [2019-10-21T21:43:50.468Z]     daemon.go:286: [d6f11728d2c5d] exiting daemon
21:43:50 [2019-10-21T21:43:50.468Z] === RUN   TestDaemonIpcModePrivateFromConfig
21:43:52 [2019-10-21T21:43:52.875Z] --- PASS: TestDaemonIpcModePrivateFromConfig (2.07s)
21:43:52 [2019-10-21T21:43:52.875Z]     ipcmode_linux_test.go:227: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModePrivateFromConfig
21:43:52 [2019-10-21T21:43:52.875Z]     daemon.go:302: [d63b1950eb8cb] waiting for daemon to start
21:43:52 [2019-10-21T21:43:52.875Z]     daemon.go:334: [d63b1950eb8cb] daemon started
21:43:52 [2019-10-21T21:43:52.875Z]     ipcmode_linux_test.go:255: [testDaemonIpcPrivateShareable] ipcdev: 0:64, shared: false, mustBeShared: false
21:43:52 [2019-10-21T21:43:52.875Z]     daemon.go:286: [d63b1950eb8cb] exiting daemon
21:43:52 [2019-10-21T21:43:52.875Z] === RUN   TestDaemonIpcModeShareableFromConfig
21:43:54 [2019-10-21T21:43:54.842Z] --- PASS: TestDaemonIpcModeShareableFromConfig (2.10s)
21:43:54 [2019-10-21T21:43:54.842Z]     ipcmode_linux_test.go:227: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModeShareableFromConfig
21:43:54 [2019-10-21T21:43:54.842Z]     daemon.go:302: [d8385b33cfa24] waiting for daemon to start
21:43:54 [2019-10-21T21:43:54.842Z]     daemon.go:334: [d8385b33cfa24] daemon started
21:43:54 [2019-10-21T21:43:54.842Z]     ipcmode_linux_test.go:255: [testDaemonIpcPrivateShareable] ipcdev: 0:58, shared: true, mustBeShared: true
21:43:54 [2019-10-21T21:43:54.842Z]     daemon.go:286: [d8385b33cfa24] exiting daemon
21:43:54 [2019-10-21T21:43:54.842Z] === RUN   TestKillContainerInvalidSignal
21:43:55 [2019-10-21T21:43:55.684Z] --- PASS: TestKillContainerInvalidSignal (1.02s)
21:43:55 [2019-10-21T21:43:55.684Z] === RUN   TestKillContainer
21:43:55 [2019-10-21T21:43:55.684Z] === RUN   TestKillContainer/no_signal
21:43:56 [2019-10-21T21:43:56.541Z] === RUN   TestKillContainer/non_killing_signal
21:43:57 [2019-10-21T21:43:57.391Z] === RUN   TestKillContainer/killing_signal
21:43:58 [2019-10-21T21:43:58.513Z] --- PASS: TestKillContainer (3.12s)
21:43:58 [2019-10-21T21:43:58.513Z]     --- PASS: TestKillContainer/no_signal (1.05s)
21:43:58 [2019-10-21T21:43:58.513Z]     --- PASS: TestKillContainer/non_killing_signal (0.63s)
21:43:58 [2019-10-21T21:43:58.513Z]     --- PASS: TestKillContainer/killing_signal (0.99s)
21:43:58 [2019-10-21T21:43:58.513Z] === RUN   TestKillWithStopSignalAndRestartPolicies
21:43:58 [2019-10-21T21:43:58.513Z] === RUN   TestKillWithStopSignalAndRestartPolicies/same-signal-disables-restart-policy
21:43:59 [2019-10-21T21:43:59.380Z] === RUN   TestKillWithStopSignalAndRestartPolicies/different-signal-keep-restart-policy
21:44:00 [2019-10-21T21:44:00.727Z] --- PASS: TestKillWithStopSignalAndRestartPolicies (2.02s)
21:44:00 [2019-10-21T21:44:00.727Z]     --- PASS: TestKillWithStopSignalAndRestartPolicies/same-signal-disables-restart-policy (0.92s)
21:44:00 [2019-10-21T21:44:00.727Z]     --- PASS: TestKillWithStopSignalAndRestartPolicies/different-signal-keep-restart-policy (0.66s)
21:44:00 [2019-10-21T21:44:00.727Z] === RUN   TestKillStoppedContainer
21:44:00 [2019-10-21T21:44:00.727Z] --- PASS: TestKillStoppedContainer (0.10s)
21:44:00 [2019-10-21T21:44:00.727Z] === RUN   TestKillStoppedContainerAPIPre120
21:44:00 [2019-10-21T21:44:00.727Z] --- PASS: TestKillStoppedContainerAPIPre120 (0.08s)
21:44:00 [2019-10-21T21:44:00.727Z] === RUN   TestKillDifferentUserContainer
21:44:02 [2019-10-21T21:44:02.088Z] --- PASS: TestKillDifferentUserContainer (0.95s)
21:44:02 [2019-10-21T21:44:02.088Z] === RUN   TestInspectOomKilledTrue
21:44:02 [2019-10-21T21:44:02.088Z] --- SKIP: TestInspectOomKilledTrue (0.00s)
21:44:02 [2019-10-21T21:44:02.088Z]     kill_test.go:151: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
21:44:02 [2019-10-21T21:44:02.088Z] === RUN   TestInspectOomKilledFalse
21:44:02 [2019-10-21T21:44:02.088Z] --- SKIP: TestInspectOomKilledFalse (0.00s)
21:44:02 [2019-10-21T21:44:02.088Z]     kill_test.go:169: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
21:44:02 [2019-10-21T21:44:02.088Z] === RUN   TestLinksEtcHostsContentMatch
21:44:02 [2019-10-21T21:44:02.491Z] --- PASS: TestLinksEtcHostsContentMatch (0.74s)
21:44:02 [2019-10-21T21:44:02.491Z] === RUN   TestLinksContainerNames
21:44:04 [2019-10-21T21:44:04.560Z] --- PASS: TestLinksContainerNames (2.05s)
21:44:04 [2019-10-21T21:44:04.560Z] === RUN   TestLogsFollowTailEmpty
21:44:05 [2019-10-21T21:44:05.455Z] --- PASS: TestLogsFollowTailEmpty (1.02s)
21:44:05 [2019-10-21T21:44:05.455Z] === RUN   TestContainerNetworkMountsNoChown
21:44:06 [2019-10-21T21:44:06.772Z] --- PASS: TestContainerNetworkMountsNoChown (0.95s)
21:44:06 [2019-10-21T21:44:06.772Z] === RUN   TestMountDaemonRoot
21:44:06 [2019-10-21T21:44:06.772Z] === RUN   TestMountDaemonRoot/default
21:44:06 [2019-10-21T21:44:06.772Z] === PAUSE TestMountDaemonRoot/default
21:44:06 [2019-10-21T21:44:06.772Z] === RUN   TestMountDaemonRoot/private
21:44:06 [2019-10-21T21:44:06.772Z] === PAUSE TestMountDaemonRoot/private
21:44:06 [2019-10-21T21:44:06.772Z] === RUN   TestMountDaemonRoot/rprivate
21:44:06 [2019-10-21T21:44:06.772Z] === PAUSE TestMountDaemonRoot/rprivate
21:44:06 [2019-10-21T21:44:06.772Z] === RUN   TestMountDaemonRoot/slave
21:44:06 [2019-10-21T21:44:06.772Z] === PAUSE TestMountDaemonRoot/slave
21:44:06 [2019-10-21T21:44:06.772Z] === RUN   TestMountDaemonRoot/rslave
21:44:06 [2019-10-21T21:44:06.772Z] === PAUSE TestMountDaemonRoot/rslave
21:44:06 [2019-10-21T21:44:06.772Z] === RUN   TestMountDaemonRoot/shared
21:44:06 [2019-10-21T21:44:06.772Z] === PAUSE TestMountDaemonRoot/shared
21:44:06 [2019-10-21T21:44:06.772Z] === RUN   TestMountDaemonRoot/rshared
21:44:06 [2019-10-21T21:44:06.772Z] === PAUSE TestMountDaemonRoot/rshared
21:44:06 [2019-10-21T21:44:06.772Z] === CONT  TestMountDaemonRoot/default
21:44:06 [2019-10-21T21:44:06.772Z] === RUN   TestMountDaemonRoot/default/mount_subpath
21:44:06 [2019-10-21T21:44:06.772Z] === PAUSE TestMountDaemonRoot/default/mount_subpath
21:44:06 [2019-10-21T21:44:06.772Z] === RUN   TestMountDaemonRoot/default/bind_root
21:44:06 [2019-10-21T21:44:06.772Z] === PAUSE TestMountDaemonRoot/default/bind_root
21:44:06 [2019-10-21T21:44:06.772Z] === RUN   TestMountDaemonRoot/default/bind_subpath
21:44:06 [2019-10-21T21:44:06.772Z] === PAUSE TestMountDaemonRoot/default/bind_subpath
21:44:06 [2019-10-21T21:44:06.772Z] === RUN   TestMountDaemonRoot/default/mount_root
21:44:06 [2019-10-21T21:44:06.772Z] === PAUSE TestMountDaemonRoot/default/mount_root
21:44:06 [2019-10-21T21:44:06.772Z] === CONT  TestMountDaemonRoot/default/mount_subpath
21:44:06 [2019-10-21T21:44:06.772Z] === CONT  TestMountDaemonRoot/rprivate
21:44:06 [2019-10-21T21:44:06.772Z] === RUN   TestMountDaemonRoot/rprivate/mount_root
21:44:06 [2019-10-21T21:44:06.772Z] === PAUSE TestMountDaemonRoot/rprivate/mount_root
21:44:06 [2019-10-21T21:44:06.772Z] === RUN   TestMountDaemonRoot/rprivate/mount_subpath
21:44:06 [2019-10-21T21:44:06.772Z] === PAUSE TestMountDaemonRoot/rprivate/mount_subpath
21:44:06 [2019-10-21T21:44:06.772Z] === RUN   TestMountDaemonRoot/rprivate/bind_root
21:44:06 [2019-10-21T21:44:06.772Z] === PAUSE TestMountDaemonRoot/rprivate/bind_root
21:44:06 [2019-10-21T21:44:06.772Z] === RUN   TestMountDaemonRoot/rprivate/bind_subpath
21:44:06 [2019-10-21T21:44:06.772Z] === PAUSE TestMountDaemonRoot/rprivate/bind_subpath
21:44:06 [2019-10-21T21:44:06.772Z] === CONT  TestMountDaemonRoot/rprivate/mount_root
21:44:06 [2019-10-21T21:44:06.772Z] === CONT  TestMountDaemonRoot/rshared
21:44:06 [2019-10-21T21:44:06.772Z] === RUN   TestMountDaemonRoot/rshared/bind_root
21:44:06 [2019-10-21T21:44:06.772Z] === PAUSE TestMountDaemonRoot/rshared/bind_root
21:44:06 [2019-10-21T21:44:06.772Z] === RUN   TestMountDaemonRoot/rshared/bind_subpath
21:44:06 [2019-10-21T21:44:06.772Z] === PAUSE TestMountDaemonRoot/rshared/bind_subpath
21:44:06 [2019-10-21T21:44:06.772Z] === RUN   TestMountDaemonRoot/rshared/mount_root
21:44:06 [2019-10-21T21:44:06.772Z] === PAUSE TestMountDaemonRoot/rshared/mount_root
21:44:06 [2019-10-21T21:44:06.772Z] === RUN   TestMountDaemonRoot/rshared/mount_subpath
21:44:06 [2019-10-21T21:44:06.772Z] === PAUSE TestMountDaemonRoot/rshared/mount_subpath
21:44:06 [2019-10-21T21:44:06.772Z] === CONT  TestMountDaemonRoot/shared
21:44:06 [2019-10-21T21:44:06.772Z] === RUN   TestMountDaemonRoot/shared/bind_root
21:44:06 [2019-10-21T21:44:06.772Z] === PAUSE TestMountDaemonRoot/shared/bind_root
21:44:06 [2019-10-21T21:44:06.772Z] === RUN   TestMountDaemonRoot/shared/bind_subpath
21:44:06 [2019-10-21T21:44:06.772Z] === PAUSE TestMountDaemonRoot/shared/bind_subpath
21:44:06 [2019-10-21T21:44:06.772Z] === RUN   TestMountDaemonRoot/shared/mount_root
21:44:06 [2019-10-21T21:44:06.772Z] === PAUSE TestMountDaemonRoot/shared/mount_root
21:44:06 [2019-10-21T21:44:06.772Z] === RUN   TestMountDaemonRoot/shared/mount_subpath
21:44:06 [2019-10-21T21:44:06.772Z] === PAUSE TestMountDaemonRoot/shared/mount_subpath
21:44:06 [2019-10-21T21:44:06.772Z] === CONT  TestMountDaemonRoot/rslave
21:44:06 [2019-10-21T21:44:06.772Z] === RUN   TestMountDaemonRoot/rslave/bind_root
21:44:06 [2019-10-21T21:44:06.772Z] === PAUSE TestMountDaemonRoot/rslave/bind_root
21:44:06 [2019-10-21T21:44:06.772Z] === RUN   TestMountDaemonRoot/rslave/bind_subpath
21:44:06 [2019-10-21T21:44:06.772Z] === PAUSE TestMountDaemonRoot/rslave/bind_subpath
21:44:06 [2019-10-21T21:44:06.772Z] === RUN   TestMountDaemonRoot/rslave/mount_root
21:44:06 [2019-10-21T21:44:06.772Z] === PAUSE TestMountDaemonRoot/rslave/mount_root
21:44:06 [2019-10-21T21:44:06.772Z] === RUN   TestMountDaemonRoot/rslave/mount_subpath
21:44:06 [2019-10-21T21:44:06.772Z] === PAUSE TestMountDaemonRoot/rslave/mount_subpath
21:44:06 [2019-10-21T21:44:06.772Z] === CONT  TestMountDaemonRoot/slave
21:44:06 [2019-10-21T21:44:06.772Z] === RUN   TestMountDaemonRoot/slave/bind_root
21:44:06 [2019-10-21T21:44:06.772Z] === PAUSE TestMountDaemonRoot/slave/bind_root
21:44:06 [2019-10-21T21:44:06.772Z] === RUN   TestMountDaemonRoot/slave/bind_subpath
21:44:06 [2019-10-21T21:44:06.772Z] === PAUSE TestMountDaemonRoot/slave/bind_subpath
21:44:06 [2019-10-21T21:44:06.772Z] === RUN   TestMountDaemonRoot/slave/mount_root
21:44:06 [2019-10-21T21:44:06.772Z] === PAUSE TestMountDaemonRoot/slave/mount_root
21:44:06 [2019-10-21T21:44:06.772Z] === RUN   TestMountDaemonRoot/slave/mount_subpath
21:44:06 [2019-10-21T21:44:06.772Z] === PAUSE TestMountDaemonRoot/slave/mount_subpath
21:44:06 [2019-10-21T21:44:06.772Z] === CONT  TestMountDaemonRoot/rprivate/bind_subpath
21:44:06 [2019-10-21T21:44:06.772Z] === CONT  TestMountDaemonRoot/rprivate/bind_root
21:44:06 [2019-10-21T21:44:06.772Z] === CONT  TestMountDaemonRoot/rprivate/mount_subpath
21:44:06 [2019-10-21T21:44:06.772Z] === CONT  TestMountDaemonRoot/default/mount_root
21:44:06 [2019-10-21T21:44:06.772Z] === CONT  TestMountDaemonRoot/private
21:44:06 [2019-10-21T21:44:06.772Z] === RUN   TestMountDaemonRoot/private/bind_subpath
21:44:06 [2019-10-21T21:44:06.772Z] === PAUSE TestMountDaemonRoot/private/bind_subpath
21:44:06 [2019-10-21T21:44:06.772Z] === RUN   TestMountDaemonRoot/private/mount_root
21:44:06 [2019-10-21T21:44:06.772Z] === PAUSE TestMountDaemonRoot/private/mount_root
21:44:06 [2019-10-21T21:44:06.772Z] === RUN   TestMountDaemonRoot/private/mount_subpath
21:44:06 [2019-10-21T21:44:06.772Z] === PAUSE TestMountDaemonRoot/private/mount_subpath
21:44:06 [2019-10-21T21:44:06.772Z] === RUN   TestMountDaemonRoot/private/bind_root
21:44:06 [2019-10-21T21:44:06.772Z] === PAUSE TestMountDaemonRoot/private/bind_root
21:44:06 [2019-10-21T21:44:06.772Z] === CONT  TestMountDaemonRoot/default/bind_subpath
21:44:06 [2019-10-21T21:44:06.772Z] === CONT  TestMountDaemonRoot/default/bind_root
21:44:06 [2019-10-21T21:44:06.772Z] === CONT  TestMountDaemonRoot/rshared/bind_root
21:44:06 [2019-10-21T21:44:06.772Z] === CONT  TestMountDaemonRoot/shared/bind_root
21:44:06 [2019-10-21T21:44:06.772Z] === CONT  TestMountDaemonRoot/rshared/mount_subpath
21:44:06 [2019-10-21T21:44:06.772Z] === CONT  TestMountDaemonRoot/rshared/mount_root
21:44:06 [2019-10-21T21:44:06.772Z] === CONT  TestMountDaemonRoot/rshared/bind_subpath
21:44:07 [2019-10-21T21:44:07.176Z] === CONT  TestMountDaemonRoot/rslave/bind_root
21:44:07 [2019-10-21T21:44:07.176Z] === CONT  TestMountDaemonRoot/shared/mount_subpath
21:44:07 [2019-10-21T21:44:07.176Z] === CONT  TestMountDaemonRoot/shared/mount_root
21:44:07 [2019-10-21T21:44:07.176Z] === CONT  TestMountDaemonRoot/shared/bind_subpath
21:44:07 [2019-10-21T21:44:07.176Z] === CONT  TestMountDaemonRoot/slave/bind_root
21:44:07 [2019-10-21T21:44:07.176Z] === CONT  TestMountDaemonRoot/rslave/mount_subpath
21:44:07 [2019-10-21T21:44:07.176Z] === CONT  TestMountDaemonRoot/rslave/mount_root
21:44:07 [2019-10-21T21:44:07.176Z] === CONT  TestMountDaemonRoot/rslave/bind_subpath
21:44:07 [2019-10-21T21:44:07.176Z] === CONT  TestMountDaemonRoot/slave/mount_subpath
21:44:07 [2019-10-21T21:44:07.176Z] === CONT  TestMountDaemonRoot/slave/mount_root
21:44:07 [2019-10-21T21:44:07.176Z] === CONT  TestMountDaemonRoot/slave/bind_subpath
21:44:07 [2019-10-21T21:44:07.176Z] === CONT  TestMountDaemonRoot/private/bind_subpath
21:44:07 [2019-10-21T21:44:07.176Z] === CONT  TestMountDaemonRoot/private/mount_subpath
21:44:07 [2019-10-21T21:44:07.605Z] === CONT  TestMountDaemonRoot/private/bind_root
21:44:07 [2019-10-21T21:44:07.605Z] === CONT  TestMountDaemonRoot/private/mount_root
21:44:07 [2019-10-21T21:44:07.605Z] --- PASS: TestMountDaemonRoot (0.02s)
21:44:07 [2019-10-21T21:44:07.605Z]     --- PASS: TestMountDaemonRoot/rprivate (0.00s)
21:44:07 [2019-10-21T21:44:07.605Z]         --- PASS: TestMountDaemonRoot/rprivate/mount_root (0.06s)
21:44:07 [2019-10-21T21:44:07.605Z]         --- PASS: TestMountDaemonRoot/rprivate/bind_subpath (0.04s)
21:44:07 [2019-10-21T21:44:07.605Z]         --- PASS: TestMountDaemonRoot/rprivate/bind_root (0.05s)
21:44:07 [2019-10-21T21:44:07.605Z]         --- PASS: TestMountDaemonRoot/rprivate/mount_subpath (0.05s)
21:44:07 [2019-10-21T21:44:07.605Z]     --- PASS: TestMountDaemonRoot/default (0.00s)
21:44:07 [2019-10-21T21:44:07.605Z]         --- PASS: TestMountDaemonRoot/default/mount_subpath (0.10s)
21:44:07 [2019-10-21T21:44:07.605Z]         --- PASS: TestMountDaemonRoot/default/mount_root (0.07s)
21:44:07 [2019-10-21T21:44:07.605Z]         --- PASS: TestMountDaemonRoot/default/bind_subpath (0.08s)
21:44:07 [2019-10-21T21:44:07.605Z]         --- PASS: TestMountDaemonRoot/default/bind_root (0.08s)
21:44:07 [2019-10-21T21:44:07.605Z]     --- PASS: TestMountDaemonRoot/rshared (0.00s)
21:44:07 [2019-10-21T21:44:07.605Z]         --- PASS: TestMountDaemonRoot/rshared/bind_root (0.07s)
21:44:07 [2019-10-21T21:44:07.605Z]         --- PASS: TestMountDaemonRoot/rshared/mount_subpath (0.07s)
21:44:07 [2019-10-21T21:44:07.605Z]         --- PASS: TestMountDaemonRoot/rshared/mount_root (0.08s)
21:44:07 [2019-10-21T21:44:07.605Z]         --- PASS: TestMountDaemonRoot/rshared/bind_subpath (0.10s)
21:44:07 [2019-10-21T21:44:07.605Z]     --- PASS: TestMountDaemonRoot/shared (0.00s)
21:44:07 [2019-10-21T21:44:07.605Z]         --- PASS: TestMountDaemonRoot/shared/bind_root (0.05s)
21:44:07 [2019-10-21T21:44:07.605Z]         --- PASS: TestMountDaemonRoot/shared/mount_subpath (0.04s)
21:44:07 [2019-10-21T21:44:07.605Z]         --- PASS: TestMountDaemonRoot/shared/mount_root (0.04s)
21:44:07 [2019-10-21T21:44:07.605Z]         --- PASS: TestMountDaemonRoot/shared/bind_subpath (0.04s)
21:44:07 [2019-10-21T21:44:07.605Z]     --- PASS: TestMountDaemonRoot/rslave (0.00s)
21:44:07 [2019-10-21T21:44:07.605Z]         --- PASS: TestMountDaemonRoot/rslave/bind_root (0.10s)
21:44:07 [2019-10-21T21:44:07.605Z]         --- PASS: TestMountDaemonRoot/rslave/mount_subpath (0.10s)
21:44:07 [2019-10-21T21:44:07.605Z]         --- PASS: TestMountDaemonRoot/rslave/mount_root (0.09s)
21:44:07 [2019-10-21T21:44:07.605Z]         --- PASS: TestMountDaemonRoot/rslave/bind_subpath (0.09s)
21:44:07 [2019-10-21T21:44:07.605Z]     --- PASS: TestMountDaemonRoot/slave (0.00s)
21:44:07 [2019-10-21T21:44:07.605Z]         --- PASS: TestMountDaemonRoot/slave/bind_root (0.05s)
21:44:07 [2019-10-21T21:44:07.605Z]         --- PASS: TestMountDaemonRoot/slave/mount_subpath (0.05s)
21:44:07 [2019-10-21T21:44:07.605Z]         --- PASS: TestMountDaemonRoot/slave/mount_root (0.04s)
21:44:07 [2019-10-21T21:44:07.605Z]         --- PASS: TestMountDaemonRoot/slave/bind_subpath (0.04s)
21:44:07 [2019-10-21T21:44:07.605Z]     --- PASS: TestMountDaemonRoot/private (0.00s)
21:44:07 [2019-10-21T21:44:07.605Z]         --- PASS: TestMountDaemonRoot/private/bind_subpath (0.03s)
21:44:07 [2019-10-21T21:44:07.605Z]         --- PASS: TestMountDaemonRoot/private/mount_subpath (0.04s)
21:44:07 [2019-10-21T21:44:07.605Z]         --- PASS: TestMountDaemonRoot/private/bind_root (0.06s)
21:44:07 [2019-10-21T21:44:07.605Z]         --- PASS: TestMountDaemonRoot/private/mount_root (0.04s)
21:44:07 [2019-10-21T21:44:07.605Z] === RUN   TestNetworkNat
21:44:08 [2019-10-21T21:44:08.445Z] --- PASS: TestNetworkNat (1.03s)
21:44:08 [2019-10-21T21:44:08.445Z] === RUN   TestNetworkLocalhostTCPNat
21:44:09 [2019-10-21T21:44:09.302Z] --- PASS: TestNetworkLocalhostTCPNat (0.99s)
21:44:09 [2019-10-21T21:44:09.302Z] === RUN   TestNetworkLoopbackNat
21:44:10 [2019-10-21T21:44:10.793Z] --- PASS: TestNetworkLoopbackNat (1.35s)
21:44:10 [2019-10-21T21:44:10.793Z] === RUN   TestPause
21:44:11 [2019-10-21T21:44:11.632Z] --- PASS: TestPause (0.97s)
21:44:11 [2019-10-21T21:44:11.632Z] === RUN   TestPauseFailsOnWindowsServerContainers
21:44:11 [2019-10-21T21:44:11.632Z] --- SKIP: TestPauseFailsOnWindowsServerContainers (0.00s)
21:44:11 [2019-10-21T21:44:11.632Z]     pause_test.go:54: testEnv.DaemonInfo.OSType != "windows" || testEnv.DaemonInfo.Isolation != "process"
21:44:11 [2019-10-21T21:44:11.632Z] === RUN   TestPauseStopPausedContainer
21:44:12 [2019-10-21T21:44:12.965Z] --- PASS: TestPauseStopPausedContainer (0.97s)
21:44:12 [2019-10-21T21:44:12.965Z] === RUN   TestPsFilter
21:44:12 [2019-10-21T21:44:12.965Z] --- PASS: TestPsFilter (0.26s)
21:44:12 [2019-10-21T21:44:12.965Z] === RUN   TestRemoveContainerWithRemovedVolume
21:44:13 [2019-10-21T21:44:13.797Z] --- PASS: TestRemoveContainerWithRemovedVolume (0.93s)
21:44:13 [2019-10-21T21:44:13.797Z] === RUN   TestRemoveContainerWithVolume
21:44:15 [2019-10-21T21:44:15.241Z] --- PASS: TestRemoveContainerWithVolume (0.95s)
21:44:15 [2019-10-21T21:44:15.241Z] === RUN   TestRemoveContainerRunning
21:44:16 [2019-10-21T21:44:16.111Z] --- PASS: TestRemoveContainerRunning (1.07s)
21:44:16 [2019-10-21T21:44:16.111Z] === RUN   TestRemoveContainerForceRemoveRunning
21:44:16 [2019-10-21T21:44:16.916Z] --- PASS: TestRemoveContainerForceRemoveRunning (1.01s)
21:44:16 [2019-10-21T21:44:16.916Z] === RUN   TestRemoveInvalidContainer
21:44:16 [2019-10-21T21:44:16.916Z] --- PASS: TestRemoveInvalidContainer (0.01s)
21:44:16 [2019-10-21T21:44:16.916Z] === RUN   TestRenameLinkedContainer
21:44:21 [2019-10-21T21:44:21.012Z] --- PASS: TestRenameLinkedContainer (3.52s)
21:44:21 [2019-10-21T21:44:21.012Z] === RUN   TestRenameStoppedContainer
21:44:21 [2019-10-21T21:44:21.468Z] --- PASS: TestRenameStoppedContainer (0.91s)
21:44:21 [2019-10-21T21:44:21.468Z] === RUN   TestRenameRunningContainerAndReuse
21:44:23 [2019-10-21T21:44:23.500Z] --- PASS: TestRenameRunningContainerAndReuse (1.93s)
21:44:23 [2019-10-21T21:44:23.500Z] === RUN   TestRenameInvalidName
21:44:24 [2019-10-21T21:44:24.307Z] --- PASS: TestRenameInvalidName (1.07s)
21:44:24 [2019-10-21T21:44:24.308Z] === RUN   TestRenameAnonymousContainer
21:44:28 [2019-10-21T21:44:28.620Z] --- PASS: TestRenameAnonymousContainer (3.57s)
21:44:28 [2019-10-21T21:44:28.620Z] === RUN   TestRenameContainerWithSameName
21:44:29 [2019-10-21T21:44:29.038Z] --- PASS: TestRenameContainerWithSameName (1.03s)
21:44:29 [2019-10-21T21:44:29.038Z] === RUN   TestRenameContainerWithLinkedContainer
21:44:30 [2019-10-21T21:44:30.931Z] --- PASS: TestRenameContainerWithLinkedContainer (1.96s)
21:44:30 [2019-10-21T21:44:30.931Z] === RUN   TestResize
21:44:32 [2019-10-21T21:44:32.215Z] --- PASS: TestResize (0.97s)
21:44:32 [2019-10-21T21:44:32.215Z] === RUN   TestResizeWithInvalidSize
21:44:33 [2019-10-21T21:44:33.041Z] --- PASS: TestResizeWithInvalidSize (0.99s)
21:44:33 [2019-10-21T21:44:33.041Z] === RUN   TestResizeWhenContainerNotStarted
21:44:34 [2019-10-21T21:44:34.127Z] --- PASS: TestResizeWhenContainerNotStarted (0.96s)
21:44:34 [2019-10-21T21:44:34.127Z] === RUN   TestDaemonRestartKillContainers
21:44:34 [2019-10-21T21:44:34.127Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
21:44:34 [2019-10-21T21:44:34.127Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
21:44:34 [2019-10-21T21:44:34.127Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
21:44:34 [2019-10-21T21:44:34.127Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
21:44:34 [2019-10-21T21:44:34.127Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
21:44:34 [2019-10-21T21:44:34.127Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
21:44:34 [2019-10-21T21:44:34.127Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
21:44:34 [2019-10-21T21:44:34.127Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
21:44:34 [2019-10-21T21:44:34.127Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
21:44:34 [2019-10-21T21:44:34.127Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
21:44:34 [2019-10-21T21:44:34.127Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
21:44:34 [2019-10-21T21:44:34.127Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
21:44:34 [2019-10-21T21:44:34.127Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
21:44:34 [2019-10-21T21:44:34.127Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
21:44:34 [2019-10-21T21:44:34.127Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
21:44:34 [2019-10-21T21:44:34.127Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
21:44:34 [2019-10-21T21:44:34.127Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
21:44:34 [2019-10-21T21:44:34.127Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
21:44:34 [2019-10-21T21:44:34.127Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
21:44:34 [2019-10-21T21:44:34.127Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
21:44:34 [2019-10-21T21:44:34.127Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
21:44:34 [2019-10-21T21:44:34.127Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
21:44:34 [2019-10-21T21:44:34.127Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
21:44:34 [2019-10-21T21:44:34.127Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
21:44:34 [2019-10-21T21:44:34.127Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
21:44:34 [2019-10-21T21:44:34.127Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
21:44:36 [2019-10-21T21:44:36.772Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
21:44:36 [2019-10-21T21:44:36.772Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
21:44:38 [2019-10-21T21:44:38.153Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
21:44:38 [2019-10-21T21:44:38.153Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
21:44:39 [2019-10-21T21:44:39.527Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
21:44:39 [2019-10-21T21:44:39.973Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
21:44:42 [2019-10-21T21:44:42.139Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
21:44:42 [2019-10-21T21:44:42.540Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
21:44:45 [2019-10-21T21:44:45.066Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
21:44:45 [2019-10-21T21:44:45.451Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
21:44:48 [2019-10-21T21:44:48.197Z] --- PASS: TestDaemonRestartKillContainers (0.00s)
21:44:48 [2019-10-21T21:44:48.197Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon (2.41s)
21:44:48 [2019-10-21T21:44:48.197Z]         restart_test.go:67: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:302: [d0a3a199b5617] waiting for daemon to start
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:334: [d0a3a199b5617] daemon started
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:302: [d0a3a199b5617] waiting for daemon to start
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:286: [d0a3a199b5617] exiting daemon
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:334: [d0a3a199b5617] daemon started
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:286: [d0a3a199b5617] exiting daemon
21:44:48 [2019-10-21T21:44:48.197Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon (2.70s)
21:44:48 [2019-10-21T21:44:48.197Z]         restart_test.go:67: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:302: [d43459733bed9] waiting for daemon to start
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:334: [d43459733bed9] daemon started
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:286: [d43459733bed9] exiting daemon
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:302: [d43459733bed9] waiting for daemon to start
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:334: [d43459733bed9] daemon started
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:286: [d43459733bed9] exiting daemon
21:44:48 [2019-10-21T21:44:48.197Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon (1.60s)
21:44:48 [2019-10-21T21:44:48.197Z]         restart_test.go:67: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:302: [d14e8ec5ea62a] waiting for daemon to start
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:334: [d14e8ec5ea62a] daemon started
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:286: [d14e8ec5ea62a] exiting daemon
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:302: [d14e8ec5ea62a] waiting for daemon to start
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:334: [d14e8ec5ea62a] daemon started
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:286: [d14e8ec5ea62a] exiting daemon
21:44:48 [2019-10-21T21:44:48.197Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon (1.67s)
21:44:48 [2019-10-21T21:44:48.197Z]         restart_test.go:67: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:302: [d09c9a1315484] waiting for daemon to start
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:334: [d09c9a1315484] daemon started
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:302: [d09c9a1315484] waiting for daemon to start
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:286: [d09c9a1315484] exiting daemon
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:334: [d09c9a1315484] daemon started
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:286: [d09c9a1315484] exiting daemon
21:44:48 [2019-10-21T21:44:48.197Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon (1.51s)
21:44:48 [2019-10-21T21:44:48.197Z]         restart_test.go:67: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:302: [d0c134925c09e] waiting for daemon to start
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:334: [d0c134925c09e] daemon started
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:286: [d0c134925c09e] exiting daemon
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:302: [d0c134925c09e] waiting for daemon to start
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:334: [d0c134925c09e] daemon started
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:286: [d0c134925c09e] exiting daemon
21:44:48 [2019-10-21T21:44:48.197Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon (1.54s)
21:44:48 [2019-10-21T21:44:48.197Z]         restart_test.go:67: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:302: [d9ac5fa5158c2] waiting for daemon to start
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:334: [d9ac5fa5158c2] daemon started
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:302: [d9ac5fa5158c2] waiting for daemon to start
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:286: [d9ac5fa5158c2] exiting daemon
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:334: [d9ac5fa5158c2] daemon started
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:286: [d9ac5fa5158c2] exiting daemon
21:44:48 [2019-10-21T21:44:48.197Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon (2.86s)
21:44:48 [2019-10-21T21:44:48.197Z]         restart_test.go:67: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:302: [daa623af77b36] waiting for daemon to start
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:334: [daa623af77b36] daemon started
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:286: [daa623af77b36] exiting daemon
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:302: [daa623af77b36] waiting for daemon to start
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:334: [daa623af77b36] daemon started
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:286: [daa623af77b36] exiting daemon
21:44:48 [2019-10-21T21:44:48.197Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon (2.71s)
21:44:48 [2019-10-21T21:44:48.197Z]         restart_test.go:67: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:302: [d0f1d780558b6] waiting for daemon to start
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:334: [d0f1d780558b6] daemon started
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:286: [d0f1d780558b6] exiting daemon
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:302: [d0f1d780558b6] waiting for daemon to start
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:334: [d0f1d780558b6] daemon started
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:286: [d0f1d780558b6] exiting daemon
21:44:48 [2019-10-21T21:44:48.197Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon (2.25s)
21:44:48 [2019-10-21T21:44:48.197Z]         restart_test.go:67: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:302: [d1951465491e2] waiting for daemon to start
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:334: [d1951465491e2] daemon started
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:286: [d1951465491e2] exiting daemon
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:302: [d1951465491e2] waiting for daemon to start
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:334: [d1951465491e2] daemon started
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:286: [d1951465491e2] exiting daemon
21:44:48 [2019-10-21T21:44:48.197Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon (3.17s)
21:44:48 [2019-10-21T21:44:48.197Z]         restart_test.go:67: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:302: [dde1ba5b024b5] waiting for daemon to start
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:334: [dde1ba5b024b5] daemon started
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:286: [dde1ba5b024b5] exiting daemon
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:302: [dde1ba5b024b5] waiting for daemon to start
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:334: [dde1ba5b024b5] daemon started
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:286: [dde1ba5b024b5] exiting daemon
21:44:48 [2019-10-21T21:44:48.197Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon (2.63s)
21:44:48 [2019-10-21T21:44:48.197Z]         restart_test.go:67: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:302: [dd12ddc13e7d1] waiting for daemon to start
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:334: [dd12ddc13e7d1] daemon started
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:286: [dd12ddc13e7d1] exiting daemon
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:302: [dd12ddc13e7d1] waiting for daemon to start
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:334: [dd12ddc13e7d1] daemon started
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:286: [dd12ddc13e7d1] exiting daemon
21:44:48 [2019-10-21T21:44:48.197Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon (2.56s)
21:44:48 [2019-10-21T21:44:48.197Z]         restart_test.go:67: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:302: [d8dd73947d399] waiting for daemon to start
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:334: [d8dd73947d399] daemon started
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:286: [d8dd73947d399] exiting daemon
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:302: [d8dd73947d399] waiting for daemon to start
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:334: [d8dd73947d399] daemon started
21:44:48 [2019-10-21T21:44:48.197Z]         daemon.go:286: [d8dd73947d399] exiting daemon
21:44:48 [2019-10-21T21:44:48.197Z] === RUN   TestStats
21:44:50 [2019-10-21T21:44:50.676Z] --- PASS: TestStats (2.31s)
21:44:50 [2019-10-21T21:44:50.676Z] === RUN   TestStopContainerWithTimeout
21:44:50 [2019-10-21T21:44:50.676Z] === RUN   TestStopContainerWithTimeout/0
21:44:50 [2019-10-21T21:44:50.676Z] === PAUSE TestStopContainerWithTimeout/0
21:44:50 [2019-10-21T21:44:50.676Z] === RUN   TestStopContainerWithTimeout/1
21:44:50 [2019-10-21T21:44:50.676Z] === PAUSE TestStopContainerWithTimeout/1
21:44:50 [2019-10-21T21:44:50.676Z] === RUN   TestStopContainerWithTimeout/3
21:44:50 [2019-10-21T21:44:50.676Z] === PAUSE TestStopContainerWithTimeout/3
21:44:50 [2019-10-21T21:44:50.676Z] === RUN   TestStopContainerWithTimeout/-1
21:44:50 [2019-10-21T21:44:50.676Z] === PAUSE TestStopContainerWithTimeout/-1
21:44:50 [2019-10-21T21:44:50.676Z] === CONT  TestStopContainerWithTimeout/0
21:44:50 [2019-10-21T21:44:50.676Z] === CONT  TestStopContainerWithTimeout/-1
21:44:51 [2019-10-21T21:44:51.506Z] === CONT  TestStopContainerWithTimeout/3
21:44:53 [2019-10-21T21:44:53.587Z] === CONT  TestStopContainerWithTimeout/1
21:44:55 [2019-10-21T21:44:55.443Z] --- PASS: TestStopContainerWithTimeout (0.01s)
21:44:55 [2019-10-21T21:44:55.443Z]     --- PASS: TestStopContainerWithTimeout/0 (1.08s)
21:44:55 [2019-10-21T21:44:55.443Z]     --- PASS: TestStopContainerWithTimeout/-1 (3.04s)
21:44:55 [2019-10-21T21:44:55.443Z]     --- PASS: TestStopContainerWithTimeout/3 (2.96s)
21:44:55 [2019-10-21T21:44:55.443Z]     --- PASS: TestStopContainerWithTimeout/1 (2.09s)
21:44:55 [2019-10-21T21:44:55.443Z] === RUN   TestDeleteDevicemapper
21:44:55 [2019-10-21T21:44:55.443Z] --- SKIP: TestDeleteDevicemapper (0.00s)
21:44:55 [2019-10-21T21:44:55.443Z]     stop_linux_test.go:74: testEnv.DaemonInfo.Driver != "devicemapper"
21:44:55 [2019-10-21T21:44:55.443Z] === RUN   TestStopContainerWithRestartPolicyAlways
21:44:59 [2019-10-21T21:44:59.698Z] --- PASS: TestStopContainerWithRestartPolicyAlways (3.59s)
21:44:59 [2019-10-21T21:44:59.698Z] === RUN   TestUpdateMemory
21:44:59 [2019-10-21T21:44:59.698Z] --- SKIP: TestUpdateMemory (0.00s)
21:44:59 [2019-10-21T21:44:59.698Z]     update_linux_test.go:21: !testEnv.DaemonInfo.SwapLimit
21:44:59 [2019-10-21T21:44:59.698Z] === RUN   TestUpdateCPUQuota
21:45:00 [2019-10-21T21:45:00.994Z] --- PASS: TestUpdateCPUQuota (1.81s)
21:45:00 [2019-10-21T21:45:00.994Z] === RUN   TestUpdateRestartPolicy
21:45:14 [2019-10-21T21:45:14.867Z] --- PASS: TestUpdateRestartPolicy (13.16s)
21:45:14 [2019-10-21T21:45:14.867Z] === RUN   TestUpdateRestartWithAutoRemove
21:45:14 [2019-10-21T21:45:14.867Z] --- PASS: TestUpdateRestartWithAutoRemove (0.85s)
21:45:14 [2019-10-21T21:45:14.867Z] === CONT  TestContainerStartOnDaemonRestart
21:45:14 [2019-10-21T21:45:14.867Z] === CONT  TestDaemonRestartIpcMode
21:45:19 [2019-10-21T21:45:19.231Z] --- PASS: TestContainerStartOnDaemonRestart (3.70s)
21:45:19 [2019-10-21T21:45:19.231Z]     daemon_linux_test.go:35: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestContainerStartOnDaemonRestart
21:45:19 [2019-10-21T21:45:19.231Z]     daemon.go:302: [d6d8681d0787b] waiting for daemon to start
21:45:19 [2019-10-21T21:45:19.231Z]     daemon.go:334: [d6d8681d0787b] daemon started
21:45:19 [2019-10-21T21:45:19.231Z]     daemon.go:302: [d6d8681d0787b] waiting for daemon to start
21:45:19 [2019-10-21T21:45:19.231Z]     daemon.go:286: [d6d8681d0787b] exiting daemon
21:45:19 [2019-10-21T21:45:19.231Z]     daemon.go:334: [d6d8681d0787b] daemon started
21:45:19 [2019-10-21T21:45:19.231Z]     daemon.go:286: [d6d8681d0787b] exiting daemon
21:45:19 [2019-10-21T21:45:19.231Z] --- PASS: TestDaemonRestartIpcMode (4.36s)
21:45:19 [2019-10-21T21:45:19.231Z]     daemon_linux_test.go:89: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartIpcMode
21:45:19 [2019-10-21T21:45:19.231Z]     daemon.go:302: [dd39c99675f40] waiting for daemon to start
21:45:19 [2019-10-21T21:45:19.231Z]     daemon.go:334: [dd39c99675f40] daemon started
21:45:19 [2019-10-21T21:45:19.231Z]     daemon.go:286: [dd39c99675f40] exiting daemon
21:45:19 [2019-10-21T21:45:19.231Z]     daemon.go:302: [dd39c99675f40] waiting for daemon to start
21:45:19 [2019-10-21T21:45:19.231Z]     daemon.go:334: [dd39c99675f40] daemon started
21:45:19 [2019-10-21T21:45:19.231Z]     daemon.go:286: [dd39c99675f40] exiting daemon
21:45:19 [2019-10-21T21:45:19.231Z] PASS
21:45:19 [2019-10-21T21:45:19.231Z] 
21:45:19 [2019-10-21T21:45:19.231Z] === Skipped
21:45:19 [2019-10-21T21:45:19.231Z] === SKIP: s390x.integration.container TestInspectOomKilledTrue (0.00s)
21:45:19 [2019-10-21T21:45:19.231Z]     kill_test.go:151: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
21:45:19 [2019-10-21T21:45:19.231Z] 
21:45:19 [2019-10-21T21:45:19.231Z] === SKIP: s390x.integration.container TestInspectOomKilledFalse (0.00s)
21:45:19 [2019-10-21T21:45:19.231Z]     kill_test.go:169: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
21:45:19 [2019-10-21T21:45:19.231Z] 
21:45:19 [2019-10-21T21:45:19.231Z] === SKIP: s390x.integration.container TestPauseFailsOnWindowsServerContainers (0.00s)
21:45:19 [2019-10-21T21:45:19.231Z]     pause_test.go:54: testEnv.DaemonInfo.OSType != "windows" || testEnv.DaemonInfo.Isolation != "process"
21:45:19 [2019-10-21T21:45:19.231Z] 
21:45:19 [2019-10-21T21:45:19.231Z] === SKIP: s390x.integration.container TestDeleteDevicemapper (0.00s)
21:45:19 [2019-10-21T21:45:19.231Z]     stop_linux_test.go:74: testEnv.DaemonInfo.Driver != "devicemapper"
21:45:19 [2019-10-21T21:45:19.231Z] 
21:45:19 [2019-10-21T21:45:19.231Z] === SKIP: s390x.integration.container TestUpdateMemory (0.00s)
21:45:19 [2019-10-21T21:45:19.231Z]     update_linux_test.go:21: !testEnv.DaemonInfo.SwapLimit
21:45:19 [2019-10-21T21:45:19.231Z] 
21:45:19 [2019-10-21T21:45:19.231Z] 
21:45:19 [2019-10-21T21:45:19.231Z] DONE 150 tests, 5 skipped in 124.241s
21:45:19 [2019-10-21T21:45:19.231Z] Running /go/src/github.com/docker/docker/integration/image (s390x.integration.image) flags=-test.v -test.timeout=120m  
21:45:19 [2019-10-21T21:45:19.231Z] ++ 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
21:45:19 [2019-10-21T21:45:19.231Z] ++ set -e
21:45:19 [2019-10-21T21:45:19.231Z] ++ '[' -n 0 ']'
21:45:19 [2019-10-21T21:45:19.231Z] ++ set -x
21:45:19 [2019-10-21T21:45:19.231Z] ++ 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
21:45:19 [2019-10-21T21:45:19.231Z] INFO: Testing against a local daemon
21:45:19 [2019-10-21T21:45:19.231Z] === RUN   TestCommitInheritsEnv
21:45:20 [2019-10-21T21:45:20.214Z] --- PASS: TestCommitInheritsEnv (0.50s)
21:45:20 [2019-10-21T21:45:20.214Z] === RUN   TestImportExtremelyLargeImageWorks
21:47:30 [2019-10-21T21:47:30.846Z] --- PASS: TestImportExtremelyLargeImageWorks (120.49s)
21:47:30 [2019-10-21T21:47:30.847Z] === RUN   TestImagesFilterMultiReference
21:47:30 [2019-10-21T21:47:30.847Z] --- PASS: TestImagesFilterMultiReference (0.04s)
21:47:30 [2019-10-21T21:47:30.847Z] === RUN   TestRemoveImageOrphaning
21:47:30 [2019-10-21T21:47:30.847Z] --- PASS: TestRemoveImageOrphaning (0.48s)
21:47:30 [2019-10-21T21:47:30.847Z] === RUN   TestTagUnprefixedRepoByNameOrName
21:47:30 [2019-10-21T21:47:30.847Z] --- PASS: TestTagUnprefixedRepoByNameOrName (0.02s)
21:47:30 [2019-10-21T21:47:30.847Z] === RUN   TestTagInvalidReference
21:47:30 [2019-10-21T21:47:30.847Z] --- PASS: TestTagInvalidReference (0.01s)
21:47:30 [2019-10-21T21:47:30.847Z] === RUN   TestTagValidPrefixedRepo
21:47:30 [2019-10-21T21:47:30.847Z] --- PASS: TestTagValidPrefixedRepo (0.03s)
21:47:30 [2019-10-21T21:47:30.847Z] === RUN   TestTagExistedNameWithoutForce
21:47:30 [2019-10-21T21:47:30.847Z] --- PASS: TestTagExistedNameWithoutForce (0.01s)
21:47:30 [2019-10-21T21:47:30.847Z] === RUN   TestTagOfficialNames
21:47:30 [2019-10-21T21:47:30.847Z] --- PASS: TestTagOfficialNames (0.05s)
21:47:30 [2019-10-21T21:47:30.847Z] === RUN   TestTagMatchesDigest
21:47:30 [2019-10-21T21:47:30.847Z] --- PASS: TestTagMatchesDigest (0.01s)
21:47:30 [2019-10-21T21:47:30.847Z] PASS
21:47:30 [2019-10-21T21:47:30.847Z] 
21:47:30 [2019-10-21T21:47:30.847Z] DONE 10 tests in 121.753s
21:47:30 [2019-10-21T21:47:30.847Z] Running /go/src/github.com/docker/docker/integration/network (s390x.integration.network) flags=-test.v -test.timeout=120m  
21:47:30 [2019-10-21T21:47:30.847Z] ++ 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
21:47:30 [2019-10-21T21:47:30.847Z] ++ set -e
21:47:30 [2019-10-21T21:47:30.847Z] ++ '[' -n 0 ']'
21:47:30 [2019-10-21T21:47:30.847Z] ++ set -x
21:47:30 [2019-10-21T21:47:30.847Z] ++ 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
21:47:30 [2019-10-21T21:47:30.847Z] INFO: Testing against a local daemon
21:47:30 [2019-10-21T21:47:30.847Z] === RUN   TestNetworkCreateDelete
21:47:30 [2019-10-21T21:47:30.847Z] --- PASS: TestNetworkCreateDelete (0.20s)
21:47:30 [2019-10-21T21:47:30.847Z] === RUN   TestDockerNetworkDeletePreferID
21:47:30 [2019-10-21T21:47:30.847Z] --- PASS: TestDockerNetworkDeletePreferID (0.71s)
21:47:30 [2019-10-21T21:47:30.847Z] === RUN   TestInspectNetwork
21:47:30 [2019-10-21T21:47:30.847Z] === RUN   TestInspectNetwork/full_network_id
21:47:30 [2019-10-21T21:47:30.847Z] === RUN   TestInspectNetwork/partial_network_id
21:47:30 [2019-10-21T21:47:30.847Z] === RUN   TestInspectNetwork/network_name
21:47:30 [2019-10-21T21:47:30.847Z] === RUN   TestInspectNetwork/network_name_and_swarm_scope
21:47:33 [2019-10-21T21:47:33.377Z] --- PASS: TestInspectNetwork (11.04s)
21:47:33 [2019-10-21T21:47:33.378Z]     inspect_test.go:18: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestInspectNetwork
21:47:33 [2019-10-21T21:47:33.378Z]     daemon.go:302: [d6be5d93dcf62] waiting for daemon to start
21:47:33 [2019-10-21T21:47:33.378Z]     daemon.go:334: [d6be5d93dcf62] daemon started
21:47:33 [2019-10-21T21:47:33.378Z]     --- PASS: TestInspectNetwork/full_network_id (0.00s)
21:47:33 [2019-10-21T21:47:33.378Z]     --- PASS: TestInspectNetwork/partial_network_id (0.00s)
21:47:33 [2019-10-21T21:47:33.378Z]     --- PASS: TestInspectNetwork/network_name (0.00s)
21:47:33 [2019-10-21T21:47:33.378Z]     --- PASS: TestInspectNetwork/network_name_and_swarm_scope (0.00s)
21:47:33 [2019-10-21T21:47:33.378Z]     daemon.go:286: [d6be5d93dcf62] exiting daemon
21:47:33 [2019-10-21T21:47:33.378Z] === RUN   TestRunContainerWithBridgeNone
21:47:36 [2019-10-21T21:47:36.732Z] --- PASS: TestRunContainerWithBridgeNone (3.33s)
21:47:36 [2019-10-21T21:47:36.732Z]     network_test.go:25: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestRunContainerWithBridgeNone
21:47:36 [2019-10-21T21:47:36.732Z]     daemon.go:302: [d673c66b242d2] waiting for daemon to start
21:47:36 [2019-10-21T21:47:36.732Z]     daemon.go:334: [d673c66b242d2] daemon started
21:47:36 [2019-10-21T21:47:36.732Z]     daemon.go:286: [d673c66b242d2] exiting daemon
21:47:36 [2019-10-21T21:47:36.732Z] === RUN   TestNetworkInvalidJSON
21:47:36 [2019-10-21T21:47:36.732Z] === RUN   TestNetworkInvalidJSON//networks/create
21:47:36 [2019-10-21T21:47:36.732Z] === PAUSE TestNetworkInvalidJSON//networks/create
21:47:36 [2019-10-21T21:47:36.732Z] === RUN   TestNetworkInvalidJSON//networks/bridge/connect
21:47:36 [2019-10-21T21:47:36.732Z] === PAUSE TestNetworkInvalidJSON//networks/bridge/connect
21:47:36 [2019-10-21T21:47:36.732Z] === RUN   TestNetworkInvalidJSON//networks/bridge/disconnect
21:47:36 [2019-10-21T21:47:36.732Z] === PAUSE TestNetworkInvalidJSON//networks/bridge/disconnect
21:47:36 [2019-10-21T21:47:36.732Z] === CONT  TestNetworkInvalidJSON//networks/create
21:47:36 [2019-10-21T21:47:36.732Z] === CONT  TestNetworkInvalidJSON//networks/bridge/disconnect
21:47:36 [2019-10-21T21:47:36.732Z] === CONT  TestNetworkInvalidJSON//networks/bridge/connect
21:47:36 [2019-10-21T21:47:36.732Z] --- PASS: TestNetworkInvalidJSON (0.01s)
21:47:36 [2019-10-21T21:47:36.732Z]     --- PASS: TestNetworkInvalidJSON//networks/bridge/disconnect (0.00s)
21:47:36 [2019-10-21T21:47:36.732Z]     --- PASS: TestNetworkInvalidJSON//networks/bridge/connect (0.00s)
21:47:36 [2019-10-21T21:47:36.732Z]     --- PASS: TestNetworkInvalidJSON//networks/create (0.00s)
21:47:36 [2019-10-21T21:47:36.732Z] === RUN   TestDaemonRestartWithLiveRestore
21:47:37 [2019-10-21T21:47:37.724Z] --- PASS: TestDaemonRestartWithLiveRestore (1.06s)
21:47:37 [2019-10-21T21:47:37.724Z]     service_test.go:32: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartWithLiveRestore
21:47:37 [2019-10-21T21:47:37.724Z]     daemon.go:302: [d5ceb108c86c6] waiting for daemon to start
21:47:37 [2019-10-21T21:47:37.724Z]     daemon.go:334: [d5ceb108c86c6] daemon started
21:47:37 [2019-10-21T21:47:37.724Z]     daemon.go:286: [d5ceb108c86c6] exiting daemon
21:47:37 [2019-10-21T21:47:37.724Z]     daemon.go:302: [d5ceb108c86c6] waiting for daemon to start
21:47:37 [2019-10-21T21:47:37.724Z]     daemon.go:334: [d5ceb108c86c6] daemon started
21:47:37 [2019-10-21T21:47:37.724Z]     daemon.go:286: [d5ceb108c86c6] exiting daemon
21:47:37 [2019-10-21T21:47:37.725Z] === RUN   TestDaemonDefaultNetworkPools
21:47:38 [2019-10-21T21:47:38.548Z] --- PASS: TestDaemonDefaultNetworkPools (0.89s)
21:47:38 [2019-10-21T21:47:38.548Z]     service_test.go:57: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDaemonDefaultNetworkPools
21:47:38 [2019-10-21T21:47:38.548Z]     daemon.go:302: [d5b01fa2ca9e0] waiting for daemon to start
21:47:38 [2019-10-21T21:47:38.548Z]     daemon.go:334: [d5b01fa2ca9e0] daemon started
21:47:38 [2019-10-21T21:47:38.548Z]     daemon.go:286: [d5b01fa2ca9e0] exiting daemon
21:47:38 [2019-10-21T21:47:38.548Z] === RUN   TestDaemonRestartWithExistingNetwork
21:47:39 [2019-10-21T21:47:39.854Z] --- PASS: TestDaemonRestartWithExistingNetwork (1.50s)
21:47:39 [2019-10-21T21:47:39.854Z]     service_test.go:98: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartWithExistingNetwork
21:47:39 [2019-10-21T21:47:39.854Z]     daemon.go:302: [da13174fd5082] waiting for daemon to start
21:47:39 [2019-10-21T21:47:39.854Z]     daemon.go:334: [da13174fd5082] daemon started
21:47:39 [2019-10-21T21:47:39.854Z]     daemon.go:286: [da13174fd5082] exiting daemon
21:47:39 [2019-10-21T21:47:39.854Z]     daemon.go:302: [da13174fd5082] waiting for daemon to start
21:47:39 [2019-10-21T21:47:39.854Z]     daemon.go:334: [da13174fd5082] daemon started
21:47:39 [2019-10-21T21:47:39.854Z]     daemon.go:286: [da13174fd5082] exiting daemon
21:47:39 [2019-10-21T21:47:39.854Z] === RUN   TestDaemonRestartWithExistingNetworkWithDefaultPoolRange
21:47:41 [2019-10-21T21:47:41.730Z] --- PASS: TestDaemonRestartWithExistingNetworkWithDefaultPoolRange (1.64s)
21:47:41 [2019-10-21T21:47:41.730Z]     service_test.go:131: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartWithExistingNetworkWithDefaultPoolRange
21:47:41 [2019-10-21T21:47:41.730Z]     daemon.go:302: [dad9b9a3b784c] waiting for daemon to start
21:47:41 [2019-10-21T21:47:41.730Z]     daemon.go:334: [dad9b9a3b784c] daemon started
21:47:41 [2019-10-21T21:47:41.730Z]     daemon.go:286: [dad9b9a3b784c] exiting daemon
21:47:41 [2019-10-21T21:47:41.730Z]     daemon.go:302: [dad9b9a3b784c] waiting for daemon to start
21:47:41 [2019-10-21T21:47:41.730Z]     daemon.go:334: [dad9b9a3b784c] daemon started
21:47:41 [2019-10-21T21:47:41.730Z]     daemon.go:286: [dad9b9a3b784c] exiting daemon
21:47:41 [2019-10-21T21:47:41.730Z] === RUN   TestDaemonWithBipAndDefaultNetworkPool
21:47:42 [2019-10-21T21:47:42.231Z] --- PASS: TestDaemonWithBipAndDefaultNetworkPool (0.60s)
21:47:42 [2019-10-21T21:47:42.231Z]     service_test.go:181: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDaemonWithBipAndDefaultNetworkPool
21:47:42 [2019-10-21T21:47:42.231Z]     daemon.go:302: [d3b2da0e4dc6c] waiting for daemon to start
21:47:42 [2019-10-21T21:47:42.231Z]     daemon.go:334: [d3b2da0e4dc6c] daemon started
21:47:42 [2019-10-21T21:47:42.231Z]     daemon.go:286: [d3b2da0e4dc6c] exiting daemon
21:47:42 [2019-10-21T21:47:42.231Z] === RUN   TestServiceWithPredefinedNetwork
21:47:46 [2019-10-21T21:47:46.467Z] --- PASS: TestServiceWithPredefinedNetwork (3.84s)
21:47:46 [2019-10-21T21:47:46.467Z]     service_test.go:203: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithPredefinedNetwork
21:47:46 [2019-10-21T21:47:46.467Z]     daemon.go:302: [d48d27352135b] waiting for daemon to start
21:47:46 [2019-10-21T21:47:46.467Z]     daemon.go:334: [d48d27352135b] daemon started
21:47:46 [2019-10-21T21:47:46.467Z]     daemon.go:286: [d48d27352135b] exiting daemon
21:47:46 [2019-10-21T21:47:46.467Z] === RUN   TestServiceRemoveKeepsIngressNetwork
21:47:46 [2019-10-21T21:47:46.467Z] --- SKIP: TestServiceRemoveKeepsIngressNetwork (0.00s)
21:47:46 [2019-10-21T21:47:46.467Z]     service_test.go:230: FLAKY_TEST
21:47:46 [2019-10-21T21:47:46.467Z] === RUN   TestServiceWithDefaultAddressPoolInit
21:47:53 [2019-10-21T21:47:53.002Z] --- PASS: TestServiceWithDefaultAddressPoolInit (6.56s)
21:47:53 [2019-10-21T21:47:53.002Z]     service_test.go:339: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithDefaultAddressPoolInit
21:47:53 [2019-10-21T21:47:53.002Z]     daemon.go:302: [d8b99e59bd1f8] waiting for daemon to start
21:47:53 [2019-10-21T21:47:53.002Z]     daemon.go:334: [d8b99e59bd1f8] daemon started
21:47:53 [2019-10-21T21:47:53.002Z]     service_test.go:364: TestServiceWithDefaultAddressPoolInit: NetworkInspect: {Name:saanvisthiraTestServiceWithDefaultAddressPoolInit ID:q7y13h6d84rskyqfqczhzscvp Created:2019-10-21 21:47:47.326937652 +0000 UTC Scope:swarm Driver:overlay EnableIPv6:false IPAM:{Driver:default Options:map[] Config:[{Subnet:20.20.0.0/24 IPRange: Gateway:20.20.0.1 AuxAddress:map[]}]} Internal:false Attachable:false Ingress:false ConfigFrom:{Network:} ConfigOnly:false Containers:map[] Options:map[com.docker.network.driver.overlay.vxlanid_list:4097] Labels:map[] Peers:[] Services:map[]}
21:47:53 [2019-10-21T21:47:53.002Z]     daemon.go:286: [d8b99e59bd1f8] exiting daemon
21:47:53 [2019-10-21T21:47:53.002Z]     service_test.go:377: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithDefaultAddressPoolInit
21:47:53 [2019-10-21T21:47:53.002Z]     daemon.go:302: [de9724d3c109d] waiting for daemon to start
21:47:53 [2019-10-21T21:47:53.002Z]     daemon.go:334: [de9724d3c109d] daemon started
21:47:53 [2019-10-21T21:47:53.002Z]     daemon.go:286: [de9724d3c109d] exiting daemon
21:47:53 [2019-10-21T21:47:53.002Z] PASS
21:47:53 [2019-10-21T21:47:53.002Z] 
21:47:53 [2019-10-21T21:47:53.002Z] === Skipped
21:47:53 [2019-10-21T21:47:53.002Z] === SKIP: s390x.integration.network TestServiceRemoveKeepsIngressNetwork (0.00s)
21:47:53 [2019-10-21T21:47:53.002Z]     service_test.go:230: FLAKY_TEST
21:47:53 [2019-10-21T21:47:53.002Z] 
21:47:53 [2019-10-21T21:47:53.002Z] 
21:47:53 [2019-10-21T21:47:53.002Z] DONE 20 tests, 1 skipped in 31.488s
21:47:53 [2019-10-21T21:47:53.002Z] Running /go/src/github.com/docker/docker/integration/network/ipvlan (s390x.integration.network.ipvlan) flags=-test.v -test.timeout=120m  
21:47:53 [2019-10-21T21:47:53.002Z] ++ 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
21:47:53 [2019-10-21T21:47:53.002Z] ++ set -e
21:47:53 [2019-10-21T21:47:53.002Z] ++ '[' -n 0 ']'
21:47:53 [2019-10-21T21:47:53.002Z] ++ set -x
21:47:53 [2019-10-21T21:47:53.002Z] ++ 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
21:47:53 [2019-10-21T21:47:53.002Z] INFO: Testing against a local daemon
21:47:53 [2019-10-21T21:47:53.002Z] === RUN   TestDockerNetworkIpvlanPersistance
21:47:53 [2019-10-21T21:47:53.002Z] --- SKIP: TestDockerNetworkIpvlanPersistance (0.00s)
21:47:53 [2019-10-21T21:47:53.002Z]     ipvlan_test.go:27: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
21:47:53 [2019-10-21T21:47:53.002Z] === RUN   TestDockerNetworkIpvlan
21:47:53 [2019-10-21T21:47:53.002Z] --- SKIP: TestDockerNetworkIpvlan (0.00s)
21:47:53 [2019-10-21T21:47:53.002Z]     ipvlan_test.go:55: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
21:47:53 [2019-10-21T21:47:53.002Z] PASS
21:47:53 [2019-10-21T21:47:53.002Z] 
21:47:53 [2019-10-21T21:47:53.002Z] === Skipped
21:47:53 [2019-10-21T21:47:53.002Z] === SKIP: s390x.integration.network.ipvlan TestDockerNetworkIpvlanPersistance (0.00s)
21:47:53 [2019-10-21T21:47:53.002Z]     ipvlan_test.go:27: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
21:47:53 [2019-10-21T21:47:53.002Z] 
21:47:53 [2019-10-21T21:47:53.002Z] === SKIP: s390x.integration.network.ipvlan TestDockerNetworkIpvlan (0.00s)
21:47:53 [2019-10-21T21:47:53.002Z]     ipvlan_test.go:55: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
21:47:53 [2019-10-21T21:47:53.002Z] 
21:47:53 [2019-10-21T21:47:53.002Z] 
21:47:53 [2019-10-21T21:47:53.002Z] DONE 2 tests, 2 skipped in 0.109s
21:47:53 [2019-10-21T21:47:53.002Z] Running /go/src/github.com/docker/docker/integration/network/macvlan (s390x.integration.network.macvlan) flags=-test.v -test.timeout=120m  
21:47:53 [2019-10-21T21:47:53.002Z] ++ 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
21:47:53 [2019-10-21T21:47:53.002Z] ++ set -e
21:47:53 [2019-10-21T21:47:53.002Z] ++ '[' -n 0 ']'
21:47:53 [2019-10-21T21:47:53.002Z] ++ set -x
21:47:53 [2019-10-21T21:47:53.002Z] ++ 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
21:47:53 [2019-10-21T21:47:53.002Z] INFO: Testing against a local daemon
21:47:53 [2019-10-21T21:47:53.002Z] === RUN   TestDockerNetworkMacvlanPersistance
21:47:54 [2019-10-21T21:47:54.309Z] --- PASS: TestDockerNetworkMacvlanPersistance (1.55s)
21:47:54 [2019-10-21T21:47:54.309Z]     macvlan_test.go:25: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlanPersistance
21:47:54 [2019-10-21T21:47:54.309Z]     daemon.go:302: [d38f54770e5ef] waiting for daemon to start
21:47:54 [2019-10-21T21:47:54.309Z]     daemon.go:334: [d38f54770e5ef] daemon started
21:47:54 [2019-10-21T21:47:54.309Z]     daemon.go:286: [d38f54770e5ef] exiting daemon
21:47:54 [2019-10-21T21:47:54.309Z]     daemon.go:302: [d38f54770e5ef] waiting for daemon to start
21:47:54 [2019-10-21T21:47:54.309Z]     daemon.go:334: [d38f54770e5ef] daemon started
21:47:54 [2019-10-21T21:47:54.309Z]     daemon.go:286: [d38f54770e5ef] exiting daemon
21:47:54 [2019-10-21T21:47:54.309Z] === RUN   TestDockerNetworkMacvlan
21:47:55 [2019-10-21T21:47:55.131Z] === RUN   TestDockerNetworkMacvlan/Subinterface
21:47:56 [2019-10-21T21:47:56.996Z] === RUN   TestDockerNetworkMacvlan/OverlapParent
21:47:57 [2019-10-21T21:47:57.942Z] === RUN   TestDockerNetworkMacvlan/NilParent
21:48:01 [2019-10-21T21:48:01.248Z] === RUN   TestDockerNetworkMacvlan/InternalMode
21:48:05 [2019-10-21T21:48:05.494Z] === RUN   TestDockerNetworkMacvlan/Addressing
21:48:22 [2019-10-21T21:48:22.024Z] --- PASS: TestDockerNetworkMacvlan (27.62s)
21:48:22 [2019-10-21T21:48:22.024Z]     macvlan_test.go:69: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan
21:48:22 [2019-10-21T21:48:22.024Z]     daemon.go:302: [df199f32f159f] waiting for daemon to start
21:48:22 [2019-10-21T21:48:22.024Z]     daemon.go:334: [df199f32f159f] daemon started
21:48:22 [2019-10-21T21:48:22.024Z]     --- PASS: TestDockerNetworkMacvlan/Subinterface (0.31s)
21:48:22 [2019-10-21T21:48:22.024Z]     daemon.go:286: [df199f32f159f] exiting daemon
21:48:22 [2019-10-21T21:48:22.024Z]     macvlan_test.go:69: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan
21:48:22 [2019-10-21T21:48:22.024Z]     daemon.go:302: [d2f27d77718ef] waiting for daemon to start
21:48:22 [2019-10-21T21:48:22.024Z]     daemon.go:334: [d2f27d77718ef] daemon started
21:48:22 [2019-10-21T21:48:22.024Z]     --- PASS: TestDockerNetworkMacvlan/OverlapParent (0.13s)
21:48:22 [2019-10-21T21:48:22.024Z]     daemon.go:286: [d2f27d77718ef] exiting daemon
21:48:22 [2019-10-21T21:48:22.024Z]     macvlan_test.go:69: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan
21:48:22 [2019-10-21T21:48:22.024Z]     daemon.go:302: [d0bcb39b9ec02] waiting for daemon to start
21:48:22 [2019-10-21T21:48:22.024Z]     daemon.go:334: [d0bcb39b9ec02] daemon started
21:48:22 [2019-10-21T21:48:22.024Z]     --- PASS: TestDockerNetworkMacvlan/NilParent (1.59s)
21:48:22 [2019-10-21T21:48:22.024Z]     daemon.go:286: [d0bcb39b9ec02] exiting daemon
21:48:22 [2019-10-21T21:48:22.024Z]     macvlan_test.go:69: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan
21:48:22 [2019-10-21T21:48:22.024Z]     daemon.go:302: [d4e522b556501] waiting for daemon to start
21:48:22 [2019-10-21T21:48:22.024Z]     daemon.go:334: [d4e522b556501] daemon started
21:48:22 [2019-10-21T21:48:22.024Z]     --- PASS: TestDockerNetworkMacvlan/InternalMode (2.41s)
21:48:22 [2019-10-21T21:48:22.024Z]     daemon.go:286: [d4e522b556501] exiting daemon
21:48:22 [2019-10-21T21:48:22.024Z]     macvlan_test.go:69: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan
21:48:22 [2019-10-21T21:48:22.024Z]     daemon.go:302: [d2dc231f942e0] waiting for daemon to start
21:48:22 [2019-10-21T21:48:22.024Z]     daemon.go:334: [d2dc231f942e0] daemon started
21:48:22 [2019-10-21T21:48:22.024Z]     --- PASS: TestDockerNetworkMacvlan/Addressing (16.64s)
21:48:22 [2019-10-21T21:48:22.024Z]     daemon.go:286: [d2dc231f942e0] exiting daemon
21:48:22 [2019-10-21T21:48:22.024Z] PASS
21:48:22 [2019-10-21T21:48:22.024Z] 
21:48:22 [2019-10-21T21:48:22.024Z] DONE 7 tests in 29.266s
21:48:22 [2019-10-21T21:48:22.024Z] Running /go/src/github.com/docker/docker/integration/plugin (s390x.integration.plugin) flags=-test.v -test.timeout=120m  
21:48:22 [2019-10-21T21:48:22.024Z] ++ 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
21:48:22 [2019-10-21T21:48:22.024Z] ++ set -e
21:48:22 [2019-10-21T21:48:22.024Z] ++ '[' -n 0 ']'
21:48:22 [2019-10-21T21:48:22.024Z] ++ set -x
21:48:22 [2019-10-21T21:48:22.024Z] ++ 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
21:48:22 [2019-10-21T21:48:22.024Z] testing: warning: no tests to run
21:48:22 [2019-10-21T21:48:22.024Z] PASS
21:48:22 [2019-10-21T21:48:22.024Z] 
21:48:22 [2019-10-21T21:48:22.024Z] DONE 0 tests in 0.070s
21:48:22 [2019-10-21T21:48:22.024Z] Running /go/src/github.com/docker/docker/integration/plugin/authz (s390x.integration.plugin.authz) flags=-test.v -test.timeout=120m  
21:48:22 [2019-10-21T21:48:22.024Z] ++ 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
21:48:22 [2019-10-21T21:48:22.024Z] ++ set -e
21:48:22 [2019-10-21T21:48:22.024Z] ++ '[' -n 0 ']'
21:48:22 [2019-10-21T21:48:22.024Z] ++ set -x
21:48:22 [2019-10-21T21:48:22.024Z] ++ 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
21:48:22 [2019-10-21T21:48:22.421Z] INFO: Testing against a local daemon
21:48:22 [2019-10-21T21:48:22.421Z] === RUN   TestAuthZPluginAllowRequest
21:48:24 [2019-10-21T21:48:24.409Z] --- PASS: TestAuthZPluginAllowRequest (2.01s)
21:48:24 [2019-10-21T21:48:24.409Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginAllowRequest
21:48:24 [2019-10-21T21:48:24.409Z]     daemon.go:302: [d416bd63d5784] waiting for daemon to start
21:48:24 [2019-10-21T21:48:24.409Z]     daemon.go:334: [d416bd63d5784] daemon started
21:48:24 [2019-10-21T21:48:24.409Z]     daemon.go:286: [d416bd63d5784] exiting daemon
21:48:24 [2019-10-21T21:48:24.409Z] === RUN   TestAuthZPluginTLS
21:48:25 [2019-10-21T21:48:25.260Z] --- PASS: TestAuthZPluginTLS (0.84s)
21:48:25 [2019-10-21T21:48:25.260Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginTLS
21:48:25 [2019-10-21T21:48:25.260Z]     daemon.go:302: [df32fe23a616a] waiting for daemon to start
21:48:25 [2019-10-21T21:48:25.260Z]     daemon.go:334: [df32fe23a616a] daemon started
21:48:25 [2019-10-21T21:48:25.260Z]     daemon.go:286: [df32fe23a616a] exiting daemon
21:48:25 [2019-10-21T21:48:25.260Z] === RUN   TestAuthZPluginDenyRequest
21:48:26 [2019-10-21T21:48:26.127Z] --- PASS: TestAuthZPluginDenyRequest (0.80s)
21:48:26 [2019-10-21T21:48:26.127Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginDenyRequest
21:48:26 [2019-10-21T21:48:26.127Z]     daemon.go:302: [d4f809b56baf8] waiting for daemon to start
21:48:26 [2019-10-21T21:48:26.127Z]     daemon.go:334: [d4f809b56baf8] daemon started
21:48:26 [2019-10-21T21:48:26.127Z]     daemon.go:286: [d4f809b56baf8] exiting daemon
21:48:26 [2019-10-21T21:48:26.127Z] === RUN   TestAuthZPluginAPIDenyResponse
21:48:27 [2019-10-21T21:48:27.044Z] --- PASS: TestAuthZPluginAPIDenyResponse (1.06s)
21:48:27 [2019-10-21T21:48:27.044Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginAPIDenyResponse
21:48:27 [2019-10-21T21:48:27.044Z]     daemon.go:302: [d7de0031c52cb] waiting for daemon to start
21:48:27 [2019-10-21T21:48:27.044Z]     daemon.go:334: [d7de0031c52cb] daemon started
21:48:27 [2019-10-21T21:48:27.044Z]     daemon.go:286: [d7de0031c52cb] exiting daemon
21:48:27 [2019-10-21T21:48:27.044Z] === RUN   TestAuthZPluginDenyResponse
21:48:27 [2019-10-21T21:48:27.464Z] --- PASS: TestAuthZPluginDenyResponse (0.65s)
21:48:27 [2019-10-21T21:48:27.464Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginDenyResponse
21:48:27 [2019-10-21T21:48:27.464Z]     daemon.go:302: [d81898e33966a] waiting for daemon to start
21:48:27 [2019-10-21T21:48:27.464Z]     daemon.go:334: [d81898e33966a] daemon started
21:48:27 [2019-10-21T21:48:27.464Z]     daemon.go:286: [d81898e33966a] exiting daemon
21:48:27 [2019-10-21T21:48:27.464Z] === RUN   TestAuthZPluginAllowEventStream
21:48:29 [2019-10-21T21:48:29.446Z] --- PASS: TestAuthZPluginAllowEventStream (1.97s)
21:48:29 [2019-10-21T21:48:29.446Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginAllowEventStream
21:48:29 [2019-10-21T21:48:29.446Z]     daemon.go:302: [d2d493ab6fd61] waiting for daemon to start
21:48:29 [2019-10-21T21:48:29.446Z]     daemon.go:334: [d2d493ab6fd61] daemon started
21:48:29 [2019-10-21T21:48:29.446Z]     daemon.go:286: [d2d493ab6fd61] exiting daemon
21:48:29 [2019-10-21T21:48:29.446Z] === RUN   TestAuthZPluginErrorResponse
21:48:30 [2019-10-21T21:48:30.300Z] --- PASS: TestAuthZPluginErrorResponse (0.65s)
21:48:30 [2019-10-21T21:48:30.300Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginErrorResponse
21:48:30 [2019-10-21T21:48:30.300Z]     daemon.go:302: [de7bc8cc5adfd] waiting for daemon to start
21:48:30 [2019-10-21T21:48:30.300Z]     daemon.go:334: [de7bc8cc5adfd] daemon started
21:48:30 [2019-10-21T21:48:30.300Z]     daemon.go:286: [de7bc8cc5adfd] exiting daemon
21:48:30 [2019-10-21T21:48:30.300Z] === RUN   TestAuthZPluginErrorRequest
21:48:30 [2019-10-21T21:48:30.718Z] --- PASS: TestAuthZPluginErrorRequest (0.57s)
21:48:30 [2019-10-21T21:48:30.718Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginErrorRequest
21:48:30 [2019-10-21T21:48:30.718Z]     daemon.go:302: [dfd48a3f2458e] waiting for daemon to start
21:48:30 [2019-10-21T21:48:30.718Z]     daemon.go:334: [dfd48a3f2458e] daemon started
21:48:30 [2019-10-21T21:48:30.718Z]     daemon.go:286: [dfd48a3f2458e] exiting daemon
21:48:30 [2019-10-21T21:48:30.718Z] === RUN   TestAuthZPluginEnsureNoDuplicatePluginRegistration
21:48:31 [2019-10-21T21:48:31.559Z] --- PASS: TestAuthZPluginEnsureNoDuplicatePluginRegistration (0.89s)
21:48:31 [2019-10-21T21:48:31.559Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginEnsureNoDuplicatePluginRegistration
21:48:31 [2019-10-21T21:48:31.559Z]     daemon.go:302: [d07be836a4cf8] waiting for daemon to start
21:48:31 [2019-10-21T21:48:31.559Z]     daemon.go:334: [d07be836a4cf8] daemon started
21:48:31 [2019-10-21T21:48:31.559Z]     daemon.go:286: [d07be836a4cf8] exiting daemon
21:48:31 [2019-10-21T21:48:31.559Z] === RUN   TestAuthZPluginEnsureLoadImportWorking
21:48:34 [2019-10-21T21:48:34.431Z] --- PASS: TestAuthZPluginEnsureLoadImportWorking (2.71s)
21:48:34 [2019-10-21T21:48:34.431Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginEnsureLoadImportWorking
21:48:34 [2019-10-21T21:48:34.431Z]     daemon.go:302: [d3bd987221f34] waiting for daemon to start
21:48:34 [2019-10-21T21:48:34.431Z]     daemon.go:334: [d3bd987221f34] daemon started
21:48:34 [2019-10-21T21:48:34.431Z]     daemon.go:286: [d3bd987221f34] exiting daemon
21:48:34 [2019-10-21T21:48:34.431Z] === RUN   TestAuthzPluginEnsureContainerCopyToFrom
21:48:37 [2019-10-21T21:48:37.847Z] --- PASS: TestAuthzPluginEnsureContainerCopyToFrom (2.95s)
21:48:37 [2019-10-21T21:48:37.847Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestAuthzPluginEnsureContainerCopyToFrom
21:48:37 [2019-10-21T21:48:37.847Z]     daemon.go:302: [dba90c742137e] waiting for daemon to start
21:48:37 [2019-10-21T21:48:37.847Z]     daemon.go:334: [dba90c742137e] daemon started
21:48:37 [2019-10-21T21:48:37.847Z]     daemon.go:286: [dba90c742137e] exiting daemon
21:48:37 [2019-10-21T21:48:37.847Z] === RUN   TestAuthZPluginHeader
21:48:38 [2019-10-21T21:48:38.245Z] --- PASS: TestAuthZPluginHeader (0.93s)
21:48:38 [2019-10-21T21:48:38.245Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginHeader
21:48:38 [2019-10-21T21:48:38.245Z]     daemon.go:302: [d18d364b98676] waiting for daemon to start
21:48:38 [2019-10-21T21:48:38.245Z]     daemon.go:334: [d18d364b98676] daemon started
21:48:38 [2019-10-21T21:48:38.245Z]     daemon.go:286: [d18d364b98676] exiting daemon
21:48:38 [2019-10-21T21:48:38.245Z] === RUN   TestAuthZPluginV2AllowNonVolumeRequest
21:48:38 [2019-10-21T21:48:38.245Z] --- SKIP: TestAuthZPluginV2AllowNonVolumeRequest (0.01s)
21:48:38 [2019-10-21T21:48:38.245Z]     authz_plugin_v2_test.go:43: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
21:48:38 [2019-10-21T21:48:38.245Z] === RUN   TestAuthZPluginV2Disable
21:48:38 [2019-10-21T21:48:38.245Z] --- SKIP: TestAuthZPluginV2Disable (0.00s)
21:48:38 [2019-10-21T21:48:38.245Z]     authz_plugin_v2_test.go:65: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
21:48:38 [2019-10-21T21:48:38.245Z] === RUN   TestAuthZPluginV2RejectVolumeRequests
21:48:38 [2019-10-21T21:48:38.245Z] --- SKIP: TestAuthZPluginV2RejectVolumeRequests (0.00s)
21:48:38 [2019-10-21T21:48:38.245Z]     authz_plugin_v2_test.go:91: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
21:48:38 [2019-10-21T21:48:38.245Z] === RUN   TestAuthZPluginV2BadManifestFailsDaemonStart
21:48:38 [2019-10-21T21:48:38.245Z] --- SKIP: TestAuthZPluginV2BadManifestFailsDaemonStart (0.00s)
21:48:38 [2019-10-21T21:48:38.245Z]     authz_plugin_v2_test.go:126: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
21:48:38 [2019-10-21T21:48:38.245Z] === RUN   TestAuthZPluginV2NonexistentFailsDaemonStart
21:48:55 [2019-10-21T21:48:55.315Z] --- PASS: TestAuthZPluginV2NonexistentFailsDaemonStart (16.90s)
21:48:55 [2019-10-21T21:48:55.315Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginV2NonexistentFailsDaemonStart
21:48:55 [2019-10-21T21:48:55.315Z]     daemon.go:302: [daf8a174b13b4] waiting for daemon to start
21:48:55 [2019-10-21T21:48:55.315Z]     daemon.go:334: [daf8a174b13b4] daemon started
21:48:55 [2019-10-21T21:48:55.315Z]     daemon.go:286: [daf8a174b13b4] exiting daemon
21:48:55 [2019-10-21T21:48:55.315Z]     daemon.go:302: [daf8a174b13b4] waiting for daemon to start
21:48:55 [2019-10-21T21:48:55.315Z]     daemon.go:302: [daf8a174b13b4] waiting for daemon to start
21:48:55 [2019-10-21T21:48:55.315Z]     daemon.go:286: [daf8a174b13b4] exiting daemon
21:48:55 [2019-10-21T21:48:55.315Z]     daemon.go:302: [daf8a174b13b4] waiting for daemon to start
21:48:55 [2019-10-21T21:48:55.315Z]     daemon.go:334: [daf8a174b13b4] daemon started
21:48:55 [2019-10-21T21:48:55.315Z]     daemon.go:286: [daf8a174b13b4] exiting daemon
21:48:55 [2019-10-21T21:48:55.315Z] PASS
21:48:55 [2019-10-21T21:48:55.315Z] 
21:48:55 [2019-10-21T21:48:55.315Z] === Skipped
21:48:55 [2019-10-21T21:48:55.315Z] === SKIP: s390x.integration.plugin.authz TestAuthZPluginV2AllowNonVolumeRequest (0.01s)
21:48:55 [2019-10-21T21:48:55.315Z]     authz_plugin_v2_test.go:43: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
21:48:55 [2019-10-21T21:48:55.315Z] 
21:48:55 [2019-10-21T21:48:55.315Z] === SKIP: s390x.integration.plugin.authz TestAuthZPluginV2Disable (0.00s)
21:48:55 [2019-10-21T21:48:55.315Z]     authz_plugin_v2_test.go:65: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
21:48:55 [2019-10-21T21:48:55.315Z] 
21:48:55 [2019-10-21T21:48:55.315Z] === SKIP: s390x.integration.plugin.authz TestAuthZPluginV2RejectVolumeRequests (0.00s)
21:48:55 [2019-10-21T21:48:55.315Z]     authz_plugin_v2_test.go:91: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
21:48:55 [2019-10-21T21:48:55.315Z] 
21:48:55 [2019-10-21T21:48:55.315Z] === SKIP: s390x.integration.plugin.authz TestAuthZPluginV2BadManifestFailsDaemonStart (0.00s)
21:48:55 [2019-10-21T21:48:55.315Z]     authz_plugin_v2_test.go:126: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
21:48:55 [2019-10-21T21:48:55.315Z] 
21:48:55 [2019-10-21T21:48:55.315Z] 
21:48:55 [2019-10-21T21:48:55.315Z] DONE 17 tests, 4 skipped in 33.125s
21:48:55 [2019-10-21T21:48:55.315Z] Running /go/src/github.com/docker/docker/integration/plugin/common (s390x.integration.plugin.common) flags=-test.v -test.timeout=120m  
21:48:55 [2019-10-21T21:48:55.315Z] ++ 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
21:48:55 [2019-10-21T21:48:55.315Z] ++ set -e
21:48:55 [2019-10-21T21:48:55.315Z] ++ '[' -n 0 ']'
21:48:55 [2019-10-21T21:48:55.315Z] ++ set -x
21:48:55 [2019-10-21T21:48:55.316Z] ++ 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
21:48:55 [2019-10-21T21:48:55.316Z] INFO: Testing against a local daemon
21:48:55 [2019-10-21T21:48:55.316Z] === RUN   TestPluginInvalidJSON
21:48:55 [2019-10-21T21:48:55.316Z] === RUN   TestPluginInvalidJSON//plugins/foobar/set
21:48:55 [2019-10-21T21:48:55.316Z] === PAUSE TestPluginInvalidJSON//plugins/foobar/set
21:48:55 [2019-10-21T21:48:55.316Z] === CONT  TestPluginInvalidJSON//plugins/foobar/set
21:48:55 [2019-10-21T21:48:55.316Z] --- PASS: TestPluginInvalidJSON (0.04s)
21:48:55 [2019-10-21T21:48:55.316Z]     --- PASS: TestPluginInvalidJSON//plugins/foobar/set (0.00s)
21:48:55 [2019-10-21T21:48:55.316Z] PASS
21:48:55 [2019-10-21T21:48:55.316Z] 
21:48:55 [2019-10-21T21:48:55.316Z] DONE 2 tests in 0.232s
21:48:55 [2019-10-21T21:48:55.721Z] Running /go/src/github.com/docker/docker/integration/plugin/graphdriver (s390x.integration.plugin.graphdriver) flags=-test.v -test.timeout=120m  
21:48:55 [2019-10-21T21:48:55.721Z] ++ 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
21:48:55 [2019-10-21T21:48:55.721Z] ++ set -e
21:48:55 [2019-10-21T21:48:55.721Z] ++ '[' -n 0 ']'
21:48:55 [2019-10-21T21:48:55.721Z] ++ set -x
21:48:55 [2019-10-21T21:48:55.721Z] ++ 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
21:48:55 [2019-10-21T21:48:55.721Z] INFO: Testing against a local daemon
21:48:55 [2019-10-21T21:48:55.721Z] === RUN   TestExternalGraphDriver
21:48:56 [2019-10-21T21:48:56.104Z] === RUN   TestExternalGraphDriver/json
21:48:58 [2019-10-21T21:48:58.011Z] === RUN   TestExternalGraphDriver/spec
21:49:00 [2019-10-21T21:49:00.617Z] === RUN   TestExternalGraphDriver/pull
21:49:03 [2019-10-21T21:49:03.122Z] --- PASS: TestExternalGraphDriver (7.02s)
21:49:03 [2019-10-21T21:49:03.122Z]     external_test.go:57: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestExternalGraphDriver
21:49:03 [2019-10-21T21:49:03.122Z]     daemon.go:302: [db7e8dc9a5190] waiting for daemon to start
21:49:03 [2019-10-21T21:49:03.122Z]     daemon.go:334: [db7e8dc9a5190] daemon started
21:49:03 [2019-10-21T21:49:03.122Z]     daemon.go:286: [db7e8dc9a5190] exiting daemon
21:49:03 [2019-10-21T21:49:03.122Z]     daemon.go:302: [db7e8dc9a5190] waiting for daemon to start
21:49:03 [2019-10-21T21:49:03.122Z]     daemon.go:334: [db7e8dc9a5190] daemon started
21:49:03 [2019-10-21T21:49:03.122Z]     daemon.go:286: [db7e8dc9a5190] exiting daemon
21:49:03 [2019-10-21T21:49:03.122Z]     --- PASS: TestExternalGraphDriver/json (2.21s)
21:49:03 [2019-10-21T21:49:03.122Z]     daemon.go:302: [db7e8dc9a5190] waiting for daemon to start
21:49:03 [2019-10-21T21:49:03.122Z]     daemon.go:334: [db7e8dc9a5190] daemon started
21:49:03 [2019-10-21T21:49:03.122Z]     daemon.go:286: [db7e8dc9a5190] exiting daemon
21:49:03 [2019-10-21T21:49:03.122Z]     daemon.go:302: [db7e8dc9a5190] waiting for daemon to start
21:49:03 [2019-10-21T21:49:03.122Z]     daemon.go:334: [db7e8dc9a5190] daemon started
21:49:03 [2019-10-21T21:49:03.122Z]     daemon.go:286: [db7e8dc9a5190] exiting daemon
21:49:03 [2019-10-21T21:49:03.122Z]     --- PASS: TestExternalGraphDriver/spec (2.19s)
21:49:03 [2019-10-21T21:49:03.122Z]     daemon.go:302: [db7e8dc9a5190] waiting for daemon to start
21:49:03 [2019-10-21T21:49:03.122Z]     daemon.go:334: [db7e8dc9a5190] daemon started
21:49:03 [2019-10-21T21:49:03.122Z]     daemon.go:286: [db7e8dc9a5190] exiting daemon
21:49:03 [2019-10-21T21:49:03.122Z]     --- PASS: TestExternalGraphDriver/pull (2.38s)
21:49:03 [2019-10-21T21:49:03.122Z] === RUN   TestGraphdriverPluginV2
21:49:03 [2019-10-21T21:49:03.122Z] --- SKIP: TestGraphdriverPluginV2 (0.08s)
21:49:03 [2019-10-21T21:49:03.122Z]     external_test.go:410: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
21:49:03 [2019-10-21T21:49:03.122Z] PASS
21:49:03 [2019-10-21T21:49:03.122Z] 
21:49:03 [2019-10-21T21:49:03.122Z] === Skipped
21:49:03 [2019-10-21T21:49:03.122Z] === SKIP: s390x.integration.plugin.graphdriver TestGraphdriverPluginV2 (0.08s)
21:49:03 [2019-10-21T21:49:03.122Z]     external_test.go:410: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
21:49:03 [2019-10-21T21:49:03.122Z] 
21:49:03 [2019-10-21T21:49:03.122Z] 
21:49:03 [2019-10-21T21:49:03.122Z] DONE 5 tests, 1 skipped in 7.325s
21:49:03 [2019-10-21T21:49:03.122Z] Running /go/src/github.com/docker/docker/integration/plugin/logging (s390x.integration.plugin.logging) flags=-test.v -test.timeout=120m  
21:49:03 [2019-10-21T21:49:03.122Z] ++ 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
21:49:03 [2019-10-21T21:49:03.122Z] ++ set -e
21:49:03 [2019-10-21T21:49:03.122Z] ++ '[' -n 0 ']'
21:49:03 [2019-10-21T21:49:03.122Z] ++ set -x
21:49:03 [2019-10-21T21:49:03.123Z] ++ 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
21:49:03 [2019-10-21T21:49:03.123Z] INFO: Testing against a local daemon
21:49:03 [2019-10-21T21:49:03.123Z] === RUN   TestContinueAfterPluginCrash
21:49:03 [2019-10-21T21:49:03.123Z] === PAUSE TestContinueAfterPluginCrash
21:49:03 [2019-10-21T21:49:03.123Z] === RUN   TestDaemonStartWithLogOpt
21:49:03 [2019-10-21T21:49:03.123Z] === PAUSE TestDaemonStartWithLogOpt
21:49:03 [2019-10-21T21:49:03.123Z] === CONT  TestContinueAfterPluginCrash
21:49:03 [2019-10-21T21:49:03.123Z] === CONT  TestDaemonStartWithLogOpt
21:49:17 [2019-10-21T21:49:17.128Z] --- PASS: TestDaemonStartWithLogOpt (12.25s)
21:49:17 [2019-10-21T21:49:17.128Z]     validation_test.go:23: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDaemonStartWithLogOpt
21:49:17 [2019-10-21T21:49:17.128Z]     daemon.go:302: [de6462a27afdc] waiting for daemon to start
21:49:17 [2019-10-21T21:49:17.128Z]     daemon.go:334: [de6462a27afdc] daemon started
21:49:17 [2019-10-21T21:49:17.128Z]     daemon.go:286: [de6462a27afdc] exiting daemon
21:49:17 [2019-10-21T21:49:17.128Z]     daemon.go:302: [de6462a27afdc] waiting for daemon to start
21:49:17 [2019-10-21T21:49:17.128Z]     daemon.go:334: [de6462a27afdc] daemon started
21:49:17 [2019-10-21T21:49:17.128Z]     daemon.go:286: [de6462a27afdc] exiting daemon
21:49:20 [2019-10-21T21:49:20.326Z] --- PASS: TestContinueAfterPluginCrash (17.24s)
21:49:20 [2019-10-21T21:49:20.326Z]     logging_linux_test.go:22: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestContinueAfterPluginCrash
21:49:20 [2019-10-21T21:49:20.326Z]     daemon.go:302: [d0654f90f59a0] waiting for daemon to start
21:49:20 [2019-10-21T21:49:20.326Z]     daemon.go:334: [d0654f90f59a0] daemon started
21:49:20 [2019-10-21T21:49:20.326Z]     daemon.go:286: [d0654f90f59a0] exiting daemon
21:49:20 [2019-10-21T21:49:20.326Z] PASS
21:49:20 [2019-10-21T21:49:20.326Z] 
21:49:20 [2019-10-21T21:49:20.326Z] DONE 2 tests in 17.540s
21:49:20 [2019-10-21T21:49:20.326Z] Running /go/src/github.com/docker/docker/integration/plugin/volumes (s390x.integration.plugin.volumes) flags=-test.v -test.timeout=120m  
21:49:20 [2019-10-21T21:49:20.326Z] ++ 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
21:49:20 [2019-10-21T21:49:20.326Z] ++ set -e
21:49:20 [2019-10-21T21:49:20.326Z] ++ '[' -n 0 ']'
21:49:20 [2019-10-21T21:49:20.326Z] ++ set -x
21:49:20 [2019-10-21T21:49:20.326Z] ++ 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
21:49:20 [2019-10-21T21:49:20.735Z] INFO: Testing against a local daemon
21:49:20 [2019-10-21T21:49:20.735Z] === RUN   TestPluginWithDevMounts
21:49:20 [2019-10-21T21:49:20.735Z] === PAUSE TestPluginWithDevMounts
21:49:20 [2019-10-21T21:49:20.735Z] === CONT  TestPluginWithDevMounts
21:49:22 [2019-10-21T21:49:22.740Z] --- PASS: TestPluginWithDevMounts (2.18s)
21:49:22 [2019-10-21T21:49:22.740Z]     mounts_test.go:23: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestPluginWithDevMounts
21:49:22 [2019-10-21T21:49:22.740Z]     daemon.go:302: [d57b39bd3ae74] waiting for daemon to start
21:49:22 [2019-10-21T21:49:22.740Z]     daemon.go:334: [d57b39bd3ae74] daemon started
21:49:22 [2019-10-21T21:49:22.740Z]     daemon.go:286: [d57b39bd3ae74] exiting daemon
21:49:22 [2019-10-21T21:49:22.740Z] PASS
21:49:22 [2019-10-21T21:49:22.740Z] 
21:49:22 [2019-10-21T21:49:22.740Z] DONE 1 tests in 2.400s
21:49:22 [2019-10-21T21:49:22.740Z] Running /go/src/github.com/docker/docker/integration/secret (s390x.integration.secret) flags=-test.v -test.timeout=120m  
21:49:22 [2019-10-21T21:49:22.740Z] ++ 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
21:49:22 [2019-10-21T21:49:22.740Z] ++ set -e
21:49:22 [2019-10-21T21:49:22.740Z] ++ '[' -n 0 ']'
21:49:22 [2019-10-21T21:49:22.740Z] ++ set -x
21:49:22 [2019-10-21T21:49:22.740Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_ENGINE_GOARCH=s390x DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///go/src/github.com/docker/docker/bundles/test-integration/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKERFILE=Dockerfile GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=docker gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/s390x-integration-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
21:49:23 [2019-10-21T21:49:23.125Z] INFO: Testing against a local daemon
21:49:23 [2019-10-21T21:49:23.125Z] === RUN   TestSecretInspect
21:49:26 [2019-10-21T21:49:26.423Z] --- PASS: TestSecretInspect (3.10s)
21:49:26 [2019-10-21T21:49:26.423Z]     secret_test.go:25: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestSecretInspect
21:49:26 [2019-10-21T21:49:26.423Z]     daemon.go:302: [d70f50b6553e5] waiting for daemon to start
21:49:26 [2019-10-21T21:49:26.423Z]     daemon.go:334: [d70f50b6553e5] daemon started
21:49:26 [2019-10-21T21:49:26.423Z]     daemon.go:286: [d70f50b6553e5] exiting daemon
21:49:26 [2019-10-21T21:49:26.423Z] === RUN   TestSecretList
21:49:29 [2019-10-21T21:49:29.854Z] --- PASS: TestSecretList (3.10s)
21:49:29 [2019-10-21T21:49:29.854Z]     secret_test.go:48: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestSecretList
21:49:29 [2019-10-21T21:49:29.854Z]     daemon.go:302: [d8c260393d334] waiting for daemon to start
21:49:29 [2019-10-21T21:49:29.854Z]     daemon.go:334: [d8c260393d334] daemon started
21:49:29 [2019-10-21T21:49:29.854Z]     daemon.go:286: [d8c260393d334] exiting daemon
21:49:29 [2019-10-21T21:49:29.854Z] === RUN   TestSecretsCreateAndDelete
21:49:31 [2019-10-21T21:49:31.691Z] --- PASS: TestSecretsCreateAndDelete (2.61s)
21:49:31 [2019-10-21T21:49:31.691Z]     secret_test.go:134: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestSecretsCreateAndDelete
21:49:31 [2019-10-21T21:49:31.691Z]     daemon.go:302: [d4d6ce92c5902] waiting for daemon to start
21:49:31 [2019-10-21T21:49:31.691Z]     daemon.go:334: [d4d6ce92c5902] daemon started
21:49:31 [2019-10-21T21:49:31.691Z]     daemon.go:286: [d4d6ce92c5902] exiting daemon
21:49:31 [2019-10-21T21:49:31.691Z] === RUN   TestSecretsUpdate
21:49:34 [2019-10-21T21:49:34.970Z] --- PASS: TestSecretsUpdate (3.10s)
21:49:34 [2019-10-21T21:49:34.970Z]     secret_test.go:181: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestSecretsUpdate
21:49:34 [2019-10-21T21:49:34.970Z]     daemon.go:302: [d6c9bbb890650] waiting for daemon to start
21:49:34 [2019-10-21T21:49:34.970Z]     daemon.go:334: [d6c9bbb890650] daemon started
21:49:34 [2019-10-21T21:49:34.970Z]     daemon.go:286: [d6c9bbb890650] exiting daemon
21:49:34 [2019-10-21T21:49:34.970Z] === RUN   TestTemplatedSecret
21:49:39 [2019-10-21T21:49:39.166Z] --- PASS: TestTemplatedSecret (3.68s)
21:49:39 [2019-10-21T21:49:39.167Z]     secret_test.go:230: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestTemplatedSecret
21:49:39 [2019-10-21T21:49:39.167Z]     daemon.go:302: [dddeddbf0da83] waiting for daemon to start
21:49:39 [2019-10-21T21:49:39.167Z]     daemon.go:334: [dddeddbf0da83] daemon started
21:49:39 [2019-10-21T21:49:39.167Z]     daemon.go:286: [dddeddbf0da83] exiting daemon
21:49:39 [2019-10-21T21:49:39.167Z] PASS
21:49:39 [2019-10-21T21:49:39.167Z] 
21:49:39 [2019-10-21T21:49:39.167Z] DONE 5 tests in 15.794s
21:49:39 [2019-10-21T21:49:39.167Z] Running /go/src/github.com/docker/docker/integration/service (s390x.integration.service) flags=-test.v -test.timeout=120m  
21:49:39 [2019-10-21T21:49:39.167Z] ++ 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
21:49:39 [2019-10-21T21:49:39.167Z] ++ set -e
21:49:39 [2019-10-21T21:49:39.167Z] ++ '[' -n 0 ']'
21:49:39 [2019-10-21T21:49:39.167Z] ++ set -x
21:49:39 [2019-10-21T21:49:39.167Z] ++ 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
21:49:39 [2019-10-21T21:49:39.167Z] INFO: Testing against a local daemon
21:49:39 [2019-10-21T21:49:39.167Z] === RUN   TestServiceCreateInit
21:49:39 [2019-10-21T21:49:39.167Z] === RUN   TestServiceCreateInit/daemonInitDisabled
21:49:44 [2019-10-21T21:49:44.436Z] === RUN   TestServiceCreateInit/daemonInitEnabled
21:49:49 [2019-10-21T21:49:49.615Z] --- PASS: TestServiceCreateInit (10.78s)
21:49:49 [2019-10-21T21:49:49.615Z]     --- PASS: TestServiceCreateInit/daemonInitDisabled (5.34s)
21:49:49 [2019-10-21T21:49:49.615Z]         create_test.go:36: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestServiceCreateInit/daemonInitDisabled
21:49:49 [2019-10-21T21:49:49.615Z]         daemon.go:302: [d31f75d5c1f4b] waiting for daemon to start
21:49:49 [2019-10-21T21:49:49.615Z]         daemon.go:334: [d31f75d5c1f4b] daemon started
21:49:49 [2019-10-21T21:49:49.615Z]         daemon.go:286: [d31f75d5c1f4b] exiting daemon
21:49:49 [2019-10-21T21:49:49.615Z]     --- PASS: TestServiceCreateInit/daemonInitEnabled (5.43s)
21:49:49 [2019-10-21T21:49:49.615Z]         create_test.go:36: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestServiceCreateInit/daemonInitEnabled
21:49:49 [2019-10-21T21:49:49.615Z]         daemon.go:302: [dc65145c6c7c5] waiting for daemon to start
21:49:49 [2019-10-21T21:49:49.615Z]         daemon.go:334: [dc65145c6c7c5] daemon started
21:49:49 [2019-10-21T21:49:49.615Z]         daemon.go:286: [dc65145c6c7c5] exiting daemon
21:49:49 [2019-10-21T21:49:49.615Z] === RUN   TestCreateServiceMultipleTimes
21:50:09 [2019-10-21T21:50:09.711Z] --- PASS: TestCreateServiceMultipleTimes (18.55s)
21:50:09 [2019-10-21T21:50:09.711Z]     create_test.go:78: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceMultipleTimes
21:50:09 [2019-10-21T21:50:09.711Z]     daemon.go:302: [d1d7571864145] waiting for daemon to start
21:50:09 [2019-10-21T21:50:09.711Z]     daemon.go:334: [d1d7571864145] daemon started
21:50:09 [2019-10-21T21:50:09.711Z]     daemon.go:286: [d1d7571864145] exiting daemon
21:50:09 [2019-10-21T21:50:09.711Z] === RUN   TestCreateWithDuplicateNetworkNames
21:50:23 [2019-10-21T21:50:23.569Z] --- PASS: TestCreateWithDuplicateNetworkNames (14.32s)
21:50:23 [2019-10-21T21:50:23.569Z]     create_test.go:127: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestCreateWithDuplicateNetworkNames
21:50:23 [2019-10-21T21:50:23.569Z]     daemon.go:302: [d2f8e769855e6] waiting for daemon to start
21:50:23 [2019-10-21T21:50:23.569Z]     daemon.go:334: [d2f8e769855e6] daemon started
21:50:23 [2019-10-21T21:50:23.569Z]     daemon.go:286: [d2f8e769855e6] exiting daemon
21:50:23 [2019-10-21T21:50:23.569Z] === RUN   TestCreateServiceSecretFileMode
21:50:26 [2019-10-21T21:50:26.240Z] --- PASS: TestCreateServiceSecretFileMode (3.57s)
21:50:26 [2019-10-21T21:50:26.240Z]     create_test.go:180: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceSecretFileMode
21:50:26 [2019-10-21T21:50:26.240Z]     daemon.go:302: [d29165b95772f] waiting for daemon to start
21:50:26 [2019-10-21T21:50:26.240Z]     daemon.go:334: [d29165b95772f] daemon started
21:50:26 [2019-10-21T21:50:26.240Z]     daemon.go:286: [d29165b95772f] exiting daemon
21:50:26 [2019-10-21T21:50:26.240Z] === RUN   TestCreateServiceConfigFileMode
21:50:29 [2019-10-21T21:50:29.472Z] --- PASS: TestCreateServiceConfigFileMode (3.53s)
21:50:29 [2019-10-21T21:50:29.472Z]     create_test.go:244: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceConfigFileMode
21:50:29 [2019-10-21T21:50:29.472Z]     daemon.go:302: [de5b391a65270] waiting for daemon to start
21:50:29 [2019-10-21T21:50:29.472Z]     daemon.go:334: [de5b391a65270] daemon started
21:50:29 [2019-10-21T21:50:29.472Z]     daemon.go:286: [de5b391a65270] exiting daemon
21:50:29 [2019-10-21T21:50:29.472Z] === RUN   TestInspect
21:50:32 [2019-10-21T21:50:32.836Z] --- PASS: TestInspect (3.17s)
21:50:32 [2019-10-21T21:50:32.836Z]     inspect_test.go:25: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestInspect
21:50:32 [2019-10-21T21:50:32.836Z]     daemon.go:302: [db2f33eedf3ec] waiting for daemon to start
21:50:32 [2019-10-21T21:50:32.836Z]     daemon.go:334: [db2f33eedf3ec] daemon started
21:50:32 [2019-10-21T21:50:32.836Z]     daemon.go:286: [db2f33eedf3ec] exiting daemon
21:50:32 [2019-10-21T21:50:32.836Z] === RUN   TestDockerNetworkConnectAlias
21:50:39 [2019-10-21T21:50:39.247Z] --- PASS: TestDockerNetworkConnectAlias (6.29s)
21:50:39 [2019-10-21T21:50:39.247Z]     network_test.go:20: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkConnectAlias
21:50:39 [2019-10-21T21:50:39.247Z]     daemon.go:302: [ddfafbc52cff6] waiting for daemon to start
21:50:39 [2019-10-21T21:50:39.247Z]     daemon.go:334: [ddfafbc52cff6] daemon started
21:50:39 [2019-10-21T21:50:39.247Z]     daemon.go:286: [ddfafbc52cff6] exiting daemon
21:50:39 [2019-10-21T21:50:39.247Z] === RUN   TestDockerNetworkReConnect
21:50:45 [2019-10-21T21:50:45.792Z] --- PASS: TestDockerNetworkReConnect (6.08s)
21:50:45 [2019-10-21T21:50:45.792Z]     network_test.go:82: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkReConnect
21:50:45 [2019-10-21T21:50:45.792Z]     daemon.go:302: [dd4a0fe4df726] waiting for daemon to start
21:50:45 [2019-10-21T21:50:45.792Z]     daemon.go:334: [dd4a0fe4df726] daemon started
21:50:45 [2019-10-21T21:50:45.792Z]     daemon.go:286: [dd4a0fe4df726] exiting daemon
21:50:45 [2019-10-21T21:50:45.792Z] === RUN   TestServicePlugin
21:50:45 [2019-10-21T21:50:45.792Z] --- SKIP: TestServicePlugin (0.00s)
21:50:45 [2019-10-21T21:50:45.792Z]     plugin_test.go:26: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
21:50:45 [2019-10-21T21:50:45.792Z] === RUN   TestServiceUpdateLabel
21:50:48 [2019-10-21T21:50:48.274Z] --- PASS: TestServiceUpdateLabel (3.03s)
21:50:48 [2019-10-21T21:50:48.274Z]     update_test.go:21: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateLabel
21:50:48 [2019-10-21T21:50:48.274Z]     daemon.go:302: [d54c09ace83f3] waiting for daemon to start
21:50:48 [2019-10-21T21:50:48.274Z]     daemon.go:334: [d54c09ace83f3] daemon started
21:50:48 [2019-10-21T21:50:48.274Z]     daemon.go:286: [d54c09ace83f3] exiting daemon
21:50:48 [2019-10-21T21:50:48.274Z] === RUN   TestServiceUpdateSecrets
21:51:04 [2019-10-21T21:51:04.963Z] --- PASS: TestServiceUpdateSecrets (16.05s)
21:51:04 [2019-10-21T21:51:04.963Z]     update_test.go:77: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateSecrets
21:51:04 [2019-10-21T21:51:04.963Z]     daemon.go:302: [da905d313ccad] waiting for daemon to start
21:51:04 [2019-10-21T21:51:04.963Z]     daemon.go:334: [da905d313ccad] daemon started
21:51:04 [2019-10-21T21:51:04.963Z]     daemon.go:286: [da905d313ccad] exiting daemon
21:51:04 [2019-10-21T21:51:04.963Z] === RUN   TestServiceUpdateConfigs
21:51:21 [2019-10-21T21:51:21.525Z] --- PASS: TestServiceUpdateConfigs (15.91s)
21:51:21 [2019-10-21T21:51:21.525Z]     update_test.go:139: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateConfigs
21:51:21 [2019-10-21T21:51:21.525Z]     daemon.go:302: [dc84f9b116414] waiting for daemon to start
21:51:21 [2019-10-21T21:51:21.525Z]     daemon.go:334: [dc84f9b116414] daemon started
21:51:21 [2019-10-21T21:51:21.525Z]     daemon.go:286: [dc84f9b116414] exiting daemon
21:51:21 [2019-10-21T21:51:21.525Z] === RUN   TestServiceUpdateNetwork
21:51:35 [2019-10-21T21:51:35.209Z] --- PASS: TestServiceUpdateNetwork (14.81s)
21:51:35 [2019-10-21T21:51:35.209Z]     update_test.go:201: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateNetwork
21:51:35 [2019-10-21T21:51:35.209Z]     daemon.go:302: [da234f3bc5df0] waiting for daemon to start
21:51:35 [2019-10-21T21:51:35.209Z]     daemon.go:334: [da234f3bc5df0] daemon started
21:51:35 [2019-10-21T21:51:35.209Z]     daemon.go:286: [da234f3bc5df0] exiting daemon
21:51:35 [2019-10-21T21:51:35.209Z] PASS
21:51:35 [2019-10-21T21:51:35.209Z] 
21:51:35 [2019-10-21T21:51:35.209Z] === Skipped
21:51:35 [2019-10-21T21:51:35.209Z] === SKIP: s390x.integration.service TestServicePlugin (0.00s)
21:51:35 [2019-10-21T21:51:35.209Z]     plugin_test.go:26: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
21:51:35 [2019-10-21T21:51:35.209Z] 
21:51:35 [2019-10-21T21:51:35.209Z] 
21:51:35 [2019-10-21T21:51:35.209Z] DONE 15 tests, 1 skipped in 116.311s
21:51:35 [2019-10-21T21:51:35.209Z] Running /go/src/github.com/docker/docker/integration/session (s390x.integration.session) flags=-test.v -test.timeout=120m  
21:51:35 [2019-10-21T21:51:35.209Z] ++ 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
21:51:35 [2019-10-21T21:51:35.209Z] ++ set -e
21:51:35 [2019-10-21T21:51:35.209Z] ++ '[' -n 0 ']'
21:51:35 [2019-10-21T21:51:35.209Z] ++ set -x
21:51:35 [2019-10-21T21:51:35.209Z] ++ 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
21:51:35 [2019-10-21T21:51:35.209Z] INFO: Testing against a local daemon
21:51:35 [2019-10-21T21:51:35.209Z] === RUN   TestSessionCreate
21:51:35 [2019-10-21T21:51:35.209Z] --- PASS: TestSessionCreate (0.01s)
21:51:35 [2019-10-21T21:51:35.209Z] === RUN   TestSessionCreateWithBadUpgrade
21:51:35 [2019-10-21T21:51:35.209Z] --- PASS: TestSessionCreateWithBadUpgrade (0.00s)
21:51:35 [2019-10-21T21:51:35.209Z] PASS
21:51:35 [2019-10-21T21:51:35.209Z] 
21:51:35 [2019-10-21T21:51:35.209Z] DONE 2 tests in 0.236s
21:51:35 [2019-10-21T21:51:35.209Z] Running /go/src/github.com/docker/docker/integration/system (s390x.integration.system) flags=-test.v -test.timeout=120m  
21:51:35 [2019-10-21T21:51:35.209Z] ++ 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
21:51:35 [2019-10-21T21:51:35.209Z] ++ set -e
21:51:35 [2019-10-21T21:51:35.209Z] ++ '[' -n 0 ']'
21:51:35 [2019-10-21T21:51:35.209Z] ++ set -x
21:51:35 [2019-10-21T21:51:35.209Z] ++ 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
21:51:35 [2019-10-21T21:51:35.703Z] INFO: Testing against a local daemon
21:51:35 [2019-10-21T21:51:35.703Z] === RUN   TestCgroupDriverSystemdMemoryLimit
21:51:35 [2019-10-21T21:51:35.703Z] === PAUSE TestCgroupDriverSystemdMemoryLimit
21:51:35 [2019-10-21T21:51:35.703Z] === RUN   TestEventsExecDie
21:51:36 [2019-10-21T21:51:36.541Z] --- PASS: TestEventsExecDie (1.14s)
21:51:36 [2019-10-21T21:51:36.541Z] === RUN   TestEventsBackwardsCompatible
21:51:36 [2019-10-21T21:51:36.541Z] --- PASS: TestEventsBackwardsCompatible (0.09s)
21:51:36 [2019-10-21T21:51:36.541Z] === RUN   TestInfoBinaryCommits
21:51:36 [2019-10-21T21:51:36.541Z] --- PASS: TestInfoBinaryCommits (0.03s)
21:51:36 [2019-10-21T21:51:36.541Z] === RUN   TestInfoAPIVersioned
21:51:36 [2019-10-21T21:51:36.541Z] --- PASS: TestInfoAPIVersioned (0.01s)
21:51:36 [2019-10-21T21:51:36.541Z] === RUN   TestInfoAPI
21:51:37 [2019-10-21T21:51:37.085Z] --- PASS: TestInfoAPI (0.04s)
21:51:37 [2019-10-21T21:51:37.085Z] === RUN   TestInfoAPIWarnings
21:51:37 [2019-10-21T21:51:37.505Z] --- PASS: TestInfoAPIWarnings (0.88s)
21:51:37 [2019-10-21T21:51:37.505Z]     info_test.go:49: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestInfoAPIWarnings
21:51:37 [2019-10-21T21:51:37.505Z]     daemon.go:302: [d6f7cb8b1eb64] waiting for daemon to start
21:51:37 [2019-10-21T21:51:37.505Z]     daemon.go:334: [d6f7cb8b1eb64] daemon started
21:51:37 [2019-10-21T21:51:37.505Z]     daemon.go:286: [d6f7cb8b1eb64] exiting daemon
21:51:37 [2019-10-21T21:51:37.505Z] === RUN   TestLoginFailsWithBadCredentials
21:51:37 [2019-10-21T21:51:37.896Z] --- PASS: TestLoginFailsWithBadCredentials (0.44s)
21:51:37 [2019-10-21T21:51:37.896Z] === RUN   TestVersion
21:51:37 [2019-10-21T21:51:37.896Z] --- PASS: TestVersion (0.01s)
21:51:37 [2019-10-21T21:51:37.896Z] === CONT  TestCgroupDriverSystemdMemoryLimit
21:51:37 [2019-10-21T21:51:37.896Z] --- SKIP: TestCgroupDriverSystemdMemoryLimit (0.00s)
21:51:37 [2019-10-21T21:51:37.896Z]     cgroupdriver_systemd_test.go:35: systemd not available
21:51:37 [2019-10-21T21:51:37.896Z] PASS
21:51:37 [2019-10-21T21:51:37.896Z] 
21:51:37 [2019-10-21T21:51:37.896Z] === Skipped
21:51:37 [2019-10-21T21:51:37.896Z] === SKIP: s390x.integration.system TestCgroupDriverSystemdMemoryLimit (0.00s)
21:51:37 [2019-10-21T21:51:37.896Z] === PAUSE TestCgroupDriverSystemdMemoryLimit
21:51:37 [2019-10-21T21:51:37.896Z] === CONT  TestCgroupDriverSystemdMemoryLimit
21:51:37 [2019-10-21T21:51:37.896Z]     cgroupdriver_systemd_test.go:35: systemd not available
21:51:37 [2019-10-21T21:51:37.896Z] 
21:51:37 [2019-10-21T21:51:37.896Z] 
21:51:37 [2019-10-21T21:51:37.896Z] DONE 9 tests, 1 skipped in 2.802s
21:51:38 [2019-10-21T21:51:38.290Z] Running /go/src/github.com/docker/docker/integration/volume (s390x.integration.volume) flags=-test.v -test.timeout=120m  
21:51:38 [2019-10-21T21:51:38.290Z] ++ 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
21:51:38 [2019-10-21T21:51:38.290Z] ++ set -e
21:51:38 [2019-10-21T21:51:38.290Z] ++ '[' -n 0 ']'
21:51:38 [2019-10-21T21:51:38.290Z] ++ set -x
21:51:38 [2019-10-21T21:51:38.290Z] ++ 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
21:51:38 [2019-10-21T21:51:38.290Z] INFO: Testing against a local daemon
21:51:38 [2019-10-21T21:51:38.290Z] === RUN   TestVolumesCreateAndList
21:51:38 [2019-10-21T21:51:38.290Z] --- PASS: TestVolumesCreateAndList (0.04s)
21:51:38 [2019-10-21T21:51:38.290Z] === RUN   TestVolumesRemove
21:51:38 [2019-10-21T21:51:38.290Z] --- PASS: TestVolumesRemove (0.10s)
21:51:38 [2019-10-21T21:51:38.290Z] === RUN   TestVolumesInspect
21:51:38 [2019-10-21T21:51:38.290Z] --- PASS: TestVolumesInspect (0.01s)
21:51:38 [2019-10-21T21:51:38.290Z] === RUN   TestVolumesInvalidJSON
21:51:38 [2019-10-21T21:51:38.290Z] === RUN   TestVolumesInvalidJSON//volumes/create
21:51:38 [2019-10-21T21:51:38.290Z] === PAUSE TestVolumesInvalidJSON//volumes/create
21:51:38 [2019-10-21T21:51:38.290Z] === CONT  TestVolumesInvalidJSON//volumes/create
21:51:38 [2019-10-21T21:51:38.290Z] --- PASS: TestVolumesInvalidJSON (0.02s)
21:51:38 [2019-10-21T21:51:38.290Z]     --- PASS: TestVolumesInvalidJSON//volumes/create (0.00s)
21:51:38 [2019-10-21T21:51:38.290Z] PASS
21:51:38 [2019-10-21T21:51:38.290Z] 
21:51:38 [2019-10-21T21:51:38.290Z] DONE 5 tests in 0.319s
21:51:38 [2019-10-21T21:51:38.290Z] ---> Making bundle: .integration-daemon-stop (in bundles/test-integration)
21:51:38 [2019-10-21T21:51:38.679Z] ++++ cat bundles/test-integration/docker.pid
21:51:38 [2019-10-21T21:51:38.679Z] +++ kill 9041
21:51:39 [2019-10-21T21:51:39.931Z] umount: bundles/test-integration/root: mountpoint not found
21:51:39 [2019-10-21T21:51:39.931Z] +++ /etc/init.d/apparmor stop
21:51:39 [2019-10-21T21:51:39.931Z] Clearing AppArmor profiles cache:.
21:51:39 [2019-10-21T21:51:39.931Z] All profile caches have been cleared, but no profiles have been unloaded.
21:51:39 [2019-10-21T21:51:39.931Z] Unloading profiles will leave already running processes permanently
21:51:39 [2019-10-21T21:51:39.931Z] unconfined, which can lead to unexpected situations.
21:51:39 [2019-10-21T21:51:39.931Z] 
21:51:39 [2019-10-21T21:51:39.931Z] To set a process to complain mode, use the command line tool
21:51:39 [2019-10-21T21:51:39.931Z] 'aa-complain'. To really tear down all profiles, run the init script
21:51:39 [2019-10-21T21:51:39.931Z] with the 'teardown' option."
21:51:39 [2019-10-21T21:51:39.931Z]